2026-06-29 03:25:48.987062 | Job console starting 2026-06-29 03:25:49.003651 | Updating git repos 2026-06-29 03:25:49.042576 | Cloning repos into workspace 2026-06-29 03:25:49.214639 | Restoring repo states 2026-06-29 03:25:49.225896 | Merging changes 2026-06-29 03:25:49.225920 | Checking out repos 2026-06-29 03:25:49.403636 | Preparing playbooks 2026-06-29 03:25:50.433983 | Running Ansible setup 2026-06-29 03:25:56.050545 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-06-29 03:25:56.990775 | 2026-06-29 03:25:56.991001 | PLAY [Base pre] 2026-06-29 03:25:57.011419 | 2026-06-29 03:25:57.011586 | TASK [Setup log path fact] 2026-06-29 03:25:57.032179 | debian-bookworm | ok 2026-06-29 03:25:57.052982 | 2026-06-29 03:25:57.053225 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-29 03:25:57.085436 | debian-bookworm | ok 2026-06-29 03:25:57.096010 | 2026-06-29 03:25:57.096162 | TASK [emit-job-header : Print job information] 2026-06-29 03:25:57.150523 | # Job Information 2026-06-29 03:25:57.150812 | Ansible Version: 2.16.14 2026-06-29 03:25:57.150887 | Job: python-black 2026-06-29 03:25:57.150936 | Pipeline: periodic-daily 2026-06-29 03:25:57.150972 | Executor: 521e9411259a 2026-06-29 03:25:57.151004 | Triggered by: https://github.com/osism/testbed 2026-06-29 03:25:57.151039 | Event ID: 4714e370863d460ea9d2a7448a529ef0 2026-06-29 03:25:57.159632 | 2026-06-29 03:25:57.159802 | LOOP [emit-job-header : Print node information] 2026-06-29 03:25:57.283519 | debian-bookworm | ok: 2026-06-29 03:25:57.283752 | debian-bookworm | # Node Information 2026-06-29 03:25:57.283789 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-06-29 03:25:57.283814 | debian-bookworm | Hostname: debian 2026-06-29 03:25:57.284593 | debian-bookworm | Username: zuul 2026-06-29 03:25:57.284661 | debian-bookworm | Distro: Debian 12.14 2026-06-29 03:25:57.284689 | debian-bookworm | Provider: regiocloud-a 2026-06-29 03:25:57.284712 | debian-bookworm | Region: 2026-06-29 03:25:57.284734 | debian-bookworm | Label: debian-bookworm 2026-06-29 03:25:57.284755 | debian-bookworm | Product Name: OpenStack Nova 2026-06-29 03:25:57.284775 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe8e:28f4 2026-06-29 03:25:57.296238 | 2026-06-29 03:25:57.296382 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-29 03:25:57.882160 | debian-bookworm -> localhost | changed 2026-06-29 03:25:57.893185 | 2026-06-29 03:25:57.893350 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-29 03:26:00.106454 | debian-bookworm -> localhost | changed 2026-06-29 03:26:00.127920 | 2026-06-29 03:26:00.128098 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-29 03:26:00.878946 | debian-bookworm -> localhost | ok 2026-06-29 03:26:00.889794 | 2026-06-29 03:26:00.889951 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-29 03:26:00.965565 | debian-bookworm | ok 2026-06-29 03:26:01.029527 | debian-bookworm | included: /var/lib/zuul/builds/401173bfc07f4abcbb23de7fceab0200/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-29 03:26:01.065564 | 2026-06-29 03:26:01.065812 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-29 03:26:03.047588 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-06-29 03:26:03.047857 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/401173bfc07f4abcbb23de7fceab0200/work/401173bfc07f4abcbb23de7fceab0200_id_rsa 2026-06-29 03:26:03.047899 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/401173bfc07f4abcbb23de7fceab0200/work/401173bfc07f4abcbb23de7fceab0200_id_rsa.pub 2026-06-29 03:26:03.047926 | debian-bookworm -> localhost | The key fingerprint is: 2026-06-29 03:26:03.047950 | debian-bookworm -> localhost | SHA256:O9a5R583Gnf3EkQoVyovlVv1XH4yYAcDQsl7Sh6fb38 zuul-build-sshkey 2026-06-29 03:26:03.047973 | debian-bookworm -> localhost | The key's randomart image is: 2026-06-29 03:26:03.048004 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-06-29 03:26:03.048026 | debian-bookworm -> localhost | | oo...=+o o| 2026-06-29 03:26:03.048048 | debian-bookworm -> localhost | | o...o*.+o| 2026-06-29 03:26:03.048100 | debian-bookworm -> localhost | | ..o+.+ =| 2026-06-29 03:26:03.048124 | debian-bookworm -> localhost | | + .+ o.o.| 2026-06-29 03:26:03.048145 | debian-bookworm -> localhost | | oS=..o. | 2026-06-29 03:26:03.048171 | debian-bookworm -> localhost | | oooo. . | 2026-06-29 03:26:03.048194 | debian-bookworm -> localhost | | + oo o +o| 2026-06-29 03:26:03.048215 | debian-bookworm -> localhost | | . . .+ *.E| 2026-06-29 03:26:03.048236 | debian-bookworm -> localhost | | .o oo+o| 2026-06-29 03:26:03.048257 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-06-29 03:26:03.048308 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.902285 2026-06-29 03:26:03.055457 | 2026-06-29 03:26:03.055582 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-29 03:26:03.085277 | debian-bookworm | ok 2026-06-29 03:26:03.121344 | debian-bookworm | included: /var/lib/zuul/builds/401173bfc07f4abcbb23de7fceab0200/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-29 03:26:03.130772 | 2026-06-29 03:26:03.130980 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-29 03:26:03.166011 | debian-bookworm | skipping: Conditional result was False 2026-06-29 03:26:03.173187 | 2026-06-29 03:26:03.173346 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-29 03:26:03.961579 | debian-bookworm | changed 2026-06-29 03:26:03.973798 | 2026-06-29 03:26:03.973949 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-29 03:26:04.352513 | debian-bookworm | ok 2026-06-29 03:26:04.360039 | 2026-06-29 03:26:04.360196 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-29 03:26:05.092422 | debian-bookworm | changed 2026-06-29 03:26:05.110104 | 2026-06-29 03:26:05.110261 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-29 03:26:05.849464 | debian-bookworm | changed 2026-06-29 03:26:05.861886 | 2026-06-29 03:26:05.862033 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-29 03:26:05.909564 | debian-bookworm | skipping: Conditional result was False 2026-06-29 03:26:05.916852 | 2026-06-29 03:26:05.916988 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-29 03:26:06.769326 | debian-bookworm -> localhost | changed 2026-06-29 03:26:06.793599 | 2026-06-29 03:26:06.793750 | TASK [add-build-sshkey : Add back temp key] 2026-06-29 03:26:07.334734 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/401173bfc07f4abcbb23de7fceab0200/work/401173bfc07f4abcbb23de7fceab0200_id_rsa (zuul-build-sshkey) 2026-06-29 03:26:07.335049 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.012493 2026-06-29 03:26:07.343672 | 2026-06-29 03:26:07.343804 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-29 03:26:07.831277 | debian-bookworm | ok 2026-06-29 03:26:07.837783 | 2026-06-29 03:26:07.837925 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-29 03:26:07.883377 | debian-bookworm | skipping: Conditional result was False 2026-06-29 03:26:07.899310 | 2026-06-29 03:26:07.899459 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-06-29 03:26:08.616814 | debian-bookworm | ok 2026-06-29 03:26:08.630336 | 2026-06-29 03:26:08.630485 | TASK [validate-host : Define zuul_info_dir fact] 2026-06-29 03:26:08.660790 | debian-bookworm | ok 2026-06-29 03:26:08.666979 | 2026-06-29 03:26:08.667143 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-06-29 03:26:09.140002 | debian-bookworm -> localhost | ok 2026-06-29 03:26:09.154607 | 2026-06-29 03:26:09.154779 | TASK [validate-host : Collect information about the host] 2026-06-29 03:26:10.404060 | debian-bookworm | ok 2026-06-29 03:26:10.418263 | 2026-06-29 03:26:10.418409 | TASK [validate-host : Sanitize hostname] 2026-06-29 03:26:10.611902 | debian-bookworm | ok 2026-06-29 03:26:10.618471 | 2026-06-29 03:26:10.618611 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-06-29 03:26:11.415410 | debian-bookworm -> localhost | changed 2026-06-29 03:26:11.437531 | 2026-06-29 03:26:11.438207 | TASK [validate-host : Collect information about zuul worker] 2026-06-29 03:26:11.972996 | debian-bookworm | ok 2026-06-29 03:26:11.981764 | 2026-06-29 03:26:11.981925 | TASK [validate-host : Write out all zuul information for each host] 2026-06-29 03:26:12.591923 | debian-bookworm -> localhost | changed 2026-06-29 03:26:12.608175 | 2026-06-29 03:26:12.608449 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-06-29 03:26:12.936880 | debian-bookworm | ok 2026-06-29 03:26:12.947404 | 2026-06-29 03:26:12.947548 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-06-29 03:26:14.722440 | debian-bookworm | changed: 2026-06-29 03:26:14.722740 | debian-bookworm | cd+++++++++ src/ 2026-06-29 03:26:14.722789 | debian-bookworm | cd+++++++++ src/github.com/ 2026-06-29 03:26:14.722815 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-06-29 03:26:14.722864 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2026-06-29 03:26:14.722886 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/401173bfc07f4abcbb23de7fceab0200/work/logs" 2026-06-29 03:27:19.363692 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/401173bfc07f4abcbb23de7fceab0200/work/artifacts" 2026-06-29 03:27:19.697024 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/401173bfc07f4abcbb23de7fceab0200/work/docs" 2026-06-29 03:27:19.713316 | 2026-06-29 03:27:19.713514 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-29 03:27:20.568976 | debian-bookworm | changed: 2026-06-29 03:27:20.569257 | debian-bookworm | .d..t...... ./ 2026-06-29 03:27:20.569295 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-06-29 03:27:20.569320 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-06-29 03:27:20.569342 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-06-29 03:27:20.569363 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-06-29 03:27:20.569384 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-06-29 03:27:20.569429 | debian-bookworm | changed: All items complete 2026-06-29 03:27:20.569456 | 2026-06-29 03:27:21.161266 | debian-bookworm | changed: .d..t...... ./ 2026-06-29 03:27:21.816899 | debian-bookworm | changed: .d..t...... ./ 2026-06-29 03:27:21.851386 | 2026-06-29 03:27:21.851547 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-29 03:27:21.900909 | debian-bookworm | skipping: Conditional result was False 2026-06-29 03:27:21.905165 | debian-bookworm | skipping: Conditional result was False 2026-06-29 03:27:21.916429 | 2026-06-29 03:27:21.916538 | PLAY RECAP 2026-06-29 03:27:21.916594 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-06-29 03:27:21.916620 | 2026-06-29 03:27:22.114189 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-06-29 03:27:22.116349 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-29 03:27:22.958890 | 2026-06-29 03:27:22.959092 | PLAY [Base post] 2026-06-29 03:27:22.973801 | 2026-06-29 03:27:22.973962 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-29 03:27:23.583335 | debian-bookworm | changed 2026-06-29 03:27:23.592625 | 2026-06-29 03:27:23.592763 | PLAY RECAP 2026-06-29 03:27:23.592828 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-29 03:27:23.592891 | 2026-06-29 03:27:23.742040 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-29 03:27:23.743477 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-06-29 03:27:24.612478 | 2026-06-29 03:27:24.612730 | PLAY [Base post-logs] 2026-06-29 03:27:24.624395 | 2026-06-29 03:27:24.624551 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-29 03:27:25.145323 | localhost | changed 2026-06-29 03:27:25.164699 | 2026-06-29 03:27:25.164917 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-29 03:27:25.202648 | localhost | ok 2026-06-29 03:27:25.208388 | 2026-06-29 03:27:25.208547 | TASK [Set zuul-log-path fact] 2026-06-29 03:27:25.225610 | localhost | ok 2026-06-29 03:27:25.235495 | 2026-06-29 03:27:25.235613 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-29 03:27:25.273878 | localhost | ok 2026-06-29 03:27:25.280142 | 2026-06-29 03:27:25.280357 | TASK [upload-logs : Create log directories] 2026-06-29 03:27:25.858820 | localhost | changed 2026-06-29 03:27:25.862483 | 2026-06-29 03:27:25.862632 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-29 03:27:26.453000 | localhost -> localhost | ok: Runtime: 0:00:00.010295 2026-06-29 03:27:26.461349 | 2026-06-29 03:27:26.461580 | TASK [upload-logs : Upload logs to log server] 2026-06-29 03:27:27.117953 | localhost | Output suppressed because no_log was given 2026-06-29 03:27:27.123231 | 2026-06-29 03:27:27.123439 | LOOP [upload-logs : Compress console log and json output] 2026-06-29 03:27:27.199248 | localhost | skipping: Conditional result was False 2026-06-29 03:27:27.204885 | localhost | skipping: Conditional result was False 2026-06-29 03:27:27.217209 | 2026-06-29 03:27:27.217427 | LOOP [upload-logs : Upload compressed console log and json output] 2026-06-29 03:27:27.278404 | localhost | skipping: Conditional result was False 2026-06-29 03:27:27.279108 | 2026-06-29 03:27:27.282820 | localhost | skipping: Conditional result was False 2026-06-29 03:27:27.289582 | 2026-06-29 03:27:27.289735 | LOOP [upload-logs : Upload console log and json output]