Exporting environment variables
Exporting TERM
Exporting PAGER
Exporting DISPLAY
Exporting CI
Exporting SEMAPHORE
Exporting SEMAPHORE_PROJECT_NAME
Exporting SEMAPHORE_PROJECT_ID
Exporting SEMAPHORE_JOB_NAME
Exporting SEMAPHORE_JOB_ID
Exporting SEMAPHORE_AGENT_MACHINE_TYPE
Exporting SEMAPHORE_AGENT_MACHINE_OS_IMAGE
Exporting SEMAPHORE_AGENT_MACHINE_ENVIRONMENT_TYPE
Exporting SEMAPHORE_ORGANIZATION_URL
Exporting SEMAPHORE_ARTIFACT_TOKEN
Exporting SSH_PRIVATE_KEY_PATH
Exporting SEMAPHORE_CACHE_PRIVATE_KEY_PATH
Exporting SEMAPHORE_CACHE_USERNAME
Exporting SEMAPHORE_CACHE_URL
Exporting SEMAPHORE_GIT_URL
Exporting SEMAPHORE_GIT_DIR
Exporting SEMAPHORE_GIT_SHA
Exporting SEMAPHORE_GIT_REPO_SLUG
Exporting SEMAPHORE_GIT_REF
Exporting SEMAPHORE_GIT_COMMIT_RANGE
Exporting SEMAPHORE_GIT_REF_TYPE
Exporting SEMAPHORE_GIT_BRANCH
Exporting CODACY_API_TOKEN
Exporting SEMAPHORE_WORKFLOW_ID
Exporting SEMAPHORE_WORKFLOW_NUMBER
Exporting SEMAPHORE_WORKFLOW_RERUN
Exporting SEMAPHORE_WORKFLOW_TRIGGERED_BY_HOOK
Exporting SEMAPHORE_WORKFLOW_HOOK_SOURCE
Exporting SEMAPHORE_WORKFLOW_TRIGGERED_BY_SCHEDULE
Exporting SEMAPHORE_WORKFLOW_TRIGGERED_BY_API
Exporting SEMAPHORE_PIPELINE_ARTEFACT_ID
Exporting SEMAPHORE_PIPELINE_ID
Exporting SEMAPHORE_PIPELINE_RERUN
Exporting SEMAPHORE_PIPELINE_PROMOTION
Exporting SEMAPHORE_PIPELINE_0_ARTEFACT_ID
Exporting PIP_CACHE_DIR
Exporting CODACY_USERNAME
Exporting CODACY_PROJECT_NAME
Exporting TOXENV
Injecting Files
Injecting /home/semaphore/.ssh/semaphore_cache_key with file mode 0600
Injecting .ssh/id_rsa with file mode 0600
Setting up the Semaphore toolbox
Running: git clone https://github.com/semaphoreci/toolbox.git ~/.toolbox && bash ~/.toolbox/install-toolbox && source ~/.toolbox/toolbox && echo 'source ~/.toolbox/toolbox' >> ~/.bash_profile && if [ -f /etc/init.d/xvfb ]; then /etc/init.d/xvfb start; fi
Cloning into '/home/semaphore/.toolbox'...
remote: Enumerating objects: 51, done.
remote: Counting objects:   1% (1/51)
remote: Counting objects:   3% (2/51)
remote: Counting objects:   5% (3/51)
remote: Counting objects:   7% (4/51)
remote: Counting objects:   9% (5/51)
remote: Counting objects:  11% (6/51)
remote: Counting objects:  13% (7/51)
remote: Counting objects:  15% (8/51)
remote: Counting objects:  17% (9/51)
remote: Counting objects:  19% (10/51)
remote: Counting objects:  21% (11/51)
remote: Counting objects:  23% (12/51)
remote: Counting objects:  25% (13/51)
remote: Counting objects:  27% (14/51)
remote: Counting objects:  29% (15/51)
remote: Counting objects:  31% (16/51)
remote: Counting objects:  33% (17/51)
remote: Counting objects:  35% (18/51)
remote: Counting objects:  37% (19/51)
remote: Counting objects:  39% (20/51)
remote: Counting objects:  41% (21/51)
remote: Counting objects:  43% (22/51)
remote: Counting objects:  45% (23/51)
remote: Counting objects:  47% (24/51)
remote: Counting objects:  49% (25/51)
remote: Counting objects:  50% (26/51)
remote: Counting objects:  52% (27/51)
remote: Counting objects:  54% (28/51)
remote: Counting objects:  56% (29/51)
remote: Counting objects:  58% (30/51)
remote: Counting objects:  60% (31/51)
remote: Counting objects:  62% (32/51)
remote: Counting objects:  64% (33/51)
remote: Counting objects:  66% (34/51)
remote: Counting objects:  68% (35/51)
remote: Counting objects:  70% (36/51)
remote: Counting objects:  72% (37/51)
remote: Counting objects:  74% (38/51)
remote: Counting objects:  76% (39/51)
remote: Counting objects:  78% (40/51)
remote: Counting objects:  80% (41/51)
remote: Counting objects:  82% (42/51)
remote: Counting objects:  84% (43/51)
remote: Counting objects:  86% (44/51)
remote: Counting objects:  88% (45/51)
remote: Counting objects:  90% (46/51)
remote: Counting objects:  92% (47/51)
remote: Counting objects:  94% (48/51)
remote: Counting objects:  96% (49/51)
remote: Counting objects:  98% (50/51)
remote: Counting objects: 100% (51/51)
remote: Counting objects: 100% (51/51), done.
remote: Compressing objects:   3% (1/32)
remote: Compressing objects:   6% (2/32)
remote: Compressing objects:   9% (3/32)
remote: Compressing objects:  12% (4/32)
remote: Compressing objects:  15% (5/32)
remote: Compressing objects:  18% (6/32)
remote: Compressing objects:  21% (7/32)
remote: Compressing objects:  25% (8/32)
remote: Compressing objects:  28% (9/32)
remote: Compressing objects:  31% (10/32)
remote: Compressing objects:  34% (11/32)
remote: Compressing objects:  37% (12/32)
remote: Compressing objects:  40% (13/32)
remote: Compressing objects:  43% (14/32)
remote: Compressing objects:  46% (15/32)
remote: Compressing objects:  50% (16/32)
remote: Compressing objects:  53% (17/32)
remote: Compressing objects:  56% (18/32)
remote: Compressing objects:  59% (19/32)
remote: Compressing objects:  62% (20/32)
remote: Compressing objects:  65% (21/32)
remote: Compressing objects:  68% (22/32)
remote: Compressing objects:  71% (23/32)
remote: Compressing objects:  75% (24/32)
remote: Compressing objects:  78% (25/32)
remote: Compressing objects:  81% (26/32)
remote: Compressing objects:  84% (27/32)
remote: Compressing objects:  87% (28/32)
remote: Compressing objects:  90% (29/32)
remote: Compressing objects:  93% (30/32)
remote: Compressing objects:  96% (31/32)
remote: Compressing objects: 100% (32/32)
remote: Compressing objects: 100% (32/32), done.
Receiving objects:   0% (1/1170)
Receiving objects:   1% (12/1170)
Receiving objects:   2% (24/1170)
Receiving objects:   3% (36/1170)
Receiving objects:   4% (47/1170)
Receiving objects:   5% (59/1170)
Receiving objects:   6% (71/1170)
Receiving objects:   7% (82/1170)
Receiving objects:   8% (94/1170)
Receiving objects:   9% (106/1170)
Receiving objects:  10% (117/1170)
Receiving objects:  11% (129/1170)
Receiving objects:  12% (141/1170)
Receiving objects:  13% (153/1170)
Receiving objects:  14% (164/1170)
Receiving objects:  15% (176/1170)
Receiving objects:  16% (188/1170)
Receiving objects:  17% (199/1170)
Receiving objects:  18% (211/1170)
Receiving objects:  19% (223/1170)
Receiving objects:  20% (234/1170)
Receiving objects:  21% (246/1170)
Receiving objects:  22% (258/1170)
Receiving objects:  23% (270/1170)
Receiving objects:  24% (281/1170)
Receiving objects:  25% (293/1170)
Receiving objects:  26% (305/1170)
Receiving objects:  27% (316/1170)
Receiving objects:  28% (328/1170)
Receiving objects:  29% (340/1170)
Receiving objects:  30% (351/1170)
Receiving objects:  31% (363/1170)
Receiving objects:  32% (375/1170)
Receiving objects:  33% (387/1170)
Receiving objects:  34% (398/1170)
Receiving objects:  35% (410/1170)
Receiving objects:  36% (422/1170)
Receiving objects:  37% (433/1170)
Receiving objects:  38% (445/1170)
Receiving objects:  39% (457/1170)
Receiving objects:  40% (468/1170)
Receiving objects:  41% (480/1170)
Receiving objects:  42% (492/1170)
Receiving objects:  43% (504/1170)
Receiving objects:  44% (515/1170)
Receiving objects:  45% (527/1170)
Receiving objects:  46% (539/1170)
Receiving objects:  47% (550/1170)
Receiving objects:  48% (562/1170)
Receiving objects:  49% (574/1170)
Receiving objects:  50% (585/1170)
Receiving objects:  51% (597/1170)
Receiving objects:  52% (609/1170)
Receiving objects:  53% (621/1170)
Receiving objects:  54% (632/1170)
Receiving objects:  55% (644/1170)
Receiving objects:  56% (656/1170)
Receiving objects:  57% (667/1170)
Receiving objects:  58% (679/1170)
Receiving objects:  59% (691/1170)
Receiving objects:  60% (702/1170)
Receiving objects:  61% (714/1170)
Receiving objects:  62% (726/1170)
Receiving objects:  63% (738/1170)
Receiving objects:  64% (749/1170)
Receiving objects:  65% (761/1170)
Receiving objects:  66% (773/1170)
Receiving objects:  67% (784/1170)
Receiving objects:  68% (796/1170)
Receiving objects:  69% (808/1170)
Receiving objects:  70% (819/1170)
Receiving objects:  71% (831/1170)
Receiving objects:  72% (843/1170)
Receiving objects:  73% (855/1170)
Receiving objects:  74% (866/1170)
Receiving objects:  75% (878/1170)
Receiving objects:  76% (890/1170)
Receiving objects:  77% (901/1170)
Receiving objects:  78% (913/1170)
Receiving objects:  79% (925/1170)
Receiving objects:  80% (936/1170)
Receiving objects:  81% (948/1170)
Receiving objects:  82% (960/1170)
Receiving objects:  83% (972/1170)
Receiving objects:  84% (983/1170)
Receiving objects:  85% (995/1170)
Receiving objects:  86% (1007/1170)
Receiving objects:  87% (1018/1170)
Receiving objects:  88% (1030/1170)
Receiving objects:  89% (1042/1170)
Receiving objects:  90% (1053/1170)
Receiving objects:  91% (1065/1170)
Receiving objects:  92% (1077/1170)
Receiving objects:  93% (1089/1170)
Receiving objects:  94% (1100/1170)
Receiving objects:  95% (1112/1170)
Receiving objects:  96% (1124/1170)
Receiving objects:  97% (1135/1170)
Receiving objects:  98% (1147/1170)
remote: Total 1170 (delta 27), reused 28 (delta 17), pack-reused 1119
Receiving objects:  99% (1159/1170)
Receiving objects: 100% (1170/1170)
Receiving objects: 100% (1170/1170), 253.98 KiB | 702.00 KiB/s, done.
Resolving deltas:   0% (0/655)
Resolving deltas:   1% (7/655)
Resolving deltas:   4% (31/655)
Resolving deltas:   6% (44/655)
Resolving deltas:   9% (63/655)
Resolving deltas:  10% (71/655)
Resolving deltas:  11% (75/655)
Resolving deltas:  15% (101/655)
Resolving deltas:  16% (105/655)
Resolving deltas:  17% (114/655)
Resolving deltas:  19% (125/655)
Resolving deltas:  21% (139/655)
Resolving deltas:  29% (193/655)
Resolving deltas:  30% (200/655)
Resolving deltas:  31% (204/655)
Resolving deltas:  40% (265/655)
Resolving deltas:  41% (272/655)
Resolving deltas:  44% (290/655)
Resolving deltas:  46% (303/655)
Resolving deltas:  48% (315/655)
Resolving deltas:  50% (333/655)
Resolving deltas:  51% (336/655)
Resolving deltas:  55% (365/655)
Resolving deltas:  56% (372/655)
Resolving deltas:  57% (375/655)
Resolving deltas:  77% (508/655)
Resolving deltas:  78% (514/655)
Resolving deltas:  83% (544/655)
Resolving deltas:  88% (580/655)
Resolving deltas:  89% (585/655)
Resolving deltas:  92% (607/655)
Resolving deltas:  93% (610/655)
Resolving deltas:  94% (616/655)
Resolving deltas: 100% (655/655)
Resolving deltas: 100% (655/655), done.
retry installed
ssh-session-cli installed
cache installed
sem-service installed
sem-dockerize installed
sem-service-check-params installed
artifacts installed
Starting virtual X frame buffer: Xvfb.
Starting an ssh-agent
Running: eval `ssh-agent` && echo 'eval $(ssh-agent) >/dev/null' >> ~/.bash_profile && echo 'yes' > /tmp/sempahore-user-commands-have-started
Agent pid 3254
Connecting to cache
Running: ssh-keyscan -p 29920 -H 116.202.54.132 >> /home/semaphore/.ssh/known_hosts && ssh-add /home/semaphore/.ssh/semaphore_cache_key
# 116.202.54.132:29920 SSH-2.0-OpenSSH_7.6p1 Ubuntu-4ubuntu0.3
# 116.202.54.132:29920 SSH-2.0-OpenSSH_7.6p1 Ubuntu-4ubuntu0.3
# 116.202.54.132:29920 SSH-2.0-OpenSSH_7.6p1 Ubuntu-4ubuntu0.3
Identity added: /home/semaphore/.ssh/semaphore_cache_key (/home/semaphore/.ssh/semaphore_cache_key)
export PATH="${HOME}/.local/bin":"${PATH}"
checkout
Performing shallow clone with depth: 50
HEAD is now at 2982d69 Correct command?
mkdir "${PIP_CACHE_DIR}"
cache restore "setup-${SEMAPHORE_GIT_BRANCH}-$(checksum setup.py)","setup-${SEMAPHORE_GIT_BRANCH}",setup-master
HIT: setup-master-1496ffee88def2281f9e239a5b179bd1, using key setup-master-1496ffee88def2281f9e239a5b179bd1
Restored: .pip_cache/
pip install --user tox
Collecting tox
  Using cached tox-3.14.5-py2.py3-none-any.whl (81 kB)
