2025-09-06 20:00:32.359785 | Job console starting 2025-09-06 20:00:32.369635 | Updating git repos 2025-09-06 20:00:32.391204 | Cloning repos into workspace 2025-09-06 20:00:32.455039 | Restoring repo states 2025-09-06 20:00:32.469461 | Merging changes 2025-09-06 20:00:33.021820 | Checking out repos 2025-09-06 20:00:33.085007 | Preparing playbooks 2025-09-06 20:00:34.774099 | Running Ansible setup 2025-09-06 20:00:40.545345 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-06 20:00:41.634805 | 2025-09-06 20:00:41.643073 | PLAY [Base pre] 2025-09-06 20:00:41.674023 | 2025-09-06 20:00:41.674147 | TASK [Setup log path fact] 2025-09-06 20:00:41.727112 | debian-bookworm | ok 2025-09-06 20:00:41.747224 | 2025-09-06 20:00:41.747339 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-06 20:00:41.784589 | debian-bookworm | ok 2025-09-06 20:00:41.792200 | 2025-09-06 20:00:41.792283 | TASK [emit-job-header : Print job information] 2025-09-06 20:00:41.837009 | # Job Information 2025-09-06 20:00:41.837147 | Ansible Version: 2.16.14 2025-09-06 20:00:41.837175 | Job: python-black 2025-09-06 20:00:41.837201 | Pipeline: check 2025-09-06 20:00:41.837220 | Executor: 521e9411259a 2025-09-06 20:00:41.837236 | Triggered by: https://github.com/osism/container-image-osism-ansible/pull/679 2025-09-06 20:00:41.837253 | Event ID: 1e32e770-8b5c-11f0-8572-b3426e4baab7 2025-09-06 20:00:41.841074 | 2025-09-06 20:00:41.841201 | LOOP [emit-job-header : Print node information] 2025-09-06 20:00:42.011076 | debian-bookworm | ok: 2025-09-06 20:00:42.011252 | debian-bookworm | # Node Information 2025-09-06 20:00:42.011307 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-06 20:00:42.011330 | debian-bookworm | Hostname: debian 2025-09-06 20:00:42.011348 | debian-bookworm | Username: zuul 2025-09-06 20:00:42.011365 | debian-bookworm | Distro: Debian 12.11 2025-09-06 20:00:42.011384 | debian-bookworm | Provider: regiocloud-a 2025-09-06 20:00:42.011402 | debian-bookworm | Region: 2025-09-06 20:00:42.011418 | debian-bookworm | Label: debian-bookworm 2025-09-06 20:00:42.011434 | debian-bookworm | Product Name: OpenStack Nova 2025-09-06 20:00:42.011450 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe39:a607 2025-09-06 20:00:42.029554 | 2025-09-06 20:00:42.029648 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-06 20:00:42.932632 | debian-bookworm -> localhost | changed 2025-09-06 20:00:42.938283 | 2025-09-06 20:00:42.938367 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-06 20:00:45.285912 | debian-bookworm -> localhost | changed 2025-09-06 20:00:45.305207 | 2025-09-06 20:00:45.306261 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-06 20:00:45.794565 | debian-bookworm -> localhost | ok 2025-09-06 20:00:45.800386 | 2025-09-06 20:00:45.800486 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-06 20:00:45.828109 | debian-bookworm | ok 2025-09-06 20:00:45.856672 | debian-bookworm | included: /var/lib/zuul/builds/7a97e68b1ed344c3b35e6fdc68e03128/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-06 20:00:45.875127 | 2025-09-06 20:00:45.875234 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-06 20:00:46.939205 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-06 20:00:46.939367 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/7a97e68b1ed344c3b35e6fdc68e03128/work/7a97e68b1ed344c3b35e6fdc68e03128_id_rsa 2025-09-06 20:00:46.939399 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/7a97e68b1ed344c3b35e6fdc68e03128/work/7a97e68b1ed344c3b35e6fdc68e03128_id_rsa.pub 2025-09-06 20:00:46.939421 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-06 20:00:46.939441 | debian-bookworm -> localhost | SHA256:l8WcuMXA9AL0FrLvTWxQYU+Cbz7vSiKjZGTkllhYni0 zuul-build-sshkey 2025-09-06 20:00:46.939467 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-06 20:00:46.939486 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-06 20:00:46.939503 | debian-bookworm -> localhost | | ..+o+.=.. | 2025-09-06 20:00:46.939521 | debian-bookworm -> localhost | | + o =o@ = | 2025-09-06 20:00:46.939538 | debian-bookworm -> localhost | | . E o *.O . | 2025-09-06 20:00:46.939554 | debian-bookworm -> localhost | | = o o Oo | 2025-09-06 20:00:46.939571 | debian-bookworm -> localhost | | . * S =o+ | 2025-09-06 20:00:46.939592 | debian-bookworm -> localhost | | + o +o | 2025-09-06 20:00:46.939609 | debian-bookworm -> localhost | | o o o oo | 2025-09-06 20:00:46.939626 | debian-bookworm -> localhost | | o . o o . | 2025-09-06 20:00:46.939643 | debian-bookworm -> localhost | | . .o. | 2025-09-06 20:00:46.939659 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-06 20:00:46.939701 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.369267 2025-09-06 20:00:46.946091 | 2025-09-06 20:00:46.946196 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-06 20:00:46.982430 | debian-bookworm | ok 2025-09-06 20:00:46.994020 | debian-bookworm | included: /var/lib/zuul/builds/7a97e68b1ed344c3b35e6fdc68e03128/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-06 20:00:47.007088 | 2025-09-06 20:00:47.007182 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-06 20:00:47.042930 | debian-bookworm | skipping: Conditional result was False 2025-09-06 20:00:47.047637 | 2025-09-06 20:00:47.047719 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-06 20:00:47.834568 | debian-bookworm | changed 2025-09-06 20:00:47.839778 | 2025-09-06 20:00:47.839858 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-06 20:00:48.098306 | debian-bookworm | ok 2025-09-06 20:00:48.102938 | 2025-09-06 20:00:48.103017 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-06 20:00:48.745171 | debian-bookworm | changed 2025-09-06 20:00:48.750510 | 2025-09-06 20:00:48.750594 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-06 20:00:49.450151 | debian-bookworm | changed 2025-09-06 20:00:49.454856 | 2025-09-06 20:00:49.454934 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-06 20:00:49.487438 | debian-bookworm | skipping: Conditional result was False 2025-09-06 20:00:49.492252 | 2025-09-06 20:00:49.492335 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-06 20:00:50.241390 | debian-bookworm -> localhost | changed 2025-09-06 20:00:50.254543 | 2025-09-06 20:00:50.254638 | TASK [add-build-sshkey : Add back temp key] 2025-09-06 20:00:50.720533 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/7a97e68b1ed344c3b35e6fdc68e03128/work/7a97e68b1ed344c3b35e6fdc68e03128_id_rsa (zuul-build-sshkey) 2025-09-06 20:00:50.720731 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.008000 2025-09-06 20:00:50.728875 | 2025-09-06 20:00:50.728966 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-06 20:00:51.207699 | debian-bookworm | ok 2025-09-06 20:00:51.212968 | 2025-09-06 20:00:51.213060 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-06 20:00:51.235764 | debian-bookworm | skipping: Conditional result was False 2025-09-06 20:00:51.244137 | 2025-09-06 20:00:51.244241 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-06 20:00:51.732590 | debian-bookworm | ok 2025-09-06 20:00:51.746670 | 2025-09-06 20:00:51.746777 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-06 20:00:51.775546 | debian-bookworm | ok 2025-09-06 20:00:51.780612 | 2025-09-06 20:00:51.780705 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-06 20:00:52.246539 | debian-bookworm -> localhost | ok 2025-09-06 20:00:52.253332 | 2025-09-06 20:00:52.253427 | TASK [validate-host : Collect information about the host] 2025-09-06 20:00:53.467280 | debian-bookworm | ok 2025-09-06 20:00:53.485885 | 2025-09-06 20:00:53.485985 | TASK [validate-host : Sanitize hostname] 2025-09-06 20:00:53.662297 | debian-bookworm | ok 2025-09-06 20:00:53.760400 | 2025-09-06 20:00:53.760500 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-06 20:00:54.713426 | debian-bookworm -> localhost | changed 2025-09-06 20:00:54.718754 | 2025-09-06 20:00:54.719015 | TASK [validate-host : Collect information about zuul worker] 2025-09-06 20:00:55.288118 | debian-bookworm | ok 2025-09-06 20:00:55.292508 | 2025-09-06 20:00:55.292591 | TASK [validate-host : Write out all zuul information for each host] 2025-09-06 20:00:56.449930 | debian-bookworm -> localhost | changed 2025-09-06 20:00:56.463322 | 2025-09-06 20:00:56.463460 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-06 20:00:56.701967 | debian-bookworm | ok 2025-09-06 20:00:56.706581 | 2025-09-06 20:00:56.706660 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-06 20:00:57.641778 | debian-bookworm | changed: 2025-09-06 20:00:57.641923 | debian-bookworm | cd+++++++++ src/ 2025-09-06 20:00:57.641952 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-06 20:00:57.641972 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-06 20:00:57.641990 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-osism-ansible/ 2025-09-06 20:00:57.642006 | debian-bookworm | Containerfile 2025-09-06 20:00:57.642116 | debian-bookworm | localhost | ok: Runtime: 0:00:00.004785 2025-09-06 20:01:25.328864 | 2025-09-06 20:01:25.328962 | TASK [upload-logs : Upload logs to log server] 2025-09-06 20:01:25.889654 | localhost | Output suppressed because no_log was given 2025-09-06 20:01:25.891044 | 2025-09-06 20:01:25.891118 | LOOP [upload-logs : Compress console log and json output] 2025-09-06 20:01:25.924196 | localhost | skipping: Conditional result was False 2025-09-06 20:01:25.929929 | localhost | skipping: Conditional result was False 2025-09-06 20:01:25.936325 | 2025-09-06 20:01:25.936404 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-06 20:01:25.984059 | localhost | skipping: Conditional result was False 2025-09-06 20:01:25.984271 | 2025-09-06 20:01:25.988760 | localhost | skipping: Conditional result was False 2025-09-06 20:01:26.001101 | 2025-09-06 20:01:26.001202 | LOOP [upload-logs : Upload console log and json output]