2026-09-30 08:22:02.073916 | Job console starting 2026-09-30 08:22:02.093441 | Updating git repos 2026-09-30 08:22:02.150830 | Cloning repos into workspace 2026-09-30 08:22:02.231579 | Restoring repo states 2026-09-30 08:22:02.258018 | Merging changes 2026-09-30 08:22:03.111724 | Checking out repos 2026-09-30 08:22:03.191418 | Preparing playbooks 2026-09-30 08:22:04.453685 | Running Ansible setup 2026-09-30 08:22:10.261883 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-09-30 08:22:11.776786 | 2026-09-30 08:22:11.776965 | PLAY [Base pre] 2026-09-30 08:22:11.810184 | 2026-09-30 08:22:11.810346 | TASK [Setup log path fact] 2026-09-30 08:22:11.841617 | debian-bookworm | ok 2026-09-30 08:22:11.870411 | 2026-09-30 08:22:11.870590 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-30 08:22:11.937617 | debian-bookworm | ok 2026-09-30 08:22:11.947751 | 2026-09-30 08:22:11.947868 | TASK [emit-job-header : Print job information] 2026-09-30 08:22:12.008797 | # Job Information 2026-09-30 08:22:12.008959 | Ansible Version: 2.16.14 2026-09-30 08:22:12.008992 | Job: python-black 2026-09-30 08:22:12.009024 | Pipeline: check 2026-09-30 08:22:12.009046 | Executor: 521e9411259a 2026-09-30 08:22:12.009066 | Triggered by: https://github.com/osism/ansible-collection-services/pull/2173 2026-09-30 08:22:12.009088 | Event ID: fc64f0b0-bca7-11f1-9ed8-fedce3852951 2026-09-30 08:22:12.019862 | 2026-09-30 08:22:12.019967 | LOOP [emit-job-header : Print node information] 2026-09-30 08:22:12.211651 | debian-bookworm | ok: 2026-09-30 08:22:12.211813 | debian-bookworm | # Node Information 2026-09-30 08:22:12.211846 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-09-30 08:22:12.211871 | debian-bookworm | Hostname: debian 2026-09-30 08:22:12.211892 | debian-bookworm | Username: zuul 2026-09-30 08:22:12.211913 | debian-bookworm | Distro: Debian 12.15 2026-09-30 08:22:12.211936 | debian-bookworm | Provider: regiocloud-a 2026-09-30 08:22:12.211957 | debian-bookworm | Region: 2026-09-30 08:22:12.211978 | debian-bookworm | Label: debian-bookworm 2026-09-30 08:22:12.211997 | debian-bookworm | Product Name: OpenStack Nova 2026-09-30 08:22:12.212017 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fee6:f1c6 2026-09-30 08:22:12.225517 | 2026-09-30 08:22:12.225654 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-30 08:22:12.964808 | debian-bookworm -> localhost | changed 2026-09-30 08:22:12.970449 | 2026-09-30 08:22:12.970538 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-30 08:22:14.517491 | debian-bookworm -> localhost | changed 2026-09-30 08:22:14.529564 | 2026-09-30 08:22:14.529688 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-30 08:22:14.860034 | debian-bookworm -> localhost | ok 2026-09-30 08:22:14.865214 | 2026-09-30 08:22:14.865303 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-30 08:22:14.903475 | debian-bookworm | ok 2026-09-30 08:22:14.925526 | debian-bookworm | included: /var/lib/zuul/builds/d59f444af5e04ab0b3a030f739f6ac17/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-30 08:22:14.938624 | 2026-09-30 08:22:14.938717 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-30 08:22:16.841948 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-09-30 08:22:16.842114 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/d59f444af5e04ab0b3a030f739f6ac17/work/d59f444af5e04ab0b3a030f739f6ac17_id_rsa 2026-09-30 08:22:16.842167 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/d59f444af5e04ab0b3a030f739f6ac17/work/d59f444af5e04ab0b3a030f739f6ac17_id_rsa.pub 2026-09-30 08:22:16.842189 | debian-bookworm -> localhost | The key fingerprint is: 2026-09-30 08:22:16.842210 | debian-bookworm -> localhost | SHA256:gpgoyHX6wWtxDlNCSpOzj9FiT3jYWERq4T8B/EKZkuA zuul-build-sshkey 2026-09-30 08:22:16.842229 | debian-bookworm -> localhost | The key's randomart image is: 2026-09-30 08:22:16.842255 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-09-30 08:22:16.842273 | debian-bookworm -> localhost | |o o=*+ | 2026-09-30 08:22:16.842291 | debian-bookworm -> localhost | |.ooBB. | 2026-09-30 08:22:16.842308 | debian-bookworm -> localhost | | Eo*@+ . | 2026-09-30 08:22:16.842325 | debian-bookworm -> localhost | |o.o%=B+ | 2026-09-30 08:22:16.842341 | debian-bookworm -> localhost | |+.+.@O..S | 2026-09-30 08:22:16.842363 | debian-bookworm -> localhost | |. ..oX. | 2026-09-30 08:22:16.842382 | debian-bookworm -> localhost | | + . | 2026-09-30 08:22:16.842399 | debian-bookworm -> localhost | | . | 2026-09-30 08:22:16.842417 | debian-bookworm -> localhost | | | 2026-09-30 08:22:16.842433 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-09-30 08:22:16.842489 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.342575 2026-09-30 08:22:16.847752 | 2026-09-30 08:22:16.847835 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-30 08:22:16.865910 | debian-bookworm | ok 2026-09-30 08:22:16.879416 | debian-bookworm | included: /var/lib/zuul/builds/d59f444af5e04ab0b3a030f739f6ac17/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-30 08:22:16.886095 | 2026-09-30 08:22:16.886186 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-30 08:22:16.908945 | debian-bookworm | skipping: Conditional result was False 2026-09-30 08:22:16.913886 | 2026-09-30 08:22:16.913964 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-30 08:22:17.562489 | debian-bookworm | changed 2026-09-30 08:22:17.567622 | 2026-09-30 08:22:17.567704 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-30 08:22:17.854053 | debian-bookworm | ok 2026-09-30 08:22:17.868036 | 2026-09-30 08:22:17.868171 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-30 08:22:18.585311 | debian-bookworm | changed 2026-09-30 08:22:18.591462 | 2026-09-30 08:22:18.591557 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-30 08:22:19.301246 | debian-bookworm | changed 2026-09-30 08:22:19.305923 | 2026-09-30 08:22:19.306002 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-30 08:22:19.371872 | debian-bookworm | skipping: Conditional result was False 2026-09-30 08:22:19.376822 | 2026-09-30 08:22:19.376910 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-30 08:22:20.654356 | debian-bookworm -> localhost | changed 2026-09-30 08:22:20.665078 | 2026-09-30 08:22:20.665187 | TASK [add-build-sshkey : Add back temp key] 2026-09-30 08:22:21.265112 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/d59f444af5e04ab0b3a030f739f6ac17/work/d59f444af5e04ab0b3a030f739f6ac17_id_rsa (zuul-build-sshkey) 2026-09-30 08:22:21.265359 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.022950 2026-09-30 08:22:21.276066 | 2026-09-30 08:22:21.276164 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-30 08:22:21.663215 | debian-bookworm | ok 2026-09-30 08:22:21.668114 | 2026-09-30 08:22:21.668223 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-30 08:22:21.691211 | debian-bookworm | skipping: Conditional result was False 2026-09-30 08:22:21.700850 | 2026-09-30 08:22:21.700935 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-09-30 08:22:22.092731 | debian-bookworm | ok 2026-09-30 08:22:22.119440 | 2026-09-30 08:22:22.119548 | TASK [validate-host : Define zuul_info_dir fact] 2026-09-30 08:22:22.170355 | debian-bookworm | ok 2026-09-30 08:22:22.175196 | 2026-09-30 08:22:22.175286 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-09-30 08:22:23.021667 | debian-bookworm -> localhost | ok 2026-09-30 08:22:23.028430 | 2026-09-30 08:22:23.028533 | TASK [validate-host : Collect information about the host] 2026-09-30 08:22:24.498481 | debian-bookworm | ok 2026-09-30 08:22:24.521005 | 2026-09-30 08:22:24.521119 | TASK [validate-host : Sanitize hostname] 2026-09-30 08:22:24.748217 | debian-bookworm | ok 2026-09-30 08:22:24.763912 | 2026-09-30 08:22:24.764016 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-09-30 08:22:26.264323 | debian-bookworm -> localhost | changed 2026-09-30 08:22:26.270049 | 2026-09-30 08:22:26.270154 | TASK [validate-host : Collect information about zuul worker] 2026-09-30 08:22:27.040804 | debian-bookworm | ok 2026-09-30 08:22:27.044607 | 2026-09-30 08:22:27.044681 | TASK [validate-host : Write out all zuul information for each host] 2026-09-30 08:22:28.078841 | debian-bookworm -> localhost | changed 2026-09-30 08:22:28.086420 | 2026-09-30 08:22:28.086503 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-09-30 08:22:28.426420 | debian-bookworm | ok 2026-09-30 08:22:28.431456 | 2026-09-30 08:22:28.431538 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-09-30 08:22:29.988713 | debian-bookworm | changed: 2026-09-30 08:22:29.988857 | debian-bookworm | cd+++++++++ src/ 2026-09-30 08:22:29.988885 | debian-bookworm | cd+++++++++ src/github.com/ 2026-09-30 08:22:29.988905 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-09-30 08:22:29.988922 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2026-09-30 08:22:29.988939 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/d59f444af5e04ab0b3a030f739f6ac17/work/logs" 2026-09-30 08:23:34.566276 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/d59f444af5e04ab0b3a030f739f6ac17/work/artifacts" 2026-09-30 08:23:35.223382 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/d59f444af5e04ab0b3a030f739f6ac17/work/docs" 2026-09-30 08:23:35.235640 | 2026-09-30 08:23:35.235727 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-30 08:23:35.967389 | debian-bookworm | changed: 2026-09-30 08:23:35.967554 | debian-bookworm | .d..t...... ./ 2026-09-30 08:23:35.967583 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-09-30 08:23:35.967604 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-09-30 08:23:35.967622 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-09-30 08:23:35.967639 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-09-30 08:23:35.967655 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-09-30 08:23:35.967682 | debian-bookworm | changed: All items complete 2026-09-30 08:23:35.967701 | 2026-09-30 08:23:36.441265 | debian-bookworm | changed: .d..t...... ./ 2026-09-30 08:23:36.989399 | debian-bookworm | changed: .d..t...... ./ 2026-09-30 08:23:37.011908 | 2026-09-30 08:23:37.012013 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-30 08:23:37.400522 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.042095 2026-09-30 08:23:37.704660 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.026123 2026-09-30 08:23:37.715216 | 2026-09-30 08:23:37.715297 | PLAY RECAP 2026-09-30 08:23:37.715349 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-09-30 08:23:37.715374 | 2026-09-30 08:23:37.835937 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-30 08:23:37.836709 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-30 08:23:38.834236 | 2026-09-30 08:23:38.834371 | PLAY [Base post] 2026-09-30 08:23:38.845824 | 2026-09-30 08:23:38.845991 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-30 08:23:39.582070 | debian-bookworm | changed 2026-09-30 08:23:39.586860 | 2026-09-30 08:23:39.586929 | PLAY RECAP 2026-09-30 08:23:39.586975 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-30 08:23:39.587024 | 2026-09-30 08:23:39.667282 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-30 08:23:39.668008 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-30 08:23:40.819900 | 2026-09-30 08:23:40.820030 | PLAY [Base post-logs] 2026-09-30 08:23:40.851149 | 2026-09-30 08:23:40.851306 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-30 08:23:41.635356 | localhost | changed 2026-09-30 08:23:41.650541 | 2026-09-30 08:23:41.650672 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-30 08:23:41.708377 | localhost | ok 2026-09-30 08:23:41.711993 | 2026-09-30 08:23:41.712085 | TASK [Set zuul-log-path fact] 2026-09-30 08:23:41.746896 | localhost | ok 2026-09-30 08:23:41.756064 | 2026-09-30 08:23:41.756167 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-30 08:23:41.794467 | localhost | ok 2026-09-30 08:23:41.797889 | 2026-09-30 08:23:41.797984 | TASK [upload-logs : Create log directories] 2026-09-30 08:23:42.602719 | localhost | changed 2026-09-30 08:23:42.604839 | 2026-09-30 08:23:42.604916 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-30 08:23:43.012405 | localhost -> localhost | ok: Runtime: 0:00:00.002956 2026-09-30 08:23:43.015517 | 2026-09-30 08:23:43.015596 | TASK [upload-logs : Upload logs to log server] 2026-09-30 08:23:43.537525 | localhost | Output suppressed because no_log was given 2026-09-30 08:23:43.538998 | 2026-09-30 08:23:43.539070 | LOOP [upload-logs : Compress console log and json output] 2026-09-30 08:23:43.582716 | localhost | skipping: Conditional result was False 2026-09-30 08:23:43.596808 | localhost | skipping: Conditional result was False 2026-09-30 08:23:43.610113 | 2026-09-30 08:23:43.610207 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-30 08:23:43.705784 | localhost | skipping: Conditional result was False 2026-09-30 08:23:43.705993 | 2026-09-30 08:23:43.712067 | localhost | skipping: Conditional result was False 2026-09-30 08:23:43.720537 | 2026-09-30 08:23:43.720626 | LOOP [upload-logs : Upload console log and json output]