2026-06-09 03:05:43.245836 | Job console starting 2026-06-09 03:05:43.255112 | Updating git repos 2026-06-09 03:05:43.284790 | Cloning repos into workspace 2026-06-09 03:05:43.333134 | Restoring repo states 2026-06-09 03:05:43.350148 | Merging changes 2026-06-09 03:05:43.350163 | Checking out repos 2026-06-09 03:05:43.430118 | Preparing playbooks 2026-06-09 03:05:45.447935 | Running Ansible setup 2026-06-09 03:05:50.376418 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-06-09 03:05:51.493093 | 2026-06-09 03:05:51.493234 | PLAY [Base pre] 2026-06-09 03:05:51.510175 | 2026-06-09 03:05:51.510322 | TASK [Setup log path fact] 2026-06-09 03:05:51.538396 | debian-bookworm | ok 2026-06-09 03:05:51.559690 | 2026-06-09 03:05:51.559819 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-09 03:05:51.587647 | debian-bookworm | ok 2026-06-09 03:05:51.597590 | 2026-06-09 03:05:51.597691 | TASK [emit-job-header : Print job information] 2026-06-09 03:05:51.639776 | # Job Information 2026-06-09 03:05:51.640086 | Ansible Version: 2.16.14 2026-06-09 03:05:51.640123 | Job: python-black 2026-06-09 03:05:51.640157 | Pipeline: periodic-daily 2026-06-09 03:05:51.640181 | Executor: 521e9411259a 2026-06-09 03:05:51.640202 | Triggered by: https://github.com/osism/openstack-health-middleware 2026-06-09 03:05:51.640237 | Event ID: 67c65f9b43ab44e697e105bfd62efc4d 2026-06-09 03:05:51.644997 | 2026-06-09 03:05:51.645085 | LOOP [emit-job-header : Print node information] 2026-06-09 03:05:51.752915 | debian-bookworm | ok: 2026-06-09 03:05:51.753152 | debian-bookworm | # Node Information 2026-06-09 03:05:51.753191 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-06-09 03:05:51.753226 | debian-bookworm | Hostname: debian 2026-06-09 03:05:51.753249 | debian-bookworm | Username: zuul 2026-06-09 03:05:51.753270 | debian-bookworm | Distro: Debian 12.14 2026-06-09 03:05:51.753299 | debian-bookworm | Provider: regiocloud-a 2026-06-09 03:05:51.753321 | debian-bookworm | Region: 2026-06-09 03:05:51.753343 | debian-bookworm | Label: debian-bookworm 2026-06-09 03:05:51.753363 | debian-bookworm | Product Name: OpenStack Nova 2026-06-09 03:05:51.753382 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe75:c7 2026-06-09 03:05:51.770883 | 2026-06-09 03:05:51.771015 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-09 03:05:52.414635 | debian-bookworm -> localhost | changed 2026-06-09 03:05:52.422605 | 2026-06-09 03:05:52.422707 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-09 03:05:53.673451 | debian-bookworm -> localhost | changed 2026-06-09 03:05:53.686308 | 2026-06-09 03:05:53.686461 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-09 03:05:54.180941 | debian-bookworm -> localhost | ok 2026-06-09 03:05:54.192389 | 2026-06-09 03:05:54.192653 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-09 03:05:54.229664 | debian-bookworm | ok 2026-06-09 03:05:54.255722 | debian-bookworm | included: /var/lib/zuul/builds/772ce9c036544bd785787fb7ae07fbde/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-09 03:05:54.282861 | 2026-06-09 03:05:54.290049 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-09 03:05:56.027667 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-06-09 03:05:56.028077 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/772ce9c036544bd785787fb7ae07fbde/work/772ce9c036544bd785787fb7ae07fbde_id_rsa 2026-06-09 03:05:56.028122 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/772ce9c036544bd785787fb7ae07fbde/work/772ce9c036544bd785787fb7ae07fbde_id_rsa.pub 2026-06-09 03:05:56.028149 | debian-bookworm -> localhost | The key fingerprint is: 2026-06-09 03:05:56.028174 | debian-bookworm -> localhost | SHA256:wQXy+Lgw0CaEwsnfsf3UDDT62+9ZkFo8c0U09LlWX7M zuul-build-sshkey 2026-06-09 03:05:56.028198 | debian-bookworm -> localhost | The key's randomart image is: 2026-06-09 03:05:56.028280 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-06-09 03:05:56.028304 | debian-bookworm -> localhost | |o.o . o+. .+o| 2026-06-09 03:05:56.028327 | debian-bookworm -> localhost | |o= . . =.o. .+| 2026-06-09 03:05:56.028348 | debian-bookworm -> localhost | |. + + =.+ + o=| 2026-06-09 03:05:56.028369 | debian-bookworm -> localhost | | = o +.o o. . O| 2026-06-09 03:05:56.028389 | debian-bookworm -> localhost | | o . S. B E.| 2026-06-09 03:05:56.028416 | debian-bookworm -> localhost | | o . .o o * | 2026-06-09 03:05:56.028437 | debian-bookworm -> localhost | | . . o . | 2026-06-09 03:05:56.028457 | debian-bookworm -> localhost | | . o | 2026-06-09 03:05:56.028478 | debian-bookworm -> localhost | | .+ | 2026-06-09 03:05:56.028499 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-06-09 03:05:56.028570 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.034352 2026-06-09 03:05:56.038949 | 2026-06-09 03:05:56.039146 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-09 03:05:56.076846 | debian-bookworm | ok 2026-06-09 03:05:56.102806 | debian-bookworm | included: /var/lib/zuul/builds/772ce9c036544bd785787fb7ae07fbde/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-09 03:05:56.119677 | 2026-06-09 03:05:56.119872 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-09 03:05:56.145570 | debian-bookworm | skipping: Conditional result was False 2026-06-09 03:05:56.153738 | 2026-06-09 03:05:56.153914 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-09 03:05:56.912654 | debian-bookworm | changed 2026-06-09 03:05:56.927136 | 2026-06-09 03:05:56.927413 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-09 03:05:57.223130 | debian-bookworm | ok 2026-06-09 03:05:57.230132 | 2026-06-09 03:05:57.230294 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-09 03:05:57.995480 | debian-bookworm | changed 2026-06-09 03:05:58.009218 | 2026-06-09 03:05:58.009354 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-09 03:05:58.709265 | debian-bookworm | changed 2026-06-09 03:05:58.721503 | 2026-06-09 03:05:58.721678 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-09 03:05:58.768952 | debian-bookworm | skipping: Conditional result was False 2026-06-09 03:05:58.795775 | 2026-06-09 03:05:58.795962 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-09 03:06:00.437037 | debian-bookworm -> localhost | changed 2026-06-09 03:06:00.464158 | 2026-06-09 03:06:00.464314 | TASK [add-build-sshkey : Add back temp key] 2026-06-09 03:06:01.425901 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/772ce9c036544bd785787fb7ae07fbde/work/772ce9c036544bd785787fb7ae07fbde_id_rsa (zuul-build-sshkey) 2026-06-09 03:06:01.426257 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.030709 2026-06-09 03:06:01.439106 | 2026-06-09 03:06:01.439284 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-09 03:06:01.961905 | debian-bookworm | ok 2026-06-09 03:06:01.976473 | 2026-06-09 03:06:01.976642 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-09 03:06:02.014333 | debian-bookworm | skipping: Conditional result was False 2026-06-09 03:06:02.041853 | 2026-06-09 03:06:02.042636 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-06-09 03:06:02.712633 | debian-bookworm | ok 2026-06-09 03:06:02.772045 | 2026-06-09 03:06:02.773040 | TASK [validate-host : Define zuul_info_dir fact] 2026-06-09 03:06:02.821442 | debian-bookworm | ok 2026-06-09 03:06:02.839105 | 2026-06-09 03:06:02.839323 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-06-09 03:06:03.748967 | debian-bookworm -> localhost | ok 2026-06-09 03:06:03.759779 | 2026-06-09 03:06:03.759954 | TASK [validate-host : Collect information about the host] 2026-06-09 03:06:05.222250 | debian-bookworm | ok 2026-06-09 03:06:05.261561 | 2026-06-09 03:06:05.261707 | TASK [validate-host : Sanitize hostname] 2026-06-09 03:06:05.629358 | debian-bookworm | ok 2026-06-09 03:06:05.777630 | 2026-06-09 03:06:05.777964 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-06-09 03:06:08.177389 | debian-bookworm -> localhost | changed 2026-06-09 03:06:08.183757 | 2026-06-09 03:06:08.183868 | TASK [validate-host : Collect information about zuul worker] 2026-06-09 03:06:08.709627 | debian-bookworm | ok 2026-06-09 03:06:08.714399 | 2026-06-09 03:06:08.714497 | TASK [validate-host : Write out all zuul information for each host] 2026-06-09 03:06:09.604273 | debian-bookworm -> localhost | changed 2026-06-09 03:06:09.616889 | 2026-06-09 03:06:09.628025 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-06-09 03:06:09.941302 | debian-bookworm | ok 2026-06-09 03:06:09.947040 | 2026-06-09 03:06:09.947113 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-06-09 03:06:11.793886 | debian-bookworm | changed: 2026-06-09 03:06:11.794091 | debian-bookworm | cd+++++++++ src/ 2026-06-09 03:06:11.794126 | debian-bookworm | cd+++++++++ src/github.com/ 2026-06-09 03:06:11.794151 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-06-09 03:06:11.794172 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-health-middleware/ 2026-06-09 03:06:11.794225 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/772ce9c036544bd785787fb7ae07fbde/work/logs" 2026-06-09 03:06:49.133021 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/772ce9c036544bd785787fb7ae07fbde/work/artifacts" 2026-06-09 03:06:49.575452 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/772ce9c036544bd785787fb7ae07fbde/work/docs" 2026-06-09 03:06:49.587197 | 2026-06-09 03:06:49.587322 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-09 03:06:50.710128 | debian-bookworm | changed: 2026-06-09 03:06:50.710346 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-06-09 03:06:50.710383 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-06-09 03:06:50.710413 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-06-09 03:06:50.710459 | debian-bookworm | changed: All items complete 2026-06-09 03:06:50.710487 | 2026-06-09 03:06:51.342376 | debian-bookworm | changed: .d..t...... ./ 2026-06-09 03:06:51.964833 | debian-bookworm | changed: .d..t...... ./ 2026-06-09 03:06:51.985052 | 2026-06-09 03:06:51.985158 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-09 03:06:52.034903 | debian-bookworm | skipping: Conditional result was False 2026-06-09 03:06:52.044534 | debian-bookworm | skipping: Conditional result was False 2026-06-09 03:06:52.053725 | 2026-06-09 03:06:52.053785 | PLAY RECAP 2026-06-09 03:06:52.053825 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-06-09 03:06:52.053846 | 2026-06-09 03:06:52.136015 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-06-09 03:06:52.136770 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-09 03:06:52.731888 | 2026-06-09 03:06:52.732000 | PLAY [Base post] 2026-06-09 03:06:52.742374 | 2026-06-09 03:06:52.742474 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-09 03:06:53.282871 | debian-bookworm | changed 2026-06-09 03:06:53.294516 | 2026-06-09 03:06:53.294651 | PLAY RECAP 2026-06-09 03:06:53.294716 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-09 03:06:53.294779 | 2026-06-09 03:06:53.419656 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-09 03:06:53.420386 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-06-09 03:06:54.129282 | 2026-06-09 03:06:54.129399 | PLAY [Base post-logs] 2026-06-09 03:06:54.137415 | 2026-06-09 03:06:54.137546 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-09 03:06:54.631843 | localhost | changed 2026-06-09 03:06:54.651216 | 2026-06-09 03:06:54.651621 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-09 03:06:54.680767 | localhost | ok 2026-06-09 03:06:54.684393 | 2026-06-09 03:06:54.684485 | TASK [Set zuul-log-path fact] 2026-06-09 03:06:54.709422 | localhost | ok 2026-06-09 03:06:54.721183 | 2026-06-09 03:06:54.721316 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-09 03:06:54.776889 | localhost | ok 2026-06-09 03:06:54.779969 | 2026-06-09 03:06:54.780057 | TASK [upload-logs : Create log directories] 2026-06-09 03:06:55.353162 | localhost | changed 2026-06-09 03:06:55.355896 | 2026-06-09 03:06:55.355982 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-09 03:06:55.913312 | localhost -> localhost | ok: Runtime: 0:00:00.003625 2026-06-09 03:06:55.917974 | 2026-06-09 03:06:55.918074 | TASK [upload-logs : Upload logs to log server] 2026-06-09 03:06:56.489202 | localhost | Output suppressed because no_log was given 2026-06-09 03:06:56.490824 | 2026-06-09 03:06:56.490982 | LOOP [upload-logs : Compress console log and json output] 2026-06-09 03:06:56.554571 | localhost | skipping: Conditional result was False 2026-06-09 03:06:56.561049 | localhost | skipping: Conditional result was False 2026-06-09 03:06:56.568938 | 2026-06-09 03:06:56.569040 | LOOP [upload-logs : Upload compressed console log and json output] 2026-06-09 03:06:56.619745 | localhost | skipping: Conditional result was False 2026-06-09 03:06:56.620006 | 2026-06-09 03:06:56.626483 | localhost | skipping: Conditional result was False 2026-06-09 03:06:56.637335 | 2026-06-09 03:06:56.637436 | LOOP [upload-logs : Upload console log and json output]