2026-03-08 00:07:00.722161 | Job console starting... 2026-03-08 00:07:00.734052 | Updating repositories 2026-03-08 00:07:01.160569 | Preparing job workspace 2026-03-08 00:07:14.080345 | Running Ansible setup... 2026-03-08 00:07:19.115635 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-03-08 00:07:19.951260 | 2026-03-08 00:07:19.951452 | PLAY [localhost] 2026-03-08 00:07:19.960714 | 2026-03-08 00:07:19.960792 | TASK [Gathering Facts] 2026-03-08 00:07:21.040606 | localhost | ok 2026-03-08 00:07:21.062124 | 2026-03-08 00:07:21.062276 | TASK [Setup log path fact] 2026-03-08 00:07:21.093013 | localhost | ok 2026-03-08 00:07:21.114037 | 2026-03-08 00:07:21.114196 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-08 00:07:21.163992 | localhost | ok 2026-03-08 00:07:21.180942 | 2026-03-08 00:07:21.181124 | TASK [emit-job-header : Print job information] 2026-03-08 00:07:21.238830 | # Job Information 2026-03-08 00:07:21.239106 | Ansible Version: 2.15.12 2026-03-08 00:07:21.239178 | Job: ansible-test-sanity-docker-devel 2026-03-08 00:07:21.239225 | Pipeline: periodic 2026-03-08 00:07:21.239268 | Executor: ze04.softwarefactory-project.io 2026-03-08 00:07:21.239310 | Triggered by: https://github.com/ansible-collections/ansible.network 2026-03-08 00:07:21.239360 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/d07/ansible/d07fe911af5e436882c1ab13982bf173/ 2026-03-08 00:07:21.239407 | Event ID: 5cf2cc93c96b4f3a806cea0572acc5d8 2026-03-08 00:07:21.246893 | 2026-03-08 00:07:21.247107 | LOOP [emit-job-header : Print node information] 2026-03-08 00:07:21.370497 | localhost | ok: 2026-03-08 00:07:21.370752 | localhost | # Node Information 2026-03-08 00:07:21.370790 | localhost | Inventory Hostname: controller 2026-03-08 00:07:21.370812 | localhost | Hostname: np0005641409 2026-03-08 00:07:21.370831 | localhost | Username: zuul 2026-03-08 00:07:21.370856 | localhost | Distro: Fedora 37 2026-03-08 00:07:21.370877 | localhost | Provider: ansible-vexxhost-ca-ymq-1 2026-03-08 00:07:21.370895 | localhost | Region: ca-ymq-1 2026-03-08 00:07:21.370912 | localhost | Label: ansible-fedora-37-1vcpu 2026-03-08 00:07:21.370929 | localhost | Product Name: OpenStack Nova 2026-03-08 00:07:21.370946 | localhost | Interface IP: 162.253.55.227 2026-03-08 00:07:21.395982 | 2026-03-08 00:07:21.396076 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-08 00:07:21.801740 | localhost -> localhost | changed 2026-03-08 00:07:21.813695 | 2026-03-08 00:07:21.813820 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-08 00:07:22.864588 | localhost -> localhost | changed 2026-03-08 00:07:22.887528 | 2026-03-08 00:07:22.887610 | PLAY [all:!appliance*] 2026-03-08 00:07:22.905597 | 2026-03-08 00:07:22.905737 | TASK [include_role : start-zuul-console] 2026-03-08 00:07:22.936082 | controller | ok 2026-03-08 00:07:22.950258 | 2026-03-08 00:07:22.950359 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-03-08 00:07:23.307327 | controller | ok 2026-03-08 00:07:23.320942 | 2026-03-08 00:07:23.321149 | TASK [use-our-mirror : Retrieve the IP address] 2026-03-08 00:07:24.224852 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found 2026-03-08 00:07:24.232752 | 2026-03-08 00:07:24.232877 | TASK [use-our-mirror : Ensure the registry service is running on the mirror] 2026-03-08 00:07:24.770830 | controller | skipping: Conditional result was False 2026-03-08 00:07:24.777867 | 2026-03-08 00:07:24.777993 | TASK [use-our-mirror : Write the IP in /etc/hosts] 2026-03-08 00:07:24.793106 | controller | skipping: Conditional result was False 2026-03-08 00:07:24.800241 | 2026-03-08 00:07:24.800333 | TASK [use-our-mirror : Create the podman configuration directory] 2026-03-08 00:07:24.814756 | controller | skipping: Conditional result was False 2026-03-08 00:07:24.822173 | 2026-03-08 00:07:24.822279 | TASK [use-our-mirror : Copy the podman configuration] 2026-03-08 00:07:24.835919 | controller | skipping: Conditional result was False 2026-03-08 00:07:24.845450 | 2026-03-08 00:07:24.845589 | TASK [use-our-mirror : Copy the Yum configuration (main)] 2026-03-08 00:07:24.860470 | controller | skipping: Conditional result was False 2026-03-08 00:07:24.869282 | 2026-03-08 00:07:24.869378 | TASK [use-our-mirror : Copy the Yum configuration (update)] 2026-03-08 00:07:24.888092 | controller | skipping: Conditional result was False 2026-03-08 00:07:24.902031 | 2026-03-08 00:07:24.902123 | TASK [Disable Fedora Modular] 2026-03-08 00:07:25.145920 | controller | changed 2026-03-08 00:07:25.151899 | 2026-03-08 00:07:25.151975 | TASK [Enable EPEL] 2026-03-08 00:07:25.175464 | controller | skipping: Conditional result was False 2026-03-08 00:07:25.182249 | 2026-03-08 00:07:25.182341 | TASK [Register the RHEL node] 2026-03-08 00:07:25.722286 | 2026-03-08 00:07:25.722433 | TASK [Show the subscription-manager status] 2026-03-08 00:07:26.498614 | controller | skipping: Conditional result was False 2026-03-08 00:07:26.515369 | 2026-03-08 00:07:26.515561 | TASK [Enable EPEL on RHEL] 2026-03-08 00:07:27.063594 | controller | skipping: Conditional result was False 2026-03-08 00:07:27.075713 | 2026-03-08 00:07:27.075844 | TASK [Install git and tox] 2026-03-08 00:08:50.344026 | controller | changed 2026-03-08 00:08:50.362043 | 2026-03-08 00:08:50.362188 | TASK [include_role : prepare-workspace] 2026-03-08 00:08:50.395278 | controller | ok 2026-03-08 00:08:50.423960 | 2026-03-08 00:08:50.424099 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-03-08 00:08:50.659072 | controller | ok 2026-03-08 00:08:50.665523 | 2026-03-08 00:08:50.665611 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-03-08 00:14:27.831586 | controller | Output suppressed because no_log was given 2026-03-08 00:14:27.843643 | 2026-03-08 00:14:27.843815 | TASK [include_role : prepare-workspace-openshift] 2026-03-08 00:14:27.860865 | controller | skipping: Conditional result was False 2026-03-08 00:14:27.885171 | 2026-03-08 00:14:27.885272 | PLAY [all:!appliance] 2026-03-08 00:14:27.902879 | 2026-03-08 00:14:27.903004 | TASK [Run add-build-sshkey role (RSA)] 2026-03-08 00:14:27.924243 | controller | ok 2026-03-08 00:14:27.939415 | 2026-03-08 00:14:27.939504 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-08 00:14:28.173353 | controller -> localhost | ok 2026-03-08 00:14:28.189254 | 2026-03-08 00:14:28.189402 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-08 00:14:28.214796 | controller | ok 2026-03-08 00:14:28.230957 | controller | included: /var/lib/zuul/builds/d07fe911af5e436882c1ab13982bf173/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-08 00:14:28.240386 | 2026-03-08 00:14:28.240507 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-08 00:14:28.684635 | controller -> localhost | Generating public/private rsa key pair. 2026-03-08 00:14:28.684950 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/d07fe911af5e436882c1ab13982bf173/work/d07fe911af5e436882c1ab13982bf173_id_rsa. 2026-03-08 00:14:28.684997 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/d07fe911af5e436882c1ab13982bf173/work/d07fe911af5e436882c1ab13982bf173_id_rsa.pub. 2026-03-08 00:14:28.685033 | controller -> localhost | The key fingerprint is: 2026-03-08 00:14:28.685067 | controller -> localhost | SHA256:TDcKMuCSVw18l+AcDu5AZge6cV9hOmCqiMDNao/w5P0 zuul-build-sshkey 2026-03-08 00:14:28.685121 | controller -> localhost | The key's randomart image is: 2026-03-08 00:14:28.685159 | controller -> localhost | +---[RSA 2048]----+ 2026-03-08 00:14:28.685192 | controller -> localhost | | Oo=o=. . | 2026-03-08 00:14:28.685225 | controller -> localhost | |.Xo*.Booo | 2026-03-08 00:14:28.685257 | controller -> localhost | |B.=o*.*.. o | 2026-03-08 00:14:28.685288 | controller -> localhost | |=*.+ = + o . | 2026-03-08 00:14:28.685318 | controller -> localhost | |*o. o S | 2026-03-08 00:14:28.685357 | controller -> localhost | |o+o. | 2026-03-08 00:14:28.685388 | controller -> localhost | | .o.. | 2026-03-08 00:14:28.685420 | controller -> localhost | | . | 2026-03-08 00:14:28.685453 | controller -> localhost | | E | 2026-03-08 00:14:28.685489 | controller -> localhost | +----[SHA256]-----+ 2026-03-08 00:14:28.685559 | controller -> localhost | ok: Runtime: 0:00:00.085592 2026-03-08 00:14:28.694979 | 2026-03-08 00:14:28.695073 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-08 00:14:28.727147 | controller | ok 2026-03-08 00:14:28.738306 | controller | included: /var/lib/zuul/builds/d07fe911af5e436882c1ab13982bf173/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-08 00:14:28.749263 | 2026-03-08 00:14:28.749374 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-08 00:14:28.774137 | controller | skipping: Conditional result was False 2026-03-08 00:14:28.781988 | 2026-03-08 00:14:28.782115 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-08 00:14:29.472848 | controller | changed 2026-03-08 00:14:29.483317 | 2026-03-08 00:14:29.483450 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-08 00:14:29.702602 | controller | ok 2026-03-08 00:14:29.712254 | 2026-03-08 00:14:29.712409 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-08 00:14:30.311235 | controller | changed 2026-03-08 00:14:30.317366 | 2026-03-08 00:14:30.317435 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-08 00:14:30.954789 | controller | changed 2026-03-08 00:14:30.966505 | 2026-03-08 00:14:30.967047 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-08 00:14:30.984184 | controller | skipping: Conditional result was False 2026-03-08 00:14:30.992361 | 2026-03-08 00:14:30.992463 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-08 00:14:31.418369 | controller -> localhost | changed 2026-03-08 00:14:31.432942 | 2026-03-08 00:14:31.433071 | TASK [add-build-sshkey : Add back temp key] 2026-03-08 00:14:31.726170 | controller -> localhost | Identity added: /var/lib/zuul/builds/d07fe911af5e436882c1ab13982bf173/work/d07fe911af5e436882c1ab13982bf173_id_rsa (zuul-build-sshkey) 2026-03-08 00:14:31.726404 | controller -> localhost | ok: Runtime: 0:00:00.010908 2026-03-08 00:14:31.736479 | 2026-03-08 00:14:31.736619 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-08 00:14:32.087465 | controller | ok 2026-03-08 00:14:32.095249 | 2026-03-08 00:14:32.095389 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-08 00:14:32.121296 | controller | skipping: Conditional result was False 2026-03-08 00:14:32.143016 | 2026-03-08 00:14:32.143169 | TASK [Run add-build-sshkey role (ECDSA)] 2026-03-08 00:14:32.172956 | controller | ok 2026-03-08 00:14:32.202655 | 2026-03-08 00:14:32.202850 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-08 00:14:32.454303 | controller -> localhost | ok 2026-03-08 00:14:32.481351 | 2026-03-08 00:14:32.481493 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-08 00:14:32.511219 | controller | ok 2026-03-08 00:14:32.532730 | controller | included: /var/lib/zuul/builds/d07fe911af5e436882c1ab13982bf173/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-08 00:14:32.541926 | 2026-03-08 00:14:32.542018 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-08 00:14:32.815028 | controller -> localhost | Generating public/private ecdsa key pair. 2026-03-08 00:14:32.815256 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/d07fe911af5e436882c1ab13982bf173/work/d07fe911af5e436882c1ab13982bf173_id_ecdsa. 2026-03-08 00:14:32.815289 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/d07fe911af5e436882c1ab13982bf173/work/d07fe911af5e436882c1ab13982bf173_id_ecdsa.pub. 2026-03-08 00:14:32.815319 | controller -> localhost | The key fingerprint is: 2026-03-08 00:14:32.815342 | controller -> localhost | SHA256:19sTfmP+7frRV6qG8gLJ+k8VXldg5il8w9otuWjMAEM zuul-build-sshkey 2026-03-08 00:14:32.815362 | controller -> localhost | The key's randomart image is: 2026-03-08 00:14:32.815382 | controller -> localhost | +---[ECDSA 521]---+ 2026-03-08 00:14:32.815401 | controller -> localhost | | E +..| 2026-03-08 00:14:32.815419 | controller -> localhost | | . . = o | 2026-03-08 00:14:32.815438 | controller -> localhost | | o . + B | 2026-03-08 00:14:32.815456 | controller -> localhost | | + + * + | 2026-03-08 00:14:32.815474 | controller -> localhost | | . .S = o = o| 2026-03-08 00:14:32.815491 | controller -> localhost | | + o + = =o| 2026-03-08 00:14:32.815509 | controller -> localhost | | . .. .* *++| 2026-03-08 00:14:32.815527 | controller -> localhost | | . .o ....oo=| 2026-03-08 00:14:32.815544 | controller -> localhost | | ....+... .=*| 2026-03-08 00:14:32.815562 | controller -> localhost | +----[SHA256]-----+ 2026-03-08 00:14:32.815605 | controller -> localhost | ok: Runtime: 0:00:00.012854 2026-03-08 00:14:32.822383 | 2026-03-08 00:14:32.822481 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-08 00:14:32.852634 | controller | ok 2026-03-08 00:14:32.860719 | controller | included: /var/lib/zuul/builds/d07fe911af5e436882c1ab13982bf173/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-08 00:14:32.870625 | 2026-03-08 00:14:32.870766 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-08 00:14:32.894975 | controller | skipping: Conditional result was False 2026-03-08 00:14:32.902807 | 2026-03-08 00:14:32.902927 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-08 00:14:33.181755 | controller | changed 2026-03-08 00:14:33.190368 | 2026-03-08 00:14:33.190497 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-08 00:14:33.429497 | controller | ok 2026-03-08 00:14:33.439100 | 2026-03-08 00:14:33.439247 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-08 00:14:34.068294 | controller | changed 2026-03-08 00:14:34.075635 | 2026-03-08 00:14:34.075759 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-08 00:14:34.670243 | controller | changed 2026-03-08 00:14:34.679493 | 2026-03-08 00:14:34.679612 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-08 00:14:34.704345 | controller | skipping: Conditional result was False 2026-03-08 00:14:34.713564 | 2026-03-08 00:14:34.713726 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-08 00:14:34.957940 | controller -> localhost | changed 2026-03-08 00:14:34.973589 | 2026-03-08 00:14:34.973731 | TASK [add-build-sshkey : Add back temp key] 2026-03-08 00:14:35.246217 | controller -> localhost | Identity added: /var/lib/zuul/builds/d07fe911af5e436882c1ab13982bf173/work/d07fe911af5e436882c1ab13982bf173_id_ecdsa (zuul-build-sshkey) 2026-03-08 00:14:35.246533 | controller -> localhost | ok: Runtime: 0:00:00.011153 2026-03-08 00:14:35.256871 | 2026-03-08 00:14:35.256988 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-08 00:14:35.480256 | controller | ok 2026-03-08 00:14:35.488927 | 2026-03-08 00:14:35.489055 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-08 00:14:35.516393 | controller | skipping: Conditional result was False 2026-03-08 00:14:35.537564 | 2026-03-08 00:14:35.537722 | TASK [include_role : remove-zuul-sshkey] 2026-03-08 00:14:35.554312 | controller | skipping: Conditional result was False 2026-03-08 00:14:35.564204 | 2026-03-08 00:14:35.564328 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-03-08 00:14:35.792632 | controller | ok: "logs" 2026-03-08 00:14:35.792899 | controller | ok: All items complete 2026-03-08 00:14:35.792928 | 2026-03-08 00:14:35.977224 | controller | ok: "artifacts" 2026-03-08 00:14:36.182349 | controller | ok: "docs" 2026-03-08 00:14:36.208914 | 2026-03-08 00:14:36.209121 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-03-08 00:14:36.440414 | controller | changed: "logs" 2026-03-08 00:14:36.632704 | controller | changed: "artifacts" 2026-03-08 00:14:36.822982 | controller | changed: "docs" 2026-03-08 00:14:36.875051 | 2026-03-08 00:14:36.875176 | PLAY RECAP 2026-03-08 00:14:36.875242 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0 2026-03-08 00:14:36.875288 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-08 00:14:36.875321 | 2026-03-08 00:14:37.007226 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-03-08 00:14:37.008174 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-03-08 00:14:37.648349 | 2026-03-08 00:14:37.648498 | PLAY [all] 2026-03-08 00:14:37.674280 | 2026-03-08 00:14:37.674432 | TASK [Install binary dependencies] 2026-03-08 00:14:37.726116 | controller | ok 2026-03-08 00:14:37.747850 | 2026-03-08 00:14:37.748012 | TASK [bindep : Include find tasks] 2026-03-08 00:14:37.778595 | controller | ok 2026-03-08 00:14:37.787812 | controller | included: /var/lib/zuul/builds/d07fe911af5e436882c1ab13982bf173/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml 2026-03-08 00:14:37.794715 | 2026-03-08 00:14:37.794841 | TASK [bindep : Look for bindep.txt] 2026-03-08 00:14:38.360406 | controller | ok 2026-03-08 00:14:38.367434 | 2026-03-08 00:14:38.367561 | TASK [bindep : Define bindep_file fact] 2026-03-08 00:14:38.392313 | controller | skipping: Conditional result was False 2026-03-08 00:14:38.399546 | 2026-03-08 00:14:38.399702 | TASK [bindep : Look for other-requirements.txt] 2026-03-08 00:14:38.613454 | controller | ok 2026-03-08 00:14:38.620214 | 2026-03-08 00:14:38.620300 | TASK [bindep : Define bindep_file fact] 2026-03-08 00:14:38.654982 | controller | skipping: Conditional result was False 2026-03-08 00:14:38.664554 | 2026-03-08 00:14:38.664710 | TASK [bindep : Look for bindep fallback file] 2026-03-08 00:14:38.700111 | controller | skipping: Conditional result was False 2026-03-08 00:14:38.708510 | 2026-03-08 00:14:38.708644 | TASK [bindep : Define bindep_file fact] 2026-03-08 00:14:38.732996 | controller | skipping: Conditional result was False 2026-03-08 00:14:38.741972 | 2026-03-08 00:14:38.742128 | TASK [bindep : Include bindep tasks] 2026-03-08 00:14:38.767561 | controller | skipping: Conditional result was False 2026-03-08 00:14:38.775338 | 2026-03-08 00:14:38.775472 | TASK [bindep : Include install tasks] 2026-03-08 00:14:38.800244 | controller | skipping: Conditional result was False 2026-03-08 00:14:38.809060 | 2026-03-08 00:14:38.809227 | LOOP [bindep : Include package tasks] 2026-03-08 00:14:38.870977 | 2026-03-08 00:14:38.871390 | TASK [Run test-setup role] 2026-03-08 00:14:38.896088 | controller | ok 2026-03-08 00:14:38.921883 | 2026-03-08 00:14:38.922045 | TASK [test-setup : Check if project's tools/test-setup.sh exists] 2026-03-08 00:14:39.129184 | controller | ok 2026-03-08 00:14:39.135631 | 2026-03-08 00:14:39.135784 | TASK [test-setup : Run tools/test-setup.sh] 2026-03-08 00:14:39.669581 | controller | skipping: Conditional result was False 2026-03-08 00:14:39.696791 | 2026-03-08 00:14:39.696902 | PLAY RECAP 2026-03-08 00:14:39.696953 | controller | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-03-08 00:14:39.696986 | 2026-03-08 00:14:39.813534 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-03-08 00:14:39.814412 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2026-03-08 00:14:40.497623 | 2026-03-08 00:14:40.497773 | PLAY [controller] 2026-03-08 00:14:40.520046 | 2026-03-08 00:14:40.520178 | TASK [Create the /root directory] 2026-03-08 00:14:41.106113 | controller | ok 2026-03-08 00:14:41.118156 | 2026-03-08 00:14:41.118275 | TASK [Install glibc-langpack-en] 2026-03-08 00:14:45.025203 | controller | ok: Nothing to do 2026-03-08 00:14:45.036067 | 2026-03-08 00:14:45.036237 | TASK [Ensure controller directory exists] 2026-03-08 00:14:45.243348 | controller | changed 2026-03-08 00:14:45.252055 | 2026-03-08 00:14:45.252188 | TASK [Install container runtime] 2026-03-08 00:14:45.295068 | controller | ok 2026-03-08 00:14:45.336909 | 2026-03-08 00:14:45.337033 | LOOP [ensure-podman : Find distribution installation] 2026-03-08 00:14:45.359871 | controller | ok: "/var/lib/zuul/builds/d07fe911af5e436882c1ab13982bf173/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-podman/tasks/RedHat.yaml" 2026-03-08 00:14:45.370575 | controller | included: /var/lib/zuul/builds/d07fe911af5e436882c1ab13982bf173/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-podman/tasks/RedHat.yaml 2026-03-08 00:14:45.381149 | 2026-03-08 00:14:45.381268 | TASK [ensure-podman : Install podman (RedHat)] 2026-03-08 00:15:53.874863 | controller | changed 2026-03-08 00:15:53.884034 | 2026-03-08 00:15:53.884138 | TASK [ensure-podman : Fetch podman version] 2026-03-08 00:15:54.418097 | controller | Client: Podman Engine 2026-03-08 00:15:54.446406 | controller | Version: 4.6.2 2026-03-08 00:15:54.446595 | controller | API Version: 4.6.2 2026-03-08 00:15:54.446611 | controller | Go Version: go1.19.12 2026-03-08 00:15:54.446648 | controller | Built: Mon Aug 28 19:38:31 2023 2026-03-08 00:15:54.446661 | controller | OS/Arch: linux/amd64 2026-03-08 00:15:54.921014 | controller | ok: Runtime: 0:00:00.186796 2026-03-08 00:15:54.931872 | 2026-03-08 00:15:54.931963 | TASK [ensure-podman : Print podman version installed] 2026-03-08 00:15:54.964501 | Podman version: Client: Podman Engine 2026-03-08 00:15:54.964643 | Version: 4.6.2 2026-03-08 00:15:54.964671 | API Version: 4.6.2 2026-03-08 00:15:54.964719 | Go Version: go1.19.12 2026-03-08 00:15:54.965048 | Built: Mon Aug 28 19:38:31 2023 2026-03-08 00:15:54.965229 | OS/Arch: linux/amd64 2026-03-08 00:15:54.973146 | 2026-03-08 00:15:54.973221 | TASK [ensure-podman : Validate podman engine] 2026-03-08 00:15:55.512425 | controller | skipping: Conditional result was False 2026-03-08 00:15:55.527290 | 2026-03-08 00:15:55.527410 | TASK [ensure-podman : Set up docker compatability socket] 2026-03-08 00:15:55.552800 | controller | skipping: Conditional result was False 2026-03-08 00:15:55.577659 | 2026-03-08 00:15:55.577859 | TASK [Ensure python3.8 is present] 2026-03-08 00:15:55.593073 | controller | skipping: Conditional result was False 2026-03-08 00:15:55.601220 | 2026-03-08 00:15:55.601320 | TASK [Run our-ensure-python role (Fedora only for now)] 2026-03-08 00:15:55.627310 | controller | ok 2026-03-08 00:15:55.654893 | 2026-03-08 00:15:55.655008 | TASK [our-ensure-python : Install the right Python version (rpm)] 2026-03-08 00:15:57.003623 | controller | ok: Nothing to do 2026-03-08 00:15:57.017762 | 2026-03-08 00:15:57.017968 | TASK [our-ensure-python : Also install python3-devel] 2026-03-08 00:16:05.334549 | controller | changed 2026-03-08 00:16:05.351356 | 2026-03-08 00:16:05.351472 | TASK [Run ensure-virtualenv role] 2026-03-08 00:16:05.372052 | controller | ok 2026-03-08 00:16:05.402521 | 2026-03-08 00:16:05.402653 | TASK [ensure-virtualenv : Check if virtualenv is installed] 2026-03-08 00:16:05.606800 | controller | /usr/bin/virtualenv 2026-03-08 00:16:05.934770 | controller | ok: Runtime: 0:00:00.004956 2026-03-08 00:16:05.941084 | 2026-03-08 00:16:05.941159 | LOOP [ensure-virtualenv : Install virtualenv package] 2026-03-08 00:16:05.964246 | controller | skipping: Conditional result was False 2026-03-08 00:16:05.964607 | controller | ok: All items complete 2026-03-08 00:16:05.964647 | 2026-03-08 00:16:05.991958 | 2026-03-08 00:16:05.992258 | TASK [Find the full path of the Python interpreter] 2026-03-08 00:16:06.341143 | controller | /usr/bin/python3 2026-03-08 00:16:06.649936 | controller | ok 2026-03-08 00:16:06.658604 | 2026-03-08 00:16:06.658791 | TASK [Create virtualenv for ansible-test with a specific interpreter] 2026-03-08 00:21:03.498784 | [Zuul] Log Stream did not terminate 2026-03-08 00:21:03.499492 | controller | ERROR 2026-03-08 00:21:03.499618 | controller | { 2026-03-08 00:21:03.499655 | 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: No route to host\r\n", 2026-03-08 00:21:03.499733 | controller | "unreachable": true 2026-03-08 00:21:03.499761 | controller | } unreachable 2026-03-08 00:21:03.502786 | 2026-03-08 00:21:03.502854 | PLAY RECAP 2026-03-08 00:21:03.502904 | controller | ok: 11 changed: 5 unreachable: 1 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-03-08 00:21:03.502930 | 2026-03-08 00:21:03.633120 | PRE-RUN END RESULT_UNREACHABLE: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2026-03-08 00:21:03.634155 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-03-08 00:21:04.301201 | 2026-03-08 00:21:04.301420 | PLAY [all] 2026-03-08 00:21:04.326913 | 2026-03-08 00:21:04.327063 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-03-08 00:21:08.066774 | controller | changed: non-zero return code 2026-03-08 00:21:08.075275 | 2026-03-08 00:21:08.075441 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-03-08 00:21:08.090617 | controller | skipping: Conditional result was False 2026-03-08 00:21:08.099244 | 2026-03-08 00:21:08.099392 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-03-08 00:21:08.124464 | 2026-03-08 00:21:08.124674 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-03-08 00:21:08.150434 | 2026-03-08 00:21:08.150642 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-03-08 00:21:08.167150 | controller | skipping: Conditional result was False 2026-03-08 00:21:08.176986 | 2026-03-08 00:21:08.177150 | LOOP [fetch-subunit-output : Generate subunit file] 2026-03-08 00:21:08.213908 | 2026-03-08 00:21:08.214321 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-03-08 00:21:08.230388 | controller | skipping: Conditional result was False 2026-03-08 00:21:08.239516 | 2026-03-08 00:21:08.239665 | TASK [fetch-subunit-output : Remove the temporary file] 2026-03-08 00:21:08.265129 | controller | skipping: Conditional result was False 2026-03-08 00:21:08.273097 | 2026-03-08 00:21:08.273256 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-03-08 00:21:08.288248 | controller | skipping: Conditional result was False 2026-03-08 00:21:08.321919 | 2026-03-08 00:21:08.322093 | PLAY RECAP 2026-03-08 00:21:08.322144 | controller | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-03-08 00:21:08.322165 | 2026-03-08 00:21:08.446602 | POST-RUN END RESULT_UNREACHABLE: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-03-08 00:21:08.447920 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master] 2026-03-08 00:21:09.067577 | 2026-03-08 00:21:09.067767 | PLAY [all:!appliance*] 2026-03-08 00:21:09.097674 | 2026-03-08 00:21:09.097820 | TASK [unregister the node] 2026-03-08 00:21:09.630028 | controller | skipping: Conditional result was False 2026-03-08 00:21:09.644769 | 2026-03-08 00:21:09.645315 | TASK [include_role : fetch-output] 2026-03-08 00:21:09.690066 | controller | ok 2026-03-08 00:21:09.722492 | 2026-03-08 00:21:09.722612 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-08 00:21:09.767068 | controller | skipping: Conditional result was False 2026-03-08 00:21:09.773624 | 2026-03-08 00:21:09.773722 | TASK [fetch-output : Set log path for single node] 2026-03-08 00:21:09.803369 | controller | ok 2026-03-08 00:21:09.809658 | 2026-03-08 00:21:09.809776 | LOOP [fetch-output : Ensure local output dirs] 2026-03-08 00:21:10.242660 | controller -> localhost | ok: "/var/lib/zuul/builds/d07fe911af5e436882c1ab13982bf173/work/logs" 2026-03-08 00:21:10.493539 | controller -> localhost | changed: "/var/lib/zuul/builds/d07fe911af5e436882c1ab13982bf173/work/artifacts" 2026-03-08 00:21:10.730806 | controller -> localhost | changed: "/var/lib/zuul/builds/d07fe911af5e436882c1ab13982bf173/work/docs" 2026-03-08 00:21:10.742080 | 2026-03-08 00:21:10.742189 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-08 00:21:11.434517 | controller | changed: 2026-03-08 00:21:11.434741 | controller | .d..t...... ./ 2026-03-08 00:21:11.434771 | controller | cd+++++++++ controller/ 2026-03-08 00:21:11.434809 | controller | changed: All items complete 2026-03-08 00:21:11.434831 | 2026-03-08 00:21:11.951428 | controller | changed: .d..t...... ./ 2026-03-08 00:21:12.399377 | controller | changed: .d..t...... ./ 2026-03-08 00:21:12.424959 | 2026-03-08 00:21:12.425090 | TASK [include_role : fetch-output-openshift] 2026-03-08 00:21:12.440129 | controller | skipping: Conditional result was False 2026-03-08 00:21:12.450220 | 2026-03-08 00:21:12.450358 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-03-08 00:21:12.481970 | controller | skipping: Conditional result was False 2026-03-08 00:21:12.494848 | controller | skipping: Conditional result was False 2026-03-08 00:21:12.530111 | 2026-03-08 00:21:12.530220 | PLAY [localhost] 2026-03-08 00:21:12.543828 | 2026-03-08 00:21:12.543916 | TASK [Run Zuul manifest role] 2026-03-08 00:21:12.562087 | localhost | ok 2026-03-08 00:21:12.578713 | 2026-03-08 00:21:12.578845 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-08 00:21:12.983443 | localhost | changed 2026-03-08 00:21:12.994088 | 2026-03-08 00:21:12.994357 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-08 00:21:13.030385 | localhost | ok 2026-03-08 00:21:13.050125 | 2026-03-08 00:21:13.050261 | TASK [Set zuul-log-path fact] 2026-03-08 00:21:13.077157 | localhost | ok 2026-03-08 00:21:13.114193 | 2026-03-08 00:21:13.114391 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-08 00:21:13.148918 | localhost | ok 2026-03-08 00:21:13.161516 | 2026-03-08 00:21:13.161633 | LOOP [Set zuul_log_targets (Swift with random Rackspace region)] 2026-03-08 00:21:13.186367 | localhost | ok: 2026-03-08 00:21:13.186597 | localhost | { 2026-03-08 00:21:13.186624 | localhost | "auth": { 2026-03-08 00:21:13.186646 | localhost | "password": "IonWCwcuOFib&&<}wp^:[2G/", 2026-03-08 00:21:13.186664 | localhost | "username": "9LF91O0RK7JU" 2026-03-08 00:21:13.186699 | localhost | }, 2026-03-08 00:21:13.186718 | localhost | "profile": "rackspace", 2026-03-08 00:21:13.186734 | localhost | "region_name": "ORD" 2026-03-08 00:21:13.186750 | localhost | } 2026-03-08 00:21:13.186776 | 2026-03-08 00:21:13.202609 | 2026-03-08 00:21:13.202787 | TASK [Run upload-logs-failover role (S3 then Swift)] 2026-03-08 00:21:13.222539 | localhost | Output suppressed because no_log was given 2026-03-08 00:21:13.237292 | 2026-03-08 00:21:13.237380 | TASK [upload-logs-failover : Initialize control vars] 2026-03-08 00:21:13.256278 | localhost | ok 2026-03-08 00:21:13.262049 | 2026-03-08 00:21:13.262138 | LOOP [upload-logs-failover : Perform log upload] 2026-03-08 00:21:13.288042 | localhost | Output suppressed because no_log was given 2026-03-08 00:21:13.330299 | localhost | included: /var/lib/zuul/builds/d07fe911af5e436882c1ab13982bf173/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/upload-logs-failover/tasks/upload.yaml 2026-03-08 00:21:13.338080 | 2026-03-08 00:21:13.338176 | LOOP [upload-logs-failover : Unpack vars for swift upload] 2026-03-08 00:21:13.415439 | localhost | Output suppressed because no_log was given 2026-03-08 00:21:13.425129 | 2026-03-08 00:21:13.425249 | TASK [Upload logs to swift] 2026-03-08 00:21:13.446855 | localhost | ok 2026-03-08 00:21:13.489773 | 2026-03-08 00:21:13.489893 | TASK [Set zuul-log-path fact] 2026-03-08 00:21:13.514300 | localhost | skipping: Conditional result was False 2026-03-08 00:21:13.519988 | 2026-03-08 00:21:13.520083 | TASK [upload-logs-swift : Ensure logs are readable before uploading] 2026-03-08 00:21:13.929645 | localhost -> localhost | ok: Runtime: 0:00:00.005332 2026-03-08 00:21:13.943908 | 2026-03-08 00:21:13.944094 | TASK [upload-logs-swift : Upload logs to swift]