2026-06-09 00:01:08.071829 | Job console starting
2026-06-09 00:01:08.200588 | Updating git repos
2026-06-09 00:01:08.241155 | Cloning repos into workspace
2026-06-09 00:01:08.710903 | Restoring repo states
2026-06-09 00:01:08.728420 | Merging changes
2026-06-09 00:01:08.728445 | Checking out repos
2026-06-09 00:01:08.793073 | Preparing playbooks
2026-06-09 00:01:13.385752 | Running Ansible setup
2026-06-09 00:01:17.390460 | PRE-RUN START: [trusted : softwarefactory-project.io/config/playbooks/base/pre.yaml@master]
2026-06-09 00:01:17.997053 | 
2026-06-09 00:01:17.997183 | PLAY [localhost]
2026-06-09 00:01:18.004014 | 
2026-06-09 00:01:18.004085 | TASK [Gathering Facts]
2026-06-09 00:01:19.006335 | localhost | ok
2026-06-09 00:01:19.020280 | 
2026-06-09 00:01:19.020494 | TASK [Setup log path fact]
2026-06-09 00:01:19.053824 | localhost | ok
2026-06-09 00:01:19.079156 | 
2026-06-09 00:01:19.079375 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-06-09 00:01:19.111718 | localhost | ok
2026-06-09 00:01:19.120316 | 
2026-06-09 00:01:19.120486 | TASK [emit-job-header : Print job information]
2026-06-09 00:01:19.161579 | # Job Information
2026-06-09 00:01:19.161887 | Ansible Version: 2.16.18
2026-06-09 00:01:19.161936 | Job: k1s-tox
2026-06-09 00:01:19.161966 | Pipeline: periodic
2026-06-09 00:01:19.161993 | Executor: 38.102.83.51
2026-06-09 00:01:19.162019 | Triggered by: https://softwarefactory-project.io/r/plugins/gitiles/software-factory/k1s/+/None^!/
2026-06-09 00:01:19.162051 | Log URL (when completed): https://gateway-cloud-softwarefactory.apps.ocp.cloud.ci.centos.org/logs/905/local/90565ee957f94addbbcb7aacfd8fb5ce/
2026-06-09 00:01:19.162079 | Event ID: 3ab9a28325544a35a541988aad424f36
2026-06-09 00:01:19.165651 | 
2026-06-09 00:01:19.165743 | LOOP [emit-job-header : Print node information]
2026-06-09 00:01:19.256712 | localhost | ok:
2026-06-09 00:01:19.256934 | localhost | # Node Information
2026-06-09 00:01:19.256970 | localhost | Inventory Hostname: testrunner
2026-06-09 00:01:19.256998 | localhost | Hostname: np0000067788
2026-06-09 00:01:19.257023 | localhost | Username: zuul-worker
2026-06-09 00:01:19.257050 | localhost | Distro: CentOS 9
2026-06-09 00:01:19.257075 | localhost | Provider: vexxhost-nodepool-sf
2026-06-09 00:01:19.257098 | localhost | Region: RegionOne
2026-06-09 00:01:19.257121 | localhost | Label: cloud-centos-9-stream
2026-06-09 00:01:19.257144 | localhost | Product Name: OpenStack Nova
2026-06-09 00:01:19.257167 | localhost | Interface IP: 38.102.83.39
2026-06-09 00:01:19.267959 | 
2026-06-09 00:01:19.268101 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-06-09 00:01:19.728138 | localhost -> localhost | changed
2026-06-09 00:01:19.732740 | 
2026-06-09 00:01:19.732813 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-06-09 00:01:20.687742 | localhost -> localhost | changed
2026-06-09 00:01:20.693758 | 
2026-06-09 00:01:20.693825 | PLAY [all]
2026-06-09 00:01:20.699634 | 
2026-06-09 00:01:20.699727 | TASK [include_role : start-zuul-console]
2026-06-09 00:01:20.720995 | testrunner | ok
2026-06-09 00:01:20.730958 | 
2026-06-09 00:01:20.731067 | TASK [start-zuul-console : Start zuul_console daemon.]
2026-06-09 00:01:21.166927 | testrunner | ok
2026-06-09 00:01:21.183505 | 
2026-06-09 00:01:21.183647 | TASK [include_role : validate-host]
2026-06-09 00:01:21.218191 | testrunner | ok
2026-06-09 00:01:21.249724 | 
2026-06-09 00:01:21.249873 | TASK [validate-host : Define zuul_info_dir fact]
2026-06-09 00:01:21.289499 | testrunner | ok
2026-06-09 00:01:21.296190 | 
2026-06-09 00:01:21.296386 | TASK [validate-host : Ensure Zuul Ansible directory exists]
2026-06-09 00:01:21.606224 | testrunner -> localhost | ok
2026-06-09 00:01:21.618256 | 
2026-06-09 00:01:21.618450 | TASK [validate-host : Collect information about the host]
2026-06-09 00:01:22.386288 | testrunner | ok
2026-06-09 00:01:22.406304 | 
2026-06-09 00:01:22.406531 | TASK [validate-host : Sanitize hostname]
2026-06-09 00:01:22.482340 | testrunner | ok
2026-06-09 00:01:22.490083 | 
2026-06-09 00:01:22.490292 | TASK [validate-host : Write out all ansible variables/facts known for each host]
2026-06-09 00:01:23.018197 | testrunner -> localhost | changed
2026-06-09 00:01:23.023036 | 
2026-06-09 00:01:23.023144 | TASK [validate-host : Collect information about zuul worker]
2026-06-09 00:01:23.490696 | testrunner | ok
2026-06-09 00:01:23.498142 | 
2026-06-09 00:01:23.498335 | TASK [validate-host : Write out all zuul information for each host]
2026-06-09 00:01:24.020947 | testrunner -> localhost | changed
2026-06-09 00:01:24.036061 | 
2026-06-09 00:01:24.036196 | TASK [include_role : prepare-workspace]
2026-06-09 00:01:24.061305 | testrunner | ok
2026-06-09 00:01:24.094574 | 
2026-06-09 00:01:24.094689 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-06-09 00:01:24.343734 | testrunner | ok
2026-06-09 00:01:24.353311 | 
2026-06-09 00:01:24.353648 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-06-09 00:01:25.204404 | testrunner | Output suppressed because no_log was given
2026-06-09 00:01:25.210023 | 
2026-06-09 00:01:25.210088 | TASK [include_role : add-build-sshkey]
2026-06-09 00:01:25.237717 | testrunner | ok
2026-06-09 00:01:25.254661 | 
2026-06-09 00:01:25.254785 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-06-09 00:01:25.532967 | testrunner -> localhost | ok
2026-06-09 00:01:25.542515 | 
2026-06-09 00:01:25.542661 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-06-09 00:01:25.577904 | testrunner | ok
2026-06-09 00:01:25.606268 | testrunner | included: /var/lib/zuul/builds/90565ee957f94addbbcb7aacfd8fb5ce/trusted/project_2/softwarefactory-project.io/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-06-09 00:01:25.614552 | 
2026-06-09 00:01:25.614693 | TASK [add-build-sshkey : Create Temp SSH key]
2026-06-09 00:01:26.334361 | testrunner -> localhost | Generating public/private rsa key pair.
2026-06-09 00:01:26.334535 | testrunner -> localhost | Your identification has been saved in /var/lib/zuul/builds/90565ee957f94addbbcb7aacfd8fb5ce/work/90565ee957f94addbbcb7aacfd8fb5ce_id_rsa
2026-06-09 00:01:26.334562 | testrunner -> localhost | Your public key has been saved in /var/lib/zuul/builds/90565ee957f94addbbcb7aacfd8fb5ce/work/90565ee957f94addbbcb7aacfd8fb5ce_id_rsa.pub
2026-06-09 00:01:26.334582 | testrunner -> localhost | The key fingerprint is:
2026-06-09 00:01:26.334601 | testrunner -> localhost | SHA256:/RfO3IX/gfcBnz7pzG6ggGkzgZIks7lFwZJCvCd+/Ok zuul-build-sshkey
2026-06-09 00:01:26.334619 | testrunner -> localhost | The key's randomart image is:
2026-06-09 00:01:26.334637 | testrunner -> localhost | +---[RSA 3072]----+
2026-06-09 00:01:26.334655 | testrunner -> localhost | |o.o..            |
2026-06-09 00:01:26.334673 | testrunner -> localhost | |.* +             |
2026-06-09 00:01:26.334691 | testrunner -> localhost | |. X . .          |
2026-06-09 00:01:26.334708 | testrunner -> localhost | | = = . . .     . |
2026-06-09 00:01:26.334725 | testrunner -> localhost | |. * .   S .  .o .|
2026-06-09 00:01:26.334742 | testrunner -> localhost | | o o   * . . =++o|
2026-06-09 00:01:26.334758 | testrunner -> localhost | |  . . o o . o.**+|
2026-06-09 00:01:26.334778 | testrunner -> localhost | |     o     . .=+=|
2026-06-09 00:01:26.334795 | testrunner -> localhost | |    .E        +*+|
2026-06-09 00:01:26.334812 | testrunner -> localhost | +----[SHA256]-----+
2026-06-09 00:01:26.334855 | testrunner -> localhost | ok: Runtime: 0:00:00.239248
2026-06-09 00:01:26.339381 | 
2026-06-09 00:01:26.339458 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-06-09 00:01:26.356623 | testrunner | ok
2026-06-09 00:01:26.363546 | testrunner | included: /var/lib/zuul/builds/90565ee957f94addbbcb7aacfd8fb5ce/trusted/project_2/softwarefactory-project.io/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-06-09 00:01:26.369536 | 
2026-06-09 00:01:26.369594 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-06-09 00:01:26.393041 | testrunner | skipping: Conditional result was False
2026-06-09 00:01:26.397632 | 
2026-06-09 00:01:26.397700 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-06-09 00:01:26.892524 | testrunner | changed
2026-06-09 00:01:26.895977 | 
2026-06-09 00:01:26.896040 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-06-09 00:01:27.156697 | testrunner | ok
2026-06-09 00:01:27.162130 | 
2026-06-09 00:01:27.162317 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-06-09 00:01:28.038008 | testrunner | changed
2026-06-09 00:01:28.041617 | 
2026-06-09 00:01:28.041700 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-06-09 00:01:28.886156 | testrunner | changed
2026-06-09 00:01:28.889855 | 
2026-06-09 00:01:28.889927 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-06-09 00:01:28.925118 | testrunner | skipping: Conditional result was False
2026-06-09 00:01:28.933164 | 
2026-06-09 00:01:28.933397 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-06-09 00:01:29.471697 | testrunner -> localhost | changed
2026-06-09 00:01:29.479211 | 
2026-06-09 00:01:29.479293 | TASK [add-build-sshkey : Add back temp key]
2026-06-09 00:01:29.862585 | testrunner -> localhost | Identity added: /var/lib/zuul/builds/90565ee957f94addbbcb7aacfd8fb5ce/work/90565ee957f94addbbcb7aacfd8fb5ce_id_rsa (zuul-build-sshkey)
2026-06-09 00:01:29.862815 | testrunner -> localhost | ok: Runtime: 0:00:00.020594
2026-06-09 00:01:29.868727 | 
2026-06-09 00:01:29.868830 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-06-09 00:01:30.334996 | testrunner | ok
2026-06-09 00:01:30.338291 | 
2026-06-09 00:01:30.338402 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-06-09 00:01:30.360437 | testrunner | skipping: Conditional result was False
2026-06-09 00:01:30.374557 | 
2026-06-09 00:01:30.374693 | TASK [include_role : prepare-workspace-openshift]
2026-06-09 00:01:30.411263 | testrunner | skipping: Conditional result was False
2026-06-09 00:01:30.420183 | 
2026-06-09 00:01:30.420326 | TASK [include_role : remove-zuul-sshkey]
2026-06-09 00:01:30.445910 | testrunner | skipping: Conditional result was False
2026-06-09 00:01:30.451026 | 
2026-06-09 00:01:30.451114 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-06-09 00:01:30.701616 | testrunner | ok: "logs"
2026-06-09 00:01:30.701924 | testrunner | ok: All items complete
2026-06-09 00:01:30.701957 | 
2026-06-09 00:01:30.909349 | testrunner | ok: "artifacts"
2026-06-09 00:01:31.151463 | testrunner | ok: "docs"
2026-06-09 00:01:31.161107 | 
2026-06-09 00:01:31.161236 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-06-09 00:01:31.457812 | testrunner | changed: "logs"
2026-06-09 00:01:31.694491 | testrunner | changed: "artifacts"
2026-06-09 00:01:31.932466 | testrunner | changed: "docs"
2026-06-09 00:01:31.942858 | 
2026-06-09 00:01:31.943036 | TASK [include_role : rhel-registration]
2026-06-09 00:01:31.978288 | testrunner | skipping: Conditional result was False
2026-06-09 00:01:31.980192 | 
2026-06-09 00:01:31.980256 | PLAY RECAP
2026-06-09 00:01:31.980319 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-06-09 00:01:31.980395 | testrunner | ok: 23 changed: 10 unreachable: 0 failed: 0 skipped: 6 rescued: 0 ignored: 0
2026-06-09 00:01:31.980430 | 
2026-06-09 00:01:32.424861 | PRE-RUN END RESULT_NORMAL: [trusted : softwarefactory-project.io/config/playbooks/base/pre.yaml@master]
2026-06-09 00:01:32.430754 | RUN START: [untrusted : softwarefactory-project.io/software-factory/k1s/playbooks/k1s-tox.yaml@master]
2026-06-09 00:01:33.018182 | 
2026-06-09 00:01:33.018309 | PLAY [all]
2026-06-09 00:01:33.029162 | 
2026-06-09 00:01:33.029242 | LOOP [ensure-podman : Find distribution installation]
2026-06-09 00:01:33.054139 | testrunner | ok: "/var/lib/zuul/builds/90565ee957f94addbbcb7aacfd8fb5ce/untrusted/project_3/softwarefactory-project.io/zuul-jobs/roles/ensure-podman/tasks/RedHat.yaml"
2026-06-09 00:01:33.060202 | testrunner | included: /var/lib/zuul/builds/90565ee957f94addbbcb7aacfd8fb5ce/untrusted/project_3/softwarefactory-project.io/zuul-jobs/roles/ensure-podman/tasks/RedHat.yaml
2026-06-09 00:01:33.064888 | 
2026-06-09 00:01:33.064957 | TASK [ensure-podman : Install podman (RedHat)]
2026-06-09 00:02:19.704806 | testrunner | changed
2026-06-09 00:02:19.711135 | 
2026-06-09 00:02:19.711269 | TASK [ensure-podman : Fetch podman version]
2026-06-08 20:02:20.318930 | testrunner | Client:       Podman Engine
2026-06-08 20:02:20.319010 | testrunner | Version:      5.8.2
2026-06-08 20:02:20.319018 | testrunner | API Version:  5.8.2
2026-06-08 20:02:20.319030 | testrunner | Go Version:   go1.26.1 (Red Hat 1.26.1-1.el9)
2026-06-08 20:02:20.319036 | testrunner | Built:        Thu Apr 16 04:05:13 2026
2026-06-08 20:02:20.319041 | testrunner | OS/Arch:      linux/amd64
2026-06-09 00:02:20.755092 | testrunner | ok: Runtime: 0:00:00.278535
2026-06-09 00:02:20.764972 | 
2026-06-09 00:02:20.765115 | TASK [ensure-podman : Print podman version installed]
2026-06-09 00:02:20.806855 | Podman version: Client:       Podman Engine
2026-06-09 00:02:20.807117 | Version:      5.8.2
2026-06-09 00:02:20.807184 | API Version:  5.8.2
2026-06-09 00:02:20.807229 | Go Version:   go1.26.1 (Red Hat 1.26.1-1.el9)
2026-06-09 00:02:20.807268 | Built:        Thu Apr 16 04:05:13 2026
2026-06-09 00:02:20.807305 | OS/Arch:      linux/amd64
2026-06-09 00:02:20.817263 | 
2026-06-09 00:02:20.817833 | TASK [ensure-podman : Validate podman engine]
2026-06-09 00:02:21.354746 | testrunner | skipping: Conditional result was False
2026-06-09 00:02:21.365047 | 
2026-06-09 00:02:21.365227 | TASK [ensure-podman : Set up docker compatability socket]
2026-06-09 00:02:21.391877 | testrunner | skipping: Conditional result was False
2026-06-09 00:02:21.408290 | 
2026-06-09 00:02:21.408518 | TASK [install tox]
2026-06-08 20:02:22.879673 | testrunner | Collecting tox
2026-06-08 20:02:22.937605 | testrunner |   Downloading tox-4.30.3-py3-none-any.whl (175 kB)
2026-06-08 20:02:23.129971 | testrunner | Collecting chardet>=5.2
2026-06-08 20:02:23.144165 | testrunner |   Downloading chardet-5.2.0-py3-none-any.whl (199 kB)
2026-06-08 20:02:23.223392 | testrunner | Collecting pluggy>=1.6
2026-06-08 20:02:23.233818 | testrunner |   Downloading pluggy-1.6.0-py3-none-any.whl (20 kB)
2026-06-08 20:02:23.432659 | testrunner | Collecting virtualenv>=20.31.2
2026-06-08 20:02:23.445071 | testrunner |   Downloading virtualenv-21.4.2-py3-none-any.whl (7.6 MB)
2026-06-08 20:02:24.169585 | testrunner | Collecting filelock>=3.18
2026-06-08 20:02:24.179509 | testrunner |   Downloading filelock-3.19.1-py3-none-any.whl (15 kB)
2026-06-08 20:02:24.238144 | testrunner | Collecting colorama>=0.4.6
2026-06-08 20:02:24.250670 | testrunner |   Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB)
2026-06-08 20:02:24.370553 | testrunner | Collecting tomli>=2.2.1
2026-06-08 20:02:24.380662 | testrunner |   Downloading tomli-2.4.1-py3-none-any.whl (14 kB)
2026-06-08 20:02:24.445806 | testrunner | Collecting cachetools>=6.1
2026-06-08 20:02:24.456396 | testrunner |   Downloading cachetools-6.2.6-py3-none-any.whl (11 kB)
2026-06-08 20:02:24.522051 | testrunner | Collecting typing-extensions>=4.14.1
2026-06-08 20:02:24.531910 | testrunner |   Downloading typing_extensions-4.15.0-py3-none-any.whl (44 kB)
2026-06-08 20:02:24.581826 | testrunner | Collecting pyproject-api>=1.9.1
2026-06-08 20:02:24.593188 | testrunner |   Downloading pyproject_api-1.9.1-py3-none-any.whl (13 kB)
2026-06-08 20:02:24.674216 | testrunner | Collecting platformdirs>=4.3.8
2026-06-08 20:02:24.684413 | testrunner |   Downloading platformdirs-4.4.0-py3-none-any.whl (18 kB)
2026-06-08 20:02:24.754623 | testrunner | Collecting packaging>=25
2026-06-08 20:02:24.766176 | testrunner |   Downloading packaging-26.2-py3-none-any.whl (100 kB)
2026-06-08 20:02:24.854822 | testrunner | Collecting python-discovery>=1.4
2026-06-08 20:02:24.863908 | testrunner |   Downloading python_discovery-1.4.0-py3-none-any.whl (33 kB)
2026-06-08 20:02:24.913707 | testrunner | Collecting distlib<1,>=0.3.7
2026-06-08 20:02:24.923514 | testrunner |   Downloading distlib-0.4.2-py2.py3-none-any.whl (470 kB)
2026-06-08 20:02:25.170248 | testrunner | Installing collected packages: platformdirs, filelock, typing-extensions, tomli, python-discovery, packaging, distlib, virtualenv, pyproject-api, pluggy, colorama, chardet, cachetools, tox
2026-06-08 20:02:25.550290 | testrunner |   WARNING: The script virtualenv is installed in '/usr/local/bin' which is not on PATH.
2026-06-08 20:02:25.550363 | testrunner |   Consider adding this directory to PATH or, if you prefer to suppress this warning, use --no-warn-script-location.
2026-06-08 20:02:25.764174 | testrunner |   WARNING: The script chardetect is installed in '/usr/local/bin' which is not on PATH.
2026-06-08 20:02:25.764225 | testrunner |   Consider adding this directory to PATH or, if you prefer to suppress this warning, use --no-warn-script-location.
2026-06-08 20:02:25.920980 | testrunner |   WARNING: The script tox is installed in '/usr/local/bin' which is not on PATH.
2026-06-08 20:02:25.921031 | testrunner |   Consider adding this directory to PATH or, if you prefer to suppress this warning, use --no-warn-script-location.
2026-06-08 20:02:25.940382 | testrunner | ERROR: pip's dependency resolver does not currently take into account all the packages that are installed. This behaviour is the source of the following dependency conflicts.
2026-06-08 20:02:25.940436 | testrunner | requests 2.25.1 requires chardet<5,>=3.0.2, but you have chardet 5.2.0 which is incompatible.
2026-06-08 20:02:25.940449 | testrunner | Successfully installed cachetools-6.2.6 chardet-5.2.0 colorama-0.4.6 distlib-0.4.2 filelock-3.19.1 packaging-26.2 platformdirs-4.4.0 pluggy-1.6.0 pyproject-api-1.9.1 python-discovery-1.4.0 tomli-2.4.1 tox-4.30.3 typing-extensions-4.15.0 virtualenv-21.4.2
2026-06-08 20:02:25.940458 | testrunner | WARNING: Running pip as the 'root' user can result in broken permissions and conflicting behaviour with the system package manager. It is recommended to use a virtual environment instead: https://pip.pypa.io/warnings/venv
2026-06-09 00:02:26.460948 | testrunner | ok: Runtime: 0:00:04.545620
2026-06-09 00:02:26.470051 | 
2026-06-09 00:02:26.470264 | TASK [Install kubectl]
2026-06-09 00:02:34.940038 | testrunner | changed: OK (49258496 bytes)
2026-06-09 00:02:34.948979 | 
2026-06-09 00:02:34.949188 | TASK [run tox pep8]
2026-06-08 20:02:36.052351 | testrunner | pep8: install_deps> python -I -m pip install ansible flake8 mypy openshift==0.13.2 pytest -r requirements.txt
2026-06-08 20:03:11.556351 | testrunner | .pkg: install_requires> python -I -m pip install 'setuptools>=40.8.0'
2026-06-08 20:03:12.253037 | testrunner | .pkg: _optional_hooks> python /usr/local/lib/python3.9/site-packages/pyproject_api/_backend.py True setuptools.build_meta __legacy__
2026-06-08 20:03:12.522885 | testrunner | .pkg: get_requires_for_build_sdist> python /usr/local/lib/python3.9/site-packages/pyproject_api/_backend.py True setuptools.build_meta __legacy__
2026-06-08 20:03:12.723158 | testrunner | .pkg: get_requires_for_build_wheel> python /usr/local/lib/python3.9/site-packages/pyproject_api/_backend.py True setuptools.build_meta __legacy__
2026-06-08 20:03:12.914897 | testrunner | .pkg: prepare_metadata_for_build_wheel> python /usr/local/lib/python3.9/site-packages/pyproject_api/_backend.py True setuptools.build_meta __legacy__
2026-06-08 20:03:13.141123 | testrunner | .pkg: build_sdist> python /usr/local/lib/python3.9/site-packages/pyproject_api/_backend.py True setuptools.build_meta __legacy__
2026-06-08 20:03:13.328230 | testrunner | pep8: install_package_deps> python -I -m pip install cherrypy routes
2026-06-08 20:03:14.484494 | testrunner | pep8: install_package> python -I -m pip install --force-reinstall --no-deps /home/zuul-worker/src/softwarefactory-project.io/software-factory/k1s/.tox/.tmp/package/1/k1s-1.0.1.tar.gz
2026-06-08 20:03:16.534280 | testrunner | pep8: commands[0]> mypy --ignore-missing-imports k1s/api.py
2026-06-08 20:03:17.893036 | testrunner | Success: no issues found in 1 source file
2026-06-08 20:03:17.899747 | testrunner | pep8: commands[1]> flake8 k1s
2026-06-08 20:03:18.244209 | testrunner |   pep8: OK (42.80=setup[41.09]+cmd[1.36,0.34] seconds)
2026-06-08 20:03:18.244280 | testrunner |   congratulations :) (42.83 seconds)
2026-06-09 00:03:18.547056 | testrunner | ok: Runtime: 0:00:43.097417
2026-06-09 00:03:18.552299 | 
2026-06-09 00:03:18.552409 | TASK [run tox py39]
2026-06-08 20:03:19.316798 | testrunner | py39: install_deps> python -I -m pip install ansible flake8 mypy openshift==0.13.2 pytest -r requirements.txt
2026-06-08 20:03:51.526305 | testrunner | .pkg: _optional_hooks> python /usr/local/lib/python3.9/site-packages/pyproject_api/_backend.py True setuptools.build_meta __legacy__
2026-06-08 20:03:51.684393 | testrunner | .pkg: get_requires_for_build_sdist> python /usr/local/lib/python3.9/site-packages/pyproject_api/_backend.py True setuptools.build_meta __legacy__
2026-06-08 20:03:51.864553 | testrunner | .pkg: get_requires_for_build_wheel> python /usr/local/lib/python3.9/site-packages/pyproject_api/_backend.py True setuptools.build_meta __legacy__
2026-06-08 20:03:52.045005 | testrunner | .pkg: prepare_metadata_for_build_wheel> python /usr/local/lib/python3.9/site-packages/pyproject_api/_backend.py True setuptools.build_meta __legacy__
2026-06-08 20:03:52.243620 | testrunner | .pkg: build_sdist> python /usr/local/lib/python3.9/site-packages/pyproject_api/_backend.py True setuptools.build_meta __legacy__
2026-06-08 20:03:52.446038 | testrunner | py39: install_package_deps> python -I -m pip install cherrypy routes
2026-06-08 20:03:53.043818 | testrunner | py39: install_package> python -I -m pip install --force-reinstall --no-deps /home/zuul-worker/src/softwarefactory-project.io/software-factory/k1s/.tox/.tmp/package/2/k1s-1.0.1.tar.gz
2026-06-08 20:03:54.994014 | testrunner | py39: commands[0]> pytest -v tests.py
2026-06-08 20:03:55.185307 | testrunner | ============================= test session starts ==============================
2026-06-08 20:03:55.185395 | testrunner | platform linux -- Python 3.9.25, pytest-8.4.2, pluggy-1.6.0 -- /home/zuul-worker/src/softwarefactory-project.io/software-factory/k1s/.tox/py39/bin/python
2026-06-08 20:03:55.185405 | testrunner | cachedir: .tox/py39/.pytest_cache
2026-06-08 20:03:55.185413 | testrunner | rootdir: /home/zuul-worker/src/softwarefactory-project.io/software-factory/k1s
2026-06-08 20:03:55.584213 | testrunner | collecting ... collected 5 items
2026-06-08 20:03:55.584269 | testrunner |
2026-06-08 20:04:47.705201 | testrunner | tests.py::K1sTestCase::test_ansible PASSED                               [ 20%]
2026-06-08 20:04:48.001290 | testrunner | tests.py::K1sTestCase::test_bad_token PASSED                             [ 40%]
2026-06-08 20:04:50.884482 | testrunner | tests.py::K1sTestCase::test_create PASSED                                [ 60%]
2026-06-08 20:04:55.499618 | testrunner | tests.py::K1sTestCase::test_kubectl PASSED                               [ 80%]
2026-06-08 20:04:59.645470 | testrunner | tests.py::K1sTestCase::test_python_client PASSED                         [100%]
2026-06-08 20:04:59.645557 | testrunner |
2026-06-08 20:04:59.645570 | testrunner | =============================== warnings summary ===============================
2026-06-08 20:04:59.645581 | testrunner | tests.py::K1sTestCase::test_bad_token
2026-06-08 20:04:59.645594 | testrunner | tests.py::K1sTestCase::test_create
2026-06-08 20:04:59.645604 | testrunner | tests.py::K1sTestCase::test_create
2026-06-08 20:04:59.645614 | testrunner | tests.py::K1sTestCase::test_create
2026-06-08 20:04:59.645624 | testrunner | tests.py::K1sTestCase::test_create
2026-06-08 20:04:59.645634 | testrunner | tests.py::K1sTestCase::test_python_client
2026-06-08 20:04:59.645646 | testrunner |   /home/zuul-worker/src/softwarefactory-project.io/software-factory/k1s/.tox/py39/lib/python3.9/site-packages/urllib3/connectionpool.py:1097: InsecureRequestWarning: Unverified HTTPS request is being made to host 'localhost'. Adding certificate verification is strongly advised. See: https://urllib3.readthedocs.io/en/latest/advanced-usage.html#tls-warnings
2026-06-08 20:04:59.645657 | testrunner |     warnings.warn(
2026-06-08 20:04:59.645668 | testrunner |
2026-06-08 20:04:59.645678 | testrunner | -- Docs: https://docs.pytest.org/en/stable/how-to/capture-warnings.html
2026-06-08 20:04:59.645688 | testrunner | =================== 5 passed, 6 warnings in 64.30s (0:01:04) ===================
2026-06-08 20:04:59.744846 | testrunner |   py39: OK (100.67=setup[35.92]+cmd[64.75] seconds)
2026-06-08 20:04:59.744917 | testrunner |   congratulations :) (100.70 seconds)
2026-06-09 00:05:00.264472 | testrunner | ok: Runtime: 0:01:40.949723
2026-06-09 00:05:00.271976 | 
2026-06-09 00:05:00.272118 | PLAY RECAP
2026-06-09 00:05:00.272194 | testrunner | ok: 8 changed: 6 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0
2026-06-09 00:05:00.272217 | 
2026-06-09 00:05:00.429006 | RUN END RESULT_NORMAL: [untrusted : softwarefactory-project.io/software-factory/k1s/playbooks/k1s-tox.yaml@master]
2026-06-09 00:05:00.431765 | POST-RUN START: [trusted : softwarefactory-project.io/config/playbooks/base/post.yaml@master]
2026-06-09 00:05:01.121319 | 
2026-06-09 00:05:01.121471 | PLAY [all]
2026-06-09 00:05:01.130918 | 
2026-06-09 00:05:01.131010 | TASK [include_role : fetch-output]
2026-06-09 00:05:01.160471 | testrunner | ok
2026-06-09 00:05:01.172859 | 
2026-06-09 00:05:01.172962 | TASK [fetch-output : Set log path for multiple nodes]
2026-06-09 00:05:01.228592 | testrunner | skipping: Conditional result was False
2026-06-09 00:05:01.235261 | 
2026-06-09 00:05:01.235483 | TASK [fetch-output : Set log path for single node]
2026-06-09 00:05:01.277032 | testrunner | ok
2026-06-09 00:05:01.282602 | 
2026-06-09 00:05:01.282714 | LOOP [fetch-output : Ensure local output dirs]
2026-06-09 00:05:01.774214 | testrunner -> localhost | changed: "/var/lib/zuul/builds/90565ee957f94addbbcb7aacfd8fb5ce/work/logs"
2026-06-09 00:05:02.055508 | testrunner -> localhost | changed: "/var/lib/zuul/builds/90565ee957f94addbbcb7aacfd8fb5ce/work/artifacts"
2026-06-09 00:05:02.346142 | testrunner -> localhost | changed: "/var/lib/zuul/builds/90565ee957f94addbbcb7aacfd8fb5ce/work/docs"
2026-06-09 00:05:02.360814 | 
2026-06-09 00:05:02.360972 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-06-09 00:05:03.105158 | testrunner | ok
2026-06-09 00:05:03.106026 | testrunner | changed: All items complete
2026-06-09 00:05:03.106134 | 
2026-06-09 00:05:03.667062 | testrunner | changed: .d..t...... ./
2026-06-09 00:05:04.147623 | testrunner | changed: .d..t...... ./
2026-06-09 00:05:04.175183 | 
2026-06-09 00:05:04.175396 | TASK [include_role : fetch-output-openshift]
2026-06-09 00:05:04.200732 | testrunner | skipping: Conditional result was False
2026-06-09 00:05:04.208023 | 
2026-06-09 00:05:04.208171 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-06-09 00:05:04.245667 | testrunner | skipping: Conditional result was False
2026-06-09 00:05:04.257144 | testrunner | skipping: Conditional result was False
2026-06-09 00:05:04.292534 | 
2026-06-09 00:05:04.292938 | TASK [include_role : rhel-registration]
2026-06-09 00:05:04.309295 | testrunner | skipping: Conditional result was False
2026-06-09 00:05:04.313139 | 
2026-06-09 00:05:04.313239 | PLAY [localhost]
2026-06-09 00:05:04.322343 | 
2026-06-09 00:05:04.322488 | TASK [add-fileserver : Create SSH private key tempfile]
2026-06-09 00:05:04.782401 | localhost | changed
2026-06-09 00:05:04.788639 | 
2026-06-09 00:05:04.788740 | TASK [add-fileserver : Create SSH private key from secret]
2026-06-09 00:05:05.681979 | localhost | changed
2026-06-09 00:05:05.686373 | 
2026-06-09 00:05:05.686439 | TASK [add-fileserver : Add fileserver ssh key]
2026-06-09 00:05:06.208114 | localhost | Identity added: /var/lib/zuul/builds/90565ee957f94addbbcb7aacfd8fb5ce/work/tmp/ansible.q2mt7d5f (/var/lib/zuul/builds/90565ee957f94addbbcb7aacfd8fb5ce/work/tmp/ansible.q2mt7d5f)
2026-06-09 00:05:06.208412 | localhost | ok: Runtime: 0:00:00.018147
2026-06-09 00:05:06.216458 | 
2026-06-09 00:05:06.216618 | TASK [add-fileserver : Remove SSH private key from disk]
2026-06-09 00:05:06.602129 | localhost | ok: Runtime: 0:00:00.005891
2026-06-09 00:05:06.606552 | 
2026-06-09 00:05:06.606656 | TASK [add-fileserver : Add fileserver to inventory]
2026-06-09 00:05:06.685318 | localhost | changed
2026-06-09 00:05:06.689268 | 
2026-06-09 00:05:06.689415 | TASK [add-fileserver : Add fileserver server to known hosts]
2026-06-09 00:05:07.136945 | localhost | changed
2026-06-09 00:05:07.152745 | 
2026-06-09 00:05:07.152925 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-06-09 00:05:07.568643 | localhost | changed
2026-06-09 00:05:07.581378 | 
2026-06-09 00:05:07.581561 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-06-09 00:05:07.623003 | localhost | ok
2026-06-09 00:05:07.633147 | 
2026-06-09 00:05:07.633267 | TASK [include_role : report-logjuicer]
2026-06-09 00:05:07.689143 | localhost | skipping: Conditional result was False
2026-06-09 00:05:07.693857 | 
2026-06-09 00:05:07.693987 | PLAY [a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com]
2026-06-09 00:05:07.700464 | 
2026-06-09 00:05:07.700609 | TASK [Set zuul-log-path fact]
2026-06-09 00:05:07.718575 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | ok
2026-06-09 00:05:07.729783 | 
2026-06-09 00:05:07.729965 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-06-09 00:05:07.768557 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | ok
2026-06-09 00:05:07.772330 | 
2026-06-09 00:05:07.772451 | TASK [upload-logs : Create log directories]
2026-06-09 00:05:08.617975 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | changed
2026-06-09 00:05:08.621902 | 
2026-06-09 00:05:08.622043 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-06-09 00:05:08.955225 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com -> localhost | ok: Runtime: 0:00:00.011768
2026-06-09 00:05:08.957556 | 
2026-06-09 00:05:08.957632 | TASK [upload-logs : Upload logs to log server]
2026-06-09 00:05:10.147194 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | changed:
2026-06-09 00:05:10.147525 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | .d..tp..... ./
2026-06-09 00:05:10.147579 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | <f+++++++++ workspace-repos.json
2026-06-09 00:05:10.147613 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | <f+++++++++ zuul-manifest.json
2026-06-09 00:05:10.147649 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | cd+++++++++ zuul-info/
2026-06-09 00:05:10.147689 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | <f+++++++++ zuul-info/host-info.testrunner.yaml
2026-06-09 00:05:10.147730 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | <f+++++++++ zuul-info/inventory.yaml
2026-06-09 00:05:10.147800 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | <f+++++++++ zuul-info/zuul-info.testrunner.txt
2026-06-09 00:05:10.152582 | 
2026-06-09 00:05:10.152732 | LOOP [upload-logs : Compress console log and json output]
