2026-10-01 18:04:26.323904 | Job console starting 2026-10-01 18:04:26.337134 | Updating git repos 2026-10-01 18:04:26.375714 | Cloning repos into workspace 2026-10-01 18:04:26.428570 | Restoring repo states 2026-10-01 18:04:26.441937 | Merging changes 2026-10-01 18:04:27.047976 | Checking out repos 2026-10-01 18:04:27.091180 | Preparing playbooks 2026-10-01 18:04:27.697535 | Running Ansible setup 2026-10-01 18:04:31.871221 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-10-01 18:04:32.657396 | 2026-10-01 18:04:32.657584 | PLAY [Base pre] 2026-10-01 18:04:32.675441 | 2026-10-01 18:04:32.675568 | TASK [Setup log path fact] 2026-10-01 18:04:32.710492 | debian-bookworm | ok 2026-10-01 18:04:32.730726 | 2026-10-01 18:04:32.730861 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-10-01 18:04:32.773212 | debian-bookworm | ok 2026-10-01 18:04:32.787148 | 2026-10-01 18:04:32.787268 | TASK [emit-job-header : Print job information] 2026-10-01 18:04:32.836372 | # Job Information 2026-10-01 18:04:32.836542 | Ansible Version: 2.16.14 2026-10-01 18:04:32.836578 | Job: yamllint 2026-10-01 18:04:32.836610 | Pipeline: check 2026-10-01 18:04:32.836634 | Executor: 521e9411259a 2026-10-01 18:04:32.836655 | Triggered by: https://github.com/osism/ansible-playbooks/pull/578 2026-10-01 18:04:32.836677 | Event ID: 8377d610-bdc2-11f1-8b8a-3d3b2b41575d 2026-10-01 18:04:32.841640 | 2026-10-01 18:04:32.841746 | LOOP [emit-job-header : Print node information] 2026-10-01 18:04:32.948956 | debian-bookworm | ok: 2026-10-01 18:04:32.949193 | debian-bookworm | # Node Information 2026-10-01 18:04:32.949235 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-10-01 18:04:32.949267 | debian-bookworm | Hostname: debian 2026-10-01 18:04:32.949296 | debian-bookworm | Username: zuul 2026-10-01 18:04:32.949324 | debian-bookworm | Distro: Debian 12.15 2026-10-01 18:04:32.949394 | debian-bookworm | Provider: regiocloud-a 2026-10-01 18:04:32.949423 | debian-bookworm | Region: 2026-10-01 18:04:32.949450 | debian-bookworm | Label: debian-bookworm 2026-10-01 18:04:32.949476 | debian-bookworm | Product Name: OpenStack Nova 2026-10-01 18:04:32.949501 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe5c:2e6a 2026-10-01 18:04:32.974759 | 2026-10-01 18:04:32.974910 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-10-01 18:04:33.444456 | debian-bookworm -> localhost | changed 2026-10-01 18:04:33.451945 | 2026-10-01 18:04:33.452152 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-10-01 18:04:34.449465 | debian-bookworm -> localhost | changed 2026-10-01 18:04:34.460420 | 2026-10-01 18:04:34.460535 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-10-01 18:04:34.748421 | debian-bookworm -> localhost | ok 2026-10-01 18:04:34.761630 | 2026-10-01 18:04:34.761806 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-10-01 18:04:34.786448 | debian-bookworm | ok 2026-10-01 18:04:34.803875 | debian-bookworm | included: /var/lib/zuul/builds/5314ff891e9f432fb20edf21cdcb902d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-10-01 18:04:34.809970 | 2026-10-01 18:04:34.810068 | TASK [add-build-sshkey : Create Temp SSH key] 2026-10-01 18:04:36.290755 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-10-01 18:04:36.291100 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/5314ff891e9f432fb20edf21cdcb902d/work/5314ff891e9f432fb20edf21cdcb902d_id_rsa 2026-10-01 18:04:36.291168 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/5314ff891e9f432fb20edf21cdcb902d/work/5314ff891e9f432fb20edf21cdcb902d_id_rsa.pub 2026-10-01 18:04:36.291217 | debian-bookworm -> localhost | The key fingerprint is: 2026-10-01 18:04:36.291262 | debian-bookworm -> localhost | SHA256:3yRbDpo/9zXlGJpmgsG/aqCiL6Ufn93lGOullUkJGkI zuul-build-sshkey 2026-10-01 18:04:36.291300 | debian-bookworm -> localhost | The key's randomart image is: 2026-10-01 18:04:36.291404 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-10-01 18:04:36.291449 | debian-bookworm -> localhost | | E | 2026-10-01 18:04:36.291487 | debian-bookworm -> localhost | | . | 2026-10-01 18:04:36.291523 | debian-bookworm -> localhost | | . . . | 2026-10-01 18:04:36.291558 | debian-bookworm -> localhost | | . + . . | 2026-10-01 18:04:36.291594 | debian-bookworm -> localhost | | . S = o . .| 2026-10-01 18:04:36.291639 | debian-bookworm -> localhost | | . . O @ o +.| 2026-10-01 18:04:36.291676 | debian-bookworm -> localhost | | o. . .= @ B ..o| 2026-10-01 18:04:36.291712 | debian-bookworm -> localhost | |o .o.o ..@.=. ..| 2026-10-01 18:04:36.291749 | debian-bookworm -> localhost | |.=o.o .oB.+o .. | 2026-10-01 18:04:36.291785 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-10-01 18:04:36.291876 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.979363 2026-10-01 18:04:36.302848 | 2026-10-01 18:04:36.303003 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-10-01 18:04:36.323703 | debian-bookworm | ok 2026-10-01 18:04:36.333844 | debian-bookworm | included: /var/lib/zuul/builds/5314ff891e9f432fb20edf21cdcb902d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-10-01 18:04:36.341914 | 2026-10-01 18:04:36.342023 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-10-01 18:04:36.356002 | debian-bookworm | skipping: Conditional result was False 2026-10-01 18:04:36.361702 | 2026-10-01 18:04:36.361803 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-10-01 18:04:37.015166 | debian-bookworm | changed 2026-10-01 18:04:37.024330 | 2026-10-01 18:04:37.024484 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-10-01 18:04:37.297426 | debian-bookworm | ok 2026-10-01 18:04:37.307162 | 2026-10-01 18:04:37.307318 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-10-01 18:04:37.986452 | debian-bookworm | changed 2026-10-01 18:04:37.994146 | 2026-10-01 18:04:37.994268 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-10-01 18:04:38.668276 | debian-bookworm | changed 2026-10-01 18:04:38.677266 | 2026-10-01 18:04:38.677471 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-10-01 18:04:38.701894 | debian-bookworm | skipping: Conditional result was False 2026-10-01 18:04:38.711232 | 2026-10-01 18:04:38.711412 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-10-01 18:04:39.142082 | debian-bookworm -> localhost | changed 2026-10-01 18:04:39.162954 | 2026-10-01 18:04:39.163100 | TASK [add-build-sshkey : Add back temp key] 2026-10-01 18:04:39.490890 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/5314ff891e9f432fb20edf21cdcb902d/work/5314ff891e9f432fb20edf21cdcb902d_id_rsa (zuul-build-sshkey) 2026-10-01 18:04:39.491141 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.017657 2026-10-01 18:04:39.499259 | 2026-10-01 18:04:39.499382 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-10-01 18:04:39.908105 | debian-bookworm | ok 2026-10-01 18:04:39.915692 | 2026-10-01 18:04:39.915815 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-10-01 18:04:39.939482 | debian-bookworm | skipping: Conditional result was False 2026-10-01 18:04:39.949610 | 2026-10-01 18:04:39.949709 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-10-01 18:04:40.408665 | debian-bookworm | ok 2026-10-01 18:04:40.423120 | 2026-10-01 18:04:40.423236 | TASK [validate-host : Define zuul_info_dir fact] 2026-10-01 18:04:40.453754 | debian-bookworm | ok 2026-10-01 18:04:40.460201 | 2026-10-01 18:04:40.460557 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-10-01 18:04:40.746999 | debian-bookworm -> localhost | ok 2026-10-01 18:04:40.753703 | 2026-10-01 18:04:40.753810 | TASK [validate-host : Collect information about the host] 2026-10-01 18:04:41.869840 | debian-bookworm | ok 2026-10-01 18:04:41.881611 | 2026-10-01 18:04:41.881729 | TASK [validate-host : Sanitize hostname] 2026-10-01 18:04:42.023097 | debian-bookworm | ok 2026-10-01 18:04:42.027793 | 2026-10-01 18:04:42.027896 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-10-01 18:04:42.579247 | debian-bookworm -> localhost | changed 2026-10-01 18:04:42.592859 | 2026-10-01 18:04:42.593021 | TASK [validate-host : Collect information about zuul worker] 2026-10-01 18:04:42.997162 | debian-bookworm | ok 2026-10-01 18:04:43.002424 | 2026-10-01 18:04:43.002536 | TASK [validate-host : Write out all zuul information for each host] 2026-10-01 18:04:43.531852 | debian-bookworm -> localhost | changed 2026-10-01 18:04:43.541670 | 2026-10-01 18:04:43.541778 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-10-01 18:04:43.818801 | debian-bookworm | ok 2026-10-01 18:04:43.827001 | 2026-10-01 18:04:43.827126 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-10-01 18:04:44.722088 | debian-bookworm | changed: 2026-10-01 18:04:44.722294 | debian-bookworm | cd+++++++++ src/ 2026-10-01 18:04:44.722330 | debian-bookworm | cd+++++++++ src/github.com/ 2026-10-01 18:04:44.722399 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-10-01 18:04:44.722424 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-playbooks/ 2026-10-01 18:04:44.722445 | debian-bookworm | cleanup-container-images.yml 2026-10-01 18:04:44.737581 | debian-bookworm | tempest.yml 2026-10-01 18:04:44.740534 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-playbooks/playbooks/state/ 2026-10-01 18:04:44.740551 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/5314ff891e9f432fb20edf21cdcb902d/work/logs" 2026-10-01 18:05:47.146016 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/5314ff891e9f432fb20edf21cdcb902d/work/artifacts" 2026-10-01 18:05:47.398066 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/5314ff891e9f432fb20edf21cdcb902d/work/docs" 2026-10-01 18:05:47.426484 | 2026-10-01 18:05:47.426640 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-10-01 18:05:48.168897 | debian-bookworm | changed: 2026-10-01 18:05:48.169159 | debian-bookworm | .d..t...... ./ 2026-10-01 18:05:48.169210 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-10-01 18:05:48.169247 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-10-01 18:05:48.169283 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-10-01 18:05:48.169316 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-10-01 18:05:48.169348 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-10-01 18:05:48.169442 | debian-bookworm | changed: All items complete 2026-10-01 18:05:48.169487 | 2026-10-01 18:05:48.752868 | debian-bookworm | changed: .d..t...... ./ 2026-10-01 18:05:49.331088 | debian-bookworm | changed: .d..t...... ./ 2026-10-01 18:05:49.359760 | 2026-10-01 18:05:49.359903 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-10-01 18:05:49.691896 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.009548 2026-10-01 18:05:49.963377 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.009526 2026-10-01 18:05:49.974419 | 2026-10-01 18:05:49.974591 | PLAY RECAP 2026-10-01 18:05:49.974646 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-10-01 18:05:49.974683 | 2026-10-01 18:05:50.092581 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-10-01 18:05:50.094631 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-10-01 18:05:50.804699 | 2026-10-01 18:05:50.804848 | PLAY [Base post] 2026-10-01 18:05:50.818030 | 2026-10-01 18:05:50.818154 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-10-01 18:05:51.392226 | debian-bookworm | changed 2026-10-01 18:05:51.401751 | 2026-10-01 18:05:51.401881 | PLAY RECAP 2026-10-01 18:05:51.401960 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-10-01 18:05:51.402038 | 2026-10-01 18:05:51.516001 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-10-01 18:05:51.518044 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-10-01 18:05:52.302544 | 2026-10-01 18:05:52.302703 | PLAY [Base post-logs] 2026-10-01 18:05:52.313083 | 2026-10-01 18:05:52.313217 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-10-01 18:05:52.764506 | localhost | changed 2026-10-01 18:05:52.774354 | 2026-10-01 18:05:52.774521 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-10-01 18:05:52.813416 | localhost | ok 2026-10-01 18:05:52.820025 | 2026-10-01 18:05:52.820177 | TASK [Set zuul-log-path fact] 2026-10-01 18:05:52.849287 | localhost | ok 2026-10-01 18:05:52.861986 | 2026-10-01 18:05:52.862133 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-10-01 18:05:52.899283 | localhost | ok 2026-10-01 18:05:52.906179 | 2026-10-01 18:05:52.906352 | TASK [upload-logs : Create log directories] 2026-10-01 18:05:53.390418 | localhost | changed 2026-10-01 18:05:53.397022 | 2026-10-01 18:05:53.397194 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-10-01 18:05:53.869528 | localhost -> localhost | ok: Runtime: 0:00:00.006726 2026-10-01 18:05:53.878997 | 2026-10-01 18:05:53.879220 | TASK [upload-logs : Upload logs to log server] 2026-10-01 18:05:54.413879 | localhost | Output suppressed because no_log was given 2026-10-01 18:05:54.416515 | 2026-10-01 18:05:54.416654 | LOOP [upload-logs : Compress console log and json output] 2026-10-01 18:05:54.471018 | localhost | skipping: Conditional result was False 2026-10-01 18:05:54.478049 | localhost | skipping: Conditional result was False 2026-10-01 18:05:54.485901 | 2026-10-01 18:05:54.486056 | LOOP [upload-logs : Upload compressed console log and json output] 2026-10-01 18:05:54.529179 | localhost | skipping: Conditional result was False 2026-10-01 18:05:54.529790 | 2026-10-01 18:05:54.533781 | localhost | skipping: Conditional result was False 2026-10-01 18:05:54.544160 | 2026-10-01 18:05:54.544322 | LOOP [upload-logs : Upload console log and json output]