2026-10-01 03:01:38.762858 | Job console starting 2026-10-01 03:01:38.773345 | Updating git repos 2026-10-01 03:01:38.826177 | Cloning repos into workspace 2026-10-01 03:01:38.925497 | Restoring repo states 2026-10-01 03:01:38.944083 | Merging changes 2026-10-01 03:01:38.944104 | Checking out repos 2026-10-01 03:01:39.004879 | Preparing playbooks 2026-10-01 03:01:40.373500 | Running Ansible setup 2026-10-01 03:01:47.786816 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-10-01 03:01:49.495539 | 2026-10-01 03:01:49.495657 | PLAY [Base pre] 2026-10-01 03:01:49.568296 | 2026-10-01 03:01:49.568420 | TASK [Setup log path fact] 2026-10-01 03:01:49.608727 | debian-bookworm | ok 2026-10-01 03:01:49.629540 | 2026-10-01 03:01:49.643370 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-10-01 03:01:49.691185 | debian-bookworm | ok 2026-10-01 03:01:49.706834 | 2026-10-01 03:01:49.706926 | TASK [emit-job-header : Print job information] 2026-10-01 03:01:49.786229 | # Job Information 2026-10-01 03:01:49.786358 | Ansible Version: 2.16.14 2026-10-01 03:01:49.786387 | Job: python-black 2026-10-01 03:01:49.786413 | Pipeline: periodic-daily 2026-10-01 03:01:49.786431 | Executor: 521e9411259a 2026-10-01 03:01:49.786448 | Triggered by: https://github.com/osism/ansible-collection-validations 2026-10-01 03:01:49.786466 | Event ID: b13f67d0d0c042e5989fb8533544afa7 2026-10-01 03:01:49.790367 | 2026-10-01 03:01:49.790445 | LOOP [emit-job-header : Print node information] 2026-10-01 03:01:50.038042 | debian-bookworm | ok: 2026-10-01 03:01:50.043760 | debian-bookworm | # Node Information 2026-10-01 03:01:50.043834 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-10-01 03:01:50.043866 | debian-bookworm | Hostname: debian 2026-10-01 03:01:50.043890 | debian-bookworm | Username: zuul 2026-10-01 03:01:50.043912 | debian-bookworm | Distro: Debian 12.15 2026-10-01 03:01:50.043944 | debian-bookworm | Provider: regiocloud-a 2026-10-01 03:01:50.043970 | debian-bookworm | Region: 2026-10-01 03:01:50.044017 | debian-bookworm | Label: debian-bookworm 2026-10-01 03:01:50.044042 | debian-bookworm | Product Name: OpenStack Nova 2026-10-01 03:01:50.044063 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feff:a9ca 2026-10-01 03:01:50.056092 | 2026-10-01 03:01:50.056184 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-10-01 03:01:51.308216 | debian-bookworm -> localhost | changed 2026-10-01 03:01:51.314550 | 2026-10-01 03:01:51.314635 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-10-01 03:01:53.299477 | debian-bookworm -> localhost | changed 2026-10-01 03:01:53.314743 | 2026-10-01 03:01:53.314837 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-10-01 03:01:53.814641 | debian-bookworm -> localhost | ok 2026-10-01 03:01:53.820399 | 2026-10-01 03:01:53.820488 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-10-01 03:01:53.849525 | debian-bookworm | ok 2026-10-01 03:01:53.867988 | debian-bookworm | included: /var/lib/zuul/builds/f25086fbc4264d14bfd9c503af605c9d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-10-01 03:01:53.873914 | 2026-10-01 03:01:53.874016 | TASK [add-build-sshkey : Create Temp SSH key] 2026-10-01 03:01:56.797600 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-10-01 03:01:56.797761 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/f25086fbc4264d14bfd9c503af605c9d/work/f25086fbc4264d14bfd9c503af605c9d_id_rsa 2026-10-01 03:01:56.797792 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/f25086fbc4264d14bfd9c503af605c9d/work/f25086fbc4264d14bfd9c503af605c9d_id_rsa.pub 2026-10-01 03:01:56.797813 | debian-bookworm -> localhost | The key fingerprint is: 2026-10-01 03:01:56.797832 | debian-bookworm -> localhost | SHA256:oZpE+XCttPirFMhyJMET9BEMxaI/DdSjDRGMDDaSyYM zuul-build-sshkey 2026-10-01 03:01:56.797850 | debian-bookworm -> localhost | The key's randomart image is: 2026-10-01 03:01:56.797874 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-10-01 03:01:56.797892 | debian-bookworm -> localhost | |@@OB. | 2026-10-01 03:01:56.797910 | debian-bookworm -> localhost | |EO*o+. . | 2026-10-01 03:01:56.797927 | debian-bookworm -> localhost | |o.==+.o o | 2026-10-01 03:01:56.797942 | debian-bookworm -> localhost | |.+oo.* + . | 2026-10-01 03:01:56.797958 | debian-bookworm -> localhost | |..+o+ = S | 2026-10-01 03:01:56.797978 | debian-bookworm -> localhost | | oo..= | 2026-10-01 03:01:56.798020 | debian-bookworm -> localhost | | .+ . | 2026-10-01 03:01:56.798039 | debian-bookworm -> localhost | | . . | 2026-10-01 03:01:56.798056 | debian-bookworm -> localhost | | ... | 2026-10-01 03:01:56.798072 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-10-01 03:01:56.798113 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.950705 2026-10-01 03:01:56.806402 | 2026-10-01 03:01:56.806485 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-10-01 03:01:56.865086 | debian-bookworm | ok 2026-10-01 03:01:56.896675 | debian-bookworm | included: /var/lib/zuul/builds/f25086fbc4264d14bfd9c503af605c9d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-10-01 03:01:56.919939 | 2026-10-01 03:01:56.920110 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-10-01 03:01:56.945536 | debian-bookworm | skipping: Conditional result was False 2026-10-01 03:01:56.950348 | 2026-10-01 03:01:56.950427 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-10-01 03:01:57.771907 | debian-bookworm | changed 2026-10-01 03:01:57.780412 | 2026-10-01 03:01:57.780494 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-10-01 03:01:58.071229 | debian-bookworm | ok 2026-10-01 03:01:58.077383 | 2026-10-01 03:01:58.077466 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-10-01 03:01:58.873509 | debian-bookworm | changed 2026-10-01 03:01:58.882422 | 2026-10-01 03:01:58.882516 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-10-01 03:01:59.764200 | debian-bookworm | changed 2026-10-01 03:01:59.772472 | 2026-10-01 03:01:59.772555 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-10-01 03:01:59.828424 | debian-bookworm | skipping: Conditional result was False 2026-10-01 03:01:59.850839 | 2026-10-01 03:01:59.852997 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-10-01 03:02:01.214548 | debian-bookworm -> localhost | changed 2026-10-01 03:02:01.223798 | 2026-10-01 03:02:01.225270 | TASK [add-build-sshkey : Add back temp key] 2026-10-01 03:02:01.936812 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/f25086fbc4264d14bfd9c503af605c9d/work/f25086fbc4264d14bfd9c503af605c9d_id_rsa (zuul-build-sshkey) 2026-10-01 03:02:01.937151 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.025115 2026-10-01 03:02:01.944615 | 2026-10-01 03:02:01.944693 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-10-01 03:02:02.602008 | debian-bookworm | ok 2026-10-01 03:02:02.606718 | 2026-10-01 03:02:02.606796 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-10-01 03:02:02.653901 | debian-bookworm | skipping: Conditional result was False 2026-10-01 03:02:02.662824 | 2026-10-01 03:02:02.662911 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-10-01 03:02:03.126894 | debian-bookworm | ok 2026-10-01 03:02:03.143525 | 2026-10-01 03:02:03.143609 | TASK [validate-host : Define zuul_info_dir fact] 2026-10-01 03:02:03.169912 | debian-bookworm | ok 2026-10-01 03:02:03.173931 | 2026-10-01 03:02:03.174010 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-10-01 03:02:03.453301 | debian-bookworm -> localhost | ok 2026-10-01 03:02:03.463205 | 2026-10-01 03:02:03.463285 | TASK [validate-host : Collect information about the host] 2026-10-01 03:02:04.555518 | debian-bookworm | ok 2026-10-01 03:02:04.569391 | 2026-10-01 03:02:04.569495 | TASK [validate-host : Sanitize hostname] 2026-10-01 03:02:04.742293 | debian-bookworm | ok 2026-10-01 03:02:04.757894 | 2026-10-01 03:02:04.757999 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-10-01 03:02:05.520106 | debian-bookworm -> localhost | changed 2026-10-01 03:02:05.524630 | 2026-10-01 03:02:05.524708 | TASK [validate-host : Collect information about zuul worker] 2026-10-01 03:02:05.961462 | debian-bookworm | ok 2026-10-01 03:02:05.970640 | 2026-10-01 03:02:05.970745 | TASK [validate-host : Write out all zuul information for each host] 2026-10-01 03:02:07.400694 | debian-bookworm -> localhost | changed 2026-10-01 03:02:07.409885 | 2026-10-01 03:02:07.409977 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-10-01 03:02:07.744872 | debian-bookworm | ok 2026-10-01 03:02:07.758247 | 2026-10-01 03:02:07.758336 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-10-01 03:02:08.888190 | debian-bookworm | changed: 2026-10-01 03:02:08.888334 | debian-bookworm | cd+++++++++ src/ 2026-10-01 03:02:08.888363 | debian-bookworm | cd+++++++++ src/github.com/ 2026-10-01 03:02:08.888384 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-10-01 03:02:08.888409 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-validations/ 2026-10-01 03:02:08.888425 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/f25086fbc4264d14bfd9c503af605c9d/work/logs" 2026-10-01 03:03:13.848351 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/f25086fbc4264d14bfd9c503af605c9d/work/artifacts" 2026-10-01 03:03:14.509294 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/f25086fbc4264d14bfd9c503af605c9d/work/docs" 2026-10-01 03:03:14.527171 | 2026-10-01 03:03:14.527650 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-10-01 03:03:16.080075 | debian-bookworm | changed: 2026-10-01 03:03:16.080334 | debian-bookworm | .d..t...... ./ 2026-10-01 03:03:16.080377 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-10-01 03:03:16.080401 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-10-01 03:03:16.080423 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-10-01 03:03:16.080445 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-10-01 03:03:16.080464 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-10-01 03:03:16.080540 | debian-bookworm | changed: All items complete 2026-10-01 03:03:16.080572 | 2026-10-01 03:03:16.615611 | debian-bookworm | changed: .d..t...... ./ 2026-10-01 03:03:17.393512 | debian-bookworm | changed: .d..t...... ./ 2026-10-01 03:03:17.411699 | 2026-10-01 03:03:17.411808 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-10-01 03:03:17.463813 | debian-bookworm | skipping: Conditional result was False 2026-10-01 03:03:17.479525 | debian-bookworm | skipping: Conditional result was False 2026-10-01 03:03:17.489364 | 2026-10-01 03:03:17.489441 | PLAY RECAP 2026-10-01 03:03:17.489489 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-10-01 03:03:17.489578 | 2026-10-01 03:03:17.595392 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-10-01 03:03:17.596170 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-10-01 03:03:18.803140 | 2026-10-01 03:03:18.803727 | PLAY [Base post] 2026-10-01 03:03:18.841064 | 2026-10-01 03:03:18.841230 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-10-01 03:03:19.627540 | debian-bookworm | changed 2026-10-01 03:03:19.633352 | 2026-10-01 03:03:19.633445 | PLAY RECAP 2026-10-01 03:03:19.633504 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-10-01 03:03:19.633581 | 2026-10-01 03:03:19.723030 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-10-01 03:03:19.723628 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-10-01 03:03:21.126089 | 2026-10-01 03:03:21.126747 | PLAY [Base post-logs] 2026-10-01 03:03:21.156864 | 2026-10-01 03:03:21.157799 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-10-01 03:03:21.877472 | localhost | changed 2026-10-01 03:03:21.885888 | 2026-10-01 03:03:21.886037 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-10-01 03:03:21.912514 | localhost | ok 2026-10-01 03:03:21.914913 | 2026-10-01 03:03:21.915001 | TASK [Set zuul-log-path fact] 2026-10-01 03:03:21.934694 | localhost | ok 2026-10-01 03:03:21.951034 | 2026-10-01 03:03:21.951132 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-10-01 03:03:21.975391 | localhost | ok 2026-10-01 03:03:21.977789 | 2026-10-01 03:03:21.977862 | TASK [upload-logs : Create log directories] 2026-10-01 03:03:22.826720 | localhost | changed 2026-10-01 03:03:22.830411 | 2026-10-01 03:03:22.830498 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-10-01 03:03:23.552538 | localhost -> localhost | ok: Runtime: 0:00:00.004792 2026-10-01 03:03:23.555537 | 2026-10-01 03:03:23.555629 | TASK [upload-logs : Upload logs to log server] 2026-10-01 03:03:24.215975 | localhost | Output suppressed because no_log was given 2026-10-01 03:03:24.217820 | 2026-10-01 03:03:24.217905 | LOOP [upload-logs : Compress console log and json output] 2026-10-01 03:03:24.256576 | localhost | skipping: Conditional result was False 2026-10-01 03:03:24.261906 | localhost | skipping: Conditional result was False 2026-10-01 03:03:24.275147 | 2026-10-01 03:03:24.275304 | LOOP [upload-logs : Upload compressed console log and json output] 2026-10-01 03:03:24.310089 | localhost | skipping: Conditional result was False 2026-10-01 03:03:24.310360 | 2026-10-01 03:03:24.313978 | localhost | skipping: Conditional result was False 2026-10-01 03:03:24.323370 | 2026-10-01 03:03:24.323478 | LOOP [upload-logs : Upload console log and json output]