2026-06-14 00:01:17.358929 | Job console starting 2026-06-14 00:01:17.494914 | Updating git repos 2026-06-14 00:01:17.530858 | Cloning repos into workspace 2026-06-14 00:01:18.008064 | Restoring repo states 2026-06-14 00:01:18.024599 | Merging changes 2026-06-14 00:01:18.024624 | Checking out repos 2026-06-14 00:01:18.090621 | Preparing playbooks 2026-06-14 00:01:21.776666 | Running Ansible setup 2026-06-14 00:01:26.150328 | PRE-RUN START: [trusted : softwarefactory-project.io/config/playbooks/base/pre.yaml@master] 2026-06-14 00:01:26.728401 | 2026-06-14 00:01:26.728534 | PLAY [localhost] 2026-06-14 00:01:26.735975 | 2026-06-14 00:01:26.736053 | TASK [Gathering Facts] 2026-06-14 00:01:28.679701 | localhost | ok 2026-06-14 00:01:28.685882 | 2026-06-14 00:01:28.685957 | TASK [Setup log path fact] 2026-06-14 00:01:28.701626 | localhost | ok 2026-06-14 00:01:28.712498 | 2026-06-14 00:01:28.712594 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-14 00:01:28.738661 | localhost | ok 2026-06-14 00:01:28.744887 | 2026-06-14 00:01:28.744959 | TASK [emit-job-header : Print job information] 2026-06-14 00:01:28.770766 | # Job Information 2026-06-14 00:01:28.770917 | Ansible Version: 2.16.18 2026-06-14 00:01:28.770951 | Job: k1s-tox 2026-06-14 00:01:28.770971 | Pipeline: periodic 2026-06-14 00:01:28.770988 | Executor: 38.102.83.47 2026-06-14 00:01:28.771004 | Triggered by: https://softwarefactory-project.io/r/plugins/gitiles/software-factory/k1s/+/None^!/ 2026-06-14 00:01:28.771024 | Log URL (when completed): https://gateway-cloud-softwarefactory.apps.ocp.cloud.ci.centos.org/logs/274/local/27440b445ff74b60975b240cbe68d061/ 2026-06-14 00:01:28.771042 | Event ID: 2927d5c9366d4579b27253bc0d6dc380 2026-06-14 00:01:28.773696 | 2026-06-14 00:01:28.773760 | LOOP [emit-job-header : Print node information] 2026-06-14 00:01:28.846712 | localhost | ok: 2026-06-14 00:01:28.846871 | localhost | # Node Information 2026-06-14 00:01:28.846898 | localhost | Inventory Hostname: testrunner 2026-06-14 00:01:28.846918 | localhost | Hostname: np0000072977 2026-06-14 00:01:28.846937 | localhost | Username: zuul-worker 2026-06-14 00:01:28.846959 | localhost | Distro: CentOS 9 2026-06-14 00:01:28.846978 | localhost | Provider: vexxhost-nodepool-sf 2026-06-14 00:01:28.846999 | localhost | Region: RegionOne 2026-06-14 00:01:28.847024 | localhost | Label: cloud-centos-9-stream 2026-06-14 00:01:28.847043 | localhost | Product Name: OpenStack Nova 2026-06-14 00:01:28.847074 | localhost | Interface IP: 38.102.83.224 2026-06-14 00:01:28.853947 | 2026-06-14 00:01:28.854058 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-14 00:01:29.242490 | localhost -> localhost | changed 2026-06-14 00:01:29.248213 | 2026-06-14 00:01:29.248303 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-14 00:01:30.196181 | localhost -> localhost | changed 2026-06-14 00:01:30.201884 | 2026-06-14 00:01:30.201947 | PLAY [all] 2026-06-14 00:01:30.207187 | 2026-06-14 00:01:30.207252 | TASK [include_role : start-zuul-console] 2026-06-14 00:01:30.223565 | testrunner | ok 2026-06-14 00:01:30.232765 | 2026-06-14 00:01:30.232825 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-06-14 00:01:30.665787 | testrunner | ok 2026-06-14 00:01:30.673517 | 2026-06-14 00:01:30.673576 | TASK [include_role : validate-host] 2026-06-14 00:01:30.700837 | testrunner | ok 2026-06-14 00:01:30.715821 | 2026-06-14 00:01:30.715889 | TASK [validate-host : Define zuul_info_dir fact] 2026-06-14 00:01:30.742697 | testrunner | ok 2026-06-14 00:01:30.746129 | 2026-06-14 00:01:30.746189 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-06-14 00:01:31.001290 | testrunner -> localhost | ok 2026-06-14 00:01:31.007083 | 2026-06-14 00:01:31.007160 | TASK [validate-host : Collect information about the host] 2026-06-14 00:01:31.753013 | testrunner | ok 2026-06-14 00:01:31.770898 | 2026-06-14 00:01:31.771109 | TASK [validate-host : Sanitize hostname] 2026-06-14 00:01:31.835605 | testrunner | ok 2026-06-14 00:01:31.843317 | 2026-06-14 00:01:31.843506 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-06-14 00:01:32.361974 | testrunner -> localhost | changed 2026-06-14 00:01:32.366902 | 2026-06-14 00:01:32.366994 | TASK [validate-host : Collect information about zuul worker] 2026-06-14 00:01:32.823027 | testrunner | ok 2026-06-14 00:01:32.831699 | 2026-06-14 00:01:32.831861 | TASK [validate-host : Write out all zuul information for each host] 2026-06-14 00:01:33.334663 | testrunner -> localhost | changed 2026-06-14 00:01:33.349731 | 2026-06-14 00:01:33.349935 | TASK [include_role : prepare-workspace] 2026-06-14 00:01:33.367285 | testrunner | ok 2026-06-14 00:01:33.385238 | 2026-06-14 00:01:33.385336 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-06-14 00:01:33.605894 | testrunner | ok 2026-06-14 00:01:33.610061 | 2026-06-14 00:01:33.610130 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-06-14 00:01:34.377575 | testrunner | Output suppressed because no_log was given 2026-06-14 00:01:34.384234 | 2026-06-14 00:01:34.384319 | TASK [include_role : add-build-sshkey] 2026-06-14 00:01:34.411726 | testrunner | ok 2026-06-14 00:01:34.431630 | 2026-06-14 00:01:34.431805 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-14 00:01:34.659242 | testrunner -> localhost | ok 2026-06-14 00:01:34.663355 | 2026-06-14 00:01:34.663424 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-14 00:01:34.689899 | testrunner | ok 2026-06-14 00:01:34.701535 | testrunner | included: /var/lib/zuul/builds/27440b445ff74b60975b240cbe68d061/trusted/project_2/softwarefactory-project.io/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-14 00:01:34.705550 | 2026-06-14 00:01:34.705619 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-14 00:01:35.313736 | testrunner -> localhost | Generating public/private rsa key pair. 2026-06-14 00:01:35.313976 | testrunner -> localhost | Your identification has been saved in /var/lib/zuul/builds/27440b445ff74b60975b240cbe68d061/work/27440b445ff74b60975b240cbe68d061_id_rsa 2026-06-14 00:01:35.314024 | testrunner -> localhost | Your public key has been saved in /var/lib/zuul/builds/27440b445ff74b60975b240cbe68d061/work/27440b445ff74b60975b240cbe68d061_id_rsa.pub 2026-06-14 00:01:35.314061 | testrunner -> localhost | The key fingerprint is: 2026-06-14 00:01:35.314095 | testrunner -> localhost | SHA256:trYeZt11qR2CFqPetTlGiXZtTCHXYjuA5jPgbnxDuQw zuul-build-sshkey 2026-06-14 00:01:35.314129 | testrunner -> localhost | The key's randomart image is: 2026-06-14 00:01:35.314162 | testrunner -> localhost | +---[RSA 3072]----+ 2026-06-14 00:01:35.314195 | testrunner -> localhost | | . . o.| 2026-06-14 00:01:35.314229 | testrunner -> localhost | | . o . = o| 2026-06-14 00:01:35.314264 | testrunner -> localhost | | . + + o + | 2026-06-14 00:01:35.314300 | testrunner -> localhost | | E B = B .| 2026-06-14 00:01:35.314332 | testrunner -> localhost | | oS= O *.B.| 2026-06-14 00:01:35.314363 | testrunner -> localhost | | .=oO.+.B..| 2026-06-14 00:01:35.314395 | testrunner -> localhost | | .*o.o.* . | 2026-06-14 00:01:35.314468 | testrunner -> localhost | | + o . . | 2026-06-14 00:01:35.314511 | testrunner -> localhost | | .o | 2026-06-14 00:01:35.314544 | testrunner -> localhost | +----[SHA256]-----+ 2026-06-14 00:01:35.314617 | testrunner -> localhost | ok: Runtime: 0:00:00.123432 2026-06-14 00:01:35.323201 | 2026-06-14 00:01:35.323322 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-14 00:01:35.343920 | testrunner | ok 2026-06-14 00:01:35.352748 | testrunner | included: /var/lib/zuul/builds/27440b445ff74b60975b240cbe68d061/trusted/project_2/softwarefactory-project.io/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-14 00:01:35.359659 | 2026-06-14 00:01:35.359742 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-14 00:01:35.383390 | testrunner | skipping: Conditional result was False 2026-06-14 00:01:35.387842 | 2026-06-14 00:01:35.387929 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-14 00:01:35.896256 | testrunner | changed 2026-06-14 00:01:35.906833 | 2026-06-14 00:01:35.907163 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-14 00:01:36.204812 | testrunner | ok 2026-06-14 00:01:36.209403 | 2026-06-14 00:01:36.209534 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-14 00:01:37.064286 | testrunner | changed 2026-06-14 00:01:37.072016 | 2026-06-14 00:01:37.072177 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-14 00:01:37.875924 | testrunner | changed 2026-06-14 00:01:37.886549 | 2026-06-14 00:01:37.886723 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-14 00:01:37.902121 | testrunner | skipping: Conditional result was False 2026-06-14 00:01:37.908396 | 2026-06-14 00:01:37.908576 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-14 00:01:38.289150 | testrunner -> localhost | changed 2026-06-14 00:01:38.298413 | 2026-06-14 00:01:38.298647 | TASK [add-build-sshkey : Add back temp key] 2026-06-14 00:01:38.610356 | testrunner -> localhost | Identity added: /var/lib/zuul/builds/27440b445ff74b60975b240cbe68d061/work/27440b445ff74b60975b240cbe68d061_id_rsa (zuul-build-sshkey) 2026-06-14 00:01:38.610591 | testrunner -> localhost | ok: Runtime: 0:00:00.010781 2026-06-14 00:01:38.615217 | 2026-06-14 00:01:38.615276 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-14 00:01:39.028593 | testrunner | ok 2026-06-14 00:01:39.032931 | 2026-06-14 00:01:39.033050 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-14 00:01:39.067174 | testrunner | skipping: Conditional result was False 2026-06-14 00:01:39.073706 | 2026-06-14 00:01:39.073794 | TASK [include_role : prepare-workspace-openshift] 2026-06-14 00:01:39.088663 | testrunner | skipping: Conditional result was False 2026-06-14 00:01:39.094455 | 2026-06-14 00:01:39.094610 | TASK [include_role : remove-zuul-sshkey] 2026-06-14 00:01:39.109255 | testrunner | skipping: Conditional result was False 2026-06-14 00:01:39.114322 | 2026-06-14 00:01:39.114388 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-06-14 00:01:39.387652 | testrunner | ok: "logs" 2026-06-14 00:01:39.388065 | testrunner | ok: All items complete 2026-06-14 00:01:39.388117 | 2026-06-14 00:01:39.606724 | testrunner | ok: "artifacts" 2026-06-14 00:01:39.826005 | testrunner | ok: "docs" 2026-06-14 00:01:39.837069 | 2026-06-14 00:01:39.837228 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-06-14 00:01:40.111966 | testrunner | changed: "logs" 2026-06-14 00:01:40.324229 | testrunner | changed: "artifacts" 2026-06-14 00:01:40.538930 | testrunner | changed: "docs" 2026-06-14 00:01:40.553757 | 2026-06-14 00:01:40.553889 | TASK [include_role : rhel-registration] 2026-06-14 00:01:40.568282 | testrunner | skipping: Conditional result was False 2026-06-14 00:01:40.569839 | 2026-06-14 00:01:40.569897 | PLAY RECAP 2026-06-14 00:01:40.569961 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-14 00:01:40.569999 | testrunner | ok: 23 changed: 10 unreachable: 0 failed: 0 skipped: 6 rescued: 0 ignored: 0 2026-06-14 00:01:40.570022 | 2026-06-14 00:01:40.825793 | PRE-RUN END RESULT_NORMAL: [trusted : softwarefactory-project.io/config/playbooks/base/pre.yaml@master] 2026-06-14 00:01:40.828696 | RUN START: [untrusted : softwarefactory-project.io/software-factory/k1s/playbooks/k1s-tox.yaml@master] 2026-06-14 00:01:41.533210 | 2026-06-14 00:01:41.533360 | PLAY [all] 2026-06-14 00:01:41.546072 | 2026-06-14 00:01:41.546242 | LOOP [ensure-podman : Find distribution installation] 2026-06-14 00:01:41.569076 | testrunner | ok: "/var/lib/zuul/builds/27440b445ff74b60975b240cbe68d061/untrusted/project_3/softwarefactory-project.io/zuul-jobs/roles/ensure-podman/tasks/RedHat.yaml" 2026-06-14 00:01:41.574741 | testrunner | included: /var/lib/zuul/builds/27440b445ff74b60975b240cbe68d061/untrusted/project_3/softwarefactory-project.io/zuul-jobs/roles/ensure-podman/tasks/RedHat.yaml 2026-06-14 00:01:41.579729 | 2026-06-14 00:01:41.579843 | TASK [ensure-podman : Install podman (RedHat)] 2026-06-14 00:02:26.526114 | testrunner | changed 2026-06-14 00:02:26.541216 | 2026-06-14 00:02:26.541351 | TASK [ensure-podman : Fetch podman version] 2026-06-13 20:02:27.125894 | testrunner | Client: Podman Engine 2026-06-13 20:02:27.125942 | testrunner | Version: 5.8.2 2026-06-13 20:02:27.125949 | testrunner | API Version: 5.8.2 2026-06-13 20:02:27.125953 | testrunner | Go Version: go1.26.1 (Red Hat 1.26.1-1.el9) 2026-06-13 20:02:27.125960 | testrunner | Built: Thu Apr 16 04:05:13 2026 2026-06-13 20:02:27.125964 | testrunner | OS/Arch: linux/amd64 2026-06-14 00:02:27.578398 | testrunner | ok: Runtime: 0:00:00.242328 2026-06-14 00:02:27.583141 | 2026-06-14 00:02:27.583233 | TASK [ensure-podman : Print podman version installed] 2026-06-14 00:02:27.622217 | Podman version: Client: Podman Engine 2026-06-14 00:02:27.622375 | Version: 5.8.2 2026-06-14 00:02:27.622407 | API Version: 5.8.2 2026-06-14 00:02:27.622452 | Go Version: go1.26.1 (Red Hat 1.26.1-1.el9) 2026-06-14 00:02:27.622490 | Built: Thu Apr 16 04:05:13 2026 2026-06-14 00:02:27.622513 | OS/Arch: linux/amd64 2026-06-14 00:02:27.626961 | 2026-06-14 00:02:27.627071 | TASK [ensure-podman : Validate podman engine] 2026-06-14 00:02:28.149641 | testrunner | skipping: Conditional result was False 2026-06-14 00:02:28.154968 | 2026-06-14 00:02:28.155080 | TASK [ensure-podman : Set up docker compatability socket] 2026-06-14 00:02:28.179256 | testrunner | skipping: Conditional result was False 2026-06-14 00:02:28.188060 | 2026-06-14 00:02:28.188185 | TASK [install tox] 2026-06-13 20:02:29.408469 | testrunner | Collecting tox 2026-06-13 20:02:29.494538 | testrunner | Downloading tox-4.30.3-py3-none-any.whl (175 kB) 2026-06-13 20:02:29.629841 | testrunner | Collecting pluggy>=1.6 2026-06-13 20:02:29.656376 | testrunner | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-06-13 20:02:29.840557 | testrunner | Collecting chardet>=5.2 2026-06-13 20:02:29.866385 | testrunner | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2026-06-13 20:02:29.941536 | testrunner | Collecting packaging>=25 2026-06-13 20:02:29.967279 | testrunner | Downloading packaging-26.2-py3-none-any.whl (100 kB) 2026-06-13 20:02:30.022510 | testrunner | Collecting colorama>=0.4.6 2026-06-13 20:02:30.047895 | testrunner | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-06-13 20:02:30.156920 | testrunner | Collecting tomli>=2.2.1 2026-06-13 20:02:30.182065 | testrunner | Downloading tomli-2.4.1-py3-none-any.whl (14 kB) 2026-06-13 20:02:30.286484 | testrunner | Collecting typing-extensions>=4.14.1 2026-06-13 20:02:30.311144 | testrunner | Downloading typing_extensions-4.15.0-py3-none-any.whl (44 kB) 2026-06-13 20:02:30.375703 | testrunner | Collecting platformdirs>=4.3.8 2026-06-13 20:02:30.402914 | testrunner | Downloading platformdirs-4.4.0-py3-none-any.whl (18 kB) 2026-06-13 20:02:30.482364 | testrunner | Collecting pyproject-api>=1.9.1 2026-06-13 20:02:30.509283 | testrunner | Downloading pyproject_api-1.9.1-py3-none-any.whl (13 kB) 2026-06-13 20:02:30.614086 | testrunner | Collecting cachetools>=6.1 2026-06-13 20:02:30.640271 | testrunner | Downloading cachetools-6.2.6-py3-none-any.whl (11 kB) 2026-06-13 20:02:30.880941 | testrunner | Collecting virtualenv>=20.31.2 2026-06-13 20:02:30.907752 | testrunner | Downloading virtualenv-21.5.0-py3-none-any.whl (4.6 MB) 2026-06-13 20:02:31.090312 | testrunner | Collecting filelock>=3.18 2026-06-13 20:02:31.116050 | testrunner | Downloading filelock-3.19.1-py3-none-any.whl (15 kB) 2026-06-13 20:02:31.218152 | testrunner | Collecting distlib<1,>=0.3.7 2026-06-13 20:02:31.243248 | testrunner | Downloading distlib-0.4.3-py2.py3-none-any.whl (470 kB) 2026-06-13 20:02:31.295569 | testrunner | Collecting python-discovery>=1.4.2 2026-06-13 20:02:31.321504 | testrunner | Downloading python_discovery-1.4.2-py3-none-any.whl (33 kB) 2026-06-13 20:02:31.494182 | testrunner | Installing collected packages: platformdirs, filelock, typing-extensions, tomli, python-discovery, packaging, distlib, virtualenv, pyproject-api, pluggy, colorama, chardet, cachetools, tox 2026-06-13 20:02:31.819529 | testrunner | WARNING: The script virtualenv is installed in '/usr/local/bin' which is not on PATH. 2026-06-13 20:02:31.819589 | testrunner | Consider adding this directory to PATH or, if you prefer to suppress this warning, use --no-warn-script-location. 2026-06-13 20:02:32.033094 | testrunner | WARNING: The script chardetect is installed in '/usr/local/bin' which is not on PATH. 2026-06-13 20:02:32.033188 | testrunner | Consider adding this directory to PATH or, if you prefer to suppress this warning, use --no-warn-script-location. 2026-06-13 20:02:32.171400 | testrunner | WARNING: The script tox is installed in '/usr/local/bin' which is not on PATH. 2026-06-13 20:02:32.171462 | testrunner | Consider adding this directory to PATH or, if you prefer to suppress this warning, use --no-warn-script-location. 2026-06-13 20:02:32.188225 | 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-13 20:02:32.188273 | testrunner | requests 2.25.1 requires chardet<5,>=3.0.2, but you have chardet 5.2.0 which is incompatible. 2026-06-13 20:02:32.188287 | testrunner | Successfully installed cachetools-6.2.6 chardet-5.2.0 colorama-0.4.6 distlib-0.4.3 filelock-3.19.1 packaging-26.2 platformdirs-4.4.0 pluggy-1.6.0 pyproject-api-1.9.1 python-discovery-1.4.2 tomli-2.4.1 tox-4.30.3 typing-extensions-4.15.0 virtualenv-21.5.0 2026-06-13 20:02:32.188293 | 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-14 00:02:32.718875 | testrunner | ok: Runtime: 0:00:03.958518 2026-06-14 00:02:32.723502 | 2026-06-14 00:02:32.723590 | TASK [Install kubectl] 2026-06-14 00:02:49.040190 | testrunner | changed: OK (49258496 bytes) 2026-06-14 00:02:49.045521 | 2026-06-14 00:02:49.045605 | TASK [run tox pep8] 2026-06-13 20:02:50.222583 | testrunner | pep8: install_deps> python -I -m pip install ansible flake8 mypy openshift==0.13.2 pytest -r requirements.txt 2026-06-13 20:03:31.039257 | testrunner | .pkg: install_requires> python -I -m pip install 'setuptools>=40.8.0' 2026-06-13 20:03:31.724090 | testrunner | .pkg: _optional_hooks> python /usr/local/lib/python3.9/site-packages/pyproject_api/_backend.py True setuptools.build_meta __legacy__ 2026-06-13 20:03:31.977793 | 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-13 20:03:32.191969 | 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-13 20:03:32.366101 | 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-13 20:03:32.548215 | testrunner | .pkg: build_sdist> python /usr/local/lib/python3.9/site-packages/pyproject_api/_backend.py True setuptools.build_meta __legacy__ 2026-06-13 20:03:32.764699 | testrunner | pep8: install_package_deps> python -I -m pip install cherrypy routes 2026-06-13 20:03:33.683572 | 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-13 20:03:36.461425 | testrunner | pep8: commands[0]> mypy --ignore-missing-imports k1s/api.py 2026-06-13 20:03:37.875338 | testrunner | Success: no issues found in 1 source file 2026-06-13 20:03:37.880336 | testrunner | pep8: commands[1]> flake8 k1s 2026-06-13 20:03:38.230375 | testrunner | pep8: OK (48.58=setup[46.81]+cmd[1.42,0.35] seconds) 2026-06-13 20:03:38.230448 | testrunner | congratulations :) (48.67 seconds) 2026-06-14 00:03:38.659024 | testrunner | ok: Runtime: 0:00:48.943413 2026-06-14 00:03:38.662667 | 2026-06-14 00:03:38.662728 | TASK [run tox py39] 2026-06-13 20:03:39.413196 | testrunner | py39: install_deps> python -I -m pip install ansible flake8 mypy openshift==0.13.2 pytest -r requirements.txt 2026-06-13 20:04:13.530641 | testrunner | .pkg: _optional_hooks> python /usr/local/lib/python3.9/site-packages/pyproject_api/_backend.py True setuptools.build_meta __legacy__ 2026-06-13 20:04:13.720257 | 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-13 20:04:13.911299 | 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-13 20:04:14.076430 | 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-13 20:04:14.323725 | testrunner | .pkg: build_sdist> python /usr/local/lib/python3.9/site-packages/pyproject_api/_backend.py True setuptools.build_meta __legacy__ 2026-06-13 20:04:14.578250 | testrunner | py39: install_package_deps> python -I -m pip install cherrypy routes 2026-06-13 20:04:15.166702 | 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-13 20:04:17.022760 | testrunner | py39: commands[0]> pytest -v tests.py 2026-06-13 20:04:17.205408 | testrunner | ============================= test session starts ============================== 2026-06-13 20:04:17.205459 | 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-13 20:04:17.205468 | testrunner | cachedir: .tox/py39/.pytest_cache 2026-06-13 20:04:17.205475 | testrunner | rootdir: /home/zuul-worker/src/softwarefactory-project.io/software-factory/k1s 2026-06-13 20:04:17.594263 | testrunner | collecting ... collected 5 items 2026-06-13 20:04:17.594310 | testrunner | 2026-06-13 20:08:59.341612 | testrunner | tests.py::K1sTestCase::test_ansible PASSED [ 20%] 2026-06-13 20:08:59.554873 | testrunner | tests.py::K1sTestCase::test_bad_token PASSED [ 40%] 2026-06-13 20:09:02.402606 | testrunner | tests.py::K1sTestCase::test_create PASSED [ 60%] 2026-06-13 20:09:07.837168 | testrunner | tests.py::K1sTestCase::test_kubectl PASSED [ 80%] 2026-06-13 20:09:12.311531 | testrunner | tests.py::K1sTestCase::test_python_client PASSED [100%] 2026-06-13 20:09:12.311592 | testrunner | 2026-06-13 20:09:12.311598 | testrunner | =============================== warnings summary =============================== 2026-06-13 20:09:12.311607 | testrunner | tests.py::K1sTestCase::test_bad_token 2026-06-13 20:09:12.311613 | testrunner | tests.py::K1sTestCase::test_create 2026-06-13 20:09:12.311617 | testrunner | tests.py::K1sTestCase::test_create 2026-06-13 20:09:12.311620 | testrunner | tests.py::K1sTestCase::test_create 2026-06-13 20:09:12.311624 | testrunner | tests.py::K1sTestCase::test_create 2026-06-13 20:09:12.311627 | testrunner | tests.py::K1sTestCase::test_python_client 2026-06-13 20:09:12.311632 | 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-13 20:09:12.311636 | testrunner | warnings.warn( 2026-06-13 20:09:12.311641 | testrunner | 2026-06-13 20:09:12.311644 | testrunner | -- Docs: https://docs.pytest.org/en/stable/how-to/capture-warnings.html 2026-06-13 20:09:12.311648 | testrunner | ================== 5 passed, 6 warnings in 294.88s (0:04:54) =================== 2026-06-13 20:09:12.464409 | testrunner | py39: OK (333.33=setup[37.89]+cmd[295.44] seconds) 2026-06-13 20:09:12.464486 | testrunner | congratulations :) (333.36 seconds) 2026-06-14 00:09:12.746976 | testrunner | ok: Runtime: 0:05:33.601333 2026-06-14 00:09:12.755336 | 2026-06-14 00:09:12.755482 | PLAY RECAP 2026-06-14 00:09:12.755586 | testrunner | ok: 8 changed: 6 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-06-14 00:09:12.755632 | 2026-06-14 00:09:12.951346 | RUN END RESULT_NORMAL: [untrusted : softwarefactory-project.io/software-factory/k1s/playbooks/k1s-tox.yaml@master] 2026-06-14 00:09:12.952674 | POST-RUN START: [trusted : softwarefactory-project.io/config/playbooks/base/post.yaml@master] 2026-06-14 00:09:13.596784 | 2026-06-14 00:09:13.596903 | PLAY [all] 2026-06-14 00:09:13.607237 | 2026-06-14 00:09:13.607337 | TASK [include_role : fetch-output] 2026-06-14 00:09:13.656819 | testrunner | ok 2026-06-14 00:09:13.673799 | 2026-06-14 00:09:13.673931 | TASK [fetch-output : Set log path for multiple nodes] 2026-06-14 00:09:13.749233 | testrunner | skipping: Conditional result was False 2026-06-14 00:09:13.757577 | 2026-06-14 00:09:13.757711 | TASK [fetch-output : Set log path for single node] 2026-06-14 00:09:13.787839 | testrunner | ok 2026-06-14 00:09:13.791669 | 2026-06-14 00:09:13.791749 | LOOP [fetch-output : Ensure local output dirs] 2026-06-14 00:09:14.283087 | testrunner -> localhost | changed: "/var/lib/zuul/builds/27440b445ff74b60975b240cbe68d061/work/logs" 2026-06-14 00:09:14.518332 | testrunner -> localhost | changed: "/var/lib/zuul/builds/27440b445ff74b60975b240cbe68d061/work/artifacts" 2026-06-14 00:09:14.767734 | testrunner -> localhost | changed: "/var/lib/zuul/builds/27440b445ff74b60975b240cbe68d061/work/docs" 2026-06-14 00:09:14.788592 | 2026-06-14 00:09:14.788775 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-14 00:09:15.468147 | testrunner | ok 2026-06-14 00:09:15.468487 | testrunner | changed: All items complete 2026-06-14 00:09:15.468548 | 2026-06-14 00:09:15.998469 | testrunner | changed: .d..t...... ./ 2026-06-14 00:09:16.534760 | testrunner | changed: .d..t...... ./ 2026-06-14 00:09:16.547393 | 2026-06-14 00:09:16.547522 | TASK [include_role : fetch-output-openshift] 2026-06-14 00:09:16.572689 | testrunner | skipping: Conditional result was False 2026-06-14 00:09:16.579046 | 2026-06-14 00:09:16.579142 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-14 00:09:16.623609 | testrunner | skipping: Conditional result was False 2026-06-14 00:09:16.633543 | testrunner | skipping: Conditional result was False 2026-06-14 00:09:16.645407 | 2026-06-14 00:09:16.645541 | TASK [include_role : rhel-registration] 2026-06-14 00:09:16.670654 | testrunner | skipping: Conditional result was False 2026-06-14 00:09:16.675810 | 2026-06-14 00:09:16.675946 | PLAY [localhost] 2026-06-14 00:09:16.690028 | 2026-06-14 00:09:16.690179 | TASK [add-fileserver : Create SSH private key tempfile] 2026-06-14 00:09:17.065372 | localhost | changed 2026-06-14 00:09:17.069220 | 2026-06-14 00:09:17.069286 | TASK [add-fileserver : Create SSH private key from secret] 2026-06-14 00:09:17.910229 | localhost | changed 2026-06-14 00:09:17.914593 | 2026-06-14 00:09:17.914660 | TASK [add-fileserver : Add fileserver ssh key] 2026-06-14 00:09:18.402178 | localhost | Identity added: /var/lib/zuul/builds/27440b445ff74b60975b240cbe68d061/work/tmp/ansible.7sd11561 (/var/lib/zuul/builds/27440b445ff74b60975b240cbe68d061/work/tmp/ansible.7sd11561) 2026-06-14 00:09:18.402665 | localhost | ok: Runtime: 0:00:00.012627 2026-06-14 00:09:18.462776 | 2026-06-14 00:09:18.462957 | TASK [add-fileserver : Remove SSH private key from disk] 2026-06-14 00:09:18.773773 | localhost | ok: Runtime: 0:00:00.006589 2026-06-14 00:09:18.777461 | 2026-06-14 00:09:18.777524 | TASK [add-fileserver : Add fileserver to inventory] 2026-06-14 00:09:18.836187 | localhost | changed 2026-06-14 00:09:18.839375 | 2026-06-14 00:09:18.839463 | TASK [add-fileserver : Add fileserver server to known hosts] 2026-06-14 00:09:19.288882 | localhost | changed 2026-06-14 00:09:19.297818 | 2026-06-14 00:09:19.297902 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-14 00:09:19.727222 | localhost | changed 2026-06-14 00:09:19.738527 | 2026-06-14 00:09:19.738661 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-14 00:09:19.776955 | localhost | ok 2026-06-14 00:09:19.782673 | 2026-06-14 00:09:19.782733 | TASK [include_role : report-logjuicer] 2026-06-14 00:09:19.817260 | localhost | skipping: Conditional result was False 2026-06-14 00:09:19.821671 | 2026-06-14 00:09:19.821786 | PLAY [a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com] 2026-06-14 00:09:19.828350 | 2026-06-14 00:09:19.828509 | TASK [Set zuul-log-path fact] 2026-06-14 00:09:19.848240 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | ok 2026-06-14 00:09:19.862731 | 2026-06-14 00:09:19.862877 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-14 00:09:19.893151 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | ok 2026-06-14 00:09:19.900060 | 2026-06-14 00:09:19.900201 | TASK [upload-logs : Create log directories] 2026-06-14 00:09:20.718956 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | changed 2026-06-14 00:09:20.721170 | 2026-06-14 00:09:20.721242 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-14 00:09:21.044260 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com -> localhost | ok: Runtime: 0:00:00.006625 2026-06-14 00:09:21.046833 | 2026-06-14 00:09:21.046924 | TASK [upload-logs : Upload logs to log server] 2026-06-14 00:09:22.215972 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | changed: 2026-06-14 00:09:22.216384 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | .d..tp..... ./ 2026-06-14 00:09:22.216519 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com |