2026-02-26 00:16:42.090611 | Job console starting...
2026-02-26 00:16:42.109834 | Updating repositories
2026-02-26 00:16:42.372705 | Preparing job workspace
2026-02-26 00:16:49.436993 | Running Ansible setup...
2026-02-26 00:16:54.296389 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master]
2026-02-26 00:16:54.989093 | 
2026-02-26 00:16:54.989228 | PLAY [localhost]
2026-02-26 00:16:54.997713 | 
2026-02-26 00:16:54.997803 | TASK [Gathering Facts]
2026-02-26 00:16:56.906306 | localhost | ok
2026-02-26 00:16:56.920877 | 
2026-02-26 00:16:56.921036 | TASK [Setup log path fact]
2026-02-26 00:16:56.940177 | localhost | ok
2026-02-26 00:16:56.955006 | 
2026-02-26 00:16:56.955126 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-02-26 00:16:56.984841 | localhost | ok
2026-02-26 00:16:57.007897 | 
2026-02-26 00:16:57.008048 | TASK [emit-job-header : Print job information]
2026-02-26 00:16:57.037883 | # Job Information
2026-02-26 00:16:57.038318 | Ansible Version: 2.15.12
2026-02-26 00:16:57.038352 | Job: ansible-test-sanity-docker-devel
2026-02-26 00:16:57.038375 | Pipeline: periodic
2026-02-26 00:16:57.038396 | Executor: ze03.softwarefactory-project.io
2026-02-26 00:16:57.038417 | Triggered by: https://github.com/ansible-collections/ansible.network
2026-02-26 00:16:57.038440 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/989/ansible/9894e605f7034b61b12072911427687a/
2026-02-26 00:16:57.038462 | Event ID: 2adb30751d3546bcab5e20cd6f839642
2026-02-26 00:16:57.043493 | 
2026-02-26 00:16:57.043620 | LOOP [emit-job-header : Print node information]
2026-02-26 00:16:57.154410 | localhost | ok:
2026-02-26 00:16:57.154674 | localhost | # Node Information
2026-02-26 00:16:57.154712 | localhost | Inventory Hostname: controller
2026-02-26 00:16:57.154763 | localhost | Hostname: np0005630871
2026-02-26 00:16:57.154791 | localhost | Username: zuul
2026-02-26 00:16:57.154827 | localhost | Distro: Fedora 37
2026-02-26 00:16:57.154853 | localhost | Provider: ansible-vexxhost-ca-ymq-1
2026-02-26 00:16:57.154877 | localhost | Region: ca-ymq-1
2026-02-26 00:16:57.154901 | localhost | Label: ansible-fedora-37-1vcpu
2026-02-26 00:16:57.154926 | localhost | Product Name: OpenStack Nova
2026-02-26 00:16:57.154950 | localhost | Interface IP: 162.253.55.227
2026-02-26 00:16:57.174089 | 
2026-02-26 00:16:57.174232 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-02-26 00:16:57.601064 | localhost -> localhost | changed
2026-02-26 00:16:57.608285 | 
2026-02-26 00:16:57.608405 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-02-26 00:16:58.529252 | localhost -> localhost | changed
2026-02-26 00:16:58.578322 | 
2026-02-26 00:16:58.578435 | PLAY [all:!appliance*]
2026-02-26 00:16:58.604520 | 
2026-02-26 00:16:58.604680 | TASK [include_role : start-zuul-console]
2026-02-26 00:16:58.628889 | controller | ok
2026-02-26 00:16:58.648185 | 
2026-02-26 00:16:58.648303 | TASK [start-zuul-console : Start zuul_console daemon.]
2026-02-26 00:16:59.098247 | controller | ok
2026-02-26 00:16:59.123507 | 
2026-02-26 00:16:59.123684 | TASK [use-our-mirror : Retrieve the IP address]
2026-02-26 00:17:00.020257 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found
2026-02-26 00:17:00.029323 | 
2026-02-26 00:17:00.029433 | TASK [use-our-mirror : Ensure the registry service is running on the mirror]
2026-02-26 00:17:00.573416 | controller | skipping: Conditional result was False
2026-02-26 00:17:00.589590 | 
2026-02-26 00:17:00.589869 | TASK [use-our-mirror : Write the IP in /etc/hosts]
2026-02-26 00:17:00.629474 | controller | skipping: Conditional result was False
2026-02-26 00:17:00.644761 | 
2026-02-26 00:17:00.644918 | TASK [use-our-mirror : Create the podman configuration directory]
2026-02-26 00:17:00.681849 | controller | skipping: Conditional result was False
2026-02-26 00:17:00.696637 | 
2026-02-26 00:17:00.696835 | TASK [use-our-mirror : Copy the podman configuration]
2026-02-26 00:17:00.734152 | controller | skipping: Conditional result was False
2026-02-26 00:17:00.747125 | 
2026-02-26 00:17:00.747273 | TASK [use-our-mirror : Copy the Yum configuration (main)]
2026-02-26 00:17:00.784344 | controller | skipping: Conditional result was False
2026-02-26 00:17:00.801528 | 
2026-02-26 00:17:00.801852 | TASK [use-our-mirror : Copy the Yum configuration (update)]
2026-02-26 00:17:00.852075 | controller | skipping: Conditional result was False
2026-02-26 00:17:00.879810 | 
2026-02-26 00:17:00.880004 | TASK [Disable Fedora Modular]
2026-02-26 00:17:04.744198 | controller | changed
2026-02-26 00:17:04.754518 | 
2026-02-26 00:17:04.754680 | TASK [Enable EPEL]
2026-02-26 00:17:04.783018 | controller | skipping: Conditional result was False
2026-02-26 00:17:04.794795 | 
2026-02-26 00:17:04.794907 | TASK [Register the RHEL node]
2026-02-26 00:17:05.421189 | 
2026-02-26 00:17:05.421473 | TASK [Show the subscription-manager status]
2026-02-26 00:17:05.986473 | controller | skipping: Conditional result was False
2026-02-26 00:17:06.003026 | 
2026-02-26 00:17:06.003220 | TASK [Enable EPEL on RHEL]
2026-02-26 00:17:06.571265 | controller | skipping: Conditional result was False
2026-02-26 00:17:06.580721 | 
2026-02-26 00:17:06.580892 | TASK [Install git and tox]
2026-02-26 00:18:36.138433 | controller | changed
2026-02-26 00:18:36.152961 | 
2026-02-26 00:18:36.153129 | TASK [include_role : prepare-workspace]
2026-02-26 00:18:36.184810 | controller | ok
2026-02-26 00:18:36.206704 | 
2026-02-26 00:18:36.206874 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-02-26 00:18:37.429715 | controller | ok
2026-02-26 00:18:37.445099 | 
2026-02-26 00:18:37.445303 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-02-26 00:24:39.676437 | controller | Output suppressed because no_log was given
2026-02-26 00:24:39.700411 | 
2026-02-26 00:24:39.700624 | TASK [include_role : prepare-workspace-openshift]
2026-02-26 00:24:39.717291 | controller | skipping: Conditional result was False
2026-02-26 00:24:39.754586 | 
2026-02-26 00:24:39.754710 | PLAY [all:!appliance]
2026-02-26 00:24:39.783191 | 
2026-02-26 00:24:39.783311 | TASK [Run add-build-sshkey role (RSA)]
2026-02-26 00:24:39.802624 | controller | ok
2026-02-26 00:24:39.826555 | 
2026-02-26 00:24:39.826676 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-02-26 00:24:40.056444 | controller -> localhost | ok
2026-02-26 00:24:40.063162 | 
2026-02-26 00:24:40.063293 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-02-26 00:24:40.094786 | controller | ok
2026-02-26 00:24:40.112479 | controller | included: /var/lib/zuul/builds/9894e605f7034b61b12072911427687a/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-02-26 00:24:40.119479 | 
2026-02-26 00:24:40.119601 | TASK [add-build-sshkey : Create Temp SSH key]
2026-02-26 00:24:40.694805 | controller -> localhost | Generating public/private rsa key pair.
2026-02-26 00:24:40.695057 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/9894e605f7034b61b12072911427687a/work/9894e605f7034b61b12072911427687a_id_rsa.
2026-02-26 00:24:40.695109 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/9894e605f7034b61b12072911427687a/work/9894e605f7034b61b12072911427687a_id_rsa.pub.
2026-02-26 00:24:40.695144 | controller -> localhost | The key fingerprint is:
2026-02-26 00:24:40.695175 | controller -> localhost | SHA256:qrWTLfkMzCNbIGP/PxvW2I4uojQkC1ciL/HKY2rdYSw zuul-build-sshkey
2026-02-26 00:24:40.695207 | controller -> localhost | The key's randomart image is:
2026-02-26 00:24:40.695237 | controller -> localhost | +---[RSA 2048]----+
2026-02-26 00:24:40.695265 | controller -> localhost | |                 |
2026-02-26 00:24:40.695294 | controller -> localhost | |                 |
2026-02-26 00:24:40.695322 | controller -> localhost | |o . .            |
2026-02-26 00:24:40.695350 | controller -> localhost | | = o             |
2026-02-26 00:24:40.695377 | controller -> localhost | |+ O o   S        |
2026-02-26 00:24:40.695418 | controller -> localhost | |oO E B . +       |
2026-02-26 00:24:40.695454 | controller -> localhost | |o++ * X++ o      |
2026-02-26 00:24:40.695483 | controller -> localhost | |oo.o.O**o+       |
2026-02-26 00:24:40.695513 | controller -> localhost | |o ..o.oBBo.      |
2026-02-26 00:24:40.695550 | controller -> localhost | +----[SHA256]-----+
2026-02-26 00:24:40.695660 | controller -> localhost | ok: Runtime: 0:00:00.168535
2026-02-26 00:24:40.707179 | 
2026-02-26 00:24:40.707291 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-02-26 00:24:40.731166 | controller | ok
2026-02-26 00:24:40.747748 | controller | included: /var/lib/zuul/builds/9894e605f7034b61b12072911427687a/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-02-26 00:24:40.761315 | 
2026-02-26 00:24:40.761426 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-02-26 00:24:40.787048 | controller | skipping: Conditional result was False
2026-02-26 00:24:40.797245 | 
2026-02-26 00:24:40.797377 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-02-26 00:24:41.454404 | controller | changed
2026-02-26 00:24:41.460549 | 
2026-02-26 00:24:41.460653 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-02-26 00:24:41.713480 | controller | ok
2026-02-26 00:24:41.728244 | 
2026-02-26 00:24:41.728483 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-02-26 00:24:42.362953 | controller | changed
2026-02-26 00:24:42.373411 | 
2026-02-26 00:24:42.373560 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-02-26 00:24:42.985188 | controller | changed
2026-02-26 00:24:43.000882 | 
2026-02-26 00:24:43.001128 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-02-26 00:24:43.039190 | controller | skipping: Conditional result was False
2026-02-26 00:24:43.049790 | 
2026-02-26 00:24:43.049907 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-02-26 00:24:43.522305 | controller -> localhost | changed
2026-02-26 00:24:43.537677 | 
2026-02-26 00:24:43.537813 | TASK [add-build-sshkey : Add back temp key]
2026-02-26 00:24:43.807442 | controller -> localhost | Identity added: /var/lib/zuul/builds/9894e605f7034b61b12072911427687a/work/9894e605f7034b61b12072911427687a_id_rsa (zuul-build-sshkey)
2026-02-26 00:24:43.807698 | controller -> localhost | ok: Runtime: 0:00:00.007874
2026-02-26 00:24:43.814348 | 
2026-02-26 00:24:43.814410 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-02-26 00:24:44.171924 | controller | ok
2026-02-26 00:24:44.184465 | 
2026-02-26 00:24:44.184611 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-02-26 00:24:44.222130 | controller | skipping: Conditional result was False
2026-02-26 00:24:44.234780 | 
2026-02-26 00:24:44.234867 | TASK [Run add-build-sshkey role (ECDSA)]
2026-02-26 00:24:44.265438 | controller | ok
2026-02-26 00:24:44.282865 | 
2026-02-26 00:24:44.282970 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-02-26 00:24:44.565023 | controller -> localhost | ok
2026-02-26 00:24:44.574502 | 
2026-02-26 00:24:44.574657 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-02-26 00:24:44.600845 | controller | ok
2026-02-26 00:24:44.615211 | controller | included: /var/lib/zuul/builds/9894e605f7034b61b12072911427687a/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-02-26 00:24:44.623220 | 
2026-02-26 00:24:44.623410 | TASK [add-build-sshkey : Create Temp SSH key]
2026-02-26 00:24:44.960302 | controller -> localhost | Generating public/private ecdsa key pair.
2026-02-26 00:24:44.960628 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/9894e605f7034b61b12072911427687a/work/9894e605f7034b61b12072911427687a_id_ecdsa.
2026-02-26 00:24:44.960659 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/9894e605f7034b61b12072911427687a/work/9894e605f7034b61b12072911427687a_id_ecdsa.pub.
2026-02-26 00:24:44.960695 | controller -> localhost | The key fingerprint is:
2026-02-26 00:24:44.960716 | controller -> localhost | SHA256:niLJn6EJ3MocQLefnmx5QNSGDHeKdqXPoinFE2c3CCc zuul-build-sshkey
2026-02-26 00:24:44.960740 | controller -> localhost | The key's randomart image is:
2026-02-26 00:24:44.960778 | controller -> localhost | +---[ECDSA 521]---+
2026-02-26 00:24:44.960800 | controller -> localhost | |   Eoooo         |
2026-02-26 00:24:44.960839 | controller -> localhost | |    *+*o         |
2026-02-26 00:24:44.960858 | controller -> localhost | | . =.B.o         |
2026-02-26 00:24:44.960875 | controller -> localhost | |. + *.+ .        |
2026-02-26 00:24:44.960891 | controller -> localhost | |.  =.. oS        |
2026-02-26 00:24:44.960908 | controller -> localhost | | o.o=oo. .       |
2026-02-26 00:24:44.960924 | controller -> localhost | | .+o=o= o        |
2026-02-26 00:24:44.960940 | controller -> localhost | | o.+oB.=         |
2026-02-26 00:24:44.960957 | controller -> localhost | |  + +++          |
2026-02-26 00:24:44.960973 | controller -> localhost | +----[SHA256]-----+
2026-02-26 00:24:44.961035 | controller -> localhost | ok: Runtime: 0:00:00.009274
2026-02-26 00:24:44.981878 | 
2026-02-26 00:24:44.982021 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-02-26 00:24:45.012214 | controller | ok
2026-02-26 00:24:45.020206 | controller | included: /var/lib/zuul/builds/9894e605f7034b61b12072911427687a/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-02-26 00:24:45.030591 | 
2026-02-26 00:24:45.030690 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-02-26 00:24:45.055662 | controller | skipping: Conditional result was False
2026-02-26 00:24:45.062898 | 
2026-02-26 00:24:45.063010 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-02-26 00:24:45.335261 | controller | changed
2026-02-26 00:24:45.346440 | 
2026-02-26 00:24:45.346690 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-02-26 00:24:45.579125 | controller | ok
2026-02-26 00:24:45.588142 | 
2026-02-26 00:24:45.588312 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-02-26 00:24:46.290216 | controller | changed
2026-02-26 00:24:46.303966 | 
2026-02-26 00:24:46.304110 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-02-26 00:24:46.956244 | controller | changed
2026-02-26 00:24:46.965473 | 
2026-02-26 00:24:46.965580 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-02-26 00:24:46.992045 | controller | skipping: Conditional result was False
2026-02-26 00:24:47.002435 | 
2026-02-26 00:24:47.002570 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-02-26 00:24:47.317476 | controller -> localhost | changed
2026-02-26 00:24:47.342820 | 
2026-02-26 00:24:47.342961 | TASK [add-build-sshkey : Add back temp key]
2026-02-26 00:24:47.707539 | controller -> localhost | Identity added: /var/lib/zuul/builds/9894e605f7034b61b12072911427687a/work/9894e605f7034b61b12072911427687a_id_ecdsa (zuul-build-sshkey)
2026-02-26 00:24:47.708150 | controller -> localhost | ok: Runtime: 0:00:00.015222
2026-02-26 00:24:47.724190 | 
2026-02-26 00:24:47.724500 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-02-26 00:24:47.936068 | controller | ok
2026-02-26 00:24:47.947483 | 
2026-02-26 00:24:47.947878 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-02-26 00:24:47.974378 | controller | skipping: Conditional result was False
2026-02-26 00:24:47.986428 | 
2026-02-26 00:24:47.986551 | TASK [include_role : remove-zuul-sshkey]
2026-02-26 00:24:48.000577 | controller | skipping: Conditional result was False
2026-02-26 00:24:48.008653 | 
2026-02-26 00:24:48.008990 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-02-26 00:24:48.238969 | controller | ok: "logs"
2026-02-26 00:24:48.239301 | controller | ok: All items complete
2026-02-26 00:24:48.239343 | 
2026-02-26 00:24:48.439651 | controller | ok: "artifacts"
2026-02-26 00:24:48.636346 | controller | ok: "docs"
2026-02-26 00:24:48.651760 | 
2026-02-26 00:24:48.651916 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-02-26 00:24:48.876369 | controller | changed: "logs"
2026-02-26 00:24:49.062622 | controller | changed: "artifacts"
2026-02-26 00:24:49.250144 | controller | changed: "docs"
2026-02-26 00:24:49.300081 | 
2026-02-26 00:24:49.300271 | PLAY RECAP
2026-02-26 00:24:49.300331 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0
2026-02-26 00:24:49.300368 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-02-26 00:24:49.300395 | 
2026-02-26 00:24:49.476976 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master]
2026-02-26 00:24:49.477947 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master]
2026-02-26 00:24:50.152612 | 
2026-02-26 00:24:50.152790 | PLAY [all]
2026-02-26 00:24:50.184611 | 
2026-02-26 00:24:50.184793 | TASK [Install binary dependencies]
2026-02-26 00:24:50.235963 | controller | ok
2026-02-26 00:24:50.258041 | 
2026-02-26 00:24:50.258205 | TASK [bindep : Include find tasks]
2026-02-26 00:24:50.289198 | controller | ok
2026-02-26 00:24:50.297854 | controller | included: /var/lib/zuul/builds/9894e605f7034b61b12072911427687a/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml
2026-02-26 00:24:50.306090 | 
2026-02-26 00:24:50.306242 | TASK [bindep : Look for bindep.txt]
2026-02-26 00:24:50.932044 | controller | ok
2026-02-26 00:24:50.945144 | 
2026-02-26 00:24:50.945359 | TASK [bindep : Define bindep_file fact]
2026-02-26 00:24:50.973564 | controller | skipping: Conditional result was False
2026-02-26 00:24:50.984215 | 
2026-02-26 00:24:50.984429 | TASK [bindep : Look for other-requirements.txt]
2026-02-26 00:24:51.203036 | controller | ok
2026-02-26 00:24:51.210938 | 
2026-02-26 00:24:51.211054 | TASK [bindep : Define bindep_file fact]
2026-02-26 00:24:51.249369 | controller | skipping: Conditional result was False
2026-02-26 00:24:51.262584 | 
2026-02-26 00:24:51.262688 | TASK [bindep : Look for bindep fallback file]
2026-02-26 00:24:51.313487 | controller | skipping: Conditional result was False
2026-02-26 00:24:51.325172 | 
2026-02-26 00:24:51.325442 | TASK [bindep : Define bindep_file fact]
2026-02-26 00:24:51.351674 | controller | skipping: Conditional result was False
2026-02-26 00:24:51.362385 | 
2026-02-26 00:24:51.362583 | TASK [bindep : Include bindep tasks]
2026-02-26 00:24:51.389228 | controller | skipping: Conditional result was False
2026-02-26 00:24:51.403035 | 
2026-02-26 00:24:51.403299 | TASK [bindep : Include install tasks]
2026-02-26 00:24:51.442678 | controller | skipping: Conditional result was False
2026-02-26 00:24:51.450908 | 
2026-02-26 00:24:51.451043 | LOOP [bindep : Include package tasks]
2026-02-26 00:24:51.531147 | 
2026-02-26 00:24:51.531356 | TASK [Run test-setup role]
2026-02-26 00:24:51.552484 | controller | ok
2026-02-26 00:24:51.573198 | 
2026-02-26 00:24:51.573342 | TASK [test-setup : Check if project's tools/test-setup.sh exists]
2026-02-26 00:24:51.790630 | controller | ok
2026-02-26 00:24:51.798997 | 
2026-02-26 00:24:51.799210 | TASK [test-setup : Run tools/test-setup.sh]
2026-02-26 00:24:52.342123 | controller | skipping: Conditional result was False
2026-02-26 00:24:52.396484 | 
2026-02-26 00:24:52.396647 | PLAY RECAP
2026-02-26 00:24:52.396765 | controller | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0
2026-02-26 00:24:52.396813 | 
2026-02-26 00:24:52.539201 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master]
2026-02-26 00:24:52.540425 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master]
2026-02-26 00:24:53.201470 | 
2026-02-26 00:24:53.201631 | PLAY [controller]
2026-02-26 00:24:53.224376 | 
2026-02-26 00:24:53.224520 | TASK [Create the /root directory]
2026-02-26 00:24:53.823995 | controller | ok
2026-02-26 00:24:53.834349 | 
2026-02-26 00:24:53.834501 | TASK [Install glibc-langpack-en]
2026-02-26 00:24:57.823292 | controller | ok: Nothing to do
2026-02-26 00:24:57.836045 | 
2026-02-26 00:24:57.836313 | TASK [Ensure controller directory exists]
2026-02-26 00:24:58.049710 | controller | changed
2026-02-26 00:24:58.055962 | 
2026-02-26 00:24:58.056034 | TASK [Install container runtime]
2026-02-26 00:24:58.126360 | controller | ok
2026-02-26 00:24:58.183384 | 
2026-02-26 00:24:58.183546 | LOOP [ensure-podman : Find distribution installation]
2026-02-26 00:24:58.224200 | controller | ok: "/var/lib/zuul/builds/9894e605f7034b61b12072911427687a/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-podman/tasks/RedHat.yaml"
2026-02-26 00:24:58.236909 | controller | included: /var/lib/zuul/builds/9894e605f7034b61b12072911427687a/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-podman/tasks/RedHat.yaml
2026-02-26 00:24:58.243720 | 
2026-02-26 00:24:58.243808 | TASK [ensure-podman : Install podman (RedHat)]
2026-02-26 00:30:46.569624 | controller | ERROR
2026-02-26 00:30:46.569916 | controller | {
2026-02-26 00:30:46.569947 | controller |   "msg": "Data could not be sent to remote host \"162.253.55.227\". Make sure this host can be reached over ssh: ssh: connect to host 162.253.55.227 port 22: Connection timed out\r\n",
2026-02-26 00:30:46.569973 | controller |   "unreachable": true
2026-02-26 00:30:46.569992 | controller | }
unreachable
2026-02-26 00:30:46.571622 | 
2026-02-26 00:30:46.571672 | PLAY RECAP
2026-02-26 00:30:46.571715 | controller | ok: 4 changed: 1 unreachable: 1 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-02-26 00:30:46.571760 | 
2026-02-26 00:30:46.740846 | PRE-RUN END RESULT_UNREACHABLE: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master]
2026-02-26 00:30:46.741841 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master]
2026-02-26 00:30:47.422179 | 
2026-02-26 00:30:47.422326 | PLAY [all]
2026-02-26 00:30:47.445825 | 
2026-02-26 00:30:47.445963 | TASK [fetch-subunit-output : Find stestr or testr executable]
2026-02-26 00:30:50.084151 | controller | changed: non-zero return code
2026-02-26 00:30:50.090462 | 
2026-02-26 00:30:50.090562 | TASK [fetch-subunit-output : Get the list of directories with subunit files]
2026-02-26 00:30:50.115070 | controller | skipping: Conditional result was False
2026-02-26 00:30:50.122015 | 
2026-02-26 00:30:50.122111 | LOOP [fetch-subunit-output : Find any inflight partial subunit files]
2026-02-26 00:30:50.156714 | 
2026-02-26 00:30:50.157018 | LOOP [fetch-subunit-output : Copy any inflight subunit files]
2026-02-26 00:30:50.189103 | 
2026-02-26 00:30:50.189281 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream]
2026-02-26 00:30:50.203805 | controller | skipping: Conditional result was False
2026-02-26 00:30:50.211030 | 
2026-02-26 00:30:50.211175 | LOOP [fetch-subunit-output : Generate subunit file]
2026-02-26 00:30:50.233832 | 
2026-02-26 00:30:50.234069 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory]
2026-02-26 00:30:50.259813 | controller | skipping: Conditional result was False
2026-02-26 00:30:50.269635 | 
2026-02-26 00:30:50.269900 | TASK [fetch-subunit-output : Remove the temporary file]
2026-02-26 00:30:50.286008 | controller | skipping: Conditional result was False
2026-02-26 00:30:50.297788 | 
2026-02-26 00:30:50.297932 | TASK [fetch-subunit-output : Process and fetch subunit results]
2026-02-26 00:30:50.323509 | controller | skipping: Conditional result was False
2026-02-26 00:30:50.387108 | 
2026-02-26 00:30:50.387238 | PLAY RECAP
2026-02-26 00:30:50.387308 | controller | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0
2026-02-26 00:30:50.387346 | 
2026-02-26 00:30:50.534887 | POST-RUN END RESULT_UNREACHABLE: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master]
2026-02-26 00:30:50.536113 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master]
2026-02-26 00:30:51.189048 | 
2026-02-26 00:30:51.189199 | PLAY [all:!appliance*]
2026-02-26 00:30:51.217472 | 
2026-02-26 00:30:51.217633 | TASK [unregister the node]
2026-02-26 00:30:51.753743 | controller | skipping: Conditional result was False
2026-02-26 00:30:51.762382 | 
2026-02-26 00:30:51.762556 | TASK [include_role : fetch-output]
2026-02-26 00:30:51.796331 | controller | ok
2026-02-26 00:30:51.826577 | 
2026-02-26 00:30:51.826750 | TASK [fetch-output : Set log path for multiple nodes]
2026-02-26 00:30:51.883400 | controller | skipping: Conditional result was False
2026-02-26 00:30:51.890800 | 
2026-02-26 00:30:51.890955 | TASK [fetch-output : Set log path for single node]
2026-02-26 00:30:51.945540 | controller | ok
2026-02-26 00:30:51.956839 | 
2026-02-26 00:30:51.956947 | LOOP [fetch-output : Ensure local output dirs]
2026-02-26 00:30:52.377482 | controller -> localhost | ok: "/var/lib/zuul/builds/9894e605f7034b61b12072911427687a/work/logs"
2026-02-26 00:30:52.661312 | controller -> localhost | changed: "/var/lib/zuul/builds/9894e605f7034b61b12072911427687a/work/artifacts"
2026-02-26 00:30:52.914529 | controller -> localhost | changed: "/var/lib/zuul/builds/9894e605f7034b61b12072911427687a/work/docs"
2026-02-26 00:30:52.934076 | 
2026-02-26 00:30:52.934252 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-02-26 00:30:53.604390 | controller | changed:
2026-02-26 00:30:53.604585 | controller | .d..t...... ./
2026-02-26 00:30:53.604615 | controller | cd+++++++++ controller/
2026-02-26 00:30:53.604650 | controller | changed: All items complete
2026-02-26 00:30:53.604672 | 
2026-02-26 00:30:54.162008 | controller | changed: .d..t...... ./
2026-02-26 00:30:54.655540 | controller | changed: .d..t...... ./
2026-02-26 00:30:54.680201 | 
2026-02-26 00:30:54.680340 | TASK [include_role : fetch-output-openshift]
2026-02-26 00:30:54.705401 | controller | skipping: Conditional result was False
2026-02-26 00:30:54.715473 | 
2026-02-26 00:30:54.715605 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-02-26 00:30:54.751114 | controller | skipping: Conditional result was False
2026-02-26 00:30:54.766321 | controller | skipping: Conditional result was False
2026-02-26 00:30:54.804784 | 
2026-02-26 00:30:54.804926 | PLAY [localhost]
2026-02-26 00:30:54.818446 | 
2026-02-26 00:30:54.818567 | TASK [Run Zuul manifest role]
2026-02-26 00:30:54.838583 | localhost | ok
2026-02-26 00:30:54.859033 | 
2026-02-26 00:30:54.859181 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-02-26 00:30:55.249355 | localhost | changed
2026-02-26 00:30:55.256399 | 
2026-02-26 00:30:55.256535 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-02-26 00:30:55.289665 | localhost | ok
2026-02-26 00:30:55.303120 | 
2026-02-26 00:30:55.303259 | TASK [Set zuul-log-path fact]
2026-02-26 00:30:55.324431 | localhost | ok
2026-02-26 00:30:55.344113 | 
2026-02-26 00:30:55.344229 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-02-26 00:30:55.372201 | localhost | ok
2026-02-26 00:30:55.380530 | 
2026-02-26 00:30:55.380636 | LOOP [Set zuul_log_targets (Swift with random Rackspace region)]
2026-02-26 00:30:55.417147 | localhost | ok:
2026-02-26 00:30:55.417374 | localhost | {
2026-02-26 00:30:55.417401 | localhost |   "auth": {
2026-02-26 00:30:55.417420 | localhost |     "password": "IonWCwcuOFib&&<}wp^:[2G/",
2026-02-26 00:30:55.417438 | localhost |     "username": "9LF91O0RK7JU"
2026-02-26 00:30:55.417455 | localhost |   },
2026-02-26 00:30:55.417471 | localhost |   "profile": "rackspace",
2026-02-26 00:30:55.417487 | localhost |   "region_name": "ORD"
2026-02-26 00:30:55.417503 | localhost | }
2026-02-26 00:30:55.417528 | 
2026-02-26 00:30:55.432351 | 
2026-02-26 00:30:55.432500 | TASK [Run upload-logs-failover role (S3 then Swift)]
2026-02-26 00:30:55.454961 | localhost | Output suppressed because no_log was given
2026-02-26 00:30:55.475037 | 
2026-02-26 00:30:55.475185 | TASK [upload-logs-failover : Initialize control vars]
2026-02-26 00:30:55.506545 | localhost | ok
2026-02-26 00:30:55.511605 | 
2026-02-26 00:30:55.511692 | LOOP [upload-logs-failover : Perform log upload]
2026-02-26 00:30:55.546867 | localhost | Output suppressed because no_log was given
2026-02-26 00:30:55.592720 | localhost | included: /var/lib/zuul/builds/9894e605f7034b61b12072911427687a/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/upload-logs-failover/tasks/upload.yaml
2026-02-26 00:30:55.600143 | 
2026-02-26 00:30:55.600276 | LOOP [upload-logs-failover : Unpack vars for swift upload]
2026-02-26 00:30:55.692783 | localhost | Output suppressed because no_log was given
2026-02-26 00:30:55.700170 | 
2026-02-26 00:30:55.700322 | TASK [Upload logs to swift]
2026-02-26 00:30:55.719078 | localhost | ok
2026-02-26 00:30:55.762391 | 
2026-02-26 00:30:55.762544 | TASK [Set zuul-log-path fact]
2026-02-26 00:30:55.797981 | localhost | skipping: Conditional result was False
2026-02-26 00:30:55.804463 | 
2026-02-26 00:30:55.804591 | TASK [upload-logs-swift : Ensure logs are readable before uploading]
2026-02-26 00:30:56.227350 | localhost -> localhost | ok: Runtime: 0:00:00.005750
2026-02-26 00:30:56.233419 | 
2026-02-26 00:30:56.233547 | TASK [upload-logs-swift : Upload logs to swift]