2026-05-03 03:06:25.584734 | Job console starting 2026-05-03 03:06:25.603505 | Updating git repos 2026-05-03 03:06:25.649695 | Cloning repos into workspace 2026-05-03 03:06:25.691489 | Restoring repo states 2026-05-03 03:06:25.742645 | Merging changes 2026-05-03 03:06:25.742667 | Checking out repos 2026-05-03 03:06:25.790541 | Preparing playbooks 2026-05-03 03:06:26.409607 | Running Ansible setup 2026-05-03 03:06:32.102718 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-03 03:06:34.342205 | 2026-05-03 03:06:34.342358 | PLAY [Base pre] 2026-05-03 03:06:34.434987 | 2026-05-03 03:06:34.435117 | TASK [Setup log path fact] 2026-05-03 03:06:34.468169 | debian-bookworm | ok 2026-05-03 03:06:34.519327 | 2026-05-03 03:06:34.519909 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-03 03:06:34.585103 | debian-bookworm | ok 2026-05-03 03:06:34.596474 | 2026-05-03 03:06:34.596615 | TASK [emit-job-header : Print job information] 2026-05-03 03:06:34.636754 | # Job Information 2026-05-03 03:06:34.636916 | Ansible Version: 2.16.14 2026-05-03 03:06:34.636951 | Job: check-shell-syntax 2026-05-03 03:06:34.636984 | Pipeline: periodic-daily 2026-05-03 03:06:34.637007 | Executor: 521e9411259a 2026-05-03 03:06:34.637028 | Triggered by: https://github.com/osism/generics 2026-05-03 03:06:34.637050 | Event ID: 0aea623a29b44030acb025d5a51287d1 2026-05-03 03:06:34.641801 | 2026-05-03 03:06:34.641897 | LOOP [emit-job-header : Print node information] 2026-05-03 03:06:34.968703 | debian-bookworm | ok: 2026-05-03 03:06:34.969169 | debian-bookworm | # Node Information 2026-05-03 03:06:34.969225 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-03 03:06:34.969252 | debian-bookworm | Hostname: debian 2026-05-03 03:06:34.969314 | debian-bookworm | Username: zuul 2026-05-03 03:06:34.969341 | debian-bookworm | Distro: Debian 12.13 2026-05-03 03:06:34.969369 | debian-bookworm | Provider: regiocloud-a 2026-05-03 03:06:34.969391 | debian-bookworm | Region: 2026-05-03 03:06:34.969413 | debian-bookworm | Label: debian-bookworm 2026-05-03 03:06:34.969434 | debian-bookworm | Product Name: OpenStack Nova 2026-05-03 03:06:34.969453 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe80:a6d6 2026-05-03 03:06:34.998775 | 2026-05-03 03:06:34.998910 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-03 03:06:36.157665 | debian-bookworm -> localhost | changed 2026-05-03 03:06:36.163702 | 2026-05-03 03:06:36.163791 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-03 03:06:37.376733 | debian-bookworm -> localhost | changed 2026-05-03 03:06:37.402275 | 2026-05-03 03:06:37.402408 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-03 03:06:37.821876 | debian-bookworm -> localhost | ok 2026-05-03 03:06:37.828343 | 2026-05-03 03:06:37.828467 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-03 03:06:37.905044 | debian-bookworm | ok 2026-05-03 03:06:37.947782 | debian-bookworm | included: /var/lib/zuul/builds/3a095f35d62147e3a80aed3f6b3d795f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-03 03:06:37.970117 | 2026-05-03 03:06:37.970229 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-03 03:06:39.359252 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-03 03:06:39.359538 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/3a095f35d62147e3a80aed3f6b3d795f/work/3a095f35d62147e3a80aed3f6b3d795f_id_rsa 2026-05-03 03:06:39.359577 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/3a095f35d62147e3a80aed3f6b3d795f/work/3a095f35d62147e3a80aed3f6b3d795f_id_rsa.pub 2026-05-03 03:06:39.359603 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-03 03:06:39.359626 | debian-bookworm -> localhost | SHA256:FnF17e/NTAyz7uMp0Qq98pngeB39ahyW5tcJEVtzMuo zuul-build-sshkey 2026-05-03 03:06:39.359649 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-03 03:06:39.359685 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-03 03:06:39.359708 | debian-bookworm -> localhost | | . ... .. | 2026-05-03 03:06:39.359729 | debian-bookworm -> localhost | | o oooo| 2026-05-03 03:06:39.359750 | debian-bookworm -> localhost | | . .++o| 2026-05-03 03:06:39.359770 | debian-bookworm -> localhost | | . .oo .| 2026-05-03 03:06:39.359791 | debian-bookworm -> localhost | | S o o.*.| 2026-05-03 03:06:39.359813 | debian-bookworm -> localhost | | . . E.O +| 2026-05-03 03:06:39.359833 | debian-bookworm -> localhost | | .o @.B+| 2026-05-03 03:06:39.359854 | debian-bookworm -> localhost | | oo.=o*oO| 2026-05-03 03:06:39.359875 | debian-bookworm -> localhost | | ...o+==+ | 2026-05-03 03:06:39.359895 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-03 03:06:39.359950 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.495045 2026-05-03 03:06:39.366635 | 2026-05-03 03:06:39.366805 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-03 03:06:39.396408 | debian-bookworm | ok 2026-05-03 03:06:39.409216 | debian-bookworm | included: /var/lib/zuul/builds/3a095f35d62147e3a80aed3f6b3d795f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-03 03:06:39.420258 | 2026-05-03 03:06:39.420367 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-03 03:06:39.444844 | debian-bookworm | skipping: Conditional result was False 2026-05-03 03:06:39.464062 | 2026-05-03 03:06:39.464300 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-03 03:06:40.121307 | debian-bookworm | changed 2026-05-03 03:06:40.130559 | 2026-05-03 03:06:40.130698 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-03 03:06:40.360982 | debian-bookworm | ok 2026-05-03 03:06:40.375452 | 2026-05-03 03:06:40.375590 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-03 03:06:41.102953 | debian-bookworm | changed 2026-05-03 03:06:41.110857 | 2026-05-03 03:06:41.110962 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-03 03:06:41.876144 | debian-bookworm | changed 2026-05-03 03:06:41.889918 | 2026-05-03 03:06:41.890026 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-03 03:06:41.973105 | debian-bookworm | skipping: Conditional result was False 2026-05-03 03:06:41.989028 | 2026-05-03 03:06:41.989141 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-03 03:06:43.317440 | debian-bookworm -> localhost | changed 2026-05-03 03:06:43.331246 | 2026-05-03 03:06:43.332173 | TASK [add-build-sshkey : Add back temp key] 2026-05-03 03:06:44.357134 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/3a095f35d62147e3a80aed3f6b3d795f/work/3a095f35d62147e3a80aed3f6b3d795f_id_rsa (zuul-build-sshkey) 2026-05-03 03:06:44.357363 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.034598 2026-05-03 03:06:44.365657 | 2026-05-03 03:06:44.365769 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-03 03:06:45.029224 | debian-bookworm | ok 2026-05-03 03:06:45.034626 | 2026-05-03 03:06:45.034738 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-03 03:06:45.101431 | debian-bookworm | skipping: Conditional result was False 2026-05-03 03:06:45.114250 | 2026-05-03 03:06:45.114366 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-03 03:06:45.889211 | debian-bookworm | ok 2026-05-03 03:06:45.908319 | 2026-05-03 03:06:45.908440 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-03 03:06:45.972766 | debian-bookworm | ok 2026-05-03 03:06:45.977352 | 2026-05-03 03:06:45.977451 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-03 03:06:46.402230 | debian-bookworm -> localhost | ok 2026-05-03 03:06:46.407645 | 2026-05-03 03:06:46.407727 | TASK [validate-host : Collect information about the host] 2026-05-03 03:06:47.820705 | debian-bookworm | ok 2026-05-03 03:06:47.857831 | 2026-05-03 03:06:47.857944 | TASK [validate-host : Sanitize hostname] 2026-05-03 03:06:48.178415 | debian-bookworm | ok 2026-05-03 03:06:48.252330 | 2026-05-03 03:06:48.252441 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-03 03:06:48.958076 | debian-bookworm -> localhost | changed 2026-05-03 03:06:48.963737 | 2026-05-03 03:06:48.963841 | TASK [validate-host : Collect information about zuul worker] 2026-05-03 03:06:49.435420 | debian-bookworm | ok 2026-05-03 03:06:49.439990 | 2026-05-03 03:06:49.440092 | TASK [validate-host : Write out all zuul information for each host] 2026-05-03 03:06:50.327267 | debian-bookworm -> localhost | changed 2026-05-03 03:06:50.336880 | 2026-05-03 03:06:50.342999 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-03 03:06:50.675886 | debian-bookworm | ok 2026-05-03 03:06:50.681762 | 2026-05-03 03:06:50.687107 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-03 03:06:52.611859 | debian-bookworm | changed: 2026-05-03 03:06:52.612097 | debian-bookworm | cd+++++++++ src/ 2026-05-03 03:06:52.612135 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-03 03:06:52.612159 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-03 03:06:52.612181 | debian-bookworm | cd+++++++++ src/github.com/osism/generics/ 2026-05-03 03:06:52.612201 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/3a095f35d62147e3a80aed3f6b3d795f/work/logs" 2026-05-03 03:07:03.384611 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/3a095f35d62147e3a80aed3f6b3d795f/work/artifacts" 2026-05-03 03:07:03.870428 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/3a095f35d62147e3a80aed3f6b3d795f/work/docs" 2026-05-03 03:07:03.889661 | 2026-05-03 03:07:03.889784 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-03 03:07:04.752624 | debian-bookworm | changed: 2026-05-03 03:07:04.752803 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-03 03:07:04.752832 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-03 03:07:04.752857 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-03 03:07:04.752892 | debian-bookworm | changed: All items complete 2026-05-03 03:07:04.752913 | 2026-05-03 03:07:05.559861 | debian-bookworm | changed: .d..t...... ./ 2026-05-03 03:07:06.337822 | debian-bookworm | changed: .d..t...... ./ 2026-05-03 03:07:06.356892 | 2026-05-03 03:07:06.356999 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-03 03:07:06.379510 | debian-bookworm | skipping: Conditional result was False 2026-05-03 03:07:06.392535 | debian-bookworm | skipping: Conditional result was False 2026-05-03 03:07:06.409326 | 2026-05-03 03:07:06.409437 | PLAY RECAP 2026-05-03 03:07:06.409487 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-03 03:07:06.409512 | 2026-05-03 03:07:06.513920 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-03 03:07:06.514673 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-03 03:07:07.472369 | 2026-05-03 03:07:07.472547 | PLAY [Base post] 2026-05-03 03:07:07.493660 | 2026-05-03 03:07:07.493815 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-03 03:07:08.399867 | debian-bookworm | changed 2026-05-03 03:07:08.408674 | 2026-05-03 03:07:08.408795 | PLAY RECAP 2026-05-03 03:07:08.408861 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-03 03:07:08.408923 | 2026-05-03 03:07:08.530541 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-03 03:07:08.531294 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-03 03:07:09.395114 | 2026-05-03 03:07:09.395247 | PLAY [Base post-logs] 2026-05-03 03:07:09.410003 | 2026-05-03 03:07:09.410125 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-03 03:07:09.819777 | localhost | changed 2026-05-03 03:07:09.829297 | 2026-05-03 03:07:09.829468 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-03 03:07:09.858630 | localhost | ok 2026-05-03 03:07:09.862759 | 2026-05-03 03:07:09.862873 | TASK [Set zuul-log-path fact] 2026-05-03 03:07:09.888272 | localhost | ok 2026-05-03 03:07:09.897721 | 2026-05-03 03:07:09.897835 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-03 03:07:09.946291 | localhost | ok 2026-05-03 03:07:09.949669 | 2026-05-03 03:07:09.949764 | TASK [upload-logs : Create log directories] 2026-05-03 03:07:10.482259 | localhost | changed 2026-05-03 03:07:10.488215 | 2026-05-03 03:07:10.488479 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-03 03:07:11.039306 | localhost -> localhost | ok: Runtime: 0:00:00.015341 2026-05-03 03:07:11.043620 | 2026-05-03 03:07:11.043724 | TASK [upload-logs : Upload logs to log server] 2026-05-03 03:07:11.800210 | localhost | Output suppressed because no_log was given 2026-05-03 03:07:11.801794 | 2026-05-03 03:07:11.801884 | LOOP [upload-logs : Compress console log and json output] 2026-05-03 03:07:11.885928 | localhost | skipping: Conditional result was False 2026-05-03 03:07:11.904119 | localhost | skipping: Conditional result was False 2026-05-03 03:07:11.909468 | 2026-05-03 03:07:11.909566 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-03 03:07:11.989459 | localhost | skipping: Conditional result was False 2026-05-03 03:07:11.989750 | 2026-05-03 03:07:11.994804 | localhost | skipping: Conditional result was False 2026-05-03 03:07:12.005173 | 2026-05-03 03:07:12.005270 | LOOP [upload-logs : Upload console log and json output]