2026-05-30 03:15:47.320210 | Job console starting 2026-05-30 03:15:47.333627 | Updating git repos 2026-05-30 03:15:47.426319 | Cloning repos into workspace 2026-05-30 03:15:47.611259 | Restoring repo states 2026-05-30 03:15:47.647854 | Merging changes 2026-05-30 03:15:47.647881 | Checking out repos 2026-05-30 03:15:47.948267 | Preparing playbooks 2026-05-30 03:15:49.402287 | Running Ansible setup 2026-05-30 03:15:54.626168 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-30 03:15:55.931625 | 2026-05-30 03:15:55.931853 | PLAY [Base pre] 2026-05-30 03:15:55.958624 | 2026-05-30 03:15:55.958823 | TASK [Setup log path fact] 2026-05-30 03:15:55.999723 | debian-bookworm | ok 2026-05-30 03:15:56.024543 | 2026-05-30 03:15:56.024772 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-30 03:15:56.087221 | debian-bookworm | ok 2026-05-30 03:15:56.106728 | 2026-05-30 03:15:56.106973 | TASK [emit-job-header : Print job information] 2026-05-30 03:15:56.198716 | # Job Information 2026-05-30 03:15:56.198978 | Ansible Version: 2.16.14 2026-05-30 03:15:56.199015 | Job: python-black 2026-05-30 03:15:56.199049 | Pipeline: periodic-daily 2026-05-30 03:15:56.199071 | Executor: 521e9411259a 2026-05-30 03:15:56.199106 | Triggered by: https://github.com/osism/ansible-collection-services 2026-05-30 03:15:56.199128 | Event ID: 60dc83d672f24ce4bff13e544437f41e 2026-05-30 03:15:56.213286 | 2026-05-30 03:15:56.213467 | LOOP [emit-job-header : Print node information] 2026-05-30 03:15:56.441059 | debian-bookworm | ok: 2026-05-30 03:15:56.441271 | debian-bookworm | # Node Information 2026-05-30 03:15:56.441306 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-30 03:15:56.441331 | debian-bookworm | Hostname: debian 2026-05-30 03:15:56.441354 | debian-bookworm | Username: zuul 2026-05-30 03:15:56.441373 | debian-bookworm | Distro: Debian 12.14 2026-05-30 03:15:56.441398 | debian-bookworm | Provider: regiocloud-a 2026-05-30 03:15:56.441419 | debian-bookworm | Region: 2026-05-30 03:15:56.441440 | debian-bookworm | Label: debian-bookworm 2026-05-30 03:15:56.441461 | debian-bookworm | Product Name: OpenStack Nova 2026-05-30 03:15:56.441480 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe84:bb0d 2026-05-30 03:15:56.462977 | 2026-05-30 03:15:56.463121 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-30 03:15:57.296013 | debian-bookworm -> localhost | changed 2026-05-30 03:15:57.304517 | 2026-05-30 03:15:57.304636 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-30 03:15:59.151598 | debian-bookworm -> localhost | changed 2026-05-30 03:15:59.162538 | 2026-05-30 03:15:59.162668 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-30 03:15:59.516580 | debian-bookworm -> localhost | ok 2026-05-30 03:15:59.523108 | 2026-05-30 03:15:59.523218 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-30 03:15:59.555573 | debian-bookworm | ok 2026-05-30 03:15:59.570390 | debian-bookworm | included: /var/lib/zuul/builds/cd25e6a6ccce4d71a60bc080bdf22f49/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-30 03:15:59.579781 | 2026-05-30 03:15:59.579897 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-30 03:16:01.117175 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-30 03:16:01.117458 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/cd25e6a6ccce4d71a60bc080bdf22f49/work/cd25e6a6ccce4d71a60bc080bdf22f49_id_rsa 2026-05-30 03:16:01.117589 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/cd25e6a6ccce4d71a60bc080bdf22f49/work/cd25e6a6ccce4d71a60bc080bdf22f49_id_rsa.pub 2026-05-30 03:16:01.117620 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-30 03:16:01.117646 | debian-bookworm -> localhost | SHA256:Sd3u28rVDfUvQOMEPzN8/GPIbDGaSUdEmJBxsVHMwa0 zuul-build-sshkey 2026-05-30 03:16:01.117669 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-30 03:16:01.117701 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-30 03:16:01.117724 | debian-bookworm -> localhost | | o=+@*o | 2026-05-30 03:16:01.117746 | debian-bookworm -> localhost | | o.B+= . | 2026-05-30 03:16:01.117767 | debian-bookworm -> localhost | | . .o@++ .| 2026-05-30 03:16:01.117787 | debian-bookworm -> localhost | | . ..=BE+o.| 2026-05-30 03:16:01.118144 | debian-bookworm -> localhost | | S ++=.oo| 2026-05-30 03:16:01.118268 | debian-bookworm -> localhost | | ....o+| 2026-05-30 03:16:01.118298 | debian-bookworm -> localhost | | . o +| 2026-05-30 03:16:01.118321 | debian-bookworm -> localhost | | . + . | 2026-05-30 03:16:01.118344 | debian-bookworm -> localhost | | +.. | 2026-05-30 03:16:01.118366 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-30 03:16:01.118887 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.532424 2026-05-30 03:16:01.136221 | 2026-05-30 03:16:01.136324 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-30 03:16:01.183885 | debian-bookworm | ok 2026-05-30 03:16:01.198580 | debian-bookworm | included: /var/lib/zuul/builds/cd25e6a6ccce4d71a60bc080bdf22f49/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-30 03:16:01.219901 | 2026-05-30 03:16:01.220555 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-30 03:16:01.246020 | debian-bookworm | skipping: Conditional result was False 2026-05-30 03:16:01.252264 | 2026-05-30 03:16:01.252363 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-30 03:16:02.075836 | debian-bookworm | changed 2026-05-30 03:16:02.085063 | 2026-05-30 03:16:02.085211 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-30 03:16:02.357858 | debian-bookworm | ok 2026-05-30 03:16:02.364177 | 2026-05-30 03:16:02.364274 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-30 03:16:03.010253 | debian-bookworm | changed 2026-05-30 03:16:03.025619 | 2026-05-30 03:16:03.025763 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-30 03:16:03.843753 | debian-bookworm | changed 2026-05-30 03:16:03.857316 | 2026-05-30 03:16:03.857481 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-30 03:16:03.892837 | debian-bookworm | skipping: Conditional result was False 2026-05-30 03:16:03.909686 | 2026-05-30 03:16:03.909938 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-30 03:16:04.829789 | debian-bookworm -> localhost | changed 2026-05-30 03:16:04.847639 | 2026-05-30 03:16:04.847781 | TASK [add-build-sshkey : Add back temp key] 2026-05-30 03:16:05.557754 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/cd25e6a6ccce4d71a60bc080bdf22f49/work/cd25e6a6ccce4d71a60bc080bdf22f49_id_rsa (zuul-build-sshkey) 2026-05-30 03:16:05.558058 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.041656 2026-05-30 03:16:05.576437 | 2026-05-30 03:16:05.576593 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-30 03:16:06.181256 | debian-bookworm | ok 2026-05-30 03:16:06.201119 | 2026-05-30 03:16:06.201275 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-30 03:16:06.265343 | debian-bookworm | skipping: Conditional result was False 2026-05-30 03:16:06.324125 | 2026-05-30 03:16:06.325595 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-30 03:16:07.105980 | debian-bookworm | ok 2026-05-30 03:16:07.136225 | 2026-05-30 03:16:07.136378 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-30 03:16:07.190889 | debian-bookworm | ok 2026-05-30 03:16:07.196154 | 2026-05-30 03:16:07.196262 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-30 03:16:07.725177 | debian-bookworm -> localhost | ok 2026-05-30 03:16:07.731556 | 2026-05-30 03:16:07.731648 | TASK [validate-host : Collect information about the host] 2026-05-30 03:16:08.938507 | debian-bookworm | ok 2026-05-30 03:16:08.953703 | 2026-05-30 03:16:08.953807 | TASK [validate-host : Sanitize hostname] 2026-05-30 03:16:09.132163 | debian-bookworm | ok 2026-05-30 03:16:09.163037 | 2026-05-30 03:16:09.163157 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-30 03:16:09.963392 | debian-bookworm -> localhost | changed 2026-05-30 03:16:09.968176 | 2026-05-30 03:16:09.968268 | TASK [validate-host : Collect information about zuul worker] 2026-05-30 03:16:10.426539 | debian-bookworm | ok 2026-05-30 03:16:10.431864 | 2026-05-30 03:16:10.431989 | TASK [validate-host : Write out all zuul information for each host] 2026-05-30 03:16:11.230348 | debian-bookworm -> localhost | changed 2026-05-30 03:16:11.243055 | 2026-05-30 03:16:11.243182 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-30 03:16:11.528014 | debian-bookworm | ok 2026-05-30 03:16:11.540847 | 2026-05-30 03:16:11.541007 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-30 03:16:13.489397 | debian-bookworm | changed: 2026-05-30 03:16:13.490023 | debian-bookworm | cd+++++++++ src/ 2026-05-30 03:16:13.490086 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-30 03:16:13.490142 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-30 03:16:13.490468 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2026-05-30 03:16:13.490648 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/cd25e6a6ccce4d71a60bc080bdf22f49/work/logs" 2026-05-30 03:16:45.736366 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/cd25e6a6ccce4d71a60bc080bdf22f49/work/artifacts" 2026-05-30 03:16:46.340303 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/cd25e6a6ccce4d71a60bc080bdf22f49/work/docs" 2026-05-30 03:16:46.367271 | 2026-05-30 03:16:46.367403 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-30 03:16:47.433712 | debian-bookworm | changed: 2026-05-30 03:16:47.434009 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-30 03:16:47.434110 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-30 03:16:47.434161 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-30 03:16:47.434230 | debian-bookworm | changed: All items complete 2026-05-30 03:16:47.434268 | 2026-05-30 03:16:48.047628 | debian-bookworm | changed: .d..t...... ./ 2026-05-30 03:16:48.686079 | debian-bookworm | changed: .d..t...... ./ 2026-05-30 03:16:48.711306 | 2026-05-30 03:16:48.711451 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-30 03:16:48.775783 | debian-bookworm | skipping: Conditional result was False 2026-05-30 03:16:48.784734 | debian-bookworm | skipping: Conditional result was False 2026-05-30 03:16:48.793872 | 2026-05-30 03:16:48.801809 | PLAY RECAP 2026-05-30 03:16:48.801920 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-30 03:16:48.801951 | 2026-05-30 03:16:48.969101 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-30 03:16:48.969884 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-30 03:16:50.804751 | 2026-05-30 03:16:50.804895 | PLAY [Base post] 2026-05-30 03:16:50.831835 | 2026-05-30 03:16:50.831969 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-30 03:16:51.841250 | debian-bookworm | changed 2026-05-30 03:16:51.863128 | 2026-05-30 03:16:51.863291 | PLAY RECAP 2026-05-30 03:16:51.863364 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-30 03:16:51.863434 | 2026-05-30 03:16:52.492281 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-30 03:16:52.493228 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-30 03:16:54.662621 | 2026-05-30 03:16:54.662773 | PLAY [Base post-logs] 2026-05-30 03:16:54.691384 | 2026-05-30 03:16:54.691517 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-30 03:16:55.601072 | localhost | changed 2026-05-30 03:16:55.610059 | 2026-05-30 03:16:55.610181 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-30 03:16:55.634620 | localhost | ok 2026-05-30 03:16:55.637657 | 2026-05-30 03:16:55.637873 | TASK [Set zuul-log-path fact] 2026-05-30 03:16:55.662222 | localhost | ok 2026-05-30 03:16:55.669567 | 2026-05-30 03:16:55.669657 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-30 03:16:55.704634 | localhost | ok 2026-05-30 03:16:55.709277 | 2026-05-30 03:16:55.709375 | TASK [upload-logs : Create log directories] 2026-05-30 03:16:56.818929 | localhost | changed 2026-05-30 03:16:56.821889 | 2026-05-30 03:16:56.821981 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-30 03:16:57.621479 | localhost -> localhost | ok: Runtime: 0:00:00.007268 2026-05-30 03:16:57.629867 | 2026-05-30 03:16:57.629976 | TASK [upload-logs : Upload logs to log server] 2026-05-30 03:16:58.708405 | localhost | Output suppressed because no_log was given 2026-05-30 03:16:58.711585 | 2026-05-30 03:16:58.711685 | LOOP [upload-logs : Compress console log and json output] 2026-05-30 03:16:58.828413 | localhost | skipping: Conditional result was False 2026-05-30 03:16:58.849329 | localhost | skipping: Conditional result was False 2026-05-30 03:16:58.859445 | 2026-05-30 03:16:58.859550 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-30 03:16:58.970762 | localhost | skipping: Conditional result was False 2026-05-30 03:16:58.971221 | 2026-05-30 03:16:58.980360 | localhost | skipping: Conditional result was False 2026-05-30 03:16:58.991789 | 2026-05-30 03:16:58.991905 | LOOP [upload-logs : Upload console log and json output]