2026-08-28 03:16:19.531287 | Job console starting 2026-08-28 03:16:19.550411 | Updating git repos 2026-08-28 03:16:19.613067 | Cloning repos into workspace 2026-08-28 03:16:19.687522 | Restoring repo states 2026-08-28 03:16:19.709847 | Merging changes 2026-08-28 03:16:19.709928 | Checking out repos 2026-08-28 03:16:19.866518 | Preparing playbooks 2026-08-28 03:16:20.803882 | Running Ansible setup 2026-08-28 03:16:25.463502 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-08-28 03:16:26.441820 | 2026-08-28 03:16:26.442011 | PLAY [Base pre] 2026-08-28 03:16:26.461010 | 2026-08-28 03:16:26.461219 | TASK [Setup log path fact] 2026-08-28 03:16:26.493078 | debian-bookworm | ok 2026-08-28 03:16:26.513665 | 2026-08-28 03:16:26.513841 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-28 03:16:26.543472 | debian-bookworm | ok 2026-08-28 03:16:26.554196 | 2026-08-28 03:16:26.554344 | TASK [emit-job-header : Print job information] 2026-08-28 03:16:26.594355 | # Job Information 2026-08-28 03:16:26.594561 | Ansible Version: 2.16.14 2026-08-28 03:16:26.594597 | Job: python-black 2026-08-28 03:16:26.594630 | Pipeline: periodic-daily 2026-08-28 03:16:26.594653 | Executor: 521e9411259a 2026-08-28 03:16:26.594673 | Triggered by: https://github.com/osism/ansible-collection-services 2026-08-28 03:16:26.594695 | Event ID: c6fc58ba2a6b4ed8851508304ce0359b 2026-08-28 03:16:26.599961 | 2026-08-28 03:16:26.600081 | LOOP [emit-job-header : Print node information] 2026-08-28 03:16:26.710883 | debian-bookworm | ok: 2026-08-28 03:16:26.711158 | debian-bookworm | # Node Information 2026-08-28 03:16:26.711194 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-08-28 03:16:26.711219 | debian-bookworm | Hostname: debian 2026-08-28 03:16:26.711241 | debian-bookworm | Username: zuul 2026-08-28 03:16:26.711262 | debian-bookworm | Distro: Debian 12.15 2026-08-28 03:16:26.711287 | debian-bookworm | Provider: regiocloud-a 2026-08-28 03:16:26.711307 | debian-bookworm | Region: 2026-08-28 03:16:26.711328 | debian-bookworm | Label: debian-bookworm 2026-08-28 03:16:26.711348 | debian-bookworm | Product Name: OpenStack Nova 2026-08-28 03:16:26.711367 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe6f:c589 2026-08-28 03:16:26.728575 | 2026-08-28 03:16:26.728746 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-28 03:16:27.240674 | debian-bookworm -> localhost | changed 2026-08-28 03:16:27.257964 | 2026-08-28 03:16:27.258164 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-28 03:16:28.445414 | debian-bookworm -> localhost | changed 2026-08-28 03:16:28.470440 | 2026-08-28 03:16:28.470583 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-28 03:16:28.805006 | debian-bookworm -> localhost | ok 2026-08-28 03:16:28.825732 | 2026-08-28 03:16:28.826082 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-28 03:16:28.867068 | debian-bookworm | ok 2026-08-28 03:16:28.888710 | debian-bookworm | included: /var/lib/zuul/builds/1864b7cf14ad4dd0aaa1c9450990c912/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-28 03:16:28.896391 | 2026-08-28 03:16:28.896518 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-28 03:16:30.200465 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-08-28 03:16:30.200966 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/1864b7cf14ad4dd0aaa1c9450990c912/work/1864b7cf14ad4dd0aaa1c9450990c912_id_rsa 2026-08-28 03:16:30.201033 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/1864b7cf14ad4dd0aaa1c9450990c912/work/1864b7cf14ad4dd0aaa1c9450990c912_id_rsa.pub 2026-08-28 03:16:30.201063 | debian-bookworm -> localhost | The key fingerprint is: 2026-08-28 03:16:30.201089 | debian-bookworm -> localhost | SHA256:nMHQ8bFzAqcMtJSRn6/OwKwm6f0A5BWeXAyAARW21OY zuul-build-sshkey 2026-08-28 03:16:30.201132 | debian-bookworm -> localhost | The key's randomart image is: 2026-08-28 03:16:30.201176 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-08-28 03:16:30.201207 | debian-bookworm -> localhost | |++*+o+B=o.o | 2026-08-28 03:16:30.201231 | debian-bookworm -> localhost | |.o +o=+*.= o | 2026-08-28 03:16:30.201252 | debian-bookworm -> localhost | | oo= ..=.= . | 2026-08-28 03:16:30.201271 | debian-bookworm -> localhost | | o .E .oo + | 2026-08-28 03:16:30.201290 | debian-bookworm -> localhost | | o S. | 2026-08-28 03:16:30.201421 | debian-bookworm -> localhost | | . o . | 2026-08-28 03:16:30.201447 | debian-bookworm -> localhost | | .. + . | 2026-08-28 03:16:30.201467 | debian-bookworm -> localhost | | o..o o. | 2026-08-28 03:16:30.201489 | debian-bookworm -> localhost | | ..oo...o | 2026-08-28 03:16:30.201510 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-08-28 03:16:30.201574 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.614377 2026-08-28 03:16:30.208654 | 2026-08-28 03:16:30.208758 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-28 03:16:30.238958 | debian-bookworm | ok 2026-08-28 03:16:30.250204 | debian-bookworm | included: /var/lib/zuul/builds/1864b7cf14ad4dd0aaa1c9450990c912/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-28 03:16:30.258798 | 2026-08-28 03:16:30.258931 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-28 03:16:30.284745 | debian-bookworm | skipping: Conditional result was False 2026-08-28 03:16:30.292357 | 2026-08-28 03:16:30.292472 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-28 03:16:31.017715 | debian-bookworm | changed 2026-08-28 03:16:31.032282 | 2026-08-28 03:16:31.033084 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-28 03:16:31.319181 | debian-bookworm | ok 2026-08-28 03:16:31.327808 | 2026-08-28 03:16:31.327987 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-28 03:16:32.027841 | debian-bookworm | changed 2026-08-28 03:16:32.035620 | 2026-08-28 03:16:32.035754 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-28 03:16:32.731181 | debian-bookworm | changed 2026-08-28 03:16:32.737917 | 2026-08-28 03:16:32.738062 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-28 03:16:32.762960 | debian-bookworm | skipping: Conditional result was False 2026-08-28 03:16:32.770475 | 2026-08-28 03:16:32.770604 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-28 03:16:33.264414 | debian-bookworm -> localhost | changed 2026-08-28 03:16:33.278775 | 2026-08-28 03:16:33.278983 | TASK [add-build-sshkey : Add back temp key] 2026-08-28 03:16:33.833899 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/1864b7cf14ad4dd0aaa1c9450990c912/work/1864b7cf14ad4dd0aaa1c9450990c912_id_rsa (zuul-build-sshkey) 2026-08-28 03:16:33.834190 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.018914 2026-08-28 03:16:33.842714 | 2026-08-28 03:16:33.849171 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-28 03:16:34.431323 | debian-bookworm | ok 2026-08-28 03:16:34.443872 | 2026-08-28 03:16:34.444206 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-28 03:16:34.471229 | debian-bookworm | skipping: Conditional result was False 2026-08-28 03:16:34.491186 | 2026-08-28 03:16:34.491443 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-08-28 03:16:34.992605 | debian-bookworm | ok 2026-08-28 03:16:35.004594 | 2026-08-28 03:16:35.004733 | TASK [validate-host : Define zuul_info_dir fact] 2026-08-28 03:16:35.034506 | debian-bookworm | ok 2026-08-28 03:16:35.040011 | 2026-08-28 03:16:35.040144 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-08-28 03:16:35.470935 | debian-bookworm -> localhost | ok 2026-08-28 03:16:35.479465 | 2026-08-28 03:16:35.479603 | TASK [validate-host : Collect information about the host] 2026-08-28 03:16:37.000788 | debian-bookworm | ok 2026-08-28 03:16:37.017282 | 2026-08-28 03:16:37.017419 | TASK [validate-host : Sanitize hostname] 2026-08-28 03:16:37.222523 | debian-bookworm | ok 2026-08-28 03:16:37.227559 | 2026-08-28 03:16:37.227671 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-08-28 03:16:37.879813 | debian-bookworm -> localhost | changed 2026-08-28 03:16:37.888320 | 2026-08-28 03:16:37.888452 | TASK [validate-host : Collect information about zuul worker] 2026-08-28 03:16:38.329601 | debian-bookworm | ok 2026-08-28 03:16:38.334933 | 2026-08-28 03:16:38.335049 | TASK [validate-host : Write out all zuul information for each host] 2026-08-28 03:16:39.071353 | debian-bookworm -> localhost | changed 2026-08-28 03:16:39.085595 | 2026-08-28 03:16:39.086580 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-08-28 03:16:39.387539 | debian-bookworm | ok 2026-08-28 03:16:39.399739 | 2026-08-28 03:16:39.399864 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-08-28 03:16:40.771076 | debian-bookworm | changed: 2026-08-28 03:16:40.771329 | debian-bookworm | cd+++++++++ src/ 2026-08-28 03:16:40.771364 | debian-bookworm | cd+++++++++ src/github.com/ 2026-08-28 03:16:40.771389 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-08-28 03:16:40.771412 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2026-08-28 03:16:40.771432 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/1864b7cf14ad4dd0aaa1c9450990c912/work/logs" 2026-08-28 03:17:47.390544 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/1864b7cf14ad4dd0aaa1c9450990c912/work/artifacts" 2026-08-28 03:17:47.691040 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/1864b7cf14ad4dd0aaa1c9450990c912/work/docs" 2026-08-28 03:17:47.713797 | 2026-08-28 03:17:47.714016 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-28 03:17:48.598707 | debian-bookworm | changed: 2026-08-28 03:17:48.599023 | debian-bookworm | .d..t...... ./ 2026-08-28 03:17:48.599062 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-08-28 03:17:48.599087 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-08-28 03:17:48.599110 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-08-28 03:17:48.599131 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-08-28 03:17:48.599172 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-08-28 03:17:48.599220 | debian-bookworm | changed: All items complete 2026-08-28 03:17:48.599248 | 2026-08-28 03:17:49.239341 | debian-bookworm | changed: .d..t...... ./ 2026-08-28 03:17:49.908029 | debian-bookworm | changed: .d..t...... ./ 2026-08-28 03:17:49.935715 | 2026-08-28 03:17:49.935874 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-28 03:17:49.964841 | debian-bookworm | skipping: Conditional result was False 2026-08-28 03:17:49.969108 | debian-bookworm | skipping: Conditional result was False 2026-08-28 03:17:49.988230 | 2026-08-28 03:17:49.988366 | PLAY RECAP 2026-08-28 03:17:49.988431 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-08-28 03:17:49.988457 | 2026-08-28 03:17:50.182873 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-08-28 03:17:50.184374 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-28 03:17:51.800460 | 2026-08-28 03:17:51.800680 | PLAY [Base post] 2026-08-28 03:17:51.819276 | 2026-08-28 03:17:51.821110 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-28 03:17:52.599801 | debian-bookworm | changed 2026-08-28 03:17:52.613297 | 2026-08-28 03:17:52.613431 | PLAY RECAP 2026-08-28 03:17:52.613495 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-28 03:17:52.613559 | 2026-08-28 03:17:52.851576 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-28 03:17:52.852496 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-28 03:17:54.101753 | 2026-08-28 03:17:54.101945 | PLAY [Base post-logs] 2026-08-28 03:17:54.122630 | 2026-08-28 03:17:54.122862 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-28 03:17:54.619253 | localhost | changed 2026-08-28 03:17:54.635516 | 2026-08-28 03:17:54.635737 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-28 03:17:54.663712 | localhost | ok 2026-08-28 03:17:54.668368 | 2026-08-28 03:17:54.668518 | TASK [Set zuul-log-path fact] 2026-08-28 03:17:54.687324 | localhost | ok 2026-08-28 03:17:54.700209 | 2026-08-28 03:17:54.700360 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-28 03:17:54.744025 | localhost | ok 2026-08-28 03:17:54.749835 | 2026-08-28 03:17:54.749986 | TASK [upload-logs : Create log directories] 2026-08-28 03:17:55.354180 | localhost | changed 2026-08-28 03:17:55.357765 | 2026-08-28 03:17:55.357893 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-28 03:17:56.106373 | localhost -> localhost | ok: Runtime: 0:00:00.010263 2026-08-28 03:17:56.111288 | 2026-08-28 03:17:56.111418 | TASK [upload-logs : Upload logs to log server] 2026-08-28 03:17:56.899677 | localhost | Output suppressed because no_log was given 2026-08-28 03:17:56.901729 | 2026-08-28 03:17:56.901845 | LOOP [upload-logs : Compress console log and json output] 2026-08-28 03:17:56.969524 | localhost | skipping: Conditional result was False 2026-08-28 03:17:56.975632 | localhost | skipping: Conditional result was False 2026-08-28 03:17:56.985434 | 2026-08-28 03:17:56.985619 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-28 03:17:57.040371 | localhost | skipping: Conditional result was False 2026-08-28 03:17:57.040735 | 2026-08-28 03:17:57.045587 | localhost | skipping: Conditional result was False 2026-08-28 03:17:57.056340 | 2026-08-28 03:17:57.056458 | LOOP [upload-logs : Upload console log and json output]