2026-05-22 03:12:25.714617 | Job console starting 2026-05-22 03:12:25.726569 | Updating git repos 2026-05-22 03:12:25.746969 | Cloning repos into workspace 2026-05-22 03:12:25.808086 | Restoring repo states 2026-05-22 03:12:25.834275 | Merging changes 2026-05-22 03:12:25.834298 | Checking out repos 2026-05-22 03:12:25.914296 | Preparing playbooks 2026-05-22 03:12:27.188571 | Running Ansible setup 2026-05-22 03:12:32.674046 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-22 03:12:33.478433 | 2026-05-22 03:12:33.478555 | PLAY [Base pre] 2026-05-22 03:12:33.511239 | 2026-05-22 03:12:33.511366 | TASK [Setup log path fact] 2026-05-22 03:12:33.529386 | debian-bookworm | ok 2026-05-22 03:12:33.544969 | 2026-05-22 03:12:33.545092 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-22 03:12:33.573226 | debian-bookworm | ok 2026-05-22 03:12:33.584996 | 2026-05-22 03:12:33.585107 | TASK [emit-job-header : Print job information] 2026-05-22 03:12:33.624570 | # Job Information 2026-05-22 03:12:33.624736 | Ansible Version: 2.16.14 2026-05-22 03:12:33.624771 | Job: yamllint 2026-05-22 03:12:33.624813 | Pipeline: periodic-daily 2026-05-22 03:12:33.624837 | Executor: 521e9411259a 2026-05-22 03:12:33.624859 | Triggered by: https://github.com/osism/testbed 2026-05-22 03:12:33.624881 | Event ID: d0e230dbab474a0082b6aa6410263483 2026-05-22 03:12:33.629610 | 2026-05-22 03:12:33.629708 | LOOP [emit-job-header : Print node information] 2026-05-22 03:12:33.729527 | debian-bookworm | ok: 2026-05-22 03:12:33.729759 | debian-bookworm | # Node Information 2026-05-22 03:12:33.729822 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-22 03:12:33.729849 | debian-bookworm | Hostname: debian 2026-05-22 03:12:33.729871 | debian-bookworm | Username: zuul 2026-05-22 03:12:33.729892 | debian-bookworm | Distro: Debian 12.14 2026-05-22 03:12:33.729919 | debian-bookworm | Provider: regiocloud-a 2026-05-22 03:12:33.729941 | debian-bookworm | Region: 2026-05-22 03:12:33.729962 | debian-bookworm | Label: debian-bookworm 2026-05-22 03:12:33.729981 | debian-bookworm | Product Name: OpenStack Nova 2026-05-22 03:12:33.730000 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feec:8ecc 2026-05-22 03:12:33.750688 | 2026-05-22 03:12:33.750821 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-22 03:12:34.233802 | debian-bookworm -> localhost | changed 2026-05-22 03:12:34.242665 | 2026-05-22 03:12:34.242775 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-22 03:12:35.280382 | debian-bookworm -> localhost | changed 2026-05-22 03:12:35.289498 | 2026-05-22 03:12:35.289587 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-22 03:12:35.577818 | debian-bookworm -> localhost | ok 2026-05-22 03:12:35.583688 | 2026-05-22 03:12:35.583782 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-22 03:12:35.602737 | debian-bookworm | ok 2026-05-22 03:12:35.616978 | debian-bookworm | included: /var/lib/zuul/builds/f68af1387aa342f79dc4ca0f7a0c1c89/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-22 03:12:35.622895 | 2026-05-22 03:12:35.622978 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-22 03:12:37.750550 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-22 03:12:37.750740 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/f68af1387aa342f79dc4ca0f7a0c1c89/work/f68af1387aa342f79dc4ca0f7a0c1c89_id_rsa 2026-05-22 03:12:37.750778 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/f68af1387aa342f79dc4ca0f7a0c1c89/work/f68af1387aa342f79dc4ca0f7a0c1c89_id_rsa.pub 2026-05-22 03:12:37.750861 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-22 03:12:37.750890 | debian-bookworm -> localhost | SHA256:YmrWGUARm4Y2WTcCjYKqab5JK/FhVUMrpbiphTMaxmo zuul-build-sshkey 2026-05-22 03:12:37.750914 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-22 03:12:37.750947 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-22 03:12:37.750970 | debian-bookworm -> localhost | |. .+*+= | 2026-05-22 03:12:37.750992 | debian-bookworm -> localhost | |o .*.Boo | 2026-05-22 03:12:37.751013 | debian-bookworm -> localhost | |..* B... | 2026-05-22 03:12:37.751033 | debian-bookworm -> localhost | |oo =.o | 2026-05-22 03:12:37.751054 | debian-bookworm -> localhost | |*++. + S | 2026-05-22 03:12:37.751081 | debian-bookworm -> localhost | |BBo + + | 2026-05-22 03:12:37.751102 | debian-bookworm -> localhost | |*E .+ o | 2026-05-22 03:12:37.751122 | debian-bookworm -> localhost | |+.+o | 2026-05-22 03:12:37.751144 | debian-bookworm -> localhost | |.+. | 2026-05-22 03:12:37.751165 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-22 03:12:37.751220 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.670606 2026-05-22 03:12:37.757349 | 2026-05-22 03:12:37.757435 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-22 03:12:37.774480 | debian-bookworm | ok 2026-05-22 03:12:37.791860 | debian-bookworm | included: /var/lib/zuul/builds/f68af1387aa342f79dc4ca0f7a0c1c89/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-22 03:12:37.809101 | 2026-05-22 03:12:37.809201 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-22 03:12:37.836974 | debian-bookworm | skipping: Conditional result was False 2026-05-22 03:12:37.843474 | 2026-05-22 03:12:37.843570 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-22 03:12:38.520352 | debian-bookworm | changed 2026-05-22 03:12:38.525486 | 2026-05-22 03:12:38.525569 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-22 03:12:38.769391 | debian-bookworm | ok 2026-05-22 03:12:38.774804 | 2026-05-22 03:12:38.774919 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-22 03:12:39.381617 | debian-bookworm | changed 2026-05-22 03:12:39.388681 | 2026-05-22 03:12:39.388789 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-22 03:12:40.013982 | debian-bookworm | changed 2026-05-22 03:12:40.019435 | 2026-05-22 03:12:40.019531 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-22 03:12:40.052857 | debian-bookworm | skipping: Conditional result was False 2026-05-22 03:12:40.059967 | 2026-05-22 03:12:40.060091 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-22 03:12:40.556571 | debian-bookworm -> localhost | changed 2026-05-22 03:12:40.567092 | 2026-05-22 03:12:40.567195 | TASK [add-build-sshkey : Add back temp key] 2026-05-22 03:12:40.884491 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/f68af1387aa342f79dc4ca0f7a0c1c89/work/f68af1387aa342f79dc4ca0f7a0c1c89_id_rsa (zuul-build-sshkey) 2026-05-22 03:12:40.884705 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.023412 2026-05-22 03:12:40.892525 | 2026-05-22 03:12:40.892627 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-22 03:12:41.309466 | debian-bookworm | ok 2026-05-22 03:12:41.316636 | 2026-05-22 03:12:41.316739 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-22 03:12:41.340301 | debian-bookworm | skipping: Conditional result was False 2026-05-22 03:12:41.353241 | 2026-05-22 03:12:41.355126 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-22 03:12:41.807662 | debian-bookworm | ok 2026-05-22 03:12:41.818166 | 2026-05-22 03:12:41.818276 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-22 03:12:41.845916 | debian-bookworm | ok 2026-05-22 03:12:41.850841 | 2026-05-22 03:12:41.850939 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-22 03:12:42.096617 | debian-bookworm -> localhost | ok 2026-05-22 03:12:42.103410 | 2026-05-22 03:12:42.103503 | TASK [validate-host : Collect information about the host] 2026-05-22 03:12:43.242214 | debian-bookworm | ok 2026-05-22 03:12:43.267152 | 2026-05-22 03:12:43.267300 | TASK [validate-host : Sanitize hostname] 2026-05-22 03:12:43.475902 | debian-bookworm | ok 2026-05-22 03:12:43.611851 | 2026-05-22 03:12:43.613113 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-22 03:12:44.416058 | debian-bookworm -> localhost | changed 2026-05-22 03:12:44.422700 | 2026-05-22 03:12:44.422923 | TASK [validate-host : Collect information about zuul worker] 2026-05-22 03:12:44.995560 | debian-bookworm | ok 2026-05-22 03:12:45.010177 | 2026-05-22 03:12:45.013576 | TASK [validate-host : Write out all zuul information for each host] 2026-05-22 03:12:46.687634 | debian-bookworm -> localhost | changed 2026-05-22 03:12:46.714613 | 2026-05-22 03:12:46.715917 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-22 03:12:47.109896 | debian-bookworm | ok 2026-05-22 03:12:47.125624 | 2026-05-22 03:12:47.125813 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-22 03:12:48.753158 | debian-bookworm | changed: 2026-05-22 03:12:48.753330 | debian-bookworm | cd+++++++++ src/ 2026-05-22 03:12:48.753365 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-22 03:12:48.753389 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-22 03:12:48.753411 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2026-05-22 03:12:48.753431 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/f68af1387aa342f79dc4ca0f7a0c1c89/work/logs" 2026-05-22 03:13:16.041017 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/f68af1387aa342f79dc4ca0f7a0c1c89/work/artifacts" 2026-05-22 03:13:16.276600 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/f68af1387aa342f79dc4ca0f7a0c1c89/work/docs" 2026-05-22 03:13:16.295683 | 2026-05-22 03:13:16.295912 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-22 03:13:17.063552 | debian-bookworm | changed: 2026-05-22 03:13:17.063815 | debian-bookworm | .d..t...... ./ 2026-05-22 03:13:17.063853 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-22 03:13:17.063885 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-22 03:13:17.063912 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-22 03:13:17.063952 | debian-bookworm | changed: All items complete 2026-05-22 03:13:17.063975 | 2026-05-22 03:13:17.684693 | debian-bookworm | changed: .d..t...... ./ 2026-05-22 03:13:18.325097 | debian-bookworm | changed: .d..t...... ./ 2026-05-22 03:13:18.347929 | 2026-05-22 03:13:18.348071 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-22 03:13:18.394508 | debian-bookworm | skipping: Conditional result was False 2026-05-22 03:13:18.400677 | debian-bookworm | skipping: Conditional result was False 2026-05-22 03:13:18.414314 | 2026-05-22 03:13:18.414434 | PLAY RECAP 2026-05-22 03:13:18.414488 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-22 03:13:18.414514 | 2026-05-22 03:13:18.559905 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-22 03:13:18.560800 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-22 03:13:19.347477 | 2026-05-22 03:13:19.347651 | PLAY [Base post] 2026-05-22 03:13:19.363235 | 2026-05-22 03:13:19.363387 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-22 03:13:19.952804 | debian-bookworm | changed 2026-05-22 03:13:19.959534 | 2026-05-22 03:13:19.959652 | PLAY RECAP 2026-05-22 03:13:19.959730 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-22 03:13:19.959795 | 2026-05-22 03:13:20.104792 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-22 03:13:20.105624 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-22 03:13:20.952423 | 2026-05-22 03:13:20.952611 | PLAY [Base post-logs] 2026-05-22 03:13:20.963991 | 2026-05-22 03:13:20.964148 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-22 03:13:21.486874 | localhost | changed 2026-05-22 03:13:21.500836 | 2026-05-22 03:13:21.500998 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-22 03:13:21.539771 | localhost | ok 2026-05-22 03:13:21.546084 | 2026-05-22 03:13:21.546235 | TASK [Set zuul-log-path fact] 2026-05-22 03:13:21.569442 | localhost | ok 2026-05-22 03:13:21.577601 | 2026-05-22 03:13:21.577737 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-22 03:13:21.613515 | localhost | ok 2026-05-22 03:13:21.618332 | 2026-05-22 03:13:21.618483 | TASK [upload-logs : Create log directories] 2026-05-22 03:13:22.190044 | localhost | changed 2026-05-22 03:13:22.196385 | 2026-05-22 03:13:22.196515 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-22 03:13:22.754783 | localhost -> localhost | ok: Runtime: 0:00:00.007375 2026-05-22 03:13:22.760788 | 2026-05-22 03:13:22.760938 | TASK [upload-logs : Upload logs to log server] 2026-05-22 03:13:23.467457 | localhost | Output suppressed because no_log was given 2026-05-22 03:13:23.469770 | 2026-05-22 03:13:23.469878 | LOOP [upload-logs : Compress console log and json output] 2026-05-22 03:13:23.522527 | localhost | skipping: Conditional result was False 2026-05-22 03:13:23.529196 | localhost | skipping: Conditional result was False 2026-05-22 03:13:23.542144 | 2026-05-22 03:13:23.542378 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-22 03:13:23.594525 | localhost | skipping: Conditional result was False 2026-05-22 03:13:23.594915 | 2026-05-22 03:13:23.599888 | localhost | skipping: Conditional result was False 2026-05-22 03:13:23.605948 | 2026-05-22 03:13:23.606132 | LOOP [upload-logs : Upload console log and json output]