2026-03-02 00:29:06.833126 | Job console starting...
2026-03-02 00:29:06.845248 | Updating repositories
2026-03-02 00:29:07.000658 | Preparing job workspace
2026-03-02 00:29:10.841323 | Running Ansible setup...
2026-03-02 00:29:15.729124 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master]
2026-03-02 00:29:16.327669 | 
2026-03-02 00:29:16.327788 | PLAY [localhost]
2026-03-02 00:29:16.336106 | 
2026-03-02 00:29:16.336180 | TASK [Gathering Facts]
2026-03-02 00:29:17.442880 | localhost | ok
2026-03-02 00:29:17.470885 | 
2026-03-02 00:29:17.471004 | TASK [Setup log path fact]
2026-03-02 00:29:17.492868 | localhost | ok
2026-03-02 00:29:17.512423 | 
2026-03-02 00:29:17.512547 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-03-02 00:29:17.554555 | localhost | ok
2026-03-02 00:29:17.565526 | 
2026-03-02 00:29:17.565644 | TASK [emit-job-header : Print job information]
2026-03-02 00:29:17.608951 | # Job Information
2026-03-02 00:29:17.609186 | Ansible Version: 2.15.12
2026-03-02 00:29:17.609232 | Job: ansible-test-sanity-docker-devel
2026-03-02 00:29:17.609262 | Pipeline: periodic
2026-03-02 00:29:17.609289 | Executor: ze01.softwarefactory-project.io
2026-03-02 00:29:17.609316 | Triggered by: https://github.com/ansible-collections/ansible.network
2026-03-02 00:29:17.609345 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/301/ansible/30143b24db9d4a5195b3db6ccb24425f/
2026-03-02 00:29:17.609372 | Event ID: 2eb49f0a79aa4455b1e117a286c05c7e
2026-03-02 00:29:17.614618 | 
2026-03-02 00:29:17.614708 | LOOP [emit-job-header : Print node information]
2026-03-02 00:29:17.728483 | localhost | ok:
2026-03-02 00:29:17.728679 | localhost | # Node Information
2026-03-02 00:29:17.728706 | localhost | Inventory Hostname: controller
2026-03-02 00:29:17.728726 | localhost | Hostname: np0005634905
2026-03-02 00:29:17.728745 | localhost | Username: zuul
2026-03-02 00:29:17.728769 | localhost | Distro: Fedora 37
2026-03-02 00:29:17.728787 | localhost | Provider: ansible-vexxhost-ca-ymq-1
2026-03-02 00:29:17.728804 | localhost | Region: ca-ymq-1
2026-03-02 00:29:17.728821 | localhost | Label: ansible-fedora-37-1vcpu
2026-03-02 00:29:17.728839 | localhost | Product Name: OpenStack Nova
2026-03-02 00:29:17.728856 | localhost | Interface IP: 162.253.55.70
2026-03-02 00:29:17.743771 | 
2026-03-02 00:29:17.743933 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-03-02 00:29:18.188854 | localhost -> localhost | changed
2026-03-02 00:29:18.194570 | 
2026-03-02 00:29:18.194642 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-03-02 00:29:19.146190 | localhost -> localhost | changed
2026-03-02 00:29:19.167689 | 
2026-03-02 00:29:19.167767 | PLAY [all:!appliance*]
2026-03-02 00:29:19.184644 | 
2026-03-02 00:29:19.184726 | TASK [include_role : start-zuul-console]
2026-03-02 00:29:19.205351 | controller | ok
2026-03-02 00:29:19.219707 | 
2026-03-02 00:29:19.219795 | TASK [start-zuul-console : Start zuul_console daemon.]
2026-03-02 00:29:19.594623 | controller | ok
2026-03-02 00:29:19.621680 | 
2026-03-02 00:29:19.621981 | TASK [use-our-mirror : Retrieve the IP address]
2026-03-02 00:29:20.598296 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found
2026-03-02 00:29:20.609897 | 
2026-03-02 00:29:20.610119 | TASK [use-our-mirror : Ensure the registry service is running on the mirror]
2026-03-02 00:29:21.164706 | controller | skipping: Conditional result was False
2026-03-02 00:29:21.174616 | 
2026-03-02 00:29:21.174760 | TASK [use-our-mirror : Write the IP in /etc/hosts]
2026-03-02 00:29:21.201339 | controller | skipping: Conditional result was False
2026-03-02 00:29:21.212233 | 
2026-03-02 00:29:21.212355 | TASK [use-our-mirror : Create the podman configuration directory]
2026-03-02 00:29:21.240936 | controller | skipping: Conditional result was False
2026-03-02 00:29:21.250102 | 
2026-03-02 00:29:21.250211 | TASK [use-our-mirror : Copy the podman configuration]
2026-03-02 00:29:21.275005 | controller | skipping: Conditional result was False
2026-03-02 00:29:21.284209 | 
2026-03-02 00:29:21.286110 | TASK [use-our-mirror : Copy the Yum configuration (main)]
2026-03-02 00:29:21.302176 | controller | skipping: Conditional result was False
2026-03-02 00:29:21.312678 | 
2026-03-02 00:29:21.312821 | TASK [use-our-mirror : Copy the Yum configuration (update)]
2026-03-02 00:29:21.337959 | controller | skipping: Conditional result was False
2026-03-02 00:29:21.356975 | 
2026-03-02 00:29:21.357101 | TASK [Disable Fedora Modular]
2026-03-02 00:29:21.638775 | controller | changed
2026-03-02 00:29:21.652226 | 
2026-03-02 00:29:21.652400 | TASK [Enable EPEL]
2026-03-02 00:29:21.668081 | controller | skipping: Conditional result was False
2026-03-02 00:29:21.677110 | 
2026-03-02 00:29:21.677223 | TASK [Register the RHEL node]
2026-03-02 00:29:22.235586 | 
2026-03-02 00:29:22.235840 | TASK [Show the subscription-manager status]
2026-03-02 00:29:22.816850 | controller | skipping: Conditional result was False
2026-03-02 00:29:22.825912 | 
2026-03-02 00:29:22.826042 | TASK [Enable EPEL on RHEL]
2026-03-02 00:29:23.370091 | controller | skipping: Conditional result was False
2026-03-02 00:29:23.379227 | 
2026-03-02 00:29:23.379339 | TASK [Install git and tox]
2026-03-02 00:30:52.336416 | controller | changed
2026-03-02 00:30:52.351253 | 
2026-03-02 00:30:52.351389 | TASK [include_role : prepare-workspace]
2026-03-02 00:30:52.383312 | controller | ok
2026-03-02 00:30:52.419667 | 
2026-03-02 00:30:52.419814 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-03-02 00:30:52.650780 | controller | ok
2026-03-02 00:30:52.665581 | 
2026-03-02 00:30:52.666405 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-03-02 00:36:41.900738 | controller | Output suppressed because no_log was given
2026-03-02 00:36:41.952145 | 
2026-03-02 00:36:41.952286 | TASK [include_role : prepare-workspace-openshift]
2026-03-02 00:36:41.977881 | controller | skipping: Conditional result was False
2026-03-02 00:36:42.008582 | 
2026-03-02 00:36:42.008666 | PLAY [all:!appliance]
2026-03-02 00:36:42.030404 | 
2026-03-02 00:36:42.030482 | TASK [Run add-build-sshkey role (RSA)]
2026-03-02 00:36:42.051756 | controller | ok
2026-03-02 00:36:42.066304 | 
2026-03-02 00:36:42.066372 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-03-02 00:36:42.323832 | controller -> localhost | ok
2026-03-02 00:36:42.330503 | 
2026-03-02 00:36:42.330566 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-03-02 00:36:42.361734 | controller | ok
2026-03-02 00:36:42.376960 | controller | included: /var/lib/zuul/builds/30143b24db9d4a5195b3db6ccb24425f/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-03-02 00:36:42.383379 | 
2026-03-02 00:36:42.383444 | TASK [add-build-sshkey : Create Temp SSH key]
2026-03-02 00:36:42.824248 | controller -> localhost | Generating public/private rsa key pair.
2026-03-02 00:36:42.824467 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/30143b24db9d4a5195b3db6ccb24425f/work/30143b24db9d4a5195b3db6ccb24425f_id_rsa.
2026-03-02 00:36:42.824496 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/30143b24db9d4a5195b3db6ccb24425f/work/30143b24db9d4a5195b3db6ccb24425f_id_rsa.pub.
2026-03-02 00:36:42.824516 | controller -> localhost | The key fingerprint is:
2026-03-02 00:36:42.824536 | controller -> localhost | SHA256:d0zddDcH1wv0YASd9RqaOkrGvJvi9+t63MT2VeCLSic zuul-build-sshkey
2026-03-02 00:36:42.824555 | controller -> localhost | The key's randomart image is:
2026-03-02 00:36:42.824573 | controller -> localhost | +---[RSA 2048]----+
2026-03-02 00:36:42.824591 | controller -> localhost | |           .==++B|
2026-03-02 00:36:42.824619 | controller -> localhost | |            .=++B|
2026-03-02 00:36:42.824638 | controller -> localhost | |            ..+o+|
2026-03-02 00:36:42.824656 | controller -> localhost | |           o o.+.|
2026-03-02 00:36:42.824674 | controller -> localhost | |        S ..=....|
2026-03-02 00:36:42.824701 | controller -> localhost | |       o .Eo* . .|
2026-03-02 00:36:42.824726 | controller -> localhost | |        =ooB . . |
2026-03-02 00:36:42.824747 | controller -> localhost | |      .o.++.. .  |
2026-03-02 00:36:42.824766 | controller -> localhost | |     ..o**+.     |
2026-03-02 00:36:42.824787 | controller -> localhost | +----[SHA256]-----+
2026-03-02 00:36:42.824842 | controller -> localhost | ok: Runtime: 0:00:00.111354
2026-03-02 00:36:42.831438 | 
2026-03-02 00:36:42.831499 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-03-02 00:36:42.851055 | controller | ok
2026-03-02 00:36:42.861841 | controller | included: /var/lib/zuul/builds/30143b24db9d4a5195b3db6ccb24425f/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-03-02 00:36:42.870221 | 
2026-03-02 00:36:42.870280 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-03-02 00:36:42.884489 | controller | skipping: Conditional result was False
2026-03-02 00:36:42.890815 | 
2026-03-02 00:36:42.890881 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-03-02 00:36:43.492526 | controller | changed
2026-03-02 00:36:43.501951 | 
2026-03-02 00:36:43.502106 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-03-02 00:36:43.732154 | controller | ok
2026-03-02 00:36:43.744515 | 
2026-03-02 00:36:43.744647 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-03-02 00:36:44.352981 | controller | changed
2026-03-02 00:36:44.358706 | 
2026-03-02 00:36:44.358769 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-03-02 00:36:44.966781 | controller | changed
2026-03-02 00:36:44.980225 | 
2026-03-02 00:36:44.980314 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-03-02 00:36:45.029005 | controller | skipping: Conditional result was False
2026-03-02 00:36:45.037931 | 
2026-03-02 00:36:45.038083 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-03-02 00:36:45.545187 | controller -> localhost | changed
2026-03-02 00:36:45.557437 | 
2026-03-02 00:36:45.557511 | TASK [add-build-sshkey : Add back temp key]
2026-03-02 00:36:45.845794 | controller -> localhost | Identity added: /var/lib/zuul/builds/30143b24db9d4a5195b3db6ccb24425f/work/30143b24db9d4a5195b3db6ccb24425f_id_rsa (zuul-build-sshkey)
2026-03-02 00:36:45.846101 | controller -> localhost | ok: Runtime: 0:00:00.007303
2026-03-02 00:36:45.853597 | 
2026-03-02 00:36:45.853672 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-03-02 00:36:46.213968 | controller | ok
2026-03-02 00:36:46.230719 | 
2026-03-02 00:36:46.230832 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-03-02 00:36:46.258616 | controller | skipping: Conditional result was False
2026-03-02 00:36:46.287864 | 
2026-03-02 00:36:46.288130 | TASK [Run add-build-sshkey role (ECDSA)]
2026-03-02 00:36:46.316252 | controller | ok
2026-03-02 00:36:46.343416 | 
2026-03-02 00:36:46.343633 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-03-02 00:36:46.608657 | controller -> localhost | ok
2026-03-02 00:36:46.615121 | 
2026-03-02 00:36:46.615205 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-03-02 00:36:46.634499 | controller | ok
2026-03-02 00:36:46.645537 | controller | included: /var/lib/zuul/builds/30143b24db9d4a5195b3db6ccb24425f/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-03-02 00:36:46.652219 | 
2026-03-02 00:36:46.652304 | TASK [add-build-sshkey : Create Temp SSH key]
2026-03-02 00:36:46.921760 | controller -> localhost | Generating public/private ecdsa key pair.
2026-03-02 00:36:46.921968 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/30143b24db9d4a5195b3db6ccb24425f/work/30143b24db9d4a5195b3db6ccb24425f_id_ecdsa.
2026-03-02 00:36:46.921996 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/30143b24db9d4a5195b3db6ccb24425f/work/30143b24db9d4a5195b3db6ccb24425f_id_ecdsa.pub.
2026-03-02 00:36:46.922039 | controller -> localhost | The key fingerprint is:
2026-03-02 00:36:46.922064 | controller -> localhost | SHA256:QqSBxz1dfsrrJz4O8lGU4yTomXYo9H4myx3t3/XOlDk zuul-build-sshkey
2026-03-02 00:36:46.922083 | controller -> localhost | The key's randomart image is:
2026-03-02 00:36:46.922101 | controller -> localhost | +---[ECDSA 521]---+
2026-03-02 00:36:46.922119 | controller -> localhost | |   o.... ..      |
2026-03-02 00:36:46.922137 | controller -> localhost | |  . o+o... .     |
2026-03-02 00:36:46.922153 | controller -> localhost | |   .o o.. * .    |
2026-03-02 00:36:46.922170 | controller -> localhost | |   . + + * +     |
2026-03-02 00:36:46.922187 | controller -> localhost | |    . O S =      |
2026-03-02 00:36:46.922204 | controller -> localhost | |     + o o .    o|
2026-03-02 00:36:46.922221 | controller -> localhost | |      + * o    Eo|
2026-03-02 00:36:46.922238 | controller -> localhost | |     . O *o .. +o|
2026-03-02 00:36:46.922255 | controller -> localhost | |      o oo==. ..+|
2026-03-02 00:36:46.922271 | controller -> localhost | +----[SHA256]-----+
2026-03-02 00:36:46.922320 | controller -> localhost | ok: Runtime: 0:00:00.010966
2026-03-02 00:36:46.928917 | 
2026-03-02 00:36:46.928981 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-03-02 00:36:46.958232 | controller | ok
2026-03-02 00:36:46.965375 | controller | included: /var/lib/zuul/builds/30143b24db9d4a5195b3db6ccb24425f/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-03-02 00:36:46.973808 | 
2026-03-02 00:36:46.973871 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-03-02 00:36:46.997603 | controller | skipping: Conditional result was False
2026-03-02 00:36:47.004263 | 
2026-03-02 00:36:47.004329 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-03-02 00:36:47.299910 | controller | changed
2026-03-02 00:36:47.305565 | 
2026-03-02 00:36:47.305634 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-03-02 00:36:47.583785 | controller | ok
2026-03-02 00:36:47.596565 | 
2026-03-02 00:36:47.596697 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-03-02 00:36:48.311519 | controller | changed
2026-03-02 00:36:48.325097 | 
2026-03-02 00:36:48.325266 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-03-02 00:36:49.038503 | controller | changed
2026-03-02 00:36:49.050973 | 
2026-03-02 00:36:49.051128 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-03-02 00:36:49.068157 | controller | skipping: Conditional result was False
2026-03-02 00:36:49.083206 | 
2026-03-02 00:36:49.083368 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-03-02 00:36:49.323707 | controller -> localhost | changed
2026-03-02 00:36:49.384042 | 
2026-03-02 00:36:49.384177 | TASK [add-build-sshkey : Add back temp key]
2026-03-02 00:36:49.663280 | controller -> localhost | Identity added: /var/lib/zuul/builds/30143b24db9d4a5195b3db6ccb24425f/work/30143b24db9d4a5195b3db6ccb24425f_id_ecdsa (zuul-build-sshkey)
2026-03-02 00:36:49.663528 | controller -> localhost | ok: Runtime: 0:00:00.006917
2026-03-02 00:36:49.669886 | 
2026-03-02 00:36:49.669950 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-03-02 00:36:49.879664 | controller | ok
2026-03-02 00:36:49.891561 | 
2026-03-02 00:36:49.891691 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-03-02 00:36:49.918292 | controller | skipping: Conditional result was False
2026-03-02 00:36:49.943523 | 
2026-03-02 00:36:49.943654 | TASK [include_role : remove-zuul-sshkey]
2026-03-02 00:36:49.969803 | controller | skipping: Conditional result was False
2026-03-02 00:36:49.982875 | 
2026-03-02 00:36:49.983040 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-03-02 00:36:50.222996 | controller | ok: "logs"
2026-03-02 00:36:50.223614 | controller | ok: All items complete
2026-03-02 00:36:50.223685 | 
2026-03-02 00:36:50.423445 | controller | ok: "artifacts"
2026-03-02 00:36:50.617281 | controller | ok: "docs"
2026-03-02 00:36:50.627556 | 
2026-03-02 00:36:50.627687 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-03-02 00:36:50.876439 | controller | changed: "logs"
2026-03-02 00:36:51.085634 | controller | changed: "artifacts"
2026-03-02 00:36:51.309230 | controller | changed: "docs"
2026-03-02 00:36:51.349899 | 
2026-03-02 00:36:51.350098 | PLAY RECAP
2026-03-02 00:36:51.350153 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0
2026-03-02 00:36:51.350182 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-03-02 00:36:51.350201 | 
2026-03-02 00:36:51.463636 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master]
2026-03-02 00:36:51.465415 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master]
2026-03-02 00:36:52.060948 | 
2026-03-02 00:36:52.061075 | PLAY [all]
2026-03-02 00:36:52.082799 | 
2026-03-02 00:36:52.082896 | TASK [Install binary dependencies]
2026-03-02 00:36:52.135208 | controller | ok
2026-03-02 00:36:52.154528 | 
2026-03-02 00:36:52.154612 | TASK [bindep : Include find tasks]
2026-03-02 00:36:52.204851 | controller | ok
2026-03-02 00:36:52.212766 | controller | included: /var/lib/zuul/builds/30143b24db9d4a5195b3db6ccb24425f/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml
2026-03-02 00:36:52.218859 | 
2026-03-02 00:36:52.218921 | TASK [bindep : Look for bindep.txt]
2026-03-02 00:36:52.777311 | controller | ok
2026-03-02 00:36:52.791281 | 
2026-03-02 00:36:52.791468 | TASK [bindep : Define bindep_file fact]
2026-03-02 00:36:52.809470 | controller | skipping: Conditional result was False
2026-03-02 00:36:52.822828 | 
2026-03-02 00:36:52.823003 | TASK [bindep : Look for other-requirements.txt]
2026-03-02 00:36:53.037334 | controller | ok
2026-03-02 00:36:53.044808 | 
2026-03-02 00:36:53.044900 | TASK [bindep : Define bindep_file fact]
2026-03-02 00:36:53.070170 | controller | skipping: Conditional result was False
2026-03-02 00:36:53.079354 | 
2026-03-02 00:36:53.079443 | TASK [bindep : Look for bindep fallback file]
2026-03-02 00:36:53.104873 | controller | skipping: Conditional result was False
2026-03-02 00:36:53.114904 | 
2026-03-02 00:36:53.115036 | TASK [bindep : Define bindep_file fact]
2026-03-02 00:36:53.145145 | controller | skipping: Conditional result was False
2026-03-02 00:36:53.153480 | 
2026-03-02 00:36:53.153596 | TASK [bindep : Include bindep tasks]
2026-03-02 00:36:53.178709 | controller | skipping: Conditional result was False
2026-03-02 00:36:53.186777 | 
2026-03-02 00:36:53.186862 | TASK [bindep : Include install tasks]
2026-03-02 00:36:53.211922 | controller | skipping: Conditional result was False
2026-03-02 00:36:53.220722 | 
2026-03-02 00:36:53.220828 | LOOP [bindep : Include package tasks]
2026-03-02 00:36:53.307787 | 
2026-03-02 00:36:53.307985 | TASK [Run test-setup role]
2026-03-02 00:36:53.331900 | controller | ok
2026-03-02 00:36:53.355473 | 
2026-03-02 00:36:53.355569 | TASK [test-setup : Check if project's tools/test-setup.sh exists]
2026-03-02 00:36:53.570635 | controller | ok
2026-03-02 00:36:53.584373 | 
2026-03-02 00:36:53.584508 | TASK [test-setup : Run tools/test-setup.sh]
2026-03-02 00:36:54.127294 | controller | skipping: Conditional result was False
2026-03-02 00:36:54.153049 | 
2026-03-02 00:36:54.153136 | PLAY RECAP
2026-03-02 00:36:54.153177 | controller | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0
2026-03-02 00:36:54.153196 | 
2026-03-02 00:36:54.255091 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master]
2026-03-02 00:36:54.256063 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master]
2026-03-02 00:36:54.849429 | 
2026-03-02 00:36:54.849550 | PLAY [controller]
2026-03-02 00:36:54.869456 | 
2026-03-02 00:36:54.869536 | TASK [Create the /root directory]
2026-03-02 00:36:55.428106 | controller | ok
2026-03-02 00:36:55.445991 | 
2026-03-02 00:36:55.446257 | TASK [Install glibc-langpack-en]
2026-03-02 00:36:59.425281 | controller | ok: Nothing to do
2026-03-02 00:36:59.437736 | 
2026-03-02 00:36:59.437880 | TASK [Ensure controller directory exists]
2026-03-02 00:36:59.676462 | controller | changed
2026-03-02 00:36:59.688695 | 
2026-03-02 00:36:59.688830 | TASK [Install container runtime]
2026-03-02 00:36:59.766517 | controller | ok
2026-03-02 00:36:59.810287 | 
2026-03-02 00:36:59.810519 | LOOP [ensure-podman : Find distribution installation]
2026-03-02 00:36:59.844260 | controller | ok: "/var/lib/zuul/builds/30143b24db9d4a5195b3db6ccb24425f/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-podman/tasks/RedHat.yaml"
2026-03-02 00:36:59.857927 | controller | included: /var/lib/zuul/builds/30143b24db9d4a5195b3db6ccb24425f/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-podman/tasks/RedHat.yaml
2026-03-02 00:36:59.865598 | 
2026-03-02 00:36:59.865747 | TASK [ensure-podman : Install podman (RedHat)]
2026-03-02 00:38:05.550729 | controller | changed
2026-03-02 00:38:05.563942 | 
2026-03-02 00:38:05.564107 | TASK [ensure-podman : Fetch podman version]
2026-03-02 00:38:06.115491 | controller | Client:       Podman Engine
2026-03-02 00:38:06.146148 | controller | Version:      4.6.2
2026-03-02 00:38:06.146199 | controller | API Version:  4.6.2
2026-03-02 00:38:06.146207 | controller | Go Version:   go1.19.12
2026-03-02 00:38:06.146227 | controller | Built:        Mon Aug 28 19:38:31 2023
2026-03-02 00:38:06.146248 | controller | OS/Arch:      linux/amd64
2026-03-02 00:38:06.614484 | controller | ok: Runtime: 0:00:00.199959
2026-03-02 00:38:06.627655 | 
2026-03-02 00:38:06.627796 | TASK [ensure-podman : Print podman version installed]
2026-03-02 00:38:06.666052 | Podman version: Client:       Podman Engine
2026-03-02 00:38:06.666318 | Version:      4.6.2
2026-03-02 00:38:06.666379 | API Version:  4.6.2
2026-03-02 00:38:06.666424 | Go Version:   go1.19.12
2026-03-02 00:38:06.666464 | Built:        Mon Aug 28 19:38:31 2023
2026-03-02 00:38:06.666505 | OS/Arch:      linux/amd64
2026-03-02 00:38:06.678503 | 
2026-03-02 00:38:06.678664 | TASK [ensure-podman : Validate podman engine]
2026-03-02 00:38:07.223510 | controller | skipping: Conditional result was False
2026-03-02 00:38:07.232258 | 
2026-03-02 00:38:07.232356 | TASK [ensure-podman : Set up docker compatability socket]
2026-03-02 00:38:07.256852 | controller | skipping: Conditional result was False
2026-03-02 00:38:07.270974 | 
2026-03-02 00:38:07.271089 | TASK [Ensure python3.8 is present]
2026-03-02 00:38:07.295624 | controller | skipping: Conditional result was False
2026-03-02 00:38:07.304556 | 
2026-03-02 00:38:07.304641 | TASK [Run our-ensure-python role (Fedora only for now)]
2026-03-02 00:38:07.326590 | controller | ok
2026-03-02 00:38:07.352792 | 
2026-03-02 00:38:07.352887 | TASK [our-ensure-python : Install the right Python version (rpm)]
2026-03-02 00:38:08.762289 | controller | ok: Nothing to do
2026-03-02 00:38:08.774459 | 
2026-03-02 00:38:08.774652 | TASK [our-ensure-python : Also install python3-devel]
2026-03-02 00:42:40.770223 | controller | ERROR
2026-03-02 00:42:40.770624 | controller | {
2026-03-02 00:42:40.770690 | controller |   "msg": "Data could not be sent to remote host \"162.253.55.70\". Make sure this host can be reached over ssh: ssh: connect to host 162.253.55.70 port 22: No route to host\r\n",
2026-03-02 00:42:40.770755 | controller |   "unreachable": true
2026-03-02 00:42:40.770802 | controller | }
unreachable
2026-03-02 00:42:40.772926 | 
2026-03-02 00:42:40.773067 | PLAY RECAP
2026-03-02 00:42:40.773157 | controller | ok: 8 changed: 3 unreachable: 1 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-03-02 00:42:40.773203 | 
2026-03-02 00:42:40.889902 | PRE-RUN END RESULT_UNREACHABLE: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master]
2026-03-02 00:42:40.890997 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master]
2026-03-02 00:42:41.416525 | 
2026-03-02 00:42:41.416643 | PLAY [all]
2026-03-02 00:42:41.437761 | 
2026-03-02 00:42:41.437878 | TASK [fetch-subunit-output : Find stestr or testr executable]
2026-03-02 00:43:13.095412 | controller | changed: non-zero return code
2026-03-02 00:43:13.108605 | 
2026-03-02 00:43:13.108768 | TASK [fetch-subunit-output : Get the list of directories with subunit files]
2026-03-02 00:43:13.137355 | controller | skipping: Conditional result was False
2026-03-02 00:43:13.151085 | 
2026-03-02 00:43:13.151361 | LOOP [fetch-subunit-output : Find any inflight partial subunit files]
2026-03-02 00:43:13.193155 | 
2026-03-02 00:43:13.193401 | LOOP [fetch-subunit-output : Copy any inflight subunit files]
2026-03-02 00:43:13.235280 | 
2026-03-02 00:43:13.235537 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream]
2026-03-02 00:43:13.262962 | controller | skipping: Conditional result was False
2026-03-02 00:43:13.276145 | 
2026-03-02 00:43:13.276292 | LOOP [fetch-subunit-output : Generate subunit file]
2026-03-02 00:43:13.315850 | 
2026-03-02 00:43:13.316120 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory]
2026-03-02 00:43:13.342899 | controller | skipping: Conditional result was False
2026-03-02 00:43:13.355807 | 
2026-03-02 00:43:13.355952 | TASK [fetch-subunit-output : Remove the temporary file]
2026-03-02 00:43:13.382714 | controller | skipping: Conditional result was False
2026-03-02 00:43:13.395814 | 
2026-03-02 00:43:13.395953 | TASK [fetch-subunit-output : Process and fetch subunit results]
2026-03-02 00:43:13.422767 | controller | skipping: Conditional result was False
2026-03-02 00:43:13.470812 | 
2026-03-02 00:43:13.470894 | PLAY RECAP
2026-03-02 00:43:13.470948 | controller | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0
2026-03-02 00:43:13.470976 | 
2026-03-02 00:43:13.569072 | POST-RUN END RESULT_UNREACHABLE: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master]
2026-03-02 00:43:13.569921 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master]
2026-03-02 00:43:14.131927 | 
2026-03-02 00:43:14.132061 | PLAY [all:!appliance*]
2026-03-02 00:43:14.153648 | 
2026-03-02 00:43:14.153721 | TASK [unregister the node]
2026-03-02 00:43:14.683777 | controller | skipping: Conditional result was False
2026-03-02 00:43:14.695870 | 
2026-03-02 00:43:14.696059 | TASK [include_role : fetch-output]
2026-03-02 00:43:14.745724 | controller | ok
2026-03-02 00:43:14.784819 | 
2026-03-02 00:43:14.784912 | TASK [fetch-output : Set log path for multiple nodes]
2026-03-02 00:43:14.852706 | controller | skipping: Conditional result was False
2026-03-02 00:43:14.862717 | 
2026-03-02 00:43:14.862841 | TASK [fetch-output : Set log path for single node]
2026-03-02 00:43:14.912433 | controller | ok
2026-03-02 00:43:14.924638 | 
2026-03-02 00:43:14.924771 | LOOP [fetch-output : Ensure local output dirs]
2026-03-02 00:43:15.372000 | controller -> localhost | ok: "/var/lib/zuul/builds/30143b24db9d4a5195b3db6ccb24425f/work/logs"
2026-03-02 00:43:15.591998 | controller -> localhost | changed: "/var/lib/zuul/builds/30143b24db9d4a5195b3db6ccb24425f/work/artifacts"
2026-03-02 00:43:15.799595 | controller -> localhost | changed: "/var/lib/zuul/builds/30143b24db9d4a5195b3db6ccb24425f/work/docs"
2026-03-02 00:43:15.821935 | 
2026-03-02 00:43:15.822175 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-03-02 00:43:16.438767 | controller | changed:
2026-03-02 00:43:16.438962 | controller | .d..t...... ./
2026-03-02 00:43:16.438992 | controller | cd+++++++++ controller/
2026-03-02 00:43:16.439060 | controller | changed: All items complete
2026-03-02 00:43:16.439088 | 
2026-03-02 00:43:16.925824 | controller | changed: .d..t...... ./
2026-03-02 00:43:17.508390 | controller | changed: .d..t...... ./
2026-03-02 00:43:17.543745 | 
2026-03-02 00:43:17.543932 | TASK [include_role : fetch-output-openshift]
2026-03-02 00:43:17.577724 | controller | skipping: Conditional result was False
2026-03-02 00:43:17.596616 | 
2026-03-02 00:43:17.596767 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-03-02 00:43:17.651394 | controller | skipping: Conditional result was False
2026-03-02 00:43:17.661314 | controller | skipping: Conditional result was False
2026-03-02 00:43:17.712609 | 
2026-03-02 00:43:17.712737 | PLAY [localhost]
2026-03-02 00:43:17.729113 | 
2026-03-02 00:43:17.729196 | TASK [Run Zuul manifest role]
2026-03-02 00:43:17.749903 | localhost | ok
2026-03-02 00:43:17.769274 | 
2026-03-02 00:43:17.769377 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-03-02 00:43:18.153634 | localhost | changed
2026-03-02 00:43:18.158273 | 
2026-03-02 00:43:18.158331 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-03-02 00:43:18.188305 | localhost | ok
2026-03-02 00:43:18.195833 | 
2026-03-02 00:43:18.195891 | TASK [Set zuul-log-path fact]
2026-03-02 00:43:18.214166 | localhost | ok
2026-03-02 00:43:18.226449 | 
2026-03-02 00:43:18.226509 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-03-02 00:43:18.265181 | localhost | ok
2026-03-02 00:43:18.272529 | 
2026-03-02 00:43:18.272586 | LOOP [Set zuul_log_targets (Swift with random Rackspace region)]
2026-03-02 00:43:18.309838 | localhost | ok:
2026-03-02 00:43:18.310291 | localhost | {
2026-03-02 00:43:18.310349 | localhost |   "auth": {
2026-03-02 00:43:18.310396 | localhost |     "password": "IonWCwcuOFib&&<}wp^:[2G/",
2026-03-02 00:43:18.310433 | localhost |     "username": "9LF91O0RK7JU"
2026-03-02 00:43:18.310469 | localhost |   },
2026-03-02 00:43:18.310504 | localhost |   "profile": "rackspace",
2026-03-02 00:43:18.310539 | localhost |   "region_name": "ORD"
2026-03-02 00:43:18.310574 | localhost | }
2026-03-02 00:43:18.310621 | 
2026-03-02 00:43:18.321210 | 
2026-03-02 00:43:18.321322 | TASK [Run upload-logs-failover role (S3 then Swift)]
2026-03-02 00:43:18.338436 | localhost | Output suppressed because no_log was given
2026-03-02 00:43:18.350191 | 
2026-03-02 00:43:18.350255 | TASK [upload-logs-failover : Initialize control vars]
2026-03-02 00:43:18.377787 | localhost | ok
2026-03-02 00:43:18.381852 | 
2026-03-02 00:43:18.381907 | LOOP [upload-logs-failover : Perform log upload]
2026-03-02 00:43:18.416569 | localhost | Output suppressed because no_log was given
2026-03-02 00:43:18.449637 | localhost | included: /var/lib/zuul/builds/30143b24db9d4a5195b3db6ccb24425f/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/upload-logs-failover/tasks/upload.yaml
2026-03-02 00:43:18.460515 | 
2026-03-02 00:43:18.460662 | LOOP [upload-logs-failover : Unpack vars for swift upload]
2026-03-02 00:43:18.551278 | localhost | Output suppressed because no_log was given
2026-03-02 00:43:18.563401 | 
2026-03-02 00:43:18.563548 | TASK [Upload logs to swift]
2026-03-02 00:43:18.589513 | localhost | ok
2026-03-02 00:43:18.633990 | 
2026-03-02 00:43:18.634097 | TASK [Set zuul-log-path fact]
2026-03-02 00:43:18.659309 | localhost | skipping: Conditional result was False
2026-03-02 00:43:18.665473 | 
2026-03-02 00:43:18.665553 | TASK [upload-logs-swift : Ensure logs are readable before uploading]
2026-03-02 00:43:19.013398 | localhost -> localhost | ok: Runtime: 0:00:00.009338
2026-03-02 00:43:19.022413 | 
2026-03-02 00:43:19.022483 | TASK [upload-logs-swift : Upload logs to swift]