2025-09-20 03:04:05.786708 | Job console starting 2025-09-20 03:04:05.800317 | Updating git repos 2025-09-20 03:04:05.858720 | Cloning repos into workspace 2025-09-20 03:04:06.018014 | Restoring repo states 2025-09-20 03:04:06.055963 | Merging changes 2025-09-20 03:04:06.055978 | Checking out repos 2025-09-20 03:04:06.153803 | Preparing playbooks 2025-09-20 03:04:07.463349 | Running Ansible setup 2025-09-20 03:04:13.829642 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-20 03:04:15.239877 | 2025-09-20 03:04:15.239987 | PLAY [Base pre] 2025-09-20 03:04:15.287988 | 2025-09-20 03:04:15.288100 | TASK [Setup log path fact] 2025-09-20 03:04:15.322123 | debian-bookworm | ok 2025-09-20 03:04:15.358742 | 2025-09-20 03:04:15.361862 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-20 03:04:15.400789 | debian-bookworm | ok 2025-09-20 03:04:15.413024 | 2025-09-20 03:04:15.419477 | TASK [emit-job-header : Print job information] 2025-09-20 03:04:15.501605 | # Job Information 2025-09-20 03:04:15.501745 | Ansible Version: 2.16.14 2025-09-20 03:04:15.501787 | Job: python-black 2025-09-20 03:04:15.501815 | Pipeline: periodic-daily 2025-09-20 03:04:15.501833 | Executor: 521e9411259a 2025-09-20 03:04:15.501850 | Triggered by: https://github.com/osism/container-image-osism-ansible 2025-09-20 03:04:15.501869 | Event ID: 78fcf63fe31a429b9b2368088a9884b7 2025-09-20 03:04:15.505788 | 2025-09-20 03:04:15.505869 | LOOP [emit-job-header : Print node information] 2025-09-20 03:04:15.703509 | debian-bookworm | ok: 2025-09-20 03:04:15.703674 | debian-bookworm | # Node Information 2025-09-20 03:04:15.703732 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-20 03:04:15.703756 | debian-bookworm | Hostname: debian 2025-09-20 03:04:15.703785 | debian-bookworm | Username: zuul 2025-09-20 03:04:15.703809 | debian-bookworm | Distro: Debian 12.12 2025-09-20 03:04:15.703829 | debian-bookworm | Provider: regiocloud-a 2025-09-20 03:04:15.703847 | debian-bookworm | Region: 2025-09-20 03:04:15.703864 | debian-bookworm | Label: debian-bookworm 2025-09-20 03:04:15.703879 | debian-bookworm | Product Name: OpenStack Nova 2025-09-20 03:04:15.703896 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe88:92a8 2025-09-20 03:04:15.722363 | 2025-09-20 03:04:15.722464 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-20 03:04:17.277722 | debian-bookworm -> localhost | changed 2025-09-20 03:04:17.283338 | 2025-09-20 03:04:17.283433 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-20 03:04:19.553527 | debian-bookworm -> localhost | changed 2025-09-20 03:04:19.563524 | 2025-09-20 03:04:19.563620 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-20 03:04:20.632146 | debian-bookworm -> localhost | ok 2025-09-20 03:04:20.638272 | 2025-09-20 03:04:20.638374 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-20 03:04:20.686705 | debian-bookworm | ok 2025-09-20 03:04:20.770992 | debian-bookworm | included: /var/lib/zuul/builds/1d239b9f94964dd5ba06b46f6a879a77/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-20 03:04:20.845007 | 2025-09-20 03:04:20.845462 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-20 03:04:26.318674 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-20 03:04:26.318869 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/1d239b9f94964dd5ba06b46f6a879a77/work/1d239b9f94964dd5ba06b46f6a879a77_id_rsa 2025-09-20 03:04:26.318911 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/1d239b9f94964dd5ba06b46f6a879a77/work/1d239b9f94964dd5ba06b46f6a879a77_id_rsa.pub 2025-09-20 03:04:26.318933 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-20 03:04:26.318953 | debian-bookworm -> localhost | SHA256:NzugC9lemwGNitghh5vkJBdSi1Fw7U38dE/DT8NAdv8 zuul-build-sshkey 2025-09-20 03:04:26.318971 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-20 03:04:26.318996 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-20 03:04:26.319015 | debian-bookworm -> localhost | |oo+. . o+o. | 2025-09-20 03:04:26.319032 | debian-bookworm -> localhost | | = .. o . ..+.+. | 2025-09-20 03:04:26.319049 | debian-bookworm -> localhost | |o o. o o . o + ..| 2025-09-20 03:04:26.319065 | debian-bookworm -> localhost | | o .. .o. . . .| 2025-09-20 03:04:26.319081 | debian-bookworm -> localhost | |+o+ o S o E| 2025-09-20 03:04:26.319101 | debian-bookworm -> localhost | |=O o + o o o | 2025-09-20 03:04:26.319117 | debian-bookworm -> localhost | |+.o + o o o | 2025-09-20 03:04:26.319134 | debian-bookworm -> localhost | | o o + . | 2025-09-20 03:04:26.319151 | debian-bookworm -> localhost | | o o | 2025-09-20 03:04:26.319167 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-20 03:04:26.319211 | debian-bookworm -> localhost | ok: Runtime: 0:00:03.880565 2025-09-20 03:04:26.325025 | 2025-09-20 03:04:26.325135 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-20 03:04:26.352494 | debian-bookworm | ok 2025-09-20 03:04:26.359937 | debian-bookworm | included: /var/lib/zuul/builds/1d239b9f94964dd5ba06b46f6a879a77/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-20 03:04:26.367776 | 2025-09-20 03:04:26.367851 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-20 03:04:26.380269 | debian-bookworm | skipping: Conditional result was False 2025-09-20 03:04:26.385054 | 2025-09-20 03:04:26.385127 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-20 03:04:27.011452 | debian-bookworm | changed 2025-09-20 03:04:27.015794 | 2025-09-20 03:04:27.015869 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-20 03:04:27.295211 | debian-bookworm | ok 2025-09-20 03:04:27.299584 | 2025-09-20 03:04:27.299663 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-20 03:04:27.943448 | debian-bookworm | changed 2025-09-20 03:04:27.952086 | 2025-09-20 03:04:27.952188 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-20 03:04:28.592366 | debian-bookworm | changed 2025-09-20 03:04:28.600358 | 2025-09-20 03:04:28.600467 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-20 03:04:28.643134 | debian-bookworm | skipping: Conditional result was False 2025-09-20 03:04:28.665226 | 2025-09-20 03:04:28.665335 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-20 03:04:29.402155 | debian-bookworm -> localhost | changed 2025-09-20 03:04:29.412978 | 2025-09-20 03:04:29.413080 | TASK [add-build-sshkey : Add back temp key] 2025-09-20 03:04:30.201635 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/1d239b9f94964dd5ba06b46f6a879a77/work/1d239b9f94964dd5ba06b46f6a879a77_id_rsa (zuul-build-sshkey) 2025-09-20 03:04:30.202178 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.025051 2025-09-20 03:04:30.227284 | 2025-09-20 03:04:30.227442 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-20 03:04:30.719834 | debian-bookworm | ok 2025-09-20 03:04:30.727618 | 2025-09-20 03:04:30.727713 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-20 03:04:30.801157 | debian-bookworm | skipping: Conditional result was False 2025-09-20 03:04:30.816282 | 2025-09-20 03:04:30.816429 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-20 03:04:31.358789 | debian-bookworm | ok 2025-09-20 03:04:31.377337 | 2025-09-20 03:04:31.377437 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-20 03:04:31.425877 | debian-bookworm | ok 2025-09-20 03:04:31.440047 | 2025-09-20 03:04:31.440158 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-20 03:04:31.917788 | debian-bookworm -> localhost | ok 2025-09-20 03:04:31.924982 | 2025-09-20 03:04:31.925079 | TASK [validate-host : Collect information about the host] 2025-09-20 03:04:33.334822 | debian-bookworm | ok 2025-09-20 03:04:33.363674 | 2025-09-20 03:04:33.363798 | TASK [validate-host : Sanitize hostname] 2025-09-20 03:04:33.604003 | debian-bookworm | ok 2025-09-20 03:04:33.640738 | 2025-09-20 03:04:33.640854 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-20 03:04:35.245551 | debian-bookworm -> localhost | changed 2025-09-20 03:04:35.251684 | 2025-09-20 03:04:35.251953 | TASK [validate-host : Collect information about zuul worker] 2025-09-20 03:04:35.776072 | debian-bookworm | ok 2025-09-20 03:04:35.780725 | 2025-09-20 03:04:35.780863 | TASK [validate-host : Write out all zuul information for each host] 2025-09-20 03:04:37.136654 | debian-bookworm -> localhost | changed 2025-09-20 03:04:37.145028 | 2025-09-20 03:04:37.145110 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-20 03:04:37.517508 | debian-bookworm | ok 2025-09-20 03:04:37.522160 | 2025-09-20 03:04:37.522379 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-20 03:04:38.782921 | debian-bookworm | changed: 2025-09-20 03:04:38.783075 | debian-bookworm | cd+++++++++ src/ 2025-09-20 03:04:38.783104 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-20 03:04:38.783124 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-20 03:04:38.783142 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-osism-ansible/ 2025-09-20 03:04:38.783160 | debian-bookworm | Containerfile 2025-09-20 03:04:38.783267 | debian-bookworm | localhost | ok: Runtime: 0:00:00.016613 2025-09-20 03:05:06.696502 | 2025-09-20 03:05:06.696963 | TASK [upload-logs : Upload logs to log server] 2025-09-20 03:05:07.899967 | localhost | Output suppressed because no_log was given 2025-09-20 03:05:07.901860 | 2025-09-20 03:05:07.901975 | LOOP [upload-logs : Compress console log and json output] 2025-09-20 03:05:07.976882 | localhost | skipping: Conditional result was False 2025-09-20 03:05:08.011317 | localhost | skipping: Conditional result was False 2025-09-20 03:05:08.021481 | 2025-09-20 03:05:08.021764 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-20 03:05:08.091558 | localhost | skipping: Conditional result was False 2025-09-20 03:05:08.091925 | 2025-09-20 03:05:08.111476 | localhost | skipping: Conditional result was False 2025-09-20 03:05:08.118880 | 2025-09-20 03:05:08.119007 | LOOP [upload-logs : Upload console log and json output]