2026-05-27 06:38:57.693512 | Job console starting 2026-05-27 06:38:57.708374 | Updating git repos 2026-05-27 06:38:57.791170 | Cloning repos into workspace 2026-05-27 06:38:57.845095 | Restoring repo states 2026-05-27 06:38:57.850986 | Merging changes 2026-05-27 06:38:58.569634 | Checking out repos 2026-05-27 06:38:58.674687 | Preparing playbooks 2026-05-27 06:38:59.533751 | Running Ansible setup 2026-05-27 06:39:03.932316 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-27 06:39:04.720569 | 2026-05-27 06:39:04.720742 | PLAY [Base pre] 2026-05-27 06:39:04.738344 | 2026-05-27 06:39:04.738504 | TASK [Setup log path fact] 2026-05-27 06:39:04.767919 | debian-bookworm | ok 2026-05-27 06:39:04.784199 | 2026-05-27 06:39:04.784348 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-27 06:39:04.826976 | debian-bookworm | ok 2026-05-27 06:39:04.838789 | 2026-05-27 06:39:04.838969 | TASK [emit-job-header : Print job information] 2026-05-27 06:39:04.889410 | # Job Information 2026-05-27 06:39:04.889601 | Ansible Version: 2.16.14 2026-05-27 06:39:04.889637 | Job: yamllint 2026-05-27 06:39:04.889670 | Pipeline: check 2026-05-27 06:39:04.889693 | Executor: 521e9411259a 2026-05-27 06:39:04.889715 | Triggered by: https://github.com/osism/testbed/pull/2896 2026-05-27 06:39:04.889738 | Event ID: b752a810-5996-11f1-90d8-0cd528a7316f 2026-05-27 06:39:04.895568 | 2026-05-27 06:39:04.895710 | LOOP [emit-job-header : Print node information] 2026-05-27 06:39:05.006894 | debian-bookworm | ok: 2026-05-27 06:39:05.007099 | debian-bookworm | # Node Information 2026-05-27 06:39:05.007134 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-27 06:39:05.007159 | debian-bookworm | Hostname: debian 2026-05-27 06:39:05.007181 | debian-bookworm | Username: zuul 2026-05-27 06:39:05.007202 | debian-bookworm | Distro: Debian 12.14 2026-05-27 06:39:05.007225 | debian-bookworm | Provider: regiocloud-a 2026-05-27 06:39:05.007246 | debian-bookworm | Region: 2026-05-27 06:39:05.007267 | debian-bookworm | Label: debian-bookworm 2026-05-27 06:39:05.007287 | debian-bookworm | Product Name: OpenStack Nova 2026-05-27 06:39:05.007306 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fef2:8f86 2026-05-27 06:39:05.034117 | 2026-05-27 06:39:05.034336 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-27 06:39:05.737508 | debian-bookworm -> localhost | changed 2026-05-27 06:39:05.745047 | 2026-05-27 06:39:05.745186 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-27 06:39:07.009536 | debian-bookworm -> localhost | changed 2026-05-27 06:39:07.025597 | 2026-05-27 06:39:07.025808 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-27 06:39:07.332761 | debian-bookworm -> localhost | ok 2026-05-27 06:39:07.339193 | 2026-05-27 06:39:07.339336 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-27 06:39:07.370382 | debian-bookworm | ok 2026-05-27 06:39:07.389459 | debian-bookworm | included: /var/lib/zuul/builds/f7c3db38c017479e8dd744bd505467a3/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-27 06:39:07.396084 | 2026-05-27 06:39:07.396198 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-27 06:39:08.680436 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-27 06:39:08.680742 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/f7c3db38c017479e8dd744bd505467a3/work/f7c3db38c017479e8dd744bd505467a3_id_rsa 2026-05-27 06:39:08.680793 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/f7c3db38c017479e8dd744bd505467a3/work/f7c3db38c017479e8dd744bd505467a3_id_rsa.pub 2026-05-27 06:39:08.680859 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-27 06:39:08.680895 | debian-bookworm -> localhost | SHA256:z1WGv3S+aq9P604oP2RU6RhmbkxNShXBBX2/H70Jez4 zuul-build-sshkey 2026-05-27 06:39:08.680926 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-27 06:39:08.680971 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-27 06:39:08.681003 | debian-bookworm -> localhost | | .*B*| 2026-05-27 06:39:08.681034 | debian-bookworm -> localhost | | .*.=o| 2026-05-27 06:39:08.681062 | debian-bookworm -> localhost | | B.B o| 2026-05-27 06:39:08.681090 | debian-bookworm -> localhost | | X ..| 2026-05-27 06:39:08.681118 | debian-bookworm -> localhost | | S + o +| 2026-05-27 06:39:08.681155 | debian-bookworm -> localhost | | o . =.*.| 2026-05-27 06:39:08.681183 | debian-bookworm -> localhost | | o.o.+o*| 2026-05-27 06:39:08.681209 | debian-bookworm -> localhost | | o+oE+| 2026-05-27 06:39:08.681238 | debian-bookworm -> localhost | | .+@O.| 2026-05-27 06:39:08.681265 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-27 06:39:08.681328 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.745374 2026-05-27 06:39:08.691958 | 2026-05-27 06:39:08.692088 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-27 06:39:08.711264 | debian-bookworm | ok 2026-05-27 06:39:08.720623 | debian-bookworm | included: /var/lib/zuul/builds/f7c3db38c017479e8dd744bd505467a3/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-27 06:39:08.729927 | 2026-05-27 06:39:08.730037 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-27 06:39:08.744379 | debian-bookworm | skipping: Conditional result was False 2026-05-27 06:39:08.759352 | 2026-05-27 06:39:08.759526 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-27 06:39:09.488989 | debian-bookworm | changed 2026-05-27 06:39:09.494632 | 2026-05-27 06:39:09.494745 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-27 06:39:09.765995 | debian-bookworm | ok 2026-05-27 06:39:09.772219 | 2026-05-27 06:39:09.772355 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-27 06:39:10.423988 | debian-bookworm | changed 2026-05-27 06:39:10.434754 | 2026-05-27 06:39:10.434973 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-27 06:39:11.148395 | debian-bookworm | changed 2026-05-27 06:39:11.156127 | 2026-05-27 06:39:11.156261 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-27 06:39:11.180079 | debian-bookworm | skipping: Conditional result was False 2026-05-27 06:39:11.186653 | 2026-05-27 06:39:11.186783 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-27 06:39:11.669364 | debian-bookworm -> localhost | changed 2026-05-27 06:39:11.680940 | 2026-05-27 06:39:11.681082 | TASK [add-build-sshkey : Add back temp key] 2026-05-27 06:39:12.033406 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/f7c3db38c017479e8dd744bd505467a3/work/f7c3db38c017479e8dd744bd505467a3_id_rsa (zuul-build-sshkey) 2026-05-27 06:39:12.033671 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.014326 2026-05-27 06:39:12.042406 | 2026-05-27 06:39:12.042541 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-27 06:39:12.498425 | debian-bookworm | ok 2026-05-27 06:39:12.507654 | 2026-05-27 06:39:12.507926 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-27 06:39:12.532866 | debian-bookworm | skipping: Conditional result was False 2026-05-27 06:39:12.544060 | 2026-05-27 06:39:12.544188 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-27 06:39:12.974659 | debian-bookworm | ok 2026-05-27 06:39:12.985980 | 2026-05-27 06:39:12.986113 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-27 06:39:13.015333 | debian-bookworm | ok 2026-05-27 06:39:13.020759 | 2026-05-27 06:39:13.020906 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-27 06:39:13.338409 | debian-bookworm -> localhost | ok 2026-05-27 06:39:13.345151 | 2026-05-27 06:39:13.345275 | TASK [validate-host : Collect information about the host] 2026-05-27 06:39:14.473563 | debian-bookworm | ok 2026-05-27 06:39:14.484531 | 2026-05-27 06:39:14.484653 | TASK [validate-host : Sanitize hostname] 2026-05-27 06:39:14.602275 | debian-bookworm | ok 2026-05-27 06:39:14.668214 | 2026-05-27 06:39:14.668374 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-27 06:39:15.242147 | debian-bookworm -> localhost | changed 2026-05-27 06:39:15.248457 | 2026-05-27 06:39:15.248575 | TASK [validate-host : Collect information about zuul worker] 2026-05-27 06:39:15.670436 | debian-bookworm | ok 2026-05-27 06:39:15.679029 | 2026-05-27 06:39:15.679179 | TASK [validate-host : Write out all zuul information for each host] 2026-05-27 06:39:16.299587 | debian-bookworm -> localhost | changed 2026-05-27 06:39:16.310766 | 2026-05-27 06:39:16.310971 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-27 06:39:16.663354 | debian-bookworm | ok 2026-05-27 06:39:16.672016 | 2026-05-27 06:39:16.672157 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-27 06:39:17.754303 | debian-bookworm | changed: 2026-05-27 06:39:17.754529 | debian-bookworm | cd+++++++++ src/ 2026-05-27 06:39:17.754565 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-27 06:39:17.754590 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-27 06:39:17.754612 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2026-05-27 06:39:17.754633 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/f7c3db38c017479e8dd744bd505467a3/work/logs" 2026-05-27 06:39:43.580038 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/f7c3db38c017479e8dd744bd505467a3/work/artifacts" 2026-05-27 06:39:43.840636 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/f7c3db38c017479e8dd744bd505467a3/work/docs" 2026-05-27 06:39:43.863235 | 2026-05-27 06:39:43.863403 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-27 06:39:44.636710 | debian-bookworm | changed: 2026-05-27 06:39:44.636961 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-27 06:39:44.637000 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-27 06:39:44.637030 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-27 06:39:44.637078 | debian-bookworm | changed: All items complete 2026-05-27 06:39:44.637105 | 2026-05-27 06:39:45.213247 | debian-bookworm | changed: .d..t...... ./ 2026-05-27 06:39:45.799902 | debian-bookworm | changed: .d..t...... ./ 2026-05-27 06:39:45.833307 | 2026-05-27 06:39:45.833459 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-27 06:39:46.412369 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.008658 2026-05-27 06:39:46.736701 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.009006 2026-05-27 06:39:46.759955 | 2026-05-27 06:39:46.760086 | PLAY RECAP 2026-05-27 06:39:46.760145 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-27 06:39:46.760171 | 2026-05-27 06:39:46.928705 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-27 06:39:46.929582 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-27 06:39:47.673384 | 2026-05-27 06:39:47.673556 | PLAY [Base post] 2026-05-27 06:39:47.687699 | 2026-05-27 06:39:47.687857 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-27 06:39:48.254632 | debian-bookworm | changed 2026-05-27 06:39:48.263757 | 2026-05-27 06:39:48.263919 | PLAY RECAP 2026-05-27 06:39:48.263990 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-27 06:39:48.264053 | 2026-05-27 06:39:48.395801 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-27 06:39:48.396728 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-27 06:39:49.237368 | 2026-05-27 06:39:49.237545 | PLAY [Base post-logs] 2026-05-27 06:39:49.259809 | 2026-05-27 06:39:49.260003 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-27 06:39:49.734291 | localhost | changed 2026-05-27 06:39:49.757153 | 2026-05-27 06:39:49.757531 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-27 06:39:49.787323 | localhost | ok 2026-05-27 06:39:49.793905 | 2026-05-27 06:39:49.794098 | TASK [Set zuul-log-path fact] 2026-05-27 06:39:49.813618 | localhost | ok 2026-05-27 06:39:49.830492 | 2026-05-27 06:39:49.830680 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-27 06:39:49.859077 | localhost | ok 2026-05-27 06:39:49.865524 | 2026-05-27 06:39:49.865704 | TASK [upload-logs : Create log directories] 2026-05-27 06:39:50.410282 | localhost | changed 2026-05-27 06:39:50.416029 | 2026-05-27 06:39:50.416185 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-27 06:39:50.983362 | localhost -> localhost | ok: Runtime: 0:00:00.010521 2026-05-27 06:39:50.987414 | 2026-05-27 06:39:50.987532 | TASK [upload-logs : Upload logs to log server] 2026-05-27 06:39:51.595579 | localhost | Output suppressed because no_log was given 2026-05-27 06:39:51.597457 | 2026-05-27 06:39:51.597571 | LOOP [upload-logs : Compress console log and json output] 2026-05-27 06:39:51.644978 | localhost | skipping: Conditional result was False 2026-05-27 06:39:51.651046 | localhost | skipping: Conditional result was False 2026-05-27 06:39:51.654609 | 2026-05-27 06:39:51.654721 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-27 06:39:51.699340 | localhost | skipping: Conditional result was False 2026-05-27 06:39:51.699689 | 2026-05-27 06:39:51.704439 | localhost | skipping: Conditional result was False 2026-05-27 06:39:51.712349 | 2026-05-27 06:39:51.712464 | LOOP [upload-logs : Upload console log and json output]