2026-06-16 16:21:30.642958 | Job console starting
2026-06-16 16:21:30.762117 | Updating git repos
2026-06-16 16:21:30.814302 | Cloning repos into workspace
2026-06-16 16:21:33.174040 | Restoring repo states
2026-06-16 16:21:33.201196 | Merging changes
2026-06-16 16:21:35.503109 | Checking out repos
2026-06-16 16:21:35.928541 | Preparing playbooks
2026-06-16 16:21:38.471783 | Running Ansible setup
2026-06-16 16:21:46.358190 | PRE-RUN START: [trusted : gitlab.com/softwarefactory-project/centosinfra-prod/dci-config/playbooks/base/pre.yaml@main]
2026-06-16 16:21:47.048184 | 
2026-06-16 16:21:47.048300 | PLAY [localhost]
2026-06-16 16:21:47.055579 | 
2026-06-16 16:21:47.055656 | TASK [Gathering Facts]
2026-06-16 16:21:47.946600 | localhost | ok
2026-06-16 16:21:47.961048 | 
2026-06-16 16:21:47.961203 | TASK [Setup log path fact]
2026-06-16 16:21:47.979817 | localhost | ok
2026-06-16 16:21:47.989761 | 
2026-06-16 16:21:47.989825 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-06-16 16:21:48.028562 | localhost | ok
2026-06-16 16:21:48.039763 | 
2026-06-16 16:21:48.039904 | TASK [emit-job-header : Print job information]
2026-06-16 16:21:48.090928 | # Job Information
2026-06-16 16:21:48.091194 | Ansible Version: 2.16.18
2026-06-16 16:21:48.091264 | Job: dci-python-test-with-dciclient-job
2026-06-16 16:21:48.091311 | Pipeline: check
2026-06-16 16:21:48.091353 | Executor: 38.102.83.47
2026-06-16 16:21:48.091393 | Triggered by: https://github.com/distributedci/dci-ansible/pull/5
2026-06-16 16:21:48.091481 | Event ID: 3cc5ab60-699f-11f1-9e8d-3a4f54de6971
2026-06-16 16:21:48.097102 | 
2026-06-16 16:21:48.097237 | LOOP [emit-job-header : Print node information]
2026-06-16 16:21:48.213299 | localhost | ok:
2026-06-16 16:21:48.213592 | localhost | # Node Information
2026-06-16 16:21:48.213651 | localhost | Inventory Hostname: testrunner
2026-06-16 16:21:48.213697 | localhost | Hostname: 559b2dcfae15
2026-06-16 16:21:48.213736 | localhost | Username: zuul
2026-06-16 16:21:48.213781 | localhost | Distro: RedHat 8.10
2026-06-16 16:21:48.213821 | localhost | Provider: k1s06
2026-06-16 16:21:48.213858 | localhost | Region:
2026-06-16 16:21:48.213896 | localhost | Label: zuul-worker-ubi8
2026-06-16 16:21:48.213933 | localhost | Product Name: OpenStack Nova
2026-06-16 16:21:48.213969 | localhost | Interface IP: zuul-worker-ubi8-0000076244
2026-06-16 16:21:48.237650 | 
2026-06-16 16:21:48.237781 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-06-16 16:21:48.676573 | localhost -> localhost | changed
2026-06-16 16:21:48.685105 | 
2026-06-16 16:21:48.685234 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-06-16 16:21:49.633380 | localhost -> localhost | changed
2026-06-16 16:21:49.644035 | 
2026-06-16 16:21:49.644167 | PLAY [all]
2026-06-16 16:21:49.656144 | 
2026-06-16 16:21:49.656289 | TASK [start-zuul-console : Start zuul_console daemon.]
2026-06-16 16:21:55.558646 | testrunner | ok
2026-06-16 16:21:55.571854 | 
2026-06-16 16:21:55.571977 | TASK [validate-host : Define zuul_info_dir fact]
2026-06-16 16:21:55.599312 | testrunner | skipping: Conditional result was False
2026-06-16 16:21:55.607825 | 
2026-06-16 16:21:55.607965 | TASK [validate-host : Ensure Zuul Ansible directory exists]
2026-06-16 16:21:55.644522 | testrunner | skipping: Conditional result was False
2026-06-16 16:21:55.653628 | 
2026-06-16 16:21:55.653788 | TASK [validate-host : Collect information about the host]
2026-06-16 16:21:55.679223 | testrunner | skipping: Conditional result was False
2026-06-16 16:21:55.687410 | 
2026-06-16 16:21:55.687605 | TASK [validate-host : Sanitize hostname]
2026-06-16 16:21:55.713588 | testrunner | skipping: Conditional result was False
2026-06-16 16:21:55.724690 | 
2026-06-16 16:21:55.724846 | TASK [validate-host : Write out all ansible variables/facts known for each host]
2026-06-16 16:21:55.761523 | testrunner | skipping: Conditional result was False
2026-06-16 16:21:55.770872 | 
2026-06-16 16:21:55.771047 | TASK [validate-host : Collect information about zuul worker]
2026-06-16 16:21:55.799103 | testrunner | skipping: Conditional result was False
2026-06-16 16:21:55.807592 | 
2026-06-16 16:21:55.807738 | TASK [validate-host : Write out all zuul information for each host]
2026-06-16 16:21:55.843065 | testrunner | skipping: Conditional result was False
2026-06-16 16:21:55.860639 | 
2026-06-16 16:21:55.860805 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-06-16 16:21:55.877941 | testrunner | skipping: Conditional result was False
2026-06-16 16:21:55.893582 | 
2026-06-16 16:21:55.893875 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-06-16 16:21:55.935141 | 
2026-06-16 16:21:55.935515 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-06-16 16:21:55.973124 | testrunner | skipping: Conditional result was False
2026-06-16 16:21:55.982111 | 
2026-06-16 16:21:55.982315 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-06-16 16:21:56.020471 | testrunner | skipping: Conditional result was False
2026-06-16 16:21:56.034643 | 
2026-06-16 16:21:56.034873 | LOOP [prepare-workspace-openshift : Include rsync tasks]
2026-06-16 16:21:56.094873 | testrunner | ok:
2026-06-16 16:21:56.095141 | testrunner | [
2026-06-16 16:21:56.095195 | testrunner |   "testrunner",
2026-06-16 16:21:56.095234 | testrunner |   {
2026-06-16 16:21:56.095269 | testrunner |     "context": "main:zuul-worker/38-102-83-49:9023",
2026-06-16 16:21:56.095304 | testrunner |     "namespace": "main",
2026-06-16 16:21:56.095338 | testrunner |     "pod": "zuul-worker-ubi8-0000076244",
2026-06-16 16:21:56.095374 | testrunner |     "resources": {
2026-06-16 16:21:56.095408 | testrunner |       "cores": 0,
2026-06-16 16:21:56.095487 | testrunner |       "instances": 1,
2026-06-16 16:21:56.095527 | testrunner |       "ram": 0
2026-06-16 16:21:56.095561 | testrunner |     },
2026-06-16 16:21:56.095595 | testrunner |     "stream_port1": 35031,
2026-06-16 16:21:56.095628 | testrunner |     "stream_port2": 40741
2026-06-16 16:21:56.095662 | testrunner |   }
2026-06-16 16:21:56.095696 | testrunner | ]
2026-06-16 16:21:56.095753 | testrunner | ok: All items complete
2026-06-16 16:21:56.095794 | 
2026-06-16 16:21:56.113871 | testrunner | included: /var/lib/zuul/builds/b5ba9e19a7e44ecc999a92aa524b8af1/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/prepare-workspace-openshift/tasks/rsync.yaml
2026-06-16 16:21:56.123624 | 
2026-06-16 16:21:56.123826 | TASK [prepare-workspace-openshift : Create src directory]
2026-06-16 16:21:57.585356 | testrunner -> localhost | ok: Runtime: 0:00:00.939629
2026-06-16 16:21:57.596211 | 
2026-06-16 16:21:57.596342 | TASK [prepare-workspace-openshift : Copy src repos to the pod]
2026-06-16 16:21:59.985647 | testrunner -> localhost | Output suppressed because no_log was given
2026-06-16 16:21:59.997794 | 
2026-06-16 16:21:59.997924 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-06-16 16:22:00.449629 | testrunner -> localhost | changed
2026-06-16 16:22:00.456747 | 
2026-06-16 16:22:00.456823 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-06-16 16:22:06.544600 | testrunner | ok: "logs"
2026-06-16 16:22:12.306408 | testrunner | ok: "artifacts"
2026-06-16 16:22:18.321978 | testrunner | ok: "docs"
2026-06-16 16:22:18.334763 | 
2026-06-16 16:22:18.334908 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-06-16 16:22:24.661099 | testrunner | changed: "logs"
2026-06-16 16:22:24.661642 | testrunner | ok: All items complete
2026-06-16 16:22:24.661719 | 
2026-06-16 16:22:30.694943 | testrunner | changed: "artifacts"
2026-06-16 16:22:36.558780 | testrunner | changed: "docs"
2026-06-16 16:22:36.577896 | 
2026-06-16 16:22:36.578043 | PLAY RECAP
2026-06-16 16:22:36.578134 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-06-16 16:22:36.578189 | testrunner | ok: 7 changed: 4 unreachable: 0 failed: 0 skipped: 11 rescued: 0 ignored: 0
2026-06-16 16:22:36.578229 | 
2026-06-16 16:22:36.709359 | PRE-RUN END RESULT_NORMAL: [trusted : gitlab.com/softwarefactory-project/centosinfra-prod/dci-config/playbooks/base/pre.yaml@main]
2026-06-16 16:22:36.710776 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master]
2026-06-16 16:22:37.278156 | 
2026-06-16 16:22:37.278305 | PLAY [all]
2026-06-16 16:22:37.287857 | 
2026-06-16 16:22:37.287940 | TASK [Install binary dependencies]
2026-06-16 16:22:37.335977 | testrunner | ok
2026-06-16 16:22:37.351336 | 
2026-06-16 16:22:37.351498 | TASK [bindep : Include find tasks]
2026-06-16 16:22:37.378641 | testrunner | ok
2026-06-16 16:22:37.384909 | testrunner | included: /var/lib/zuul/builds/b5ba9e19a7e44ecc999a92aa524b8af1/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml
2026-06-16 16:22:37.388657 | 
2026-06-16 16:22:37.388719 | TASK [bindep : Look for bindep.txt]
2026-06-16 16:22:43.445208 | testrunner | ok
2026-06-16 16:22:43.452520 | 
2026-06-16 16:22:43.452661 | TASK [bindep : Define bindep_file fact]
2026-06-16 16:22:43.469545 | testrunner | skipping: Conditional result was False
2026-06-16 16:22:43.477495 | 
2026-06-16 16:22:43.477627 | TASK [bindep : Look for other-requirements.txt]
2026-06-16 16:22:49.464931 | testrunner | ok
2026-06-16 16:22:49.471942 | 
2026-06-16 16:22:49.472085 | TASK [bindep : Define bindep_file fact]
2026-06-16 16:22:49.508509 | testrunner | skipping: Conditional result was False
2026-06-16 16:22:49.516381 | 
2026-06-16 16:22:49.516553 | TASK [bindep : Look for bindep fallback file]
2026-06-16 16:22:49.552581 | testrunner | skipping: Conditional result was False
2026-06-16 16:22:49.560460 | 
2026-06-16 16:22:49.560638 | TASK [bindep : Define bindep_file fact]
2026-06-16 16:22:49.596466 | testrunner | skipping: Conditional result was False
2026-06-16 16:22:49.606617 | 
2026-06-16 16:22:49.606762 | TASK [bindep : Include bindep tasks]
2026-06-16 16:22:49.643634 | testrunner | skipping: Conditional result was False
2026-06-16 16:22:49.651879 | 
2026-06-16 16:22:49.652030 | TASK [bindep : Include install tasks]
2026-06-16 16:22:49.690831 | testrunner | skipping: Conditional result was False
2026-06-16 16:22:49.698163 | 
2026-06-16 16:22:49.698296 | LOOP [bindep : Include package tasks]
2026-06-16 16:22:49.767721 | 
2026-06-16 16:22:49.768023 | TASK [Run test-setup role]
2026-06-16 16:22:49.790290 | testrunner | ok
2026-06-16 16:22:49.818550 | 
2026-06-16 16:22:49.818725 | TASK [test-setup : Check if project's tools/test-setup.sh exists]
2026-06-16 16:22:55.662144 | testrunner | ok
2026-06-16 16:22:55.670776 | 
2026-06-16 16:22:55.670966 | TASK [test-setup : Run tools/test-setup.sh]
2026-06-16 16:22:56.236961 | testrunner | skipping: Conditional result was False
2026-06-16 16:22:56.246151 | 
2026-06-16 16:22:56.246260 | PLAY RECAP
2026-06-16 16:22:56.246341 | testrunner | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0
2026-06-16 16:22:56.246384 | 
2026-06-16 16:22:56.406786 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master]
2026-06-16 16:22:56.410137 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/pre.yaml@master]
2026-06-16 16:22:57.026836 | 
2026-06-16 16:22:57.026951 | PLAY [all]
2026-06-16 16:22:57.037927 | 
2026-06-16 16:22:57.038009 | TASK [ensure-python : Validate python_version value]
2026-06-16 16:22:57.071645 | testrunner | skipping: Conditional result was False
2026-06-16 16:22:57.075664 | 
2026-06-16 16:22:57.075742 | TASK [ensure-python : Install specified version of python interpreter and development files (DEB)]
2026-06-16 16:22:57.109570 | testrunner | skipping: Conditional result was False
2026-06-16 16:22:57.113200 | 
2026-06-16 16:22:57.113270 | TASK [ensure-python : Pull in venv package]
2026-06-16 16:22:57.147332 | testrunner | skipping: Conditional result was False
2026-06-16 16:22:57.158304 | 
2026-06-16 16:22:57.158499 | TASK [ensure-python : Set default RPM package name]
2026-06-16 16:22:57.184861 | testrunner | skipping: Conditional result was False
2026-06-16 16:22:57.192217 | 
2026-06-16 16:22:57.192358 | TASK [ensure-python : Set RPM package name for CentOS/RHEL 9/10]
2026-06-16 16:22:57.218320 | testrunner | skipping: Conditional result was False
2026-06-16 16:22:57.225589 | 
2026-06-16 16:22:57.225731 | TASK [ensure-python : Install RPM package]
2026-06-16 16:22:57.251535 | testrunner | skipping: Conditional result was False
2026-06-16 16:22:57.258890 | 
2026-06-16 16:22:57.259049 | TASK [ensure-python : Install python using pyenv]
2026-06-16 16:22:57.285112 | testrunner | skipping: Conditional result was False
2026-06-16 16:22:57.292413 | 
2026-06-16 16:22:57.292586 | TASK [ensure-python : Activate python using stow]
2026-06-16 16:22:57.317769 | testrunner | skipping: Conditional result was False
2026-06-16 16:22:57.330832 | 
2026-06-16 16:22:57.330999 | TASK [Install pip]
2026-06-16 16:22:57.352465 | testrunner | ok
2026-06-16 16:22:57.386275 | 
2026-06-16 16:22:57.386410 | TASK [ensure-pip : Check if pip is installed]
2026-06-16 16:23:02.447801 | testrunner | /usr/bin/pip3
2026-06-16 16:23:02.556790 | testrunner | usage: __main__.py [-h]
2026-06-16 16:23:02.556847 | testrunner |                    {unpack,install,install-scripts,convert,version,help} ...
2026-06-16 16:23:02.556865 | testrunner |
2026-06-16 16:23:02.556880 | testrunner | positional arguments:
2026-06-16 16:23:02.556898 | testrunner |   {unpack,install,install-scripts,convert,version,help}
2026-06-16 16:23:02.556915 | testrunner |                         commands
2026-06-16 16:23:02.556931 | testrunner |     unpack              Unpack wheel
2026-06-16 16:23:02.556947 | testrunner |     install             Install wheels
2026-06-16 16:23:02.556963 | testrunner |     install-scripts     Install console_scripts
2026-06-16 16:23:02.556976 | testrunner |     convert             Convert egg or wininst to wheel
2026-06-16 16:23:02.556990 | testrunner |     version             Print version and exit
2026-06-16 16:23:02.557004 | testrunner |     help                Show this help
2026-06-16 16:23:02.557016 | testrunner |
2026-06-16 16:23:02.557029 | testrunner | optional arguments:
2026-06-16 16:23:02.557043 | testrunner |   -h, --help            show this help message and exit
2026-06-16 16:23:03.624873 | testrunner | ok: Runtime: 0:00:00.126768
2026-06-16 16:23:03.632227 | 
2026-06-16 16:23:03.632354 | LOOP [ensure-pip : Install pip from packages]
2026-06-16 16:23:03.670150 | testrunner | skipping: Conditional result was False
2026-06-16 16:23:03.686214 | 
2026-06-16 16:23:03.686387 | TASK [ensure-pip : Ensure setuptools]
2026-06-16 16:23:03.712483 | testrunner | skipping: Conditional result was False
2026-06-16 16:23:03.722068 | 
2026-06-16 16:23:03.722265 | TASK [ensure-pip : Check for ensurepip module]
2026-06-16 16:23:04.023028 | testrunner | skipping: Conditional result was False
2026-06-16 16:23:04.031790 | 
2026-06-16 16:23:04.031959 | TASK [ensure-pip : Ensure python3-venv]
2026-06-16 16:23:04.057983 | testrunner | skipping: Conditional result was False
2026-06-16 16:23:04.066709 | 
2026-06-16 16:23:04.066847 | TASK [ensure-pip : Install pip from source]
2026-06-16 16:23:04.092676 | testrunner | skipping: Conditional result was False
2026-06-16 16:23:04.100892 | 
2026-06-16 16:23:04.101037 | TASK [ensure-pip : Probe for venv python full path]
2026-06-16 16:23:09.084739 | testrunner | /usr/bin/python3
2026-06-16 16:23:10.094154 | testrunner | ok: Runtime: 0:00:00.009539
2026-06-16 16:23:10.101402 | 
2026-06-16 16:23:10.101565 | TASK [ensure-pip : Set host default]
2026-06-16 16:23:10.175421 | testrunner | ok
2026-06-16 16:23:10.183634 | 
2026-06-16 16:23:10.183773 | TASK [ensure-pip : Set ensure_pip_virtualenv_command]
2026-06-16 16:23:10.238321 | testrunner | ok
2026-06-16 16:23:10.249992 | 
2026-06-16 16:23:10.250127 | TASK [ensure-tox : Check if tox is installed]
2026-06-16 16:23:15.211558 | testrunner | /workspace/.local/bin/tox
2026-06-16 16:23:16.196284 | testrunner | ok: Runtime: 0:00:00.008943
2026-06-16 16:23:16.202951 | 
2026-06-16 16:23:16.203081 | TASK [ensure-tox : Export preinstalled tox_exectuable]
2026-06-16 16:23:16.256911 | testrunner | ok
2026-06-16 16:23:16.264087 | 
2026-06-16 16:23:16.264233 | TASK [ensure-tox : Create local venv]
2026-06-16 16:23:16.560092 | testrunner | skipping: Conditional result was False
2026-06-16 16:23:16.567867 | 
2026-06-16 16:23:16.568001 | TASK [ensure-tox : Install tox to local venv]
2026-06-16 16:23:17.026778 | testrunner | skipping: Conditional result was False
2026-06-16 16:23:17.034568 | 
2026-06-16 16:23:17.034713 | TASK [ensure-tox : Export installed tox_executable path]
2026-06-16 16:23:17.060719 | testrunner | skipping: Conditional result was False
2026-06-16 16:23:17.067991 | 
2026-06-16 16:23:17.068129 | TASK [ensure-tox : Output tox version]
2026-06-16 16:23:22.015020 | testrunner | 3.28.0 imported from /workspace/.local/lib/python3.6/site-packages/tox/__init__.py
2026-06-16 16:23:23.067272 | testrunner | ok: Runtime: 0:00:00.229303
2026-06-16 16:23:23.072591 | 
2026-06-16 16:23:23.072700 | TASK [ensure-tox : Make global symlink]
2026-06-16 16:23:23.097781 | testrunner | skipping: Conditional result was False
2026-06-16 16:23:23.103166 | 
2026-06-16 16:23:23.103228 | PLAY RECAP
2026-06-16 16:23:23.103271 | testrunner | ok: 7 changed: 4 unreachable: 0 failed: 0 skipped: 17 rescued: 0 ignored: 0
2026-06-16 16:23:23.103290 | 
2026-06-16 16:23:23.219636 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/pre.yaml@master]
2026-06-16 16:23:23.222094 | PRE-RUN START: [trusted : gitlab.com/softwarefactory-project/centosinfra-prod/dci-config/playbooks/python/pre-run.yaml@main]
2026-06-16 16:23:23.843454 | 
2026-06-16 16:23:23.843556 | PLAY [testrunner]
2026-06-16 16:23:23.852036 | 
2026-06-16 16:23:23.852104 | TASK [Get full path of current project's src dir]
2026-06-16 16:23:28.921945 | testrunner | /workspace/src/github.com/distributedci/dci-ansible
2026-06-16 16:23:29.955046 | testrunner | ok: Runtime: 0:00:00.008827
2026-06-16 16:23:29.959562 | 
2026-06-16 16:23:29.959654 | TASK [Set fact for zuul_basedir]
2026-06-16 16:23:30.038568 | testrunner | ok
2026-06-16 16:23:30.042693 | 
2026-06-16 16:23:30.042774 | TASK [Install required packages]
2026-06-16 16:24:40.264540 | testrunner | changed
2026-06-16 16:24:40.271591 | 
2026-06-16 16:24:40.271726 | TASK [Install tox]
2026-06-16 16:24:40.293236 | testrunner | ok
2026-06-16 16:24:40.325546 | 
2026-06-16 16:24:40.325641 | TASK [Install pip]
2026-06-16 16:24:40.344720 | testrunner | ok
2026-06-16 16:24:40.368722 | 
2026-06-16 16:24:40.368815 | TASK [ensure-pip : Check if pip is installed]
2026-06-16 16:24:45.376681 | testrunner | /usr/bin/pip3
2026-06-16 16:24:45.485088 | testrunner | usage: __main__.py [-h]
2026-06-16 16:24:45.485172 | testrunner |                    {unpack,install,install-scripts,convert,version,help} ...
2026-06-16 16:24:45.485192 | testrunner |
2026-06-16 16:24:45.485208 | testrunner | positional arguments:
2026-06-16 16:24:45.485226 | testrunner |   {unpack,install,install-scripts,convert,version,help}
2026-06-16 16:24:45.485243 | testrunner |                         commands
2026-06-16 16:24:45.485260 | testrunner |     unpack              Unpack wheel
2026-06-16 16:24:45.485278 | testrunner |     install             Install wheels
2026-06-16 16:24:45.485295 | testrunner |     install-scripts     Install console_scripts
2026-06-16 16:24:45.485309 | testrunner |     convert             Convert egg or wininst to wheel
2026-06-16 16:24:45.485325 | testrunner |     version             Print version and exit
2026-06-16 16:24:45.485354 | testrunner |     help                Show this help
2026-06-16 16:24:45.485374 | testrunner |
2026-06-16 16:24:45.485392 | testrunner | optional arguments:
2026-06-16 16:24:45.485412 | testrunner |   -h, --help            show this help message and exit
2026-06-16 16:24:46.574479 | testrunner | ok: Runtime: 0:00:00.127953
2026-06-16 16:24:46.581801 | 
2026-06-16 16:24:46.581934 | LOOP [ensure-pip : Install pip from packages]
2026-06-16 16:24:46.616136 | testrunner | skipping: Conditional result was False
2026-06-16 16:24:46.625575 | 
2026-06-16 16:24:46.625713 | TASK [ensure-pip : Ensure setuptools]
2026-06-16 16:24:46.651630 | testrunner | skipping: Conditional result was False
2026-06-16 16:24:46.659775 | 
2026-06-16 16:24:46.659928 | TASK [ensure-pip : Check for ensurepip module]
2026-06-16 16:24:46.979656 | testrunner | skipping: Conditional result was False
2026-06-16 16:24:46.989488 | 
2026-06-16 16:24:46.989634 | TASK [ensure-pip : Ensure python3-venv]
2026-06-16 16:24:47.015246 | testrunner | skipping: Conditional result was False
2026-06-16 16:24:47.023270 | 
2026-06-16 16:24:47.023401 | TASK [ensure-pip : Install pip from source]
2026-06-16 16:24:47.049001 | testrunner | skipping: Conditional result was False
2026-06-16 16:24:47.056219 | 
2026-06-16 16:24:47.056346 | TASK [ensure-pip : Probe for venv python full path]
2026-06-16 16:24:52.791202 | testrunner | /usr/bin/python3
2026-06-16 16:24:53.787600 | testrunner | ok: Runtime: 0:00:00.009488
2026-06-16 16:24:53.794553 | 
2026-06-16 16:24:53.794687 | TASK [ensure-pip : Set host default]
2026-06-16 16:24:53.867272 | testrunner | ok
2026-06-16 16:24:53.873610 | 
2026-06-16 16:24:53.873766 | TASK [ensure-pip : Set ensure_pip_virtualenv_command]
2026-06-16 16:24:53.948022 | testrunner | ok
2026-06-16 16:24:53.959621 | 
2026-06-16 16:24:53.959748 | TASK [ensure-tox : Check if tox is installed]
2026-06-16 16:24:58.982572 | testrunner | /workspace/.local/bin/tox
2026-06-16 16:25:00.033704 | testrunner | ok: Runtime: 0:00:00.009194
2026-06-16 16:25:00.041899 | 
2026-06-16 16:25:00.042189 | TASK [ensure-tox : Export preinstalled tox_exectuable]
2026-06-16 16:25:00.076743 | testrunner | ok
2026-06-16 16:25:00.083364 | 
2026-06-16 16:25:00.083516 | TASK [ensure-tox : Create local venv]
2026-06-16 16:25:00.433488 | testrunner | skipping: Conditional result was False
2026-06-16 16:25:00.442163 | 
2026-06-16 16:25:00.442300 | TASK [ensure-tox : Install tox to local venv]
2026-06-16 16:25:00.924241 | testrunner | skipping: Conditional result was False
2026-06-16 16:25:00.932994 | 
2026-06-16 16:25:00.933136 | TASK [ensure-tox : Export installed tox_executable path]
2026-06-16 16:25:00.958813 | testrunner | skipping: Conditional result was False
2026-06-16 16:25:00.966424 | 
2026-06-16 16:25:00.966614 | TASK [ensure-tox : Output tox version]
2026-06-16 16:25:06.074778 | testrunner | 3.28.0 imported from /workspace/.local/lib/python3.6/site-packages/tox/__init__.py
2026-06-16 16:25:07.292396 | testrunner | ok: Runtime: 0:00:00.227207
2026-06-16 16:25:07.300581 | 
2026-06-16 16:25:07.300716 | TASK [ensure-tox : Make global symlink]
2026-06-16 16:25:07.325936 | testrunner | skipping: Conditional result was False
2026-06-16 16:25:07.339406 | 
2026-06-16 16:25:07.339576 | LOOP [Gather existing test-requirements.txt files]
2026-06-16 16:25:13.295726 | testrunner | ok:
2026-06-16 16:25:13.296070 | testrunner | {
2026-06-16 16:25:13.296130 | testrunner |   "canonical_hostname": "github.com",
2026-06-16 16:25:13.296173 | testrunner |   "canonical_name": "github.com/distributedci/dci-ansible",
2026-06-16 16:25:13.296212 | testrunner |   "checkout": "main",
2026-06-16 16:25:13.296250 | testrunner |   "checkout_description": "zuul branch",
2026-06-16 16:25:13.296287 | testrunner |   "commit": "195ded490a3841b8c0e8da8948f4e705d874720f",
2026-06-16 16:25:13.296323 | testrunner |   "name": "distributedci/dci-ansible",
2026-06-16 16:25:13.296359 | testrunner |   "required": false,
2026-06-16 16:25:13.296395 | testrunner |   "short_name": "dci-ansible",
2026-06-16 16:25:13.296464 | testrunner |   "src_dir": "src/github.com/distributedci/dci-ansible"
2026-06-16 16:25:13.296512 | testrunner | }
2026-06-16 16:25:13.296571 | 
2026-06-16 16:25:19.246675 | testrunner | ok:
2026-06-16 16:25:19.246820 | testrunner | {
2026-06-16 16:25:19.246869 | testrunner |   "canonical_hostname": "github.com",
2026-06-16 16:25:19.246907 | testrunner |   "canonical_name": "github.com/distributedci/dci-control-server",
2026-06-16 16:25:19.246944 | testrunner |   "checkout": "main",
2026-06-16 16:25:19.246978 | testrunner |   "checkout_description": "zuul branch",
2026-06-16 16:25:19.247012 | testrunner |   "commit": "4ba1a779be565de9a6f47d616151c8b0bd23f864",
2026-06-16 16:25:19.247058 | testrunner |   "name": "distributedci/dci-control-server",
2026-06-16 16:25:19.247093 | testrunner |   "required": true,
2026-06-16 16:25:19.247127 | testrunner |   "short_name": "dci-control-server",
2026-06-16 16:25:19.247160 | testrunner |   "src_dir": "src/github.com/distributedci/dci-control-server"
2026-06-16 16:25:19.247194 | testrunner | }
2026-06-16 16:25:25.026148 | testrunner | ok:
2026-06-16 16:25:25.026474 | testrunner | {
2026-06-16 16:25:25.026544 | testrunner |   "canonical_hostname": "github.com",
2026-06-16 16:25:25.026585 | testrunner |   "canonical_name": "github.com/distributedci/dci-pipeline",
2026-06-16 16:25:25.026623 | testrunner |   "checkout": "main",
2026-06-16 16:25:25.026666 | testrunner |   "checkout_description": "zuul branch",
2026-06-16 16:25:25.026721 | testrunner |   "commit": "3f6e2d60df291b5b85c2fac4e5c17da88f50e7fc",
2026-06-16 16:25:25.026777 | testrunner |   "name": "distributedci/dci-pipeline",
2026-06-16 16:25:25.026834 | testrunner |   "required": false,
2026-06-16 16:25:25.026876 | testrunner |   "short_name": "dci-pipeline",
2026-06-16 16:25:25.026911 | testrunner |   "src_dir": "src/github.com/distributedci/dci-pipeline"
2026-06-16 16:25:25.026946 | testrunner | }
2026-06-16 16:25:30.770135 | testrunner | ok:
2026-06-16 16:25:30.770286 | testrunner | {
2026-06-16 16:25:30.770337 | testrunner |   "canonical_hostname": "github.com",
2026-06-16 16:25:30.770378 | testrunner |   "canonical_name": "github.com/distributedci/python-dciclient",
2026-06-16 16:25:30.770422 | testrunner |   "checkout": "main",
2026-06-16 16:25:30.770501 | testrunner |   "checkout_description": "zuul branch",
2026-06-16 16:25:30.770540 | testrunner |   "commit": "ec18fb7db4b2b1764b8a342bcad42f710ec19af3",
2026-06-16 16:25:30.770576 | testrunner |   "name": "distributedci/python-dciclient",
2026-06-16 16:25:30.770612 | testrunner |   "required": true,
2026-06-16 16:25:30.770647 | testrunner |   "short_name": "python-dciclient",
2026-06-16 16:25:30.770680 | testrunner |   "src_dir": "src/github.com/distributedci/python-dciclient"
2026-06-16 16:25:30.770714 | testrunner | }
2026-06-16 16:25:36.409364 | testrunner | ok:
2026-06-16 16:25:36.409645 | testrunner | {
2026-06-16 16:25:36.409711 | testrunner |   "canonical_hostname": "gitlab.com",
2026-06-16 16:25:36.409754 | testrunner |   "canonical_name": "gitlab.com/softwarefactory-project/centosinfra-prod/dci-config",
2026-06-16 16:25:36.409794 | testrunner |   "checkout": "main",
2026-06-16 16:25:36.409832 | testrunner |   "checkout_description": "zuul branch",
2026-06-16 16:25:36.409869 | testrunner |   "commit": "401c077f4f321288dc08f65b2bd861fbd6a8e7ea",
2026-06-16 16:25:36.409906 | testrunner |   "name": "softwarefactory-project/centosinfra-prod/dci-config",
2026-06-16 16:25:36.409943 | testrunner |   "required": true,
2026-06-16 16:25:36.409978 | testrunner |   "short_name": "dci-config",
2026-06-16 16:25:36.410014 | testrunner |   "src_dir": "src/gitlab.com/softwarefactory-project/centosinfra-prod/dci-config"
2026-06-16 16:25:36.410050 | testrunner | }
2026-06-16 16:25:36.434027 | 
2026-06-16 16:25:36.434221 | TASK [Initialize existing_requirements_files with existing test-requirements.txt]
2026-06-16 16:25:36.486533 | testrunner | ok
2026-06-16 16:25:36.489569 | 
2026-06-16 16:25:36.489696 | LOOP [Gather existing requirements.txt files]
2026-06-16 16:25:41.965922 | testrunner | ok:
2026-06-16 16:25:41.966286 | testrunner | {
2026-06-16 16:25:41.966345 | testrunner |   "canonical_hostname": "github.com",
2026-06-16 16:25:41.966386 | testrunner |   "canonical_name": "github.com/distributedci/dci-ansible",
2026-06-16 16:25:41.966423 | testrunner |   "checkout": "main",
2026-06-16 16:25:41.966515 | testrunner |   "checkout_description": "zuul branch",
2026-06-16 16:25:41.966552 | testrunner |   "commit": "195ded490a3841b8c0e8da8948f4e705d874720f",
2026-06-16 16:25:41.966588 | testrunner |   "name": "distributedci/dci-ansible",
2026-06-16 16:25:41.966623 | testrunner |   "required": false,
2026-06-16 16:25:41.966673 | testrunner |   "short_name": "dci-ansible",
2026-06-16 16:25:41.966709 | testrunner |   "src_dir": "src/github.com/distributedci/dci-ansible"
2026-06-16 16:25:41.966743 | testrunner | }
2026-06-16 16:25:47.622168 | testrunner | ok:
2026-06-16 16:25:47.622300 | testrunner | {
2026-06-16 16:25:47.622349 | testrunner |   "canonical_hostname": "github.com",
2026-06-16 16:25:47.622391 | testrunner |   "canonical_name": "github.com/distributedci/dci-control-server",
2026-06-16 16:25:47.622462 | testrunner |   "checkout": "main",
2026-06-16 16:25:47.622518 | testrunner |   "checkout_description": "zuul branch",
2026-06-16 16:25:47.622560 | testrunner |   "commit": "4ba1a779be565de9a6f47d616151c8b0bd23f864",
2026-06-16 16:25:47.622600 | testrunner |   "name": "distributedci/dci-control-server",
2026-06-16 16:25:47.622637 | testrunner |   "required": true,
2026-06-16 16:25:47.622672 | testrunner |   "short_name": "dci-control-server",
2026-06-16 16:25:47.622710 | testrunner |   "src_dir": "src/github.com/distributedci/dci-control-server"
2026-06-16 16:25:47.622748 | testrunner | }
2026-06-16 16:25:53.356326 | testrunner | ok:
2026-06-16 16:25:53.356425 | testrunner | {
2026-06-16 16:25:53.356486 | testrunner |   "canonical_hostname": "github.com",
2026-06-16 16:25:53.356513 | testrunner |   "canonical_name": "github.com/distributedci/dci-pipeline",
2026-06-16 16:25:53.356532 | testrunner |   "checkout": "main",
2026-06-16 16:25:53.356549 | testrunner |   "checkout_description": "zuul branch",
2026-06-16 16:25:53.356565 | testrunner |   "commit": "3f6e2d60df291b5b85c2fac4e5c17da88f50e7fc",
2026-06-16 16:25:53.356581 | testrunner |   "name": "distributedci/dci-pipeline",
2026-06-16 16:25:53.356597 | testrunner |   "required": false,
2026-06-16 16:25:53.356613 | testrunner |   "short_name": "dci-pipeline",
2026-06-16 16:25:53.356628 | testrunner |   "src_dir": "src/github.com/distributedci/dci-pipeline"
2026-06-16 16:25:53.356644 | testrunner | }
2026-06-16 16:25:58.888062 | testrunner | ok:
2026-06-16 16:25:58.888270 | testrunner | {
2026-06-16 16:25:58.888322 | testrunner |   "canonical_hostname": "github.com",
2026-06-16 16:25:58.888360 | testrunner |   "canonical_name": "github.com/distributedci/python-dciclient",
2026-06-16 16:25:58.888396 | testrunner |   "checkout": "main",
2026-06-16 16:25:58.888471 | testrunner |   "checkout_description": "zuul branch",
2026-06-16 16:25:58.888511 | testrunner |   "commit": "ec18fb7db4b2b1764b8a342bcad42f710ec19af3",
2026-06-16 16:25:58.888546 | testrunner |   "name": "distributedci/python-dciclient",
2026-06-16 16:25:58.888579 | testrunner |   "required": true,
2026-06-16 16:25:58.888612 | testrunner |   "short_name": "python-dciclient",
2026-06-16 16:25:58.888648 | testrunner |   "src_dir": "src/github.com/distributedci/python-dciclient"
2026-06-16 16:25:58.888680 | testrunner | }
2026-06-16 16:26:04.401133 | testrunner | ok:
2026-06-16 16:26:04.401290 | testrunner | {
2026-06-16 16:26:04.401339 | testrunner |   "canonical_hostname": "gitlab.com",
2026-06-16 16:26:04.401378 | testrunner |   "canonical_name": "gitlab.com/softwarefactory-project/centosinfra-prod/dci-config",
2026-06-16 16:26:04.401419 | testrunner |   "checkout": "main",
2026-06-16 16:26:04.401530 | testrunner |   "checkout_description": "zuul branch",
2026-06-16 16:26:04.401593 | testrunner |   "commit": "401c077f4f321288dc08f65b2bd861fbd6a8e7ea",
2026-06-16 16:26:04.401633 | testrunner |   "name": "softwarefactory-project/centosinfra-prod/dci-config",
2026-06-16 16:26:04.401669 | testrunner |   "required": true,
2026-06-16 16:26:04.401705 | testrunner |   "short_name": "dci-config",
2026-06-16 16:26:04.401739 | testrunner |   "src_dir": "src/gitlab.com/softwarefactory-project/centosinfra-prod/dci-config"
2026-06-16 16:26:04.401774 | testrunner | }
2026-06-16 16:26:04.416105 | 
2026-06-16 16:26:04.416284 | TASK [Append existing requirements.txt to existing_requirements_files]
2026-06-16 16:26:04.500865 | testrunner | ok
2026-06-16 16:26:04.507781 | 
2026-06-16 16:26:04.507903 | TASK [Debug all existing requirements files]
2026-06-16 16:26:04.550388 | testrunner | ok:
2026-06-16 16:26:04.551181 | testrunner | {
2026-06-16 16:26:04.551297 | testrunner |   "existing_requirements_files": [
2026-06-16 16:26:04.551393 | testrunner |     "/workspace/src/github.com/distributedci/dci-ansible/test-requirements.txt",
2026-06-16 16:26:04.551690 | testrunner |     "/workspace/src/github.com/distributedci/dci-control-server/test-requirements.txt",
2026-06-16 16:26:04.551955 | testrunner |     "/workspace/src/github.com/distributedci/dci-pipeline/test-requirements.txt",
2026-06-16 16:26:04.552011 | testrunner |     "/workspace/src/github.com/distributedci/python-dciclient/test-requirements.txt",
2026-06-16 16:26:04.552050 | testrunner |     "/workspace/src/github.com/distributedci/dci-ansible/requirements.txt",
2026-06-16 16:26:04.552086 | testrunner |     "/workspace/src/github.com/distributedci/dci-control-server/requirements.txt",
2026-06-16 16:26:04.552120 | testrunner |     "/workspace/src/github.com/distributedci/dci-pipeline/requirements.txt",
2026-06-16 16:26:04.552155 | testrunner |     "/workspace/src/github.com/distributedci/python-dciclient/requirements.txt"
2026-06-16 16:26:04.552190 | testrunner |   ]
2026-06-16 16:26:04.552225 | testrunner | }
2026-06-16 16:26:04.558173 | 
2026-06-16 16:26:04.558416 | LOOP [Replace dci-control-server link in all existing requirements files]
2026-06-16 16:26:10.663951 | testrunner | ok
2026-06-16 16:26:10.664296 | testrunner | ok: All items complete
2026-06-16 16:26:10.664357 | 
2026-06-16 16:26:16.406800 | testrunner | ok
2026-06-16 16:26:22.155507 | testrunner | ok
2026-06-16 16:26:27.789080 | testrunner | changed: 1 replacements made
2026-06-16 16:26:33.689372 | testrunner | ok
2026-06-16 16:26:39.307564 | testrunner | ok
2026-06-16 16:26:45.007460 | testrunner | ok
2026-06-16 16:26:50.835824 | testrunner | ok
2026-06-16 16:26:50.847312 | 
2026-06-16 16:26:50.847538 | LOOP [Replace dciclient link in all existing requirements files]
2026-06-16 16:26:56.649620 | testrunner | ok
2026-06-16 16:27:02.481794 | testrunner | changed: 1 replacements made
2026-06-16 16:27:08.239555 | testrunner | ok
2026-06-16 16:27:14.016575 | testrunner | ok
2026-06-16 16:27:19.829000 | testrunner | changed: 1 replacements made
2026-06-16 16:27:25.768877 | testrunner | ok
2026-06-16 16:27:31.586748 | testrunner | changed: 1 replacements made
2026-06-16 16:27:37.301077 | testrunner | ok
2026-06-16 16:27:37.320065 | 
2026-06-16 16:27:37.320262 | LOOP [Read and display all requirements files from remote host]
2026-06-16 16:27:43.293761 | testrunner | ok: "/workspace/src/github.com/distributedci/dci-ansible/test-requirements.txt"
2026-06-16 16:27:43.294129 | testrunner | changed: All items complete
2026-06-16 16:27:43.294190 | 
2026-06-16 16:27:49.172519 | testrunner | ok: "/workspace/src/github.com/distributedci/dci-control-server/test-requirements.txt"
2026-06-16 16:27:54.855679 | testrunner | ok: "/workspace/src/github.com/distributedci/dci-pipeline/test-requirements.txt"
2026-06-16 16:28:00.566690 | testrunner | ok: "/workspace/src/github.com/distributedci/python-dciclient/test-requirements.txt"
2026-06-16 16:28:06.318478 | testrunner | ok: "/workspace/src/github.com/distributedci/dci-ansible/requirements.txt"
2026-06-16 16:28:12.059097 | testrunner | ok: "/workspace/src/github.com/distributedci/dci-control-server/requirements.txt"
2026-06-16 16:28:17.939417 | testrunner | ok: "/workspace/src/github.com/distributedci/dci-pipeline/requirements.txt"
2026-06-16 16:28:23.866611 | testrunner | ok: "/workspace/src/github.com/distributedci/python-dciclient/requirements.txt"
2026-06-16 16:28:23.879754 | 
2026-06-16 16:28:23.879883 | LOOP [Show contents of requirements files]
2026-06-16 16:28:23.941964 | testrunner | ok:
2026-06-16 16:28:23.942296 | testrunner | /workspace/src/github.com/distributedci/dci-ansible/test-requirements.txt:
2026-06-16 16:28:23.942353 | testrunner | pytest
2026-06-16 16:28:23.942394 | testrunner | flake8
2026-06-16 16:28:23.942462 | testrunner | -r requirements.txt
2026-06-16 16:28:23.948105 | testrunner | ok:
2026-06-16 16:28:23.948198 | testrunner | /workspace/src/github.com/distributedci/dci-control-server/test-requirements.txt:
2026-06-16 16:28:23.948250 | testrunner | mock
2026-06-16 16:28:23.948292 | testrunner | pytest
2026-06-16 16:28:23.948548 | testrunner | -e /workspace/src/github.com/distributedci/python-dciclient
2026-06-16 16:28:23.948606 | testrunner | flake8
2026-06-16 16:28:23.948647 | testrunner | tox
2026-06-16 16:28:23.948686 | testrunner | responses
2026-06-16 16:28:23.948723 | testrunner | importlib-metadata
2026-06-16 16:28:23.948759 | testrunner | freezegun
2026-06-16 16:28:23.954541 | testrunner | ok:
2026-06-16 16:28:23.954639 | testrunner | /workspace/src/github.com/distributedci/dci-pipeline/test-requirements.txt:
2026-06-16 16:28:23.954694 | testrunner | mock
2026-06-16 16:28:23.954753 | testrunner | pytest
2026-06-16 16:28:23.960319 | testrunner | ok:
2026-06-16 16:28:23.960413 | testrunner | /workspace/src/github.com/distributedci/python-dciclient/test-requirements.txt:
2026-06-16 16:28:23.960500 | testrunner | pytest
2026-06-16 16:28:23.960544 | testrunner | -e /workspace/src/github.com/distributedci/dci-control-server
2026-06-16 16:28:23.960584 | testrunner | mock
2026-06-16 16:28:23.960622 | testrunner | boto3
2026-06-16 16:28:23.960659 | testrunner | responses
2026-06-16 16:28:23.965961 | testrunner | ok:
2026-06-16 16:28:23.966052 | testrunner | /workspace/src/github.com/distributedci/dci-ansible/requirements.txt:
2026-06-16 16:28:23.966102 | testrunner | dciauth
2026-06-16 16:28:23.966144 | testrunner | -e /workspace/src/github.com/distributedci/python-dciclient
2026-06-16 16:28:23.966184 | testrunner | ansible
2026-06-16 16:28:23.966221 | testrunner | selinux
2026-06-16 16:28:23.972038 | testrunner | ok:
2026-06-16 16:28:23.972133 | testrunner | /workspace/src/github.com/distributedci/dci-control-server/requirements.txt:
2026-06-16 16:28:23.972182 | testrunner | pyjwt
2026-06-16 16:28:23.972223 | testrunner | cryptography
2026-06-16 16:28:23.972264 | testrunner | pyparsing
2026-06-16 16:28:23.972303 | testrunner | pytz
2026-06-16 16:28:23.972341 | testrunner | psycopg[binary,pool]
2026-06-16 16:28:23.972379 | testrunner | pyOpenSSL
2026-06-16 16:28:23.972416 | testrunner | jsonschema
2026-06-16 16:28:23.972494 | testrunner | SQLAlchemy
2026-06-16 16:28:23.972533 | testrunner | alembic
2026-06-16 16:28:23.972570 | testrunner | six
2026-06-16 16:28:23.972607 | testrunner | requests
2026-06-16 16:28:23.972643 | testrunner | gunicorn[gevent]
2026-06-16 16:28:23.972679 | testrunner | flask
2026-06-16 16:28:23.972715 | testrunner | jinja2
2026-06-16 16:28:23.972750 | testrunner | markupsafe
2026-06-16 16:28:23.972786 | testrunner | itsdangerous
2026-06-16 16:28:23.972821 | testrunner | werkzeug
2026-06-16 16:28:23.972856 | testrunner | SQLAlchemy-Utils
2026-06-16 16:28:23.972890 | testrunner | passlib
2026-06-16 16:28:23.972925 | testrunner | kombu
2026-06-16 16:28:23.972959 | testrunner | boto3
2026-06-16 16:28:23.972994 | testrunner | redis
2026-06-16 16:28:23.973029 | testrunner | dciauth
2026-06-16 16:28:23.973063 | testrunner | tenacity
2026-06-16 16:28:23.978638 | testrunner | ok:
2026-06-16 16:28:23.978920 | testrunner | /workspace/src/github.com/distributedci/dci-pipeline/requirements.txt:
2026-06-16 16:28:23.978975 | testrunner | ansible-core
2026-06-16 16:28:23.979017 | testrunner | ansible-runner
2026-06-16 16:28:23.979056 | testrunner | dciauth
2026-06-16 16:28:23.979094 | testrunner | -e /workspace/src/github.com/distributedci/python-dciclient
2026-06-16 16:28:23.979135 | testrunner | junit-xml
2026-06-16 16:28:23.979240 | testrunner | jmespath
2026-06-16 16:28:23.979286 | testrunner | selinux
2026-06-16 16:28:23.979324 | testrunner | psutil
2026-06-16 16:28:23.983077 | testrunner | ok:
2026-06-16 16:28:23.983139 | testrunner | /workspace/src/github.com/distributedci/python-dciclient/requirements.txt:
2026-06-16 16:28:23.983174 | testrunner | PrettyTable
2026-06-16 16:28:23.983202 | testrunner | requests
2026-06-16 16:28:23.983228 | testrunner | dciauth
2026-06-16 16:28:23.987750 | 
2026-06-16 16:28:23.987887 | PLAY RECAP
2026-06-16 16:28:23.987934 | testrunner | ok: 19 changed: 7 unreachable: 0 failed: 0 skipped: 9 rescued: 0 ignored: 0
2026-06-16 16:28:23.987955 | 
2026-06-16 16:28:24.100097 | PRE-RUN END RESULT_NORMAL: [trusted : gitlab.com/softwarefactory-project/centosinfra-prod/dci-config/playbooks/python/pre-run.yaml@main]
2026-06-16 16:28:24.102889 | RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/run.yaml@master]
2026-06-16 16:28:24.711975 | 
2026-06-16 16:28:24.712101 | PLAY [all]
2026-06-16 16:28:24.722939 | 
2026-06-16 16:28:24.723017 | TASK [revoke-sudo : Check if zuul is sudoer]
2026-06-16 16:28:31.076738 | testrunner | ok: Runtime: 0:00:00.043828
2026-06-16 16:28:31.084069 | 
2026-06-16 16:28:31.084234 | TASK [revoke-sudo : Remove sudo access for zuul user.]
2026-06-16 16:28:37.140888 | testrunner | ok: Runtime: 0:00:00.012187
2026-06-16 16:28:37.149619 | 
2026-06-16 16:28:37.149772 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.]
2026-06-16 16:28:42.246368 | testrunner | root is not in the sudoers file.  This incident will be reported.
2026-06-16 16:28:43.318680 | testrunner | ok: Runtime: 0:00:00.039193
2026-06-16 16:28:43.331269 | 
2026-06-16 16:28:43.331416 | TASK [tox : Check to see if the constraints file exists]
2026-06-16 16:28:43.367992 | testrunner | skipping: Conditional result was False
2026-06-16 16:28:43.375651 | 
2026-06-16 16:28:43.375791 | TASK [tox : Fail if constraints file is missing]
2026-06-16 16:28:43.411885 | testrunner | skipping: Conditional result was False
2026-06-16 16:28:43.419967 | 
2026-06-16 16:28:43.420113 | TASK [tox : Record file location]
2026-06-16 16:28:43.456511 | testrunner | skipping: Conditional result was False
2026-06-16 16:28:43.463906 | 
2026-06-16 16:28:43.464044 | TASK [tox : Install tox siblings]
2026-06-16 16:28:43.496356 | testrunner | ok
2026-06-16 16:28:43.509482 | testrunner | included: /var/lib/zuul/builds/b5ba9e19a7e44ecc999a92aa524b8af1/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/tox/tasks/siblings.yaml
2026-06-16 16:28:43.516495 | 
2026-06-16 16:28:43.516584 | TASK [tox : Run tox without tests]
2026-06-16 16:28:48.829488 | testrunner | using tox.ini: /workspace/src/github.com/distributedci/dci-ansible/tox.ini (pid 1168)
2026-06-16 16:28:48.836372 | testrunner | using tox-3.28.0 from /workspace/.local/lib/python3.6/site-packages/tox/__init__.py (pid 1168)
2026-06-16 16:28:48.836425 | testrunner | skipping sdist step
2026-06-16 16:28:48.906870 | testrunner | /usr/bin/python3.6 (/usr/bin/python3.6) is {'executable': '/usr/bin/python3.6', 'implementation': 'CPython', 'version_info': [3, 6, 8, 'final', 0], 'version': '3.6.8 (default, Aug 11 2025, 09:47:15) \n[GCC 8.5.0 20210514 (Red Hat 8.5.0-28)]', 'is_64': True, 'sysplatform': 'linux', 'os_sep': '/', 'extra_version_info': None}
2026-06-16 16:28:48.907017 | testrunner | pep8 uses /usr/bin/python3.6
2026-06-16 16:28:48.907492 | testrunner | pep8 start: getenv /workspace/src/github.com/distributedci/dci-ansible/.tox/pep8
2026-06-16 16:28:48.907880 | testrunner | pep8 cannot reuse: no previous config /workspace/src/github.com/distributedci/dci-ansible/.tox/pep8/.tox-config1
2026-06-16 16:28:48.907915 | testrunner | pep8 create: /workspace/src/github.com/distributedci/dci-ansible/.tox/pep8
2026-06-16 16:28:48.908578 | testrunner | setting PATH=/workspace/src/github.com/distributedci/dci-ansible/.tox/pep8/bin:/workspace/.local/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
2026-06-16 16:28:48.914413 | testrunner | [1174] /workspace/src/github.com/distributedci/dci-ansible/.tox$ /usr/bin/python3.6 -m virtualenv --no-download --python /usr/bin/python3.6 pep8
2026-06-16 16:28:49.486186 | testrunner | created virtual environment CPython3.6.8.final.0-64 in 427ms
2026-06-16 16:28:49.486264 | testrunner |   creator CPython3Posix(dest=/workspace/src/github.com/distributedci/dci-ansible/.tox/pep8, clear=False, no_vcs_ignore=False, global=False)
2026-06-16 16:28:49.486272 | testrunner |   seeder FromAppData(download=False, pip=bundle, setuptools=bundle, wheel=bundle, via=copy, app_data_dir=/workspace/.local/share/virtualenv)
2026-06-16 16:28:49.486279 | testrunner |     added seed packages: pip==21.3.1, setuptools==59.6.0, wheel==0.37.1
2026-06-16 16:28:49.486285 | testrunner |   activators BashActivator,CShellActivator,FishActivator,NushellActivator,PowerShellActivator,PythonActivator
2026-06-16 16:28:49.515231 | testrunner | pep8 installdeps: -r/workspace/src/github.com/distributedci/dci-ansible/test-requirements.txt
2026-06-16 16:28:49.515932 | testrunner | setting PATH=/workspace/src/github.com/distributedci/dci-ansible/.tox/pep8/bin:/workspace/.local/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
2026-06-16 16:28:49.521451 | testrunner | [1187] /workspace/src/github.com/distributedci/dci-ansible$ /workspace/src/github.com/distributedci/dci-ansible/.tox/pep8/bin/pip install -U -r/workspace/src/github.com/distributedci/dci-ansible/test-requirements.txt
2026-06-16 16:28:50.306561 | testrunner | Obtaining file:///workspace/src/github.com/distributedci/python-dciclient (from -r /workspace/src/github.com/distributedci/dci-ansible/requirements.txt (line 2))
2026-06-16 16:28:50.307316 | testrunner |   Preparing metadata (setup.py): started
2026-06-16 16:28:50.651968 | testrunner |   Preparing metadata (setup.py): finished with status 'done'
2026-06-16 16:28:50.916306 | testrunner | Collecting pytest
2026-06-16 16:28:50.974182 | testrunner |   Downloading pytest-7.0.1-py3-none-any.whl (296 kB)
2026-06-16 16:28:51.096208 | testrunner | Collecting flake8
2026-06-16 16:28:51.109231 | testrunner |   Downloading flake8-5.0.4-py2.py3-none-any.whl (61 kB)
2026-06-16 16:28:51.137781 | testrunner | Collecting dciauth
2026-06-16 16:28:51.150642 | testrunner |   Downloading dciauth-4.0.1.post202603121510-py3-none-any.whl (13 kB)
2026-06-16 16:28:51.362014 | testrunner | Collecting ansible
2026-06-16 16:28:51.375036 | testrunner |   Downloading ansible-4.10.0.tar.gz (36.8 MB)
2026-06-16 16:29:04.325587 | testrunner |   Preparing metadata (setup.py): started
2026-06-16 16:29:15.538434 | testrunner |   Preparing metadata (setup.py): finished with status 'done'
2026-06-16 16:29:15.599450 | testrunner | Collecting selinux
2026-06-16 16:29:15.612630 | testrunner |   Downloading selinux-0.2.1-py2.py3-none-any.whl (4.3 kB)
2026-06-16 16:29:15.717220 | testrunner | Collecting py>=1.8.2
2026-06-16 16:29:15.721067 | testrunner |   Using cached py-1.11.0-py2.py3-none-any.whl (98 kB)
2026-06-16 16:29:15.748137 | testrunner | Collecting iniconfig
2026-06-16 16:29:15.764655 | testrunner |   Downloading iniconfig-1.1.1-py2.py3-none-any.whl (5.0 kB)
2026-06-16 16:29:15.908668 | testrunner | Collecting importlib-metadata>=0.12
2026-06-16 16:29:15.910527 | testrunner |   Using cached importlib_metadata-4.8.3-py3-none-any.whl (17 kB)
2026-06-16 16:29:16.009077 | testrunner | Collecting packaging
2026-06-16 16:29:16.011780 | testrunner |   Using cached packaging-21.3-py3-none-any.whl (40 kB)
2026-06-16 16:29:16.046784 | testrunner | Collecting pluggy<2.0,>=0.12
2026-06-16 16:29:16.048384 | testrunner |   Using cached pluggy-1.0.0-py2.py3-none-any.whl (13 kB)
2026-06-16 16:29:16.090777 | testrunner | Collecting attrs>=19.2.0
2026-06-16 16:29:16.101972 | testrunner |   Downloading attrs-22.2.0-py3-none-any.whl (60 kB)
2026-06-16 16:29:16.211096 | testrunner | Collecting tomli>=1.0.0
2026-06-16 16:29:16.222887 | testrunner |   Downloading tomli-1.2.3-py3-none-any.whl (12 kB)
2026-06-16 16:29:16.251571 | testrunner | Collecting mccabe<0.8.0,>=0.7.0
2026-06-16 16:29:16.262292 | testrunner |   Downloading mccabe-0.7.0-py2.py3-none-any.whl (7.3 kB)
2026-06-16 16:29:16.302012 | testrunner | Collecting pyflakes<2.6.0,>=2.5.0
2026-06-16 16:29:16.315004 | testrunner |   Downloading pyflakes-2.5.0-py2.py3-none-any.whl (66 kB)
2026-06-16 16:29:16.349744 | testrunner | Collecting pycodestyle<2.10.0,>=2.9.0
2026-06-16 16:29:16.362014 | testrunner |   Downloading pycodestyle-2.9.1-py2.py3-none-any.whl (41 kB)
2026-06-16 16:29:16.384968 | testrunner | Collecting importlib-metadata>=0.12
2026-06-16 16:29:16.396415 | testrunner |   Downloading importlib_metadata-4.2.0-py3-none-any.whl (16 kB)
2026-06-16 16:29:16.442763 | testrunner | Collecting PrettyTable
2026-06-16 16:29:16.453698 | testrunner |   Downloading prettytable-2.5.0-py3-none-any.whl (24 kB)
2026-06-16 16:29:16.545848 | testrunner | Collecting requests
2026-06-16 16:29:16.557913 | testrunner |   Downloading requests-2.27.1-py2.py3-none-any.whl (63 kB)
2026-06-16 16:29:16.857548 | testrunner | Collecting ansible-core~=2.11.7
2026-06-16 16:29:16.874583 | testrunner |   Downloading ansible-core-2.11.12.tar.gz (7.1 MB)
2026-06-16 16:29:18.863195 | testrunner |   Preparing metadata (setup.py): started
2026-06-16 16:29:19.497713 | testrunner |   Preparing metadata (setup.py): finished with status 'done'
2026-06-16 16:29:19.560665 | testrunner | Collecting distro>=1.3.0
2026-06-16 16:29:19.574575 | testrunner |   Downloading distro-1.9.0-py3-none-any.whl (20 kB)
2026-06-16 16:29:19.581212 | testrunner | Requirement already satisfied: setuptools>=39.0 in ./.tox/pep8/lib/python3.6/site-packages (from selinux->-r /workspace/src/github.com/distributedci/dci-ansible/requirements.txt (line 4)) (59.6.0)
2026-06-16 16:29:19.653091 | testrunner | Collecting jinja2
2026-06-16 16:29:19.666719 | testrunner |   Downloading Jinja2-3.0.3-py3-none-any.whl (133 kB)
2026-06-16 16:29:19.870515 | testrunner | Collecting PyYAML
2026-06-16 16:29:19.883495 | testrunner |   Downloading PyYAML-6.0.1-cp36-cp36m-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (677 kB)
2026-06-16 16:29:21.131818 | testrunner | Collecting cryptography
2026-06-16 16:29:21.145000 | testrunner |   Downloading cryptography-40.0.2-cp36-abi3-manylinux_2_28_x86_64.whl (3.7 MB)
2026-06-16 16:29:21.352893 | testrunner | Collecting resolvelib<0.6.0,>=0.5.3
2026-06-16 16:29:21.366118 | testrunner |   Downloading resolvelib-0.5.4-py2.py3-none-any.whl (12 kB)
2026-06-16 16:29:21.467024 | testrunner | Collecting typing-extensions>=3.6.4
2026-06-16 16:29:21.469036 | testrunner |   Using cached typing_extensions-4.1.1-py3-none-any.whl (26 kB)
2026-06-16 16:29:21.531255 | testrunner | Collecting zipp>=0.5
2026-06-16 16:29:21.532891 | testrunner |   Using cached zipp-3.6.0-py3-none-any.whl (5.3 kB)
2026-06-16 16:29:21.675824 | testrunner | Collecting pyparsing!=3.0.5,>=2.0.2
2026-06-16 16:29:21.679121 | testrunner |   Using cached pyparsing-3.1.4-py3-none-any.whl (104 kB)
2026-06-16 16:29:21.726910 | testrunner | Collecting wcwidth
2026-06-16 16:29:21.738384 | testrunner |   Downloading wcwidth-0.2.14-py2.py3-none-any.whl (37 kB)
2026-06-16 16:29:21.851884 | testrunner | Collecting urllib3<1.27,>=1.21.1
2026-06-16 16:29:21.863485 | testrunner |   Downloading urllib3-1.26.20-py2.py3-none-any.whl (144 kB)
2026-06-16 16:29:22.503156 | testrunner | Collecting charset-normalizer~=2.0.0
2026-06-16 16:29:22.515663 | testrunner |   Downloading charset_normalizer-2.0.12-py3-none-any.whl (39 kB)
2026-06-16 16:29:22.580863 | testrunner | Collecting certifi>=2017.4.17
2026-06-16 16:29:22.592172 | testrunner |   Downloading certifi-2025.4.26-py3-none-any.whl (159 kB)
2026-06-16 16:29:22.637796 | testrunner | Collecting idna<4,>=2.5
2026-06-16 16:29:22.650237 | testrunner |   Downloading idna-3.10-py3-none-any.whl (70 kB)
2026-06-16 16:29:23.453423 | testrunner | Collecting cffi>=1.12
2026-06-16 16:29:23.467466 | testrunner |   Downloading cffi-1.15.1-cp36-cp36m-manylinux_2_5_x86_64.manylinux1_x86_64.whl (402 kB)
2026-06-16 16:29:23.810133 | testrunner | Collecting MarkupSafe>=2.0
2026-06-16 16:29:23.824925 | testrunner |   Downloading MarkupSafe-2.0.1-cp36-cp36m-manylinux_2_5_x86_64.manylinux1_x86_64.manylinux_2_12_x86_64.manylinux2010_x86_64.whl (30 kB)
2026-06-16 16:29:23.925918 | testrunner | Collecting pycparser
2026-06-16 16:29:23.943039 | testrunner |   Downloading pycparser-2.21-py2.py3-none-any.whl (118 kB)
2026-06-16 16:29:24.036674 | testrunner | Building wheels for collected packages: ansible, ansible-core
2026-06-16 16:29:24.037750 | testrunner |   Building wheel for ansible (setup.py): started
2026-06-16 16:30:06.855644 | testrunner |   Building wheel for ansible (setup.py): finished with status 'done'
2026-06-16 16:30:06.939232 | testrunner |   Created wheel for ansible: filename=ansible-4.10.0-py3-none-any.whl size=60568528 sha256=bf0d41a24581f0f189cb6c5be6ea38c9944c06f649f962af8b96ad2d0e3a7349
2026-06-16 16:30:06.939291 | testrunner |   Stored in directory: /workspace/.cache/pip/wheels/fd/0b/73/1536be1c3fe3e172e003fa05da85642fa29210760ca928348b
2026-06-16 16:30:07.233381 | testrunner |   Building wheel for ansible-core (setup.py): started
2026-06-16 16:30:08.783716 | testrunner |   Building wheel for ansible-core (setup.py): finished with status 'done'
2026-06-16 16:30:08.789256 | testrunner |   Created wheel for ansible-core: filename=ansible_core-2.11.12-py3-none-any.whl size=1960974 sha256=0c76b89b125928ec1fdbdd45883067ceb433e1d8d0de53bdb1d4232d3500c91a
2026-06-16 16:30:08.789321 | testrunner |   Stored in directory: /workspace/.cache/pip/wheels/de/a2/0a/cfe72f018b6d3845ab54b29259c0ac20eb169d18063770c09e
2026-06-16 16:30:08.806522 | testrunner | Successfully built ansible ansible-core
2026-06-16 16:30:09.281697 | testrunner | Installing collected packages: pycparser, zipp, typing-extensions, pyparsing, MarkupSafe, cffi, wcwidth, urllib3, resolvelib, PyYAML, packaging, jinja2, importlib-metadata, idna, cryptography, charset-normalizer, certifi, tomli, requests, pyflakes, pycodestyle, py, PrettyTable, pluggy, mccabe, iniconfig, distro, dciauth, attrs, ansible-core, selinux, pytest, flake8, dciclient, ansible
2026-06-16 16:30:11.392795 | testrunner |   Running setup.py develop for dciclient
2026-06-16 16:30:35.824307 | testrunner | Successfully installed MarkupSafe-2.0.1 PrettyTable-2.5.0 PyYAML-6.0.1 ansible-4.10.0 ansible-core-2.11.12 attrs-22.2.0 certifi-2025.4.26 cffi-1.15.1 charset-normalizer-2.0.12 cryptography-40.0.2 dciauth-4.0.1.post202603121510 dciclient-4.2.0 distro-1.9.0 flake8-5.0.4 idna-3.10 importlib-metadata-4.2.0 iniconfig-1.1.1 jinja2-3.0.3 mccabe-0.7.0 packaging-21.3 pluggy-1.0.0 py-1.11.0 pycodestyle-2.9.1 pycparser-2.21 pyflakes-2.5.0 pyparsing-3.1.4 pytest-7.0.1 requests-2.27.1 resolvelib-0.5.4 selinux-0.2.1 tomli-1.2.3 typing-extensions-4.1.1 urllib3-1.26.20 wcwidth-0.2.14 zipp-3.6.0
2026-06-16 16:30:45.225658 | testrunner | pep8 finish: getenv /workspace/src/github.com/distributedci/dci-ansible/.tox/pep8 after 116.32 seconds
2026-06-16 16:30:45.226114 | testrunner | pep8 start: finishvenv
2026-06-16 16:30:45.227559 | testrunner | write config to /workspace/src/github.com/distributedci/dci-ansible/.tox/pep8/.tox-config1 as '6742c0f74fd7d2805124b90b5d9444a7c0914321e07ec3a2c92289deb23c4d43 /usr/bin/python3.6\n3.28.0 0 0 0\n00000000000000000000000000000000 -r/workspace/src/github.com/distributedci/dci-ansible/test-requirements.txt'
2026-06-16 16:30:45.227597 | testrunner | pep8 finish: finishvenv  after 0.00 seconds
2026-06-16 16:30:45.227767 | testrunner | pep8 start: envreport
2026-06-16 16:30:45.228141 | testrunner | setting PATH=/workspace/src/github.com/distributedci/dci-ansible/.tox/pep8/bin:/workspace/.local/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
2026-06-16 16:30:45.235865 | testrunner | [1227] /workspace/src/github.com/distributedci/dci-ansible$ /workspace/src/github.com/distributedci/dci-ansible/.tox/pep8/bin/python -m pip freeze >.tox/pep8/log/pep8-0.log
2026-06-16 16:30:45.715218 | testrunner | pep8 finish: envreport  after 0.49 seconds
2026-06-16 16:30:45.715341 | testrunner | pep8 installed: ansible==4.10.0,ansible-core==2.11.12,attrs==22.2.0,certifi==2025.4.26,cffi==1.15.1,charset-normalizer==2.0.12,cryptography==40.0.2,dciauth==4.0.1.post202603121510,-e git+file:///dev/null@ec18fb7db4b2b1764b8a342bcad42f710ec19af3#egg=dciclient,distro==1.9.0,flake8==5.0.4,idna==3.10,importlib-metadata==4.2.0,iniconfig==1.1.1,Jinja2==3.0.3,MarkupSafe==2.0.1,mccabe==0.7.0,packaging==21.3,pluggy==1.0.0,prettytable==2.5.0,py==1.11.0,pycodestyle==2.9.1,pycparser==2.21,pyflakes==2.5.0,pyparsing==3.1.4,pytest==7.0.1,PyYAML==6.0.1,requests==2.27.1,resolvelib==0.5.4,selinux==0.2.1,tomli==1.2.3,typing_extensions==4.1.1,urllib3==1.26.20,wcwidth==0.2.14,zipp==3.6.0
2026-06-16 16:30:45.716508 | testrunner | py36 uses /usr/bin/python3.6
2026-06-16 16:30:45.716828 | testrunner | py36 start: getenv /workspace/src/github.com/distributedci/dci-ansible/.tox/py36
2026-06-16 16:30:45.717010 | testrunner | py36 cannot reuse: no previous config /workspace/src/github.com/distributedci/dci-ansible/.tox/py36/.tox-config1
2026-06-16 16:30:45.717030 | testrunner | py36 create: /workspace/src/github.com/distributedci/dci-ansible/.tox/py36
2026-06-16 16:30:45.717661 | testrunner | setting PATH=/workspace/src/github.com/distributedci/dci-ansible/.tox/py36/bin:/workspace/.local/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
2026-06-16 16:30:45.722601 | testrunner | [1233] /workspace/src/github.com/distributedci/dci-ansible/.tox$ /usr/bin/python3.6 -m virtualenv --no-download --python /usr/bin/python3.6 py36
2026-06-16 16:30:46.075933 | testrunner | created virtual environment CPython3.6.8.final.0-64 in 248ms
2026-06-16 16:30:46.075975 | testrunner |   creator CPython3Posix(dest=/workspace/src/github.com/distributedci/dci-ansible/.tox/py36, clear=False, no_vcs_ignore=False, global=False)
2026-06-16 16:30:46.075983 | testrunner |   seeder FromAppData(download=False, pip=bundle, setuptools=bundle, wheel=bundle, via=copy, app_data_dir=/workspace/.local/share/virtualenv)
2026-06-16 16:30:46.075989 | testrunner |     added seed packages: pip==21.3.1, setuptools==59.6.0, wheel==0.37.1
2026-06-16 16:30:46.075996 | testrunner |   activators BashActivator,CShellActivator,FishActivator,NushellActivator,PowerShellActivator,PythonActivator
2026-06-16 16:30:46.108122 | testrunner | py36 installdeps: -r/workspace/src/github.com/distributedci/dci-ansible/test-requirements.txt
2026-06-16 16:30:46.108413 | testrunner | setting PATH=/workspace/src/github.com/distributedci/dci-ansible/.tox/py36/bin:/workspace/.local/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
2026-06-16 16:30:46.112988 | testrunner | [1240] /workspace/src/github.com/distributedci/dci-ansible$ /workspace/src/github.com/distributedci/dci-ansible/.tox/py36/bin/pip install -U -r/workspace/src/github.com/distributedci/dci-ansible/test-requirements.txt
2026-06-16 16:30:46.918636 | testrunner | Obtaining file:///workspace/src/github.com/distributedci/python-dciclient (from -r /workspace/src/github.com/distributedci/dci-ansible/requirements.txt (line 2))
2026-06-16 16:30:46.919160 | testrunner |   Preparing metadata (setup.py): started
2026-06-16 16:30:47.273512 | testrunner |   Preparing metadata (setup.py): finished with status 'done'
2026-06-16 16:30:47.555987 | testrunner | Collecting pytest
2026-06-16 16:30:47.559054 | testrunner |   Using cached pytest-7.0.1-py3-none-any.whl (296 kB)
2026-06-16 16:30:47.654089 | testrunner | Collecting flake8
2026-06-16 16:30:47.657526 | testrunner |   Using cached flake8-5.0.4-py2.py3-none-any.whl (61 kB)
2026-06-16 16:30:47.695156 | testrunner | Collecting dciauth
2026-06-16 16:30:47.696729 | testrunner |   Using cached dciauth-4.0.1.post202603121510-py3-none-any.whl (13 kB)
2026-06-16 16:30:47.906114 | testrunner | Collecting ansible
2026-06-16 16:30:47.906176 | testrunner |   Using cached ansible-4.10.0-py3-none-any.whl
2026-06-16 16:30:48.210906 | testrunner | Collecting selinux
2026-06-16 16:30:48.212467 | testrunner |   Using cached selinux-0.2.1-py2.py3-none-any.whl (4.3 kB)
2026-06-16 16:30:48.273861 | testrunner | Collecting py>=1.8.2
2026-06-16 16:30:48.276518 | testrunner |   Using cached py-1.11.0-py2.py3-none-any.whl (98 kB)
2026-06-16 16:30:48.304814 | testrunner | Collecting iniconfig
2026-06-16 16:30:48.306379 | testrunner |   Using cached iniconfig-1.1.1-py2.py3-none-any.whl (5.0 kB)
2026-06-16 16:30:48.483099 | testrunner | Collecting importlib-metadata>=0.12
2026-06-16 16:30:48.484936 | testrunner |   Using cached importlib_metadata-4.8.3-py3-none-any.whl (17 kB)
2026-06-16 16:30:48.548020 | testrunner | Collecting packaging
2026-06-16 16:30:48.549873 | testrunner |   Using cached packaging-21.3-py3-none-any.whl (40 kB)
2026-06-16 16:30:48.591364 | testrunner | Collecting pluggy<2.0,>=0.12
2026-06-16 16:30:48.592914 | testrunner |   Using cached pluggy-1.0.0-py2.py3-none-any.whl (13 kB)
2026-06-16 16:30:48.641209 | testrunner | Collecting attrs>=19.2.0
2026-06-16 16:30:48.642751 | testrunner |   Using cached attrs-22.2.0-py3-none-any.whl (60 kB)
2026-06-16 16:30:48.756411 | testrunner | Collecting tomli>=1.0.0
2026-06-16 16:30:48.758164 | testrunner |   Using cached tomli-1.2.3-py3-none-any.whl (12 kB)
2026-06-16 16:30:48.792530 | testrunner | Collecting mccabe<0.8.0,>=0.7.0
2026-06-16 16:30:48.794070 | testrunner |   Using cached mccabe-0.7.0-py2.py3-none-any.whl (7.3 kB)
2026-06-16 16:30:48.839434 | testrunner | Collecting pyflakes<2.6.0,>=2.5.0
2026-06-16 16:30:48.840998 | testrunner |   Using cached pyflakes-2.5.0-py2.py3-none-any.whl (66 kB)
2026-06-16 16:30:48.880965 | testrunner | Collecting pycodestyle<2.10.0,>=2.9.0
2026-06-16 16:30:48.882544 | testrunner |   Using cached pycodestyle-2.9.1-py2.py3-none-any.whl (41 kB)
2026-06-16 16:30:48.904632 | testrunner | Collecting importlib-metadata>=0.12
2026-06-16 16:30:48.906128 | testrunner |   Using cached importlib_metadata-4.2.0-py3-none-any.whl (16 kB)
2026-06-16 16:30:48.959128 | testrunner | Collecting PrettyTable
2026-06-16 16:30:48.960655 | testrunner |   Using cached prettytable-2.5.0-py3-none-any.whl (24 kB)
2026-06-16 16:30:49.058506 | testrunner | Collecting requests
2026-06-16 16:30:49.060283 | testrunner |   Using cached requests-2.27.1-py2.py3-none-any.whl (63 kB)
2026-06-16 16:30:49.286945 | testrunner | Collecting ansible-core~=2.11.7
2026-06-16 16:30:49.287015 | testrunner |   Using cached ansible_core-2.11.12-py3-none-any.whl
2026-06-16 16:30:49.325033 | testrunner | Collecting distro>=1.3.0
2026-06-16 16:30:49.326644 | testrunner |   Using cached distro-1.9.0-py3-none-any.whl (20 kB)
2026-06-16 16:30:49.328242 | testrunner | Requirement already satisfied: setuptools>=39.0 in ./.tox/py36/lib/python3.6/site-packages (from selinux->-r /workspace/src/github.com/distributedci/dci-ansible/requirements.txt (line 4)) (59.6.0)
2026-06-16 16:30:49.543639 | testrunner | Collecting PyYAML
2026-06-16 16:30:49.546565 | testrunner |   Using cached PyYAML-6.0.1-cp36-cp36m-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (677 kB)
2026-06-16 16:30:50.831470 | testrunner | Collecting cryptography
2026-06-16 16:30:50.842109 | testrunner |   Using cached cryptography-40.0.2-cp36-abi3-manylinux_2_28_x86_64.whl (3.7 MB)
2026-06-16 16:30:50.895404 | testrunner | Collecting resolvelib<0.6.0,>=0.5.3
2026-06-16 16:30:50.896995 | testrunner |   Using cached resolvelib-0.5.4-py2.py3-none-any.whl (12 kB)
2026-06-16 16:30:50.948222 | testrunner | Collecting jinja2
2026-06-16 16:30:50.950049 | testrunner |   Using cached Jinja2-3.0.3-py3-none-any.whl (133 kB)
2026-06-16 16:30:51.056214 | testrunner | Collecting typing-extensions>=3.6.4
2026-06-16 16:30:51.057941 | testrunner |   Using cached typing_extensions-4.1.1-py3-none-any.whl (26 kB)
2026-06-16 16:30:51.125847 | testrunner | Collecting zipp>=0.5
2026-06-16 16:30:51.127210 | testrunner |   Using cached zipp-3.6.0-py3-none-any.whl (5.3 kB)
2026-06-16 16:30:51.264663 | testrunner | Collecting pyparsing!=3.0.5,>=2.0.2
2026-06-16 16:30:51.267217 | testrunner |   Using cached pyparsing-3.1.4-py3-none-any.whl (104 kB)
2026-06-16 16:30:51.323761 | testrunner | Collecting wcwidth
2026-06-16 16:30:51.325284 | testrunner |   Using cached wcwidth-0.2.14-py2.py3-none-any.whl (37 kB)
2026-06-16 16:30:51.484598 | testrunner | Collecting urllib3<1.27,>=1.21.1
2026-06-16 16:30:51.486800 | testrunner |   Using cached urllib3-1.26.20-py2.py3-none-any.whl (144 kB)
2026-06-16 16:30:52.123841 | testrunner | Collecting charset-normalizer~=2.0.0
2026-06-16 16:30:52.125752 | testrunner |   Using cached charset_normalizer-2.0.12-py3-none-any.whl (39 kB)
2026-06-16 16:30:52.193424 | testrunner | Collecting certifi>=2017.4.17
2026-06-16 16:30:52.195071 | testrunner |   Using cached certifi-2025.4.26-py3-none-any.whl (159 kB)
2026-06-16 16:30:52.242783 | testrunner | Collecting idna<4,>=2.5
2026-06-16 16:30:52.244279 | testrunner |   Using cached idna-3.10-py3-none-any.whl (70 kB)
2026-06-16 16:30:52.990173 | testrunner | Collecting cffi>=1.12
2026-06-16 16:30:52.992538 | testrunner |   Using cached cffi-1.15.1-cp36-cp36m-manylinux_2_5_x86_64.manylinux1_x86_64.whl (402 kB)
2026-06-16 16:30:53.323247 | testrunner | Collecting MarkupSafe>=2.0
2026-06-16 16:30:53.325142 | testrunner |   Using cached MarkupSafe-2.0.1-cp36-cp36m-manylinux_2_5_x86_64.manylinux1_x86_64.manylinux_2_12_x86_64.manylinux2010_x86_64.whl (30 kB)
2026-06-16 16:30:53.374240 | testrunner | Collecting pycparser
2026-06-16 16:30:53.376093 | testrunner |   Using cached pycparser-2.21-py2.py3-none-any.whl (118 kB)
2026-06-16 16:30:53.857347 | testrunner | Installing collected packages: pycparser, zipp, typing-extensions, pyparsing, MarkupSafe, cffi, wcwidth, urllib3, resolvelib, PyYAML, packaging, jinja2, importlib-metadata, idna, cryptography, charset-normalizer, certifi, tomli, requests, pyflakes, pycodestyle, py, PrettyTable, pluggy, mccabe, iniconfig, distro, dciauth, attrs, ansible-core, selinux, pytest, flake8, dciclient, ansible
2026-06-16 16:30:55.906206 | testrunner |   Running setup.py develop for dciclient
2026-06-16 16:31:20.127240 | testrunner | Successfully installed MarkupSafe-2.0.1 PrettyTable-2.5.0 PyYAML-6.0.1 ansible-4.10.0 ansible-core-2.11.12 attrs-22.2.0 certifi-2025.4.26 cffi-1.15.1 charset-normalizer-2.0.12 cryptography-40.0.2 dciauth-4.0.1.post202603121510 dciclient-4.2.0 distro-1.9.0 flake8-5.0.4 idna-3.10 importlib-metadata-4.2.0 iniconfig-1.1.1 jinja2-3.0.3 mccabe-0.7.0 packaging-21.3 pluggy-1.0.0 py-1.11.0 pycodestyle-2.9.1 pycparser-2.21 pyflakes-2.5.0 pyparsing-3.1.4 pytest-7.0.1 requests-2.27.1 resolvelib-0.5.4 selinux-0.2.1 tomli-1.2.3 typing-extensions-4.1.1 urllib3-1.26.20 wcwidth-0.2.14 zipp-3.6.0
2026-06-16 16:31:20.604419 | testrunner | py36 finish: getenv /workspace/src/github.com/distributedci/dci-ansible/.tox/py36 after 34.89 seconds
2026-06-16 16:31:20.604902 | testrunner | py36 start: finishvenv
2026-06-16 16:31:20.606128 | testrunner | write config to /workspace/src/github.com/distributedci/dci-ansible/.tox/py36/.tox-config1 as '6742c0f74fd7d2805124b90b5d9444a7c0914321e07ec3a2c92289deb23c4d43 /usr/bin/python3.6\n3.28.0 0 0 0\n00000000000000000000000000000000 -r/workspace/src/github.com/distributedci/dci-ansible/test-requirements.txt'
2026-06-16 16:31:20.606182 | testrunner | py36 finish: finishvenv  after 0.00 seconds
2026-06-16 16:31:20.606212 | testrunner | py36 start: envreport
2026-06-16 16:31:20.606669 | testrunner | setting PATH=/workspace/src/github.com/distributedci/dci-ansible/.tox/py36/bin:/workspace/.local/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
2026-06-16 16:31:20.614585 | testrunner | [1253] /workspace/src/github.com/distributedci/dci-ansible$ /workspace/src/github.com/distributedci/dci-ansible/.tox/py36/bin/python -m pip freeze >.tox/py36/log/py36-0.log
2026-06-16 16:31:21.074700 | testrunner | py36 finish: envreport  after 0.47 seconds
2026-06-16 16:31:21.074796 | testrunner | py36 installed: ansible==4.10.0,ansible-core==2.11.12,attrs==22.2.0,certifi==2025.4.26,cffi==1.15.1,charset-normalizer==2.0.12,cryptography==40.0.2,dciauth==4.0.1.post202603121510,-e git+file:///dev/null@ec18fb7db4b2b1764b8a342bcad42f710ec19af3#egg=dciclient,distro==1.9.0,flake8==5.0.4,idna==3.10,importlib-metadata==4.2.0,iniconfig==1.1.1,Jinja2==3.0.3,MarkupSafe==2.0.1,mccabe==0.7.0,packaging==21.3,pluggy==1.0.0,prettytable==2.5.0,py==1.11.0,pycodestyle==2.9.1,pycparser==2.21,pyflakes==2.5.0,pyparsing==3.1.4,pytest==7.0.1,PyYAML==6.0.1,requests==2.27.1,resolvelib==0.5.4,selinux==0.2.1,tomli==1.2.3,typing_extensions==4.1.1,urllib3==1.26.20,wcwidth==0.2.14,zipp==3.6.0
2026-06-16 16:31:21.075058 | testrunner | ___________________________________ summary ____________________________________
2026-06-16 16:31:21.075139 | testrunner |   pep8: skipped tests
2026-06-16 16:31:21.075155 | testrunner |   py36: skipped tests
2026-06-16 16:31:21.075161 | testrunner |   congratulations :)
2026-06-16 16:31:22.176635 | testrunner | ok: Runtime: 0:02:32.530030
2026-06-16 16:31:22.182806 | 
2026-06-16 16:31:22.182889 | TASK [tox : Create a tempfile to save tox showconfig]
2026-06-16 16:31:28.217978 | testrunner | changed
2026-06-16 16:31:28.224963 | 
2026-06-16 16:31:28.225098 | TASK [tox : Detect tox version]
2026-06-16 16:31:33.765670 | testrunner | 3.28.0 imported from /workspace/.local/lib/python3.6/site-packages/tox/__init__.py
2026-06-16 16:31:34.855548 | testrunner | ok: Runtime: 0:00:00.225805
2026-06-16 16:31:34.862218 | 
2026-06-16 16:31:34.862351 | TASK [tox : Get tox envlist config]
2026-06-16 16:31:41.354542 | testrunner | ok: Runtime: 0:00:00.377402
2026-06-16 16:31:41.361747 | 
2026-06-16 16:31:41.361887 | TASK [tox : Install any sibling python packages]
2026-06-16 16:31:47.476880 | testrunner | ok: No setup.cfg, no action needed
2026-06-16 16:31:47.485085 | 
2026-06-16 16:31:47.485291 | TASK [tox : Remove tempfile]
2026-06-16 16:31:53.480502 | testrunner | changed
2026-06-16 16:31:53.484924 | 
2026-06-16 16:31:53.484989 | TASK [tox : Emit tox command]
2026-06-16 16:31:53.600031 | /workspace/.local/bin/tox   -vv --skip-missing-interpreters=false
2026-06-16 16:31:53.602860 | 
2026-06-16 16:31:53.602923 | TASK [tox : Run tox]
2026-06-16 16:31:58.820541 | testrunner | using tox.ini: /workspace/src/github.com/distributedci/dci-ansible/tox.ini (pid 1374)
2026-06-16 16:31:58.821444 | testrunner |   removing /workspace/src/github.com/distributedci/dci-ansible/.tox/log
2026-06-16 16:31:58.829564 | testrunner | using tox-3.28.0 from /workspace/.local/lib/python3.6/site-packages/tox/__init__.py (pid 1374)
2026-06-16 16:31:58.829643 | testrunner | skipping sdist step
2026-06-16 16:31:58.885993 | testrunner | /usr/bin/python3.6 (/usr/bin/python3.6) is {'executable': '/usr/bin/python3.6', 'implementation': 'CPython', 'version_info': [3, 6, 8, 'final', 0], 'version': '3.6.8 (default, Aug 11 2025, 09:47:15) \n[GCC 8.5.0 20210514 (Red Hat 8.5.0-28)]', 'is_64': True, 'sysplatform': 'linux', 'os_sep': '/', 'extra_version_info': None}
2026-06-16 16:31:58.886054 | testrunner | pep8 uses /usr/bin/python3.6
2026-06-16 16:31:58.886313 | testrunner | pep8 start: getenv /workspace/src/github.com/distributedci/dci-ansible/.tox/pep8
2026-06-16 16:31:58.886915 | testrunner | pep8 reusing: /workspace/src/github.com/distributedci/dci-ansible/.tox/pep8
2026-06-16 16:31:58.943517 | testrunner | pep8 finish: getenv /workspace/src/github.com/distributedci/dci-ansible/.tox/pep8 after 0.06 seconds
2026-06-16 16:31:58.944049 | testrunner | pep8 start: finishvenv
2026-06-16 16:31:58.944888 | testrunner | pep8 finish: finishvenv  after 0.00 seconds
2026-06-16 16:31:58.945084 | testrunner | pep8 start: envreport
2026-06-16 16:31:58.945648 | testrunner | setting PATH=/workspace/src/github.com/distributedci/dci-ansible/.tox/pep8/bin:/workspace/.local/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
2026-06-16 16:31:58.953425 | testrunner | [1381] /workspace/src/github.com/distributedci/dci-ansible$ /workspace/src/github.com/distributedci/dci-ansible/.tox/pep8/bin/python -m pip freeze >.tox/pep8/log/pep8-1.log
2026-06-16 16:31:59.441863 | testrunner | pep8 finish: envreport  after 0.50 seconds
2026-06-16 16:31:59.441977 | testrunner | pep8 installed: ansible==4.10.0,ansible-core==2.11.12,attrs==22.2.0,certifi==2025.4.26,cffi==1.15.1,charset-normalizer==2.0.12,cryptography==40.0.2,dciauth==4.0.1.post202603121510,-e git+file:///dev/null@ec18fb7db4b2b1764b8a342bcad42f710ec19af3#egg=dciclient,distro==1.9.0,flake8==5.0.4,idna==3.10,importlib-metadata==4.2.0,iniconfig==1.1.1,Jinja2==3.0.3,MarkupSafe==2.0.1,mccabe==0.7.0,packaging==21.3,pluggy==1.0.0,prettytable==2.5.0,py==1.11.0,pycodestyle==2.9.1,pycparser==2.21,pyflakes==2.5.0,pyparsing==3.1.4,pytest==7.0.1,PyYAML==6.0.1,requests==2.27.1,resolvelib==0.5.4,selinux==0.2.1,tomli==1.2.3,typing_extensions==4.1.1,urllib3==1.26.20,wcwidth==0.2.14,zipp==3.6.0
2026-06-16 16:31:59.442904 | testrunner | pep8 start: run-test-pre
2026-06-16 16:31:59.443140 | testrunner | pep8 run-test-pre: PYTHONHASHSEED='4210176182'
2026-06-16 16:31:59.443161 | testrunner | pep8 finish: run-test-pre  after 0.00 seconds
2026-06-16 16:31:59.443325 | testrunner | pep8 start: run-test
2026-06-16 16:31:59.443345 | testrunner | pep8 run-test: commands[0] | flake8
2026-06-16 16:31:59.443537 | testrunner | setting PATH=/workspace/src/github.com/distributedci/dci-ansible/.tox/pep8/bin:/workspace/.local/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
2026-06-16 16:31:59.450143 | testrunner | [1387] /workspace/src/github.com/distributedci/dci-ansible$ /workspace/src/github.com/distributedci/dci-ansible/.tox/pep8/bin/flake8
2026-06-16 16:31:59.905912 | testrunner | pep8 finish: run-test  after 0.46 seconds
2026-06-16 16:31:59.906219 | testrunner | pep8 start: run-test-post
2026-06-16 16:31:59.906239 | testrunner | pep8 finish: run-test-post  after 0.00 seconds
2026-06-16 16:31:59.906881 | testrunner | py36 uses /usr/bin/python3.6
2026-06-16 16:31:59.906911 | testrunner | py36 start: getenv /workspace/src/github.com/distributedci/dci-ansible/.tox/py36
2026-06-16 16:31:59.907429 | testrunner | py36 reusing: /workspace/src/github.com/distributedci/dci-ansible/.tox/py36
2026-06-16 16:31:59.978160 | testrunner | py36 finish: getenv /workspace/src/github.com/distributedci/dci-ansible/.tox/py36 after 0.07 seconds
2026-06-16 16:31:59.978564 | testrunner | py36 start: finishvenv
2026-06-16 16:31:59.979305 | testrunner | py36 finish: finishvenv  after 0.00 seconds
2026-06-16 16:31:59.979459 | testrunner | py36 start: envreport
2026-06-16 16:31:59.979994 | testrunner | setting PATH=/workspace/src/github.com/distributedci/dci-ansible/.tox/py36/bin:/workspace/.local/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
2026-06-16 16:31:59.986836 | testrunner | [1402] /workspace/src/github.com/distributedci/dci-ansible$ /workspace/src/github.com/distributedci/dci-ansible/.tox/py36/bin/python -m pip freeze >.tox/py36/log/py36-1.log
2026-06-16 16:32:00.445548 | testrunner | py36 finish: envreport  after 0.47 seconds
2026-06-16 16:32:00.445702 | testrunner | py36 installed: ansible==4.10.0,ansible-core==2.11.12,attrs==22.2.0,certifi==2025.4.26,cffi==1.15.1,charset-normalizer==2.0.12,cryptography==40.0.2,dciauth==4.0.1.post202603121510,-e git+file:///dev/null@ec18fb7db4b2b1764b8a342bcad42f710ec19af3#egg=dciclient,distro==1.9.0,flake8==5.0.4,idna==3.10,importlib-metadata==4.2.0,iniconfig==1.1.1,Jinja2==3.0.3,MarkupSafe==2.0.1,mccabe==0.7.0,packaging==21.3,pluggy==1.0.0,prettytable==2.5.0,py==1.11.0,pycodestyle==2.9.1,pycparser==2.21,pyflakes==2.5.0,pyparsing==3.1.4,pytest==7.0.1,PyYAML==6.0.1,requests==2.27.1,resolvelib==0.5.4,selinux==0.2.1,tomli==1.2.3,typing_extensions==4.1.1,urllib3==1.26.20,wcwidth==0.2.14,zipp==3.6.0
2026-06-16 16:32:00.446517 | testrunner | py36 start: run-test-pre
2026-06-16 16:32:00.446797 | testrunner | py36 run-test-pre: PYTHONHASHSEED='4210176182'
2026-06-16 16:32:00.446846 | testrunner | py36 finish: run-test-pre  after 0.00 seconds
2026-06-16 16:32:00.446914 | testrunner | py36 start: run-test
2026-06-16 16:32:00.446967 | testrunner | py36 run-test: commands[0] | pytest tests/callbacks/test_dci.py
2026-06-16 16:32:00.447199 | testrunner | setting PATH=/workspace/src/github.com/distributedci/dci-ansible/.tox/py36/bin:/workspace/.local/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
2026-06-16 16:32:00.453315 | testrunner | [1408] /workspace/src/github.com/distributedci/dci-ansible$ /workspace/src/github.com/distributedci/dci-ansible/.tox/py36/bin/pytest tests/callbacks/test_dci.py
2026-06-16 16:32:01.245270 | testrunner | ============================= test session starts ==============================
2026-06-16 16:32:01.245327 | testrunner | platform linux -- Python 3.6.8, pytest-7.0.1, pluggy-1.0.0
2026-06-16 16:32:01.245335 | testrunner | cachedir: .tox/py36/.pytest_cache
2026-06-16 16:32:01.245341 | testrunner | rootdir: /workspace/src/github.com/distributedci/dci-ansible
2026-06-16 16:32:01.245347 | testrunner | collected 3 items
2026-06-16 16:32:01.245353 | testrunner |
2026-06-16 16:32:01.250657 | testrunner | tests/callbacks/test_dci.py ...                                          [100%]
2026-06-16 16:32:01.250683 | testrunner |
2026-06-16 16:32:01.250690 | testrunner | =============================== warnings summary ===============================
2026-06-16 16:32:01.250697 | testrunner | .tox/py36/lib/python3.6/site-packages/ansible/parsing/vault/__init__.py:44
2026-06-16 16:32:01.250709 | testrunner |   /workspace/src/github.com/distributedci/dci-ansible/.tox/py36/lib/python3.6/site-packages/ansible/parsing/vault/__init__.py:44: CryptographyDeprecationWarning: Python 3.6 is no longer supported by the Python core team. Therefore, support for it is deprecated in cryptography. The next release of cryptography will remove support for Python 3.6.
2026-06-16 16:32:01.250717 | testrunner |     from cryptography.exceptions import InvalidSignature
2026-06-16 16:32:01.250723 | testrunner |
2026-06-16 16:32:01.250728 | testrunner | .tox/py36/lib64/python3.6/site-packages/_yaml/__init__.py:23
2026-06-16 16:32:01.250735 | testrunner |   /workspace/src/github.com/distributedci/dci-ansible/.tox/py36/lib64/python3.6/site-packages/_yaml/__init__.py:23: DeprecationWarning: The _yaml extension module is now located at yaml._yaml and its location is subject to change.  To use the LibYAML-based parser and emitter, import from `yaml`: `from yaml import CLoader as Loader, CDumper as Dumper`.
2026-06-16 16:32:01.250741 | testrunner |     DeprecationWarning
2026-06-16 16:32:01.250747 | testrunner |
2026-06-16 16:32:01.250753 | testrunner | -- Docs: https://docs.pytest.org/en/stable/how-to/capture-warnings.html
2026-06-16 16:32:01.250759 | testrunner | ======================== 3 passed, 2 warnings in 0.54s =========================
2026-06-16 16:32:01.361813 | testrunner | py36 finish: run-test  after 0.91 seconds
2026-06-16 16:32:01.362501 | testrunner | py36 start: run-test-post
2026-06-16 16:32:01.362543 | testrunner | py36 finish: run-test-post  after 0.00 seconds
2026-06-16 16:32:01.363041 | testrunner | ___________________________________ summary ____________________________________
2026-06-16 16:32:01.363113 | testrunner |   pep8: commands succeeded
2026-06-16 16:32:01.363140 | testrunner |   py36: commands succeeded
2026-06-16 16:32:01.363164 | testrunner |   congratulations :)
2026-06-16 16:32:02.481281 | testrunner | ok: Runtime: 0:00:02.817121
2026-06-16 16:32:02.490346 | 
2026-06-16 16:32:02.490541 | TASK [tox : Look for output]
2026-06-16 16:32:08.583510 | testrunner | ok
2026-06-16 16:32:08.603879 | 
2026-06-16 16:32:08.604055 | TASK [tox : Return file comments to Zuul]
2026-06-16 16:32:08.640414 | testrunner | skipping: Conditional result was False
2026-06-16 16:32:08.648167 | 
2026-06-16 16:32:08.648251 | PLAY RECAP
2026-06-16 16:32:08.648323 | testrunner | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0
2026-06-16 16:32:08.648362 | 
2026-06-16 16:32:08.756972 | RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/run.yaml@master]
2026-06-16 16:32:08.759522 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master]
2026-06-16 16:32:09.301794 | 
2026-06-16 16:32:09.301896 | PLAY [all]
2026-06-16 16:32:09.311309 | 
2026-06-16 16:32:09.311382 | TASK [fetch-tox-output : Set tox log path for multiple nodes]
2026-06-16 16:32:09.375409 | testrunner | skipping: Conditional result was False
2026-06-16 16:32:09.380158 | 
2026-06-16 16:32:09.380259 | TASK [fetch-tox-output : Set tox log path for single node]
2026-06-16 16:32:09.421279 | testrunner | ok
2026-06-16 16:32:09.428565 | 
2026-06-16 16:32:09.428713 | TASK [fetch-tox-output : Ensure local tox dir]
2026-06-16 16:32:09.849068 | testrunner -> localhost | changed
2026-06-16 16:32:09.859499 | 
2026-06-16 16:32:09.859642 | TASK [fetch-tox-output : Ensure zuul-output tox dir]
2026-06-16 16:32:09.895389 | testrunner | skipping: Conditional result was False
2026-06-16 16:32:09.902957 | 
2026-06-16 16:32:09.903131 | TASK [fetch-tox-output : Set envlist fact]
2026-06-16 16:32:09.929707 | testrunner | skipping: Conditional result was False
2026-06-16 16:32:09.938166 | 
2026-06-16 16:32:09.938302 | TASK [fetch-tox-output : Get tox version]
2026-06-16 16:32:15.169098 | testrunner | 3.28.0 imported from /workspace/.local/lib/python3.6/site-packages/tox/__init__.py
2026-06-16 16:32:16.227947 | testrunner | ok: Runtime: 0:00:00.243457
2026-06-16 16:32:16.234747 | 
2026-06-16 16:32:16.234883 | TASK [fetch-tox-output : Find all default environments]
2026-06-16 16:32:21.456451 | testrunner | pep8
2026-06-16 16:32:21.456666 | testrunner | py36
2026-06-16 16:32:22.558724 | testrunner | ok: Runtime: 0:00:00.303790
2026-06-16 16:32:22.565836 | 
2026-06-16 16:32:22.566009 | TASK [fetch-tox-output : Set envlist fact]
2026-06-16 16:32:22.631909 | testrunner | ok
2026-06-16 16:32:22.639225 | 
2026-06-16 16:32:22.639555 | TASK [fetch-tox-output : Find all default environments]
2026-06-16 16:32:22.946235 | testrunner | skipping: Conditional result was False
2026-06-16 16:32:22.953890 | 
2026-06-16 16:32:22.954039 | TASK [fetch-tox-output : Set envlist fact]
2026-06-16 16:32:22.990753 | testrunner | skipping: Conditional result was False
2026-06-16 16:32:22.999170 | 
2026-06-16 16:32:22.999310 | LOOP [fetch-tox-output : Copy tox logs]
2026-06-16 16:32:23.044023 | testrunner | skipping: Conditional result was False
2026-06-16 16:32:23.049795 | testrunner | skipping: Conditional result was False
2026-06-16 16:32:23.065989 | 
2026-06-16 16:32:23.066148 | LOOP [fetch-tox-output : Collect tox logs]
2026-06-16 16:32:23.132270 | testrunner | ok: synchronize uses rsync to function. rsync needs to connect to the remote host via ssh, docker client or a direct filesystem copy. This remote host is being accessed via kubectl instead so it cannot work.
2026-06-16 16:32:23.132651 | 
2026-06-16 16:32:23.138615 | testrunner | ok: synchronize uses rsync to function. rsync needs to connect to the remote host via ssh, docker client or a direct filesystem copy. This remote host is being accessed via kubectl instead so it cannot work.
2026-06-16 16:32:23.143613 | 
2026-06-16 16:32:23.143661 | PLAY RECAP
2026-06-16 16:32:23.143701 | testrunner | ok: 6 changed: 3 unreachable: 0 failed: 0 skipped: 6 rescued: 0 ignored: 0
2026-06-16 16:32:23.143721 | 
2026-06-16 16:32:23.243372 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master]
2026-06-16 16:32:23.244454 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master]
2026-06-16 16:32:23.856764 | 
2026-06-16 16:32:23.856870 | PLAY [all]
2026-06-16 16:32:23.866641 | 
2026-06-16 16:32:23.866725 | TASK [fetch-subunit-output : Find stestr or testr executable]
2026-06-16 16:32:29.619570 | testrunner | changed: non-zero return code
2026-06-16 16:32:29.627657 | 
2026-06-16 16:32:29.627843 | TASK [fetch-subunit-output : Get the list of directories with subunit files]
2026-06-16 16:32:29.654384 | testrunner | skipping: Conditional result was False
2026-06-16 16:32:29.662163 | 
2026-06-16 16:32:29.662314 | LOOP [fetch-subunit-output : Find any inflight partial subunit files]
2026-06-16 16:32:29.701914 | 
2026-06-16 16:32:29.702186 | LOOP [fetch-subunit-output : Copy any inflight subunit files]
2026-06-16 16:32:29.742630 | 
2026-06-16 16:32:29.742950 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream]
2026-06-16 16:32:29.769522 | testrunner | skipping: Conditional result was False
2026-06-16 16:32:29.778522 | 
2026-06-16 16:32:29.778671 | LOOP [fetch-subunit-output : Generate subunit file]
2026-06-16 16:32:29.812127 | 
2026-06-16 16:32:29.812405 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory]
2026-06-16 16:32:29.838185 | testrunner | skipping: Conditional result was False
2026-06-16 16:32:29.845836 | 
2026-06-16 16:32:29.846140 | TASK [fetch-subunit-output : Remove the temporary file]
2026-06-16 16:32:29.872472 | testrunner | skipping: Conditional result was False
2026-06-16 16:32:29.881564 | 
2026-06-16 16:32:29.881721 | TASK [fetch-subunit-output : Process and fetch subunit results]
2026-06-16 16:32:29.906862 | testrunner | skipping: Conditional result was False
2026-06-16 16:32:29.915345 | 
2026-06-16 16:32:29.915471 | PLAY RECAP
2026-06-16 16:32:29.915569 | testrunner | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0
2026-06-16 16:32:29.915613 | 
2026-06-16 16:32:30.036228 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master]
2026-06-16 16:32:30.037813 | POST-RUN START: [trusted : gitlab.com/softwarefactory-project/centosinfra-prod/dci-config/playbooks/base/post.yaml@main]
2026-06-16 16:32:30.725861 | 
2026-06-16 16:32:30.725970 | PLAY [all]
2026-06-16 16:32:30.735180 | 
2026-06-16 16:32:30.735258 | TASK [include_role : fetch-output]
2026-06-16 16:32:30.760467 | testrunner | skipping: Conditional result was False
2026-06-16 16:32:30.764150 | 
2026-06-16 16:32:30.764232 | TASK [include_role : fetch-output-openshift]
2026-06-16 16:32:30.801196 | testrunner | ok
2026-06-16 16:32:30.813598 | 
2026-06-16 16:32:30.813668 | TASK [fetch-output-openshift : Set log path for multiple nodes]
2026-06-16 16:32:30.878233 | testrunner | skipping: Conditional result was False
2026-06-16 16:32:30.886837 | 
2026-06-16 16:32:30.886995 | TASK [fetch-output-openshift : Set log path for single node]
2026-06-16 16:32:30.930173 | testrunner | ok
2026-06-16 16:32:30.938959 | 
2026-06-16 16:32:30.939106 | LOOP [fetch-output-openshift : Ensure local output dirs]
2026-06-16 16:32:31.395721 | testrunner -> localhost | changed: "/var/lib/zuul/builds/b5ba9e19a7e44ecc999a92aa524b8af1/work/logs"
2026-06-16 16:32:31.747746 | testrunner -> localhost | changed: "/var/lib/zuul/builds/b5ba9e19a7e44ecc999a92aa524b8af1/work/logs/npm"
2026-06-16 16:32:32.033629 | testrunner -> localhost | changed: "/var/lib/zuul/builds/b5ba9e19a7e44ecc999a92aa524b8af1/work/artifacts"
2026-06-16 16:32:32.311319 | testrunner -> localhost | changed: "/var/lib/zuul/builds/b5ba9e19a7e44ecc999a92aa524b8af1/work/docs"
2026-06-16 16:32:32.328262 | 
2026-06-16 16:32:32.328581 | LOOP [fetch-output-openshift : Include rsync tasks]
2026-06-16 16:32:32.418660 | testrunner | ok:
2026-06-16 16:32:32.419097 | testrunner | [
2026-06-16 16:32:32.419155 | testrunner |   "testrunner",
2026-06-16 16:32:32.419196 | testrunner |   {
2026-06-16 16:32:32.419234 | testrunner |     "context": "main:zuul-worker/38-102-83-49:9023",
2026-06-16 16:32:32.419272 | testrunner |     "namespace": "main",
2026-06-16 16:32:32.419310 | testrunner |     "pod": "zuul-worker-ubi8-0000076244",
2026-06-16 16:32:32.419347 | testrunner |     "resources": {
2026-06-16 16:32:32.419397 | testrunner |       "cores": 0,
2026-06-16 16:32:32.419495 | testrunner |       "instances": 1,
2026-06-16 16:32:32.419554 | testrunner |       "ram": 0
2026-06-16 16:32:32.419593 | testrunner |     },
2026-06-16 16:32:32.419634 | testrunner |     "stream_port1": 35031,
2026-06-16 16:32:32.419696 | testrunner |     "stream_port2": 40741
2026-06-16 16:32:32.419732 | testrunner |   }
2026-06-16 16:32:32.419767 | testrunner | ]
2026-06-16 16:32:32.419827 | testrunner | changed: All items complete
2026-06-16 16:32:32.419870 | 
2026-06-16 16:32:32.439702 | testrunner | included: /var/lib/zuul/builds/b5ba9e19a7e44ecc999a92aa524b8af1/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/fetch-output-openshift/tasks/rsync.yaml
2026-06-16 16:32:32.453648 | 
2026-06-16 16:32:32.453895 | LOOP [fetch-output-openshift : Fetch zuul-output from the pod]
2026-06-16 16:32:37.649259 | testrunner | Output suppressed because no_log was given
2026-06-16 16:32:37.657398 | 
2026-06-16 16:32:37.657568 | TASK [fetch-output-openshift : Remove empty directory]
2026-06-16 16:32:38.104807 | testrunner -> localhost | ok: Runtime: 0:00:00.047328
2026-06-16 16:32:38.117839 | 
2026-06-16 16:32:38.117972 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-06-16 16:32:38.481553 | testrunner -> localhost | find: ‘/var/lib/zuul/builds/b5ba9e19a7e44ecc999a92aa524b8af1/work/artifacts’: No such file or directory
2026-06-16 16:32:38.482039 | testrunner -> localhost | find: ‘/var/lib/zuul/builds/b5ba9e19a7e44ecc999a92aa524b8af1/work/artifacts’: No such file or directory
2026-06-16 16:32:38.482142 | testrunner -> localhost | ok: Item: artifacts Runtime: 0:00:00.013140
2026-06-16 16:32:38.766612 | testrunner -> localhost | find: ‘/var/lib/zuul/builds/b5ba9e19a7e44ecc999a92aa524b8af1/work/docs’: No such file or directory
2026-06-16 16:32:38.766815 | testrunner -> localhost | find: ‘/var/lib/zuul/builds/b5ba9e19a7e44ecc999a92aa524b8af1/work/docs’: No such file or directory
2026-06-16 16:32:38.766894 | testrunner -> localhost | ok: Item: docs Runtime: 0:00:00.013533
2026-06-16 16:32:38.780179 | 
2026-06-16 16:32:38.780315 | PLAY [localhost]
2026-06-16 16:32:38.792683 | 
2026-06-16 16:32:38.792823 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-06-16 16:32:39.237202 | localhost | changed
2026-06-16 16:32:39.258988 | 
2026-06-16 16:32:39.259143 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-06-16 16:32:39.338301 | localhost | ok
2026-06-16 16:32:39.352240 | 
2026-06-16 16:32:39.352411 | TASK [add-fileserver : Create SSH private key tempfile]
2026-06-16 16:32:39.721505 | localhost | changed
2026-06-16 16:32:39.731180 | 
2026-06-16 16:32:39.731506 | TASK [add-fileserver : Create SSH private key from secret]
2026-06-16 16:32:40.582942 | localhost | changed
2026-06-16 16:32:40.590725 | 
2026-06-16 16:32:40.590866 | TASK [add-fileserver : Add fileserver ssh key]
2026-06-16 16:32:40.933677 | localhost | Identity added: /var/lib/zuul/builds/b5ba9e19a7e44ecc999a92aa524b8af1/work/tmp/ansible.x66j2cip (/var/lib/zuul/builds/b5ba9e19a7e44ecc999a92aa524b8af1/work/tmp/ansible.x66j2cip)
2026-06-16 16:32:40.934042 | localhost | ok: Runtime: 0:00:00.019597
2026-06-16 16:32:40.942924 | 
2026-06-16 16:32:40.943059 | TASK [add-fileserver : Remove SSH private key from disk]
2026-06-16 16:32:41.286608 | localhost | ok: Runtime: 0:00:00.008815
2026-06-16 16:32:41.294375 | 
2026-06-16 16:32:41.294615 | TASK [add-fileserver : Add fileserver to inventory]
2026-06-16 16:32:41.378750 | localhost | changed
2026-06-16 16:32:41.386570 | 
2026-06-16 16:32:41.386720 | TASK [add-fileserver : Add fileserver server to known hosts]
2026-06-16 16:32:41.814243 | localhost | changed
2026-06-16 16:32:41.821221 | 
2026-06-16 16:32:41.821298 | PLAY [a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com]
2026-06-16 16:32:41.825539 | 
2026-06-16 16:32:41.825634 | TASK [Gathering Facts]
2026-06-16 16:32:43.289651 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | ok
2026-06-16 16:32:43.306042 | 
2026-06-16 16:32:43.306202 | TASK [Set zuul-log-path fact]
2026-06-16 16:32:43.329505 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | ok
2026-06-16 16:32:43.349326 | 
2026-06-16 16:32:43.349509 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-06-16 16:32:43.390902 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | ok
2026-06-16 16:32:43.405140 | 
2026-06-16 16:32:43.405311 | TASK [upload-logs : Create log directories]
2026-06-16 16:32:43.750778 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | changed
2026-06-16 16:32:43.756938 | 
2026-06-16 16:32:43.757075 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-06-16 16:32:44.084579 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com -> localhost | ok: Runtime: 0:00:00.009716
2026-06-16 16:32:44.093704 | 
2026-06-16 16:32:44.093868 | TASK [upload-logs : Upload logs to log server]
2026-06-16 16:32:45.253563 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | Output suppressed because no_log was given
2026-06-16 16:32:45.259580 | 
2026-06-16 16:32:45.259727 | LOOP [upload-logs : Compress console log and json output]