2025-06-01 00:09:04.490126 | Job console starting 2025-06-01 00:09:04.500349 | Updating git repos 2025-06-01 00:09:04.529639 | Cloning repos into workspace 2025-06-01 00:09:04.575043 | Restoring repo states 2025-06-01 00:09:04.592270 | Merging changes 2025-06-01 00:09:05.143787 | Checking out repos 2025-06-01 00:09:05.193528 | Preparing playbooks 2025-06-01 00:09:05.920421 | Running Ansible setup 2025-06-01 00:09:10.850125 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-06-01 00:09:11.713913 | 2025-06-01 00:09:11.714293 | PLAY [Base pre] 2025-06-01 00:09:11.738501 | 2025-06-01 00:09:11.738914 | TASK [Setup log path fact] 2025-06-01 00:09:11.783040 | debian-bookworm | ok 2025-06-01 00:09:11.805817 | 2025-06-01 00:09:11.806015 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-06-01 00:09:11.863487 | debian-bookworm | ok 2025-06-01 00:09:11.882616 | 2025-06-01 00:09:11.882814 | TASK [emit-job-header : Print job information] 2025-06-01 00:09:12.011896 | # Job Information 2025-06-01 00:09:12.012724 | Ansible Version: 2.16.14 2025-06-01 00:09:12.013492 | Job: yamllint 2025-06-01 00:09:12.013883 | Pipeline: check 2025-06-01 00:09:12.014278 | Executor: 521e9411259a 2025-06-01 00:09:12.015037 | Triggered by: https://github.com/osism/testbed/pull/2715 2025-06-01 00:09:12.015488 | Event ID: 9b129b00-3e7c-11f0-8baa-3284173de9fb 2025-06-01 00:09:12.059753 | 2025-06-01 00:09:12.061274 | LOOP [emit-job-header : Print node information] 2025-06-01 00:09:12.251661 | debian-bookworm | ok: 2025-06-01 00:09:12.251930 | debian-bookworm | # Node Information 2025-06-01 00:09:12.251971 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-06-01 00:09:12.251996 | debian-bookworm | Hostname: debian 2025-06-01 00:09:12.252018 | debian-bookworm | Username: zuul 2025-06-01 00:09:12.252039 | debian-bookworm | Distro: Debian 12.11 2025-06-01 00:09:12.252063 | debian-bookworm | Provider: regiocloud-a 2025-06-01 00:09:12.252085 | debian-bookworm | Region: 2025-06-01 00:09:12.252106 | debian-bookworm | Label: debian-bookworm 2025-06-01 00:09:12.252125 | debian-bookworm | Product Name: OpenStack Nova 2025-06-01 00:09:12.252145 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fedf:84b7 2025-06-01 00:09:12.311558 | 2025-06-01 00:09:12.311722 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-06-01 00:09:13.249055 | debian-bookworm -> localhost | changed 2025-06-01 00:09:13.275299 | 2025-06-01 00:09:13.275734 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-06-01 00:09:14.951017 | debian-bookworm -> localhost | changed 2025-06-01 00:09:14.962862 | 2025-06-01 00:09:14.963056 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-06-01 00:09:15.244725 | debian-bookworm -> localhost | ok 2025-06-01 00:09:15.253636 | 2025-06-01 00:09:15.253781 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-06-01 00:09:15.282822 | debian-bookworm | ok 2025-06-01 00:09:15.301733 | debian-bookworm | included: /var/lib/zuul/builds/4b15e108ccca4b7eaa15630decffa99a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-06-01 00:09:15.308145 | 2025-06-01 00:09:15.308303 | TASK [add-build-sshkey : Create Temp SSH key] 2025-06-01 00:09:17.523896 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-06-01 00:09:17.524422 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/4b15e108ccca4b7eaa15630decffa99a/work/4b15e108ccca4b7eaa15630decffa99a_id_rsa 2025-06-01 00:09:17.524494 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/4b15e108ccca4b7eaa15630decffa99a/work/4b15e108ccca4b7eaa15630decffa99a_id_rsa.pub 2025-06-01 00:09:17.524523 | debian-bookworm -> localhost | The key fingerprint is: 2025-06-01 00:09:17.524551 | debian-bookworm -> localhost | SHA256:R+8cCAPzOKO8zClh02RpDn58BVou1ODQGT9U2Gw7GUQ zuul-build-sshkey 2025-06-01 00:09:17.524671 | debian-bookworm -> localhost | The key's randomart image is: 2025-06-01 00:09:17.524731 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-06-01 00:09:17.524755 | debian-bookworm -> localhost | | ..+=*BE | 2025-06-01 00:09:17.524778 | debian-bookworm -> localhost | | +oBo*= | 2025-06-01 00:09:17.524799 | debian-bookworm -> localhost | | . O B.=+. | 2025-06-01 00:09:17.524819 | debian-bookworm -> localhost | | . X o =++ o | 2025-06-01 00:09:17.524839 | debian-bookworm -> localhost | | = B . S.o o | 2025-06-01 00:09:17.524970 | debian-bookworm -> localhost | | . * + . o . | 2025-06-01 00:09:17.525003 | debian-bookworm -> localhost | | . = o | 2025-06-01 00:09:17.525025 | debian-bookworm -> localhost | | . | 2025-06-01 00:09:17.525047 | debian-bookworm -> localhost | | | 2025-06-01 00:09:17.525069 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-06-01 00:09:17.525273 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.376794 2025-06-01 00:09:17.537091 | 2025-06-01 00:09:17.537489 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-06-01 00:09:17.597698 | debian-bookworm | ok 2025-06-01 00:09:17.612022 | debian-bookworm | included: /var/lib/zuul/builds/4b15e108ccca4b7eaa15630decffa99a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-06-01 00:09:17.625417 | 2025-06-01 00:09:17.625541 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-06-01 00:09:17.662292 | debian-bookworm | skipping: Conditional result was False 2025-06-01 00:09:17.671080 | 2025-06-01 00:09:17.671613 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-06-01 00:09:18.445423 | debian-bookworm | changed 2025-06-01 00:09:18.451568 | 2025-06-01 00:09:18.451684 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-06-01 00:09:18.725482 | debian-bookworm | ok 2025-06-01 00:09:18.735534 | 2025-06-01 00:09:18.735795 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-06-01 00:09:19.421117 | debian-bookworm | changed 2025-06-01 00:09:19.434112 | 2025-06-01 00:09:19.434277 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-06-01 00:09:20.123726 | debian-bookworm | changed 2025-06-01 00:09:20.132348 | 2025-06-01 00:09:20.132460 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-06-01 00:09:20.156267 | debian-bookworm | skipping: Conditional result was False 2025-06-01 00:09:20.163115 | 2025-06-01 00:09:20.163247 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-06-01 00:09:20.793511 | debian-bookworm -> localhost | changed 2025-06-01 00:09:20.809898 | 2025-06-01 00:09:20.810052 | TASK [add-build-sshkey : Add back temp key] 2025-06-01 00:09:21.456206 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/4b15e108ccca4b7eaa15630decffa99a/work/4b15e108ccca4b7eaa15630decffa99a_id_rsa (zuul-build-sshkey) 2025-06-01 00:09:21.456637 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.022698 2025-06-01 00:09:21.470032 | 2025-06-01 00:09:21.470237 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-06-01 00:09:21.906079 | debian-bookworm | ok 2025-06-01 00:09:21.910958 | 2025-06-01 00:09:21.911050 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-06-01 00:09:21.934307 | debian-bookworm | skipping: Conditional result was False 2025-06-01 00:09:21.944219 | 2025-06-01 00:09:21.944328 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-06-01 00:09:22.369032 | debian-bookworm | ok 2025-06-01 00:09:22.391234 | 2025-06-01 00:09:22.391352 | TASK [validate-host : Define zuul_info_dir fact] 2025-06-01 00:09:22.440337 | debian-bookworm | ok 2025-06-01 00:09:22.445301 | 2025-06-01 00:09:22.445396 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-06-01 00:09:22.786140 | debian-bookworm -> localhost | ok 2025-06-01 00:09:22.792246 | 2025-06-01 00:09:22.792334 | TASK [validate-host : Collect information about the host] 2025-06-01 00:09:23.960837 | debian-bookworm | ok 2025-06-01 00:09:23.975874 | 2025-06-01 00:09:23.976048 | TASK [validate-host : Sanitize hostname] 2025-06-01 00:09:24.088506 | debian-bookworm | ok 2025-06-01 00:09:24.120446 | 2025-06-01 00:09:24.120555 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-06-01 00:09:24.710939 | debian-bookworm -> localhost | changed 2025-06-01 00:09:24.717004 | 2025-06-01 00:09:24.717118 | TASK [validate-host : Collect information about zuul worker] 2025-06-01 00:09:25.144590 | debian-bookworm | ok 2025-06-01 00:09:25.150627 | 2025-06-01 00:09:25.150757 | TASK [validate-host : Write out all zuul information for each host] 2025-06-01 00:09:25.843638 | debian-bookworm -> localhost | changed 2025-06-01 00:09:25.853953 | 2025-06-01 00:09:25.854070 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-06-01 00:09:26.143816 | debian-bookworm | ok 2025-06-01 00:09:26.159372 | 2025-06-01 00:09:26.159548 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-06-01 00:09:27.377374 | debian-bookworm | changed: 2025-06-01 00:09:27.377597 | debian-bookworm | cd+++++++++ src/ 2025-06-01 00:09:27.377633 | debian-bookworm | cd+++++++++ src/github.com/ 2025-06-01 00:09:27.377658 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-06-01 00:09:27.377680 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2025-06-01 00:09:27.377700 | debian-bookworm | , but found '' (syntax) 2025-06-01 00:09:49.089427 | debian-bookworm | 2025-06-01 00:09:49.468596 | debian-bookworm | ERROR 2025-06-01 00:09:49.469012 | debian-bookworm | { 2025-06-01 00:09:49.469094 | debian-bookworm | "delta": "0:00:01.358799", 2025-06-01 00:09:49.469208 | debian-bookworm | "end": "2025-06-01 00:09:49.106030", 2025-06-01 00:09:49.469273 | debian-bookworm | "msg": "non-zero return code", 2025-06-01 00:09:49.469307 | debian-bookworm | "rc": 1, 2025-06-01 00:09:49.469340 | debian-bookworm | "start": "2025-06-01 00:09:47.747231" 2025-06-01 00:09:49.469372 | debian-bookworm | } failure 2025-06-01 00:09:49.474471 | 2025-06-01 00:09:49.474609 | PLAY RECAP 2025-06-01 00:09:49.474711 | debian-bookworm | ok: 9 changed: 6 unreachable: 0 failed: 1 skipped: 12 rescued: 0 ignored: 0 2025-06-01 00:09:49.474755 | 2025-06-01 00:09:49.728073 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/zuul-jobs/playbooks/yamllint/run.yaml@main] 2025-06-01 00:09:49.729166 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-06-01 00:09:50.486967 | 2025-06-01 00:09:50.487183 | PLAY [Base post] 2025-06-01 00:09:50.501502 | 2025-06-01 00:09:50.501657 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-06-01 00:09:51.129898 | debian-bookworm | changed 2025-06-01 00:09:51.141898 | 2025-06-01 00:09:51.142051 | PLAY RECAP 2025-06-01 00:09:51.142218 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-06-01 00:09:51.142810 | 2025-06-01 00:09:51.335661 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-06-01 00:09:51.337030 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-06-01 00:09:52.241838 | 2025-06-01 00:09:52.242065 | PLAY [Base post-logs] 2025-06-01 00:09:52.254163 | 2025-06-01 00:09:52.254342 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-06-01 00:09:52.717944 | localhost | changed 2025-06-01 00:09:52.728557 | 2025-06-01 00:09:52.728718 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-06-01 00:09:52.755296 | localhost | ok 2025-06-01 00:09:52.759032 | 2025-06-01 00:09:52.759152 | TASK [Set zuul-log-path fact] 2025-06-01 00:09:52.785917 | localhost | ok 2025-06-01 00:09:52.793955 | 2025-06-01 00:09:52.794062 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-06-01 00:09:52.819019 | localhost | ok 2025-06-01 00:09:52.822207 | 2025-06-01 00:09:52.822311 | TASK [upload-logs : Create log directories] 2025-06-01 00:09:53.476083 | localhost | changed 2025-06-01 00:09:53.479527 | 2025-06-01 00:09:53.479643 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-06-01 00:09:54.120347 | localhost -> localhost | ok: Runtime: 0:00:00.010459 2025-06-01 00:09:54.124830 | 2025-06-01 00:09:54.124949 | TASK [upload-logs : Upload logs to log server] 2025-06-01 00:09:54.825668 | localhost | Output suppressed because no_log was given 2025-06-01 00:09:54.828693 | 2025-06-01 00:09:54.828812 | LOOP [upload-logs : Compress console log and json output] 2025-06-01 00:09:54.885430 | localhost | skipping: Conditional result was False 2025-06-01 00:09:54.898503 | localhost | skipping: Conditional result was False 2025-06-01 00:09:54.912203 | 2025-06-01 00:09:54.912350 | LOOP [upload-logs : Upload compressed console log and json output] 2025-06-01 00:09:54.966376 | localhost | skipping: Conditional result was False 2025-06-01 00:09:54.967107 | 2025-06-01 00:09:54.970394 | localhost | skipping: Conditional result was False 2025-06-01 00:09:54.979710 | 2025-06-01 00:09:54.979825 | LOOP [upload-logs : Upload console log and json output]