2025-12-29 20:31:42.651718 | Job console starting 2025-12-29 20:31:42.685230 | Updating git repos 2025-12-29 20:31:42.731378 | Cloning repos into workspace 2025-12-29 20:31:42.779311 | Restoring repo states 2025-12-29 20:31:42.785456 | Merging changes 2025-12-29 20:31:43.326404 | Checking out repos 2025-12-29 20:31:43.386266 | Preparing playbooks 2025-12-29 20:31:44.352807 | Running Ansible setup 2025-12-29 20:31:49.847315 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-29 20:31:51.081824 | 2025-12-29 20:31:51.082006 | PLAY [Base pre] 2025-12-29 20:31:51.124269 | 2025-12-29 20:31:51.124437 | TASK [Setup log path fact] 2025-12-29 20:31:51.146292 | debian-bookworm | ok 2025-12-29 20:31:51.164863 | 2025-12-29 20:31:51.165032 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-29 20:31:51.210628 | debian-bookworm | ok 2025-12-29 20:31:51.222783 | 2025-12-29 20:31:51.222946 | TASK [emit-job-header : Print job information] 2025-12-29 20:31:51.285445 | # Job Information 2025-12-29 20:31:51.285824 | Ansible Version: 2.16.14 2025-12-29 20:31:51.285875 | Job: python-black 2025-12-29 20:31:51.285924 | Pipeline: check 2025-12-29 20:31:51.285953 | Executor: 521e9411259a 2025-12-29 20:31:51.285974 | Triggered by: https://github.com/osism/cfg-cookiecutter/pull/804 2025-12-29 20:31:51.285995 | Event ID: 5d36ac70-e4f5-11f0-9739-e3f4c1691d32 2025-12-29 20:31:51.295343 | 2025-12-29 20:31:51.295499 | LOOP [emit-job-header : Print node information] 2025-12-29 20:31:51.419122 | debian-bookworm | ok: 2025-12-29 20:31:51.419325 | debian-bookworm | # Node Information 2025-12-29 20:31:51.419358 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-29 20:31:51.419383 | debian-bookworm | Hostname: debian 2025-12-29 20:31:51.419405 | debian-bookworm | Username: zuul 2025-12-29 20:31:51.419426 | debian-bookworm | Distro: Debian 12.12 2025-12-29 20:31:51.419449 | debian-bookworm | Provider: regiocloud-a 2025-12-29 20:31:51.419470 | debian-bookworm | Region: 2025-12-29 20:31:51.419491 | debian-bookworm | Label: debian-bookworm 2025-12-29 20:31:51.419510 | debian-bookworm | Product Name: OpenStack Nova 2025-12-29 20:31:51.419529 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe02:5b0f 2025-12-29 20:31:51.440336 | 2025-12-29 20:31:51.440529 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-29 20:31:52.291546 | debian-bookworm -> localhost | changed 2025-12-29 20:31:52.299860 | 2025-12-29 20:31:52.300011 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-29 20:31:53.973735 | debian-bookworm -> localhost | changed 2025-12-29 20:31:54.001183 | 2025-12-29 20:31:54.001399 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-29 20:31:54.535774 | debian-bookworm -> localhost | ok 2025-12-29 20:31:54.542474 | 2025-12-29 20:31:54.542613 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-29 20:31:54.593987 | debian-bookworm | ok 2025-12-29 20:31:54.634064 | debian-bookworm | included: /var/lib/zuul/builds/820d41bf8762459794462de09af31fa0/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-29 20:31:54.663630 | 2025-12-29 20:31:54.663772 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-29 20:31:56.280782 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-29 20:31:56.281023 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/820d41bf8762459794462de09af31fa0/work/820d41bf8762459794462de09af31fa0_id_rsa 2025-12-29 20:31:56.281064 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/820d41bf8762459794462de09af31fa0/work/820d41bf8762459794462de09af31fa0_id_rsa.pub 2025-12-29 20:31:56.281111 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-29 20:31:56.281137 | debian-bookworm -> localhost | SHA256:li0STaINgK7+rkBC3mc1Wl8kzq3VUlRRMuGM9O+JxJk zuul-build-sshkey 2025-12-29 20:31:56.281160 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-29 20:31:56.281197 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-29 20:31:56.281220 | debian-bookworm -> localhost | | .... . .. .oo=++| 2025-12-29 20:31:56.281242 | debian-bookworm -> localhost | |. + +o +.o= o | 2025-12-29 20:31:56.281263 | debian-bookworm -> localhost | |.. . o+.o =..+ | 2025-12-29 20:31:56.281282 | debian-bookworm -> localhost | |o.. +.oo+ o o. | 2025-12-29 20:31:56.281302 | debian-bookworm -> localhost | |oo . +. So. E .| 2025-12-29 20:31:56.281328 | debian-bookworm -> localhost | |+ o o . . ...| 2025-12-29 20:31:56.281349 | debian-bookworm -> localhost | |o . ..| 2025-12-29 20:31:56.281369 | debian-bookworm -> localhost | |.. | 2025-12-29 20:31:56.281390 | debian-bookworm -> localhost | | .+o | 2025-12-29 20:31:56.281410 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-29 20:31:56.281468 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.740921 2025-12-29 20:31:56.289594 | 2025-12-29 20:31:56.289724 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-29 20:31:56.329435 | debian-bookworm | ok 2025-12-29 20:31:56.343585 | debian-bookworm | included: /var/lib/zuul/builds/820d41bf8762459794462de09af31fa0/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-29 20:31:56.354047 | 2025-12-29 20:31:56.354215 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-29 20:31:56.399921 | debian-bookworm | skipping: Conditional result was False 2025-12-29 20:31:56.406517 | 2025-12-29 20:31:56.406650 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-29 20:31:57.082225 | debian-bookworm | changed 2025-12-29 20:31:57.097299 | 2025-12-29 20:31:57.097447 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-29 20:31:57.356955 | debian-bookworm | ok 2025-12-29 20:31:57.365654 | 2025-12-29 20:31:57.365789 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-29 20:31:58.046910 | debian-bookworm | changed 2025-12-29 20:31:58.054826 | 2025-12-29 20:31:58.054993 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-29 20:31:58.691580 | debian-bookworm | changed 2025-12-29 20:31:58.700104 | 2025-12-29 20:31:58.700252 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-29 20:31:58.725181 | debian-bookworm | skipping: Conditional result was False 2025-12-29 20:31:58.742451 | 2025-12-29 20:31:58.742637 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-29 20:31:59.306093 | debian-bookworm -> localhost | changed 2025-12-29 20:31:59.317539 | 2025-12-29 20:31:59.317680 | TASK [add-build-sshkey : Add back temp key] 2025-12-29 20:31:59.686649 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/820d41bf8762459794462de09af31fa0/work/820d41bf8762459794462de09af31fa0_id_rsa (zuul-build-sshkey) 2025-12-29 20:31:59.686956 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.029469 2025-12-29 20:31:59.698225 | 2025-12-29 20:31:59.698377 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-29 20:32:00.147519 | debian-bookworm | ok 2025-12-29 20:32:00.156968 | 2025-12-29 20:32:00.157210 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-29 20:32:00.181911 | debian-bookworm | skipping: Conditional result was False 2025-12-29 20:32:00.194379 | 2025-12-29 20:32:00.194523 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-29 20:32:00.629276 | debian-bookworm | ok 2025-12-29 20:32:00.653986 | 2025-12-29 20:32:00.654160 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-29 20:32:00.704660 | debian-bookworm | ok 2025-12-29 20:32:00.709979 | 2025-12-29 20:32:00.710125 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-29 20:32:01.012124 | debian-bookworm -> localhost | ok 2025-12-29 20:32:01.024173 | 2025-12-29 20:32:01.024331 | TASK [validate-host : Collect information about the host] 2025-12-29 20:32:02.153676 | debian-bookworm | ok 2025-12-29 20:32:02.168424 | 2025-12-29 20:32:02.168566 | TASK [validate-host : Sanitize hostname] 2025-12-29 20:32:02.306780 | debian-bookworm | ok 2025-12-29 20:32:02.355891 | 2025-12-29 20:32:02.356037 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-29 20:32:03.135731 | debian-bookworm -> localhost | changed 2025-12-29 20:32:03.142174 | 2025-12-29 20:32:03.142311 | TASK [validate-host : Collect information about zuul worker] 2025-12-29 20:32:03.609433 | debian-bookworm | ok 2025-12-29 20:32:03.614528 | 2025-12-29 20:32:03.614662 | TASK [validate-host : Write out all zuul information for each host] 2025-12-29 20:32:04.402245 | debian-bookworm -> localhost | changed 2025-12-29 20:32:04.413021 | 2025-12-29 20:32:04.413201 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-29 20:32:04.712133 | debian-bookworm | ok 2025-12-29 20:32:04.731686 | 2025-12-29 20:32:04.731892 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-29 20:32:05.687437 | debian-bookworm | changed: 2025-12-29 20:32:05.687814 | debian-bookworm | cd+++++++++ src/ 2025-12-29 20:32:05.687866 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-29 20:32:05.687892 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-29 20:32:05.687915 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2025-12-29 20:32:05.687935 | debian-bookworm | Containerfile 2025-12-29 20:32:05.688257 | debian-bookworm | localhost | ok: Runtime: 0:00:00.005508 2025-12-29 20:32:34.507598 | 2025-12-29 20:32:34.507727 | TASK [upload-logs : Upload logs to log server] 2025-12-29 20:32:35.641890 | localhost | Output suppressed because no_log was given 2025-12-29 20:32:35.643997 | 2025-12-29 20:32:35.644156 | LOOP [upload-logs : Compress console log and json output] 2025-12-29 20:32:35.736797 | localhost | skipping: Conditional result was False 2025-12-29 20:32:35.746562 | localhost | skipping: Conditional result was False 2025-12-29 20:32:35.751967 | 2025-12-29 20:32:35.752160 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-29 20:32:35.808900 | localhost | skipping: Conditional result was False 2025-12-29 20:32:35.809231 | 2025-12-29 20:32:35.828713 | localhost | skipping: Conditional result was False 2025-12-29 20:32:35.835867 | 2025-12-29 20:32:35.836066 | LOOP [upload-logs : Upload console log and json output]