2026-05-05 03:01:36.704747 | Job console starting 2026-05-05 03:01:36.737607 | Updating git repos 2026-05-05 03:01:36.878037 | Cloning repos into workspace 2026-05-05 03:01:36.975293 | Restoring repo states 2026-05-05 03:01:36.987638 | Merging changes 2026-05-05 03:01:36.987653 | Checking out repos 2026-05-05 03:01:37.131195 | Preparing playbooks 2026-05-05 03:01:38.332501 | Running Ansible setup 2026-05-05 03:01:44.719369 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-05 03:01:46.967349 | 2026-05-05 03:01:46.967471 | PLAY [Base pre] 2026-05-05 03:01:46.988511 | 2026-05-05 03:01:46.988626 | TASK [Setup log path fact] 2026-05-05 03:01:47.028629 | debian-bookworm | ok 2026-05-05 03:01:47.057959 | 2026-05-05 03:01:47.058087 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-05 03:01:47.111273 | debian-bookworm | ok 2026-05-05 03:01:47.128083 | 2026-05-05 03:01:47.128217 | TASK [emit-job-header : Print job information] 2026-05-05 03:01:47.257571 | # Job Information 2026-05-05 03:01:47.257723 | Ansible Version: 2.16.14 2026-05-05 03:01:47.257752 | Job: python-black 2026-05-05 03:01:47.257778 | Pipeline: periodic-daily 2026-05-05 03:01:47.257798 | Executor: 521e9411259a 2026-05-05 03:01:47.257815 | Triggered by: https://github.com/osism/ansible-collection-validations 2026-05-05 03:01:47.257833 | Event ID: 07cb4fa3ea0e47ec917729f92ae9976e 2026-05-05 03:01:47.289585 | 2026-05-05 03:01:47.289702 | LOOP [emit-job-header : Print node information] 2026-05-05 03:01:47.472092 | debian-bookworm | ok: 2026-05-05 03:01:47.472263 | debian-bookworm | # Node Information 2026-05-05 03:01:47.472291 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-05 03:01:47.472312 | debian-bookworm | Hostname: debian 2026-05-05 03:01:47.472331 | debian-bookworm | Username: zuul 2026-05-05 03:01:47.472348 | debian-bookworm | Distro: Debian 12.13 2026-05-05 03:01:47.472367 | debian-bookworm | Provider: regiocloud-a 2026-05-05 03:01:47.472385 | debian-bookworm | Region: 2026-05-05 03:01:47.472402 | debian-bookworm | Label: debian-bookworm 2026-05-05 03:01:47.472418 | debian-bookworm | Product Name: OpenStack Nova 2026-05-05 03:01:47.472434 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe70:3989 2026-05-05 03:01:47.486683 | 2026-05-05 03:01:47.486781 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-05 03:01:48.753027 | debian-bookworm -> localhost | changed 2026-05-05 03:01:48.759403 | 2026-05-05 03:01:48.759502 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-05 03:01:51.829823 | debian-bookworm -> localhost | changed 2026-05-05 03:01:51.844665 | 2026-05-05 03:01:51.844784 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-05 03:01:52.612994 | debian-bookworm -> localhost | ok 2026-05-05 03:01:52.619257 | 2026-05-05 03:01:52.619379 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-05 03:01:52.669362 | debian-bookworm | ok 2026-05-05 03:01:52.706352 | debian-bookworm | included: /var/lib/zuul/builds/c5b96f5dbde3483c85da055fad90a333/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-05 03:01:52.718353 | 2026-05-05 03:01:52.718461 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-05 03:01:54.696249 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-05 03:01:54.696427 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/c5b96f5dbde3483c85da055fad90a333/work/c5b96f5dbde3483c85da055fad90a333_id_rsa 2026-05-05 03:01:54.696456 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/c5b96f5dbde3483c85da055fad90a333/work/c5b96f5dbde3483c85da055fad90a333_id_rsa.pub 2026-05-05 03:01:54.696477 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-05 03:01:54.696497 | debian-bookworm -> localhost | SHA256:n+CR7KN2sk2bKeKkC4TDdTgNb/xjv0gH9OjPk+Va8Dw zuul-build-sshkey 2026-05-05 03:01:54.696515 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-05 03:01:54.696539 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-05 03:01:54.696558 | debian-bookworm -> localhost | | . | 2026-05-05 03:01:54.696576 | debian-bookworm -> localhost | | * | 2026-05-05 03:01:54.696593 | debian-bookworm -> localhost | | + * . | 2026-05-05 03:01:54.696609 | debian-bookworm -> localhost | |o . + o.o. | 2026-05-05 03:01:54.696625 | debian-bookworm -> localhost | |oo *So | 2026-05-05 03:01:54.696642 | debian-bookworm -> localhost | |.. oo+++o | 2026-05-05 03:01:54.696659 | debian-bookworm -> localhost | |. . o=o*E | 2026-05-05 03:01:54.696676 | debian-bookworm -> localhost | | . o. =+*Bo.. | 2026-05-05 03:01:54.696693 | debian-bookworm -> localhost | | oo.oo*==o | 2026-05-05 03:01:54.696709 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-05 03:01:54.696756 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.622370 2026-05-05 03:01:54.701875 | 2026-05-05 03:01:54.701954 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-05 03:01:54.739346 | debian-bookworm | ok 2026-05-05 03:01:54.760977 | debian-bookworm | included: /var/lib/zuul/builds/c5b96f5dbde3483c85da055fad90a333/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-05 03:01:54.786040 | 2026-05-05 03:01:54.786150 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-05 03:01:54.840641 | debian-bookworm | skipping: Conditional result was False 2026-05-05 03:01:54.866678 | 2026-05-05 03:01:54.866784 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-05 03:01:55.811744 | debian-bookworm | changed 2026-05-05 03:01:55.817467 | 2026-05-05 03:01:55.817550 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-05 03:01:56.192391 | debian-bookworm | ok 2026-05-05 03:01:56.198408 | 2026-05-05 03:01:56.198516 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-05 03:01:57.067235 | debian-bookworm | changed 2026-05-05 03:01:57.092409 | 2026-05-05 03:01:57.092562 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-05 03:01:57.933558 | debian-bookworm | changed 2026-05-05 03:01:57.955667 | 2026-05-05 03:01:57.956473 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-05 03:01:58.017911 | debian-bookworm | skipping: Conditional result was False 2026-05-05 03:01:58.032429 | 2026-05-05 03:01:58.032566 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-05 03:01:59.595664 | debian-bookworm -> localhost | changed 2026-05-05 03:01:59.605395 | 2026-05-05 03:01:59.605494 | TASK [add-build-sshkey : Add back temp key] 2026-05-05 03:02:00.178699 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/c5b96f5dbde3483c85da055fad90a333/work/c5b96f5dbde3483c85da055fad90a333_id_rsa (zuul-build-sshkey) 2026-05-05 03:02:00.178917 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.014500 2026-05-05 03:02:00.188674 | 2026-05-05 03:02:00.188781 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-05 03:02:00.653576 | debian-bookworm | ok 2026-05-05 03:02:00.657822 | 2026-05-05 03:02:00.657912 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-05 03:02:00.728838 | debian-bookworm | skipping: Conditional result was False 2026-05-05 03:02:00.738427 | 2026-05-05 03:02:00.738537 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-05 03:02:01.219642 | debian-bookworm | ok 2026-05-05 03:02:01.248909 | 2026-05-05 03:02:01.249026 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-05 03:02:01.301196 | debian-bookworm | ok 2026-05-05 03:02:01.306064 | 2026-05-05 03:02:01.306163 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-05 03:02:01.922540 | debian-bookworm -> localhost | ok 2026-05-05 03:02:01.929443 | 2026-05-05 03:02:01.929548 | TASK [validate-host : Collect information about the host] 2026-05-05 03:02:03.305198 | debian-bookworm | ok 2026-05-05 03:02:03.331362 | 2026-05-05 03:02:03.331490 | TASK [validate-host : Sanitize hostname] 2026-05-05 03:02:03.432750 | debian-bookworm | ok 2026-05-05 03:02:03.472923 | 2026-05-05 03:02:03.473036 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-05 03:02:04.792885 | debian-bookworm -> localhost | changed 2026-05-05 03:02:04.808812 | 2026-05-05 03:02:04.808922 | TASK [validate-host : Collect information about zuul worker] 2026-05-05 03:02:05.377119 | debian-bookworm | ok 2026-05-05 03:02:05.381707 | 2026-05-05 03:02:05.381809 | TASK [validate-host : Write out all zuul information for each host] 2026-05-05 03:02:06.793432 | debian-bookworm -> localhost | changed 2026-05-05 03:02:06.805422 | 2026-05-05 03:02:06.805518 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-05 03:02:07.069228 | debian-bookworm | ok 2026-05-05 03:02:07.074034 | 2026-05-05 03:02:07.074139 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-05 03:02:08.523730 | debian-bookworm | changed: 2026-05-05 03:02:08.523959 | debian-bookworm | cd+++++++++ src/ 2026-05-05 03:02:08.523991 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-05 03:02:08.524011 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-05 03:02:08.524029 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-validations/ 2026-05-05 03:02:08.524046 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/c5b96f5dbde3483c85da055fad90a333/work/logs" 2026-05-05 03:02:37.763937 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/c5b96f5dbde3483c85da055fad90a333/work/artifacts" 2026-05-05 03:02:37.987408 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/c5b96f5dbde3483c85da055fad90a333/work/docs" 2026-05-05 03:02:38.004989 | 2026-05-05 03:02:38.005102 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-05 03:02:38.734991 | debian-bookworm | changed: 2026-05-05 03:02:38.735245 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-05 03:02:38.735292 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-05 03:02:38.735332 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-05 03:02:38.735385 | debian-bookworm | changed: All items complete 2026-05-05 03:02:38.735417 | 2026-05-05 03:02:39.278496 | debian-bookworm | changed: .d..t...... ./ 2026-05-05 03:02:39.816339 | debian-bookworm | changed: .d..t...... ./ 2026-05-05 03:02:39.840279 | 2026-05-05 03:02:39.840397 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-05 03:02:39.875064 | debian-bookworm | skipping: Conditional result was False 2026-05-05 03:02:39.888425 | debian-bookworm | skipping: Conditional result was False 2026-05-05 03:02:39.902253 | 2026-05-05 03:02:39.902337 | PLAY RECAP 2026-05-05 03:02:39.902385 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-05 03:02:39.902410 | 2026-05-05 03:02:39.999538 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-05 03:02:40.002169 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-05 03:02:40.903042 | 2026-05-05 03:02:40.903191 | PLAY [Base post] 2026-05-05 03:02:40.915652 | 2026-05-05 03:02:40.915778 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-05 03:02:41.466076 | debian-bookworm | changed 2026-05-05 03:02:41.474374 | 2026-05-05 03:02:41.474485 | PLAY RECAP 2026-05-05 03:02:41.474547 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-05 03:02:41.474610 | 2026-05-05 03:02:41.631168 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-05 03:02:41.631892 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-05 03:02:42.702128 | 2026-05-05 03:02:42.702426 | PLAY [Base post-logs] 2026-05-05 03:02:42.728458 | 2026-05-05 03:02:42.728757 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-05 03:02:43.395132 | localhost | changed 2026-05-05 03:02:43.405485 | 2026-05-05 03:02:43.405677 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-05 03:02:43.462879 | localhost | ok 2026-05-05 03:02:43.466306 | 2026-05-05 03:02:43.466420 | TASK [Set zuul-log-path fact] 2026-05-05 03:02:43.492260 | localhost | ok 2026-05-05 03:02:43.500802 | 2026-05-05 03:02:43.500939 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-05 03:02:43.527183 | localhost | ok 2026-05-05 03:02:43.530532 | 2026-05-05 03:02:43.530647 | TASK [upload-logs : Create log directories] 2026-05-05 03:02:44.112476 | localhost | changed 2026-05-05 03:02:44.116470 | 2026-05-05 03:02:44.116605 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-05 03:02:44.720918 | localhost -> localhost | ok: Runtime: 0:00:00.016813 2026-05-05 03:02:44.728132 | 2026-05-05 03:02:44.728306 | TASK [upload-logs : Upload logs to log server] 2026-05-05 03:02:45.585890 | localhost | Output suppressed because no_log was given 2026-05-05 03:02:45.590823 | 2026-05-05 03:02:45.590988 | LOOP [upload-logs : Compress console log and json output] 2026-05-05 03:02:45.678280 | localhost | skipping: Conditional result was False 2026-05-05 03:02:45.701897 | localhost | skipping: Conditional result was False 2026-05-05 03:02:45.713838 | 2026-05-05 03:02:45.713994 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-05 03:02:45.879169 | localhost | skipping: Conditional result was False 2026-05-05 03:02:45.879463 | 2026-05-05 03:02:45.908403 | localhost | skipping: Conditional result was False 2026-05-05 03:02:45.919228 | 2026-05-05 03:02:45.919378 | LOOP [upload-logs : Upload console log and json output]