2026-03-05 16:17:47.100393 | Job console starting 2026-03-05 16:17:47.112461 | Updating git repos 2026-03-05 16:17:47.135125 | Cloning repos into workspace 2026-03-05 16:17:47.224394 | Restoring repo states 2026-03-05 16:17:47.231329 | Merging changes 2026-03-05 16:17:47.556948 | Checking out repos 2026-03-05 16:17:47.605071 | Preparing playbooks 2026-03-05 16:17:48.897452 | Running Ansible setup 2026-03-05 16:17:52.597855 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-05 16:17:53.254788 | 2026-03-05 16:17:53.254932 | PLAY [localhost] 2026-03-05 16:17:53.262689 | 2026-03-05 16:17:53.262759 | TASK [Gathering Facts] 2026-03-05 16:17:54.170921 | localhost | ok 2026-03-05 16:17:54.192592 | 2026-03-05 16:17:54.192800 | TASK [Setup log path fact] 2026-03-05 16:17:54.225211 | localhost | ok 2026-03-05 16:17:54.238219 | 2026-03-05 16:17:54.238296 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-05 16:17:54.267041 | localhost | ok 2026-03-05 16:17:54.274334 | 2026-03-05 16:17:54.274413 | TASK [emit-job-header : Print job information] 2026-03-05 16:17:54.323557 | # Job Information 2026-03-05 16:17:54.323757 | Ansible Version: 2.16.16 2026-03-05 16:17:54.323791 | Job: ansible-collection-containers-molecule-nerdctl-rockylinux-9 2026-03-05 16:17:54.323814 | Pipeline: check 2026-03-05 16:17:54.323834 | Executor: 0a8996d2b663 2026-03-05 16:17:54.323854 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/97 2026-03-05 16:17:54.323877 | Event ID: 12f135d0-18ae-11f1-85c2-fd1165a7d91d 2026-03-05 16:17:54.326863 | 2026-03-05 16:17:54.326934 | LOOP [emit-job-header : Print node information] 2026-03-05 16:17:54.416798 | localhost | ok: 2026-03-05 16:17:54.417567 | localhost | # Node Information 2026-03-05 16:17:54.417725 | localhost | Inventory Hostname: rockylinux-9 2026-03-05 16:17:54.417786 | localhost | Hostname: np0000157902 2026-03-05 16:17:54.417825 | localhost | Username: zuul 2026-03-05 16:17:54.417866 | localhost | Distro: Rocky 9.7 2026-03-05 16:17:54.417903 | localhost | Provider: yul1 2026-03-05 16:17:54.417938 | localhost | Region: ca-ymq-1 2026-03-05 16:17:54.417973 | localhost | Label: rockylinux-9 2026-03-05 16:17:54.418008 | localhost | Product Name: OpenStack Nova 2026-03-05 16:17:54.418043 | localhost | Interface IP: 199.204.45.67 2026-03-05 16:17:54.430187 | 2026-03-05 16:17:54.430305 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-05 16:17:54.890254 | localhost -> localhost | changed 2026-03-05 16:17:54.895146 | 2026-03-05 16:17:54.895211 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-05 16:17:55.789438 | localhost -> localhost | changed 2026-03-05 16:17:55.799192 | 2026-03-05 16:17:55.799284 | PLAY [all] 2026-03-05 16:17:55.810114 | 2026-03-05 16:17:55.810237 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-05 16:17:56.085389 | rockylinux-9 -> localhost | ok 2026-03-05 16:17:56.094405 | 2026-03-05 16:17:56.094476 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-05 16:17:56.130244 | rockylinux-9 | ok 2026-03-05 16:17:56.145972 | rockylinux-9 | included: /var/lib/zuul/builds/d1b15c507f8e45e4b94a05e6e48299c0/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-05 16:17:56.151264 | 2026-03-05 16:17:56.151325 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-05 16:17:56.911980 | rockylinux-9 -> localhost | Generating public/private rsa key pair. 2026-03-05 16:17:56.912193 | rockylinux-9 -> localhost | Your identification has been saved in /var/lib/zuul/builds/d1b15c507f8e45e4b94a05e6e48299c0/work/d1b15c507f8e45e4b94a05e6e48299c0_id_rsa 2026-03-05 16:17:56.912224 | rockylinux-9 -> localhost | Your public key has been saved in /var/lib/zuul/builds/d1b15c507f8e45e4b94a05e6e48299c0/work/d1b15c507f8e45e4b94a05e6e48299c0_id_rsa.pub 2026-03-05 16:17:56.912247 | rockylinux-9 -> localhost | The key fingerprint is: 2026-03-05 16:17:56.912268 | rockylinux-9 -> localhost | SHA256:5MKpleXhhPeL8ccPPOfUTO0sjKB0AGlTpRCmlC4hK1U zuul-build-sshkey 2026-03-05 16:17:56.912308 | rockylinux-9 -> localhost | The key's randomart image is: 2026-03-05 16:17:56.912328 | rockylinux-9 -> localhost | +---[RSA 3072]----+ 2026-03-05 16:17:56.912354 | rockylinux-9 -> localhost | | .E.=+... | 2026-03-05 16:17:56.912375 | rockylinux-9 -> localhost | |. o..o++ . | 2026-03-05 16:17:56.912395 | rockylinux-9 -> localhost | | + o....O | 2026-03-05 16:17:56.912414 | rockylinux-9 -> localhost | |o . .. @ + .| 2026-03-05 16:17:56.912433 | rockylinux-9 -> localhost | |. . * S + o| 2026-03-05 16:17:56.912452 | rockylinux-9 -> localhost | | o o * = o * | 2026-03-05 16:17:56.912471 | rockylinux-9 -> localhost | | . o o B = =| 2026-03-05 16:17:56.912490 | rockylinux-9 -> localhost | | . B . | 2026-03-05 16:17:56.912511 | rockylinux-9 -> localhost | | o | 2026-03-05 16:17:56.912530 | rockylinux-9 -> localhost | +----[SHA256]-----+ 2026-03-05 16:17:56.912580 | rockylinux-9 -> localhost | ok: Runtime: 0:00:00.342560 2026-03-05 16:17:56.917728 | 2026-03-05 16:17:56.917793 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-05 16:17:56.943797 | rockylinux-9 | ok 2026-03-05 16:17:56.954050 | rockylinux-9 | included: /var/lib/zuul/builds/d1b15c507f8e45e4b94a05e6e48299c0/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-05 16:17:56.962474 | 2026-03-05 16:17:56.962535 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-05 16:17:56.979083 | rockylinux-9 | skipping: Conditional result was False 2026-03-05 16:17:56.984342 | 2026-03-05 16:17:56.984401 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-05 16:17:57.480507 | rockylinux-9 | changed 2026-03-05 16:17:57.485184 | 2026-03-05 16:17:57.485251 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-05 16:17:57.755427 | rockylinux-9 | ok 2026-03-05 16:17:57.781581 | 2026-03-05 16:17:57.781679 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-05 16:17:58.698634 | rockylinux-9 | changed 2026-03-05 16:17:58.708952 | 2026-03-05 16:17:58.709079 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-05 16:17:59.640974 | rockylinux-9 | changed 2026-03-05 16:17:59.645815 | 2026-03-05 16:17:59.645879 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-05 16:17:59.671001 | rockylinux-9 | skipping: Conditional result was False 2026-03-05 16:17:59.681502 | 2026-03-05 16:17:59.681572 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-05 16:18:00.050434 | rockylinux-9 -> localhost | changed 2026-03-05 16:18:00.060803 | 2026-03-05 16:18:00.060866 | TASK [add-build-sshkey : Add back temp key] 2026-03-05 16:18:00.370479 | rockylinux-9 -> localhost | Identity added: /var/lib/zuul/builds/d1b15c507f8e45e4b94a05e6e48299c0/work/d1b15c507f8e45e4b94a05e6e48299c0_id_rsa (zuul-build-sshkey) 2026-03-05 16:18:00.370713 | rockylinux-9 -> localhost | ok: Runtime: 0:00:00.012641 2026-03-05 16:18:00.377907 | 2026-03-05 16:18:00.377975 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-05 16:18:00.752591 | rockylinux-9 | ok 2026-03-05 16:18:00.757585 | 2026-03-05 16:18:00.757648 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-05 16:18:00.784009 | rockylinux-9 | skipping: Conditional result was False 2026-03-05 16:18:00.798552 | 2026-03-05 16:18:00.798625 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-03-05 16:18:01.198733 | rockylinux-9 | ok 2026-03-05 16:18:01.205642 | 2026-03-05 16:18:01.205719 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-03-05 16:18:02.176398 | rockylinux-9 | Output suppressed because no_log was given 2026-03-05 16:18:02.184084 | 2026-03-05 16:18:02.184147 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-03-05 16:18:02.433488 | rockylinux-9 | ok: "logs" 2026-03-05 16:18:02.433847 | rockylinux-9 | ok: All items complete 2026-03-05 16:18:02.433890 | 2026-03-05 16:18:02.666239 | rockylinux-9 | ok: "artifacts" 2026-03-05 16:18:02.893627 | rockylinux-9 | ok: "docs" 2026-03-05 16:18:02.901556 | 2026-03-05 16:18:02.901626 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-03-05 16:18:03.187929 | rockylinux-9 | changed: "logs" 2026-03-05 16:18:03.407997 | rockylinux-9 | changed: "artifacts" 2026-03-05 16:18:03.627667 | rockylinux-9 | changed: "docs" 2026-03-05 16:18:03.641537 | 2026-03-05 16:18:03.641693 | PLAY RECAP 2026-03-05 16:18:03.641746 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-05 16:18:03.641777 | rockylinux-9 | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-03-05 16:18:03.641799 | 2026-03-05 16:18:03.838844 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-05 16:18:03.841998 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-05 16:18:04.431069 | 2026-03-05 16:18:04.431232 | PLAY [all] 2026-03-05 16:18:04.443090 | 2026-03-05 16:18:04.443184 | TASK [setup-uv : Extract archive] 2026-03-05 16:18:07.174605 | rockylinux-9 | changed 2026-03-05 16:18:07.182054 | 2026-03-05 16:18:07.182138 | TASK [setup-uv : Print version] 2026-03-05 16:18:07.205376 | [rockylinux-9] Waiting on logger 2026-03-05 16:18:07.720347 | rockylinux-9 | ok: Runtime: 0:00:00.015797 2026-03-05 16:18:07.726947 | 2026-03-05 16:18:07.727000 | PLAY RECAP 2026-03-05 16:18:07.727049 | rockylinux-9 | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-05 16:18:07.727073 | 2026-03-05 16:18:07.866946 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-05 16:18:07.868236 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-05 16:18:08.502321 | 2026-03-05 16:18:08.738718 | PLAY [all] 2026-03-05 16:18:08.757189 | 2026-03-05 16:18:08.757354 | TASK [Copy inventory file for Zuul] 2026-03-05 16:18:10.145736 | rockylinux-9 | changed 2026-03-05 16:18:10.150662 | 2026-03-05 16:18:10.150734 | TASK [Switch "ansible_host" to private IP] 2026-03-05 16:18:10.512302 | rockylinux-9 | changed: 1 replacements made 2026-03-05 16:18:10.520244 | 2026-03-05 16:18:10.520329 | TASK [Run Molecule scenario] 2026-03-05 16:18:10.558005 | [rockylinux-9] Waiting on logger 2026-03-05 16:18:18.694065 | [rockylinux-9] Waiting on logger 2026-03-05 16:18:28.869976 | [rockylinux-9] Waiting on logger 2026-03-05 16:18:39.046212 | [rockylinux-9] Waiting on logger 2026-03-05 16:18:48.203272 | [rockylinux-9] Waiting on logger 2026-03-05 16:18:58.373912 | [rockylinux-9] Waiting on logger 2026-03-05 16:19:08.550055 | [rockylinux-9] Waiting on logger 2026-03-05 16:19:18.729988 | [rockylinux-9] Waiting on logger 2026-03-05 16:19:28.906185 | [rockylinux-9] Waiting on logger 2026-03-05 16:19:39.078138 | [rockylinux-9] Waiting on logger 2026-03-05 16:19:48.239259 | [rockylinux-9] Waiting on logger 2026-03-05 16:19:53.837755 | rockylinux-9 | ok: Runtime: 0:01:42.634527 2026-03-05 16:19:53.844282 | 2026-03-05 16:19:53.844345 | PLAY RECAP 2026-03-05 16:19:53.844400 | rockylinux-9 | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-05 16:19:53.844432 | 2026-03-05 16:19:53.955605 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-05 16:19:53.958076 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-05 16:19:54.524853 | 2026-03-05 16:19:54.525026 | PLAY [all] 2026-03-05 16:19:54.537143 | 2026-03-05 16:19:54.537215 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-05 16:19:54.582077 | rockylinux-9 | skipping: Conditional result was False 2026-03-05 16:19:54.589469 | 2026-03-05 16:19:54.589576 | TASK [fetch-output : Set log path for single node] 2026-03-05 16:19:54.624134 | rockylinux-9 | ok 2026-03-05 16:19:54.630919 | 2026-03-05 16:19:54.676333 | LOOP [fetch-output : Ensure local output dirs] 2026-03-05 16:19:55.108702 | rockylinux-9 -> localhost | ok: "/var/lib/zuul/builds/d1b15c507f8e45e4b94a05e6e48299c0/work/logs" 2026-03-05 16:19:55.342623 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/d1b15c507f8e45e4b94a05e6e48299c0/work/artifacts" 2026-03-05 16:19:55.552904 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/d1b15c507f8e45e4b94a05e6e48299c0/work/docs" 2026-03-05 16:19:55.567375 | 2026-03-05 16:19:55.567514 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-05 16:19:56.279731 | rockylinux-9 | changed: .d..t...... ./ 2026-03-05 16:19:56.279935 | rockylinux-9 | changed: All items complete 2026-03-05 16:19:56.279964 | 2026-03-05 16:19:56.833057 | rockylinux-9 | changed: .d..t...... ./ 2026-03-05 16:19:57.369195 | rockylinux-9 | changed: .d..t...... ./ 2026-03-05 16:19:57.389281 | 2026-03-05 16:19:57.389400 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-03-05 16:19:57.822121 | rockylinux-9 -> localhost | ok: Item: artifacts Runtime: 0:00:00.008915 2026-03-05 16:19:58.057090 | rockylinux-9 -> localhost | ok: Item: docs Runtime: 0:00:00.007411 2026-03-05 16:19:58.078834 | 2026-03-05 16:19:58.078972 | PLAY [all] 2026-03-05 16:19:58.085341 | 2026-03-05 16:19:58.085413 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-03-05 16:19:58.578589 | rockylinux-9 | changed 2026-03-05 16:19:58.583521 | 2026-03-05 16:19:58.583570 | PLAY RECAP 2026-03-05 16:19:58.583614 | rockylinux-9 | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-03-05 16:19:58.583638 | 2026-03-05 16:19:58.710564 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-05 16:19:58.712564 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-03-05 16:19:59.292222 | 2026-03-05 16:19:59.292343 | PLAY [localhost] 2026-03-05 16:19:59.302604 | 2026-03-05 16:19:59.302684 | TASK [Generate Zuul manifest] 2026-03-05 16:19:59.323122 | localhost | ok 2026-03-05 16:19:59.339972 | 2026-03-05 16:19:59.340067 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-05 16:19:59.646927 | localhost | changed 2026-03-05 16:19:59.660623 | 2026-03-05 16:19:59.660751 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-05 16:19:59.694094 | localhost | ok 2026-03-05 16:19:59.701295 | 2026-03-05 16:19:59.701363 | TASK [Upload logs] 2026-03-05 16:19:59.722984 | localhost | ok 2026-03-05 16:19:59.786962 | 2026-03-05 16:19:59.787140 | TASK [Set zuul-log-path fact] 2026-03-05 16:19:59.808434 | localhost | ok 2026-03-05 16:19:59.820836 | 2026-03-05 16:19:59.833565 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-05 16:19:59.867900 | localhost | ok 2026-03-05 16:19:59.876934 | 2026-03-05 16:19:59.877029 | TASK [upload-logs : Create log directories] 2026-03-05 16:20:00.317273 | localhost | changed 2026-03-05 16:20:00.322928 | 2026-03-05 16:20:00.323022 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-03-05 16:20:00.772710 | localhost -> localhost | ok: Runtime: 0:00:00.006542 2026-03-05 16:20:00.779947 | 2026-03-05 16:20:00.780029 | TASK [upload-logs : Upload logs to log server] 2026-03-05 16:20:01.252152 | localhost | Output suppressed because no_log was given 2026-03-05 16:20:01.256296 | 2026-03-05 16:20:01.256365 | LOOP [upload-logs : Compress console log and json output] 2026-03-05 16:20:01.302725 | localhost | skipping: Conditional result was False 2026-03-05 16:20:01.309476 | localhost | skipping: Conditional result was False 2026-03-05 16:20:01.324999 | 2026-03-05 16:20:01.325197 | LOOP [upload-logs : Upload compressed console log and json output] 2026-03-05 16:20:01.386690 | localhost | skipping: Conditional result was False 2026-03-05 16:20:01.387078 | 2026-03-05 16:20:01.388238 | localhost | skipping: Conditional result was False 2026-03-05 16:20:01.398453 | 2026-03-05 16:20:01.398633 | LOOP [upload-logs : Upload console log and json output]