2025-12-06 22:15:48.781996 | Job console starting...
2025-12-06 22:15:48.805066 | Updating repositories
2025-12-06 22:15:48.838201 | Preparing job workspace
2025-12-06 22:15:50.522913 | Running Ansible setup...
2025-12-06 22:15:55.208363 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master]
2025-12-06 22:15:55.838077 | 
2025-12-06 22:15:55.838227 | PLAY [localhost]
2025-12-06 22:15:55.846363 | 
2025-12-06 22:15:55.846430 | TASK [Gathering Facts]
2025-12-06 22:15:56.895638 | localhost | ok
2025-12-06 22:15:56.927170 | 
2025-12-06 22:15:56.927329 | TASK [Setup log path fact]
2025-12-06 22:15:56.950018 | localhost | ok
2025-12-06 22:15:56.975940 | 
2025-12-06 22:15:56.976073 | TASK [set-zuul-log-path-fact : Set log path for a build]
2025-12-06 22:15:57.016248 | localhost | ok
2025-12-06 22:15:57.027715 | 
2025-12-06 22:15:57.027833 | TASK [emit-job-header : Print job information]
2025-12-06 22:15:57.081366 | # Job Information
2025-12-06 22:15:57.081623 | Ansible Version: 2.15.12
2025-12-06 22:15:57.081703 | Job: release-ansible-collection-galaxy
2025-12-06 22:15:57.081791 | Pipeline: release
2025-12-06 22:15:57.081834 | Executor: ze03.softwarefactory-project.io
2025-12-06 22:15:57.081874 | Triggered by: https://github.com/ansible-collections/community.docker/releases/tag/5.0.4
2025-12-06 22:15:57.081928 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/538/ansible/538a8e8727ef4023bca0677d60620ddd/
2025-12-06 22:15:57.081982 | Event ID: e97254be-d2ee-11f0-9280-aa5675f02e5c
2025-12-06 22:15:57.090983 | 
2025-12-06 22:15:57.091122 | LOOP [emit-job-header : Print node information]
2025-12-06 22:15:57.205185 | localhost | ok:
2025-12-06 22:15:57.205513 | localhost | # Node Information
2025-12-06 22:15:57.205575 | localhost | Inventory Hostname: controller
2025-12-06 22:15:57.205618 | localhost | Hostname: np0005549164
2025-12-06 22:15:57.205658 | localhost | Username: zuul
2025-12-06 22:15:57.205702 | localhost | Distro: Fedora 37
2025-12-06 22:15:57.205791 | localhost | Provider: ansible-vexxhost-ca-ymq-1
2025-12-06 22:15:57.205835 | localhost | Region: ca-ymq-1
2025-12-06 22:15:57.205871 | localhost | Label: ansible-fedora-37-1vcpu
2025-12-06 22:15:57.205908 | localhost | Product Name: OpenStack Nova
2025-12-06 22:15:57.205944 | localhost | Interface IP: 162.253.55.52
2025-12-06 22:15:57.228085 | 
2025-12-06 22:15:57.228315 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2025-12-06 22:15:57.651791 | localhost -> localhost | changed
2025-12-06 22:15:57.657774 | 
2025-12-06 22:15:57.657846 | TASK [log-inventory : Copy ansible inventory to logs dir]
2025-12-06 22:15:58.480618 | localhost -> localhost | changed
2025-12-06 22:15:58.499588 | 
2025-12-06 22:15:58.499643 | PLAY [all:!appliance*]
2025-12-06 22:15:58.516268 | 
2025-12-06 22:15:58.516360 | TASK [include_role : start-zuul-console]
2025-12-06 22:15:58.534980 | controller | ok
2025-12-06 22:15:58.548262 | 
2025-12-06 22:15:58.548332 | TASK [start-zuul-console : Start zuul_console daemon.]
2025-12-06 22:15:58.871408 | controller | ok
2025-12-06 22:15:58.882559 | 
2025-12-06 22:15:58.882628 | TASK [use-our-mirror : Retrieve the IP address]
2025-12-06 22:16:00.124933 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found
2025-12-06 22:16:00.135101 | 
2025-12-06 22:16:00.135212 | TASK [use-our-mirror : Ensure the registry service is running on the mirror]
2025-12-06 22:16:00.641706 | controller | skipping: Conditional result was False
2025-12-06 22:16:00.649251 | 
2025-12-06 22:16:00.649372 | TASK [use-our-mirror : Write the IP in /etc/hosts]
2025-12-06 22:16:00.683596 | controller | skipping: Conditional result was False
2025-12-06 22:16:00.690976 | 
2025-12-06 22:16:00.691096 | TASK [use-our-mirror : Create the podman configuration directory]
2025-12-06 22:16:00.715216 | controller | skipping: Conditional result was False
2025-12-06 22:16:00.723445 | 
2025-12-06 22:16:00.723549 | TASK [use-our-mirror : Copy the podman configuration]
2025-12-06 22:16:00.747568 | controller | skipping: Conditional result was False
2025-12-06 22:16:00.754748 | 
2025-12-06 22:16:00.754820 | TASK [use-our-mirror : Copy the Yum configuration (main)]
2025-12-06 22:16:00.778893 | controller | skipping: Conditional result was False
2025-12-06 22:16:00.787194 | 
2025-12-06 22:16:00.787278 | TASK [use-our-mirror : Copy the Yum configuration (update)]
2025-12-06 22:16:00.811865 | controller | skipping: Conditional result was False
2025-12-06 22:16:00.825015 | 
2025-12-06 22:16:00.825123 | TASK [Disable Fedora Modular]
2025-12-06 22:16:01.078185 | controller | changed
2025-12-06 22:16:01.094008 | 
2025-12-06 22:16:01.094160 | TASK [Enable EPEL]
2025-12-06 22:16:01.123244 | controller | skipping: Conditional result was False
2025-12-06 22:16:01.140798 | 
2025-12-06 22:16:01.141018 | TASK [Register the RHEL node]
2025-12-06 22:16:01.659934 | 
2025-12-06 22:16:01.660091 | TASK [Show the subscription-manager status]
2025-12-06 22:16:02.210953 | controller | skipping: Conditional result was False
2025-12-06 22:16:02.226106 | 
2025-12-06 22:16:02.226254 | TASK [Enable EPEL on RHEL]
2025-12-06 22:16:02.786458 | controller | skipping: Conditional result was False
2025-12-06 22:16:02.798870 | 
2025-12-06 22:16:02.799164 | TASK [Install git and tox]
2025-12-06 22:17:22.754701 | controller | changed
2025-12-06 22:17:22.773622 | 
2025-12-06 22:17:22.773714 | TASK [include_role : prepare-workspace]
2025-12-06 22:17:22.806229 | controller | ok
2025-12-06 22:17:22.836571 | 
2025-12-06 22:17:22.836707 | TASK [prepare-workspace : Start zuul_console daemon.]
2025-12-06 22:17:23.071258 | controller | ok
2025-12-06 22:17:23.085380 | 
2025-12-06 22:17:23.085512 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2025-12-06 22:17:25.114456 | controller | Output suppressed because no_log was given
2025-12-06 22:17:25.137135 | 
2025-12-06 22:17:25.137263 | TASK [include_role : prepare-workspace-openshift]
2025-12-06 22:17:25.163778 | controller | skipping: Conditional result was False
2025-12-06 22:17:25.205090 | 
2025-12-06 22:17:25.205161 | PLAY [all:!appliance]
2025-12-06 22:17:25.226718 | 
2025-12-06 22:17:25.226832 | TASK [Run add-build-sshkey role (RSA)]
2025-12-06 22:17:25.258129 | controller | ok
2025-12-06 22:17:25.277488 | 
2025-12-06 22:17:25.277581 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2025-12-06 22:17:25.569185 | controller -> localhost | ok
2025-12-06 22:17:25.583570 | 
2025-12-06 22:17:25.583712 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2025-12-06 22:17:25.623583 | controller | ok
2025-12-06 22:17:25.684851 | controller | included: /var/lib/zuul/builds/538a8e8727ef4023bca0677d60620ddd/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2025-12-06 22:17:25.690843 | 
2025-12-06 22:17:25.690901 | TASK [add-build-sshkey : Create Temp SSH key]
2025-12-06 22:17:26.201192 | controller -> localhost | Generating public/private rsa key pair.
2025-12-06 22:17:26.201424 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/538a8e8727ef4023bca0677d60620ddd/work/538a8e8727ef4023bca0677d60620ddd_id_rsa.
2025-12-06 22:17:26.201453 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/538a8e8727ef4023bca0677d60620ddd/work/538a8e8727ef4023bca0677d60620ddd_id_rsa.pub.
2025-12-06 22:17:26.201473 | controller -> localhost | The key fingerprint is:
2025-12-06 22:17:26.201494 | controller -> localhost | SHA256:kdRri+OZ4Hqu7Z3HN2EcnwjflV7NfdJbsTL52/ugRcE zuul-build-sshkey
2025-12-06 22:17:26.201513 | controller -> localhost | The key's randomart image is:
2025-12-06 22:17:26.201531 | controller -> localhost | +---[RSA 2048]----+
2025-12-06 22:17:26.201549 | controller -> localhost | |        ..       |
2025-12-06 22:17:26.201566 | controller -> localhost | |       . ..  . . |
2025-12-06 22:17:26.201584 | controller -> localhost | |        o  .  Eo*|
2025-12-06 22:17:26.201600 | controller -> localhost | |         .+ .+.+X|
2025-12-06 22:17:26.201617 | controller -> localhost | |        So = =*+=|
2025-12-06 22:17:26.201643 | controller -> localhost | |      . o . *.++ |
2025-12-06 22:17:26.201666 | controller -> localhost | |     . o = . .o o|
2025-12-06 22:17:26.201685 | controller -> localhost | |     .o.+.o oo o.|
2025-12-06 22:17:26.201703 | controller -> localhost | |    o*+ o. ... .+|
2025-12-06 22:17:26.201744 | controller -> localhost | +----[SHA256]-----+
2025-12-06 22:17:26.201802 | controller -> localhost | ok: Runtime: 0:00:00.086421
2025-12-06 22:17:26.208814 | 
2025-12-06 22:17:26.208890 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2025-12-06 22:17:26.229246 | controller | ok
2025-12-06 22:17:26.241193 | controller | included: /var/lib/zuul/builds/538a8e8727ef4023bca0677d60620ddd/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2025-12-06 22:17:26.252313 | 
2025-12-06 22:17:26.252412 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2025-12-06 22:17:26.266743 | controller | skipping: Conditional result was False
2025-12-06 22:17:26.274139 | 
2025-12-06 22:17:26.274206 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2025-12-06 22:17:26.648260 | controller | changed
2025-12-06 22:17:26.656646 | 
2025-12-06 22:17:26.656769 | TASK [add-build-sshkey : Make sure user has a .ssh]
2025-12-06 22:17:26.884747 | controller | ok
2025-12-06 22:17:26.896119 | 
2025-12-06 22:17:26.896285 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2025-12-06 22:17:27.539626 | controller | changed
2025-12-06 22:17:27.554008 | 
2025-12-06 22:17:27.554163 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2025-12-06 22:17:28.190246 | controller | changed
2025-12-06 22:17:28.207580 | 
2025-12-06 22:17:28.207826 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2025-12-06 22:17:28.225388 | controller | skipping: Conditional result was False
2025-12-06 22:17:28.239769 | 
2025-12-06 22:17:28.239912 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2025-12-06 22:17:28.594165 | controller -> localhost | changed
2025-12-06 22:17:28.620708 | 
2025-12-06 22:17:28.620927 | TASK [add-build-sshkey : Add back temp key]
2025-12-06 22:17:28.905363 | controller -> localhost | Identity added: /var/lib/zuul/builds/538a8e8727ef4023bca0677d60620ddd/work/538a8e8727ef4023bca0677d60620ddd_id_rsa (zuul-build-sshkey)
2025-12-06 22:17:28.905848 | controller -> localhost | ok: Runtime: 0:00:00.007229
2025-12-06 22:17:28.920641 | 
2025-12-06 22:17:28.920796 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2025-12-06 22:17:29.259957 | controller | ok
2025-12-06 22:17:29.272220 | 
2025-12-06 22:17:29.272354 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2025-12-06 22:17:29.299808 | controller | skipping: Conditional result was False
2025-12-06 22:17:29.326234 | 
2025-12-06 22:17:29.326372 | TASK [Run add-build-sshkey role (ECDSA)]
2025-12-06 22:17:29.360824 | controller | ok
2025-12-06 22:17:29.386425 | 
2025-12-06 22:17:29.386530 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2025-12-06 22:17:29.665567 | controller -> localhost | ok
2025-12-06 22:17:29.674885 | 
2025-12-06 22:17:29.674969 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2025-12-06 22:17:29.709243 | controller | ok
2025-12-06 22:17:29.724651 | controller | included: /var/lib/zuul/builds/538a8e8727ef4023bca0677d60620ddd/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2025-12-06 22:17:29.733025 | 
2025-12-06 22:17:29.733109 | TASK [add-build-sshkey : Create Temp SSH key]
2025-12-06 22:17:30.062670 | controller -> localhost | Generating public/private ecdsa key pair.
2025-12-06 22:17:30.062905 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/538a8e8727ef4023bca0677d60620ddd/work/538a8e8727ef4023bca0677d60620ddd_id_ecdsa.
2025-12-06 22:17:30.062933 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/538a8e8727ef4023bca0677d60620ddd/work/538a8e8727ef4023bca0677d60620ddd_id_ecdsa.pub.
2025-12-06 22:17:30.062962 | controller -> localhost | The key fingerprint is:
2025-12-06 22:17:30.062981 | controller -> localhost | SHA256:QGW/eTAS/q1H5zwaoeLFI0asoG4wTB/+UXErZI0Aur0 zuul-build-sshkey
2025-12-06 22:17:30.062999 | controller -> localhost | The key's randomart image is:
2025-12-06 22:17:30.063017 | controller -> localhost | +---[ECDSA 521]---+
2025-12-06 22:17:30.063033 | controller -> localhost | |   ...o.*        |
2025-12-06 22:17:30.063050 | controller -> localhost | |  .  . B =       |
2025-12-06 22:17:30.063067 | controller -> localhost | | .    + = =      |
2025-12-06 22:17:30.063083 | controller -> localhost | | .o.   = + *     |
2025-12-06 22:17:30.063100 | controller -> localhost | |o.o.o . S + = .  |
2025-12-06 22:17:30.063117 | controller -> localhost | |o. +.o o . = =   |
2025-12-06 22:17:30.063149 | controller -> localhost | | o.E. o + * o +  |
2025-12-06 22:17:30.063166 | controller -> localhost | | ..  . o + o o . |
2025-12-06 22:17:30.063190 | controller -> localhost | | ..     .   .    |
2025-12-06 22:17:30.063206 | controller -> localhost | +----[SHA256]-----+
2025-12-06 22:17:30.063253 | controller -> localhost | ok: Runtime: 0:00:00.013873
2025-12-06 22:17:30.071362 | 
2025-12-06 22:17:30.071428 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2025-12-06 22:17:30.101857 | controller | ok
2025-12-06 22:17:30.109697 | controller | included: /var/lib/zuul/builds/538a8e8727ef4023bca0677d60620ddd/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2025-12-06 22:17:30.118398 | 
2025-12-06 22:17:30.118518 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2025-12-06 22:17:30.132897 | controller | skipping: Conditional result was False
2025-12-06 22:17:30.139991 | 
2025-12-06 22:17:30.140057 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2025-12-06 22:17:30.424620 | controller | changed
2025-12-06 22:17:30.430308 | 
2025-12-06 22:17:30.430373 | TASK [add-build-sshkey : Make sure user has a .ssh]
2025-12-06 22:17:30.675017 | controller | ok
2025-12-06 22:17:30.689537 | 
2025-12-06 22:17:30.689771 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2025-12-06 22:17:31.393840 | controller | changed
2025-12-06 22:17:31.409936 | 
2025-12-06 22:17:31.410109 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2025-12-06 22:17:32.080102 | controller | changed
2025-12-06 22:17:32.090054 | 
2025-12-06 22:17:32.090149 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2025-12-06 22:17:32.116979 | controller | skipping: Conditional result was False
2025-12-06 22:17:32.133526 | 
2025-12-06 22:17:32.133871 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2025-12-06 22:17:32.477776 | controller -> localhost | changed
2025-12-06 22:17:32.506901 | 
2025-12-06 22:17:32.507057 | TASK [add-build-sshkey : Add back temp key]
2025-12-06 22:17:32.828164 | controller -> localhost | Identity added: /var/lib/zuul/builds/538a8e8727ef4023bca0677d60620ddd/work/538a8e8727ef4023bca0677d60620ddd_id_ecdsa (zuul-build-sshkey)
2025-12-06 22:17:32.828509 | controller -> localhost | ok: Runtime: 0:00:00.013561
2025-12-06 22:17:32.843930 | 
2025-12-06 22:17:32.844077 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2025-12-06 22:17:33.069630 | controller | ok
2025-12-06 22:17:33.082233 | 
2025-12-06 22:17:33.082374 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2025-12-06 22:17:33.119895 | controller | skipping: Conditional result was False
2025-12-06 22:17:33.140890 | 
2025-12-06 22:17:33.141157 | TASK [include_role : remove-zuul-sshkey]
2025-12-06 22:17:33.166829 | controller | skipping: Conditional result was False
2025-12-06 22:17:33.175832 | 
2025-12-06 22:17:33.175925 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2025-12-06 22:17:33.400976 | controller | ok: "logs"
2025-12-06 22:17:33.401214 | controller | ok: All items complete
2025-12-06 22:17:33.401243 | 
2025-12-06 22:17:33.599905 | controller | ok: "artifacts"
2025-12-06 22:17:33.797289 | controller | ok: "docs"
2025-12-06 22:17:33.813388 | 
2025-12-06 22:17:33.813571 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2025-12-06 22:17:34.149946 | controller | changed: "logs"
2025-12-06 22:17:34.328315 | controller | changed: "artifacts"
2025-12-06 22:17:34.531641 | controller | changed: "docs"
2025-12-06 22:17:34.597475 | 
2025-12-06 22:17:34.597643 | PLAY RECAP
2025-12-06 22:17:34.597906 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0
2025-12-06 22:17:34.597991 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2025-12-06 22:17:34.598034 | 
2025-12-06 22:17:34.720354 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master]
2025-12-06 22:17:34.721101 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/ansible-collection/pre.yaml@master]
2025-12-06 22:17:35.300474 | 
2025-12-06 22:17:35.300586 | PLAY [controller]
2025-12-06 22:17:35.321272 | 
2025-12-06 22:17:35.321371 | TASK [Run bindep role]
2025-12-06 22:17:35.340748 | controller | ok
2025-12-06 22:17:35.360841 | 
2025-12-06 22:17:35.360941 | TASK [bindep : Include find tasks]
2025-12-06 22:17:35.401122 | controller | ok
2025-12-06 22:17:35.408905 | controller | included: /var/lib/zuul/builds/538a8e8727ef4023bca0677d60620ddd/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml
2025-12-06 22:17:35.415211 | 
2025-12-06 22:17:35.415274 | TASK [bindep : Look for bindep.txt]
2025-12-06 22:17:35.788287 | controller | ok
2025-12-06 22:17:35.801959 | 
2025-12-06 22:17:35.802106 | TASK [bindep : Define bindep_file fact]
2025-12-06 22:17:35.830131 | controller | skipping: Conditional result was False
2025-12-06 22:17:35.844428 | 
2025-12-06 22:17:35.844580 | TASK [bindep : Look for other-requirements.txt]
2025-12-06 22:17:36.086543 | controller | ok
2025-12-06 22:17:36.098980 | 
2025-12-06 22:17:36.099125 | TASK [bindep : Define bindep_file fact]
2025-12-06 22:17:36.137681 | controller | skipping: Conditional result was False
2025-12-06 22:17:36.152553 | 
2025-12-06 22:17:36.152717 | TASK [bindep : Look for bindep fallback file]
2025-12-06 22:17:36.180952 | controller | skipping: Conditional result was False
2025-12-06 22:17:36.196638 | 
2025-12-06 22:17:36.196847 | TASK [bindep : Define bindep_file fact]
2025-12-06 22:17:36.234301 | controller | skipping: Conditional result was False
2025-12-06 22:17:36.247401 | 
2025-12-06 22:17:36.247541 | TASK [bindep : Include bindep tasks]
2025-12-06 22:17:36.284481 | controller | skipping: Conditional result was False
2025-12-06 22:17:36.297770 | 
2025-12-06 22:17:36.297910 | TASK [bindep : Include install tasks]
2025-12-06 22:17:36.334890 | controller | skipping: Conditional result was False
2025-12-06 22:17:36.348333 | 
2025-12-06 22:17:36.348468 | LOOP [bindep : Include package tasks]
2025-12-06 22:17:36.430304 | 
2025-12-06 22:17:36.430572 | TASK [Ensure ansible-core is installed on the controller]
2025-12-06 22:17:43.566587 | controller | changed
2025-12-06 22:17:43.573163 | 
2025-12-06 22:17:43.573327 | TASK [Run revoke-sudo role]
2025-12-06 22:17:43.606685 | controller | ok
2025-12-06 22:17:43.632381 | 
2025-12-06 22:17:43.632524 | TASK [revoke-sudo : Check if zuul is sudoer]
2025-12-06 22:17:44.167429 | controller | ok: Runtime: 0:00:00.018141
2025-12-06 22:17:44.181540 | 
2025-12-06 22:17:44.181697 | TASK [revoke-sudo : Remove sudo access for zuul user.]
2025-12-06 22:17:44.766202 | controller | ok: Runtime: 0:00:00.002829
2025-12-06 22:17:44.778805 | 
2025-12-06 22:17:44.778936 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.]
2025-12-06 22:17:45.157738 | controller | sudo: a password is required
2025-12-06 22:17:45.332516 | controller | ok: Runtime: 0:00:00.017693
2025-12-06 22:17:45.389647 | 
2025-12-06 22:17:45.389840 | PLAY RECAP
2025-12-06 22:17:45.389917 | controller | ok: 7 changed: 4 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0
2025-12-06 22:17:45.389952 | 
2025-12-06 22:17:45.506851 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/ansible-collection/pre.yaml@master]
2025-12-06 22:17:45.508569 | RUN START: [trusted : github.com/ansible/zuul-config/playbooks/ansible-collection/run-pre.yaml@master]
2025-12-06 22:17:46.065880 | 
2025-12-06 22:17:46.065992 | PLAY [all]
2025-12-06 22:17:46.087046 | 
2025-12-06 22:17:46.087138 | TASK [Setup tox role]
2025-12-06 22:17:46.106043 | controller | ok
2025-12-06 22:17:46.127129 | 
2025-12-06 22:17:46.127227 | TASK [tox : Check to see if the constraints file exists]
2025-12-06 22:17:46.161467 | controller | skipping: Conditional result was False
2025-12-06 22:17:46.168264 | 
2025-12-06 22:17:46.168340 | TASK [tox : Fail if constraints file is missing]
2025-12-06 22:17:46.192621 | controller | skipping: Conditional result was False
2025-12-06 22:17:46.199575 | 
2025-12-06 22:17:46.199645 | TASK [tox : Record file location]
2025-12-06 22:17:46.224154 | controller | skipping: Conditional result was False
2025-12-06 22:17:46.230802 | 
2025-12-06 22:17:46.230873 | TASK [tox : Install tox siblings]
2025-12-06 22:17:46.255123 | controller | skipping: Conditional result was False
2025-12-06 22:17:46.262752 | 
2025-12-06 22:17:46.262826 | TASK [tox : Emit tox command]
2025-12-06 22:17:46.302314 | tox   -egenerate_collection_version  -vv --notest
2025-12-06 22:17:46.308191 | 
2025-12-06 22:17:46.308278 | TASK [tox : Run tox]
2025-12-06 22:17:46.832614 | controller | using tox.ini: /home/zuul/src/github.com/ansible-network/releases/tox.ini (pid 2552)
2025-12-06 22:17:46.840216 | controller | using tox-3.28.0 from /usr/lib/python3.11/site-packages/tox/__init__.py (pid 2552)
2025-12-06 22:17:46.840311 | controller | skipping sdist step
2025-12-06 22:17:46.840658 | controller | generate_collection_version uses /usr/bin/python3
2025-12-06 22:17:46.861914 | controller | generate_collection_version start: getenv /home/zuul/src/github.com/ansible-network/releases/.tox/generate_collection_version
2025-12-06 22:17:46.862104 | controller | generate_collection_version cannot reuse: no previous config /home/zuul/src/github.com/ansible-network/releases/.tox/generate_collection_version/.tox-config1
2025-12-06 22:17:46.862116 | controller | generate_collection_version create: /home/zuul/src/github.com/ansible-network/releases/.tox/generate_collection_version
2025-12-06 22:17:46.862124 | controller | setting PATH=/home/zuul/src/github.com/ansible-network/releases/.tox/generate_collection_version/bin:/home/zuul/.local/bin:/home/zuul/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin
2025-12-06 22:17:46.862134 | controller | [2560] /home/zuul/src/github.com/ansible-network/releases/.tox$ /usr/bin/python3 -m virtualenv --no-download --python /usr/bin/python3 generate_collection_version
2025-12-06 22:17:47.394216 | controller | created virtual environment CPython3.11.0.final.0-64 in 454ms
2025-12-06 22:17:47.410983 | controller |   creator CPython3Posix(dest=/home/zuul/src/github.com/ansible-network/releases/.tox/generate_collection_version, clear=False, no_vcs_ignore=False, global=False)
2025-12-06 22:17:47.411012 | 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-12-06 22:17:47.411018 | controller |     added seed packages: pip==22.2.2, setuptools==62.6.0, wheel==0.37.1
2025-12-06 22:17:47.411025 | controller |   activators BashActivator,CShellActivator,FishActivator,NushellActivator,PowerShellActivator,PythonActivator
2025-12-06 22:17:47.411036 | controller | generate_collection_version installdeps: ansible-core, pbr, ruamel.yaml
2025-12-06 22:17:47.411371 | controller | setting PATH=/home/zuul/src/github.com/ansible-network/releases/.tox/generate_collection_version/bin:/home/zuul/.local/bin:/home/zuul/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin
2025-12-06 22:17:47.411613 | controller | [2568] /home/zuul/src/github.com/ansible-network/releases$ /home/zuul/src/github.com/ansible-network/releases/.tox/generate_collection_version/bin/pip install ansible-core pbr ruamel.yaml
2025-12-06 22:17:48.536336 | controller | Collecting ansible-core
2025-12-06 22:17:48.586913 | controller |   Downloading ansible_core-2.19.4-py3-none-any.whl (2.4 MB)
2025-12-06 22:17:48.642393 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 2.4/2.4 MB 46.4 MB/s eta 0:00:00
2025-12-06 22:17:48.696294 | controller | Collecting pbr
2025-12-06 22:17:48.712710 | controller |   Downloading pbr-7.0.3-py2.py3-none-any.whl (131 kB)
2025-12-06 22:17:48.723715 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 131.9/131.9 kB 14.8 MB/s eta 0:00:00
2025-12-06 22:17:49.087339 | controller | Collecting ruamel.yaml
2025-12-06 22:17:49.092822 | controller |   Downloading ruamel.yaml-0.18.16-py3-none-any.whl (119 kB)
2025-12-06 22:17:49.103435 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 119.9/119.9 kB 13.5 MB/s eta 0:00:00
2025-12-06 22:17:49.141237 | controller | Collecting jinja2>=3.1.0
2025-12-06 22:17:49.146978 | controller |   Downloading jinja2-3.1.6-py3-none-any.whl (134 kB)
2025-12-06 22:17:49.156061 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 134.9/134.9 kB 17.9 MB/s eta 0:00:00
2025-12-06 22:17:49.255514 | controller | Collecting PyYAML>=5.1
2025-12-06 22:17:49.260610 | controller |   Downloading pyyaml-6.0.3-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl (806 kB)
2025-12-06 22:17:49.277572 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 806.6/806.6 kB 60.9 MB/s eta 0:00:00
2025-12-06 22:17:49.771390 | controller | Collecting cryptography
2025-12-06 22:17:49.778034 | controller |   Downloading cryptography-46.0.3-cp311-abi3-manylinux_2_34_x86_64.whl (4.5 MB)
2025-12-06 22:17:49.824853 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 4.5/4.5 MB 104.1 MB/s eta 0:00:00
2025-12-06 22:22:25.397279 | [Zuul] Log Stream did not terminate
2025-12-06 22:22:25.397636 | controller | ERROR
2025-12-06 22:22:25.397865 | controller | {
2025-12-06 22:22:25.397963 | controller |   "msg": "Data could not be sent to remote host \"162.253.55.52\". Make sure this host can be reached over ssh: ssh: connect to host 162.253.55.52 port 22: No route to host\r\n",
2025-12-06 22:22:25.398017 | controller |   "unreachable": true
2025-12-06 22:22:25.398059 | controller | }
unreachable
2025-12-06 22:22:25.400081 | 
2025-12-06 22:22:25.400181 | PLAY RECAP
2025-12-06 22:22:25.400262 | controller | ok: 1 changed: 0 unreachable: 1 failed: 0 skipped: 4 rescued: 0 ignored: 0
2025-12-06 22:22:25.400305 | 
2025-12-06 22:22:25.524971 | RUN END RESULT_UNREACHABLE: [trusted : github.com/ansible/zuul-config/playbooks/ansible-collection/run-pre.yaml@master]
2025-12-06 22:22:25.526006 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/ansible-collection/post.yaml@master]
2025-12-06 22:22:26.171404 | 
2025-12-06 22:22:26.171526 | PLAY [all]
2025-12-06 22:22:26.191762 | 
2025-12-06 22:22:26.191870 | TASK [Find tarballs in folder]
2025-12-06 22:22:40.895611 | controller | ERROR
2025-12-06 22:22:40.896967 | controller | {
2025-12-06 22:22:40.897205 | controller |   "msg": "Data could not be sent to remote host \"162.253.55.52\". Make sure this host can be reached over ssh: ssh: connect to host 162.253.55.52 port 22: No route to host\r\n",
2025-12-06 22:22:40.897295 | controller |   "unreachable": true
2025-12-06 22:22:40.897404 | controller | }
unreachable
2025-12-06 22:22:40.900574 | 
2025-12-06 22:22:40.900680 | PLAY RECAP
2025-12-06 22:22:40.900825 | controller | ok: 0 changed: 0 unreachable: 1 failed: 0 skipped: 0 rescued: 0 ignored: 0
2025-12-06 22:22:40.900883 | 
2025-12-06 22:22:41.048873 | POST-RUN END RESULT_UNREACHABLE: [trusted : github.com/ansible/zuul-config/playbooks/ansible-collection/post.yaml@master]
2025-12-06 22:22:41.050170 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/publish/ansible-galaxy.yaml@master]
2025-12-06 22:22:41.586456 | 
2025-12-06 22:22:41.586580 | PLAY [controller]
2025-12-06 22:22:41.609916 | 
2025-12-06 22:22:41.610051 | TASK [Run upload-ansible-collection-fork]
2025-12-06 22:22:41.644325 | controller | skipping: Conditional result was False
2025-12-06 22:22:41.673639 | 
2025-12-06 22:22:41.674128 | PLAY RECAP
2025-12-06 22:22:41.674185 | controller | ok: 0 changed: 0 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2025-12-06 22:22:41.674234 | 
2025-12-06 22:22:41.761842 | POST-RUN END RESULT_UNREACHABLE: [trusted : github.com/ansible/zuul-config/playbooks/publish/ansible-galaxy.yaml@master]
2025-12-06 22:22:41.763849 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master]
2025-12-06 22:22:42.380798 | 
2025-12-06 22:22:42.381030 | PLAY [all:!appliance*]
2025-12-06 22:22:42.403996 | 
2025-12-06 22:22:42.404102 | TASK [unregister the node]
2025-12-06 22:22:43.943780 | [controller] Waiting on logger
2025-12-06 22:22:50.636430 | controller | skipping: Conditional result was False
2025-12-06 22:22:50.652378 | 
2025-12-06 22:22:50.652578 | TASK [include_role : fetch-output]
2025-12-06 22:22:50.712951 | controller | ok
2025-12-06 22:22:50.756061 | 
2025-12-06 22:22:50.756224 | TASK [fetch-output : Set log path for multiple nodes]
2025-12-06 22:22:50.801700 | controller | skipping: Conditional result was False
2025-12-06 22:22:50.808277 | 
2025-12-06 22:22:50.808348 | TASK [fetch-output : Set log path for single node]
2025-12-06 22:22:50.847909 | controller | ok
2025-12-06 22:22:50.855371 | 
2025-12-06 22:22:50.855475 | LOOP [fetch-output : Ensure local output dirs]
2025-12-06 22:22:51.283780 | controller -> localhost | ok: "/var/lib/zuul/builds/538a8e8727ef4023bca0677d60620ddd/work/logs"
2025-12-06 22:22:51.543218 | controller -> localhost | changed: "/var/lib/zuul/builds/538a8e8727ef4023bca0677d60620ddd/work/artifacts"
2025-12-06 22:22:51.811219 | controller -> localhost | changed: "/var/lib/zuul/builds/538a8e8727ef4023bca0677d60620ddd/work/docs"
2025-12-06 22:22:51.834309 | 
2025-12-06 22:22:51.834467 | LOOP [fetch-output : Collect logs, artifacts and docs]
2025-12-06 22:22:52.565517 | controller | ok
2025-12-06 22:22:52.565698 | controller | changed: All items complete
2025-12-06 22:22:52.565727 | 
2025-12-06 22:22:53.099650 | controller | changed: .d..t...... ./
2025-12-06 22:22:53.660426 | controller | changed: .d..t...... ./
2025-12-06 22:22:53.689694 | 
2025-12-06 22:22:53.689947 | TASK [include_role : fetch-output-openshift]
2025-12-06 22:22:53.717027 | controller | skipping: Conditional result was False
2025-12-06 22:22:53.730867 | 
2025-12-06 22:22:53.731002 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2025-12-06 22:22:53.764403 | controller | skipping: Conditional result was False
2025-12-06 22:22:53.776749 | controller | skipping: Conditional result was False
2025-12-06 22:22:53.829770 | 
2025-12-06 22:22:53.829895 | PLAY [localhost]
2025-12-06 22:22:53.846403 | 
2025-12-06 22:22:53.846486 | TASK [Run Zuul manifest role]
2025-12-06 22:22:53.866953 | localhost | ok
2025-12-06 22:22:53.885530 | 
2025-12-06 22:22:53.885618 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2025-12-06 22:22:54.250569 | localhost | changed
2025-12-06 22:22:54.256914 | 
2025-12-06 22:22:54.256996 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2025-12-06 22:22:54.287214 | localhost | ok
2025-12-06 22:22:54.298161 | 
2025-12-06 22:22:54.298237 | TASK [Set zuul-log-path fact]
2025-12-06 22:22:54.318365 | localhost | ok
2025-12-06 22:22:54.337517 | 
2025-12-06 22:22:54.337612 | TASK [set-zuul-log-path-fact : Set log path for a build]
2025-12-06 22:22:54.378478 | localhost | ok
2025-12-06 22:22:54.389503 | 
2025-12-06 22:22:54.389583 | LOOP [Run upload-logs-swift role]
2025-12-06 22:22:54.428015 | localhost | Output suppressed because no_log was given
2025-12-06 22:22:54.461808 | 
2025-12-06 22:22:54.461901 | TASK [Set zuul-log-path fact]
2025-12-06 22:22:54.497023 | localhost | skipping: Conditional result was False
2025-12-06 22:22:54.504296 | 
2025-12-06 22:22:54.504380 | TASK [upload-logs-swift : Ensure logs are readable before uploading]
2025-12-06 22:22:54.959138 | localhost -> localhost | ok: Runtime: 0:00:00.008554
2025-12-06 22:22:54.987278 | 
2025-12-06 22:22:54.987396 | TASK [upload-logs-swift : Upload logs to swift]