2025-11-15 19:52:59.594016 | Job console starting 2025-11-15 19:52:59.624564 | Updating git repos 2025-11-15 19:52:59.677306 | Cloning repos into workspace 2025-11-15 19:52:59.775612 | Restoring repo states 2025-11-15 19:52:59.810269 | Merging changes 2025-11-15 19:53:00.568787 | Checking out repos 2025-11-15 19:53:00.648210 | Preparing playbooks 2025-11-15 19:53:01.792245 | Running Ansible setup 2025-11-15 19:53:07.818483 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-15 19:53:09.169541 | 2025-11-15 19:53:09.169743 | PLAY [Base pre] 2025-11-15 19:53:09.212049 | 2025-11-15 19:53:09.212227 | TASK [Setup log path fact] 2025-11-15 19:53:09.253688 | debian-bookworm | ok 2025-11-15 19:53:09.295225 | 2025-11-15 19:53:09.295423 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-15 19:53:09.357020 | debian-bookworm | ok 2025-11-15 19:53:09.377683 | 2025-11-15 19:53:09.377822 | TASK [emit-job-header : Print job information] 2025-11-15 19:53:09.438257 | # Job Information 2025-11-15 19:53:09.438444 | Ansible Version: 2.16.14 2025-11-15 19:53:09.438480 | Job: python-black 2025-11-15 19:53:09.438513 | Pipeline: check 2025-11-15 19:53:09.438536 | Executor: 521e9411259a 2025-11-15 19:53:09.438556 | Triggered by: https://github.com/osism/python-osism/pull/1731 2025-11-15 19:53:09.438579 | Event ID: ab35b990-c25c-11f0-9e1b-5ff1edabdbf9 2025-11-15 19:53:09.445548 | 2025-11-15 19:53:09.445711 | LOOP [emit-job-header : Print node information] 2025-11-15 19:53:09.650955 | debian-bookworm | ok: 2025-11-15 19:53:09.651157 | debian-bookworm | # Node Information 2025-11-15 19:53:09.651192 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-15 19:53:09.651218 | debian-bookworm | Hostname: debian 2025-11-15 19:53:09.651240 | debian-bookworm | Username: zuul 2025-11-15 19:53:09.651262 | debian-bookworm | Distro: Debian 12.12 2025-11-15 19:53:09.651287 | debian-bookworm | Provider: regiocloud-a 2025-11-15 19:53:09.651307 | debian-bookworm | Region: 2025-11-15 19:53:09.651328 | debian-bookworm | Label: debian-bookworm 2025-11-15 19:53:09.651347 | debian-bookworm | Product Name: OpenStack Nova 2025-11-15 19:53:09.651366 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe6e:1334 2025-11-15 19:53:09.669817 | 2025-11-15 19:53:09.669960 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-15 19:53:10.505707 | debian-bookworm -> localhost | changed 2025-11-15 19:53:10.512437 | 2025-11-15 19:53:10.512537 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-15 19:53:12.083670 | debian-bookworm -> localhost | changed 2025-11-15 19:53:12.094286 | 2025-11-15 19:53:12.094387 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-15 19:53:12.447314 | debian-bookworm -> localhost | ok 2025-11-15 19:53:12.453222 | 2025-11-15 19:53:12.453323 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-15 19:53:12.501327 | debian-bookworm | ok 2025-11-15 19:53:12.520366 | debian-bookworm | included: /var/lib/zuul/builds/769746c1b713495fba98af0233484566/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-15 19:53:12.540777 | 2025-11-15 19:53:12.540886 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-15 19:53:15.374307 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-15 19:53:15.374561 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/769746c1b713495fba98af0233484566/work/769746c1b713495fba98af0233484566_id_rsa 2025-11-15 19:53:15.374609 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/769746c1b713495fba98af0233484566/work/769746c1b713495fba98af0233484566_id_rsa.pub 2025-11-15 19:53:15.374725 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-15 19:53:15.374771 | debian-bookworm -> localhost | SHA256:nGjwewoVqV3/8UiqfCyJzsfNzZxTI1Mwc+xxB29GKcI zuul-build-sshkey 2025-11-15 19:53:15.374803 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-15 19:53:15.374855 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-15 19:53:15.374885 | debian-bookworm -> localhost | | . ...o| 2025-11-15 19:53:15.374912 | debian-bookworm -> localhost | | . E+.++o| 2025-11-15 19:53:15.374937 | debian-bookworm -> localhost | | . o . .*.o=| 2025-11-15 19:53:15.374962 | debian-bookworm -> localhost | | = = o oo | 2025-11-15 19:53:15.374988 | debian-bookworm -> localhost | | . * S . o. | 2025-11-15 19:53:15.375023 | debian-bookworm -> localhost | | o . +o+o | 2025-11-15 19:53:15.375049 | debian-bookworm -> localhost | | . .o.=.+o=.. | 2025-11-15 19:53:15.375075 | debian-bookworm -> localhost | | o.+=.= * | 2025-11-15 19:53:15.375101 | debian-bookworm -> localhost | | .+.oo . | 2025-11-15 19:53:15.375126 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-15 19:53:15.375184 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.937709 2025-11-15 19:53:15.382166 | 2025-11-15 19:53:15.382274 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-15 19:53:15.410552 | debian-bookworm | ok 2025-11-15 19:53:15.419683 | debian-bookworm | included: /var/lib/zuul/builds/769746c1b713495fba98af0233484566/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-15 19:53:15.428330 | 2025-11-15 19:53:15.428415 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-15 19:53:15.451472 | debian-bookworm | skipping: Conditional result was False 2025-11-15 19:53:15.457519 | 2025-11-15 19:53:15.457606 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-15 19:53:16.074247 | debian-bookworm | changed 2025-11-15 19:53:16.081862 | 2025-11-15 19:53:16.081965 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-15 19:53:16.404364 | debian-bookworm | ok 2025-11-15 19:53:16.409867 | 2025-11-15 19:53:16.409962 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-15 19:53:17.068442 | debian-bookworm | changed 2025-11-15 19:53:17.075040 | 2025-11-15 19:53:17.075134 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-15 19:53:17.763736 | debian-bookworm | changed 2025-11-15 19:53:17.769059 | 2025-11-15 19:53:17.769159 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-15 19:53:17.792055 | debian-bookworm | skipping: Conditional result was False 2025-11-15 19:53:17.798920 | 2025-11-15 19:53:17.799023 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-15 19:53:18.460218 | debian-bookworm -> localhost | changed 2025-11-15 19:53:18.477436 | 2025-11-15 19:53:18.477589 | TASK [add-build-sshkey : Add back temp key] 2025-11-15 19:53:19.003587 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/769746c1b713495fba98af0233484566/work/769746c1b713495fba98af0233484566_id_rsa (zuul-build-sshkey) 2025-11-15 19:53:19.003880 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.012783 2025-11-15 19:53:19.012348 | 2025-11-15 19:53:19.012482 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-15 19:53:19.691072 | debian-bookworm | ok 2025-11-15 19:53:19.705726 | 2025-11-15 19:53:19.705866 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-15 19:53:19.765678 | debian-bookworm | skipping: Conditional result was False 2025-11-15 19:53:19.787727 | 2025-11-15 19:53:19.787864 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-15 19:53:20.262720 | debian-bookworm | ok 2025-11-15 19:53:20.286295 | 2025-11-15 19:53:20.286429 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-15 19:53:20.320302 | debian-bookworm | ok 2025-11-15 19:53:20.325476 | 2025-11-15 19:53:20.325583 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-15 19:53:20.674725 | debian-bookworm -> localhost | ok 2025-11-15 19:53:20.685154 | 2025-11-15 19:53:20.685297 | TASK [validate-host : Collect information about the host] 2025-11-15 19:53:21.957237 | debian-bookworm | ok 2025-11-15 19:53:21.976155 | 2025-11-15 19:53:21.976305 | TASK [validate-host : Sanitize hostname] 2025-11-15 19:53:22.130767 | debian-bookworm | ok 2025-11-15 19:53:22.196616 | 2025-11-15 19:53:22.196775 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-15 19:53:23.094414 | debian-bookworm -> localhost | changed 2025-11-15 19:53:23.100877 | 2025-11-15 19:53:23.101011 | TASK [validate-host : Collect information about zuul worker] 2025-11-15 19:53:23.606622 | debian-bookworm | ok 2025-11-15 19:53:23.611509 | 2025-11-15 19:53:23.611621 | TASK [validate-host : Write out all zuul information for each host] 2025-11-15 19:53:24.406111 | debian-bookworm -> localhost | changed 2025-11-15 19:53:24.418227 | 2025-11-15 19:53:24.418360 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-15 19:53:24.739876 | debian-bookworm | ok 2025-11-15 19:53:24.746545 | 2025-11-15 19:53:24.746762 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-15 19:53:26.032892 | debian-bookworm | changed: 2025-11-15 19:53:26.033103 | debian-bookworm | cd+++++++++ src/ 2025-11-15 19:53:26.033137 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-15 19:53:26.033161 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-15 19:53:26.033182 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-11-15 19:53:26.033202 | debian-bookworm | Containerfile 2025-11-15 19:53:26.034989 | debian-bookworm | Containerfile 2025-11-15 19:53:26.088540 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006961 2025-11-15 19:53:54.467820 | 2025-11-15 19:53:54.468045 | TASK [upload-logs : Upload logs to log server] 2025-11-15 19:53:55.033939 | localhost | Output suppressed because no_log was given 2025-11-15 19:53:55.037385 | 2025-11-15 19:53:55.037511 | LOOP [upload-logs : Compress console log and json output] 2025-11-15 19:53:55.102316 | localhost | skipping: Conditional result was False 2025-11-15 19:53:55.108022 | localhost | skipping: Conditional result was False 2025-11-15 19:53:55.119482 | 2025-11-15 19:53:55.119804 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-15 19:53:55.168005 | localhost | skipping: Conditional result was False 2025-11-15 19:53:55.168495 | 2025-11-15 19:53:55.172814 | localhost | skipping: Conditional result was False 2025-11-15 19:53:55.178181 | 2025-11-15 19:53:55.178296 | LOOP [upload-logs : Upload console log and json output]