2026-06-14 01:23:33.982207 | Job console starting 2026-06-14 01:23:33.990363 | Updating git repos 2026-06-14 01:23:34.015153 | Cloning repos into workspace 2026-06-14 01:23:34.066880 | Restoring repo states 2026-06-14 01:23:34.074825 | Merging changes 2026-06-14 01:23:34.368158 | Checking out repos 2026-06-14 01:23:34.396912 | Preparing playbooks 2026-06-14 01:23:35.604993 | Running Ansible setup 2026-06-14 01:23:39.131512 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-06-14 01:23:39.833051 | 2026-06-14 01:23:39.833206 | PLAY [localhost] 2026-06-14 01:23:39.842093 | 2026-06-14 01:23:39.842206 | TASK [Gathering Facts] 2026-06-14 01:23:40.807173 | localhost | ok 2026-06-14 01:23:40.814175 | 2026-06-14 01:23:40.814303 | TASK [Setup log path fact] 2026-06-14 01:23:40.833252 | localhost | ok 2026-06-14 01:23:40.844279 | 2026-06-14 01:23:40.844413 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-14 01:23:40.880749 | localhost | ok 2026-06-14 01:23:40.889810 | 2026-06-14 01:23:40.889886 | TASK [emit-job-header : Print job information] 2026-06-14 01:23:40.940024 | # Job Information 2026-06-14 01:23:40.940282 | Ansible Version: 2.16.18 2026-06-14 01:23:40.940359 | Job: ansible-collection-containers-molecule-docker-rockylinux-9 2026-06-14 01:23:40.940414 | Pipeline: check 2026-06-14 01:23:40.940465 | Executor: 2d72f0692154 2026-06-14 01:23:40.940513 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/136 2026-06-14 01:23:40.940585 | Event ID: 789bd9a0-678f-11f1-974f-6b3d586f8e5d 2026-06-14 01:23:40.944041 | 2026-06-14 01:23:40.944105 | LOOP [emit-job-header : Print node information] 2026-06-14 01:23:41.195654 | localhost | ok: 2026-06-14 01:23:41.196234 | localhost | # Node Information 2026-06-14 01:23:41.196280 | localhost | Inventory Hostname: rockylinux-9 2026-06-14 01:23:41.196311 | localhost | Hostname: np0000179964 2026-06-14 01:23:41.196340 | localhost | Username: zuul 2026-06-14 01:23:41.196372 | localhost | Distro: Rocky 9.7 2026-06-14 01:23:41.196400 | localhost | Provider: yul1 2026-06-14 01:23:41.196428 | localhost | Region: ca-ymq-1 2026-06-14 01:23:41.196454 | localhost | Label: rockylinux-9 2026-06-14 01:23:41.196480 | localhost | Product Name: OpenStack Nova 2026-06-14 01:23:41.196506 | localhost | Interface IP: 199.204.45.240 2026-06-14 01:23:41.207895 | 2026-06-14 01:23:41.208022 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-14 01:23:41.658745 | localhost -> localhost | changed 2026-06-14 01:23:41.665825 | 2026-06-14 01:23:41.665929 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-14 01:23:42.540728 | localhost -> localhost | changed 2026-06-14 01:23:42.551525 | 2026-06-14 01:23:42.551612 | PLAY [all] 2026-06-14 01:23:42.559069 | 2026-06-14 01:23:42.559142 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-14 01:23:42.778393 | rockylinux-9 -> localhost | ok 2026-06-14 01:23:42.786404 | 2026-06-14 01:23:42.786502 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-14 01:23:42.816566 | rockylinux-9 | ok 2026-06-14 01:23:42.835087 | rockylinux-9 | included: /var/lib/zuul/builds/fce7b73bec9940d28cc669bcd57bbef7/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-14 01:23:42.841129 | 2026-06-14 01:23:42.841192 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-14 01:23:43.808081 | rockylinux-9 -> localhost | Generating public/private rsa key pair. 2026-06-14 01:23:43.808282 | rockylinux-9 -> localhost | Your identification has been saved in /var/lib/zuul/builds/fce7b73bec9940d28cc669bcd57bbef7/work/fce7b73bec9940d28cc669bcd57bbef7_id_rsa 2026-06-14 01:23:43.808313 | rockylinux-9 -> localhost | Your public key has been saved in /var/lib/zuul/builds/fce7b73bec9940d28cc669bcd57bbef7/work/fce7b73bec9940d28cc669bcd57bbef7_id_rsa.pub 2026-06-14 01:23:43.808336 | rockylinux-9 -> localhost | The key fingerprint is: 2026-06-14 01:23:43.808357 | rockylinux-9 -> localhost | SHA256:GPxBJrW+k3AC+O9LN1GHpNBT7+eitJWMQir5PNWcHZk zuul-build-sshkey 2026-06-14 01:23:43.808395 | rockylinux-9 -> localhost | The key's randomart image is: 2026-06-14 01:23:43.808415 | rockylinux-9 -> localhost | +---[RSA 3072]----+ 2026-06-14 01:23:43.808577 | rockylinux-9 -> localhost | | oo+.o | 2026-06-14 01:23:43.808604 | rockylinux-9 -> localhost | | . . =o+ o | 2026-06-14 01:23:43.808625 | rockylinux-9 -> localhost | | . . o +.o oo | 2026-06-14 01:23:43.808646 | rockylinux-9 -> localhost | | . . = o oE | 2026-06-14 01:23:43.808665 | rockylinux-9 -> localhost | | . + So o... | 2026-06-14 01:23:43.808684 | rockylinux-9 -> localhost | | o *.++o.+ | 2026-06-14 01:23:43.808703 | rockylinux-9 -> localhost | | o +.B o = . | 2026-06-14 01:23:43.808722 | rockylinux-9 -> localhost | | *.. = + . | 2026-06-14 01:23:43.808744 | rockylinux-9 -> localhost | | =o o | 2026-06-14 01:23:43.808763 | rockylinux-9 -> localhost | +----[SHA256]-----+ 2026-06-14 01:23:43.808815 | rockylinux-9 -> localhost | ok: Runtime: 0:00:00.530317 2026-06-14 01:23:43.813747 | 2026-06-14 01:23:43.813814 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-14 01:23:43.842760 | rockylinux-9 | ok 2026-06-14 01:23:43.851431 | rockylinux-9 | included: /var/lib/zuul/builds/fce7b73bec9940d28cc669bcd57bbef7/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-14 01:23:43.860567 | 2026-06-14 01:23:43.860662 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-14 01:23:43.886528 | rockylinux-9 | skipping: Conditional result was False 2026-06-14 01:23:43.894236 | 2026-06-14 01:23:43.894409 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-14 01:23:44.359168 | rockylinux-9 | changed 2026-06-14 01:23:44.363902 | 2026-06-14 01:23:44.363969 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-14 01:23:44.605739 | rockylinux-9 | ok 2026-06-14 01:23:44.610498 | 2026-06-14 01:23:44.610560 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-14 01:23:45.541721 | rockylinux-9 | changed 2026-06-14 01:23:45.549178 | 2026-06-14 01:23:45.549347 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-14 01:23:46.473752 | rockylinux-9 | changed 2026-06-14 01:23:46.479708 | 2026-06-14 01:23:46.479792 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-14 01:23:46.504667 | rockylinux-9 | skipping: Conditional result was False 2026-06-14 01:23:46.510078 | 2026-06-14 01:23:46.510146 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-14 01:23:46.869373 | rockylinux-9 -> localhost | changed 2026-06-14 01:23:46.878395 | 2026-06-14 01:23:46.878483 | TASK [add-build-sshkey : Add back temp key] 2026-06-14 01:23:47.159774 | rockylinux-9 -> localhost | Identity added: /var/lib/zuul/builds/fce7b73bec9940d28cc669bcd57bbef7/work/fce7b73bec9940d28cc669bcd57bbef7_id_rsa (zuul-build-sshkey) 2026-06-14 01:23:47.159977 | rockylinux-9 -> localhost | ok: Runtime: 0:00:00.012623 2026-06-14 01:23:47.165031 | 2026-06-14 01:23:47.165121 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-14 01:23:47.604656 | rockylinux-9 | ok 2026-06-14 01:23:47.622475 | 2026-06-14 01:23:47.622567 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-14 01:23:47.655985 | rockylinux-9 | skipping: Conditional result was False 2026-06-14 01:23:47.668003 | 2026-06-14 01:23:47.668085 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-06-14 01:23:48.057335 | rockylinux-9 | ok 2026-06-14 01:23:48.063236 | 2026-06-14 01:23:48.063341 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-06-14 01:23:49.077727 | rockylinux-9 | Output suppressed because no_log was given 2026-06-14 01:23:49.085488 | 2026-06-14 01:23:49.085558 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-06-14 01:23:49.360004 | rockylinux-9 | ok: "logs" 2026-06-14 01:23:49.360287 | rockylinux-9 | ok: All items complete 2026-06-14 01:23:49.360327 | 2026-06-14 01:23:49.581022 | rockylinux-9 | ok: "artifacts" 2026-06-14 01:23:49.799227 | rockylinux-9 | ok: "docs" 2026-06-14 01:23:49.812483 | 2026-06-14 01:23:49.812572 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-06-14 01:23:50.072274 | rockylinux-9 | changed: "logs" 2026-06-14 01:23:50.353789 | rockylinux-9 | changed: "artifacts" 2026-06-14 01:23:50.521756 | rockylinux-9 | changed: "docs" 2026-06-14 01:23:50.537243 | 2026-06-14 01:23:50.537362 | PLAY RECAP 2026-06-14 01:23:50.537424 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-14 01:23:50.537468 | rockylinux-9 | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-06-14 01:23:50.537504 | 2026-06-14 01:23:50.687546 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-06-14 01:23:50.689117 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-06-14 01:23:51.315351 | 2026-06-14 01:23:51.315624 | PLAY [all] 2026-06-14 01:23:51.328539 | 2026-06-14 01:23:51.328651 | TASK [setup-uv : Extract archive] 2026-06-14 01:23:54.067934 | rockylinux-9 | changed 2026-06-14 01:23:54.077799 | 2026-06-14 01:23:54.077884 | TASK [setup-uv : Print version] 2026-06-14 01:23:54.105399 | [rockylinux-9] Waiting on logger 2026-06-14 01:23:54.616484 | rockylinux-9 | ok: Runtime: 0:00:00.014820 2026-06-14 01:23:54.628448 | 2026-06-14 01:23:54.628540 | TASK [Install Ansible collection siblings] 2026-06-14 01:23:55.110963 | rockylinux-9 | ok: 2026-06-14 01:23:55.111219 | rockylinux-9 | Skipping ansible.posix: no checked-out sibling 2026-06-14 01:23:55.111282 | rockylinux-9 | Skipping community.general: no checked-out sibling 2026-06-14 01:23:55.113594 | 2026-06-14 01:23:55.113644 | PLAY RECAP 2026-06-14 01:23:55.113692 | rockylinux-9 | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-14 01:23:55.113714 | 2026-06-14 01:23:55.235797 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-06-14 01:23:55.238342 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-06-14 01:23:55.908865 | 2026-06-14 01:23:55.909144 | PLAY [all] 2026-06-14 01:23:55.922181 | 2026-06-14 01:23:55.922279 | TASK [Copy inventory file for Zuul] 2026-06-14 01:23:57.282587 | rockylinux-9 | changed 2026-06-14 01:23:57.289075 | 2026-06-14 01:23:57.289154 | TASK [Switch "ansible_host" to private IP] 2026-06-14 01:23:57.667551 | rockylinux-9 | changed: 1 replacements made 2026-06-14 01:23:57.675015 | 2026-06-14 01:23:57.675088 | TASK [Run Molecule scenario] 2026-06-14 01:23:57.700819 | [rockylinux-9] Waiting on logger 2026-06-14 01:24:05.829982 | [rockylinux-9] Waiting on logger 2026-06-14 01:24:16.006116 | [rockylinux-9] Waiting on logger 2026-06-14 01:24:25.163450 | [rockylinux-9] Waiting on logger 2026-06-14 01:24:35.337845 | [rockylinux-9] Waiting on logger 2026-06-14 01:24:45.509821 | [rockylinux-9] Waiting on logger 2026-06-14 01:24:55.973847 | [rockylinux-9] Waiting on logger 2026-06-14 01:25:05.135107 | [rockylinux-9] Waiting on logger 2026-06-14 01:25:15.301747 | [rockylinux-9] Waiting on logger 2026-06-14 01:25:25.477942 | [rockylinux-9] Waiting on logger 2026-06-14 01:25:35.115330 | [rockylinux-9] Waiting on logger 2026-06-14 01:25:45.285857 | [rockylinux-9] Waiting on logger 2026-06-14 01:25:55.462313 | [rockylinux-9] Waiting on logger 2026-06-14 01:26:05.637956 | [rockylinux-9] Waiting on logger 2026-06-14 01:26:15.813952 | [rockylinux-9] Waiting on logger 2026-06-14 01:26:25.989868 | [rockylinux-9] Waiting on logger 2026-06-14 01:26:27.117355 | rockylinux-9 | ok: Runtime: 0:02:28.422074 2026-06-14 01:26:27.127128 | 2026-06-14 01:26:27.127175 | PLAY RECAP 2026-06-14 01:26:27.127222 | rockylinux-9 | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-14 01:26:27.127256 | 2026-06-14 01:26:27.239807 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-06-14 01:26:27.241684 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-06-14 01:26:27.835786 | 2026-06-14 01:26:27.835944 | PLAY [all] 2026-06-14 01:26:27.847389 | 2026-06-14 01:26:27.847471 | TASK [fetch-output : Set log path for multiple nodes] 2026-06-14 01:26:27.894169 | rockylinux-9 | skipping: Conditional result was False 2026-06-14 01:26:27.903700 | 2026-06-14 01:26:27.903866 | TASK [fetch-output : Set log path for single node] 2026-06-14 01:26:27.947869 | rockylinux-9 | ok 2026-06-14 01:26:27.952986 | 2026-06-14 01:26:27.953055 | LOOP [fetch-output : Ensure local output dirs] 2026-06-14 01:26:28.341586 | rockylinux-9 -> localhost | ok: "/var/lib/zuul/builds/fce7b73bec9940d28cc669bcd57bbef7/work/logs" 2026-06-14 01:26:28.542354 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/fce7b73bec9940d28cc669bcd57bbef7/work/artifacts" 2026-06-14 01:26:28.750479 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/fce7b73bec9940d28cc669bcd57bbef7/work/docs" 2026-06-14 01:26:28.773933 | 2026-06-14 01:26:28.774006 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-14 01:26:29.461545 | rockylinux-9 | changed: .d..t...... ./ 2026-06-14 01:26:29.461787 | rockylinux-9 | changed: All items complete 2026-06-14 01:26:29.461815 | 2026-06-14 01:26:29.981803 | rockylinux-9 | changed: .d..t...... ./ 2026-06-14 01:26:30.491964 | rockylinux-9 | changed: .d..t...... ./ 2026-06-14 01:26:30.518870 | 2026-06-14 01:26:30.519017 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-14 01:26:30.931852 | rockylinux-9 -> localhost | ok: Item: artifacts Runtime: 0:00:00.007373 2026-06-14 01:26:31.153107 | rockylinux-9 -> localhost | ok: Item: docs Runtime: 0:00:00.008406 2026-06-14 01:26:31.175041 | 2026-06-14 01:26:31.175186 | PLAY [all] 2026-06-14 01:26:31.181822 | 2026-06-14 01:26:31.181890 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-14 01:26:31.639786 | rockylinux-9 | changed 2026-06-14 01:26:31.644878 | 2026-06-14 01:26:31.644926 | PLAY RECAP 2026-06-14 01:26:31.644981 | rockylinux-9 | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-06-14 01:26:31.645006 | 2026-06-14 01:26:31.764302 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-06-14 01:26:31.766954 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-06-14 01:26:32.343964 | 2026-06-14 01:26:32.344112 | PLAY [localhost] 2026-06-14 01:26:32.355313 | 2026-06-14 01:26:32.355390 | TASK [Generate Zuul manifest] 2026-06-14 01:26:32.377149 | localhost | ok 2026-06-14 01:26:32.393291 | 2026-06-14 01:26:32.393377 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-14 01:26:32.738793 | localhost | changed 2026-06-14 01:26:32.749863 | 2026-06-14 01:26:32.749948 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-14 01:26:32.781707 | localhost | ok 2026-06-14 01:26:32.790453 | 2026-06-14 01:26:32.790522 | TASK [Upload logs] 2026-06-14 01:26:32.809822 | localhost | ok 2026-06-14 01:26:32.876982 | 2026-06-14 01:26:32.877164 | TASK [Set zuul-log-path fact] 2026-06-14 01:26:32.898366 | localhost | ok 2026-06-14 01:26:32.910281 | 2026-06-14 01:26:32.910383 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-14 01:26:32.942135 | localhost | ok 2026-06-14 01:26:32.950976 | 2026-06-14 01:26:32.951057 | TASK [upload-logs : Create log directories] 2026-06-14 01:26:33.357685 | localhost | changed 2026-06-14 01:26:33.365772 | 2026-06-14 01:26:33.365851 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-14 01:26:33.749977 | localhost -> localhost | ok: Runtime: 0:00:00.006153 2026-06-14 01:26:33.756214 | 2026-06-14 01:26:33.756302 | TASK [upload-logs : Upload logs to log server] 2026-06-14 01:26:34.195696 | localhost | Output suppressed because no_log was given 2026-06-14 01:26:34.199352 | 2026-06-14 01:26:34.199417 | LOOP [upload-logs : Compress console log and json output] 2026-06-14 01:26:34.241963 | localhost | skipping: Conditional result was False 2026-06-14 01:26:34.249025 | localhost | skipping: Conditional result was False 2026-06-14 01:26:34.263546 | 2026-06-14 01:26:34.265176 | LOOP [upload-logs : Upload compressed console log and json output] 2026-06-14 01:26:34.322843 | localhost | skipping: Conditional result was False 2026-06-14 01:26:34.323223 | 2026-06-14 01:26:34.327637 | localhost | skipping: Conditional result was False 2026-06-14 01:26:34.340461 | 2026-06-14 01:26:34.340638 | LOOP [upload-logs : Upload console log and json output]