2026-07-20 04:06:21.763545 | Job console starting 2026-07-20 04:06:21.782569 | Updating git repos 2026-07-20 04:06:21.831101 | Cloning repos into workspace 2026-07-20 04:06:21.967075 | Restoring repo states 2026-07-20 04:06:22.006577 | Merging changes 2026-07-20 04:06:22.006606 | Checking out repos 2026-07-20 04:06:22.135083 | Preparing playbooks 2026-07-20 04:06:23.548135 | Running Ansible setup 2026-07-20 04:06:29.728419 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-07-20 04:06:30.681733 | 2026-07-20 04:06:30.681925 | PLAY [Base pre] 2026-07-20 04:06:30.713775 | 2026-07-20 04:06:30.713948 | TASK [Setup log path fact] 2026-07-20 04:06:30.745798 | debian-bookworm | ok 2026-07-20 04:06:30.769394 | 2026-07-20 04:06:30.769568 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-20 04:06:30.820054 | debian-bookworm | ok 2026-07-20 04:06:30.830969 | 2026-07-20 04:06:30.831098 | TASK [emit-job-header : Print job information] 2026-07-20 04:06:30.872997 | # Job Information 2026-07-20 04:06:30.873208 | Ansible Version: 2.16.14 2026-07-20 04:06:30.873243 | Job: python-black 2026-07-20 04:06:30.873278 | Pipeline: periodic-daily 2026-07-20 04:06:30.873302 | Executor: 521e9411259a 2026-07-20 04:06:30.873323 | Triggered by: https://github.com/osism/openstack-sandbox-manager 2026-07-20 04:06:30.873344 | Event ID: cbff8a87e43849108de52c2fcc295bc0 2026-07-20 04:06:30.878554 | 2026-07-20 04:06:30.878693 | LOOP [emit-job-header : Print node information] 2026-07-20 04:06:30.994681 | debian-bookworm | ok: 2026-07-20 04:06:30.995102 | debian-bookworm | # Node Information 2026-07-20 04:06:30.995148 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-07-20 04:06:30.995173 | debian-bookworm | Hostname: debian 2026-07-20 04:06:30.995196 | debian-bookworm | Username: zuul 2026-07-20 04:06:30.995217 | debian-bookworm | Distro: Debian 12.15 2026-07-20 04:06:30.995240 | debian-bookworm | Provider: regiocloud-a 2026-07-20 04:06:30.995261 | debian-bookworm | Region: 2026-07-20 04:06:30.995282 | debian-bookworm | Label: debian-bookworm 2026-07-20 04:06:30.995302 | debian-bookworm | Product Name: OpenStack Nova 2026-07-20 04:06:30.995322 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe16:5f2c 2026-07-20 04:06:31.026804 | 2026-07-20 04:06:31.027010 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-07-20 04:06:31.640592 | debian-bookworm -> localhost | changed 2026-07-20 04:06:31.657803 | 2026-07-20 04:06:31.657951 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-07-20 04:06:33.865608 | debian-bookworm -> localhost | changed 2026-07-20 04:06:33.930729 | 2026-07-20 04:06:33.931077 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-07-20 04:06:34.779437 | debian-bookworm -> localhost | ok 2026-07-20 04:06:34.807154 | 2026-07-20 04:06:34.807310 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-07-20 04:06:34.861415 | debian-bookworm | ok 2026-07-20 04:06:34.885310 | debian-bookworm | included: /var/lib/zuul/builds/4701e5bee5ef472a8608d0b3cf87b161/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-07-20 04:06:34.897442 | 2026-07-20 04:06:34.897547 | TASK [add-build-sshkey : Create Temp SSH key] 2026-07-20 04:06:36.401458 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-07-20 04:06:36.401868 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/4701e5bee5ef472a8608d0b3cf87b161/work/4701e5bee5ef472a8608d0b3cf87b161_id_rsa 2026-07-20 04:06:36.401936 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/4701e5bee5ef472a8608d0b3cf87b161/work/4701e5bee5ef472a8608d0b3cf87b161_id_rsa.pub 2026-07-20 04:06:36.401972 | debian-bookworm -> localhost | The key fingerprint is: 2026-07-20 04:06:36.402004 | debian-bookworm -> localhost | SHA256:sZvQhJx+exOqJ+ySph9TaagyxVb0NjPMegcz2DWHJ70 zuul-build-sshkey 2026-07-20 04:06:36.402032 | debian-bookworm -> localhost | The key's randomart image is: 2026-07-20 04:06:36.402158 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-07-20 04:06:36.402191 | debian-bookworm -> localhost | | . oo. | 2026-07-20 04:06:36.402220 | debian-bookworm -> localhost | | . B +ooo | 2026-07-20 04:06:36.402246 | debian-bookworm -> localhost | | o ^ oo . | 2026-07-20 04:06:36.402271 | debian-bookworm -> localhost | | . . = @ oE | 2026-07-20 04:06:36.402296 | debian-bookworm -> localhost | | + o B S . | 2026-07-20 04:06:36.402329 | debian-bookworm -> localhost | | o . + + = . | 2026-07-20 04:06:36.402357 | debian-bookworm -> localhost | |o . oo = o | 2026-07-20 04:06:36.402383 | debian-bookworm -> localhost | | o +oo... . | 2026-07-20 04:06:36.402410 | debian-bookworm -> localhost | | .+.ooo | 2026-07-20 04:06:36.402436 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-07-20 04:06:36.402514 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.557247 2026-07-20 04:06:36.412687 | 2026-07-20 04:06:36.412799 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-07-20 04:06:36.432975 | debian-bookworm | ok 2026-07-20 04:06:36.446003 | debian-bookworm | included: /var/lib/zuul/builds/4701e5bee5ef472a8608d0b3cf87b161/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-07-20 04:06:36.455829 | 2026-07-20 04:06:36.455918 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-07-20 04:06:36.479659 | debian-bookworm | skipping: Conditional result was False 2026-07-20 04:06:36.486223 | 2026-07-20 04:06:36.486358 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-07-20 04:06:37.205502 | debian-bookworm | changed 2026-07-20 04:06:37.221295 | 2026-07-20 04:06:37.221408 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-07-20 04:06:37.508042 | debian-bookworm | ok 2026-07-20 04:06:37.515600 | 2026-07-20 04:06:37.515723 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-07-20 04:06:38.294323 | debian-bookworm | changed 2026-07-20 04:06:38.302820 | 2026-07-20 04:06:38.302935 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-07-20 04:06:39.169119 | debian-bookworm | changed 2026-07-20 04:06:39.174934 | 2026-07-20 04:06:39.175037 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-07-20 04:06:39.198600 | debian-bookworm | skipping: Conditional result was False 2026-07-20 04:06:39.204902 | 2026-07-20 04:06:39.205000 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-07-20 04:06:39.678162 | debian-bookworm -> localhost | changed 2026-07-20 04:06:39.701743 | 2026-07-20 04:06:39.701953 | TASK [add-build-sshkey : Add back temp key] 2026-07-20 04:06:40.133432 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/4701e5bee5ef472a8608d0b3cf87b161/work/4701e5bee5ef472a8608d0b3cf87b161_id_rsa (zuul-build-sshkey) 2026-07-20 04:06:40.133792 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.021176 2026-07-20 04:06:40.146433 | 2026-07-20 04:06:40.147048 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-07-20 04:06:40.611845 | debian-bookworm | ok 2026-07-20 04:06:40.620266 | 2026-07-20 04:06:40.620527 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-07-20 04:06:40.647012 | debian-bookworm | skipping: Conditional result was False 2026-07-20 04:06:40.661605 | 2026-07-20 04:06:40.661805 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-07-20 04:06:41.426031 | debian-bookworm | ok 2026-07-20 04:06:41.464346 | 2026-07-20 04:06:41.464521 | TASK [validate-host : Define zuul_info_dir fact] 2026-07-20 04:06:41.545152 | debian-bookworm | ok 2026-07-20 04:06:41.551775 | 2026-07-20 04:06:41.551942 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-07-20 04:06:41.948433 | debian-bookworm -> localhost | ok 2026-07-20 04:06:41.956020 | 2026-07-20 04:06:41.956152 | TASK [validate-host : Collect information about the host] 2026-07-20 04:06:43.746591 | debian-bookworm | ok 2026-07-20 04:06:43.787284 | 2026-07-20 04:06:43.787449 | TASK [validate-host : Sanitize hostname] 2026-07-20 04:06:44.206937 | debian-bookworm | ok 2026-07-20 04:06:44.213206 | 2026-07-20 04:06:44.213503 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-07-20 04:06:45.886778 | debian-bookworm -> localhost | changed 2026-07-20 04:06:45.899664 | 2026-07-20 04:06:45.899850 | TASK [validate-host : Collect information about zuul worker] 2026-07-20 04:06:46.464065 | debian-bookworm | ok 2026-07-20 04:06:46.474076 | 2026-07-20 04:06:46.474223 | TASK [validate-host : Write out all zuul information for each host] 2026-07-20 04:06:47.213933 | debian-bookworm -> localhost | changed 2026-07-20 04:06:47.225912 | 2026-07-20 04:06:47.226022 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-07-20 04:06:47.551836 | debian-bookworm | ok 2026-07-20 04:06:47.561303 | 2026-07-20 04:06:47.561446 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-07-20 04:06:48.551638 | debian-bookworm | changed: 2026-07-20 04:06:48.551838 | debian-bookworm | cd+++++++++ src/ 2026-07-20 04:06:48.551873 | debian-bookworm | cd+++++++++ src/github.com/ 2026-07-20 04:06:48.551898 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-07-20 04:06:48.551920 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-sandbox-manager/ 2026-07-20 04:06:48.551940 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/4701e5bee5ef472a8608d0b3cf87b161/work/logs" 2026-07-20 04:07:51.943105 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/4701e5bee5ef472a8608d0b3cf87b161/work/artifacts" 2026-07-20 04:07:52.290702 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/4701e5bee5ef472a8608d0b3cf87b161/work/docs" 2026-07-20 04:07:52.309376 | 2026-07-20 04:07:52.309552 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-07-20 04:07:53.168131 | debian-bookworm | changed: 2026-07-20 04:07:53.168393 | debian-bookworm | .d..t...... ./ 2026-07-20 04:07:53.168429 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-07-20 04:07:53.168453 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-07-20 04:07:53.168474 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-07-20 04:07:53.168495 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-07-20 04:07:53.168515 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-07-20 04:07:53.168557 | debian-bookworm | changed: All items complete 2026-07-20 04:07:53.168579 | 2026-07-20 04:07:53.784476 | debian-bookworm | changed: .d..t...... ./ 2026-07-20 04:07:54.415041 | debian-bookworm | changed: .d..t...... ./ 2026-07-20 04:07:54.429661 | 2026-07-20 04:07:54.429823 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-07-20 04:07:54.458867 | debian-bookworm | skipping: Conditional result was False 2026-07-20 04:07:54.461959 | debian-bookworm | skipping: Conditional result was False 2026-07-20 04:07:54.476706 | 2026-07-20 04:07:54.476816 | PLAY RECAP 2026-07-20 04:07:54.476881 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-07-20 04:07:54.476911 | 2026-07-20 04:07:54.668796 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-20 04:07:54.670339 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-20 04:07:55.534336 | 2026-07-20 04:07:55.534546 | PLAY [Base post] 2026-07-20 04:07:55.551362 | 2026-07-20 04:07:55.551531 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-07-20 04:07:56.180562 | debian-bookworm | changed 2026-07-20 04:07:56.199630 | 2026-07-20 04:07:56.200059 | PLAY RECAP 2026-07-20 04:07:56.200166 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-20 04:07:56.200309 | 2026-07-20 04:07:56.402654 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-20 04:07:56.404284 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-07-20 04:07:57.263559 | 2026-07-20 04:07:57.263768 | PLAY [Base post-logs] 2026-07-20 04:07:57.275347 | 2026-07-20 04:07:57.275504 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-07-20 04:07:57.798324 | localhost | changed 2026-07-20 04:07:57.810016 | 2026-07-20 04:07:57.810192 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-07-20 04:07:57.837987 | localhost | ok 2026-07-20 04:07:57.841279 | 2026-07-20 04:07:57.841387 | TASK [Set zuul-log-path fact] 2026-07-20 04:07:57.859026 | localhost | ok 2026-07-20 04:07:57.867821 | 2026-07-20 04:07:57.867963 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-20 04:07:57.893508 | localhost | ok 2026-07-20 04:07:57.897217 | 2026-07-20 04:07:57.897342 | TASK [upload-logs : Create log directories] 2026-07-20 04:07:58.498955 | localhost | changed 2026-07-20 04:07:58.505508 | 2026-07-20 04:07:58.505705 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-07-20 04:07:59.104633 | localhost -> localhost | ok: Runtime: 0:00:00.013659 2026-07-20 04:07:59.114448 | 2026-07-20 04:07:59.114699 | TASK [upload-logs : Upload logs to log server] 2026-07-20 04:07:59.837962 | localhost | Output suppressed because no_log was given 2026-07-20 04:07:59.840318 | 2026-07-20 04:07:59.841814 | LOOP [upload-logs : Compress console log and json output] 2026-07-20 04:07:59.900400 | localhost | skipping: Conditional result was False 2026-07-20 04:07:59.918318 | localhost | skipping: Conditional result was False 2026-07-20 04:07:59.937339 | 2026-07-20 04:07:59.937497 | LOOP [upload-logs : Upload compressed console log and json output] 2026-07-20 04:08:00.011579 | localhost | skipping: Conditional result was False 2026-07-20 04:08:00.011926 | 2026-07-20 04:08:00.018299 | localhost | skipping: Conditional result was False 2026-07-20 04:08:00.027464 | 2026-07-20 04:08:00.027652 | LOOP [upload-logs : Upload console log and json output]