2026-02-13 23:20:19.383272 | Job console starting 2026-02-13 23:20:19.397706 | Updating git repos 2026-02-13 23:20:19.424912 | Cloning repos into workspace 2026-02-13 23:20:19.491081 | Restoring repo states 2026-02-13 23:20:19.498185 | Merging changes 2026-02-13 23:20:19.754917 | Checking out repos 2026-02-13 23:20:19.788887 | Preparing playbooks 2026-02-13 23:20:20.875469 | Running Ansible setup 2026-02-13 23:20:24.631402 | PRE-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/pre.yaml@main] 2026-02-13 23:20:25.297593 | 2026-02-13 23:20:25.297738 | PLAY [localhost] 2026-02-13 23:20:25.306028 | 2026-02-13 23:20:25.306136 | TASK [Gathering Facts] 2026-02-13 23:20:26.446388 | localhost | ok 2026-02-13 23:20:26.458220 | 2026-02-13 23:20:26.458366 | TASK [Setup log path fact] 2026-02-13 23:20:26.491867 | localhost | ok 2026-02-13 23:20:26.504656 | 2026-02-13 23:20:26.506284 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-13 23:20:26.539990 | localhost | ok 2026-02-13 23:20:26.548548 | 2026-02-13 23:20:26.548746 | TASK [emit-job-header : Print job information] 2026-02-13 23:20:26.590885 | # Job Information 2026-02-13 23:20:26.591127 | Ansible Version: 2.16.15 2026-02-13 23:20:26.591169 | Job: ansible-collection-containers-molecule-containerd-rockylinux-9 2026-02-13 23:20:26.591200 | Pipeline: check 2026-02-13 23:20:26.591227 | Executor: 3a2793d2bd32 2026-02-13 23:20:26.591254 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/96 2026-02-13 23:20:26.591284 | Event ID: 4d80af90-0932-11f1-94bb-f36709d2ee90 2026-02-13 23:20:26.595663 | 2026-02-13 23:20:26.595813 | LOOP [emit-job-header : Print node information] 2026-02-13 23:20:26.689855 | localhost | ok: 2026-02-13 23:20:26.690088 | localhost | # Node Information 2026-02-13 23:20:26.690117 | localhost | Inventory Hostname: rockylinux-9 2026-02-13 23:20:26.690139 | localhost | Hostname: np0000155509 2026-02-13 23:20:26.690159 | localhost | Username: zuul 2026-02-13 23:20:26.690182 | localhost | Distro: Rocky 9.7 2026-02-13 23:20:26.690202 | localhost | Provider: yul1 2026-02-13 23:20:26.690223 | localhost | Region: ca-ymq-1 2026-02-13 23:20:26.690242 | localhost | Label: rockylinux-9 2026-02-13 23:20:26.690261 | localhost | Product Name: OpenStack Nova 2026-02-13 23:20:26.690280 | localhost | Interface IP: 199.204.45.99 2026-02-13 23:20:26.708951 | 2026-02-13 23:20:26.709170 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-02-13 23:20:27.176358 | localhost -> localhost | changed 2026-02-13 23:20:27.184307 | 2026-02-13 23:20:27.184453 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-02-13 23:20:28.159998 | localhost -> localhost | changed 2026-02-13 23:20:28.186615 | 2026-02-13 23:20:28.245500 | PLAY [all] 2026-02-13 23:20:28.258949 | 2026-02-13 23:20:28.259070 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-13 23:20:28.487107 | rockylinux-9 -> localhost | ok 2026-02-13 23:20:28.495781 | 2026-02-13 23:20:28.495899 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-13 23:20:28.531521 | rockylinux-9 | ok 2026-02-13 23:20:28.547109 | rockylinux-9 | included: /var/lib/zuul/builds/83e209aef6d04d40afc7364f8a0ca668/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-13 23:20:28.553768 | 2026-02-13 23:20:28.553836 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-13 23:20:30.473580 | rockylinux-9 -> localhost | Generating public/private rsa key pair. 2026-02-13 23:20:30.473768 | rockylinux-9 -> localhost | Your identification has been saved in /var/lib/zuul/builds/83e209aef6d04d40afc7364f8a0ca668/work/83e209aef6d04d40afc7364f8a0ca668_id_rsa 2026-02-13 23:20:30.473799 | rockylinux-9 -> localhost | Your public key has been saved in /var/lib/zuul/builds/83e209aef6d04d40afc7364f8a0ca668/work/83e209aef6d04d40afc7364f8a0ca668_id_rsa.pub 2026-02-13 23:20:30.473821 | rockylinux-9 -> localhost | The key fingerprint is: 2026-02-13 23:20:30.473843 | rockylinux-9 -> localhost | SHA256:ZAmaTeBtWefy+UoILXOmYIVeHqycKP0DNza/5EJsaX0 zuul-build-sshkey 2026-02-13 23:20:30.473876 | rockylinux-9 -> localhost | The key's randomart image is: 2026-02-13 23:20:30.473897 | rockylinux-9 -> localhost | +---[RSA 3072]----+ 2026-02-13 23:20:30.473922 | rockylinux-9 -> localhost | | ..o . . | 2026-02-13 23:20:30.473944 | rockylinux-9 -> localhost | | . O + + | 2026-02-13 23:20:30.473964 | rockylinux-9 -> localhost | | = X = . | 2026-02-13 23:20:30.473983 | rockylinux-9 -> localhost | | . + B = o . | 2026-02-13 23:20:30.474003 | rockylinux-9 -> localhost | |. +.%o= S o | 2026-02-13 23:20:30.474022 | rockylinux-9 -> localhost | | . **=.BE. . | 2026-02-13 23:20:30.474041 | rockylinux-9 -> localhost | | +o +.. . . | 2026-02-13 23:20:30.474061 | rockylinux-9 -> localhost | | .+ . . . | 2026-02-13 23:20:30.474082 | rockylinux-9 -> localhost | | .o . | 2026-02-13 23:20:30.474102 | rockylinux-9 -> localhost | +----[SHA256]-----+ 2026-02-13 23:20:30.474155 | rockylinux-9 -> localhost | ok: Runtime: 0:00:01.504454 2026-02-13 23:20:30.479040 | 2026-02-13 23:20:30.479117 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-13 23:20:30.512769 | rockylinux-9 | ok 2026-02-13 23:20:30.523084 | rockylinux-9 | included: /var/lib/zuul/builds/83e209aef6d04d40afc7364f8a0ca668/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-13 23:20:30.531931 | 2026-02-13 23:20:30.531999 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-13 23:20:30.557905 | rockylinux-9 | skipping: Conditional result was False 2026-02-13 23:20:30.567271 | 2026-02-13 23:20:30.567361 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-13 23:20:31.048725 | rockylinux-9 | changed 2026-02-13 23:20:31.054634 | 2026-02-13 23:20:31.054703 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-13 23:20:31.306107 | rockylinux-9 | ok 2026-02-13 23:20:31.310829 | 2026-02-13 23:20:31.310893 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-13 23:20:32.172448 | rockylinux-9 | changed 2026-02-13 23:20:32.179803 | 2026-02-13 23:20:32.179922 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-13 23:20:32.979784 | rockylinux-9 | changed 2026-02-13 23:20:32.986719 | 2026-02-13 23:20:32.986788 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-13 23:20:33.018203 | rockylinux-9 | skipping: Conditional result was False 2026-02-13 23:20:33.027360 | 2026-02-13 23:20:33.027523 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-13 23:20:33.397124 | rockylinux-9 -> localhost | changed 2026-02-13 23:20:33.406725 | 2026-02-13 23:20:33.406796 | TASK [add-build-sshkey : Add back temp key] 2026-02-13 23:20:33.689789 | rockylinux-9 -> localhost | Identity added: /var/lib/zuul/builds/83e209aef6d04d40afc7364f8a0ca668/work/83e209aef6d04d40afc7364f8a0ca668_id_rsa (zuul-build-sshkey) 2026-02-13 23:20:33.689997 | rockylinux-9 -> localhost | ok: Runtime: 0:00:00.013130 2026-02-13 23:20:33.694931 | 2026-02-13 23:20:33.694993 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-13 23:20:34.083916 | rockylinux-9 | ok 2026-02-13 23:20:34.091362 | 2026-02-13 23:20:34.091437 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-13 23:20:34.121302 | rockylinux-9 | skipping: Conditional result was False 2026-02-13 23:20:34.134201 | 2026-02-13 23:20:34.134305 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-02-13 23:20:34.528008 | rockylinux-9 | ok 2026-02-13 23:20:34.533391 | 2026-02-13 23:20:34.533454 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-02-13 23:20:35.447623 | rockylinux-9 | Output suppressed because no_log was given 2026-02-13 23:20:35.462658 | 2026-02-13 23:20:35.463213 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-02-13 23:20:35.689442 | rockylinux-9 | ok: "logs" 2026-02-13 23:20:35.689699 | rockylinux-9 | ok: All items complete 2026-02-13 23:20:35.689728 | 2026-02-13 23:20:35.912239 | rockylinux-9 | ok: "artifacts" 2026-02-13 23:20:36.126043 | rockylinux-9 | ok: "docs" 2026-02-13 23:20:36.140677 | 2026-02-13 23:20:36.140816 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-02-13 23:20:36.389409 | rockylinux-9 | changed: "logs" 2026-02-13 23:20:36.606734 | rockylinux-9 | changed: "artifacts" 2026-02-13 23:20:36.831550 | rockylinux-9 | changed: "docs" 2026-02-13 23:20:36.844951 | 2026-02-13 23:20:36.845103 | PLAY RECAP 2026-02-13 23:20:36.845162 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-02-13 23:20:36.845203 | rockylinux-9 | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-02-13 23:20:36.845233 | 2026-02-13 23:20:37.035371 | PRE-RUN END RESULT_NORMAL: [trusted : vexxhost.dev/zuul-config/playbooks/base/pre.yaml@main] 2026-02-13 23:20:37.036683 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-02-13 23:20:37.603971 | 2026-02-13 23:20:37.604099 | PLAY [all] 2026-02-13 23:20:37.616938 | 2026-02-13 23:20:37.617040 | TASK [setup-uv : Extract archive] 2026-02-13 23:20:40.478434 | rockylinux-9 | changed 2026-02-13 23:20:40.484168 | 2026-02-13 23:20:40.484279 | TASK [setup-uv : Print version] 2026-02-13 23:20:40.508074 | [rockylinux-9] Waiting on logger 2026-02-13 23:20:41.020868 | rockylinux-9 | ok: Runtime: 0:00:00.013745 2026-02-13 23:20:41.030691 | 2026-02-13 23:20:41.030870 | PLAY RECAP 2026-02-13 23:20:41.030969 | rockylinux-9 | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-02-13 23:20:41.031026 | 2026-02-13 23:20:41.149765 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-02-13 23:20:41.151215 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-02-13 23:20:41.738044 | 2026-02-13 23:20:41.738193 | PLAY [all] 2026-02-13 23:20:41.750174 | 2026-02-13 23:20:41.750275 | TASK [Copy inventory file for Zuul] 2026-02-13 23:20:42.996502 | rockylinux-9 | changed 2026-02-13 23:20:43.003341 | 2026-02-13 23:20:43.003500 | TASK [Switch "ansible_host" to private IP] 2026-02-13 23:20:43.362392 | rockylinux-9 | changed: 1 replacements made 2026-02-13 23:20:43.368423 | 2026-02-13 23:20:43.368494 | TASK [Run Molecule scenario] 2026-02-13 23:20:43.391507 | [rockylinux-9] Waiting on logger 2026-02-13 23:20:51.531518 | [rockylinux-9] Waiting on logger 2026-02-13 23:21:01.701896 | [rockylinux-9] Waiting on logger 2026-02-13 23:21:11.877617 | [rockylinux-9] Waiting on logger 2026-02-13 23:21:22.053781 | [rockylinux-9] Waiting on logger 2026-02-13 23:21:32.229956 | [rockylinux-9] Waiting on logger 2026-02-13 23:21:42.405984 | [rockylinux-9] Waiting on logger 2026-02-13 23:21:51.563115 | [rockylinux-9] Waiting on logger 2026-02-13 23:22:01.738042 | [rockylinux-9] Waiting on logger 2026-02-13 23:22:11.913861 | [rockylinux-9] Waiting on logger 2026-02-13 23:22:22.085984 | [rockylinux-9] Waiting on logger 2026-02-13 23:22:32.262336 | [rockylinux-9] Waiting on logger 2026-02-13 23:22:42.437923 | [rockylinux-9] Waiting on logger 2026-02-13 23:22:51.595264 | [rockylinux-9] Waiting on logger 2026-02-13 23:23:01.770182 | [rockylinux-9] Waiting on logger 2026-02-13 23:23:11.942033 | [rockylinux-9] Waiting on logger 2026-02-13 23:23:22.121918 | [rockylinux-9] Waiting on logger 2026-02-13 23:23:32.293852 | [rockylinux-9] Waiting on logger 2026-02-13 23:23:42.469953 | [rockylinux-9] Waiting on logger 2026-02-13 23:23:51.627127 | [rockylinux-9] Waiting on logger 2026-02-13 23:24:01.797951 | [rockylinux-9] Waiting on logger 2026-02-13 23:24:11.974039 | [rockylinux-9] Waiting on logger 2026-02-13 23:24:22.149882 | [rockylinux-9] Waiting on logger 2026-02-13 23:24:32.326161 | [rockylinux-9] Waiting on logger 2026-02-13 23:24:42.502230 | [rockylinux-9] Waiting on logger 2026-02-13 23:24:45.965599 | rockylinux-9 | ok: Runtime: 0:04:01.937857 2026-02-13 23:24:45.972668 | 2026-02-13 23:24:45.972718 | PLAY RECAP 2026-02-13 23:24:45.972776 | rockylinux-9 | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-02-13 23:24:45.972803 | 2026-02-13 23:24:46.080607 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-02-13 23:24:46.082875 | POST-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/post.yaml@main] 2026-02-13 23:24:46.720997 | 2026-02-13 23:24:46.721152 | PLAY [all] 2026-02-13 23:24:46.732329 | 2026-02-13 23:24:46.732415 | TASK [fetch-output : Set log path for multiple nodes] 2026-02-13 23:24:46.778104 | rockylinux-9 | skipping: Conditional result was False 2026-02-13 23:24:46.787829 | 2026-02-13 23:24:46.788019 | TASK [fetch-output : Set log path for single node] 2026-02-13 23:24:46.823077 | rockylinux-9 | ok 2026-02-13 23:24:46.827952 | 2026-02-13 23:24:46.828054 | LOOP [fetch-output : Ensure local output dirs] 2026-02-13 23:24:47.221371 | rockylinux-9 -> localhost | ok: "/var/lib/zuul/builds/83e209aef6d04d40afc7364f8a0ca668/work/logs" 2026-02-13 23:24:47.430519 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/83e209aef6d04d40afc7364f8a0ca668/work/artifacts" 2026-02-13 23:24:47.640339 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/83e209aef6d04d40afc7364f8a0ca668/work/docs" 2026-02-13 23:24:47.657994 | 2026-02-13 23:24:47.658153 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-02-13 23:24:48.321005 | rockylinux-9 | changed: .d..t...... ./ 2026-02-13 23:24:48.321317 | rockylinux-9 | changed: All items complete 2026-02-13 23:24:48.321363 | 2026-02-13 23:24:48.813051 | rockylinux-9 | changed: .d..t...... ./ 2026-02-13 23:24:49.299125 | rockylinux-9 | changed: .d..t...... ./ 2026-02-13 23:24:49.316123 | 2026-02-13 23:24:49.316666 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-02-13 23:24:49.732888 | rockylinux-9 -> localhost | ok: Item: artifacts Runtime: 0:00:00.007615 2026-02-13 23:24:49.960362 | rockylinux-9 -> localhost | ok: Item: docs Runtime: 0:00:00.006128 2026-02-13 23:24:49.979997 | 2026-02-13 23:24:49.980151 | PLAY [all] 2026-02-13 23:24:49.985864 | 2026-02-13 23:24:49.985935 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-02-13 23:24:50.446085 | rockylinux-9 | changed 2026-02-13 23:24:50.451885 | 2026-02-13 23:24:50.451936 | PLAY RECAP 2026-02-13 23:24:50.451984 | rockylinux-9 | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-02-13 23:24:50.452006 | 2026-02-13 23:24:50.575626 | POST-RUN END RESULT_NORMAL: [trusted : vexxhost.dev/zuul-config/playbooks/base/post.yaml@main] 2026-02-13 23:24:50.577691 | POST-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/post-logs.yaml@main] 2026-02-13 23:24:51.131151 | 2026-02-13 23:24:51.131290 | PLAY [localhost] 2026-02-13 23:24:51.141959 | 2026-02-13 23:24:51.142037 | TASK [Generate Zuul manifest] 2026-02-13 23:24:51.171812 | localhost | ok 2026-02-13 23:24:51.188409 | 2026-02-13 23:24:51.188537 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-02-13 23:24:51.494596 | localhost | changed 2026-02-13 23:24:51.506735 | 2026-02-13 23:24:51.506810 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-02-13 23:24:51.537610 | localhost | ok 2026-02-13 23:24:51.545152 | 2026-02-13 23:24:51.545212 | TASK [Upload logs] 2026-02-13 23:24:51.566013 | localhost | ok 2026-02-13 23:24:51.621066 | 2026-02-13 23:24:51.621166 | TASK [Set zuul-log-path fact] 2026-02-13 23:24:51.641260 | localhost | ok 2026-02-13 23:24:51.653501 | 2026-02-13 23:24:51.653572 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-13 23:24:51.685930 | localhost | ok 2026-02-13 23:24:51.693245 | 2026-02-13 23:24:51.693308 | TASK [upload-logs : Create log directories] 2026-02-13 23:24:52.101159 | localhost | changed 2026-02-13 23:24:52.107556 | 2026-02-13 23:24:52.107653 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-02-13 23:24:52.496590 | localhost -> localhost | ok: Runtime: 0:00:00.004845 2026-02-13 23:24:52.503005 | 2026-02-13 23:24:52.503072 | TASK [upload-logs : Upload logs to log server] 2026-02-13 23:24:52.960637 | localhost | Output suppressed because no_log was given 2026-02-13 23:24:52.965091 | 2026-02-13 23:24:52.965157 | LOOP [upload-logs : Compress console log and json output] 2026-02-13 23:24:53.006100 | localhost | skipping: Conditional result was False 2026-02-13 23:24:53.012169 | localhost | skipping: Conditional result was False 2026-02-13 23:24:53.027233 | 2026-02-13 23:24:53.027339 | LOOP [upload-logs : Upload compressed console log and json output] 2026-02-13 23:24:53.067686 | localhost | skipping: Conditional result was False 2026-02-13 23:24:53.068063 | 2026-02-13 23:24:53.070961 | localhost | skipping: Conditional result was False 2026-02-13 23:24:53.080469 | 2026-02-13 23:24:53.080640 | LOOP [upload-logs : Upload console log and json output]