2026-06-10 00:01:21.037235 | Job console starting
2026-06-10 00:01:21.173447 | Updating git repos
2026-06-10 00:01:21.207059 | Cloning repos into workspace
2026-06-10 00:01:21.684090 | Restoring repo states
2026-06-10 00:01:21.702024 | Merging changes
2026-06-10 00:01:21.702044 | Checking out repos
2026-06-10 00:01:21.764947 | Preparing playbooks
2026-06-10 00:01:27.881082 | Running Ansible setup
2026-06-10 00:01:31.863287 | PRE-RUN START: [trusted : softwarefactory-project.io/config/playbooks/base/pre.yaml@master]
2026-06-10 00:01:32.560746 | 
2026-06-10 00:01:32.560877 | PLAY [localhost]
2026-06-10 00:01:32.568108 | 
2026-06-10 00:01:32.568190 | TASK [Gathering Facts]
2026-06-10 00:01:33.534075 | localhost | ok
2026-06-10 00:01:33.540065 | 
2026-06-10 00:01:33.540139 | TASK [Setup log path fact]
2026-06-10 00:01:33.555906 | localhost | ok
2026-06-10 00:01:33.566021 | 
2026-06-10 00:01:33.566095 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-06-10 00:01:33.597335 | localhost | ok
2026-06-10 00:01:33.605702 | 
2026-06-10 00:01:33.605783 | TASK [emit-job-header : Print job information]
2026-06-10 00:01:33.653355 | # Job Information
2026-06-10 00:01:33.653570 | Ansible Version: 2.16.18
2026-06-10 00:01:33.653651 | Job: k1s-tox
2026-06-10 00:01:33.653692 | Pipeline: periodic
2026-06-10 00:01:33.653728 | Executor: 38.102.83.40
2026-06-10 00:01:33.653763 | Triggered by: https://softwarefactory-project.io/r/plugins/gitiles/software-factory/k1s/+/None^!/
2026-06-10 00:01:33.653796 | Log URL (when completed): https://gateway-cloud-softwarefactory.apps.ocp.cloud.ci.centos.org/logs/9e1/local/9e1ad329c85f401b92c9950107c9606d/
2026-06-10 00:01:33.653824 | Event ID: 700a2f5588bd4248ad8d842bf6c2c46c
2026-06-10 00:01:33.657325 | 
2026-06-10 00:01:33.657410 | LOOP [emit-job-header : Print node information]
2026-06-10 00:01:33.742076 | localhost | ok:
2026-06-10 00:01:33.742526 | localhost | # Node Information
2026-06-10 00:01:33.742569 | localhost | Inventory Hostname: testrunner
2026-06-10 00:01:33.742646 | localhost | Hostname: np0000069173
2026-06-10 00:01:33.742674 | localhost | Username: zuul-worker
2026-06-10 00:01:33.742703 | localhost | Distro: CentOS 9
2026-06-10 00:01:33.742728 | localhost | Provider: vexxhost-nodepool-sf
2026-06-10 00:01:33.742752 | localhost | Region: RegionOne
2026-06-10 00:01:33.742776 | localhost | Label: cloud-centos-9-stream
2026-06-10 00:01:33.742799 | localhost | Product Name: OpenStack Nova
2026-06-10 00:01:33.742821 | localhost | Interface IP: 38.102.83.66
2026-06-10 00:01:33.762273 | 
2026-06-10 00:01:33.762454 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-06-10 00:01:34.216498 | localhost -> localhost | changed
2026-06-10 00:01:34.225902 | 
2026-06-10 00:01:34.226052 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-06-10 00:01:35.180148 | localhost -> localhost | changed
2026-06-10 00:01:35.191847 | 
2026-06-10 00:01:35.191961 | PLAY [all]
2026-06-10 00:01:35.202912 | 
2026-06-10 00:01:35.203043 | TASK [include_role : start-zuul-console]
2026-06-10 00:01:35.227362 | testrunner | ok
2026-06-10 00:01:35.246299 | 
2026-06-10 00:01:35.246386 | TASK [start-zuul-console : Start zuul_console daemon.]
2026-06-10 00:01:35.674022 | testrunner | ok
2026-06-10 00:01:35.696625 | 
2026-06-10 00:01:35.696773 | TASK [include_role : validate-host]
2026-06-10 00:01:35.736927 | testrunner | ok
2026-06-10 00:01:35.758413 | 
2026-06-10 00:01:35.758550 | TASK [validate-host : Define zuul_info_dir fact]
2026-06-10 00:01:35.789076 | testrunner | ok
2026-06-10 00:01:35.792896 | 
2026-06-10 00:01:35.792991 | TASK [validate-host : Ensure Zuul Ansible directory exists]
2026-06-10 00:01:36.071739 | testrunner -> localhost | ok
2026-06-10 00:01:36.083616 | 
2026-06-10 00:01:36.083756 | TASK [validate-host : Collect information about the host]
2026-06-10 00:01:36.817133 | testrunner | ok
2026-06-10 00:01:36.827678 | 
2026-06-10 00:01:36.827760 | TASK [validate-host : Sanitize hostname]
2026-06-10 00:01:36.917816 | testrunner | ok
2026-06-10 00:01:36.921537 | 
2026-06-10 00:01:36.921633 | TASK [validate-host : Write out all ansible variables/facts known for each host]
2026-06-10 00:01:37.442916 | testrunner -> localhost | changed
2026-06-10 00:01:37.447618 | 
2026-06-10 00:01:37.447689 | TASK [validate-host : Collect information about zuul worker]
2026-06-10 00:01:37.956233 | testrunner | ok
2026-06-10 00:01:37.963085 | 
2026-06-10 00:01:37.963217 | TASK [validate-host : Write out all zuul information for each host]
2026-06-10 00:01:38.498486 | testrunner -> localhost | changed
2026-06-10 00:01:38.505690 | 
2026-06-10 00:01:38.505752 | TASK [include_role : prepare-workspace]
2026-06-10 00:01:38.532767 | testrunner | ok
2026-06-10 00:01:38.550310 | 
2026-06-10 00:01:38.550370 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-06-10 00:01:38.770967 | testrunner | ok
2026-06-10 00:01:38.776899 | 
2026-06-10 00:01:38.776991 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-06-10 00:01:39.550483 | testrunner | Output suppressed because no_log was given
2026-06-10 00:01:39.555957 | 
2026-06-10 00:01:39.556018 | TASK [include_role : add-build-sshkey]
2026-06-10 00:01:39.574469 | testrunner | ok
2026-06-10 00:01:39.590391 | 
2026-06-10 00:01:39.590460 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-06-10 00:01:39.879482 | testrunner -> localhost | ok
2026-06-10 00:01:39.889004 | 
2026-06-10 00:01:39.889146 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-06-10 00:01:39.917126 | testrunner | ok
2026-06-10 00:01:39.942997 | testrunner | included: /var/lib/zuul/builds/9e1ad329c85f401b92c9950107c9606d/trusted/project_2/softwarefactory-project.io/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-06-10 00:01:39.949105 | 
2026-06-10 00:01:39.949193 | TASK [add-build-sshkey : Create Temp SSH key]
2026-06-10 00:01:40.524392 | testrunner -> localhost | Generating public/private rsa key pair.
2026-06-10 00:01:40.524599 | testrunner -> localhost | Your identification has been saved in /var/lib/zuul/builds/9e1ad329c85f401b92c9950107c9606d/work/9e1ad329c85f401b92c9950107c9606d_id_rsa
2026-06-10 00:01:40.524630 | testrunner -> localhost | Your public key has been saved in /var/lib/zuul/builds/9e1ad329c85f401b92c9950107c9606d/work/9e1ad329c85f401b92c9950107c9606d_id_rsa.pub
2026-06-10 00:01:40.524652 | testrunner -> localhost | The key fingerprint is:
2026-06-10 00:01:40.524671 | testrunner -> localhost | SHA256:2I9z/dBs7VXpqrEYoelSFNz/LTkOgYuMedX6Y5QaD4E zuul-build-sshkey
2026-06-10 00:01:40.524689 | testrunner -> localhost | The key's randomart image is:
2026-06-10 00:01:40.524708 | testrunner -> localhost | +---[RSA 3072]----+
2026-06-10 00:01:40.524726 | testrunner -> localhost | |      . .        |
2026-06-10 00:01:40.524745 | testrunner -> localhost | |       o .       |
2026-06-10 00:01:40.524763 | testrunner -> localhost | |        o +      |
2026-06-10 00:01:40.524780 | testrunner -> localhost | |       E + +    .|
2026-06-10 00:01:40.524797 | testrunner -> localhost | |      * S.+ + o..|
2026-06-10 00:01:40.524814 | testrunner -> localhost | |     o =oB.= B.o.|
2026-06-10 00:01:40.524831 | testrunner -> localhost | |      ooo.X.= *.o|
2026-06-10 00:01:40.524850 | testrunner -> localhost | |     ..  +o=o=...|
2026-06-10 00:01:40.524874 | testrunner -> localhost | |      .. ..oo.. .|
2026-06-10 00:01:40.524897 | testrunner -> localhost | +----[SHA256]-----+
2026-06-10 00:01:40.524948 | testrunner -> localhost | ok: Runtime: 0:00:00.162115
2026-06-10 00:01:40.529914 | 
2026-06-10 00:01:40.530010 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-06-10 00:01:40.559029 | testrunner | ok
2026-06-10 00:01:40.566195 | testrunner | included: /var/lib/zuul/builds/9e1ad329c85f401b92c9950107c9606d/trusted/project_2/softwarefactory-project.io/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-06-10 00:01:40.572670 | 
2026-06-10 00:01:40.572730 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-06-10 00:01:40.606930 | testrunner | skipping: Conditional result was False
2026-06-10 00:01:40.610890 | 
2026-06-10 00:01:40.610955 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-06-10 00:01:41.114073 | testrunner | changed
2026-06-10 00:01:41.117721 | 
2026-06-10 00:01:41.117800 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-06-10 00:01:41.409346 | testrunner | ok
2026-06-10 00:01:41.422014 | 
2026-06-10 00:01:41.422210 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-06-10 00:01:42.192711 | testrunner | changed
2026-06-10 00:01:42.196245 | 
2026-06-10 00:01:42.196312 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-06-10 00:01:43.044164 | testrunner | changed
2026-06-10 00:01:43.049148 | 
2026-06-10 00:01:43.049226 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-06-10 00:01:43.083438 | testrunner | skipping: Conditional result was False
2026-06-10 00:01:43.089082 | 
2026-06-10 00:01:43.089171 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-06-10 00:01:43.542441 | testrunner -> localhost | changed
2026-06-10 00:01:43.556310 | 
2026-06-10 00:01:43.556482 | TASK [add-build-sshkey : Add back temp key]
2026-06-10 00:01:43.890923 | testrunner -> localhost | Identity added: /var/lib/zuul/builds/9e1ad329c85f401b92c9950107c9606d/work/9e1ad329c85f401b92c9950107c9606d_id_rsa (zuul-build-sshkey)
2026-06-10 00:01:43.891147 | testrunner -> localhost | ok: Runtime: 0:00:00.009598
2026-06-10 00:01:43.896158 | 
2026-06-10 00:01:43.896221 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-06-10 00:01:44.297715 | testrunner | ok
2026-06-10 00:01:44.300836 | 
2026-06-10 00:01:44.300914 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-06-10 00:01:44.324809 | testrunner | skipping: Conditional result was False
2026-06-10 00:01:44.331624 | 
2026-06-10 00:01:44.331697 | TASK [include_role : prepare-workspace-openshift]
2026-06-10 00:01:44.355852 | testrunner | skipping: Conditional result was False
2026-06-10 00:01:44.360139 | 
2026-06-10 00:01:44.360206 | TASK [include_role : remove-zuul-sshkey]
2026-06-10 00:01:44.393891 | testrunner | skipping: Conditional result was False
2026-06-10 00:01:44.398192 | 
2026-06-10 00:01:44.398278 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-06-10 00:01:44.638447 | testrunner | ok: "logs"
2026-06-10 00:01:44.638930 | testrunner | ok: All items complete
2026-06-10 00:01:44.638988 | 
2026-06-10 00:01:44.833863 | testrunner | ok: "artifacts"
2026-06-10 00:01:45.060036 | testrunner | ok: "docs"
2026-06-10 00:01:45.066092 | 
2026-06-10 00:01:45.066390 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-06-10 00:01:45.338027 | testrunner | changed: "logs"
2026-06-10 00:01:45.576267 | testrunner | changed: "artifacts"
2026-06-10 00:01:45.794411 | testrunner | changed: "docs"
2026-06-10 00:01:45.815431 | 
2026-06-10 00:01:45.815693 | TASK [include_role : rhel-registration]
2026-06-10 00:01:45.843022 | testrunner | skipping: Conditional result was False
2026-06-10 00:01:45.844882 | 
2026-06-10 00:01:45.844953 | PLAY RECAP
2026-06-10 00:01:45.845017 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-06-10 00:01:45.845054 | testrunner | ok: 23 changed: 10 unreachable: 0 failed: 0 skipped: 6 rescued: 0 ignored: 0
2026-06-10 00:01:45.845079 | 
2026-06-10 00:01:46.097301 | PRE-RUN END RESULT_NORMAL: [trusted : softwarefactory-project.io/config/playbooks/base/pre.yaml@master]
2026-06-10 00:01:46.099702 | RUN START: [untrusted : softwarefactory-project.io/software-factory/k1s/playbooks/k1s-tox.yaml@master]
2026-06-10 00:01:46.699507 | 
2026-06-10 00:01:46.699649 | PLAY [all]
2026-06-10 00:01:46.710150 | 
2026-06-10 00:01:46.710220 | LOOP [ensure-podman : Find distribution installation]
2026-06-10 00:01:46.737804 | testrunner | ok: "/var/lib/zuul/builds/9e1ad329c85f401b92c9950107c9606d/untrusted/project_3/softwarefactory-project.io/zuul-jobs/roles/ensure-podman/tasks/RedHat.yaml"
2026-06-10 00:01:46.749430 | testrunner | included: /var/lib/zuul/builds/9e1ad329c85f401b92c9950107c9606d/untrusted/project_3/softwarefactory-project.io/zuul-jobs/roles/ensure-podman/tasks/RedHat.yaml
2026-06-10 00:01:46.753732 | 
2026-06-10 00:01:46.753803 | TASK [ensure-podman : Install podman (RedHat)]
2026-06-10 00:02:52.272970 | testrunner | changed
2026-06-10 00:02:52.280163 | 
2026-06-10 00:02:52.280303 | TASK [ensure-podman : Fetch podman version]
2026-06-09 20:02:52.913787 | testrunner | Client:       Podman Engine
2026-06-09 20:02:52.913930 | testrunner | Version:      5.8.2
2026-06-09 20:02:52.913945 | testrunner | API Version:  5.8.2
2026-06-09 20:02:52.913956 | testrunner | Go Version:   go1.26.1 (Red Hat 1.26.1-1.el9)
2026-06-09 20:02:52.913966 | testrunner | Built:        Thu Apr 16 04:05:13 2026
2026-06-09 20:02:52.913975 | testrunner | OS/Arch:      linux/amd64
2026-06-10 00:02:53.313375 | testrunner | ok: Runtime: 0:00:00.302419
2026-06-10 00:02:53.322846 | 
2026-06-10 00:02:53.323030 | TASK [ensure-podman : Print podman version installed]
2026-06-10 00:02:53.364936 | Podman version: Client:       Podman Engine
2026-06-10 00:02:53.365183 | Version:      5.8.2
2026-06-10 00:02:53.365234 | API Version:  5.8.2
2026-06-10 00:02:53.365258 | Go Version:   go1.26.1 (Red Hat 1.26.1-1.el9)
2026-06-10 00:02:53.365276 | Built:        Thu Apr 16 04:05:13 2026
2026-06-10 00:02:53.365293 | OS/Arch:      linux/amd64
2026-06-10 00:02:53.369305 | 
2026-06-10 00:02:53.369435 | TASK [ensure-podman : Validate podman engine]
2026-06-10 00:02:53.895306 | testrunner | skipping: Conditional result was False
2026-06-10 00:02:53.900258 | 
2026-06-10 00:02:53.900373 | TASK [ensure-podman : Set up docker compatability socket]
2026-06-10 00:02:53.925063 | testrunner | skipping: Conditional result was False
2026-06-10 00:02:53.935949 | 
2026-06-10 00:02:53.936071 | TASK [install tox]
2026-06-09 20:02:55.030561 | testrunner | Collecting tox
2026-06-09 20:02:55.052391 | testrunner |   Downloading tox-4.30.3-py3-none-any.whl (175 kB)
2026-06-09 20:02:55.148379 | testrunner | Collecting packaging>=25
2026-06-09 20:02:55.152993 | testrunner |   Downloading packaging-26.2-py3-none-any.whl (100 kB)
2026-06-09 20:02:55.218389 | testrunner | Collecting platformdirs>=4.3.8
2026-06-09 20:02:55.231161 | testrunner |   Downloading platformdirs-4.4.0-py3-none-any.whl (18 kB)
2026-06-09 20:02:55.285340 | testrunner | Collecting pluggy>=1.6
2026-06-09 20:02:55.290224 | testrunner |   Downloading pluggy-1.6.0-py3-none-any.whl (20 kB)
2026-06-09 20:02:55.399434 | testrunner | Collecting tomli>=2.2.1
2026-06-09 20:02:55.404619 | testrunner |   Downloading tomli-2.4.1-py3-none-any.whl (14 kB)
2026-06-09 20:02:55.476891 | testrunner | Collecting filelock>=3.18
2026-06-09 20:02:55.484029 | testrunner |   Downloading filelock-3.19.1-py3-none-any.whl (15 kB)
2026-06-09 20:02:55.554983 | testrunner | Collecting pyproject-api>=1.9.1
2026-06-09 20:02:55.565393 | testrunner |   Downloading pyproject_api-1.9.1-py3-none-any.whl (13 kB)
2026-06-09 20:02:55.707940 | testrunner | Collecting chardet>=5.2
2026-06-09 20:02:55.712097 | testrunner |   Downloading chardet-5.2.0-py3-none-any.whl (199 kB)
2026-06-09 20:02:55.914611 | testrunner | Collecting virtualenv>=20.31.2
2026-06-09 20:02:55.918775 | testrunner |   Downloading virtualenv-21.4.2-py3-none-any.whl (7.6 MB)
2026-06-09 20:02:56.088344 | testrunner | Collecting typing-extensions>=4.14.1
2026-06-09 20:02:56.092870 | testrunner |   Downloading typing_extensions-4.15.0-py3-none-any.whl (44 kB)
2026-06-09 20:02:56.143901 | testrunner | Collecting colorama>=0.4.6
2026-06-09 20:02:56.148174 | testrunner |   Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB)
2026-06-09 20:02:56.210010 | testrunner | Collecting cachetools>=6.1
2026-06-09 20:02:56.217513 | testrunner |   Downloading cachetools-6.2.6-py3-none-any.whl (11 kB)
2026-06-09 20:02:56.312518 | testrunner | Collecting distlib<1,>=0.3.7
2026-06-09 20:02:56.316733 | testrunner |   Downloading distlib-0.4.2-py2.py3-none-any.whl (470 kB)
2026-06-09 20:02:56.371090 | testrunner | Collecting python-discovery>=1.4
2026-06-09 20:02:56.376202 | testrunner |   Downloading python_discovery-1.4.0-py3-none-any.whl (33 kB)
2026-06-09 20:02:56.544620 | testrunner | Installing collected packages: platformdirs, filelock, typing-extensions, tomli, python-discovery, packaging, distlib, virtualenv, pyproject-api, pluggy, colorama, chardet, cachetools, tox
2026-06-09 20:02:56.877872 | testrunner |   WARNING: The script virtualenv is installed in '/usr/local/bin' which is not on PATH.
2026-06-09 20:02:56.877940 | testrunner |   Consider adding this directory to PATH or, if you prefer to suppress this warning, use --no-warn-script-location.
2026-06-09 20:02:57.090146 | testrunner |   WARNING: The script chardetect is installed in '/usr/local/bin' which is not on PATH.
2026-06-09 20:02:57.090217 | testrunner |   Consider adding this directory to PATH or, if you prefer to suppress this warning, use --no-warn-script-location.
2026-06-09 20:02:57.225713 | testrunner |   WARNING: The script tox is installed in '/usr/local/bin' which is not on PATH.
2026-06-09 20:02:57.225772 | testrunner |   Consider adding this directory to PATH or, if you prefer to suppress this warning, use --no-warn-script-location.
2026-06-09 20:02:57.238164 | 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-09 20:02:57.238204 | testrunner | requests 2.25.1 requires chardet<5,>=3.0.2, but you have chardet 5.2.0 which is incompatible.
2026-06-09 20:02:57.238219 | 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-09 20:02:57.238226 | 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-10 00:02:57.973305 | testrunner | ok: Runtime: 0:00:03.289999
2026-06-10 00:02:57.977677 | 
2026-06-10 00:02:57.977761 | TASK [Install kubectl]
2026-06-10 00:03:15.398840 | testrunner | changed: OK (49258496 bytes)
2026-06-10 00:03:15.407624 | 
2026-06-10 00:03:15.407808 | TASK [run tox pep8]
2026-06-09 20:03:16.398194 | testrunner | pep8: install_deps> python -I -m pip install ansible flake8 mypy openshift==0.13.2 pytest -r requirements.txt
2026-06-09 20:03:52.930719 | testrunner | .pkg: install_requires> python -I -m pip install 'setuptools>=40.8.0'
2026-06-09 20:03:53.636370 | testrunner | .pkg: _optional_hooks> python /usr/local/lib/python3.9/site-packages/pyproject_api/_backend.py True setuptools.build_meta __legacy__
2026-06-09 20:03:53.946707 | 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-09 20:03:54.148956 | 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-09 20:03:54.337609 | 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-09 20:03:54.554389 | testrunner | .pkg: build_sdist> python /usr/local/lib/python3.9/site-packages/pyproject_api/_backend.py True setuptools.build_meta __legacy__
2026-06-09 20:03:54.762036 | testrunner | pep8: install_package_deps> python -I -m pip install cherrypy routes
2026-06-09 20:03:55.519380 | 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-09 20:03:57.654835 | testrunner | pep8: commands[0]> mypy --ignore-missing-imports k1s/api.py
2026-06-09 20:03:59.126380 | testrunner | Success: no issues found in 1 source file
2026-06-09 20:03:59.132914 | testrunner | pep8: commands[1]> flake8 k1s
2026-06-09 20:03:59.417608 | testrunner |   pep8: OK (43.48=setup[41.73]+cmd[1.48,0.28] seconds)
2026-06-09 20:03:59.417678 | testrunner |   congratulations :) (43.52 seconds)
2026-06-10 00:03:59.520914 | testrunner | ok: Runtime: 0:00:43.795560
2026-06-10 00:03:59.527266 | 
2026-06-10 00:03:59.527431 | TASK [run tox py39]
2026-06-09 20:04:00.287125 | testrunner | py39: install_deps> python -I -m pip install ansible flake8 mypy openshift==0.13.2 pytest -r requirements.txt
2026-06-09 20:04:35.829873 | testrunner | .pkg: _optional_hooks> python /usr/local/lib/python3.9/site-packages/pyproject_api/_backend.py True setuptools.build_meta __legacy__
2026-06-09 20:04:36.042076 | 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-09 20:04:36.327994 | 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-09 20:04:36.575278 | 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-09 20:04:36.828012 | testrunner | .pkg: build_sdist> python /usr/local/lib/python3.9/site-packages/pyproject_api/_backend.py True setuptools.build_meta __legacy__
2026-06-09 20:04:37.138491 | testrunner | py39: install_package_deps> python -I -m pip install cherrypy routes
2026-06-09 20:04:37.751266 | 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-09 20:04:39.999062 | testrunner | py39: commands[0]> pytest -v tests.py
2026-06-09 20:04:40.215037 | testrunner | ============================= test session starts ==============================
2026-06-09 20:04:40.215084 | 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-09 20:04:40.215090 | testrunner | cachedir: .tox/py39/.pytest_cache
2026-06-09 20:04:40.215095 | testrunner | rootdir: /home/zuul-worker/src/softwarefactory-project.io/software-factory/k1s
2026-06-09 20:04:40.678544 | testrunner | collecting ... collected 5 items
2026-06-09 20:04:40.678588 | testrunner |
2026-06-09 20:06:09.067917 | testrunner | tests.py::K1sTestCase::test_ansible PASSED                               [ 20%]
2026-06-09 20:06:09.350183 | testrunner | tests.py::K1sTestCase::test_bad_token PASSED                             [ 40%]
2026-06-09 20:06:12.096253 | testrunner | tests.py::K1sTestCase::test_create PASSED                                [ 60%]
2026-06-09 20:06:18.289860 | testrunner | tests.py::K1sTestCase::test_kubectl PASSED                               [ 80%]
2026-06-09 20:06:22.409185 | testrunner | tests.py::K1sTestCase::test_python_client PASSED                         [100%]
2026-06-09 20:06:22.409233 | testrunner |
2026-06-09 20:06:22.409241 | testrunner | =============================== warnings summary ===============================
2026-06-09 20:06:22.409247 | testrunner | tests.py::K1sTestCase::test_bad_token
2026-06-09 20:06:22.409254 | testrunner | tests.py::K1sTestCase::test_create
2026-06-09 20:06:22.409260 | testrunner | tests.py::K1sTestCase::test_create
2026-06-09 20:06:22.409265 | testrunner | tests.py::K1sTestCase::test_create
2026-06-09 20:06:22.409271 | testrunner | tests.py::K1sTestCase::test_create
2026-06-09 20:06:22.409276 | testrunner | tests.py::K1sTestCase::test_python_client
2026-06-09 20:06:22.409283 | 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-09 20:06:22.409289 | testrunner |     warnings.warn(
2026-06-09 20:06:22.409295 | testrunner |
2026-06-09 20:06:22.409300 | testrunner | -- Docs: https://docs.pytest.org/en/stable/how-to/capture-warnings.html
2026-06-09 20:06:22.409306 | testrunner | ================== 5 passed, 6 warnings in 102.06s (0:01:42) ===================
2026-06-09 20:06:22.501854 | testrunner |   py39: OK (142.44=setup[39.94]+cmd[102.50] seconds)
2026-06-09 20:06:22.501920 | testrunner |   congratulations :) (142.47 seconds)
2026-06-10 00:06:22.787723 | testrunner | ok: Runtime: 0:02:22.724949
2026-06-10 00:06:22.789281 | 
2026-06-10 00:06:22.789423 | PLAY RECAP
2026-06-10 00:06:22.789467 | testrunner | ok: 8 changed: 6 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0
2026-06-10 00:06:22.789488 | 
2026-06-10 00:06:22.969230 | RUN END RESULT_NORMAL: [untrusted : softwarefactory-project.io/software-factory/k1s/playbooks/k1s-tox.yaml@master]
2026-06-10 00:06:22.970516 | POST-RUN START: [trusted : softwarefactory-project.io/config/playbooks/base/post.yaml@master]
2026-06-10 00:06:23.769155 | 
2026-06-10 00:06:23.769327 | PLAY [all]
2026-06-10 00:06:23.782524 | 
2026-06-10 00:06:23.782651 | TASK [include_role : fetch-output]
2026-06-10 00:06:23.825347 | testrunner | ok
2026-06-10 00:06:23.843644 | 
2026-06-10 00:06:23.843800 | TASK [fetch-output : Set log path for multiple nodes]
2026-06-10 00:06:23.889835 | testrunner | skipping: Conditional result was False
2026-06-10 00:06:23.895167 | 
2026-06-10 00:06:23.895267 | TASK [fetch-output : Set log path for single node]
2026-06-10 00:06:23.933862 | testrunner | ok
2026-06-10 00:06:23.938235 | 
2026-06-10 00:06:23.938335 | LOOP [fetch-output : Ensure local output dirs]
2026-06-10 00:06:24.364699 | testrunner -> localhost | changed: "/var/lib/zuul/builds/9e1ad329c85f401b92c9950107c9606d/work/logs"
2026-06-10 00:06:24.617977 | testrunner -> localhost | changed: "/var/lib/zuul/builds/9e1ad329c85f401b92c9950107c9606d/work/artifacts"
2026-06-10 00:06:24.880210 | testrunner -> localhost | changed: "/var/lib/zuul/builds/9e1ad329c85f401b92c9950107c9606d/work/docs"
2026-06-10 00:06:24.896427 | 
2026-06-10 00:06:24.896567 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-06-10 00:06:25.628070 | testrunner | ok
2026-06-10 00:06:25.628352 | testrunner | changed: All items complete
2026-06-10 00:06:25.628391 | 
2026-06-10 00:06:26.124311 | testrunner | changed: .d..t...... ./
2026-06-10 00:06:26.590263 | testrunner | changed: .d..t...... ./
2026-06-10 00:06:26.610074 | 
2026-06-10 00:06:26.610338 | TASK [include_role : fetch-output-openshift]
2026-06-10 00:06:26.635148 | testrunner | skipping: Conditional result was False
2026-06-10 00:06:26.640852 | 
2026-06-10 00:06:26.640973 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-06-10 00:06:26.669647 | testrunner | skipping: Conditional result was False
2026-06-10 00:06:26.678706 | testrunner | skipping: Conditional result was False
2026-06-10 00:06:26.697380 | 
2026-06-10 00:06:26.697604 | TASK [include_role : rhel-registration]
2026-06-10 00:06:26.718661 | testrunner | skipping: Conditional result was False
2026-06-10 00:06:26.724212 | 
2026-06-10 00:06:26.724707 | PLAY [localhost]
2026-06-10 00:06:26.738249 | 
2026-06-10 00:06:26.738457 | TASK [add-fileserver : Create SSH private key tempfile]
2026-06-10 00:06:27.173642 | localhost | changed
2026-06-10 00:06:27.178048 | 
2026-06-10 00:06:27.178160 | TASK [add-fileserver : Create SSH private key from secret]
2026-06-10 00:06:27.996914 | localhost | changed
2026-06-10 00:06:28.001334 | 
2026-06-10 00:06:28.001439 | TASK [add-fileserver : Add fileserver ssh key]
2026-06-10 00:06:28.479843 | localhost | Identity added: /var/lib/zuul/builds/9e1ad329c85f401b92c9950107c9606d/work/tmp/ansible.ci4uzvcr (/var/lib/zuul/builds/9e1ad329c85f401b92c9950107c9606d/work/tmp/ansible.ci4uzvcr)
2026-06-10 00:06:28.480097 | localhost | ok: Runtime: 0:00:00.017438
2026-06-10 00:06:28.486563 | 
2026-06-10 00:06:28.486706 | TASK [add-fileserver : Remove SSH private key from disk]
2026-06-10 00:06:28.879437 | localhost | ok: Runtime: 0:00:00.006310
2026-06-10 00:06:28.883724 | 
2026-06-10 00:06:28.883821 | TASK [add-fileserver : Add fileserver to inventory]
2026-06-10 00:06:28.964475 | localhost | changed
2026-06-10 00:06:28.969568 | 
2026-06-10 00:06:28.969670 | TASK [add-fileserver : Add fileserver server to known hosts]
2026-06-10 00:06:29.375171 | localhost | changed
2026-06-10 00:06:29.384424 | 
2026-06-10 00:06:29.384555 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-06-10 00:06:29.773295 | localhost | changed
2026-06-10 00:06:29.798716 | 
2026-06-10 00:06:29.798979 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-06-10 00:06:29.831184 | localhost | ok
2026-06-10 00:06:29.838707 | 
2026-06-10 00:06:29.838887 | TASK [include_role : report-logjuicer]
2026-06-10 00:06:29.884770 | localhost | skipping: Conditional result was False
2026-06-10 00:06:29.888618 | 
2026-06-10 00:06:29.888769 | PLAY [a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com]
2026-06-10 00:06:29.893696 | 
2026-06-10 00:06:29.893854 | TASK [Set zuul-log-path fact]
2026-06-10 00:06:29.910410 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | ok
2026-06-10 00:06:29.920522 | 
2026-06-10 00:06:29.920719 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-06-10 00:06:29.949157 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | ok
2026-06-10 00:06:29.952076 | 
2026-06-10 00:06:29.952148 | TASK [upload-logs : Create log directories]
2026-06-10 00:06:30.772542 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | changed
2026-06-10 00:06:30.774852 | 
2026-06-10 00:06:30.774933 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-06-10 00:06:31.065201 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com -> localhost | ok: Runtime: 0:00:00.006033
2026-06-10 00:06:31.067452 | 
2026-06-10 00:06:31.067534 | TASK [upload-logs : Upload logs to log server]
2026-06-10 00:06:32.188204 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | changed:
2026-06-10 00:06:32.188406 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | .d..tp..... ./
2026-06-10 00:06:32.188433 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | <f+++++++++ workspace-repos.json
2026-06-10 00:06:32.188454 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | <f+++++++++ zuul-manifest.json
2026-06-10 00:06:32.188473 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | cd+++++++++ zuul-info/
2026-06-10 00:06:32.188491 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | <f+++++++++ zuul-info/host-info.testrunner.yaml
2026-06-10 00:06:32.188510 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | <f+++++++++ zuul-info/inventory.yaml
2026-06-10 00:06:32.188528 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | <f+++++++++ zuul-info/zuul-info.testrunner.txt
2026-06-10 00:06:32.190954 | 
2026-06-10 00:06:32.191021 | LOOP [upload-logs : Compress console log and json output]
