2026-03-11 16:44:56.632687 | Job console starting 2026-03-11 16:44:56.657201 | Updating git repos 2026-03-11 16:44:56.680133 | Cloning repos into workspace 2026-03-11 16:44:56.825346 | Restoring repo states 2026-03-11 16:44:56.838856 | Merging changes 2026-03-11 16:44:57.575100 | Checking out repos 2026-03-11 16:44:57.675310 | Preparing playbooks 2026-03-11 16:45:01.309211 | Running Ansible setup 2026-03-11 16:45:05.388852 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-11 16:45:05.976226 | 2026-03-11 16:45:06.001473 | PLAY [localhost] 2026-03-11 16:45:06.009679 | 2026-03-11 16:45:06.009751 | TASK [Gathering Facts] 2026-03-11 16:45:07.054178 | localhost | ok 2026-03-11 16:45:07.065199 | 2026-03-11 16:45:07.089175 | TASK [Setup log path fact] 2026-03-11 16:45:07.109359 | localhost | ok 2026-03-11 16:45:07.138066 | 2026-03-11 16:45:07.138185 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-11 16:45:07.165497 | localhost | ok 2026-03-11 16:45:07.174815 | 2026-03-11 16:45:07.175082 | TASK [emit-job-header : Print job information] 2026-03-11 16:45:07.216618 | # Job Information 2026-03-11 16:45:07.216854 | Ansible Version: 2.16.16 2026-03-11 16:45:07.216926 | Job: ansible-collection-containers-molecule-containerd-rockylinux-9 2026-03-11 16:45:07.217075 | Pipeline: check 2026-03-11 16:45:07.217130 | Executor: 0a8996d2b663 2026-03-11 16:45:07.217175 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/98 2026-03-11 16:45:07.217225 | Event ID: 76884650-1d69-11f1-8213-7e12ab15453b 2026-03-11 16:45:07.223168 | 2026-03-11 16:45:07.223308 | LOOP [emit-job-header : Print node information] 2026-03-11 16:45:07.349238 | localhost | ok: 2026-03-11 16:45:07.349394 | localhost | # Node Information 2026-03-11 16:45:07.349423 | localhost | Inventory Hostname: rockylinux-9 2026-03-11 16:45:07.349457 | localhost | Hostname: np0000158371 2026-03-11 16:45:07.349478 | localhost | Username: zuul 2026-03-11 16:45:07.349501 | localhost | Distro: Rocky 9.7 2026-03-11 16:45:07.349521 | localhost | Provider: yul1 2026-03-11 16:45:07.349541 | localhost | Region: ca-ymq-1 2026-03-11 16:45:07.349560 | localhost | Label: rockylinux-9 2026-03-11 16:45:07.349579 | localhost | Product Name: OpenStack Nova 2026-03-11 16:45:07.349598 | localhost | Interface IP: 162.253.55.12 2026-03-11 16:45:07.361014 | 2026-03-11 16:45:07.361156 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-11 16:45:08.504443 | localhost -> localhost | changed 2026-03-11 16:45:08.516918 | 2026-03-11 16:45:08.517064 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-11 16:45:10.378394 | localhost -> localhost | changed 2026-03-11 16:45:10.491334 | 2026-03-11 16:45:10.491469 | PLAY [all] 2026-03-11 16:45:10.499849 | 2026-03-11 16:45:10.499923 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-11 16:45:10.787777 | rockylinux-9 -> localhost | ok 2026-03-11 16:45:10.799788 | 2026-03-11 16:45:10.800165 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-11 16:45:10.835152 | rockylinux-9 | ok 2026-03-11 16:45:10.854779 | rockylinux-9 | included: /var/lib/zuul/builds/cf3f1f516e9b48f78b9ceed7aa92ded6/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-11 16:45:10.859927 | 2026-03-11 16:45:10.859988 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-11 16:45:11.761690 | rockylinux-9 -> localhost | Generating public/private rsa key pair. 2026-03-11 16:45:11.761837 | rockylinux-9 -> localhost | Your identification has been saved in /var/lib/zuul/builds/cf3f1f516e9b48f78b9ceed7aa92ded6/work/cf3f1f516e9b48f78b9ceed7aa92ded6_id_rsa 2026-03-11 16:45:11.761870 | rockylinux-9 -> localhost | Your public key has been saved in /var/lib/zuul/builds/cf3f1f516e9b48f78b9ceed7aa92ded6/work/cf3f1f516e9b48f78b9ceed7aa92ded6_id_rsa.pub 2026-03-11 16:45:11.761892 | rockylinux-9 -> localhost | The key fingerprint is: 2026-03-11 16:45:11.761913 | rockylinux-9 -> localhost | SHA256:toIxZisoeTIg1JbyZF4SR4ElKjVABfsmDMw0EfS9VmU zuul-build-sshkey 2026-03-11 16:45:11.761943 | rockylinux-9 -> localhost | The key's randomart image is: 2026-03-11 16:45:11.761963 | rockylinux-9 -> localhost | +---[RSA 3072]----+ 2026-03-11 16:45:11.761988 | rockylinux-9 -> localhost | |+XB++=. E | 2026-03-11 16:45:11.763587 | rockylinux-9 -> localhost | |+.*o* o | 2026-03-11 16:45:11.763619 | rockylinux-9 -> localhost | |oB O o . | 2026-03-11 16:45:11.763641 | rockylinux-9 -> localhost | |= O o o | 2026-03-11 16:45:11.763661 | rockylinux-9 -> localhost | |oo ==o S | 2026-03-11 16:45:11.763681 | rockylinux-9 -> localhost | |oooo.= . . | 2026-03-11 16:45:11.763700 | rockylinux-9 -> localhost | |* o o . . | 2026-03-11 16:45:11.763722 | rockylinux-9 -> localhost | |.+ . . | 2026-03-11 16:45:11.763746 | rockylinux-9 -> localhost | | | 2026-03-11 16:45:11.763766 | rockylinux-9 -> localhost | +----[SHA256]-----+ 2026-03-11 16:45:11.763812 | rockylinux-9 -> localhost | ok: Runtime: 0:00:00.355406 2026-03-11 16:45:11.768292 | 2026-03-11 16:45:11.768353 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-11 16:45:11.798199 | rockylinux-9 | ok 2026-03-11 16:45:11.807812 | rockylinux-9 | included: /var/lib/zuul/builds/cf3f1f516e9b48f78b9ceed7aa92ded6/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-11 16:45:11.816512 | 2026-03-11 16:45:11.816727 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-11 16:45:11.833046 | rockylinux-9 | skipping: Conditional result was False 2026-03-11 16:45:11.841381 | 2026-03-11 16:45:11.841474 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-11 16:45:12.300244 | rockylinux-9 | changed 2026-03-11 16:45:12.306047 | 2026-03-11 16:45:12.306120 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-11 16:45:12.545843 | rockylinux-9 | ok 2026-03-11 16:45:12.550735 | 2026-03-11 16:45:12.550808 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-11 16:45:13.461497 | rockylinux-9 | changed 2026-03-11 16:45:13.525475 | 2026-03-11 16:45:13.525586 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-11 16:45:14.446680 | rockylinux-9 | changed 2026-03-11 16:45:14.527212 | 2026-03-11 16:45:14.527348 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-11 16:45:14.553373 | rockylinux-9 | skipping: Conditional result was False 2026-03-11 16:45:14.562453 | 2026-03-11 16:45:14.562593 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-11 16:45:15.029228 | rockylinux-9 -> localhost | changed 2026-03-11 16:45:15.042234 | 2026-03-11 16:45:15.042304 | TASK [add-build-sshkey : Add back temp key] 2026-03-11 16:45:15.325453 | rockylinux-9 -> localhost | Identity added: /var/lib/zuul/builds/cf3f1f516e9b48f78b9ceed7aa92ded6/work/cf3f1f516e9b48f78b9ceed7aa92ded6_id_rsa (zuul-build-sshkey) 2026-03-11 16:45:15.325620 | rockylinux-9 -> localhost | ok: Runtime: 0:00:00.014192 2026-03-11 16:45:15.331454 | 2026-03-11 16:45:15.331516 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-11 16:45:15.726599 | rockylinux-9 | ok 2026-03-11 16:45:15.742965 | 2026-03-11 16:45:15.743032 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-11 16:45:15.777720 | rockylinux-9 | skipping: Conditional result was False 2026-03-11 16:45:15.791571 | 2026-03-11 16:45:15.791705 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-03-11 16:45:16.183287 | rockylinux-9 | ok 2026-03-11 16:45:16.190268 | 2026-03-11 16:45:16.190340 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-03-11 16:45:17.148586 | rockylinux-9 | Output suppressed because no_log was given 2026-03-11 16:45:17.159696 | 2026-03-11 16:45:17.159761 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-03-11 16:45:17.428493 | rockylinux-9 | ok: "logs" 2026-03-11 16:45:17.481138 | rockylinux-9 | ok: All items complete 2026-03-11 16:45:17.481238 | 2026-03-11 16:45:17.667677 | rockylinux-9 | ok: "artifacts" 2026-03-11 16:45:17.884007 | rockylinux-9 | ok: "docs" 2026-03-11 16:45:17.898319 | 2026-03-11 16:45:17.898490 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-03-11 16:45:18.150899 | rockylinux-9 | changed: "logs" 2026-03-11 16:45:18.373230 | rockylinux-9 | changed: "artifacts" 2026-03-11 16:45:18.606879 | rockylinux-9 | changed: "docs" 2026-03-11 16:45:18.617412 | 2026-03-11 16:45:18.617541 | PLAY RECAP 2026-03-11 16:45:18.617595 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-11 16:45:18.617629 | rockylinux-9 | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-03-11 16:45:18.617653 | 2026-03-11 16:45:18.810825 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-11 16:45:18.815076 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-11 16:45:19.539149 | 2026-03-11 16:45:19.539273 | PLAY [all] 2026-03-11 16:45:19.550482 | 2026-03-11 16:45:19.550584 | TASK [setup-uv : Extract archive] 2026-03-11 16:45:22.502035 | rockylinux-9 | changed 2026-03-11 16:45:22.548129 | 2026-03-11 16:45:22.557560 | TASK [setup-uv : Print version] 2026-03-11 16:45:22.590224 | [rockylinux-9] Waiting on logger 2026-03-11 16:45:24.239167 | rockylinux-9 | ok: Runtime: 0:00:00.016849 2026-03-11 16:45:24.254258 | 2026-03-11 16:45:24.254344 | PLAY RECAP 2026-03-11 16:45:24.254395 | rockylinux-9 | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-11 16:45:24.254420 | 2026-03-11 16:45:24.419590 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-11 16:45:24.476045 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-11 16:45:25.109927 | 2026-03-11 16:45:25.110050 | PLAY [all] 2026-03-11 16:45:25.120940 | 2026-03-11 16:45:25.121062 | TASK [Copy inventory file for Zuul] 2026-03-11 16:45:26.505984 | rockylinux-9 | changed 2026-03-11 16:45:26.512311 | 2026-03-11 16:45:26.512413 | TASK [Switch "ansible_host" to private IP] 2026-03-11 16:45:26.882190 | rockylinux-9 | changed: 1 replacements made 2026-03-11 16:45:26.889952 | 2026-03-11 16:45:26.890180 | TASK [Run Molecule scenario] 2026-03-11 16:45:26.911873 | [rockylinux-9] Waiting on logger 2026-03-11 16:45:35.046045 | [rockylinux-9] Waiting on logger 2026-03-11 16:45:45.226016 | [rockylinux-9] Waiting on logger 2026-03-11 16:45:55.397946 | [rockylinux-9] Waiting on logger 2026-03-11 16:46:04.938233 | [rockylinux-9] Waiting on logger 2026-03-11 16:46:15.113864 | [rockylinux-9] Waiting on logger 2026-03-11 16:46:25.285903 | [rockylinux-9] Waiting on logger 2026-03-11 16:46:35.462005 | [rockylinux-9] Waiting on logger 2026-03-11 16:46:44.619446 | [rockylinux-9] Waiting on logger 2026-03-11 16:46:54.822111 | [rockylinux-9] Waiting on logger 2026-03-11 16:47:07.669029 | localhost | Timeout exception waiting for the logger. Please check connectivity to [162.253.55.12:19885] 2026-03-11 16:49:58.622088 | rockylinux-9 | ok: Runtime: 0:04:31.207939 2026-03-11 16:49:58.628807 | 2026-03-11 16:49:58.628860 | PLAY RECAP 2026-03-11 16:49:58.628911 | rockylinux-9 | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-11 16:49:58.628932 | 2026-03-11 16:49:58.775787 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-11 16:49:58.778024 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-11 16:49:59.498280 | 2026-03-11 16:49:59.498409 | PLAY [all] 2026-03-11 16:49:59.508803 | 2026-03-11 16:49:59.508885 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-11 16:49:59.554510 | rockylinux-9 | skipping: Conditional result was False 2026-03-11 16:49:59.609210 | 2026-03-11 16:49:59.609322 | TASK [fetch-output : Set log path for single node] 2026-03-11 16:49:59.651597 | rockylinux-9 | ok 2026-03-11 16:49:59.658398 | 2026-03-11 16:49:59.658466 | LOOP [fetch-output : Ensure local output dirs] 2026-03-11 16:50:00.078427 | rockylinux-9 -> localhost | ok: "/var/lib/zuul/builds/cf3f1f516e9b48f78b9ceed7aa92ded6/work/logs" 2026-03-11 16:50:00.288418 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/cf3f1f516e9b48f78b9ceed7aa92ded6/work/artifacts" 2026-03-11 16:50:00.567196 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/cf3f1f516e9b48f78b9ceed7aa92ded6/work/docs" 2026-03-11 16:50:00.577837 | 2026-03-11 16:50:00.577985 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-11 16:50:01.292772 | rockylinux-9 | changed: .d..t...... ./ 2026-03-11 16:50:01.293115 | rockylinux-9 | changed: All items complete 2026-03-11 16:50:01.293157 | 2026-03-11 16:50:01.827652 | rockylinux-9 | changed: .d..t...... ./ 2026-03-11 16:50:02.351873 | rockylinux-9 | changed: .d..t...... ./ 2026-03-11 16:50:02.376694 | 2026-03-11 16:50:02.376821 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-03-11 16:50:02.769444 | rockylinux-9 -> localhost | ok: Item: artifacts Runtime: 0:00:00.006465 2026-03-11 16:50:02.982190 | rockylinux-9 -> localhost | ok: Item: docs Runtime: 0:00:00.006183 2026-03-11 16:50:02.999606 | 2026-03-11 16:50:02.999706 | PLAY [all] 2026-03-11 16:50:03.005164 | 2026-03-11 16:50:03.005229 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-03-11 16:50:03.462483 | rockylinux-9 | changed 2026-03-11 16:50:03.468315 | 2026-03-11 16:50:03.468368 | PLAY RECAP 2026-03-11 16:50:03.468416 | rockylinux-9 | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-03-11 16:50:03.468439 | 2026-03-11 16:50:03.613356 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-11 16:50:03.615523 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-03-11 16:50:04.376370 | 2026-03-11 16:50:04.376558 | PLAY [localhost] 2026-03-11 16:50:04.389108 | 2026-03-11 16:50:04.389289 | TASK [Generate Zuul manifest] 2026-03-11 16:50:04.413324 | localhost | ok 2026-03-11 16:50:04.460742 | 2026-03-11 16:50:04.460894 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-11 16:50:05.722769 | localhost | changed 2026-03-11 16:50:05.734708 | 2026-03-11 16:50:05.734781 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-11 16:50:05.855731 | localhost | ok 2026-03-11 16:50:05.863946 | 2026-03-11 16:50:05.864011 | TASK [Upload logs] 2026-03-11 16:50:05.880896 | localhost | ok 2026-03-11 16:50:06.108962 | 2026-03-11 16:50:06.109106 | TASK [Set zuul-log-path fact] 2026-03-11 16:50:06.128636 | localhost | ok 2026-03-11 16:50:06.141472 | 2026-03-11 16:50:06.141539 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-11 16:50:06.170713 | localhost | ok 2026-03-11 16:50:06.179521 | 2026-03-11 16:50:06.179581 | TASK [upload-logs : Create log directories] 2026-03-11 16:50:06.615775 | localhost | changed 2026-03-11 16:50:06.622336 | 2026-03-11 16:50:06.622403 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-03-11 16:50:07.007563 | localhost -> localhost | ok: Runtime: 0:00:00.005078 2026-03-11 16:50:07.015369 | 2026-03-11 16:50:07.015619 | TASK [upload-logs : Upload logs to log server] 2026-03-11 16:50:07.534382 | localhost | Output suppressed because no_log was given 2026-03-11 16:50:07.539255 | 2026-03-11 16:50:07.539365 | LOOP [upload-logs : Compress console log and json output] 2026-03-11 16:50:07.582306 | localhost | skipping: Conditional result was False 2026-03-11 16:50:07.596820 | localhost | skipping: Conditional result was False 2026-03-11 16:50:07.607378 | 2026-03-11 16:50:07.607580 | LOOP [upload-logs : Upload compressed console log and json output] 2026-03-11 16:50:07.651861 | localhost | skipping: Conditional result was False 2026-03-11 16:50:07.652280 | 2026-03-11 16:50:07.655629 | localhost | skipping: Conditional result was False 2026-03-11 16:50:07.671943 | 2026-03-11 16:50:07.672093 | LOOP [upload-logs : Upload console log and json output]