2025-10-14 17:49:38.803673 | Job console starting 2025-10-14 17:49:38.812429 | Updating git repos 2025-10-14 17:49:38.861538 | Cloning repos into workspace 2025-10-14 17:49:38.984212 | Restoring repo states 2025-10-14 17:49:39.004867 | Merging changes 2025-10-14 17:49:39.653114 | Checking out repos 2025-10-14 17:49:39.743749 | Preparing playbooks 2025-10-14 17:49:41.040998 | Running Ansible setup 2025-10-14 17:49:45.679242 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-14 17:49:46.436147 | 2025-10-14 17:49:46.436269 | PLAY [Base pre] 2025-10-14 17:49:46.450762 | 2025-10-14 17:49:46.450915 | TASK [Setup log path fact] 2025-10-14 17:49:46.469603 | debian-bookworm | ok 2025-10-14 17:49:46.483932 | 2025-10-14 17:49:46.484059 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-14 17:49:46.512583 | debian-bookworm | ok 2025-10-14 17:49:46.521721 | 2025-10-14 17:49:46.521806 | TASK [emit-job-header : Print job information] 2025-10-14 17:49:46.583714 | # Job Information 2025-10-14 17:49:46.583892 | Ansible Version: 2.16.14 2025-10-14 17:49:46.583929 | Job: python-black 2025-10-14 17:49:46.583963 | Pipeline: check 2025-10-14 17:49:46.583986 | Executor: 521e9411259a 2025-10-14 17:49:46.584006 | Triggered by: https://github.com/osism/openstack-image-manager/pull/958 2025-10-14 17:49:46.584029 | Event ID: 2213f4f0-a926-11f0-9726-cb2a2768e3fc 2025-10-14 17:49:46.609565 | 2025-10-14 17:49:46.609683 | LOOP [emit-job-header : Print node information] 2025-10-14 17:49:46.749094 | debian-bookworm | ok: 2025-10-14 17:49:46.749258 | debian-bookworm | # Node Information 2025-10-14 17:49:46.749293 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-14 17:49:46.749317 | debian-bookworm | Hostname: debian 2025-10-14 17:49:46.749339 | debian-bookworm | Username: zuul 2025-10-14 17:49:46.749360 | debian-bookworm | Distro: Debian 12.12 2025-10-14 17:49:46.749382 | debian-bookworm | Provider: regiocloud-a 2025-10-14 17:49:46.749403 | debian-bookworm | Region: 2025-10-14 17:49:46.749424 | debian-bookworm | Label: debian-bookworm 2025-10-14 17:49:46.749444 | debian-bookworm | Product Name: OpenStack Nova 2025-10-14 17:49:46.749463 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fedb:495a 2025-10-14 17:49:46.768425 | 2025-10-14 17:49:46.768530 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-14 17:49:47.305772 | debian-bookworm -> localhost | changed 2025-10-14 17:49:47.312425 | 2025-10-14 17:49:47.312527 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-14 17:49:48.290208 | debian-bookworm -> localhost | changed 2025-10-14 17:49:48.301047 | 2025-10-14 17:49:48.301141 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-14 17:49:48.567351 | debian-bookworm -> localhost | ok 2025-10-14 17:49:48.572126 | 2025-10-14 17:49:48.572211 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-14 17:49:48.608471 | debian-bookworm | ok 2025-10-14 17:49:48.631884 | debian-bookworm | included: /var/lib/zuul/builds/8ecab63f85fa4c2cab30ea68d7e3b10f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-14 17:49:48.636638 | 2025-10-14 17:49:48.636709 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-14 17:49:50.058652 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-14 17:49:50.058809 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/8ecab63f85fa4c2cab30ea68d7e3b10f/work/8ecab63f85fa4c2cab30ea68d7e3b10f_id_rsa 2025-10-14 17:49:50.058852 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/8ecab63f85fa4c2cab30ea68d7e3b10f/work/8ecab63f85fa4c2cab30ea68d7e3b10f_id_rsa.pub 2025-10-14 17:49:50.058899 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-14 17:49:50.058922 | debian-bookworm -> localhost | SHA256:cZJJIeEmHQxhGxVodcfrdPgwRcB81Jb1UUHheRbQL+M zuul-build-sshkey 2025-10-14 17:49:50.058941 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-14 17:49:50.058968 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-14 17:49:50.058986 | debian-bookworm -> localhost | | =BBo+=o+oo+O*| 2025-10-14 17:49:50.059004 | debian-bookworm -> localhost | | .o=.= ++ o =.=| 2025-10-14 17:49:50.059021 | debian-bookworm -> localhost | | .o + = .= . o=| 2025-10-14 17:49:50.059037 | debian-bookworm -> localhost | | o +* . o.o| 2025-10-14 17:49:50.059053 | debian-bookworm -> localhost | | So = . o | 2025-10-14 17:49:50.059074 | debian-bookworm -> localhost | | . . E | 2025-10-14 17:49:50.059090 | debian-bookworm -> localhost | | | 2025-10-14 17:49:50.059105 | debian-bookworm -> localhost | | | 2025-10-14 17:49:50.059123 | debian-bookworm -> localhost | | | 2025-10-14 17:49:50.059139 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-14 17:49:50.059181 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.919570 2025-10-14 17:49:50.064544 | 2025-10-14 17:49:50.064622 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-14 17:49:50.080696 | debian-bookworm | ok 2025-10-14 17:49:50.087999 | debian-bookworm | included: /var/lib/zuul/builds/8ecab63f85fa4c2cab30ea68d7e3b10f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-14 17:49:50.095000 | 2025-10-14 17:49:50.095069 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-14 17:49:50.107332 | debian-bookworm | skipping: Conditional result was False 2025-10-14 17:49:50.111860 | 2025-10-14 17:49:50.111941 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-14 17:49:50.738433 | debian-bookworm | changed 2025-10-14 17:49:50.744717 | 2025-10-14 17:49:50.744801 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-14 17:49:51.037864 | debian-bookworm | ok 2025-10-14 17:49:51.044251 | 2025-10-14 17:49:51.044352 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-14 17:49:51.690865 | debian-bookworm | changed 2025-10-14 17:49:51.705917 | 2025-10-14 17:49:51.706018 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-14 17:49:52.352646 | debian-bookworm | changed 2025-10-14 17:49:52.358018 | 2025-10-14 17:49:52.358102 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-14 17:49:52.392408 | debian-bookworm | skipping: Conditional result was False 2025-10-14 17:49:52.398373 | 2025-10-14 17:49:52.398459 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-14 17:49:52.956365 | debian-bookworm -> localhost | changed 2025-10-14 17:49:52.974687 | 2025-10-14 17:49:52.974787 | TASK [add-build-sshkey : Add back temp key] 2025-10-14 17:49:53.518355 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/8ecab63f85fa4c2cab30ea68d7e3b10f/work/8ecab63f85fa4c2cab30ea68d7e3b10f_id_rsa (zuul-build-sshkey) 2025-10-14 17:49:53.518582 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011244 2025-10-14 17:49:53.526450 | 2025-10-14 17:49:53.526553 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-14 17:49:53.909135 | debian-bookworm | ok 2025-10-14 17:49:53.922450 | 2025-10-14 17:49:53.922614 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-14 17:49:53.947285 | debian-bookworm | skipping: Conditional result was False 2025-10-14 17:49:53.972340 | 2025-10-14 17:49:53.972530 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-14 17:49:54.409108 | debian-bookworm | ok 2025-10-14 17:49:54.431530 | 2025-10-14 17:49:54.432015 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-14 17:49:54.485717 | debian-bookworm | ok 2025-10-14 17:49:54.496541 | 2025-10-14 17:49:54.496862 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-14 17:49:54.910967 | debian-bookworm -> localhost | ok 2025-10-14 17:49:54.922433 | 2025-10-14 17:49:54.922539 | TASK [validate-host : Collect information about the host] 2025-10-14 17:49:56.101183 | debian-bookworm | ok 2025-10-14 17:49:56.111495 | 2025-10-14 17:49:56.111606 | TASK [validate-host : Sanitize hostname] 2025-10-14 17:49:56.223724 | debian-bookworm | ok 2025-10-14 17:49:56.264725 | 2025-10-14 17:49:56.264855 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-14 17:49:57.028157 | debian-bookworm -> localhost | changed 2025-10-14 17:49:57.034328 | 2025-10-14 17:49:57.034442 | TASK [validate-host : Collect information about zuul worker] 2025-10-14 17:49:57.487736 | debian-bookworm | ok 2025-10-14 17:49:57.496478 | 2025-10-14 17:49:57.496655 | TASK [validate-host : Write out all zuul information for each host] 2025-10-14 17:49:58.111005 | debian-bookworm -> localhost | changed 2025-10-14 17:49:58.134065 | 2025-10-14 17:49:58.134315 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-14 17:49:58.422033 | debian-bookworm | ok 2025-10-14 17:49:58.435836 | 2025-10-14 17:49:58.436008 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-14 17:49:59.926811 | debian-bookworm | changed: 2025-10-14 17:49:59.929107 | debian-bookworm | cd+++++++++ src/ 2025-10-14 17:49:59.929493 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-14 17:49:59.930722 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-14 17:49:59.931174 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-10-14 17:49:59.931840 | debian-bookworm | localhost | ok: Runtime: 0:00:00.018710 2025-10-14 17:50:27.088549 | 2025-10-14 17:50:27.088668 | TASK [upload-logs : Upload logs to log server] 2025-10-14 17:50:27.761291 | localhost | Output suppressed because no_log was given 2025-10-14 17:50:27.764798 | 2025-10-14 17:50:27.764948 | LOOP [upload-logs : Compress console log and json output] 2025-10-14 17:50:27.820852 | localhost | skipping: Conditional result was False 2025-10-14 17:50:27.829227 | localhost | skipping: Conditional result was False 2025-10-14 17:50:27.843567 | 2025-10-14 17:50:27.843778 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-14 17:50:27.900924 | localhost | skipping: Conditional result was False 2025-10-14 17:50:27.901255 | 2025-10-14 17:50:27.908301 | localhost | skipping: Conditional result was False 2025-10-14 17:50:27.918716 | 2025-10-14 17:50:27.919028 | LOOP [upload-logs : Upload console log and json output]