Collecting packaging>=14
  Using cached packaging-20.3-py2.py3-none-any.whl (37 kB)
Collecting filelock<4,>=3.0.0
  Using cached filelock-3.0.12-py3-none-any.whl (7.6 kB)
Collecting toml>=0.9.4
  Using cached toml-0.10.0-py2.py3-none-any.whl (25 kB)
Collecting six<2,>=1.14.0
  Using cached six-1.14.0-py2.py3-none-any.whl (10 kB)
Collecting pluggy<1,>=0.12.0
  Using cached pluggy-0.13.1-py2.py3-none-any.whl (18 kB)
Requirement already satisfied: virtualenv>=16.0.0 in /usr/local/lib/python3.8/dist-packages (from tox) (16.0.0)
Collecting py<2,>=1.4.17
  Using cached py-1.8.1-py2.py3-none-any.whl (83 kB)
Collecting pyparsing>=2.0.2
  Using cached pyparsing-2.4.6-py2.py3-none-any.whl (67 kB)
Installing collected packages: pyparsing, six, packaging, filelock, toml, pluggy, py, tox
Successfully installed filelock-3.0.12 packaging-20.3 pluggy-0.13.1 py-1.8.1 pyparsing-2.4.6 six-1.14.0 toml-0.10.0 tox-3.14.5
tox
py36 create: /home/semaphore/logging/.tox/py36
py36 installdeps: .[dev]
py36 develop-inst: /home/semaphore/logging
py36 installed: astroid==2.3.3,atomicwrites==1.3.0,attrs==19.3.0,callee==0.3.1,coverage==5.0.3,dodgy==0.2.1,-e git+git@github.com:fiaas/logging.git@2982d69ea92aba25c959c34a2277deed803d273c#egg=fiaas_logging,importlib-metadata==1.5.0,isort==4.3.21,lazy-object-proxy==1.4.3,mccabe==0.6.1,mock==3.0.5,more-itertools==8.2.0,packaging==20.3,pep8-naming==0.4.1,pluggy==0.13.1,prospector==1.2.0,py==1.8.1,pycodestyle==2.4.0,pydocstyle==5.0.2,pyflakes==2.1.1,pylint==2.4.4,pylint-celery==0.3,pylint-django==2.0.12,pylint-flask==0.6,pylint-plugin-utils==0.6,pyparsing==2.4.6,pytest==4.6.9,pytest-cov==2.8.1,pytest-html==1.22.1,pytest-metadata==1.8.0,pytest-sugar==0.9.2,PyYAML==5.3,requirements-detector==0.6,setoptconf==0.2.0,six==1.14.0,snowballstemmer==2.0.0,termcolor==1.1.0,typed-ast==1.4.1,wcwidth==0.1.8,wrapt==1.11.2,zipp==3.1.0
py36 run-test-pre: PYTHONHASHSEED='1012747116'
py36 run-test: commands[0] | prospector
Check Information
=================
         Started: 2020-03-06 14:31:44.425851
        Finished: 2020-03-06 14:31:44.483419
      Time Taken: 0.06 seconds
       Formatter: grouped
        Profiles: .prospector.yaml, no_doc_warnings, strictness_high, strictness_veryhigh, no_member_warnings
      Strictness: from profile
  Libraries Used: 
       Tools Run: dodgy, mccabe, pep8, profile-validator, pyflakes
  Messages Found: 0

