2026-03-01 21:59:53.045912 | Job console starting... 2026-03-01 21:59:53.056110 | Updating repositories 2026-03-01 21:59:53.085777 | Preparing job workspace 2026-03-01 21:59:57.168199 | Running Ansible setup... 2026-03-01 22:00:01.490228 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-03-01 22:00:02.093034 | 2026-03-01 22:00:02.093198 | PLAY [localhost] 2026-03-01 22:00:02.101545 | 2026-03-01 22:00:02.101627 | TASK [Gathering Facts] 2026-03-01 22:00:03.157629 | localhost | ok 2026-03-01 22:00:03.185370 | 2026-03-01 22:00:03.185525 | TASK [Setup log path fact] 2026-03-01 22:00:03.207033 | localhost | ok 2026-03-01 22:00:03.224851 | 2026-03-01 22:00:03.224938 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-01 22:00:03.264540 | localhost | ok 2026-03-01 22:00:03.274472 | 2026-03-01 22:00:03.274564 | TASK [emit-job-header : Print job information] 2026-03-01 22:00:03.327042 | # Job Information 2026-03-01 22:00:03.327249 | Ansible Version: 2.15.12 2026-03-01 22:00:03.327315 | Job: ansible-galaxy-importer 2026-03-01 22:00:03.327359 | Pipeline: third-party-check 2026-03-01 22:00:03.327400 | Executor: ze04.softwarefactory-project.io 2026-03-01 22:00:03.327439 | Triggered by: https://github.com/ansible-collections/ansible.windows/pull/871 2026-03-01 22:00:03.327484 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/972/ansible/9723edf559324bdebb48555b89c8709f/ 2026-03-01 22:00:03.327524 | Event ID: efa3da00-15b6-11f1-98f3-822866c1f400 2026-03-01 22:00:03.335325 | 2026-03-01 22:00:03.335459 | LOOP [emit-job-header : Print node information] 2026-03-01 22:00:03.455811 | localhost | ok: 2026-03-01 22:00:03.456154 | localhost | # Node Information 2026-03-01 22:00:03.456215 | localhost | Inventory Hostname: controller 2026-03-01 22:00:03.456259 | localhost | Hostname: np0005634769 2026-03-01 22:00:03.456300 | localhost | Username: zuul 2026-03-01 22:00:03.456345 | localhost | Distro: Fedora 37 2026-03-01 22:00:03.456385 | localhost | Provider: ansible-vexxhost-ca-ymq-1 2026-03-01 22:00:03.456423 | localhost | Region: ca-ymq-1 2026-03-01 22:00:03.456459 | localhost | Label: ansible-fedora-37-1vcpu 2026-03-01 22:00:03.456494 | localhost | Product Name: OpenStack Nova 2026-03-01 22:00:03.456530 | localhost | Interface IP: 162.253.55.207 2026-03-01 22:00:03.479834 | 2026-03-01 22:00:03.480028 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-01 22:00:03.903487 | localhost -> localhost | changed 2026-03-01 22:00:03.915171 | 2026-03-01 22:00:03.915317 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-01 22:00:04.799178 | localhost -> localhost | changed 2026-03-01 22:00:04.839464 | 2026-03-01 22:00:04.839579 | PLAY [all:!appliance*] 2026-03-01 22:00:04.870933 | 2026-03-01 22:00:04.871030 | TASK [include_role : start-zuul-console] 2026-03-01 22:00:04.892840 | controller | ok 2026-03-01 22:00:04.910758 | 2026-03-01 22:00:04.910840 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-03-01 22:00:05.293621 | controller | ok 2026-03-01 22:00:05.318563 | 2026-03-01 22:00:05.318744 | TASK [use-our-mirror : Retrieve the IP address] 2026-03-01 22:00:06.464389 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found 2026-03-01 22:00:06.479033 | 2026-03-01 22:00:06.479185 | TASK [use-our-mirror : Ensure the registry service is running on the mirror] 2026-03-01 22:00:07.031293 | controller | skipping: Conditional result was False 2026-03-01 22:00:07.037491 | 2026-03-01 22:00:07.037557 | TASK [use-our-mirror : Write the IP in /etc/hosts] 2026-03-01 22:00:07.062253 | controller | skipping: Conditional result was False 2026-03-01 22:00:07.069415 | 2026-03-01 22:00:07.069485 | TASK [use-our-mirror : Create the podman configuration directory] 2026-03-01 22:00:07.088661 | controller | skipping: Conditional result was False 2026-03-01 22:00:07.095435 | 2026-03-01 22:00:07.095521 | TASK [use-our-mirror : Copy the podman configuration] 2026-03-01 22:00:07.131658 | controller | skipping: Conditional result was False 2026-03-01 22:00:07.143504 | 2026-03-01 22:00:07.143616 | TASK [use-our-mirror : Copy the Yum configuration (main)] 2026-03-01 22:00:07.167880 | controller | skipping: Conditional result was False 2026-03-01 22:00:07.178311 | 2026-03-01 22:00:07.178443 | TASK [use-our-mirror : Copy the Yum configuration (update)] 2026-03-01 22:00:07.202927 | controller | skipping: Conditional result was False 2026-03-01 22:00:07.214448 | 2026-03-01 22:00:07.214547 | TASK [Disable Fedora Modular] 2026-03-01 22:00:07.470146 | controller | changed 2026-03-01 22:00:07.483037 | 2026-03-01 22:00:07.483145 | TASK [Enable EPEL] 2026-03-01 22:00:07.510168 | controller | skipping: Conditional result was False 2026-03-01 22:00:07.516748 | 2026-03-01 22:00:07.516816 | TASK [Register the RHEL node] 2026-03-01 22:00:08.066984 | 2026-03-01 22:00:08.067134 | TASK [Show the subscription-manager status] 2026-03-01 22:00:08.620339 | controller | skipping: Conditional result was False 2026-03-01 22:00:08.628983 | 2026-03-01 22:00:08.629069 | TASK [Enable EPEL on RHEL] 2026-03-01 22:00:09.386476 | controller | skipping: Conditional result was False 2026-03-01 22:00:09.394520 | 2026-03-01 22:00:09.394611 | TASK [Install git and tox] 2026-03-01 22:01:30.991414 | controller | changed 2026-03-01 22:01:31.004530 | 2026-03-01 22:01:31.004660 | TASK [include_role : prepare-workspace] 2026-03-01 22:01:31.043310 | controller | ok 2026-03-01 22:01:31.078662 | 2026-03-01 22:01:31.078774 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-03-01 22:01:31.332416 | controller | ok 2026-03-01 22:01:31.346616 | 2026-03-01 22:01:31.346781 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-03-01 22:01:32.906696 | controller | Output suppressed because no_log was given 2026-03-01 22:01:32.918354 | 2026-03-01 22:01:32.918421 | TASK [include_role : prepare-workspace-openshift] 2026-03-01 22:01:32.944323 | controller | skipping: Conditional result was False 2026-03-01 22:01:32.976642 | 2026-03-01 22:01:32.976767 | PLAY [all:!appliance] 2026-03-01 22:01:32.997790 | 2026-03-01 22:01:32.997859 | TASK [Run add-build-sshkey role (RSA)] 2026-03-01 22:01:33.019416 | controller | ok 2026-03-01 22:01:33.037207 | 2026-03-01 22:01:33.037287 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-01 22:01:33.255203 | controller -> localhost | ok 2026-03-01 22:01:33.265039 | 2026-03-01 22:01:33.265141 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-01 22:01:33.296744 | controller | ok 2026-03-01 22:01:33.315486 | controller | included: /var/lib/zuul/builds/9723edf559324bdebb48555b89c8709f/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-01 22:01:33.324117 | 2026-03-01 22:01:33.324207 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-01 22:01:33.900940 | controller -> localhost | Generating public/private rsa key pair. 2026-03-01 22:01:33.901264 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/9723edf559324bdebb48555b89c8709f/work/9723edf559324bdebb48555b89c8709f_id_rsa. 2026-03-01 22:01:33.901323 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/9723edf559324bdebb48555b89c8709f/work/9723edf559324bdebb48555b89c8709f_id_rsa.pub. 2026-03-01 22:01:33.901367 | controller -> localhost | The key fingerprint is: 2026-03-01 22:01:33.901408 | controller -> localhost | SHA256:e/88oa+J6ZPhl7kWzf2dlHWvw3eEByxexYJKu1oOPPs zuul-build-sshkey 2026-03-01 22:01:33.901451 | controller -> localhost | The key's randomart image is: 2026-03-01 22:01:33.901491 | controller -> localhost | +---[RSA 2048]----+ 2026-03-01 22:01:33.901528 | controller -> localhost | | . . | 2026-03-01 22:01:33.901567 | controller -> localhost | | . . . o| 2026-03-01 22:01:33.901605 | controller -> localhost | | . o . o | 2026-03-01 22:01:33.901642 | controller -> localhost | | o . + o| 2026-03-01 22:01:33.901709 | controller -> localhost | | .S o = +=| 2026-03-01 22:01:33.901773 | controller -> localhost | | +.+ o =o=| 2026-03-01 22:01:33.901820 | controller -> localhost | | .O.o *.=+| 2026-03-01 22:01:33.901860 | controller -> localhost | | o.=+*o=.=| 2026-03-01 22:01:33.901902 | controller -> localhost | | oE+==++.| 2026-03-01 22:01:33.901944 | controller -> localhost | +----[SHA256]-----+ 2026-03-01 22:01:33.902030 | controller -> localhost | ok: Runtime: 0:00:00.129405 2026-03-01 22:01:33.916477 | 2026-03-01 22:01:33.916605 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-01 22:01:33.986375 | controller | ok 2026-03-01 22:01:33.999603 | controller | included: /var/lib/zuul/builds/9723edf559324bdebb48555b89c8709f/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-01 22:01:34.010763 | 2026-03-01 22:01:34.010871 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-01 22:01:34.056491 | controller | skipping: Conditional result was False 2026-03-01 22:01:34.063281 | 2026-03-01 22:01:34.063347 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-01 22:01:34.434706 | controller | changed 2026-03-01 22:01:34.456748 | 2026-03-01 22:01:34.456892 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-01 22:01:34.698229 | controller | ok 2026-03-01 22:01:34.710332 | 2026-03-01 22:01:34.710466 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-01 22:01:35.343594 | controller | changed 2026-03-01 22:01:35.356012 | 2026-03-01 22:01:35.356146 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-01 22:01:35.997869 | controller | changed 2026-03-01 22:01:36.012382 | 2026-03-01 22:01:36.012645 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-01 22:01:36.052562 | controller | skipping: Conditional result was False 2026-03-01 22:01:36.066726 | 2026-03-01 22:01:36.066993 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-01 22:01:36.435329 | controller -> localhost | changed 2026-03-01 22:01:36.446606 | 2026-03-01 22:01:36.446674 | TASK [add-build-sshkey : Add back temp key] 2026-03-01 22:01:36.772336 | controller -> localhost | Identity added: /var/lib/zuul/builds/9723edf559324bdebb48555b89c8709f/work/9723edf559324bdebb48555b89c8709f_id_rsa (zuul-build-sshkey) 2026-03-01 22:01:36.772646 | controller -> localhost | ok: Runtime: 0:00:00.012146 2026-03-01 22:01:36.785723 | 2026-03-01 22:01:36.785849 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-01 22:01:37.082924 | controller | ok 2026-03-01 22:01:37.088179 | 2026-03-01 22:01:37.088242 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-01 22:01:37.133372 | controller | skipping: Conditional result was False 2026-03-01 22:01:37.144249 | 2026-03-01 22:01:37.144311 | TASK [Run add-build-sshkey role (ECDSA)] 2026-03-01 22:01:37.175034 | controller | ok 2026-03-01 22:01:37.190406 | 2026-03-01 22:01:37.190471 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-01 22:01:37.437580 | controller -> localhost | ok 2026-03-01 22:01:37.444007 | 2026-03-01 22:01:37.444067 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-01 22:01:37.463873 | controller | ok 2026-03-01 22:01:37.474389 | controller | included: /var/lib/zuul/builds/9723edf559324bdebb48555b89c8709f/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-01 22:01:37.481208 | 2026-03-01 22:01:37.481274 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-01 22:01:37.748557 | controller -> localhost | Generating public/private ecdsa key pair. 2026-03-01 22:01:37.748854 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/9723edf559324bdebb48555b89c8709f/work/9723edf559324bdebb48555b89c8709f_id_ecdsa. 2026-03-01 22:01:37.748895 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/9723edf559324bdebb48555b89c8709f/work/9723edf559324bdebb48555b89c8709f_id_ecdsa.pub. 2026-03-01 22:01:37.748933 | controller -> localhost | The key fingerprint is: 2026-03-01 22:01:37.748958 | controller -> localhost | SHA256:+98xQGuyNOpURpWEePRHBCM/Z19xLSgtquVns9mf/6I zuul-build-sshkey 2026-03-01 22:01:37.748984 | controller -> localhost | The key's randomart image is: 2026-03-01 22:01:37.749009 | controller -> localhost | +---[ECDSA 521]---+ 2026-03-01 22:01:37.749031 | controller -> localhost | | oo+==o.o| 2026-03-01 22:01:37.749053 | controller -> localhost | | . ==+o. +| 2026-03-01 22:01:37.749077 | controller -> localhost | | o.o= +..| 2026-03-01 22:01:37.749100 | controller -> localhost | | o. . * ..| 2026-03-01 22:01:37.749121 | controller -> localhost | | +S * + .| 2026-03-01 22:01:37.749142 | controller -> localhost | | . .*+= . | 2026-03-01 22:01:37.749165 | controller -> localhost | | +o.= o | 2026-03-01 22:01:37.749188 | controller -> localhost | | o .o ...+ | 2026-03-01 22:01:37.749211 | controller -> localhost | | . ..Eo+o+| 2026-03-01 22:01:37.749232 | controller -> localhost | +----[SHA256]-----+ 2026-03-01 22:01:37.749293 | controller -> localhost | ok: Runtime: 0:00:00.007208 2026-03-01 22:01:37.758118 | 2026-03-01 22:01:37.758189 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-01 22:01:37.780708 | controller | ok 2026-03-01 22:01:37.790187 | controller | included: /var/lib/zuul/builds/9723edf559324bdebb48555b89c8709f/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-01 22:01:37.801119 | 2026-03-01 22:01:37.801185 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-01 22:01:37.825559 | controller | skipping: Conditional result was False 2026-03-01 22:01:37.833183 | 2026-03-01 22:01:37.833249 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-01 22:01:38.095015 | controller | changed 2026-03-01 22:01:38.100616 | 2026-03-01 22:01:38.100769 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-01 22:01:38.321959 | controller | ok 2026-03-01 22:01:38.344609 | 2026-03-01 22:01:38.344845 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-01 22:01:38.933702 | controller | changed 2026-03-01 22:01:38.945877 | 2026-03-01 22:01:38.946061 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-01 22:01:39.567355 | controller | changed 2026-03-01 22:01:39.579941 | 2026-03-01 22:01:39.580117 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-01 22:01:39.607165 | controller | skipping: Conditional result was False 2026-03-01 22:01:39.621347 | 2026-03-01 22:01:39.621507 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-01 22:01:39.861175 | controller -> localhost | changed 2026-03-01 22:01:39.886147 | 2026-03-01 22:01:39.886306 | TASK [add-build-sshkey : Add back temp key] 2026-03-01 22:01:40.167127 | controller -> localhost | Identity added: /var/lib/zuul/builds/9723edf559324bdebb48555b89c8709f/work/9723edf559324bdebb48555b89c8709f_id_ecdsa (zuul-build-sshkey) 2026-03-01 22:01:40.167334 | controller -> localhost | ok: Runtime: 0:00:00.014818 2026-03-01 22:01:40.173598 | 2026-03-01 22:01:40.173661 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-01 22:01:40.381549 | controller | ok 2026-03-01 22:01:40.393191 | 2026-03-01 22:01:40.393330 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-01 22:01:40.430244 | controller | skipping: Conditional result was False 2026-03-01 22:01:40.455469 | 2026-03-01 22:01:40.455602 | TASK [include_role : remove-zuul-sshkey] 2026-03-01 22:01:40.478795 | controller | skipping: Conditional result was False 2026-03-01 22:01:40.492466 | 2026-03-01 22:01:40.492614 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-03-01 22:01:40.733643 | controller | ok: "logs" 2026-03-01 22:01:40.734323 | controller | ok: All items complete 2026-03-01 22:01:40.734399 | 2026-03-01 22:01:40.926139 | controller | ok: "artifacts" 2026-03-01 22:01:41.121259 | controller | ok: "docs" 2026-03-01 22:01:41.137406 | 2026-03-01 22:01:41.137552 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-03-01 22:01:41.385752 | controller | changed: "logs" 2026-03-01 22:01:41.581103 | controller | changed: "artifacts" 2026-03-01 22:01:41.772756 | controller | changed: "docs" 2026-03-01 22:01:41.858170 | 2026-03-01 22:01:41.858291 | PLAY RECAP 2026-03-01 22:01:41.858344 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0 2026-03-01 22:01:41.858378 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-01 22:01:41.858402 | 2026-03-01 22:01:41.955281 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-03-01 22:01:41.956745 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-galaxy-importer/pre.yaml@master] 2026-03-01 22:01:42.536108 | 2026-03-01 22:01:42.536218 | PLAY [all] 2026-03-01 22:01:42.555832 | 2026-03-01 22:01:42.555904 | TASK [Setup ensure-tox role] 2026-03-01 22:01:42.575003 | controller | ok 2026-03-01 22:01:42.596947 | 2026-03-01 22:01:42.597018 | TASK [Install pip] 2026-03-01 22:01:42.616084 | controller | ok 2026-03-01 22:01:42.636497 | 2026-03-01 22:01:42.636562 | TASK [ensure-pip : Check if pip is installed] 2026-03-01 22:01:43.016829 | controller | /usr/bin/pip3 2026-03-01 22:01:43.031158 | controller | /usr/bin/python3: No module named wheel 2026-03-01 22:01:43.168207 | controller | ok: Runtime: 0:00:00.022971 2026-03-01 22:01:43.174230 | 2026-03-01 22:01:43.174299 | LOOP [ensure-pip : Install pip from packages] 2026-03-01 22:01:43.220436 | controller | ok: "/var/lib/zuul/builds/9723edf559324bdebb48555b89c8709f/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/RedHat.yaml" 2026-03-01 22:01:43.237109 | controller | included: /var/lib/zuul/builds/9723edf559324bdebb48555b89c8709f/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/RedHat.yaml 2026-03-01 22:01:43.251159 | 2026-03-01 22:01:43.251306 | TASK [ensure-pip : Install Python 3 pip] 2026-03-01 22:01:47.936264 | controller | changed 2026-03-01 22:01:47.948817 | 2026-03-01 22:01:47.948956 | TASK [ensure-pip : Check for EPEL repository] 2026-03-01 22:01:47.977185 | controller | skipping: Conditional result was False 2026-03-01 22:01:47.990323 | 2026-03-01 22:01:47.990458 | TASK [ensure-pip : Fail with instructions when EPEL is not installed] 2026-03-01 22:01:48.018435 | controller | skipping: Conditional result was False 2026-03-01 22:01:48.031818 | 2026-03-01 22:01:48.031984 | TASK [ensure-pip : Install Python 2 pip] 2026-03-01 22:01:48.059100 | controller | skipping: Conditional result was False 2026-03-01 22:01:48.072545 | 2026-03-01 22:01:48.072732 | TASK [ensure-pip : Ensure setuptools] 2026-03-01 22:01:48.099561 | controller | skipping: Conditional result was False 2026-03-01 22:01:48.119953 | 2026-03-01 22:01:48.120090 | TASK [ensure-pip : Check for ensurepip module] 2026-03-01 22:01:48.666309 | controller | skipping: Conditional result was False 2026-03-01 22:01:48.679104 | 2026-03-01 22:01:48.679244 | TASK [ensure-pip : Ensure python3-venv] 2026-03-01 22:01:48.705434 | controller | skipping: Conditional result was False 2026-03-01 22:01:48.718364 | 2026-03-01 22:01:48.718500 | TASK [ensure-pip : Install pip from source] 2026-03-01 22:01:48.744986 | controller | skipping: Conditional result was False 2026-03-01 22:01:48.758238 | 2026-03-01 22:01:48.758371 | TASK [ensure-pip : Probe for venv python full path] 2026-03-01 22:01:49.129592 | controller | /usr/bin/python3 2026-03-01 22:01:49.304591 | controller | ok: Runtime: 0:00:00.004607 2026-03-01 22:01:49.354824 | 2026-03-01 22:01:49.354965 | TASK [ensure-pip : Set host default] 2026-03-01 22:01:49.432172 | controller | ok 2026-03-01 22:01:49.444453 | 2026-03-01 22:01:49.444605 | TASK [ensure-pip : Set ensure_pip_virtualenv_command] 2026-03-01 22:01:49.515966 | controller | ok 2026-03-01 22:01:49.539468 | 2026-03-01 22:01:49.539613 | TASK [ensure-tox : Check if tox is installed] 2026-03-01 22:01:49.802066 | controller | /usr/bin/tox 2026-03-01 22:01:50.081717 | controller | ok: Runtime: 0:00:00.002986 2026-03-01 22:01:50.094930 | 2026-03-01 22:01:50.095072 | TASK [ensure-tox : Export preinstalled tox_exectuable] 2026-03-01 22:01:50.146737 | controller | ok 2026-03-01 22:01:50.164239 | 2026-03-01 22:01:50.164378 | TASK [ensure-tox : Create local venv] 2026-03-01 22:01:50.705631 | controller | skipping: Conditional result was False 2026-03-01 22:01:50.718857 | 2026-03-01 22:01:50.718999 | TASK [ensure-tox : Install tox to local venv] 2026-03-01 22:01:51.275397 | controller | skipping: Conditional result was False 2026-03-01 22:01:51.283986 | 2026-03-01 22:01:51.284077 | TASK [ensure-tox : Export installed tox_executable path] 2026-03-01 22:01:51.310767 | controller | skipping: Conditional result was False 2026-03-01 22:01:51.324187 | 2026-03-01 22:01:51.324330 | TASK [ensure-tox : Output tox version] 2026-03-01 22:01:51.690028 | controller | 3.28.0 imported from /usr/lib/python3.11/site-packages/tox/__init__.py 2026-03-01 22:01:51.883524 | controller | ok: Runtime: 0:00:00.139240 2026-03-01 22:01:51.896915 | 2026-03-01 22:01:51.897062 | TASK [ensure-tox : Make global symlink] 2026-03-01 22:01:51.924385 | controller | skipping: Conditional result was False 2026-03-01 22:01:51.948122 | 2026-03-01 22:01:51.948256 | TASK [Setup tox role] 2026-03-01 22:01:51.976635 | controller | ok 2026-03-01 22:01:52.020560 | 2026-03-01 22:01:52.020658 | TASK [tox : Check to see if the constraints file exists] 2026-03-01 22:01:52.055700 | controller | skipping: Conditional result was False 2026-03-01 22:01:52.062128 | 2026-03-01 22:01:52.062191 | TASK [tox : Fail if constraints file is missing] 2026-03-01 22:01:52.096230 | controller | skipping: Conditional result was False 2026-03-01 22:01:52.102487 | 2026-03-01 22:01:52.102558 | TASK [tox : Record file location] 2026-03-01 22:01:52.136638 | controller | skipping: Conditional result was False 2026-03-01 22:01:52.142718 | 2026-03-01 22:01:52.142794 | TASK [tox : Install tox siblings] 2026-03-01 22:01:52.183911 | controller | skipping: Conditional result was False 2026-03-01 22:01:52.190745 | 2026-03-01 22:01:52.190813 | TASK [tox : Emit tox command] 2026-03-01 22:01:52.247883 | /usr/bin/tox -evenv -vv --notest 2026-03-01 22:01:52.253382 | 2026-03-01 22:01:52.253445 | TASK [tox : Run tox] 2026-03-01 22:01:52.607542 | controller | using tox.ini: /home/zuul/src/github.com/ansible-network/releases/tox.ini (pid 2288) 2026-03-01 22:01:52.614473 | controller | using tox-3.28.0 from /usr/lib/python3.11/site-packages/tox/__init__.py (pid 2288) 2026-03-01 22:01:52.635375 | controller | skipping sdist step 2026-03-01 22:01:52.635393 | controller | venv uses /usr/bin/python3 2026-03-01 22:01:52.635409 | controller | venv start: getenv /home/zuul/src/github.com/ansible-network/releases/.tox/venv 2026-03-01 22:01:52.635781 | controller | venv cannot reuse: no previous config /home/zuul/src/github.com/ansible-network/releases/.tox/venv/.tox-config1 2026-03-01 22:01:52.635794 | controller | venv create: /home/zuul/src/github.com/ansible-network/releases/.tox/venv 2026-03-01 22:01:52.635805 | controller | setting PATH=/home/zuul/src/github.com/ansible-network/releases/.tox/venv/bin:/home/zuul/.local/bin:/home/zuul/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin 2026-03-01 22:01:52.635968 | controller | [2296] /home/zuul/src/github.com/ansible-network/releases/.tox$ /usr/bin/python3 -m virtualenv --no-download --python /usr/bin/python3 venv 2026-03-01 22:01:53.134903 | controller | created virtual environment CPython3.11.0.final.0-64 in 420ms 2026-03-01 22:01:53.156151 | controller | creator CPython3Posix(dest=/home/zuul/src/github.com/ansible-network/releases/.tox/venv, clear=False, no_vcs_ignore=False, global=False) 2026-03-01 22:01:53.156181 | controller | seeder FromAppData(extra_search_dir=/usr/share/python-wheels,download=False, pip=bundle, setuptools=bundle, wheel=bundle, via=copy, app_data_dir=/home/zuul/.local/share/virtualenv) 2026-03-01 22:01:53.156190 | controller | added seed packages: pip==22.2.2, setuptools==62.6.0, wheel==0.37.1 2026-03-01 22:01:53.156195 | controller | activators BashActivator,CShellActivator,FishActivator,NushellActivator,PowerShellActivator,PythonActivator 2026-03-01 22:01:53.156204 | controller | venv installdeps: -r/home/zuul/src/github.com/ansible-network/releases/requirements.txt, -r/home/zuul/src/github.com/ansible-network/releases/test-requirements.txt 2026-03-01 22:01:53.156538 | controller | setting PATH=/home/zuul/src/github.com/ansible-network/releases/.tox/venv/bin:/home/zuul/.local/bin:/home/zuul/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin 2026-03-01 22:01:53.156557 | controller | [2304] /home/zuul/src/github.com/ansible-network/releases$ /home/zuul/src/github.com/ansible-network/releases/.tox/venv/bin/pip install -r/home/zuul/src/github.com/ansible-network/releases/requirements.txt -r/home/zuul/src/github.com/ansible-network/releases/test-requirements.txt 2026-03-01 22:01:54.474933 | controller | Collecting ruamel.yaml 2026-03-01 22:01:54.550715 | controller | Downloading ruamel_yaml-0.19.1-py3-none-any.whl (118 kB) 2026-03-01 22:01:54.586412 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 118.1/118.1 kB 3.5 MB/s eta 0:00:00 2026-03-01 22:01:54.632180 | controller | Collecting pbr 2026-03-01 22:01:54.649077 | controller | Downloading pbr-7.0.3-py2.py3-none-any.whl (131 kB) 2026-03-01 22:01:54.665538 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 131.9/131.9 kB 8.8 MB/s eta 0:00:00 2026-03-01 22:01:54.700000 | controller | Collecting tweepy 2026-03-01 22:01:54.719618 | controller | Downloading tweepy-4.16.0-py3-none-any.whl (98 kB) 2026-03-01 22:01:54.728022 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 98.8/98.8 kB 13.4 MB/s eta 0:00:00 2026-03-01 22:01:54.785296 | controller | Collecting galaxy-importer 2026-03-01 22:01:54.803683 | controller | Downloading galaxy_importer-0.4.37-py3-none-any.whl (64 kB) 2026-03-01 22:01:54.812418 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 64.9/64.9 kB 8.1 MB/s eta 0:00:00 2026-03-01 22:01:54.862051 | controller | Collecting flake8 2026-03-01 22:01:54.878935 | controller | Downloading flake8-7.3.0-py2.py3-none-any.whl (57 kB) 2026-03-01 22:01:54.887226 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 57.9/57.9 kB 8.4 MB/s eta 0:00:00 2026-03-01 22:01:54.899972 | controller | Requirement already satisfied: setuptools in ./.tox/venv/lib/python3.11/site-packages (from pbr->-r /home/zuul/src/github.com/ansible-network/releases/requirements.txt (line 2)) (62.6.0) 2026-03-01 22:01:54.940062 | controller | Collecting oauthlib<4,>=3.2.0 2026-03-01 22:01:54.958509 | controller | Downloading oauthlib-3.3.1-py3-none-any.whl (160 kB) 2026-03-01 22:01:54.967654 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 160.1/160.1 kB 23.6 MB/s eta 0:00:00 2026-03-01 22:01:55.024229 | controller | Collecting requests<3,>=2.27.0 2026-03-01 22:01:55.054705 | controller | Downloading requests-2.32.5-py3-none-any.whl (64 kB) 2026-03-01 22:01:55.063219 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 64.7/64.7 kB 8.2 MB/s eta 0:00:00 2026-03-01 22:01:55.131753 | controller | Collecting requests-oauthlib<3,>=1.2.0 2026-03-01 22:01:55.148628 | controller | Downloading requests_oauthlib-2.0.0-py2.py3-none-any.whl (24 kB) 2026-03-01 22:06:57.310023 | controller | ERROR 2026-03-01 22:06:57.310170 | controller | { 2026-03-01 22:06:57.310199 | controller | "msg": "Data could not be sent to remote host \"162.253.55.207\". Make sure this host can be reached over ssh: ssh: connect to host 162.253.55.207 port 22: No route to host\r\n", 2026-03-01 22:06:57.310220 | controller | "unreachable": true 2026-03-01 22:06:57.310239 | controller | } unreachable 2026-03-01 22:06:57.311716 | 2026-03-01 22:06:57.311764 | PLAY RECAP 2026-03-01 22:06:57.311801 | controller | ok: 10 changed: 5 unreachable: 1 failed: 0 skipped: 15 rescued: 0 ignored: 0 2026-03-01 22:06:57.311820 | 2026-03-01 22:06:57.392724 | PRE-RUN END RESULT_UNREACHABLE: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-galaxy-importer/pre.yaml@master] 2026-03-01 22:06:57.393468 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master] 2026-03-01 22:06:57.913518 | 2026-03-01 22:06:57.913621 | PLAY [all:!appliance*] 2026-03-01 22:06:57.934879 | 2026-03-01 22:06:57.934952 | TASK [unregister the node] 2026-03-01 22:06:58.467311 | controller | skipping: Conditional result was False 2026-03-01 22:06:58.479145 | 2026-03-01 22:06:58.479298 | TASK [include_role : fetch-output] 2026-03-01 22:06:58.527920 | controller | ok 2026-03-01 22:06:58.563992 | 2026-03-01 22:06:58.564082 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-01 22:06:58.639807 | controller | skipping: Conditional result was False 2026-03-01 22:06:58.652145 | 2026-03-01 22:06:58.652280 | TASK [fetch-output : Set log path for single node] 2026-03-01 22:06:58.700166 | controller | ok 2026-03-01 22:06:58.711576 | 2026-03-01 22:06:58.711740 | LOOP [fetch-output : Ensure local output dirs] 2026-03-01 22:06:59.142023 | controller -> localhost | ok: "/var/lib/zuul/builds/9723edf559324bdebb48555b89c8709f/work/logs" 2026-03-01 22:06:59.370977 | controller -> localhost | changed: "/var/lib/zuul/builds/9723edf559324bdebb48555b89c8709f/work/artifacts" 2026-03-01 22:06:59.612212 | controller -> localhost | changed: "/var/lib/zuul/builds/9723edf559324bdebb48555b89c8709f/work/docs" 2026-03-01 22:06:59.631911 | 2026-03-01 22:06:59.632063 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-01 22:07:00.432815 | controller | ok 2026-03-01 22:07:00.433142 | controller | changed: All items complete 2026-03-01 22:07:00.433200 | 2026-03-01 22:07:00.984976 | controller | changed: .d..t...... ./ 2026-03-01 22:07:01.522176 | controller | changed: .d..t...... ./ 2026-03-01 22:07:01.555990 | 2026-03-01 22:07:01.556222 | TASK [include_role : fetch-output-openshift] 2026-03-01 22:07:01.584496 | controller | skipping: Conditional result was False 2026-03-01 22:07:01.598147 | 2026-03-01 22:07:01.598285 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-03-01 22:07:02.074507 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.015363 2026-03-01 22:07:02.370467 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.013320 2026-03-01 22:07:02.405776 | 2026-03-01 22:07:02.405889 | PLAY [localhost] 2026-03-01 22:07:02.418486 | 2026-03-01 22:07:02.418545 | TASK [Run Zuul manifest role] 2026-03-01 22:07:02.437707 | localhost | ok 2026-03-01 22:07:02.450286 | 2026-03-01 22:07:02.450351 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-01 22:07:02.853640 | localhost | changed 2026-03-01 22:07:02.858472 | 2026-03-01 22:07:02.858534 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-01 22:07:02.903215 | localhost | ok 2026-03-01 22:07:02.920020 | 2026-03-01 22:07:02.920119 | TASK [Set zuul-log-path fact] 2026-03-01 22:07:02.942600 | localhost | ok 2026-03-01 22:07:02.961028 | 2026-03-01 22:07:02.961112 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-01 22:07:03.001332 | localhost | ok 2026-03-01 22:07:03.011844 | 2026-03-01 22:07:03.011923 | LOOP [Set zuul_log_targets (Swift with random Rackspace region)] 2026-03-01 22:07:03.054892 | localhost | ok: 2026-03-01 22:07:03.055350 | localhost | { 2026-03-01 22:07:03.055408 | localhost | "auth": { 2026-03-01 22:07:03.055448 | localhost | "password": "IonWCwcuOFib&&<}wp^:[2G/", 2026-03-01 22:07:03.055485 | localhost | "username": "9LF91O0RK7JU" 2026-03-01 22:07:03.055532 | localhost | }, 2026-03-01 22:07:03.055567 | localhost | "profile": "rackspace", 2026-03-01 22:07:03.055603 | localhost | "region_name": "IAD" 2026-03-01 22:07:03.055638 | localhost | } 2026-03-01 22:07:03.055735 | localhost | changed: All items complete 2026-03-01 22:07:03.055789 | 2026-03-01 22:07:03.064458 | 2026-03-01 22:07:03.064575 | TASK [Run upload-logs-failover role (S3 then Swift)] 2026-03-01 22:07:03.085925 | localhost | Output suppressed because no_log was given 2026-03-01 22:07:03.102230 | 2026-03-01 22:07:03.102315 | TASK [upload-logs-failover : Initialize control vars] 2026-03-01 22:07:03.165360 | localhost | ok 2026-03-01 22:07:03.171217 | 2026-03-01 22:07:03.171278 | LOOP [upload-logs-failover : Perform log upload] 2026-03-01 22:07:03.216526 | localhost | Output suppressed because no_log was given 2026-03-01 22:07:03.223025 | localhost | included: /var/lib/zuul/builds/9723edf559324bdebb48555b89c8709f/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/upload-logs-failover/tasks/upload.yaml 2026-03-01 22:07:03.229743 | 2026-03-01 22:07:03.229806 | LOOP [upload-logs-failover : Unpack vars for swift upload] 2026-03-01 22:07:03.337600 | localhost | Output suppressed because no_log was given 2026-03-01 22:07:03.343321 | 2026-03-01 22:07:03.343387 | TASK [Upload logs to swift] 2026-03-01 22:07:03.371415 | localhost | ok 2026-03-01 22:07:03.396562 | 2026-03-01 22:07:03.396619 | TASK [Set zuul-log-path fact] 2026-03-01 22:07:03.430525 | localhost | skipping: Conditional result was False 2026-03-01 22:07:03.435622 | 2026-03-01 22:07:03.435696 | TASK [upload-logs-swift : Ensure logs are readable before uploading] 2026-03-01 22:07:03.723147 | localhost -> localhost | ok: Runtime: 0:00:00.008902 2026-03-01 22:07:03.728778 | 2026-03-01 22:07:03.728839 | TASK [upload-logs-swift : Upload logs to swift]