2026-05-09 21:08:48.249779 | Job console starting 2026-05-09 21:08:48.277762 | Updating git repos 2026-05-09 21:08:48.344178 | Cloning repos into workspace 2026-05-09 21:08:48.410171 | Restoring repo states 2026-05-09 21:08:48.440223 | Merging changes 2026-05-09 21:08:49.022973 | Checking out repos 2026-05-09 21:08:49.053382 | Preparing playbooks 2026-05-09 21:08:50.366241 | Running Ansible setup 2026-05-09 21:08:57.293890 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-09 21:08:59.084651 | 2026-05-09 21:08:59.084834 | PLAY [Base pre] 2026-05-09 21:08:59.129677 | 2026-05-09 21:08:59.129850 | TASK [Setup log path fact] 2026-05-09 21:08:59.166447 | debian-bookworm | ok 2026-05-09 21:08:59.212850 | 2026-05-09 21:08:59.213075 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-09 21:08:59.267350 | debian-bookworm | ok 2026-05-09 21:08:59.281516 | 2026-05-09 21:08:59.281663 | TASK [emit-job-header : Print job information] 2026-05-09 21:08:59.355352 | # Job Information 2026-05-09 21:08:59.355546 | Ansible Version: 2.16.14 2026-05-09 21:08:59.355581 | Job: check-shell-syntax 2026-05-09 21:08:59.355614 | Pipeline: check 2026-05-09 21:08:59.355637 | Executor: 521e9411259a 2026-05-09 21:08:59.355657 | Triggered by: https://github.com/osism/generics/pull/593 2026-05-09 21:08:59.355680 | Event ID: 3fa965a0-4beb-11f1-893a-142211c38529 2026-05-09 21:08:59.360783 | 2026-05-09 21:08:59.360904 | LOOP [emit-job-header : Print node information] 2026-05-09 21:08:59.616713 | debian-bookworm | ok: 2026-05-09 21:08:59.617014 | debian-bookworm | # Node Information 2026-05-09 21:08:59.617056 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-09 21:08:59.617082 | debian-bookworm | Hostname: debian 2026-05-09 21:08:59.617105 | debian-bookworm | Username: zuul 2026-05-09 21:08:59.617126 | debian-bookworm | Distro: Debian 12.13 2026-05-09 21:08:59.617156 | debian-bookworm | Provider: regiocloud-a 2026-05-09 21:08:59.617182 | debian-bookworm | Region: 2026-05-09 21:08:59.617204 | debian-bookworm | Label: debian-bookworm 2026-05-09 21:08:59.617224 | debian-bookworm | Product Name: OpenStack Nova 2026-05-09 21:08:59.617243 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe32:7dc9 2026-05-09 21:08:59.633342 | 2026-05-09 21:08:59.633493 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-09 21:09:00.698609 | debian-bookworm -> localhost | changed 2026-05-09 21:09:00.706274 | 2026-05-09 21:09:00.706463 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-09 21:09:03.041338 | debian-bookworm -> localhost | changed 2026-05-09 21:09:03.053629 | 2026-05-09 21:09:03.053753 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-09 21:09:03.502623 | debian-bookworm -> localhost | ok 2026-05-09 21:09:03.508719 | 2026-05-09 21:09:03.508816 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-09 21:09:03.538772 | debian-bookworm | ok 2026-05-09 21:09:03.573528 | debian-bookworm | included: /var/lib/zuul/builds/a0bc3555b552488f809b5773d60ca66e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-09 21:09:03.600209 | 2026-05-09 21:09:03.600314 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-09 21:09:04.996516 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-09 21:09:04.996703 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/a0bc3555b552488f809b5773d60ca66e/work/a0bc3555b552488f809b5773d60ca66e_id_rsa 2026-05-09 21:09:04.996737 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/a0bc3555b552488f809b5773d60ca66e/work/a0bc3555b552488f809b5773d60ca66e_id_rsa.pub 2026-05-09 21:09:04.996763 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-09 21:09:04.996787 | debian-bookworm -> localhost | SHA256:/cETzovmZUYAA5dOu5qtPJkhgPrfuYaBsx9pA9GKMJE zuul-build-sshkey 2026-05-09 21:09:04.996809 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-09 21:09:04.996841 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-09 21:09:04.996864 | debian-bookworm -> localhost | |.. ..+. | 2026-05-09 21:09:04.996886 | debian-bookworm -> localhost | |E. . .oo | 2026-05-09 21:09:04.996906 | debian-bookworm -> localhost | |o.. . o .. . | 2026-05-09 21:09:04.996926 | debian-bookworm -> localhost | |oo.o o. = . | 2026-05-09 21:09:04.996946 | debian-bookworm -> localhost | |o oo S.. B | 2026-05-09 21:09:04.996987 | debian-bookworm -> localhost | |. o.o.. . + + | 2026-05-09 21:09:04.997010 | debian-bookworm -> localhost | | . o=+ B o * | 2026-05-09 21:09:04.997030 | debian-bookworm -> localhost | | o..=B..o + | 2026-05-09 21:09:04.997051 | debian-bookworm -> localhost | | oo.*+ . | 2026-05-09 21:09:04.997070 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-09 21:09:04.997122 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.413760 2026-05-09 21:09:05.003308 | 2026-05-09 21:09:05.003413 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-09 21:09:05.030827 | debian-bookworm | ok 2026-05-09 21:09:05.047618 | debian-bookworm | included: /var/lib/zuul/builds/a0bc3555b552488f809b5773d60ca66e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-09 21:09:05.057006 | 2026-05-09 21:09:05.057098 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-09 21:09:05.104769 | debian-bookworm | skipping: Conditional result was False 2026-05-09 21:09:05.111373 | 2026-05-09 21:09:05.111475 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-09 21:09:05.948060 | debian-bookworm | changed 2026-05-09 21:09:05.953468 | 2026-05-09 21:09:05.953554 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-09 21:09:06.235005 | debian-bookworm | ok 2026-05-09 21:09:06.240326 | 2026-05-09 21:09:06.240417 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-09 21:09:06.957050 | debian-bookworm | changed 2026-05-09 21:09:06.967153 | 2026-05-09 21:09:06.967267 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-09 21:09:07.696698 | debian-bookworm | changed 2026-05-09 21:09:07.702206 | 2026-05-09 21:09:07.702318 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-09 21:09:07.740602 | debian-bookworm | skipping: Conditional result was False 2026-05-09 21:09:07.746430 | 2026-05-09 21:09:07.746526 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-09 21:09:08.247748 | debian-bookworm -> localhost | changed 2026-05-09 21:09:08.263765 | 2026-05-09 21:09:08.263898 | TASK [add-build-sshkey : Add back temp key] 2026-05-09 21:09:08.569726 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/a0bc3555b552488f809b5773d60ca66e/work/a0bc3555b552488f809b5773d60ca66e_id_rsa (zuul-build-sshkey) 2026-05-09 21:09:08.569931 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.031669 2026-05-09 21:09:08.578025 | 2026-05-09 21:09:08.578117 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-09 21:09:09.048705 | debian-bookworm | ok 2026-05-09 21:09:09.054605 | 2026-05-09 21:09:09.054708 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-09 21:09:09.079191 | debian-bookworm | skipping: Conditional result was False 2026-05-09 21:09:09.107775 | 2026-05-09 21:09:09.107882 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-09 21:09:09.653890 | debian-bookworm | ok 2026-05-09 21:09:09.666802 | 2026-05-09 21:09:09.666933 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-09 21:09:09.729726 | debian-bookworm | ok 2026-05-09 21:09:09.734027 | 2026-05-09 21:09:09.734120 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-09 21:09:10.165319 | debian-bookworm -> localhost | ok 2026-05-09 21:09:10.173754 | 2026-05-09 21:09:10.173861 | TASK [validate-host : Collect information about the host] 2026-05-09 21:09:11.380629 | debian-bookworm | ok 2026-05-09 21:09:11.395810 | 2026-05-09 21:09:11.395952 | TASK [validate-host : Sanitize hostname] 2026-05-09 21:09:11.527473 | debian-bookworm | ok 2026-05-09 21:09:11.634568 | 2026-05-09 21:09:11.634730 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-09 21:09:12.668336 | debian-bookworm -> localhost | changed 2026-05-09 21:09:12.674857 | 2026-05-09 21:09:12.675000 | TASK [validate-host : Collect information about zuul worker] 2026-05-09 21:09:13.147190 | debian-bookworm | ok 2026-05-09 21:09:13.152287 | 2026-05-09 21:09:13.152392 | TASK [validate-host : Write out all zuul information for each host] 2026-05-09 21:09:13.840499 | debian-bookworm -> localhost | changed 2026-05-09 21:09:13.848859 | 2026-05-09 21:09:13.848977 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-09 21:09:14.166900 | debian-bookworm | ok 2026-05-09 21:09:14.172369 | 2026-05-09 21:09:14.172472 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-09 21:09:14.995016 | debian-bookworm | changed: 2026-05-09 21:09:14.995229 | debian-bookworm | cd+++++++++ src/ 2026-05-09 21:09:14.995264 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-09 21:09:14.995289 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-09 21:09:14.995311 | debian-bookworm | cd+++++++++ src/github.com/osism/generics/ 2026-05-09 21:09:14.995331 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/a0bc3555b552488f809b5773d60ca66e/work/logs" 2026-05-09 21:09:22.719861 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/a0bc3555b552488f809b5773d60ca66e/work/artifacts" 2026-05-09 21:09:22.994636 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/a0bc3555b552488f809b5773d60ca66e/work/docs" 2026-05-09 21:09:23.016051 | 2026-05-09 21:09:23.016259 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-09 21:09:23.817453 | debian-bookworm | changed: 2026-05-09 21:09:23.817695 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-09 21:09:23.817730 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-09 21:09:23.817759 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-09 21:09:23.817805 | debian-bookworm | changed: All items complete 2026-05-09 21:09:23.817832 | 2026-05-09 21:09:24.400686 | debian-bookworm | changed: .d..t...... ./ 2026-05-09 21:09:25.032299 | debian-bookworm | changed: .d..t...... ./ 2026-05-09 21:09:25.051306 | 2026-05-09 21:09:25.051457 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-09 21:09:25.618590 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.010963 2026-05-09 21:09:25.911224 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.010630 2026-05-09 21:09:25.921480 | 2026-05-09 21:09:25.921582 | PLAY RECAP 2026-05-09 21:09:25.921636 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-09 21:09:25.921661 | 2026-05-09 21:09:26.057942 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-09 21:09:26.059917 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-09 21:09:26.917111 | 2026-05-09 21:09:26.917300 | PLAY [Base post] 2026-05-09 21:09:26.933210 | 2026-05-09 21:09:26.933371 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-09 21:09:27.521316 | debian-bookworm | changed 2026-05-09 21:09:27.531310 | 2026-05-09 21:09:27.531463 | PLAY RECAP 2026-05-09 21:09:27.531543 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-09 21:09:27.531619 | 2026-05-09 21:09:27.690073 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-09 21:09:27.692224 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-09 21:09:28.538757 | 2026-05-09 21:09:28.538992 | PLAY [Base post-logs] 2026-05-09 21:09:28.550378 | 2026-05-09 21:09:28.550542 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-09 21:09:29.045688 | localhost | changed 2026-05-09 21:09:29.060666 | 2026-05-09 21:09:29.060878 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-09 21:09:29.099845 | localhost | ok 2026-05-09 21:09:29.106764 | 2026-05-09 21:09:29.107127 | TASK [Set zuul-log-path fact] 2026-05-09 21:09:29.126187 | localhost | ok 2026-05-09 21:09:29.141530 | 2026-05-09 21:09:29.141672 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-09 21:09:29.179984 | localhost | ok 2026-05-09 21:09:29.186523 | 2026-05-09 21:09:29.186684 | TASK [upload-logs : Create log directories] 2026-05-09 21:09:29.765999 | localhost | changed 2026-05-09 21:09:29.769338 | 2026-05-09 21:09:29.769461 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-09 21:09:30.345092 | localhost -> localhost | ok: Runtime: 0:00:00.009315 2026-05-09 21:09:30.349865 | 2026-05-09 21:09:30.351114 | TASK [upload-logs : Upload logs to log server] 2026-05-09 21:09:30.969493 | localhost | Output suppressed because no_log was given 2026-05-09 21:09:30.971566 | 2026-05-09 21:09:30.971676 | LOOP [upload-logs : Compress console log and json output] 2026-05-09 21:09:31.087038 | localhost | skipping: Conditional result was False 2026-05-09 21:09:31.102228 | localhost | skipping: Conditional result was False 2026-05-09 21:09:31.113784 | 2026-05-09 21:09:31.113938 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-09 21:09:31.181568 | localhost | skipping: Conditional result was False 2026-05-09 21:09:31.181882 | 2026-05-09 21:09:31.186696 | localhost | skipping: Conditional result was False 2026-05-09 21:09:31.192658 | 2026-05-09 21:09:31.192776 | LOOP [upload-logs : Upload console log and json output]