2026-04-29 03:10:28.232565 | Job console starting 2026-04-29 03:10:28.243977 | Updating git repos 2026-04-29 03:10:28.269952 | Cloning repos into workspace 2026-04-29 03:10:28.322258 | Restoring repo states 2026-04-29 03:10:28.339364 | Merging changes 2026-04-29 03:10:28.339381 | Checking out repos 2026-04-29 03:10:28.393441 | Preparing playbooks 2026-04-29 03:10:29.064603 | Running Ansible setup 2026-04-29 03:10:33.749008 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-04-29 03:10:34.535173 | 2026-04-29 03:10:34.535317 | PLAY [Base pre] 2026-04-29 03:10:34.563218 | 2026-04-29 03:10:34.563352 | TASK [Setup log path fact] 2026-04-29 03:10:34.591620 | debian-bookworm | ok 2026-04-29 03:10:34.607333 | 2026-04-29 03:10:34.607461 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-29 03:10:34.635473 | debian-bookworm | ok 2026-04-29 03:10:34.645461 | 2026-04-29 03:10:34.645564 | TASK [emit-job-header : Print job information] 2026-04-29 03:10:34.684183 | # Job Information 2026-04-29 03:10:34.684348 | Ansible Version: 2.16.14 2026-04-29 03:10:34.684382 | Job: python-black 2026-04-29 03:10:34.684414 | Pipeline: periodic-daily 2026-04-29 03:10:34.684437 | Executor: 521e9411259a 2026-04-29 03:10:34.684457 | Triggered by: https://github.com/osism/openstack-health-middleware 2026-04-29 03:10:34.684479 | Event ID: 183c033add5640e398d0a96633039ca3 2026-04-29 03:10:34.689516 | 2026-04-29 03:10:34.689645 | LOOP [emit-job-header : Print node information] 2026-04-29 03:10:34.793050 | debian-bookworm | ok: 2026-04-29 03:10:34.793222 | debian-bookworm | # Node Information 2026-04-29 03:10:34.793256 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-04-29 03:10:34.793281 | debian-bookworm | Hostname: debian 2026-04-29 03:10:34.793302 | debian-bookworm | Username: zuul 2026-04-29 03:10:34.793323 | debian-bookworm | Distro: Debian 12.13 2026-04-29 03:10:34.793346 | debian-bookworm | Provider: regiocloud-a 2026-04-29 03:10:34.793366 | debian-bookworm | Region: 2026-04-29 03:10:34.793387 | debian-bookworm | Label: debian-bookworm 2026-04-29 03:10:34.793406 | debian-bookworm | Product Name: OpenStack Nova 2026-04-29 03:10:34.793426 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe50:a107 2026-04-29 03:10:34.809107 | 2026-04-29 03:10:34.809225 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-29 03:10:35.287281 | debian-bookworm -> localhost | changed 2026-04-29 03:10:35.294331 | 2026-04-29 03:10:35.294435 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-29 03:10:36.332885 | debian-bookworm -> localhost | changed 2026-04-29 03:10:36.343815 | 2026-04-29 03:10:36.343929 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-29 03:10:36.593504 | debian-bookworm -> localhost | ok 2026-04-29 03:10:36.599722 | 2026-04-29 03:10:36.599823 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-29 03:10:36.619046 | debian-bookworm | ok 2026-04-29 03:10:36.633618 | debian-bookworm | included: /var/lib/zuul/builds/0012f2af109c4d24bafef85acd238c5e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-29 03:10:36.639729 | 2026-04-29 03:10:36.639819 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-29 03:10:37.622091 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-04-29 03:10:37.622302 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/0012f2af109c4d24bafef85acd238c5e/work/0012f2af109c4d24bafef85acd238c5e_id_rsa 2026-04-29 03:10:37.622337 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/0012f2af109c4d24bafef85acd238c5e/work/0012f2af109c4d24bafef85acd238c5e_id_rsa.pub 2026-04-29 03:10:37.622362 | debian-bookworm -> localhost | The key fingerprint is: 2026-04-29 03:10:37.622386 | debian-bookworm -> localhost | SHA256:DC1EFrZe0qqBFKBmuS4kVBj3PNMMnUo19foYidJkxME zuul-build-sshkey 2026-04-29 03:10:37.622407 | debian-bookworm -> localhost | The key's randomart image is: 2026-04-29 03:10:37.622436 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-04-29 03:10:37.622459 | debian-bookworm -> localhost | |.o+o o@*+. | 2026-04-29 03:10:37.622480 | debian-bookworm -> localhost | |..+.o==E. . | 2026-04-29 03:10:37.622500 | debian-bookworm -> localhost | |.=. .=*=+ . | 2026-04-29 03:10:37.622519 | debian-bookworm -> localhost | |+... o*B. o | 2026-04-29 03:10:37.622538 | debian-bookworm -> localhost | |.o. ..ooS+ | 2026-04-29 03:10:37.622565 | debian-bookworm -> localhost | |+ o. + | 2026-04-29 03:10:37.622611 | debian-bookworm -> localhost | |.. . . . | 2026-04-29 03:10:37.622636 | debian-bookworm -> localhost | |. | 2026-04-29 03:10:37.622657 | debian-bookworm -> localhost | | | 2026-04-29 03:10:37.622678 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-04-29 03:10:37.622737 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.538780 2026-04-29 03:10:37.629053 | 2026-04-29 03:10:37.629147 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-29 03:10:37.658643 | debian-bookworm | ok 2026-04-29 03:10:37.668944 | debian-bookworm | included: /var/lib/zuul/builds/0012f2af109c4d24bafef85acd238c5e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-29 03:10:37.677800 | 2026-04-29 03:10:37.677886 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-29 03:10:37.691197 | debian-bookworm | skipping: Conditional result was False 2026-04-29 03:10:37.699198 | 2026-04-29 03:10:37.699308 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-29 03:10:38.359420 | debian-bookworm | changed 2026-04-29 03:10:38.367748 | 2026-04-29 03:10:38.367854 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-29 03:10:38.637801 | debian-bookworm | ok 2026-04-29 03:10:38.645618 | 2026-04-29 03:10:38.645731 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-29 03:10:39.343324 | debian-bookworm | changed 2026-04-29 03:10:39.353071 | 2026-04-29 03:10:39.353174 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-29 03:10:40.115900 | debian-bookworm | changed 2026-04-29 03:10:40.140969 | 2026-04-29 03:10:40.141092 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-29 03:10:40.183689 | debian-bookworm | skipping: Conditional result was False 2026-04-29 03:10:40.190100 | 2026-04-29 03:10:40.190210 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-29 03:10:40.903238 | debian-bookworm -> localhost | changed 2026-04-29 03:10:40.916259 | 2026-04-29 03:10:40.916363 | TASK [add-build-sshkey : Add back temp key] 2026-04-29 03:10:41.387354 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/0012f2af109c4d24bafef85acd238c5e/work/0012f2af109c4d24bafef85acd238c5e_id_rsa (zuul-build-sshkey) 2026-04-29 03:10:41.387627 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.013094 2026-04-29 03:10:41.396731 | 2026-04-29 03:10:41.396842 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-29 03:10:41.938561 | debian-bookworm | ok 2026-04-29 03:10:41.946189 | 2026-04-29 03:10:41.946305 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-29 03:10:42.011818 | debian-bookworm | skipping: Conditional result was False 2026-04-29 03:10:42.023296 | 2026-04-29 03:10:42.023405 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-04-29 03:10:42.604893 | debian-bookworm | ok 2026-04-29 03:10:42.629954 | 2026-04-29 03:10:42.630081 | TASK [validate-host : Define zuul_info_dir fact] 2026-04-29 03:10:42.678760 | debian-bookworm | ok 2026-04-29 03:10:42.685428 | 2026-04-29 03:10:42.685543 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-04-29 03:10:43.094139 | debian-bookworm -> localhost | ok 2026-04-29 03:10:43.100741 | 2026-04-29 03:10:43.100841 | TASK [validate-host : Collect information about the host] 2026-04-29 03:10:44.342371 | debian-bookworm | ok 2026-04-29 03:10:44.360772 | 2026-04-29 03:10:44.360883 | TASK [validate-host : Sanitize hostname] 2026-04-29 03:10:44.522440 | debian-bookworm | ok 2026-04-29 03:10:44.594025 | 2026-04-29 03:10:44.594126 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-04-29 03:10:45.757935 | debian-bookworm -> localhost | changed 2026-04-29 03:10:45.763458 | 2026-04-29 03:10:45.763554 | TASK [validate-host : Collect information about zuul worker] 2026-04-29 03:10:46.235754 | debian-bookworm | ok 2026-04-29 03:10:46.240341 | 2026-04-29 03:10:46.240438 | TASK [validate-host : Write out all zuul information for each host] 2026-04-29 03:10:46.979150 | debian-bookworm -> localhost | changed 2026-04-29 03:10:46.988278 | 2026-04-29 03:10:46.988387 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-04-29 03:10:47.305787 | debian-bookworm | ok 2026-04-29 03:10:47.311084 | 2026-04-29 03:10:47.311198 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-04-29 03:10:48.295883 | debian-bookworm | changed: 2026-04-29 03:10:48.296151 | debian-bookworm | cd+++++++++ src/ 2026-04-29 03:10:48.296187 | debian-bookworm | cd+++++++++ src/github.com/ 2026-04-29 03:10:48.296210 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-04-29 03:10:48.296231 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-health-middleware/ 2026-04-29 03:10:48.296253 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/0012f2af109c4d24bafef85acd238c5e/work/logs" 2026-04-29 03:11:17.404123 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/0012f2af109c4d24bafef85acd238c5e/work/artifacts" 2026-04-29 03:11:17.632224 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/0012f2af109c4d24bafef85acd238c5e/work/docs" 2026-04-29 03:11:17.641889 | 2026-04-29 03:11:17.641990 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-04-29 03:11:18.359518 | debian-bookworm | changed: 2026-04-29 03:11:18.359801 | debian-bookworm | .d..t...... ./ 2026-04-29 03:11:18.359855 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-04-29 03:11:18.359902 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-04-29 03:11:18.359947 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-04-29 03:11:18.360005 | debian-bookworm | changed: All items complete 2026-04-29 03:11:18.360047 | 2026-04-29 03:11:18.952684 | debian-bookworm | changed: .d..t...... ./ 2026-04-29 03:11:19.502309 | debian-bookworm | changed: .d..t...... ./ 2026-04-29 03:11:19.520640 | 2026-04-29 03:11:19.520759 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-04-29 03:11:19.580454 | debian-bookworm | skipping: Conditional result was False 2026-04-29 03:11:19.588556 | debian-bookworm | skipping: Conditional result was False 2026-04-29 03:11:19.603127 | 2026-04-29 03:11:19.603212 | PLAY RECAP 2026-04-29 03:11:19.603261 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-04-29 03:11:19.603287 | 2026-04-29 03:11:19.706870 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-04-29 03:11:19.707594 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-04-29 03:11:20.407741 | 2026-04-29 03:11:20.407879 | PLAY [Base post] 2026-04-29 03:11:20.423905 | 2026-04-29 03:11:20.424037 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-04-29 03:11:20.987402 | debian-bookworm | changed 2026-04-29 03:11:20.998352 | 2026-04-29 03:11:20.998556 | PLAY RECAP 2026-04-29 03:11:20.998622 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-29 03:11:20.998708 | 2026-04-29 03:11:21.098528 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-04-29 03:11:21.099210 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-04-29 03:11:21.771147 | 2026-04-29 03:11:21.771320 | PLAY [Base post-logs] 2026-04-29 03:11:21.779365 | 2026-04-29 03:11:21.779464 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-04-29 03:11:22.172878 | localhost | changed 2026-04-29 03:11:22.187283 | 2026-04-29 03:11:22.187533 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-04-29 03:11:22.212359 | localhost | ok 2026-04-29 03:11:22.217331 | 2026-04-29 03:11:22.217422 | TASK [Set zuul-log-path fact] 2026-04-29 03:11:22.237171 | localhost | ok 2026-04-29 03:11:22.250822 | 2026-04-29 03:11:22.250941 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-29 03:11:22.276823 | localhost | ok 2026-04-29 03:11:22.281061 | 2026-04-29 03:11:22.281390 | TASK [upload-logs : Create log directories] 2026-04-29 03:11:22.857829 | localhost | changed 2026-04-29 03:11:22.860715 | 2026-04-29 03:11:22.860806 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-04-29 03:11:23.417214 | localhost -> localhost | ok: Runtime: 0:00:00.004382 2026-04-29 03:11:23.429034 | 2026-04-29 03:11:23.429145 | TASK [upload-logs : Upload logs to log server] 2026-04-29 03:11:24.146512 | localhost | Output suppressed because no_log was given 2026-04-29 03:11:24.148088 | 2026-04-29 03:11:24.148168 | LOOP [upload-logs : Compress console log and json output] 2026-04-29 03:11:24.232616 | localhost | skipping: Conditional result was False 2026-04-29 03:11:24.247337 | localhost | skipping: Conditional result was False 2026-04-29 03:11:24.254187 | 2026-04-29 03:11:24.254298 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-29 03:11:24.396725 | localhost | skipping: Conditional result was False 2026-04-29 03:11:24.397006 | 2026-04-29 03:11:24.401445 | localhost | skipping: Conditional result was False 2026-04-29 03:11:24.423695 | 2026-04-29 03:11:24.423807 | LOOP [upload-logs : Upload console log and json output]