2025-08-26 20:39:25.837662 | Job console starting 2025-08-26 20:39:25.868513 | Updating git repos 2025-08-26 20:39:25.915664 | Cloning repos into workspace 2025-08-26 20:39:25.966812 | Restoring repo states 2025-08-26 20:39:25.990356 | Merging changes 2025-08-26 20:39:26.779084 | Checking out repos 2025-08-26 20:39:26.809467 | Preparing playbooks 2025-08-26 20:39:27.816905 | Running Ansible setup 2025-08-26 20:39:32.717684 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-08-26 20:39:33.878206 | 2025-08-26 20:39:33.878330 | PLAY [Base pre] 2025-08-26 20:39:33.901372 | 2025-08-26 20:39:33.901527 | TASK [Setup log path fact] 2025-08-26 20:39:33.939934 | debian-bookworm | ok 2025-08-26 20:39:33.969585 | 2025-08-26 20:39:33.969753 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-26 20:39:34.026484 | debian-bookworm | ok 2025-08-26 20:39:34.043066 | 2025-08-26 20:39:34.043173 | TASK [emit-job-header : Print job information] 2025-08-26 20:39:34.097457 | # Job Information 2025-08-26 20:39:34.097608 | Ansible Version: 2.16.14 2025-08-26 20:39:34.097642 | Job: python-black 2025-08-26 20:39:34.097674 | Pipeline: check 2025-08-26 20:39:34.097696 | Executor: 521e9411259a 2025-08-26 20:39:34.097716 | Triggered by: https://github.com/osism/openstack-image-manager/pull/943 2025-08-26 20:39:34.097755 | Event ID: 92580570-82bc-11f0-96ef-96b49153990a 2025-08-26 20:39:34.102673 | 2025-08-26 20:39:34.102779 | LOOP [emit-job-header : Print node information] 2025-08-26 20:39:34.227830 | debian-bookworm | ok: 2025-08-26 20:39:34.228018 | debian-bookworm | # Node Information 2025-08-26 20:39:34.228051 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-08-26 20:39:34.228076 | debian-bookworm | Hostname: debian 2025-08-26 20:39:34.228098 | debian-bookworm | Username: zuul 2025-08-26 20:39:34.228118 | debian-bookworm | Distro: Debian 12.11 2025-08-26 20:39:34.228142 | debian-bookworm | Provider: regiocloud-a 2025-08-26 20:39:34.228163 | debian-bookworm | Region: 2025-08-26 20:39:34.228184 | debian-bookworm | Label: debian-bookworm 2025-08-26 20:39:34.228204 | debian-bookworm | Product Name: OpenStack Nova 2025-08-26 20:39:34.228223 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe3a:e77 2025-08-26 20:39:34.247410 | 2025-08-26 20:39:34.247522 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-08-26 20:39:35.448109 | debian-bookworm -> localhost | changed 2025-08-26 20:39:35.471946 | 2025-08-26 20:39:35.472058 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-08-26 20:39:36.679084 | debian-bookworm -> localhost | changed 2025-08-26 20:39:36.689316 | 2025-08-26 20:39:36.689416 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-08-26 20:39:37.106621 | debian-bookworm -> localhost | ok 2025-08-26 20:39:37.112632 | 2025-08-26 20:39:37.112762 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-08-26 20:39:37.131811 | debian-bookworm | ok 2025-08-26 20:39:37.150770 | debian-bookworm | included: /var/lib/zuul/builds/44ab06a18c874ab8a4f2709f915d0246/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-08-26 20:39:37.156425 | 2025-08-26 20:39:37.156510 | TASK [add-build-sshkey : Create Temp SSH key] 2025-08-26 20:39:38.499857 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-08-26 20:39:38.500045 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/44ab06a18c874ab8a4f2709f915d0246/work/44ab06a18c874ab8a4f2709f915d0246_id_rsa 2025-08-26 20:39:38.500084 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/44ab06a18c874ab8a4f2709f915d0246/work/44ab06a18c874ab8a4f2709f915d0246_id_rsa.pub 2025-08-26 20:39:38.500112 | debian-bookworm -> localhost | The key fingerprint is: 2025-08-26 20:39:38.500138 | debian-bookworm -> localhost | SHA256:sXTwgrOVg62gtPXpd8sS+REhraBFLiz6nXYil6AhMEc zuul-build-sshkey 2025-08-26 20:39:38.500161 | debian-bookworm -> localhost | The key's randomart image is: 2025-08-26 20:39:38.500193 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-08-26 20:39:38.500215 | debian-bookworm -> localhost | | E .. .. | 2025-08-26 20:39:38.500237 | debian-bookworm -> localhost | | . . .o+.+o | 2025-08-26 20:39:38.500258 | debian-bookworm -> localhost | |o + =o=.Ooo. | 2025-08-26 20:39:38.500277 | debian-bookworm -> localhost | |.= =.+ B.*. | 2025-08-26 20:39:38.500297 | debian-bookworm -> localhost | |+ + = S. . | 2025-08-26 20:39:38.500323 | debian-bookworm -> localhost | |.+ o + o . | 2025-08-26 20:39:38.500344 | debian-bookworm -> localhost | |. o B o .o.. | 2025-08-26 20:39:38.500364 | debian-bookworm -> localhost | | + o ..o.. | 2025-08-26 20:39:38.500385 | debian-bookworm -> localhost | | .o | 2025-08-26 20:39:38.500406 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-08-26 20:39:38.500454 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.861766 2025-08-26 20:39:38.515920 | 2025-08-26 20:39:38.516023 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-08-26 20:39:38.545280 | debian-bookworm | ok 2025-08-26 20:39:38.564001 | debian-bookworm | included: /var/lib/zuul/builds/44ab06a18c874ab8a4f2709f915d0246/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-08-26 20:39:38.571254 | 2025-08-26 20:39:38.571378 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-08-26 20:39:38.585123 | debian-bookworm | skipping: Conditional result was False 2025-08-26 20:39:38.590938 | 2025-08-26 20:39:38.591036 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-08-26 20:39:39.224628 | debian-bookworm | changed 2025-08-26 20:39:39.228882 | 2025-08-26 20:39:39.228955 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-08-26 20:39:39.471013 | debian-bookworm | ok 2025-08-26 20:39:39.483602 | 2025-08-26 20:39:39.483693 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-08-26 20:39:40.074477 | debian-bookworm | changed 2025-08-26 20:39:40.082160 | 2025-08-26 20:39:40.082267 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-08-26 20:39:40.786081 | debian-bookworm | changed 2025-08-26 20:39:40.798633 | 2025-08-26 20:39:40.798762 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-08-26 20:39:40.839583 | debian-bookworm | skipping: Conditional result was False 2025-08-26 20:39:40.846766 | 2025-08-26 20:39:40.846883 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-08-26 20:39:41.429650 | debian-bookworm -> localhost | changed 2025-08-26 20:39:41.443242 | 2025-08-26 20:39:41.443424 | TASK [add-build-sshkey : Add back temp key] 2025-08-26 20:39:41.846375 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/44ab06a18c874ab8a4f2709f915d0246/work/44ab06a18c874ab8a4f2709f915d0246_id_rsa (zuul-build-sshkey) 2025-08-26 20:39:41.846613 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011296 2025-08-26 20:39:41.853487 | 2025-08-26 20:39:41.853577 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-08-26 20:39:42.228981 | debian-bookworm | ok 2025-08-26 20:39:42.233807 | 2025-08-26 20:39:42.233898 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-08-26 20:39:42.256805 | debian-bookworm | skipping: Conditional result was False 2025-08-26 20:39:42.266532 | 2025-08-26 20:39:42.266620 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-08-26 20:39:42.628343 | debian-bookworm | ok 2025-08-26 20:39:42.641397 | 2025-08-26 20:39:42.641495 | TASK [validate-host : Define zuul_info_dir fact] 2025-08-26 20:39:42.684146 | debian-bookworm | ok 2025-08-26 20:39:42.688989 | 2025-08-26 20:39:42.689071 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-08-26 20:39:43.036041 | debian-bookworm -> localhost | ok 2025-08-26 20:39:43.042459 | 2025-08-26 20:39:43.042550 | TASK [validate-host : Collect information about the host] 2025-08-26 20:39:44.036568 | debian-bookworm | ok 2025-08-26 20:39:44.056620 | 2025-08-26 20:39:44.056742 | TASK [validate-host : Sanitize hostname] 2025-08-26 20:39:44.166567 | debian-bookworm | ok 2025-08-26 20:39:44.199867 | 2025-08-26 20:39:44.199973 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-08-26 20:39:44.777427 | debian-bookworm -> localhost | changed 2025-08-26 20:39:44.783283 | 2025-08-26 20:39:44.783371 | TASK [validate-host : Collect information about zuul worker] 2025-08-26 20:39:45.193914 | debian-bookworm | ok 2025-08-26 20:39:45.198291 | 2025-08-26 20:39:45.198386 | TASK [validate-host : Write out all zuul information for each host] 2025-08-26 20:39:45.837799 | debian-bookworm -> localhost | changed 2025-08-26 20:39:45.847054 | 2025-08-26 20:39:45.847156 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-08-26 20:39:46.086278 | debian-bookworm | ok 2025-08-26 20:39:46.091674 | 2025-08-26 20:39:46.091798 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-08-26 20:39:47.015559 | debian-bookworm | changed: 2025-08-26 20:39:47.015905 | debian-bookworm | cd+++++++++ src/ 2025-08-26 20:39:47.015948 | debian-bookworm | cd+++++++++ src/github.com/ 2025-08-26 20:39:47.015973 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-08-26 20:39:47.015996 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-08-26 20:39:47.016018 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007768 2025-08-26 20:40:12.269649 | 2025-08-26 20:40:12.269899 | TASK [upload-logs : Upload logs to log server] 2025-08-26 20:40:12.845160 | localhost | Output suppressed because no_log was given 2025-08-26 20:40:12.847083 | 2025-08-26 20:40:12.847191 | LOOP [upload-logs : Compress console log and json output] 2025-08-26 20:40:12.892316 | localhost | skipping: Conditional result was False 2025-08-26 20:40:12.898123 | localhost | skipping: Conditional result was False 2025-08-26 20:40:12.905295 | 2025-08-26 20:40:12.905395 | LOOP [upload-logs : Upload compressed console log and json output] 2025-08-26 20:40:12.950040 | localhost | skipping: Conditional result was False 2025-08-26 20:40:12.950742 | 2025-08-26 20:40:12.954006 | localhost | skipping: Conditional result was False 2025-08-26 20:40:12.968869 | 2025-08-26 20:40:12.969157 | LOOP [upload-logs : Upload console log and json output]