2026-02-13 23:19:13.548035 | Job console starting 2026-02-13 23:19:13.565234 | Updating git repos 2026-02-13 23:19:13.618921 | Cloning repos into workspace 2026-02-13 23:19:13.721007 | Restoring repo states 2026-02-13 23:19:13.774465 | Merging changes 2026-02-13 23:19:14.103167 | Checking out repos 2026-02-13 23:19:14.144530 | Preparing playbooks 2026-02-13 23:19:16.101736 | Running Ansible setup 2026-02-13 23:19:19.969042 | PRE-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/pre.yaml@main] 2026-02-13 23:19:20.654635 | 2026-02-13 23:19:20.654789 | PLAY [localhost] 2026-02-13 23:19:20.663918 | 2026-02-13 23:19:20.664004 | TASK [Gathering Facts] 2026-02-13 23:19:21.626539 | localhost | ok 2026-02-13 23:19:21.634022 | 2026-02-13 23:19:21.634106 | TASK [Setup log path fact] 2026-02-13 23:19:21.654515 | localhost | ok 2026-02-13 23:19:21.670054 | 2026-02-13 23:19:21.670123 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-13 23:19:21.700359 | localhost | ok 2026-02-13 23:19:21.710083 | 2026-02-13 23:19:21.710181 | TASK [emit-job-header : Print job information] 2026-02-13 23:19:21.751460 | # Job Information 2026-02-13 23:19:21.751593 | Ansible Version: 2.16.15 2026-02-13 23:19:21.751623 | Job: ansible-collection-containers-molecule-nerdctl-rockylinux-9 2026-02-13 23:19:21.751645 | Pipeline: check 2026-02-13 23:19:21.751665 | Executor: 3a2793d2bd32 2026-02-13 23:19:21.751684 | Triggered by: https://github.com/vexxhost/ansible-collection-containers/pull/93 2026-02-13 23:19:21.751705 | Event ID: 40d80630-0932-11f1-9f6d-138448d30538 2026-02-13 23:19:21.757313 | 2026-02-13 23:19:21.757386 | LOOP [emit-job-header : Print node information] 2026-02-13 23:19:21.878076 | localhost | ok: 2026-02-13 23:19:21.996699 | localhost | # Node Information 2026-02-13 23:19:21.996885 | localhost | Inventory Hostname: rockylinux-9 2026-02-13 23:19:21.996988 | localhost | Hostname: np0000155490 2026-02-13 23:19:21.997042 | localhost | Username: zuul 2026-02-13 23:19:21.997103 | localhost | Distro: Rocky 9.7 2026-02-13 23:19:21.997168 | localhost | Provider: yul1 2026-02-13 23:19:21.997225 | localhost | Region: ca-ymq-1 2026-02-13 23:19:21.997269 | localhost | Label: rockylinux-9 2026-02-13 23:19:21.997310 | localhost | Product Name: OpenStack Nova 2026-02-13 23:19:21.997350 | localhost | Interface IP: 199.204.45.138 2026-02-13 23:19:22.017403 | 2026-02-13 23:19:22.017593 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-02-13 23:19:22.444295 | localhost -> localhost | changed 2026-02-13 23:19:22.453716 | 2026-02-13 23:19:22.454163 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-02-13 23:19:23.450521 | localhost -> localhost | changed 2026-02-13 23:19:23.460842 | 2026-02-13 23:19:23.484866 | PLAY [all] 2026-02-13 23:19:23.498015 | 2026-02-13 23:19:23.498124 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-13 23:19:23.964174 | rockylinux-9 -> localhost | ok 2026-02-13 23:19:23.972409 | 2026-02-13 23:19:23.972560 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-13 23:19:24.006138 | rockylinux-9 | ok 2026-02-13 23:19:24.023210 | rockylinux-9 | included: /var/lib/zuul/builds/20389cff22d9444da682c3ce8958f6ab/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-13 23:19:24.029928 | 2026-02-13 23:19:24.129976 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-13 23:19:25.402692 | rockylinux-9 -> localhost | Generating public/private rsa key pair. 2026-02-13 23:19:25.403094 | rockylinux-9 -> localhost | Your identification has been saved in /var/lib/zuul/builds/20389cff22d9444da682c3ce8958f6ab/work/20389cff22d9444da682c3ce8958f6ab_id_rsa 2026-02-13 23:19:25.403140 | rockylinux-9 -> localhost | Your public key has been saved in /var/lib/zuul/builds/20389cff22d9444da682c3ce8958f6ab/work/20389cff22d9444da682c3ce8958f6ab_id_rsa.pub 2026-02-13 23:19:25.403166 | rockylinux-9 -> localhost | The key fingerprint is: 2026-02-13 23:19:25.403190 | rockylinux-9 -> localhost | SHA256:2KKNpSN4L6ioU+SoNnRsdQxH/91KBOPAfX7w3j2qVsM zuul-build-sshkey 2026-02-13 23:19:25.403226 | rockylinux-9 -> localhost | The key's randomart image is: 2026-02-13 23:19:25.403249 | rockylinux-9 -> localhost | +---[RSA 3072]----+ 2026-02-13 23:19:25.403275 | rockylinux-9 -> localhost | | .....o | 2026-02-13 23:19:25.403297 | rockylinux-9 -> localhost | | . ...o.oo | 2026-02-13 23:19:25.403317 | rockylinux-9 -> localhost | | + . .o.o | 2026-02-13 23:19:25.403338 | rockylinux-9 -> localhost | | . . = . o..o | 2026-02-13 23:19:25.403360 | rockylinux-9 -> localhost | | +. . = S ..oo.o| 2026-02-13 23:19:25.403380 | rockylinux-9 -> localhost | |.oo+ * . .E.oo| 2026-02-13 23:19:25.403399 | rockylinux-9 -> localhost | |+o= = . ..o .| 2026-02-13 23:19:25.403418 | rockylinux-9 -> localhost | |=+.o . . . | 2026-02-13 23:19:25.403439 | rockylinux-9 -> localhost | |B.... ... | 2026-02-13 23:19:25.403548 | rockylinux-9 -> localhost | +----[SHA256]-----+ 2026-02-13 23:19:25.403619 | rockylinux-9 -> localhost | ok: Runtime: 0:00:00.505989 2026-02-13 23:19:25.408830 | 2026-02-13 23:19:25.408902 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-13 23:19:25.430737 | rockylinux-9 | ok 2026-02-13 23:19:25.441463 | rockylinux-9 | included: /var/lib/zuul/builds/20389cff22d9444da682c3ce8958f6ab/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-13 23:19:25.449533 | 2026-02-13 23:19:25.449595 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-13 23:19:25.474752 | rockylinux-9 | skipping: Conditional result was False 2026-02-13 23:19:25.506802 | 2026-02-13 23:19:25.506918 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-13 23:19:26.000773 | rockylinux-9 | changed 2026-02-13 23:19:26.009465 | 2026-02-13 23:19:26.082694 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-13 23:19:26.320547 | rockylinux-9 | ok 2026-02-13 23:19:26.326401 | 2026-02-13 23:19:26.326481 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-13 23:19:27.189732 | rockylinux-9 | changed 2026-02-13 23:19:27.198853 | 2026-02-13 23:19:27.199001 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-13 23:19:28.033843 | rockylinux-9 | changed 2026-02-13 23:19:28.042715 | 2026-02-13 23:19:28.141655 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-13 23:19:28.177274 | rockylinux-9 | skipping: Conditional result was False 2026-02-13 23:19:28.183073 | 2026-02-13 23:19:28.183155 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-13 23:19:28.552685 | rockylinux-9 -> localhost | changed 2026-02-13 23:19:28.563395 | 2026-02-13 23:19:28.580124 | TASK [add-build-sshkey : Add back temp key] 2026-02-13 23:19:28.872993 | rockylinux-9 -> localhost | Identity added: /var/lib/zuul/builds/20389cff22d9444da682c3ce8958f6ab/work/20389cff22d9444da682c3ce8958f6ab_id_rsa (zuul-build-sshkey) 2026-02-13 23:19:28.873205 | rockylinux-9 -> localhost | ok: Runtime: 0:00:00.014012 2026-02-13 23:19:28.878081 | 2026-02-13 23:19:28.878146 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-13 23:19:29.256452 | rockylinux-9 | ok 2026-02-13 23:19:29.263307 | 2026-02-13 23:19:29.263424 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-13 23:19:29.288880 | rockylinux-9 | skipping: Conditional result was False 2026-02-13 23:19:29.305090 | 2026-02-13 23:19:29.305286 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-02-13 23:19:29.710110 | rockylinux-9 | ok 2026-02-13 23:19:29.717410 | 2026-02-13 23:19:29.717478 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-02-13 23:19:30.626714 | rockylinux-9 | Output suppressed because no_log was given 2026-02-13 23:19:30.646870 | 2026-02-13 23:19:30.646980 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-02-13 23:19:30.871829 | rockylinux-9 | ok: "logs" 2026-02-13 23:19:30.872177 | rockylinux-9 | ok: All items complete 2026-02-13 23:19:30.872220 | 2026-02-13 23:19:31.082451 | rockylinux-9 | ok: "artifacts" 2026-02-13 23:19:31.305865 | rockylinux-9 | ok: "docs" 2026-02-13 23:19:31.323968 | 2026-02-13 23:19:31.324657 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-02-13 23:19:31.578839 | rockylinux-9 | changed: "logs" 2026-02-13 23:19:31.773564 | rockylinux-9 | changed: "artifacts" 2026-02-13 23:19:32.000997 | rockylinux-9 | changed: "docs" 2026-02-13 23:19:32.035012 | 2026-02-13 23:19:32.035432 | PLAY RECAP 2026-02-13 23:19:32.035503 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-02-13 23:19:32.035537 | rockylinux-9 | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-02-13 23:19:32.035561 | 2026-02-13 23:19:32.258643 | PRE-RUN END RESULT_NORMAL: [trusted : vexxhost.dev/zuul-config/playbooks/base/pre.yaml@main] 2026-02-13 23:19:32.260579 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-02-13 23:19:32.917881 | 2026-02-13 23:19:32.967520 | PLAY [all] 2026-02-13 23:19:32.985804 | 2026-02-13 23:19:32.985903 | TASK [setup-uv : Extract archive] 2026-02-13 23:19:35.500141 | rockylinux-9 | changed 2026-02-13 23:19:35.505466 | 2026-02-13 23:19:35.505541 | TASK [setup-uv : Print version] 2026-02-13 23:19:35.553447 | [rockylinux-9] Waiting on logger 2026-02-13 23:19:36.074947 | rockylinux-9 | ok: Runtime: 0:00:00.019125 2026-02-13 23:19:36.089325 | 2026-02-13 23:19:36.089435 | PLAY RECAP 2026-02-13 23:19:36.090001 | rockylinux-9 | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-02-13 23:19:36.090049 | 2026-02-13 23:19:36.229885 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-02-13 23:19:36.235569 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-02-13 23:19:36.877064 | 2026-02-13 23:19:36.959890 | PLAY [all] 2026-02-13 23:19:36.980430 | 2026-02-13 23:19:36.980528 | TASK [Copy inventory file for Zuul] 2026-02-13 23:19:38.216400 | rockylinux-9 | changed 2026-02-13 23:19:38.221683 | 2026-02-13 23:19:38.221765 | TASK [Switch "ansible_host" to private IP] 2026-02-13 23:19:38.565746 | rockylinux-9 | changed: 1 replacements made 2026-02-13 23:19:38.570672 | 2026-02-13 23:19:38.570739 | TASK [Run Molecule scenario] 2026-02-13 23:19:38.625682 | [rockylinux-9] Waiting on logger 2026-02-13 23:19:46.761687 | [rockylinux-9] Waiting on logger 2026-02-13 23:19:56.933808 | [rockylinux-9] Waiting on logger 2026-02-13 23:20:07.109910 | [rockylinux-9] Waiting on logger 2026-02-13 23:20:17.285982 | [rockylinux-9] Waiting on logger 2026-02-13 23:20:27.466097 | [rockylinux-9] Waiting on logger 2026-02-13 23:20:36.656311 | [rockylinux-9] Waiting on logger 2026-02-13 23:20:46.822171 | [rockylinux-9] Waiting on logger 2026-02-13 23:20:57.097939 | [rockylinux-9] Waiting on logger 2026-02-13 23:21:07.273947 | [rockylinux-9] Waiting on logger 2026-02-13 23:21:17.454767 | rockylinux-9 | ok: Runtime: 0:01:37.917703 2026-02-13 23:21:17.459833 | 2026-02-13 23:21:17.459885 | PLAY RECAP 2026-02-13 23:21:17.459929 | rockylinux-9 | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-02-13 23:21:17.459952 | 2026-02-13 23:21:17.595037 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-02-13 23:21:17.596332 | POST-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/post.yaml@main] 2026-02-13 23:21:18.222425 | 2026-02-13 23:21:18.222560 | PLAY [all] 2026-02-13 23:21:18.233815 | 2026-02-13 23:21:18.233900 | TASK [fetch-output : Set log path for multiple nodes] 2026-02-13 23:21:18.280377 | rockylinux-9 | skipping: Conditional result was False 2026-02-13 23:21:18.288527 | 2026-02-13 23:21:18.288645 | TASK [fetch-output : Set log path for single node] 2026-02-13 23:21:18.334074 | rockylinux-9 | ok 2026-02-13 23:21:18.339495 | 2026-02-13 23:21:18.339586 | LOOP [fetch-output : Ensure local output dirs] 2026-02-13 23:21:18.765507 | rockylinux-9 -> localhost | ok: "/var/lib/zuul/builds/20389cff22d9444da682c3ce8958f6ab/work/logs" 2026-02-13 23:21:19.004273 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/20389cff22d9444da682c3ce8958f6ab/work/artifacts" 2026-02-13 23:21:19.219974 | rockylinux-9 -> localhost | changed: "/var/lib/zuul/builds/20389cff22d9444da682c3ce8958f6ab/work/docs" 2026-02-13 23:21:19.242907 | 2026-02-13 23:21:19.243013 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-02-13 23:21:20.378616 | rockylinux-9 | changed: .d..t...... ./ 2026-02-13 23:21:20.378816 | rockylinux-9 | changed: All items complete 2026-02-13 23:21:20.378843 | 2026-02-13 23:21:20.875088 | rockylinux-9 | changed: .d..t...... ./ 2026-02-13 23:21:21.373955 | rockylinux-9 | changed: .d..t...... ./ 2026-02-13 23:21:21.398359 | 2026-02-13 23:21:21.398543 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-02-13 23:21:21.826424 | rockylinux-9 -> localhost | ok: Item: artifacts Runtime: 0:00:00.008153 2026-02-13 23:21:22.062063 | rockylinux-9 -> localhost | ok: Item: docs Runtime: 0:00:00.007724 2026-02-13 23:21:22.074544 | 2026-02-13 23:21:22.074679 | PLAY [all] 2026-02-13 23:21:22.081048 | 2026-02-13 23:21:22.081120 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-02-13 23:21:22.518769 | rockylinux-9 | changed 2026-02-13 23:21:22.524158 | 2026-02-13 23:21:22.524209 | PLAY RECAP 2026-02-13 23:21:22.524258 | rockylinux-9 | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-02-13 23:21:22.524280 | 2026-02-13 23:21:22.668324 | POST-RUN END RESULT_NORMAL: [trusted : vexxhost.dev/zuul-config/playbooks/base/post.yaml@main] 2026-02-13 23:21:22.669754 | POST-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/post-logs.yaml@main] 2026-02-13 23:21:23.281254 | 2026-02-13 23:21:23.281423 | PLAY [localhost] 2026-02-13 23:21:23.293474 | 2026-02-13 23:21:23.293575 | TASK [Generate Zuul manifest] 2026-02-13 23:21:23.314857 | localhost | ok 2026-02-13 23:21:23.335260 | 2026-02-13 23:21:23.335436 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-02-13 23:21:23.666499 | localhost | changed 2026-02-13 23:21:23.677951 | 2026-02-13 23:21:23.678028 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-02-13 23:21:23.707907 | localhost | ok 2026-02-13 23:21:23.714383 | 2026-02-13 23:21:23.714445 | TASK [Upload logs] 2026-02-13 23:21:23.733138 | localhost | ok 2026-02-13 23:21:23.790559 | 2026-02-13 23:21:23.790672 | TASK [Set zuul-log-path fact] 2026-02-13 23:21:23.810589 | localhost | ok 2026-02-13 23:21:23.825682 | 2026-02-13 23:21:23.825777 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-13 23:21:23.861660 | localhost | ok 2026-02-13 23:21:23.874835 | 2026-02-13 23:21:23.874918 | TASK [upload-logs : Create log directories] 2026-02-13 23:21:24.291958 | localhost | changed 2026-02-13 23:21:24.298898 | 2026-02-13 23:21:24.298996 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-02-13 23:21:24.735876 | localhost -> localhost | ok: Runtime: 0:00:00.005112 2026-02-13 23:21:24.741629 | 2026-02-13 23:21:24.741697 | TASK [upload-logs : Upload logs to log server] 2026-02-13 23:21:25.229950 | localhost | Output suppressed because no_log was given 2026-02-13 23:21:25.235061 | 2026-02-13 23:21:25.235146 | LOOP [upload-logs : Compress console log and json output] 2026-02-13 23:21:25.279605 | localhost | skipping: Conditional result was False 2026-02-13 23:21:25.490007 | localhost | skipping: Conditional result was False 2026-02-13 23:21:25.501607 | 2026-02-13 23:21:25.501797 | LOOP [upload-logs : Upload compressed console log and json output] 2026-02-13 23:21:25.546957 | localhost | skipping: Conditional result was False 2026-02-13 23:21:25.547363 | 2026-02-13 23:21:25.550955 | localhost | skipping: Conditional result was False 2026-02-13 23:21:25.567457 | 2026-02-13 23:21:25.567616 | LOOP [upload-logs : Upload console log and json output]