2025-11-10 14:05:51.056699 | Job console starting 2025-11-10 14:05:51.076695 | Updating git repos 2025-11-10 14:05:51.163651 | Cloning repos into workspace 2025-11-10 14:05:51.252888 | Restoring repo states 2025-11-10 14:05:51.274018 | Merging changes 2025-11-10 14:05:52.004874 | Checking out repos 2025-11-10 14:05:52.099685 | Preparing playbooks 2025-11-10 14:05:53.420206 | Running Ansible setup 2025-11-10 14:05:59.457827 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-10 14:06:00.706384 | 2025-11-10 14:06:00.706503 | PLAY [Base pre] 2025-11-10 14:06:00.738416 | 2025-11-10 14:06:00.738535 | TASK [Setup log path fact] 2025-11-10 14:06:00.766405 | debian-bookworm | ok 2025-11-10 14:06:00.788595 | 2025-11-10 14:06:00.788737 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-10 14:06:00.818785 | debian-bookworm | ok 2025-11-10 14:06:00.828809 | 2025-11-10 14:06:00.828911 | TASK [emit-job-header : Print job information] 2025-11-10 14:06:00.891866 | # Job Information 2025-11-10 14:06:00.892087 | Ansible Version: 2.16.14 2025-11-10 14:06:00.892126 | Job: python-black 2025-11-10 14:06:00.892161 | Pipeline: check 2025-11-10 14:06:00.892189 | Executor: 521e9411259a 2025-11-10 14:06:00.892210 | Triggered by: https://github.com/osism/python-osism/pull/1810 2025-11-10 14:06:00.892232 | Event ID: 581b4f80-be3e-11f0-829e-34016bcf8f46 2025-11-10 14:06:00.898677 | 2025-11-10 14:06:00.898788 | LOOP [emit-job-header : Print node information] 2025-11-10 14:06:01.022009 | debian-bookworm | ok: 2025-11-10 14:06:01.022178 | debian-bookworm | # Node Information 2025-11-10 14:06:01.022213 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-10 14:06:01.022240 | debian-bookworm | Hostname: debian 2025-11-10 14:06:01.022262 | debian-bookworm | Username: zuul 2025-11-10 14:06:01.022282 | debian-bookworm | Distro: Debian 12.12 2025-11-10 14:06:01.022308 | debian-bookworm | Provider: regiocloud-a 2025-11-10 14:06:01.022329 | debian-bookworm | Region: 2025-11-10 14:06:01.022350 | debian-bookworm | Label: debian-bookworm 2025-11-10 14:06:01.022370 | debian-bookworm | Product Name: OpenStack Nova 2025-11-10 14:06:01.022390 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fec3:b753 2025-11-10 14:06:01.035337 | 2025-11-10 14:06:01.035453 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-10 14:06:01.827133 | debian-bookworm -> localhost | changed 2025-11-10 14:06:01.833904 | 2025-11-10 14:06:01.834013 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-10 14:06:03.123358 | debian-bookworm -> localhost | changed 2025-11-10 14:06:03.131878 | 2025-11-10 14:06:03.131963 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-10 14:06:03.466786 | debian-bookworm -> localhost | ok 2025-11-10 14:06:03.472592 | 2025-11-10 14:06:03.472695 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-10 14:06:03.500204 | debian-bookworm | ok 2025-11-10 14:06:03.540199 | debian-bookworm | included: /var/lib/zuul/builds/0ac49e5aa7f24dbe8354abe4a3564638/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-10 14:06:03.553476 | 2025-11-10 14:06:03.553630 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-10 14:06:05.601657 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-10 14:06:05.601852 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/0ac49e5aa7f24dbe8354abe4a3564638/work/0ac49e5aa7f24dbe8354abe4a3564638_id_rsa 2025-11-10 14:06:05.601892 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/0ac49e5aa7f24dbe8354abe4a3564638/work/0ac49e5aa7f24dbe8354abe4a3564638_id_rsa.pub 2025-11-10 14:06:05.601919 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-10 14:06:05.601945 | debian-bookworm -> localhost | SHA256:YRW/Dg1BS9BRBUud5GdwZTifAnmBlOxSjMyUPbNnsIM zuul-build-sshkey 2025-11-10 14:06:05.601968 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-10 14:06:05.601999 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-10 14:06:05.602020 | debian-bookworm -> localhost | | ==#=B*=o=| 2025-11-10 14:06:05.602041 | debian-bookworm -> localhost | | B.^ +=+ | 2025-11-10 14:06:05.602062 | debian-bookworm -> localhost | | o * @ .o+| 2025-11-10 14:06:05.602081 | debian-bookworm -> localhost | | . E B = +.| 2025-11-10 14:06:05.602101 | debian-bookworm -> localhost | | S o * . | 2025-11-10 14:06:05.602122 | debian-bookworm -> localhost | | o | 2025-11-10 14:06:05.602157 | debian-bookworm -> localhost | | . | 2025-11-10 14:06:05.602177 | debian-bookworm -> localhost | | | 2025-11-10 14:06:05.602198 | debian-bookworm -> localhost | | | 2025-11-10 14:06:05.602218 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-10 14:06:05.602265 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.387569 2025-11-10 14:06:05.608333 | 2025-11-10 14:06:05.608420 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-10 14:06:05.625266 | debian-bookworm | ok 2025-11-10 14:06:05.633909 | debian-bookworm | included: /var/lib/zuul/builds/0ac49e5aa7f24dbe8354abe4a3564638/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-10 14:06:05.642349 | 2025-11-10 14:06:05.642423 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-10 14:06:05.668389 | debian-bookworm | skipping: Conditional result was False 2025-11-10 14:06:05.673692 | 2025-11-10 14:06:05.673770 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-10 14:06:06.327643 | debian-bookworm | changed 2025-11-10 14:06:06.332759 | 2025-11-10 14:06:06.332841 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-10 14:06:06.597157 | debian-bookworm | ok 2025-11-10 14:06:06.604614 | 2025-11-10 14:06:06.604720 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-10 14:06:07.222622 | debian-bookworm | changed 2025-11-10 14:06:07.229036 | 2025-11-10 14:06:07.229122 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-10 14:06:07.889636 | debian-bookworm | changed 2025-11-10 14:06:07.908685 | 2025-11-10 14:06:07.908794 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-10 14:06:07.942320 | debian-bookworm | skipping: Conditional result was False 2025-11-10 14:06:07.948183 | 2025-11-10 14:06:07.948277 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-10 14:06:08.673583 | debian-bookworm -> localhost | changed 2025-11-10 14:06:08.685136 | 2025-11-10 14:06:08.685245 | TASK [add-build-sshkey : Add back temp key] 2025-11-10 14:06:09.003319 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/0ac49e5aa7f24dbe8354abe4a3564638/work/0ac49e5aa7f24dbe8354abe4a3564638_id_rsa (zuul-build-sshkey) 2025-11-10 14:06:09.003507 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.039088 2025-11-10 14:06:09.009820 | 2025-11-10 14:06:09.009904 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-10 14:06:09.420961 | debian-bookworm | ok 2025-11-10 14:06:09.426874 | 2025-11-10 14:06:09.426979 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-10 14:06:09.449807 | debian-bookworm | skipping: Conditional result was False 2025-11-10 14:06:09.459784 | 2025-11-10 14:06:09.459884 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-10 14:06:09.924297 | debian-bookworm | ok 2025-11-10 14:06:09.934262 | 2025-11-10 14:06:09.934362 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-10 14:06:09.962462 | debian-bookworm | ok 2025-11-10 14:06:09.967198 | 2025-11-10 14:06:09.967283 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-10 14:06:10.235948 | debian-bookworm -> localhost | ok 2025-11-10 14:06:10.246327 | 2025-11-10 14:06:10.246426 | TASK [validate-host : Collect information about the host] 2025-11-10 14:06:11.319969 | debian-bookworm | ok 2025-11-10 14:06:11.339205 | 2025-11-10 14:06:11.339309 | TASK [validate-host : Sanitize hostname] 2025-11-10 14:06:11.427788 | debian-bookworm | ok 2025-11-10 14:06:11.455672 | 2025-11-10 14:06:11.455765 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-10 14:06:12.192040 | debian-bookworm -> localhost | changed 2025-11-10 14:06:12.197535 | 2025-11-10 14:06:12.197637 | TASK [validate-host : Collect information about zuul worker] 2025-11-10 14:06:12.591923 | debian-bookworm | ok 2025-11-10 14:06:12.597181 | 2025-11-10 14:06:12.597270 | TASK [validate-host : Write out all zuul information for each host] 2025-11-10 14:06:13.087586 | debian-bookworm -> localhost | changed 2025-11-10 14:06:13.100693 | 2025-11-10 14:06:13.100790 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-10 14:06:13.387328 | debian-bookworm | ok 2025-11-10 14:06:13.392821 | 2025-11-10 14:06:13.392920 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-10 14:06:14.485879 | debian-bookworm | changed: 2025-11-10 14:06:14.486060 | debian-bookworm | cd+++++++++ src/ 2025-11-10 14:06:14.486095 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-10 14:06:14.486119 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-10 14:06:14.486140 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-11-10 14:06:14.486160 | debian-bookworm | Containerfile 2025-11-10 14:06:14.486290 | debian-bookworm | Containerfile 2025-11-10 14:06:14.507994 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007464 2025-11-10 14:06:41.772127 | 2025-11-10 14:06:41.772270 | TASK [upload-logs : Upload logs to log server] 2025-11-10 14:06:42.337963 | localhost | Output suppressed because no_log was given 2025-11-10 14:06:42.341701 | 2025-11-10 14:06:42.341881 | LOOP [upload-logs : Compress console log and json output] 2025-11-10 14:06:42.393373 | localhost | skipping: Conditional result was False 2025-11-10 14:06:42.398813 | localhost | skipping: Conditional result was False 2025-11-10 14:06:42.413879 | 2025-11-10 14:06:42.414067 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-10 14:06:42.484847 | localhost | skipping: Conditional result was False 2025-11-10 14:06:42.485213 | 2025-11-10 14:06:42.492959 | localhost | skipping: Conditional result was False 2025-11-10 14:06:42.505278 | 2025-11-10 14:06:42.505498 | LOOP [upload-logs : Upload console log and json output]