py36 run-test: commands[1] | py.test
Test session starts (platform: linux, Python 3.6.9, pytest 4.6.9, pytest-sugar 0.9.2)
cachedir: .tox/py36/.pytest_cache
rootdir: /home/semaphore/logging, inifile: setup.cfg
plugins: metadata-1.8.0, cov-2.8.1, sugar-0.9.2, html-1.22.1
collecting ... 

 tests/test_fiaas_logging.py ✓                                    17% █▋        
 tests/test_fiaas_logging.py ✓✓                                   33% ███▍      
 tests/test_fiaas_logging.py ✓✓✓                                  50% █████     
 tests/test_fiaas_logging.py ✓✓✓✓                                 67% ██████▋   
 tests/test_fiaas_logging.py ✓✓✓✓✓                                83% ████████▍ 
 tests/test_fiaas_logging.py ✓✓✓✓✓✓                              100% ██████████
-- generated xml file: /home/semaphore/logging/build/reports/tests/junit.xml ---

Results (0.21s):
       6 passed
___________________________________ summary ____________________________________
  py36: commands succeeded
  congratulations :)
export SEMAPHORE_JOB_RESULT=passed
cache store "setup-${SEMAPHORE_GIT_BRANCH}-$(checksum setup.py)" "${PIP_CACHE_DIR}"
Key 'setup-master-1496ffee88def2281f9e239a5b179bd1' already exists.