2025-11-29 11:57:15.098538 | Job console starting... 2025-11-29 11:57:15.110321 | Updating repositories 2025-11-29 11:57:15.143394 | Preparing job workspace 2025-11-29 11:57:18.820493 | Running Ansible setup... 2025-11-29 11:57:23.672163 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2025-11-29 11:57:24.224352 | 2025-11-29 11:57:24.224539 | PLAY [localhost] 2025-11-29 11:57:24.232601 | 2025-11-29 11:57:24.232684 | TASK [Gathering Facts] 2025-11-29 11:57:25.174480 | localhost | ok 2025-11-29 11:57:25.202746 | 2025-11-29 11:57:25.202843 | TASK [Setup log path fact] 2025-11-29 11:57:25.223482 | localhost | ok 2025-11-29 11:57:25.240139 | 2025-11-29 11:57:25.240227 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-29 11:57:25.282602 | localhost | ok 2025-11-29 11:57:25.297789 | 2025-11-29 11:57:25.297874 | TASK [emit-job-header : Print job information] 2025-11-29 11:57:25.350643 | # Job Information 2025-11-29 11:57:25.350883 | Ansible Version: 2.15.12 2025-11-29 11:57:25.350948 | Job: ansible-galaxy-importer 2025-11-29 11:57:25.351016 | Pipeline: third-party-check 2025-11-29 11:57:25.351058 | Executor: ze02.softwarefactory-project.io 2025-11-29 11:57:25.351097 | Triggered by: https://github.com/ansible-collections/community.clickhouse/pull/164 2025-11-29 11:57:25.351143 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/45e/ansible/45e277aa8b7746339461fe3f126e2a24/ 2025-11-29 11:57:25.351185 | Event ID: 8bf761c0-cd18-11f0-908d-039a708e0f1f 2025-11-29 11:57:25.358950 | 2025-11-29 11:57:25.359103 | LOOP [emit-job-header : Print node information] 2025-11-29 11:57:25.482715 | localhost | ok: 2025-11-29 11:57:25.483109 | localhost | # Node Information 2025-11-29 11:57:25.483168 | localhost | Inventory Hostname: controller 2025-11-29 11:57:25.483211 | localhost | Hostname: np0005539838 2025-11-29 11:57:25.483251 | localhost | Username: zuul 2025-11-29 11:57:25.483294 | localhost | Distro: Fedora 37 2025-11-29 11:57:25.483332 | localhost | Provider: ansible-vexxhost-ca-ymq-1 2025-11-29 11:57:25.483368 | localhost | Region: ca-ymq-1 2025-11-29 11:57:25.483404 | localhost | Label: ansible-fedora-37-1vcpu 2025-11-29 11:57:25.483439 | localhost | Product Name: OpenStack Nova 2025-11-29 11:57:25.483474 | localhost | Interface IP: 162.253.55.218 2025-11-29 11:57:25.502941 | 2025-11-29 11:57:25.503126 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-29 11:57:25.917421 | localhost -> localhost | changed 2025-11-29 11:57:25.928651 | 2025-11-29 11:57:25.928817 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-29 11:57:26.871507 | localhost -> localhost | changed 2025-11-29 11:57:26.912858 | 2025-11-29 11:57:26.912975 | PLAY [all:!appliance*] 2025-11-29 11:57:26.944540 | 2025-11-29 11:57:26.944625 | TASK [include_role : start-zuul-console] 2025-11-29 11:57:26.968331 | controller | ok 2025-11-29 11:57:26.986586 | 2025-11-29 11:57:26.986693 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-29 11:57:27.390455 | controller | ok 2025-11-29 11:57:27.412979 | 2025-11-29 11:57:27.413110 | TASK [use-our-mirror : Retrieve the IP address] 2025-11-29 11:57:28.742317 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found 2025-11-29 11:57:28.756057 | 2025-11-29 11:57:28.756186 | TASK [use-our-mirror : Ensure the registry service is running on the mirror] 2025-11-29 11:57:29.306771 | controller | skipping: Conditional result was False 2025-11-29 11:57:29.320300 | 2025-11-29 11:57:29.320442 | TASK [use-our-mirror : Write the IP in /etc/hosts] 2025-11-29 11:57:29.347996 | controller | skipping: Conditional result was False 2025-11-29 11:57:29.361763 | 2025-11-29 11:57:29.361895 | TASK [use-our-mirror : Create the podman configuration directory] 2025-11-29 11:57:29.388624 | controller | skipping: Conditional result was False 2025-11-29 11:57:29.401495 | 2025-11-29 11:57:29.401636 | TASK [use-our-mirror : Copy the podman configuration] 2025-11-29 11:57:29.428336 | controller | skipping: Conditional result was False 2025-11-29 11:57:29.441247 | 2025-11-29 11:57:29.441379 | TASK [use-our-mirror : Copy the Yum configuration (main)] 2025-11-29 11:57:29.468918 | controller | skipping: Conditional result was False 2025-11-29 11:57:29.484460 | 2025-11-29 11:57:29.484597 | TASK [use-our-mirror : Copy the Yum configuration (update)] 2025-11-29 11:57:29.511305 | controller | skipping: Conditional result was False 2025-11-29 11:57:29.534695 | 2025-11-29 11:57:29.534828 | TASK [Disable Fedora Modular] 2025-11-29 11:57:29.817625 | controller | changed 2025-11-29 11:57:29.829902 | 2025-11-29 11:57:29.830026 | TASK [Enable EPEL] 2025-11-29 11:57:29.857817 | controller | skipping: Conditional result was False 2025-11-29 11:57:29.870815 | 2025-11-29 11:57:29.870950 | TASK [Register the RHEL node] 2025-11-29 11:57:30.433476 | 2025-11-29 11:57:30.433750 | TASK [Show the subscription-manager status] 2025-11-29 11:57:31.024441 | controller | skipping: Conditional result was False 2025-11-29 11:57:31.033734 | 2025-11-29 11:57:31.033822 | TASK [Enable EPEL on RHEL] 2025-11-29 11:57:31.575002 | controller | skipping: Conditional result was False 2025-11-29 11:57:31.588068 | 2025-11-29 11:57:31.588209 | TASK [Install git and tox] 2025-11-29 11:58:53.582801 | controller | changed 2025-11-29 11:58:53.595826 | 2025-11-29 11:58:53.595964 | TASK [include_role : prepare-workspace] 2025-11-29 11:58:53.632744 | controller | ok 2025-11-29 11:58:53.670860 | 2025-11-29 11:58:53.670995 | TASK [prepare-workspace : Start zuul_console daemon.] 2025-11-29 11:58:53.922897 | controller | ok 2025-11-29 11:58:53.936046 | 2025-11-29 11:58:53.936178 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2025-11-29 11:58:54.888493 | controller | Output suppressed because no_log was given 2025-11-29 11:58:54.911106 | 2025-11-29 11:58:54.911267 | TASK [include_role : prepare-workspace-openshift] 2025-11-29 11:58:54.936021 | controller | skipping: Conditional result was False 2025-11-29 11:58:54.964599 | 2025-11-29 11:58:54.964703 | PLAY [all:!appliance] 2025-11-29 11:58:54.985972 | 2025-11-29 11:58:54.986051 | TASK [Run add-build-sshkey role (RSA)] 2025-11-29 11:58:55.017314 | controller | ok 2025-11-29 11:58:55.036310 | 2025-11-29 11:58:55.036400 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-29 11:58:55.295083 | controller -> localhost | ok 2025-11-29 11:58:55.309083 | 2025-11-29 11:58:55.309242 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-29 11:58:55.348799 | controller | ok 2025-11-29 11:58:55.375609 | controller | included: /var/lib/zuul/builds/45e277aa8b7746339461fe3f126e2a24/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-29 11:58:55.383949 | 2025-11-29 11:58:55.384031 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-29 11:58:55.897545 | controller -> localhost | Generating public/private rsa key pair. 2025-11-29 11:58:55.898033 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/45e277aa8b7746339461fe3f126e2a24/work/45e277aa8b7746339461fe3f126e2a24_id_rsa. 2025-11-29 11:58:55.898079 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/45e277aa8b7746339461fe3f126e2a24/work/45e277aa8b7746339461fe3f126e2a24_id_rsa.pub. 2025-11-29 11:58:55.898112 | controller -> localhost | The key fingerprint is: 2025-11-29 11:58:55.898143 | controller -> localhost | SHA256:Sgzm8isHZewcuOvCBjeTj5D7ACpPylOF1doas84FK0E zuul-build-sshkey 2025-11-29 11:58:55.898175 | controller -> localhost | The key's randomart image is: 2025-11-29 11:58:55.898204 | controller -> localhost | +---[RSA 2048]----+ 2025-11-29 11:58:55.898232 | controller -> localhost | | . | 2025-11-29 11:58:55.898261 | controller -> localhost | | E . . | 2025-11-29 11:58:55.898289 | controller -> localhost | | .o= o | 2025-11-29 11:58:55.898423 | controller -> localhost | | .==O . | 2025-11-29 11:58:55.898491 | controller -> localhost | |...B+.X S | 2025-11-29 11:58:55.898531 | controller -> localhost | |* B=o= o | 2025-11-29 11:58:55.898566 | controller -> localhost | |*+oB= o | 2025-11-29 11:58:55.898597 | controller -> localhost | |=O+ o+ | 2025-11-29 11:58:55.898625 | controller -> localhost | |o==o. | 2025-11-29 11:58:55.898657 | controller -> localhost | +----[SHA256]-----+ 2025-11-29 11:58:55.898784 | controller -> localhost | ok: Runtime: 0:00:00.073300 2025-11-29 11:58:55.907727 | 2025-11-29 11:58:55.907818 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-29 11:58:55.940769 | controller | ok 2025-11-29 11:58:55.983175 | controller | included: /var/lib/zuul/builds/45e277aa8b7746339461fe3f126e2a24/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-29 11:58:55.991687 | 2025-11-29 11:58:55.991747 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-29 11:58:56.015424 | controller | skipping: Conditional result was False 2025-11-29 11:58:56.024204 | 2025-11-29 11:58:56.024299 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-29 11:58:56.436560 | controller | changed 2025-11-29 11:58:56.448542 | 2025-11-29 11:58:56.448701 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-29 11:58:56.681245 | controller | ok 2025-11-29 11:58:56.693233 | 2025-11-29 11:58:56.693363 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-29 11:58:57.341639 | controller | changed 2025-11-29 11:58:57.353957 | 2025-11-29 11:58:57.354083 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-29 11:58:58.016216 | controller | changed 2025-11-29 11:58:58.028563 | 2025-11-29 11:58:58.028720 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-29 11:58:58.055116 | controller | skipping: Conditional result was False 2025-11-29 11:58:58.068220 | 2025-11-29 11:58:58.068376 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-29 11:58:58.511523 | controller -> localhost | changed 2025-11-29 11:58:58.535892 | 2025-11-29 11:58:58.536022 | TASK [add-build-sshkey : Add back temp key] 2025-11-29 11:58:58.878180 | controller -> localhost | Identity added: /var/lib/zuul/builds/45e277aa8b7746339461fe3f126e2a24/work/45e277aa8b7746339461fe3f126e2a24_id_rsa (zuul-build-sshkey) 2025-11-29 11:58:58.878520 | controller -> localhost | ok: Runtime: 0:00:00.013205 2025-11-29 11:58:58.893943 | 2025-11-29 11:58:58.894071 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-29 11:58:59.217288 | controller | ok 2025-11-29 11:58:59.228988 | 2025-11-29 11:58:59.229114 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-29 11:58:59.266542 | controller | skipping: Conditional result was False 2025-11-29 11:58:59.290895 | 2025-11-29 11:58:59.291032 | TASK [Run add-build-sshkey role (ECDSA)] 2025-11-29 11:58:59.328147 | controller | ok 2025-11-29 11:58:59.358885 | 2025-11-29 11:58:59.358989 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-29 11:58:59.617275 | controller -> localhost | ok 2025-11-29 11:58:59.623841 | 2025-11-29 11:58:59.623902 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-29 11:58:59.643247 | controller | ok 2025-11-29 11:58:59.653479 | controller | included: /var/lib/zuul/builds/45e277aa8b7746339461fe3f126e2a24/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-29 11:58:59.660030 | 2025-11-29 11:58:59.660090 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-29 11:58:59.927227 | controller -> localhost | Generating public/private ecdsa key pair. 2025-11-29 11:58:59.927576 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/45e277aa8b7746339461fe3f126e2a24/work/45e277aa8b7746339461fe3f126e2a24_id_ecdsa. 2025-11-29 11:58:59.927635 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/45e277aa8b7746339461fe3f126e2a24/work/45e277aa8b7746339461fe3f126e2a24_id_ecdsa.pub. 2025-11-29 11:58:59.927728 | controller -> localhost | The key fingerprint is: 2025-11-29 11:58:59.927777 | controller -> localhost | SHA256:1PJ7s8jsMwCCZZG6VUwylBTCNL3pYdrDvVDf7W24DRE zuul-build-sshkey 2025-11-29 11:58:59.927820 | controller -> localhost | The key's randomart image is: 2025-11-29 11:58:59.927861 | controller -> localhost | +---[ECDSA 521]---+ 2025-11-29 11:58:59.927901 | controller -> localhost | | o++BB. | 2025-11-29 11:58:59.927941 | controller -> localhost | | .o*oo . | 2025-11-29 11:58:59.927980 | controller -> localhost | | = + o . E | 2025-11-29 11:58:59.928018 | controller -> localhost | | o B o. o . | 2025-11-29 11:58:59.928057 | controller -> localhost | | O = oS.... | 2025-11-29 11:58:59.928095 | controller -> localhost | | o * . o .... | 2025-11-29 11:58:59.928134 | controller -> localhost | | o . ...+o | 2025-11-29 11:58:59.928172 | controller -> localhost | | . oooo=o | 2025-11-29 11:58:59.928211 | controller -> localhost | | .=ooo. | 2025-11-29 11:58:59.928248 | controller -> localhost | +----[SHA256]-----+ 2025-11-29 11:58:59.928338 | controller -> localhost | ok: Runtime: 0:00:00.007717 2025-11-29 11:58:59.941841 | 2025-11-29 11:58:59.941965 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-29 11:58:59.969364 | controller | ok 2025-11-29 11:58:59.985011 | controller | included: /var/lib/zuul/builds/45e277aa8b7746339461fe3f126e2a24/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-29 11:58:59.999633 | 2025-11-29 11:58:59.999738 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-29 11:59:00.014351 | controller | skipping: Conditional result was False 2025-11-29 11:59:00.023577 | 2025-11-29 11:59:00.023687 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-29 11:59:00.316111 | controller | changed 2025-11-29 11:59:00.328205 | 2025-11-29 11:59:00.328336 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-29 11:59:00.559428 | controller | ok 2025-11-29 11:59:00.572005 | 2025-11-29 11:59:00.572128 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-29 11:59:01.191414 | controller | changed 2025-11-29 11:59:01.204793 | 2025-11-29 11:59:01.204930 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-29 11:59:01.824347 | controller | changed 2025-11-29 11:59:01.837969 | 2025-11-29 11:59:01.838104 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-29 11:59:01.864385 | controller | skipping: Conditional result was False 2025-11-29 11:59:01.878517 | 2025-11-29 11:59:01.878707 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-29 11:59:02.158616 | controller -> localhost | changed 2025-11-29 11:59:02.170708 | 2025-11-29 11:59:02.170774 | TASK [add-build-sshkey : Add back temp key] 2025-11-29 11:59:02.490790 | controller -> localhost | Identity added: /var/lib/zuul/builds/45e277aa8b7746339461fe3f126e2a24/work/45e277aa8b7746339461fe3f126e2a24_id_ecdsa (zuul-build-sshkey) 2025-11-29 11:59:02.491139 | controller -> localhost | ok: Runtime: 0:00:00.012882 2025-11-29 11:59:02.504511 | 2025-11-29 11:59:02.504637 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-29 11:59:02.717498 | controller | ok 2025-11-29 11:59:02.729479 | 2025-11-29 11:59:02.729602 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-29 11:59:02.765795 | controller | skipping: Conditional result was False 2025-11-29 11:59:02.791831 | 2025-11-29 11:59:02.791955 | TASK [include_role : remove-zuul-sshkey] 2025-11-29 11:59:02.808000 | controller | skipping: Conditional result was False 2025-11-29 11:59:02.823437 | 2025-11-29 11:59:02.823568 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2025-11-29 11:59:03.056393 | controller | ok: "logs" 2025-11-29 11:59:03.056632 | controller | ok: All items complete 2025-11-29 11:59:03.056659 | 2025-11-29 11:59:03.260222 | controller | ok: "artifacts" 2025-11-29 11:59:03.459603 | controller | ok: "docs" 2025-11-29 11:59:03.483772 | 2025-11-29 11:59:03.484117 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2025-11-29 11:59:03.845727 | controller | changed: "logs" 2025-11-29 11:59:04.057718 | controller | changed: "artifacts" 2025-11-29 11:59:04.268547 | controller | changed: "docs" 2025-11-29 11:59:04.359232 | 2025-11-29 11:59:04.359339 | PLAY RECAP 2025-11-29 11:59:04.359380 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0 2025-11-29 11:59:04.359405 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-11-29 11:59:04.359422 | 2025-11-29 11:59:04.462063 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2025-11-29 11:59:04.463507 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-galaxy-importer/pre.yaml@master] 2025-11-29 11:59:05.022310 | 2025-11-29 11:59:05.022485 | PLAY [all] 2025-11-29 11:59:05.042931 | 2025-11-29 11:59:05.043008 | TASK [Setup ensure-tox role] 2025-11-29 11:59:05.062818 | controller | ok 2025-11-29 11:59:05.085154 | 2025-11-29 11:59:05.085229 | TASK [Install pip] 2025-11-29 11:59:05.104428 | controller | ok 2025-11-29 11:59:05.125486 | 2025-11-29 11:59:05.125558 | TASK [ensure-pip : Check if pip is installed] 2025-11-29 11:59:05.532987 | controller | /usr/bin/pip3 2025-11-29 11:59:05.550548 | controller | /usr/bin/python3: No module named wheel 2025-11-29 11:59:05.655735 | controller | ok: Runtime: 0:00:00.028517 2025-11-29 11:59:05.668042 | 2025-11-29 11:59:05.668171 | LOOP [ensure-pip : Install pip from packages] 2025-11-29 11:59:05.718391 | controller | ok: "/var/lib/zuul/builds/45e277aa8b7746339461fe3f126e2a24/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/RedHat.yaml" 2025-11-29 11:59:05.745533 | controller | included: /var/lib/zuul/builds/45e277aa8b7746339461fe3f126e2a24/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/RedHat.yaml 2025-11-29 11:59:05.765841 | 2025-11-29 11:59:05.765976 | TASK [ensure-pip : Install Python 3 pip] 2025-11-29 11:59:10.541550 | controller | changed 2025-11-29 11:59:10.553971 | 2025-11-29 11:59:10.554097 | TASK [ensure-pip : Check for EPEL repository] 2025-11-29 11:59:10.582158 | controller | skipping: Conditional result was False 2025-11-29 11:59:10.595408 | 2025-11-29 11:59:10.595547 | TASK [ensure-pip : Fail with instructions when EPEL is not installed] 2025-11-29 11:59:10.623510 | controller | skipping: Conditional result was False 2025-11-29 11:59:10.637497 | 2025-11-29 11:59:10.637636 | TASK [ensure-pip : Install Python 2 pip] 2025-11-29 11:59:10.664641 | controller | skipping: Conditional result was False 2025-11-29 11:59:10.677640 | 2025-11-29 11:59:10.677801 | TASK [ensure-pip : Ensure setuptools] 2025-11-29 11:59:10.707057 | controller | skipping: Conditional result was False 2025-11-29 11:59:10.721672 | 2025-11-29 11:59:10.721862 | TASK [ensure-pip : Check for ensurepip module] 2025-11-29 11:59:11.268988 | controller | skipping: Conditional result was False 2025-11-29 11:59:11.282632 | 2025-11-29 11:59:11.282812 | TASK [ensure-pip : Ensure python3-venv] 2025-11-29 11:59:11.310244 | controller | skipping: Conditional result was False 2025-11-29 11:59:11.323449 | 2025-11-29 11:59:11.323581 | TASK [ensure-pip : Install pip from source] 2025-11-29 11:59:11.350168 | controller | skipping: Conditional result was False 2025-11-29 11:59:11.363343 | 2025-11-29 11:59:11.363470 | TASK [ensure-pip : Probe for venv python full path] 2025-11-29 11:59:11.719292 | controller | /usr/bin/python3 2025-11-29 11:59:11.913888 | controller | ok: Runtime: 0:00:00.007736 2025-11-29 11:59:11.964551 | 2025-11-29 11:59:11.964769 | TASK [ensure-pip : Set host default] 2025-11-29 11:59:12.041758 | controller | ok 2025-11-29 11:59:12.053306 | 2025-11-29 11:59:12.053433 | TASK [ensure-pip : Set ensure_pip_virtualenv_command] 2025-11-29 11:59:12.124252 | controller | ok 2025-11-29 11:59:12.146362 | 2025-11-29 11:59:12.146499 | TASK [ensure-tox : Check if tox is installed] 2025-11-29 11:59:12.448278 | controller | /usr/bin/tox 2025-11-29 11:59:12.691548 | controller | ok: Runtime: 0:00:00.004330 2025-11-29 11:59:12.703920 | 2025-11-29 11:59:12.704050 | TASK [ensure-tox : Export preinstalled tox_exectuable] 2025-11-29 11:59:12.754245 | controller | ok 2025-11-29 11:59:12.765584 | 2025-11-29 11:59:12.765745 | TASK [ensure-tox : Create local venv] 2025-11-29 11:59:13.319721 | controller | skipping: Conditional result was False 2025-11-29 11:59:13.332482 | 2025-11-29 11:59:13.332551 | TASK [ensure-tox : Install tox to local venv] 2025-11-29 11:59:13.875170 | controller | skipping: Conditional result was False 2025-11-29 11:59:13.888697 | 2025-11-29 11:59:13.888834 | TASK [ensure-tox : Export installed tox_executable path] 2025-11-29 11:59:13.915403 | controller | skipping: Conditional result was False 2025-11-29 11:59:13.927729 | 2025-11-29 11:59:13.927857 | TASK [ensure-tox : Output tox version] 2025-11-29 11:59:14.362919 | controller | 3.28.0 imported from /usr/lib/python3.11/site-packages/tox/__init__.py 2025-11-29 11:59:14.483128 | controller | ok: Runtime: 0:00:00.157489 2025-11-29 11:59:14.494899 | 2025-11-29 11:59:14.495019 | TASK [ensure-tox : Make global symlink] 2025-11-29 11:59:14.521756 | controller | skipping: Conditional result was False 2025-11-29 11:59:14.544396 | 2025-11-29 11:59:14.544522 | TASK [Setup tox role] 2025-11-29 11:59:14.572293 | controller | ok 2025-11-29 11:59:14.613964 | 2025-11-29 11:59:14.614049 | TASK [tox : Check to see if the constraints file exists] 2025-11-29 11:59:14.649167 | controller | skipping: Conditional result was False 2025-11-29 11:59:14.657057 | 2025-11-29 11:59:14.657137 | TASK [tox : Fail if constraints file is missing] 2025-11-29 11:59:14.692052 | controller | skipping: Conditional result was False 2025-11-29 11:59:14.705067 | 2025-11-29 11:59:14.705194 | TASK [tox : Record file location] 2025-11-29 11:59:14.731868 | controller | skipping: Conditional result was False 2025-11-29 11:59:14.745003 | 2025-11-29 11:59:14.745127 | TASK [tox : Install tox siblings] 2025-11-29 11:59:14.762291 | controller | skipping: Conditional result was False 2025-11-29 11:59:14.778716 | 2025-11-29 11:59:14.778845 | TASK [tox : Emit tox command] 2025-11-29 11:59:14.826376 | /usr/bin/tox -evenv -vv --notest 2025-11-29 11:59:14.837751 | 2025-11-29 11:59:14.837879 | TASK [tox : Run tox] 2025-11-29 11:59:15.259250 | controller | using tox.ini: /home/zuul/src/github.com/ansible-network/releases/tox.ini (pid 2312) 2025-11-29 11:59:15.266760 | controller | using tox-3.28.0 from /usr/lib/python3.11/site-packages/tox/__init__.py (pid 2312) 2025-11-29 11:59:15.289090 | controller | skipping sdist step 2025-11-29 11:59:15.289109 | controller | venv uses /usr/bin/python3 2025-11-29 11:59:15.289129 | controller | venv start: getenv /home/zuul/src/github.com/ansible-network/releases/.tox/venv 2025-11-29 11:59:15.289585 | controller | venv cannot reuse: no previous config /home/zuul/src/github.com/ansible-network/releases/.tox/venv/.tox-config1 2025-11-29 11:59:15.289771 | controller | venv create: /home/zuul/src/github.com/ansible-network/releases/.tox/venv 2025-11-29 11:59:15.289786 | 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-11-29 11:59:15.289796 | controller | [2320] /home/zuul/src/github.com/ansible-network/releases/.tox$ /usr/bin/python3 -m virtualenv --no-download --python /usr/bin/python3 venv 2025-11-29 11:59:15.879295 | controller | created virtual environment CPython3.11.0.final.0-64 in 505ms 2025-11-29 11:59:15.905123 | controller | creator CPython3Posix(dest=/home/zuul/src/github.com/ansible-network/releases/.tox/venv, clear=False, no_vcs_ignore=False, global=False) 2025-11-29 11:59:15.905173 | 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-11-29 11:59:15.905185 | controller | added seed packages: pip==22.2.2, setuptools==62.6.0, wheel==0.37.1 2025-11-29 11:59:15.905190 | controller | activators BashActivator,CShellActivator,FishActivator,NushellActivator,PowerShellActivator,PythonActivator 2025-11-29 11:59:15.905203 | 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-11-29 11:59:15.905739 | 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-11-29 11:59:15.906125 | controller | [2328] /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-11-29 12:03:53.355724 | [Zuul] Log Stream did not terminate 2025-11-29 12:03:53.355981 | controller | ERROR 2025-11-29 12:03:53.356067 | controller | { 2025-11-29 12:03:53.356093 | controller | "msg": "Data could not be sent to remote host \"162.253.55.218\". Make sure this host can be reached over ssh: ssh: connect to host 162.253.55.218 port 22: No route to host\r\n", 2025-11-29 12:03:53.356114 | controller | "unreachable": true 2025-11-29 12:03:53.356131 | controller | } unreachable 2025-11-29 12:03:53.357891 | 2025-11-29 12:03:53.357937 | PLAY RECAP 2025-11-29 12:03:53.357976 | controller | ok: 10 changed: 5 unreachable: 1 failed: 0 skipped: 15 rescued: 0 ignored: 0 2025-11-29 12:03:53.357996 | 2025-11-29 12:03:53.465998 | PRE-RUN END RESULT_UNREACHABLE: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-galaxy-importer/pre.yaml@master] 2025-11-29 12:03:53.467613 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master] 2025-11-29 12:03:54.063746 | 2025-11-29 12:03:54.063928 | PLAY [all:!appliance*] 2025-11-29 12:03:54.085831 | 2025-11-29 12:03:54.085913 | TASK [unregister the node] 2025-11-29 12:03:56.522355 | [controller] Waiting on logger 2025-11-29 12:04:17.810640 | controller | skipping: Conditional result was False 2025-11-29 12:04:17.823919 | 2025-11-29 12:04:17.824091 | TASK [include_role : fetch-output] 2025-11-29 12:04:17.874620 | controller | ok 2025-11-29 12:04:17.912864 | 2025-11-29 12:04:17.912956 | TASK [fetch-output : Set log path for multiple nodes] 2025-11-29 12:04:17.990100 | controller | skipping: Conditional result was False 2025-11-29 12:04:18.002615 | 2025-11-29 12:04:18.002778 | TASK [fetch-output : Set log path for single node] 2025-11-29 12:04:18.062804 | controller | ok 2025-11-29 12:04:18.074418 | 2025-11-29 12:04:18.074553 | LOOP [fetch-output : Ensure local output dirs] 2025-11-29 12:04:18.545276 | controller -> localhost | ok: "/var/lib/zuul/builds/45e277aa8b7746339461fe3f126e2a24/work/logs" 2025-11-29 12:04:18.811615 | controller -> localhost | changed: "/var/lib/zuul/builds/45e277aa8b7746339461fe3f126e2a24/work/artifacts" 2025-11-29 12:04:19.093693 | controller -> localhost | changed: "/var/lib/zuul/builds/45e277aa8b7746339461fe3f126e2a24/work/docs" 2025-11-29 12:04:19.117979 | 2025-11-29 12:04:19.118261 | LOOP [fetch-output : Collect logs, artifacts and docs] 2025-11-29 12:04:19.898219 | controller | changed: .d..t...... ./ 2025-11-29 12:04:19.898657 | controller | changed: All items complete 2025-11-29 12:04:19.898753 | 2025-11-29 12:04:20.473002 | controller | changed: .d..t...... ./ 2025-11-29 12:04:21.051014 | controller | changed: .d..t...... ./ 2025-11-29 12:04:21.086164 | 2025-11-29 12:04:21.086456 | TASK [include_role : fetch-output-openshift] 2025-11-29 12:04:21.116888 | controller | skipping: Conditional result was False 2025-11-29 12:04:21.136231 | 2025-11-29 12:04:21.136501 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2025-11-29 12:04:21.588078 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.007740 2025-11-29 12:04:21.901658 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.007914 2025-11-29 12:04:21.936610 | 2025-11-29 12:04:21.936707 | PLAY [localhost] 2025-11-29 12:04:21.948769 | 2025-11-29 12:04:21.948831 | TASK [Run Zuul manifest role] 2025-11-29 12:04:21.967204 | localhost | ok 2025-11-29 12:04:21.980339 | 2025-11-29 12:04:21.980408 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-11-29 12:04:22.399413 | localhost | changed 2025-11-29 12:04:22.409246 | 2025-11-29 12:04:22.409381 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-11-29 12:04:22.456800 | localhost | ok 2025-11-29 12:04:22.475992 | 2025-11-29 12:04:22.476124 | TASK [Set zuul-log-path fact] 2025-11-29 12:04:22.498319 | localhost | ok 2025-11-29 12:04:22.516189 | 2025-11-29 12:04:22.516277 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-29 12:04:22.546430 | localhost | ok 2025-11-29 12:04:22.557439 | 2025-11-29 12:04:22.557521 | LOOP [Run upload-logs-swift role] 2025-11-29 12:04:22.605307 | localhost | Output suppressed because no_log was given 2025-11-29 12:04:22.639550 | 2025-11-29 12:04:22.639715 | TASK [Set zuul-log-path fact] 2025-11-29 12:04:22.716610 | localhost | skipping: Conditional result was False 2025-11-29 12:04:22.761642 | 2025-11-29 12:04:22.761820 | TASK [upload-logs-swift : Ensure logs are readable before uploading] 2025-11-29 12:04:23.072521 | localhost -> localhost | ok: Runtime: 0:00:00.008907 2025-11-29 12:04:23.080165 | 2025-11-29 12:04:23.080254 | TASK [upload-logs-swift : Upload logs to swift]