2025-12-02 12:29:49.794088 | Job console starting... 2025-12-02 12:29:49.804456 | Updating repositories 2025-12-02 12:29:49.852658 | Preparing job workspace 2025-12-02 12:29:53.965976 | Running Ansible setup... 2025-12-02 12:29:58.434115 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2025-12-02 12:29:59.030807 | 2025-12-02 12:29:59.030983 | PLAY [localhost] 2025-12-02 12:29:59.040895 | 2025-12-02 12:29:59.041002 | TASK [Gathering Facts] 2025-12-02 12:29:59.998069 | localhost | ok 2025-12-02 12:30:00.030629 | 2025-12-02 12:30:00.030858 | TASK [Setup log path fact] 2025-12-02 12:30:00.056709 | localhost | ok 2025-12-02 12:30:00.081120 | 2025-12-02 12:30:00.081246 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-02 12:30:00.110961 | localhost | ok 2025-12-02 12:30:00.121589 | 2025-12-02 12:30:00.121679 | TASK [emit-job-header : Print job information] 2025-12-02 12:30:00.161672 | # Job Information 2025-12-02 12:30:00.161884 | Ansible Version: 2.15.12 2025-12-02 12:30:00.161931 | Job: ansible-galaxy-importer 2025-12-02 12:30:00.161962 | Pipeline: third-party-check 2025-12-02 12:30:00.161989 | Executor: ze03.softwarefactory-project.io 2025-12-02 12:30:00.162017 | Triggered by: https://github.com/ansible-collections/community.postgresql/pull/899 2025-12-02 12:30:00.162049 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/17c/ansible/17c486c7965748ba9d78235a43340eaf/ 2025-12-02 12:30:00.162077 | Event ID: ae7d8720-cf79-11f0-867b-87514445da6a 2025-12-02 12:30:00.167126 | 2025-12-02 12:30:00.167215 | LOOP [emit-job-header : Print node information] 2025-12-02 12:30:00.278876 | localhost | ok: 2025-12-02 12:30:00.279267 | localhost | # Node Information 2025-12-02 12:30:00.279334 | localhost | Inventory Hostname: controller 2025-12-02 12:30:00.279383 | localhost | Hostname: np0005542419 2025-12-02 12:30:00.279429 | localhost | Username: zuul 2025-12-02 12:30:00.279478 | localhost | Distro: Fedora 37 2025-12-02 12:30:00.279523 | localhost | Provider: ansible-vexxhost-ca-ymq-1 2025-12-02 12:30:00.279566 | localhost | Region: ca-ymq-1 2025-12-02 12:30:00.279607 | localhost | Label: ansible-fedora-37-1vcpu 2025-12-02 12:30:00.279648 | localhost | Product Name: OpenStack Nova 2025-12-02 12:30:00.279690 | localhost | Interface IP: 162.253.55.209 2025-12-02 12:30:00.292865 | 2025-12-02 12:30:00.292954 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-02 12:30:00.683512 | localhost -> localhost | changed 2025-12-02 12:30:00.694426 | 2025-12-02 12:30:00.694559 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-02 12:30:01.557144 | localhost -> localhost | changed 2025-12-02 12:30:01.598721 | 2025-12-02 12:30:01.598859 | PLAY [all:!appliance*] 2025-12-02 12:30:01.629294 | 2025-12-02 12:30:01.629397 | TASK [include_role : start-zuul-console] 2025-12-02 12:30:01.652186 | controller | ok 2025-12-02 12:30:01.671881 | 2025-12-02 12:30:01.672016 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-02 12:30:02.071153 | controller | ok 2025-12-02 12:30:02.086685 | 2025-12-02 12:30:02.086867 | TASK [use-our-mirror : Retrieve the IP address] 2025-12-02 12:30:05.181126 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found 2025-12-02 12:30:05.195689 | 2025-12-02 12:30:05.195973 | TASK [use-our-mirror : Ensure the registry service is running on the mirror] 2025-12-02 12:30:05.746528 | controller | skipping: Conditional result was False 2025-12-02 12:30:05.755336 | 2025-12-02 12:30:05.755432 | TASK [use-our-mirror : Write the IP in /etc/hosts] 2025-12-02 12:30:05.783931 | controller | skipping: Conditional result was False 2025-12-02 12:30:05.793236 | 2025-12-02 12:30:05.793325 | TASK [use-our-mirror : Create the podman configuration directory] 2025-12-02 12:30:05.818287 | controller | skipping: Conditional result was False 2025-12-02 12:30:05.827314 | 2025-12-02 12:30:05.827405 | TASK [use-our-mirror : Copy the podman configuration] 2025-12-02 12:30:05.852856 | controller | skipping: Conditional result was False 2025-12-02 12:30:05.861849 | 2025-12-02 12:30:05.861940 | TASK [use-our-mirror : Copy the Yum configuration (main)] 2025-12-02 12:30:05.887047 | controller | skipping: Conditional result was False 2025-12-02 12:30:05.895674 | 2025-12-02 12:30:05.895812 | TASK [use-our-mirror : Copy the Yum configuration (update)] 2025-12-02 12:30:05.920393 | controller | skipping: Conditional result was False 2025-12-02 12:30:05.935418 | 2025-12-02 12:30:05.935504 | TASK [Disable Fedora Modular] 2025-12-02 12:30:06.178587 | controller | changed 2025-12-02 12:30:06.190861 | 2025-12-02 12:30:06.191012 | TASK [Enable EPEL] 2025-12-02 12:30:06.218307 | controller | skipping: Conditional result was False 2025-12-02 12:30:06.232055 | 2025-12-02 12:30:06.232198 | TASK [Register the RHEL node] 2025-12-02 12:30:06.833084 | 2025-12-02 12:30:06.833265 | TASK [Show the subscription-manager status] 2025-12-02 12:30:07.375702 | controller | skipping: Conditional result was False 2025-12-02 12:30:07.384253 | 2025-12-02 12:30:07.384336 | TASK [Enable EPEL on RHEL] 2025-12-02 12:30:07.929082 | controller | skipping: Conditional result was False 2025-12-02 12:30:07.937634 | 2025-12-02 12:30:07.937773 | TASK [Install git and tox] 2025-12-02 12:31:26.340345 | controller | changed 2025-12-02 12:31:26.354118 | 2025-12-02 12:31:26.354238 | TASK [include_role : prepare-workspace] 2025-12-02 12:31:26.382481 | controller | ok 2025-12-02 12:31:26.416547 | 2025-12-02 12:31:26.416681 | TASK [prepare-workspace : Start zuul_console daemon.] 2025-12-02 12:31:26.646604 | controller | ok 2025-12-02 12:31:26.668811 | 2025-12-02 12:31:26.669045 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2025-12-02 12:31:27.711364 | controller | Output suppressed because no_log was given 2025-12-02 12:31:27.734038 | 2025-12-02 12:31:27.734168 | TASK [include_role : prepare-workspace-openshift] 2025-12-02 12:31:27.751852 | controller | skipping: Conditional result was False 2025-12-02 12:31:27.786001 | 2025-12-02 12:31:27.786100 | PLAY [all:!appliance] 2025-12-02 12:31:27.806940 | 2025-12-02 12:31:27.807022 | TASK [Run add-build-sshkey role (RSA)] 2025-12-02 12:31:27.828834 | controller | ok 2025-12-02 12:31:27.842952 | 2025-12-02 12:31:27.843012 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-02 12:31:28.072099 | controller -> localhost | ok 2025-12-02 12:31:28.088279 | 2025-12-02 12:31:28.088433 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-02 12:31:28.125333 | controller | ok 2025-12-02 12:31:28.143049 | controller | included: /var/lib/zuul/builds/17c486c7965748ba9d78235a43340eaf/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-02 12:31:28.181346 | 2025-12-02 12:31:28.181705 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-02 12:31:28.708805 | controller -> localhost | Generating public/private rsa key pair. 2025-12-02 12:31:28.709130 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/17c486c7965748ba9d78235a43340eaf/work/17c486c7965748ba9d78235a43340eaf_id_rsa. 2025-12-02 12:31:28.709194 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/17c486c7965748ba9d78235a43340eaf/work/17c486c7965748ba9d78235a43340eaf_id_rsa.pub. 2025-12-02 12:31:28.709242 | controller -> localhost | The key fingerprint is: 2025-12-02 12:31:28.709287 | controller -> localhost | SHA256:NZ76jnuwdJGYUGzrgFV5SMyDGr2SRNbPBEhh/F62eig zuul-build-sshkey 2025-12-02 12:31:28.709331 | controller -> localhost | The key's randomart image is: 2025-12-02 12:31:28.709374 | controller -> localhost | +---[RSA 2048]----+ 2025-12-02 12:31:28.709415 | controller -> localhost | | +*=.X+o | 2025-12-02 12:31:28.709459 | controller -> localhost | | o= * X . | 2025-12-02 12:31:28.709501 | controller -> localhost | | . B B *o. | 2025-12-02 12:31:28.709542 | controller -> localhost | | = + Oooo | 2025-12-02 12:31:28.709582 | controller -> localhost | | o =S.o. | 2025-12-02 12:31:28.709641 | controller -> localhost | | . =.. | 2025-12-02 12:31:28.709695 | controller -> localhost | | +.+ | 2025-12-02 12:31:28.709799 | controller -> localhost | | E o oo. | 2025-12-02 12:31:28.709856 | controller -> localhost | | . .o+o | 2025-12-02 12:31:28.709906 | controller -> localhost | +----[SHA256]-----+ 2025-12-02 12:31:28.709999 | controller -> localhost | ok: Runtime: 0:00:00.074785 2025-12-02 12:31:28.724861 | 2025-12-02 12:31:28.724995 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-02 12:31:28.764914 | controller | ok 2025-12-02 12:31:28.785430 | controller | included: /var/lib/zuul/builds/17c486c7965748ba9d78235a43340eaf/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-02 12:31:28.798012 | 2025-12-02 12:31:28.798096 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-02 12:31:28.823254 | controller | skipping: Conditional result was False 2025-12-02 12:31:28.832614 | 2025-12-02 12:31:28.832701 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-02 12:31:29.259364 | controller | changed 2025-12-02 12:31:29.271714 | 2025-12-02 12:31:29.271892 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-02 12:31:29.545053 | controller | ok 2025-12-02 12:31:29.557650 | 2025-12-02 12:31:29.557804 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-02 12:31:30.219166 | controller | changed 2025-12-02 12:31:30.231640 | 2025-12-02 12:31:30.231805 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-02 12:31:30.891405 | controller | changed 2025-12-02 12:31:30.904277 | 2025-12-02 12:31:30.904406 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-02 12:31:30.932249 | controller | skipping: Conditional result was False 2025-12-02 12:31:30.946645 | 2025-12-02 12:31:30.946806 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-02 12:31:31.331686 | controller -> localhost | changed 2025-12-02 12:31:31.366819 | 2025-12-02 12:31:31.367080 | TASK [add-build-sshkey : Add back temp key] 2025-12-02 12:31:31.661750 | controller -> localhost | Identity added: /var/lib/zuul/builds/17c486c7965748ba9d78235a43340eaf/work/17c486c7965748ba9d78235a43340eaf_id_rsa (zuul-build-sshkey) 2025-12-02 12:31:31.661971 | controller -> localhost | ok: Runtime: 0:00:00.012233 2025-12-02 12:31:31.668510 | 2025-12-02 12:31:31.668568 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-02 12:31:31.962020 | controller | ok 2025-12-02 12:31:31.974634 | 2025-12-02 12:31:31.974828 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-02 12:31:32.013630 | controller | skipping: Conditional result was False 2025-12-02 12:31:32.038609 | 2025-12-02 12:31:32.038843 | TASK [Run add-build-sshkey role (ECDSA)] 2025-12-02 12:31:32.077866 | controller | ok 2025-12-02 12:31:32.107235 | 2025-12-02 12:31:32.107340 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-02 12:31:32.402768 | controller -> localhost | ok 2025-12-02 12:31:32.417713 | 2025-12-02 12:31:32.417890 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-02 12:31:32.458044 | controller | ok 2025-12-02 12:31:32.479973 | controller | included: /var/lib/zuul/builds/17c486c7965748ba9d78235a43340eaf/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-02 12:31:32.488457 | 2025-12-02 12:31:32.488548 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-02 12:31:32.799706 | controller -> localhost | Generating public/private ecdsa key pair. 2025-12-02 12:31:32.800106 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/17c486c7965748ba9d78235a43340eaf/work/17c486c7965748ba9d78235a43340eaf_id_ecdsa. 2025-12-02 12:31:32.800168 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/17c486c7965748ba9d78235a43340eaf/work/17c486c7965748ba9d78235a43340eaf_id_ecdsa.pub. 2025-12-02 12:31:32.800228 | controller -> localhost | The key fingerprint is: 2025-12-02 12:31:32.800273 | controller -> localhost | SHA256:Y750G+O/mW3Q9UDoFfKsJj3AUVRe9b4yHQJ3xvmWzLA zuul-build-sshkey 2025-12-02 12:31:32.800316 | controller -> localhost | The key's randomart image is: 2025-12-02 12:31:32.800356 | controller -> localhost | +---[ECDSA 521]---+ 2025-12-02 12:31:32.800395 | controller -> localhost | | .o+oo.+| 2025-12-02 12:31:32.800434 | controller -> localhost | | . ..=+.o| 2025-12-02 12:31:32.800473 | controller -> localhost | | oo =+=.| 2025-12-02 12:31:32.800512 | controller -> localhost | | o+.O.+| 2025-12-02 12:31:32.800550 | controller -> localhost | | S . =E B=| 2025-12-02 12:31:32.800588 | controller -> localhost | | o . o..+.+| 2025-12-02 12:31:32.800625 | controller -> localhost | | o + + o | 2025-12-02 12:31:32.800661 | controller -> localhost | | . + + ++ | 2025-12-02 12:31:32.800697 | controller -> localhost | | . o.=o. | 2025-12-02 12:31:32.800770 | controller -> localhost | +----[SHA256]-----+ 2025-12-02 12:31:32.800866 | controller -> localhost | ok: Runtime: 0:00:00.007347 2025-12-02 12:31:32.815396 | 2025-12-02 12:31:32.815524 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-02 12:31:32.858715 | controller | ok 2025-12-02 12:31:32.876572 | controller | included: /var/lib/zuul/builds/17c486c7965748ba9d78235a43340eaf/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-02 12:31:32.889322 | 2025-12-02 12:31:32.889449 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-02 12:31:32.904915 | controller | skipping: Conditional result was False 2025-12-02 12:31:32.914187 | 2025-12-02 12:31:32.914272 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-02 12:31:33.216956 | controller | changed 2025-12-02 12:31:33.231243 | 2025-12-02 12:31:33.231375 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-02 12:31:33.468682 | controller | ok 2025-12-02 12:31:33.482164 | 2025-12-02 12:31:33.482363 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-02 12:31:34.129999 | controller | changed 2025-12-02 12:31:34.138315 | 2025-12-02 12:31:34.138463 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-02 12:31:34.708026 | controller | changed 2025-12-02 12:31:34.721688 | 2025-12-02 12:31:34.721855 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-02 12:31:34.749372 | controller | skipping: Conditional result was False 2025-12-02 12:31:34.762901 | 2025-12-02 12:31:34.763032 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-02 12:31:35.035277 | controller -> localhost | changed 2025-12-02 12:31:35.062256 | 2025-12-02 12:31:35.062394 | TASK [add-build-sshkey : Add back temp key] 2025-12-02 12:31:35.386359 | controller -> localhost | Identity added: /var/lib/zuul/builds/17c486c7965748ba9d78235a43340eaf/work/17c486c7965748ba9d78235a43340eaf_id_ecdsa (zuul-build-sshkey) 2025-12-02 12:31:35.386856 | controller -> localhost | ok: Runtime: 0:00:00.009297 2025-12-02 12:31:35.403280 | 2025-12-02 12:31:35.403422 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-02 12:31:35.617440 | controller | ok 2025-12-02 12:31:35.629807 | 2025-12-02 12:31:35.629941 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-02 12:31:35.657436 | controller | skipping: Conditional result was False 2025-12-02 12:31:35.682035 | 2025-12-02 12:31:35.682191 | TASK [include_role : remove-zuul-sshkey] 2025-12-02 12:31:35.709713 | controller | skipping: Conditional result was False 2025-12-02 12:31:35.723238 | 2025-12-02 12:31:35.723383 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2025-12-02 12:31:35.963257 | controller | ok: "logs" 2025-12-02 12:31:35.963678 | controller | ok: All items complete 2025-12-02 12:31:35.963782 | 2025-12-02 12:31:36.155822 | controller | ok: "artifacts" 2025-12-02 12:31:36.351329 | controller | ok: "docs" 2025-12-02 12:31:36.376138 | 2025-12-02 12:31:36.376423 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2025-12-02 12:31:36.634137 | controller | changed: "logs" 2025-12-02 12:31:36.888034 | controller | changed: "artifacts" 2025-12-02 12:31:37.039397 | controller | changed: "docs" 2025-12-02 12:31:37.104156 | 2025-12-02 12:31:37.104296 | PLAY RECAP 2025-12-02 12:31:37.104357 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0 2025-12-02 12:31:37.104393 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-12-02 12:31:37.104417 | 2025-12-02 12:31:37.218063 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2025-12-02 12:31:37.219654 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-galaxy-importer/pre.yaml@master] 2025-12-02 12:31:37.840972 | 2025-12-02 12:31:37.841114 | PLAY [all] 2025-12-02 12:31:37.861534 | 2025-12-02 12:31:37.861625 | TASK [Setup ensure-tox role] 2025-12-02 12:31:37.881174 | controller | ok 2025-12-02 12:31:37.904168 | 2025-12-02 12:31:37.904255 | TASK [Install pip] 2025-12-02 12:31:37.923811 | controller | ok 2025-12-02 12:31:37.944976 | 2025-12-02 12:31:37.945046 | TASK [ensure-pip : Check if pip is installed] 2025-12-02 12:31:38.336810 | controller | /usr/bin/pip3 2025-12-02 12:31:38.354314 | controller | /usr/bin/python3: No module named wheel 2025-12-02 12:31:38.479446 | controller | ok: Runtime: 0:00:00.024086 2025-12-02 12:31:38.492953 | 2025-12-02 12:31:38.493091 | LOOP [ensure-pip : Install pip from packages] 2025-12-02 12:31:38.529463 | controller | ok: "/var/lib/zuul/builds/17c486c7965748ba9d78235a43340eaf/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/RedHat.yaml" 2025-12-02 12:31:38.550351 | controller | included: /var/lib/zuul/builds/17c486c7965748ba9d78235a43340eaf/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/RedHat.yaml 2025-12-02 12:31:38.574036 | 2025-12-02 12:31:38.574126 | TASK [ensure-pip : Install Python 3 pip] 2025-12-02 12:31:43.338676 | controller | changed 2025-12-02 12:31:43.351941 | 2025-12-02 12:31:43.352121 | TASK [ensure-pip : Check for EPEL repository] 2025-12-02 12:31:43.380421 | controller | skipping: Conditional result was False 2025-12-02 12:31:43.397798 | 2025-12-02 12:31:43.397998 | TASK [ensure-pip : Fail with instructions when EPEL is not installed] 2025-12-02 12:31:43.427512 | controller | skipping: Conditional result was False 2025-12-02 12:31:43.441919 | 2025-12-02 12:31:43.442071 | TASK [ensure-pip : Install Python 2 pip] 2025-12-02 12:31:43.469486 | controller | skipping: Conditional result was False 2025-12-02 12:31:43.483776 | 2025-12-02 12:31:43.483932 | TASK [ensure-pip : Ensure setuptools] 2025-12-02 12:31:43.511681 | controller | skipping: Conditional result was False 2025-12-02 12:31:43.527115 | 2025-12-02 12:31:43.527256 | TASK [ensure-pip : Check for ensurepip module] 2025-12-02 12:31:44.075674 | controller | skipping: Conditional result was False 2025-12-02 12:31:44.089238 | 2025-12-02 12:31:44.089397 | TASK [ensure-pip : Ensure python3-venv] 2025-12-02 12:31:44.116332 | controller | skipping: Conditional result was False 2025-12-02 12:31:44.129157 | 2025-12-02 12:31:44.129323 | TASK [ensure-pip : Install pip from source] 2025-12-02 12:31:44.156800 | controller | skipping: Conditional result was False 2025-12-02 12:31:44.170103 | 2025-12-02 12:31:44.170248 | TASK [ensure-pip : Probe for venv python full path] 2025-12-02 12:31:44.510445 | controller | /usr/bin/python3 2025-12-02 12:31:44.719600 | controller | ok: Runtime: 0:00:00.003203 2025-12-02 12:31:44.771550 | 2025-12-02 12:31:44.771699 | TASK [ensure-pip : Set host default] 2025-12-02 12:31:44.829350 | controller | ok 2025-12-02 12:31:44.841221 | 2025-12-02 12:31:44.841355 | TASK [ensure-pip : Set ensure_pip_virtualenv_command] 2025-12-02 12:31:44.917211 | controller | ok 2025-12-02 12:31:44.927652 | 2025-12-02 12:31:44.927716 | TASK [ensure-tox : Check if tox is installed] 2025-12-02 12:31:45.179494 | controller | /usr/bin/tox 2025-12-02 12:31:45.458764 | controller | ok: Runtime: 0:00:00.004090 2025-12-02 12:31:45.471602 | 2025-12-02 12:31:45.471771 | TASK [ensure-tox : Export preinstalled tox_exectuable] 2025-12-02 12:31:45.523081 | controller | ok 2025-12-02 12:31:45.535007 | 2025-12-02 12:31:45.535146 | TASK [ensure-tox : Create local venv] 2025-12-02 12:31:46.082957 | controller | skipping: Conditional result was False 2025-12-02 12:31:46.098266 | 2025-12-02 12:31:46.098467 | TASK [ensure-tox : Install tox to local venv] 2025-12-02 12:31:46.656616 | controller | skipping: Conditional result was False 2025-12-02 12:31:46.670466 | 2025-12-02 12:31:46.670637 | TASK [ensure-tox : Export installed tox_executable path] 2025-12-02 12:31:46.696956 | controller | skipping: Conditional result was False 2025-12-02 12:31:46.710162 | 2025-12-02 12:31:46.710302 | TASK [ensure-tox : Output tox version] 2025-12-02 12:31:47.102111 | controller | 3.28.0 imported from /usr/lib/python3.11/site-packages/tox/__init__.py 2025-12-02 12:31:47.259864 | controller | ok: Runtime: 0:00:00.147614 2025-12-02 12:31:47.274069 | 2025-12-02 12:31:47.274273 | TASK [ensure-tox : Make global symlink] 2025-12-02 12:31:47.301788 | controller | skipping: Conditional result was False 2025-12-02 12:31:47.328109 | 2025-12-02 12:31:47.328256 | TASK [Setup tox role] 2025-12-02 12:31:47.357956 | controller | ok 2025-12-02 12:31:47.402062 | 2025-12-02 12:31:47.402162 | TASK [tox : Check to see if the constraints file exists] 2025-12-02 12:31:47.438081 | controller | skipping: Conditional result was False 2025-12-02 12:31:47.452078 | 2025-12-02 12:31:47.452221 | TASK [tox : Fail if constraints file is missing] 2025-12-02 12:31:47.491348 | controller | skipping: Conditional result was False 2025-12-02 12:31:47.507055 | 2025-12-02 12:31:47.507246 | TASK [tox : Record file location] 2025-12-02 12:31:47.535556 | controller | skipping: Conditional result was False 2025-12-02 12:31:47.550839 | 2025-12-02 12:31:47.550978 | TASK [tox : Install tox siblings] 2025-12-02 12:31:47.569706 | controller | skipping: Conditional result was False 2025-12-02 12:31:47.585339 | 2025-12-02 12:31:47.585481 | TASK [tox : Emit tox command] 2025-12-02 12:31:47.649542 | /usr/bin/tox -evenv -vv --notest 2025-12-02 12:31:47.661814 | 2025-12-02 12:31:47.661964 | TASK [tox : Run tox] 2025-12-02 12:31:48.042337 | controller | using tox.ini: /home/zuul/src/github.com/ansible-network/releases/tox.ini (pid 2352) 2025-12-02 12:31:48.050378 | controller | using tox-3.28.0 from /usr/lib/python3.11/site-packages/tox/__init__.py (pid 2352) 2025-12-02 12:31:48.071602 | controller | skipping sdist step 2025-12-02 12:31:48.071643 | controller | venv uses /usr/bin/python3 2025-12-02 12:31:48.071664 | controller | venv start: getenv /home/zuul/src/github.com/ansible-network/releases/.tox/venv 2025-12-02 12:31:48.071904 | controller | venv cannot reuse: no previous config /home/zuul/src/github.com/ansible-network/releases/.tox/venv/.tox-config1 2025-12-02 12:31:48.071914 | controller | venv create: /home/zuul/src/github.com/ansible-network/releases/.tox/venv 2025-12-02 12:31:48.071923 | 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-12-02 12:31:48.071933 | controller | [2360] /home/zuul/src/github.com/ansible-network/releases/.tox$ /usr/bin/python3 -m virtualenv --no-download --python /usr/bin/python3 venv 2025-12-02 12:31:48.611141 | controller | created virtual environment CPython3.11.0.final.0-64 in 461ms 2025-12-02 12:31:48.633613 | controller | creator CPython3Posix(dest=/home/zuul/src/github.com/ansible-network/releases/.tox/venv, clear=False, no_vcs_ignore=False, global=False) 2025-12-02 12:31:48.633633 | 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-02 12:31:48.633645 | controller | added seed packages: pip==22.2.2, setuptools==62.6.0, wheel==0.37.1 2025-12-02 12:31:48.633650 | controller | activators BashActivator,CShellActivator,FishActivator,NushellActivator,PowerShellActivator,PythonActivator 2025-12-02 12:31:48.633660 | 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-12-02 12:31:48.633790 | 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-12-02 12:31:48.636647 | controller | [2368] /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-12-02 12:31:50.031068 | controller | Collecting ruamel.yaml 2025-12-02 12:31:50.070136 | controller | Downloading ruamel.yaml-0.18.16-py3-none-any.whl (119 kB) 2025-12-02 12:31:50.096003 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 119.9/119.9 kB 5.0 MB/s eta 0:00:00 2025-12-02 12:31:50.153506 | controller | Collecting pbr 2025-12-02 12:31:50.157772 | controller | Downloading pbr-7.0.3-py2.py3-none-any.whl (131 kB) 2025-12-02 12:31:50.167387 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 131.9/131.9 kB 16.5 MB/s eta 0:00:00 2025-12-02 12:31:50.207321 | controller | Collecting tweepy 2025-12-02 12:31:50.211889 | controller | Downloading tweepy-4.16.0-py3-none-any.whl (98 kB) 2025-12-02 12:31:50.219297 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 98.8/98.8 kB 17.4 MB/s eta 0:00:00 2025-12-02 12:36:26.701662 | [Zuul] Log Stream did not terminate 2025-12-02 12:36:26.701973 | controller | ERROR 2025-12-02 12:36:26.702107 | controller | { 2025-12-02 12:36:26.702163 | controller | "msg": "Data could not be sent to remote host \"162.253.55.209\". Make sure this host can be reached over ssh: ssh: connect to host 162.253.55.209 port 22: No route to host\r\n", 2025-12-02 12:36:26.702206 | controller | "unreachable": true 2025-12-02 12:36:26.702247 | controller | } unreachable 2025-12-02 12:36:26.705605 | 2025-12-02 12:36:26.705794 | PLAY RECAP 2025-12-02 12:36:26.705884 | controller | ok: 10 changed: 5 unreachable: 1 failed: 0 skipped: 15 rescued: 0 ignored: 0 2025-12-02 12:36:26.705929 | 2025-12-02 12:36:26.888037 | PRE-RUN END RESULT_UNREACHABLE: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-galaxy-importer/pre.yaml@master] 2025-12-02 12:36:26.889751 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master] 2025-12-02 12:36:27.500397 | 2025-12-02 12:36:27.500521 | PLAY [all:!appliance*] 2025-12-02 12:36:27.529186 | 2025-12-02 12:36:27.529270 | TASK [unregister the node] 2025-12-02 12:36:29.960524 | [controller] Waiting on logger 2025-12-02 12:36:50.774664 | controller | skipping: Conditional result was False 2025-12-02 12:36:50.787903 | 2025-12-02 12:36:50.788097 | TASK [include_role : fetch-output] 2025-12-02 12:36:50.847200 | controller | ok 2025-12-02 12:36:50.886011 | 2025-12-02 12:36:50.886185 | TASK [fetch-output : Set log path for multiple nodes] 2025-12-02 12:36:50.963146 | controller | skipping: Conditional result was False 2025-12-02 12:36:50.972476 | 2025-12-02 12:36:50.972577 | TASK [fetch-output : Set log path for single node] 2025-12-02 12:36:51.020505 | controller | ok 2025-12-02 12:36:51.034311 | 2025-12-02 12:36:51.034468 | LOOP [fetch-output : Ensure local output dirs] 2025-12-02 12:36:51.465097 | controller -> localhost | ok: "/var/lib/zuul/builds/17c486c7965748ba9d78235a43340eaf/work/logs" 2025-12-02 12:36:51.666093 | controller -> localhost | changed: "/var/lib/zuul/builds/17c486c7965748ba9d78235a43340eaf/work/artifacts" 2025-12-02 12:36:51.882578 | controller -> localhost | changed: "/var/lib/zuul/builds/17c486c7965748ba9d78235a43340eaf/work/docs" 2025-12-02 12:36:51.895444 | 2025-12-02 12:36:51.895574 | LOOP [fetch-output : Collect logs, artifacts and docs] 2025-12-02 12:36:52.630649 | controller | changed: .d..t...... ./ 2025-12-02 12:36:52.631020 | controller | changed: All items complete 2025-12-02 12:36:52.631081 | 2025-12-02 12:36:53.087121 | controller | changed: .d..t...... ./ 2025-12-02 12:36:53.579826 | controller | changed: .d..t...... ./ 2025-12-02 12:36:53.606574 | 2025-12-02 12:36:53.606726 | TASK [include_role : fetch-output-openshift] 2025-12-02 12:36:53.631988 | controller | skipping: Conditional result was False 2025-12-02 12:36:53.641026 | 2025-12-02 12:36:53.641167 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2025-12-02 12:36:54.061462 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.011859 2025-12-02 12:36:54.351222 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.012260 2025-12-02 12:36:54.409988 | 2025-12-02 12:36:54.410097 | PLAY [localhost] 2025-12-02 12:36:54.427701 | 2025-12-02 12:36:54.427816 | TASK [Run Zuul manifest role] 2025-12-02 12:36:54.448460 | localhost | ok 2025-12-02 12:36:54.465808 | 2025-12-02 12:36:54.465895 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-12-02 12:36:54.872040 | localhost | changed 2025-12-02 12:36:54.876731 | 2025-12-02 12:36:54.876822 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-12-02 12:36:54.906165 | localhost | ok 2025-12-02 12:36:54.916945 | 2025-12-02 12:36:54.917078 | TASK [Set zuul-log-path fact] 2025-12-02 12:36:54.938701 | localhost | ok 2025-12-02 12:36:54.955753 | 2025-12-02 12:36:54.955839 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-02 12:36:54.985001 | localhost | ok 2025-12-02 12:36:54.995462 | 2025-12-02 12:36:54.995540 | LOOP [Run upload-logs-swift role] 2025-12-02 12:36:55.019529 | localhost | Output suppressed because no_log was given 2025-12-02 12:36:55.049677 | 2025-12-02 12:36:55.049786 | TASK [Set zuul-log-path fact] 2025-12-02 12:36:55.074875 | localhost | skipping: Conditional result was False 2025-12-02 12:36:55.102203 | 2025-12-02 12:36:55.102345 | TASK [upload-logs-swift : Ensure logs are readable before uploading] 2025-12-02 12:36:55.412863 | localhost -> localhost | ok: Runtime: 0:00:00.006367 2025-12-02 12:36:55.418190 | 2025-12-02 12:36:55.418255 | TASK [upload-logs-swift : Upload logs to swift]