2025-09-24 20:25:50.670443 | Job console starting...
2025-09-24 20:25:50.684350 | Updating repositories
2025-09-24 20:25:50.743273 | Preparing job workspace
2025-09-24 20:25:55.241235 | Running Ansible setup...
2025-09-24 20:26:00.125018 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master]
2025-09-24 20:26:00.712148 | 
2025-09-24 20:26:00.712319 | PLAY [localhost]
2025-09-24 20:26:00.720567 | 
2025-09-24 20:26:00.720640 | TASK [Gathering Facts]
2025-09-24 20:26:01.676989 | localhost | ok
2025-09-24 20:26:01.704050 | 
2025-09-24 20:26:01.704154 | TASK [Setup log path fact]
2025-09-24 20:26:01.725806 | localhost | ok
2025-09-24 20:26:01.742562 | 
2025-09-24 20:26:01.742654 | TASK [set-zuul-log-path-fact : Set log path for a build]
2025-09-24 20:26:01.782144 | localhost | ok
2025-09-24 20:26:01.792443 | 
2025-09-24 20:26:01.792530 | TASK [emit-job-header : Print job information]
2025-09-24 20:26:01.826899 | # Job Information
2025-09-24 20:26:01.827134 | Ansible Version: 2.15.12
2025-09-24 20:26:01.827204 | Job: ansible-galaxy-importer
2025-09-24 20:26:01.827252 | Pipeline: gate
2025-09-24 20:26:01.827297 | Executor: ze02.softwarefactory-project.io
2025-09-24 20:26:01.827340 | Triggered by: https://github.com/ansible-collections/kubernetes.core/pull/971
2025-09-24 20:26:01.827393 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/26c/ansible/26ce0c52ad6a4f0ca824de8c0a4ef0c2/
2025-09-24 20:26:01.827439 | Event ID: be9e3450-9983-11f0-8781-3272edb87b42
2025-09-24 20:26:01.835930 | 
2025-09-24 20:26:01.836068 | LOOP [emit-job-header : Print node information]
2025-09-24 20:26:01.961418 | localhost | ok:
2025-09-24 20:26:01.961845 | localhost | # Node Information
2025-09-24 20:26:01.961908 | localhost | Inventory Hostname: controller
2025-09-24 20:26:01.961952 | localhost | Hostname: np0005450131
2025-09-24 20:26:01.961993 | localhost | Username: zuul
2025-09-24 20:26:01.962045 | localhost | Distro: Fedora 37
2025-09-24 20:26:01.962087 | localhost | Provider: ansible-vexxhost-ca-ymq-1
2025-09-24 20:26:01.962125 | localhost | Region: ca-ymq-1
2025-09-24 20:26:01.962162 | localhost | Label: ansible-fedora-37-1vcpu
2025-09-24 20:26:01.962198 | localhost | Product Name: OpenStack Nova
2025-09-24 20:26:01.962234 | localhost | Interface IP: 199.204.45.99
2025-09-24 20:26:01.979414 | 
2025-09-24 20:26:01.979578 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2025-09-24 20:26:02.363532 | localhost -> localhost | changed
2025-09-24 20:26:02.369087 | 
2025-09-24 20:26:02.369151 | TASK [log-inventory : Copy ansible inventory to logs dir]
2025-09-24 20:26:03.188602 | localhost -> localhost | changed
2025-09-24 20:26:03.207792 | 
2025-09-24 20:26:03.207847 | PLAY [all:!appliance*]
2025-09-24 20:26:03.223236 | 
2025-09-24 20:26:03.223295 | TASK [include_role : start-zuul-console]
2025-09-24 20:26:03.242911 | controller | ok
2025-09-24 20:26:03.255176 | 
2025-09-24 20:26:03.255236 | TASK [start-zuul-console : Start zuul_console daemon.]
2025-09-24 20:26:03.667360 | controller | ok
2025-09-24 20:26:03.689875 | 
2025-09-24 20:26:03.690009 | TASK [use-our-mirror : Retrieve the IP address]
2025-09-24 20:26:04.928128 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found
2025-09-24 20:26:04.941569 | 
2025-09-24 20:26:04.941746 | TASK [use-our-mirror : Ensure the registry service is running on the mirror]
2025-09-24 20:26:05.492431 | controller | skipping: Conditional result was False
2025-09-24 20:26:05.505139 | 
2025-09-24 20:26:05.505272 | TASK [use-our-mirror : Write the IP in /etc/hosts]
2025-09-24 20:26:05.532010 | controller | skipping: Conditional result was False
2025-09-24 20:26:05.545583 | 
2025-09-24 20:26:05.545765 | TASK [use-our-mirror : Create the podman configuration directory]
2025-09-24 20:26:05.572354 | controller | skipping: Conditional result was False
2025-09-24 20:26:05.585291 | 
2025-09-24 20:26:05.585431 | TASK [use-our-mirror : Copy the podman configuration]
2025-09-24 20:26:05.611930 | controller | skipping: Conditional result was False
2025-09-24 20:26:05.624941 | 
2025-09-24 20:26:05.625081 | TASK [use-our-mirror : Copy the Yum configuration (main)]
2025-09-24 20:26:05.652127 | controller | skipping: Conditional result was False
2025-09-24 20:26:05.666692 | 
2025-09-24 20:26:05.666833 | TASK [use-our-mirror : Copy the Yum configuration (update)]
2025-09-24 20:26:05.693122 | controller | skipping: Conditional result was False
2025-09-24 20:26:05.716312 | 
2025-09-24 20:26:05.716439 | TASK [Disable Fedora Modular]
2025-09-24 20:26:05.977520 | controller | changed
2025-09-24 20:26:05.989152 | 
2025-09-24 20:26:05.989271 | TASK [Enable EPEL]
2025-09-24 20:26:06.016111 | controller | skipping: Conditional result was False
2025-09-24 20:26:06.028861 | 
2025-09-24 20:26:06.028992 | TASK [Register the RHEL node]
2025-09-24 20:26:06.588888 | 
2025-09-24 20:26:06.589154 | TASK [Show the subscription-manager status]
2025-09-24 20:26:07.169245 | controller | skipping: Conditional result was False
2025-09-24 20:26:07.182236 | 
2025-09-24 20:26:07.182371 | TASK [Enable EPEL on RHEL]
2025-09-24 20:26:07.737909 | controller | skipping: Conditional result was False
2025-09-24 20:26:07.750528 | 
2025-09-24 20:26:07.750703 | TASK [Install git and tox]
2025-09-24 20:27:26.933471 | controller | changed
2025-09-24 20:27:26.946940 | 
2025-09-24 20:27:26.947072 | TASK [include_role : prepare-workspace]
2025-09-24 20:27:26.984188 | controller | ok
2025-09-24 20:27:27.021188 | 
2025-09-24 20:27:27.021316 | TASK [prepare-workspace : Start zuul_console daemon.]
2025-09-24 20:27:27.270462 | controller | ok
2025-09-24 20:27:27.283426 | 
2025-09-24 20:27:27.283561 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2025-09-24 20:27:28.488289 | controller | Output suppressed because no_log was given
2025-09-24 20:27:28.509702 | 
2025-09-24 20:27:28.509824 | TASK [include_role : prepare-workspace-openshift]
2025-09-24 20:27:28.536194 | controller | skipping: Conditional result was False
2025-09-24 20:27:28.566595 | 
2025-09-24 20:27:28.566686 | PLAY [all:!appliance]
2025-09-24 20:27:28.588193 | 
2025-09-24 20:27:28.588276 | TASK [Run add-build-sshkey role (RSA)]
2025-09-24 20:27:28.620561 | controller | ok
2025-09-24 20:27:28.641741 | 
2025-09-24 20:27:28.641831 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2025-09-24 20:27:28.921206 | controller -> localhost | ok
2025-09-24 20:27:28.934039 | 
2025-09-24 20:27:28.934172 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2025-09-24 20:27:28.972464 | controller | ok
2025-09-24 20:27:28.999957 | controller | included: /var/lib/zuul/builds/26ce0c52ad6a4f0ca824de8c0a4ef0c2/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2025-09-24 20:27:29.008776 | 
2025-09-24 20:27:29.008858 | TASK [add-build-sshkey : Create Temp SSH key]
2025-09-24 20:27:29.543287 | controller -> localhost | Generating public/private rsa key pair.
2025-09-24 20:27:29.543549 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/26ce0c52ad6a4f0ca824de8c0a4ef0c2/work/26ce0c52ad6a4f0ca824de8c0a4ef0c2_id_rsa.
2025-09-24 20:27:29.543610 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/26ce0c52ad6a4f0ca824de8c0a4ef0c2/work/26ce0c52ad6a4f0ca824de8c0a4ef0c2_id_rsa.pub.
2025-09-24 20:27:29.543656 | controller -> localhost | The key fingerprint is:
2025-09-24 20:27:29.543739 | controller -> localhost | SHA256:39o7o6TvXdR3/hnCgpxjPDowM+amkUG7zvJhRHm25ds zuul-build-sshkey
2025-09-24 20:27:29.543783 | controller -> localhost | The key's randomart image is:
2025-09-24 20:27:29.543824 | controller -> localhost | +---[RSA 2048]----+
2025-09-24 20:27:29.543864 | controller -> localhost | |                 |
2025-09-24 20:27:29.543905 | controller -> localhost | |    .            |
2025-09-24 20:27:29.543945 | controller -> localhost | |   + o .         |
2025-09-24 20:27:29.543983 | controller -> localhost | |  o + +        . |
2025-09-24 20:27:29.544022 | controller -> localhost | |   + . .S     . +|
2025-09-24 20:27:29.544075 | controller -> localhost | |  . +*  =.o... .o|
2025-09-24 20:27:29.544120 | controller -> localhost | |   *o =. Eo..o...|
2025-09-24 20:27:29.544162 | controller -> localhost | | .+ oo .ooo++.. +|
2025-09-24 20:27:29.544203 | controller -> localhost | |  o=o  .oo=.++ ..|
2025-09-24 20:27:29.544247 | controller -> localhost | +----[SHA256]-----+
2025-09-24 20:27:29.544325 | controller -> localhost | ok: Runtime: 0:00:00.089923
2025-09-24 20:27:29.556496 | 
2025-09-24 20:27:29.556622 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2025-09-24 20:27:29.584722 | controller | ok
2025-09-24 20:27:29.605046 | controller | included: /var/lib/zuul/builds/26ce0c52ad6a4f0ca824de8c0a4ef0c2/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2025-09-24 20:27:29.619175 | 
2025-09-24 20:27:29.619257 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2025-09-24 20:27:29.633646 | controller | skipping: Conditional result was False
2025-09-24 20:27:29.642412 | 
2025-09-24 20:27:29.642498 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2025-09-24 20:27:30.056889 | controller | changed
2025-09-24 20:27:30.068950 | 
2025-09-24 20:27:30.069078 | TASK [add-build-sshkey : Make sure user has a .ssh]
2025-09-24 20:27:30.352146 | controller | ok
2025-09-24 20:27:30.364598 | 
2025-09-24 20:27:30.364759 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2025-09-24 20:27:31.087604 | controller | changed
2025-09-24 20:27:31.099736 | 
2025-09-24 20:27:31.099871 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2025-09-24 20:27:31.811961 | controller | changed
2025-09-24 20:27:31.826120 | 
2025-09-24 20:27:31.826257 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2025-09-24 20:27:31.854564 | controller | skipping: Conditional result was False
2025-09-24 20:27:31.869112 | 
2025-09-24 20:27:31.869251 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2025-09-24 20:27:32.254781 | controller -> localhost | changed
2025-09-24 20:27:32.278594 | 
2025-09-24 20:27:32.278781 | TASK [add-build-sshkey : Add back temp key]
2025-09-24 20:27:32.580869 | controller -> localhost | Identity added: /var/lib/zuul/builds/26ce0c52ad6a4f0ca824de8c0a4ef0c2/work/26ce0c52ad6a4f0ca824de8c0a4ef0c2_id_rsa (zuul-build-sshkey)
2025-09-24 20:27:32.581332 | controller -> localhost | ok: Runtime: 0:00:00.013072
2025-09-24 20:27:32.594625 | 
2025-09-24 20:27:32.594796 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2025-09-24 20:27:32.928512 | controller | ok
2025-09-24 20:27:32.940286 | 
2025-09-24 20:27:32.940433 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2025-09-24 20:27:32.977946 | controller | skipping: Conditional result was False
2025-09-24 20:27:33.003745 | 
2025-09-24 20:27:33.003884 | TASK [Run add-build-sshkey role (ECDSA)]
2025-09-24 20:27:33.041703 | controller | ok
2025-09-24 20:27:33.071252 | 
2025-09-24 20:27:33.071338 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2025-09-24 20:27:33.339717 | controller -> localhost | ok
2025-09-24 20:27:33.349699 | 
2025-09-24 20:27:33.349785 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2025-09-24 20:27:33.382356 | controller | ok
2025-09-24 20:27:33.396595 | controller | included: /var/lib/zuul/builds/26ce0c52ad6a4f0ca824de8c0a4ef0c2/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2025-09-24 20:27:33.404651 | 
2025-09-24 20:27:33.404765 | TASK [add-build-sshkey : Create Temp SSH key]
2025-09-24 20:27:33.724789 | controller -> localhost | Generating public/private ecdsa key pair.
2025-09-24 20:27:33.725005 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/26ce0c52ad6a4f0ca824de8c0a4ef0c2/work/26ce0c52ad6a4f0ca824de8c0a4ef0c2_id_ecdsa.
2025-09-24 20:27:33.725045 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/26ce0c52ad6a4f0ca824de8c0a4ef0c2/work/26ce0c52ad6a4f0ca824de8c0a4ef0c2_id_ecdsa.pub.
2025-09-24 20:27:33.725083 | controller -> localhost | The key fingerprint is:
2025-09-24 20:27:33.725111 | controller -> localhost | SHA256:XdUxQ4HAfnDd3iJHLRQxRl7DUQEY6rS0v5T2KbUdcII zuul-build-sshkey
2025-09-24 20:27:33.725138 | controller -> localhost | The key's randomart image is:
2025-09-24 20:27:33.725164 | controller -> localhost | +---[ECDSA 521]---+
2025-09-24 20:27:33.725189 | controller -> localhost | |          .o++##X|
2025-09-24 20:27:33.725214 | controller -> localhost | |          .+ *o=B|
2025-09-24 20:27:33.725239 | controller -> localhost | |         +. =..o.|
2025-09-24 20:27:33.725263 | controller -> localhost | |        +.oE.+o.o|
2025-09-24 20:27:33.725287 | controller -> localhost | |        S+. .o+. |
2025-09-24 20:27:33.725311 | controller -> localhost | |          . .. . |
2025-09-24 20:27:33.725335 | controller -> localhost | |           =. o .|
2025-09-24 20:27:33.725359 | controller -> localhost | |          o.o... |
2025-09-24 20:27:33.725382 | controller -> localhost | |           ..o   |
2025-09-24 20:27:33.725406 | controller -> localhost | +----[SHA256]-----+
2025-09-24 20:27:33.725469 | controller -> localhost | ok: Runtime: 0:00:00.013507
2025-09-24 20:27:33.734442 | 
2025-09-24 20:27:33.734525 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2025-09-24 20:27:33.769236 | controller | ok
2025-09-24 20:27:33.784981 | controller | included: /var/lib/zuul/builds/26ce0c52ad6a4f0ca824de8c0a4ef0c2/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2025-09-24 20:27:33.799065 | 
2025-09-24 20:27:33.799149 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2025-09-24 20:27:33.823584 | controller | skipping: Conditional result was False
2025-09-24 20:27:33.832621 | 
2025-09-24 20:27:33.832743 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2025-09-24 20:27:34.137590 | controller | changed
2025-09-24 20:27:34.145296 | 
2025-09-24 20:27:34.145378 | TASK [add-build-sshkey : Make sure user has a .ssh]
2025-09-24 20:27:34.386512 | controller | ok
2025-09-24 20:27:34.399120 | 
2025-09-24 20:27:34.399253 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2025-09-24 20:27:35.087936 | controller | changed
2025-09-24 20:27:35.100180 | 
2025-09-24 20:27:35.100313 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2025-09-24 20:27:35.771970 | controller | changed
2025-09-24 20:27:35.784276 | 
2025-09-24 20:27:35.784401 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2025-09-24 20:27:35.811579 | controller | skipping: Conditional result was False
2025-09-24 20:27:35.825422 | 
2025-09-24 20:27:35.825556 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2025-09-24 20:27:36.116828 | controller -> localhost | changed
2025-09-24 20:27:36.140633 | 
2025-09-24 20:27:36.140829 | TASK [add-build-sshkey : Add back temp key]
2025-09-24 20:27:36.462705 | controller -> localhost | Identity added: /var/lib/zuul/builds/26ce0c52ad6a4f0ca824de8c0a4ef0c2/work/26ce0c52ad6a4f0ca824de8c0a4ef0c2_id_ecdsa (zuul-build-sshkey)
2025-09-24 20:27:36.463054 | controller -> localhost | ok: Runtime: 0:00:00.013159
2025-09-24 20:27:36.478890 | 
2025-09-24 20:27:36.479019 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2025-09-24 20:27:36.719915 | controller | ok
2025-09-24 20:27:36.731539 | 
2025-09-24 20:27:36.731727 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2025-09-24 20:27:36.768646 | controller | skipping: Conditional result was False
2025-09-24 20:27:36.792770 | 
2025-09-24 20:27:36.792902 | TASK [include_role : remove-zuul-sshkey]
2025-09-24 20:27:36.819358 | controller | skipping: Conditional result was False
2025-09-24 20:27:36.832518 | 
2025-09-24 20:27:36.832708 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2025-09-24 20:27:37.095260 | controller | ok: "logs"
2025-09-24 20:27:37.095946 | controller | ok: All items complete
2025-09-24 20:27:37.096036 | 
2025-09-24 20:27:37.288716 | controller | ok: "artifacts"
2025-09-24 20:27:37.500599 | controller | ok: "docs"
2025-09-24 20:27:37.516033 | 
2025-09-24 20:27:37.516175 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2025-09-24 20:27:37.774148 | controller | changed: "logs"
2025-09-24 20:27:38.037770 | controller | changed: "artifacts"
2025-09-24 20:27:38.218733 | controller | changed: "docs"
2025-09-24 20:27:38.255316 | 
2025-09-24 20:27:38.255420 | PLAY RECAP
2025-09-24 20:27:38.255461 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0
2025-09-24 20:27:38.255486 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2025-09-24 20:27:38.255504 | 
2025-09-24 20:27:38.359605 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master]
2025-09-24 20:27:38.360998 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-galaxy-importer/pre.yaml@master]
2025-09-24 20:27:38.942411 | 
2025-09-24 20:27:38.942522 | PLAY [all]
2025-09-24 20:27:38.962479 | 
2025-09-24 20:27:38.962551 | TASK [Setup ensure-tox role]
2025-09-24 20:27:38.982325 | controller | ok
2025-09-24 20:27:39.003755 | 
2025-09-24 20:27:39.003826 | TASK [Install pip]
2025-09-24 20:27:39.023077 | controller | ok
2025-09-24 20:27:39.043586 | 
2025-09-24 20:27:39.043650 | TASK [ensure-pip : Check if pip is installed]
2025-09-24 20:27:39.454564 | controller | /usr/bin/pip3
2025-09-24 20:27:39.470034 | controller | /usr/bin/python3: No module named wheel
2025-09-24 20:27:39.575465 | controller | ok: Runtime: 0:00:00.025724
2025-09-24 20:27:39.588124 | 
2025-09-24 20:27:39.588297 | LOOP [ensure-pip : Install pip from packages]
2025-09-24 20:27:39.636572 | controller | ok: "/var/lib/zuul/builds/26ce0c52ad6a4f0ca824de8c0a4ef0c2/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/RedHat.yaml"
2025-09-24 20:27:39.655609 | controller | included: /var/lib/zuul/builds/26ce0c52ad6a4f0ca824de8c0a4ef0c2/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/RedHat.yaml
2025-09-24 20:27:39.677028 | 
2025-09-24 20:27:39.677162 | TASK [ensure-pip : Install Python 3 pip]
2025-09-24 20:27:44.493047 | controller | changed
2025-09-24 20:27:44.505273 | 
2025-09-24 20:27:44.505403 | TASK [ensure-pip : Check for EPEL repository]
2025-09-24 20:27:44.522432 | controller | skipping: Conditional result was False
2025-09-24 20:27:44.535588 | 
2025-09-24 20:27:44.535757 | TASK [ensure-pip : Fail with instructions when EPEL is not installed]
2025-09-24 20:27:44.553004 | controller | skipping: Conditional result was False
2025-09-24 20:27:44.567244 | 
2025-09-24 20:27:44.567389 | TASK [ensure-pip : Install Python 2 pip]
2025-09-24 20:27:44.584014 | controller | skipping: Conditional result was False
2025-09-24 20:27:44.597586 | 
2025-09-24 20:27:44.597768 | TASK [ensure-pip : Ensure setuptools]
2025-09-24 20:27:44.614562 | controller | skipping: Conditional result was False
2025-09-24 20:27:44.631106 | 
2025-09-24 20:27:44.631238 | TASK [ensure-pip : Check for ensurepip module]
2025-09-24 20:27:45.175726 | controller | skipping: Conditional result was False
2025-09-24 20:27:45.189220 | 
2025-09-24 20:27:45.189392 | TASK [ensure-pip : Ensure python3-venv]
2025-09-24 20:27:45.216019 | controller | skipping: Conditional result was False
2025-09-24 20:27:45.229384 | 
2025-09-24 20:27:45.229513 | TASK [ensure-pip : Install pip from source]
2025-09-24 20:27:45.255829 | controller | skipping: Conditional result was False
2025-09-24 20:27:45.268385 | 
2025-09-24 20:27:45.268523 | TASK [ensure-pip : Probe for venv python full path]
2025-09-24 20:27:45.628545 | controller | /usr/bin/python3
2025-09-24 20:27:45.817010 | controller | ok: Runtime: 0:00:00.003142
2025-09-24 20:27:45.829415 | 
2025-09-24 20:27:45.829542 | TASK [ensure-pip : Set host default]
2025-09-24 20:27:45.907826 | controller | ok
2025-09-24 20:27:45.919088 | 
2025-09-24 20:27:45.919232 | TASK [ensure-pip : Set ensure_pip_virtualenv_command]
2025-09-24 20:27:45.989909 | controller | ok
2025-09-24 20:27:46.012630 | 
2025-09-24 20:27:46.012789 | TASK [ensure-tox : Check if tox is installed]
2025-09-24 20:27:46.264291 | controller | /usr/bin/tox
2025-09-24 20:27:46.554218 | controller | ok: Runtime: 0:00:00.003066
2025-09-24 20:27:46.567170 | 
2025-09-24 20:27:46.567330 | TASK [ensure-tox : Export preinstalled tox_exectuable]
2025-09-24 20:27:46.616955 | controller | ok
2025-09-24 20:27:46.628117 | 
2025-09-24 20:27:46.628242 | TASK [ensure-tox : Create local venv]
2025-09-24 20:27:47.176160 | controller | skipping: Conditional result was False
2025-09-24 20:27:47.189405 | 
2025-09-24 20:27:47.189562 | TASK [ensure-tox : Install tox to local venv]
2025-09-24 20:27:47.748423 | controller | skipping: Conditional result was False
2025-09-24 20:27:47.761991 | 
2025-09-24 20:27:47.762137 | TASK [ensure-tox : Export installed tox_executable path]
2025-09-24 20:27:47.789090 | controller | skipping: Conditional result was False
2025-09-24 20:27:47.801726 | 
2025-09-24 20:27:47.801859 | TASK [ensure-tox : Output tox version]
2025-09-24 20:27:48.179383 | controller | 3.28.0 imported from /usr/lib/python3.11/site-packages/tox/__init__.py
2025-09-24 20:27:48.354736 | controller | ok: Runtime: 0:00:00.141397
2025-09-24 20:27:48.366941 | 
2025-09-24 20:27:48.367072 | TASK [ensure-tox : Make global symlink]
2025-09-24 20:27:48.393979 | controller | skipping: Conditional result was False
2025-09-24 20:27:48.416844 | 
2025-09-24 20:27:48.416974 | TASK [Setup tox role]
2025-09-24 20:27:48.445034 | controller | ok
2025-09-24 20:27:48.488581 | 
2025-09-24 20:27:48.488690 | TASK [tox : Check to see if the constraints file exists]
2025-09-24 20:27:48.524111 | controller | skipping: Conditional result was False
2025-09-24 20:27:48.539861 | 
2025-09-24 20:27:48.539985 | TASK [tox : Fail if constraints file is missing]
2025-09-24 20:27:48.587740 | controller | skipping: Conditional result was False
2025-09-24 20:27:48.614464 | 
2025-09-24 20:27:48.614920 | TASK [tox : Record file location]
2025-09-24 20:27:48.664160 | controller | skipping: Conditional result was False
2025-09-24 20:27:48.677990 | 
2025-09-24 20:27:48.678165 | TASK [tox : Install tox siblings]
2025-09-24 20:27:48.704906 | controller | skipping: Conditional result was False
2025-09-24 20:27:48.721187 | 
2025-09-24 20:27:48.721336 | TASK [tox : Emit tox command]
2025-09-24 20:27:48.779619 | /usr/bin/tox   -evenv  -vv --notest
2025-09-24 20:27:48.791547 | 
2025-09-24 20:27:48.791741 | TASK [tox : Run tox]
2025-09-24 20:27:49.178818 | controller | using tox.ini: /home/zuul/src/github.com/ansible-network/releases/tox.ini (pid 2310)
2025-09-24 20:27:49.186727 | controller | using tox-3.28.0 from /usr/lib/python3.11/site-packages/tox/__init__.py (pid 2310)
2025-09-24 20:27:49.214190 | controller | skipping sdist step
2025-09-24 20:27:49.214213 | controller | venv uses /usr/bin/python3
2025-09-24 20:27:49.214232 | controller | venv start: getenv /home/zuul/src/github.com/ansible-network/releases/.tox/venv
2025-09-24 20:27:49.214833 | controller | venv cannot reuse: no previous config /home/zuul/src/github.com/ansible-network/releases/.tox/venv/.tox-config1
2025-09-24 20:27:49.215062 | controller | venv create: /home/zuul/src/github.com/ansible-network/releases/.tox/venv
2025-09-24 20:27:49.215078 | 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
2025-09-24 20:27:49.215089 | controller | [2318] /home/zuul/src/github.com/ansible-network/releases/.tox$ /usr/bin/python3 -m virtualenv --no-download --python /usr/bin/python3 venv
2025-09-24 20:27:49.695642 | controller | created virtual environment CPython3.11.0.final.0-64 in 401ms
2025-09-24 20:27:49.711188 | controller |   creator CPython3Posix(dest=/home/zuul/src/github.com/ansible-network/releases/.tox/venv, clear=False, no_vcs_ignore=False, global=False)
2025-09-24 20:27:49.711219 | 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)
2025-09-24 20:27:49.711227 | controller |     added seed packages: pip==22.2.2, setuptools==62.6.0, wheel==0.37.1
2025-09-24 20:27:49.711232 | controller |   activators BashActivator,CShellActivator,FishActivator,NushellActivator,PowerShellActivator,PythonActivator
2025-09-24 20:27:49.711242 | 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
2025-09-24 20:27:49.711669 | 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
2025-09-24 20:27:49.711912 | controller | [2326] /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
2025-09-24 20:27:51.051398 | controller | Collecting ruamel.yaml
2025-09-24 20:27:51.085476 | controller |   Downloading ruamel.yaml-0.18.15-py3-none-any.whl (119 kB)
2025-09-24 20:27:51.107019 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 119.7/119.7 kB 5.9 MB/s eta 0:00:00
2025-09-24 20:27:51.150810 | controller | Collecting pbr
2025-09-24 20:27:51.154332 | controller |   Downloading pbr-7.0.1-py2.py3-none-any.whl (126 kB)
2025-09-24 20:27:51.164277 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 126.1/126.1 kB 15.1 MB/s eta 0:00:00
2025-09-24 20:27:51.211866 | controller | Collecting tweepy
2025-09-24 20:27:51.216894 | controller |   Downloading tweepy-4.16.0-py3-none-any.whl (98 kB)
2025-09-24 20:27:51.223741 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 98.8/98.8 kB 22.3 MB/s eta 0:00:00
2025-09-24 20:27:51.282822 | controller | Collecting galaxy-importer
2025-09-24 20:27:51.287592 | controller |   Downloading galaxy_importer-0.4.33-py3-none-any.whl (64 kB)
2025-09-24 20:27:51.295987 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 64.3/64.3 kB 9.0 MB/s eta 0:00:00
2025-09-24 20:27:51.417062 | controller | Collecting flake8
2025-09-24 20:27:51.421425 | controller |   Downloading flake8-7.3.0-py2.py3-none-any.whl (57 kB)
2025-09-24 20:27:51.430140 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 57.9/57.9 kB 7.4 MB/s eta 0:00:00
2025-09-24 20:27:51.530442 | controller | Collecting ruamel.yaml.clib>=0.2.7
2025-09-24 20:27:51.538576 | controller |   Downloading ruamel.yaml.clib-0.2.14-cp311-cp311-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (738 kB)
2025-09-24 20:27:51.561714 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 738.1/738.1 kB 36.7 MB/s eta 0:00:00
2025-09-24 20:27:51.567019 | 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)
2025-09-24 20:27:51.608729 | controller | Collecting oauthlib<4,>=3.2.0
2025-09-24 20:27:51.613022 | controller |   Downloading oauthlib-3.3.1-py3-none-any.whl (160 kB)
2025-09-24 20:27:51.623423 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 160.1/160.1 kB 18.4 MB/s eta 0:00:00
2025-09-24 20:27:51.684521 | controller | Collecting requests<3,>=2.27.0
2025-09-24 20:27:51.687737 | controller |   Downloading requests-2.32.5-py3-none-any.whl (64 kB)
2025-09-24 20:27:51.695884 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 64.7/64.7 kB 9.4 MB/s eta 0:00:00
2025-09-24 20:27:51.727901 | controller | Collecting requests-oauthlib<3,>=1.2.0
2025-09-24 20:27:51.731328 | controller |   Downloading requests_oauthlib-2.0.0-py2.py3-none-any.whl (24 kB)
2025-09-24 20:32:27.855105 | [Zuul] Log Stream did not terminate
2025-09-24 20:32:27.855493 | controller | ERROR
2025-09-24 20:32:27.855615 | controller | {
2025-09-24 20:32:27.855647 | controller |   "msg": "Data could not be sent to remote host \"199.204.45.99\". Make sure this host can be reached over ssh: ssh: connect to host 199.204.45.99 port 22: No route to host\r\n",
2025-09-24 20:32:27.855747 | controller |   "unreachable": true
2025-09-24 20:32:27.855768 | controller | }
unreachable
2025-09-24 20:32:27.857775 | 
2025-09-24 20:32:27.857825 | PLAY RECAP
2025-09-24 20:32:27.857869 | controller | ok: 10 changed: 5 unreachable: 1 failed: 0 skipped: 15 rescued: 0 ignored: 0
2025-09-24 20:32:27.857889 | 
2025-09-24 20:32:28.012486 | PRE-RUN END RESULT_UNREACHABLE: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-galaxy-importer/pre.yaml@master]
2025-09-24 20:32:28.014223 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master]
2025-09-24 20:32:28.630722 | 
2025-09-24 20:32:28.630848 | PLAY [all:!appliance*]
2025-09-24 20:32:28.660115 | 
2025-09-24 20:32:28.660189 | TASK [unregister the node]
2025-09-24 20:32:31.018480 | [controller] Waiting on logger
2025-09-24 20:32:52.658249 | controller | skipping: Conditional result was False
2025-09-24 20:32:52.670765 | 
2025-09-24 20:32:52.670929 | TASK [include_role : fetch-output]
2025-09-24 20:32:52.720925 | controller | ok
2025-09-24 20:32:52.759798 | 
2025-09-24 20:32:52.760014 | TASK [fetch-output : Set log path for multiple nodes]
2025-09-24 20:32:52.826866 | controller | skipping: Conditional result was False
2025-09-24 20:32:52.839642 | 
2025-09-24 20:32:52.839810 | TASK [fetch-output : Set log path for single node]
2025-09-24 20:32:52.895009 | controller | ok
2025-09-24 20:32:52.902456 | 
2025-09-24 20:32:52.902561 | LOOP [fetch-output : Ensure local output dirs]
2025-09-24 20:32:53.350568 | controller -> localhost | ok: "/var/lib/zuul/builds/26ce0c52ad6a4f0ca824de8c0a4ef0c2/work/logs"
2025-09-24 20:32:53.600941 | controller -> localhost | changed: "/var/lib/zuul/builds/26ce0c52ad6a4f0ca824de8c0a4ef0c2/work/artifacts"
2025-09-24 20:32:53.816350 | controller -> localhost | changed: "/var/lib/zuul/builds/26ce0c52ad6a4f0ca824de8c0a4ef0c2/work/docs"
2025-09-24 20:32:53.831069 | 
2025-09-24 20:32:53.831196 | LOOP [fetch-output : Collect logs, artifacts and docs]
2025-09-24 20:32:54.605724 | controller | changed: .d..t...... ./
2025-09-24 20:32:54.605958 | controller | changed: All items complete
2025-09-24 20:32:54.605984 | 
2025-09-24 20:32:55.099210 | controller | changed: .d..t...... ./
2025-09-24 20:32:55.637982 | controller | changed: .d..t...... ./
2025-09-24 20:32:55.671713 | 
2025-09-24 20:32:55.671951 | TASK [include_role : fetch-output-openshift]
2025-09-24 20:32:55.699012 | controller | skipping: Conditional result was False
2025-09-24 20:32:55.712504 | 
2025-09-24 20:32:55.712647 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2025-09-24 20:32:56.216375 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.014777
2025-09-24 20:32:56.579942 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.015005
2025-09-24 20:32:56.624904 | 
2025-09-24 20:32:56.625051 | PLAY [localhost]
2025-09-24 20:32:56.642249 | 
2025-09-24 20:32:56.642333 | TASK [Run Zuul manifest role]
2025-09-24 20:32:56.663177 | localhost | ok
2025-09-24 20:32:56.676579 | 
2025-09-24 20:32:56.676643 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2025-09-24 20:32:57.101264 | localhost | changed
2025-09-24 20:32:57.106108 | 
2025-09-24 20:32:57.106172 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2025-09-24 20:32:57.147442 | localhost | ok
2025-09-24 20:32:57.159607 | 
2025-09-24 20:32:57.159706 | TASK [Set zuul-log-path fact]
2025-09-24 20:32:57.182129 | localhost | ok
2025-09-24 20:32:57.199846 | 
2025-09-24 20:32:57.199933 | TASK [set-zuul-log-path-fact : Set log path for a build]
2025-09-24 20:32:57.244070 | localhost | ok
2025-09-24 20:32:57.258012 | 
2025-09-24 20:32:57.258090 | LOOP [Run upload-logs-swift role]
2025-09-24 20:32:57.305264 | localhost | Output suppressed because no_log was given
2025-09-24 20:32:57.389296 | 
2025-09-24 20:32:57.389445 | TASK [Set zuul-log-path fact]
2025-09-24 20:32:57.424738 | localhost | skipping: Conditional result was False
2025-09-24 20:32:57.432194 | 
2025-09-24 20:32:57.432282 | TASK [upload-logs-swift : Ensure logs are readable before uploading]
2025-09-24 20:32:57.764620 | localhost -> localhost | ok: Runtime: 0:00:00.009618
2025-09-24 20:32:57.770898 | 
2025-09-24 20:32:57.770966 | TASK [upload-logs-swift : Upload logs to swift]