2025-10-18 18:31:48.656297 | Job console starting 2025-10-18 18:31:48.680697 | Updating git repos 2025-10-18 18:31:48.800197 | Cloning repos into workspace 2025-10-18 18:31:48.871994 | Restoring repo states 2025-10-18 18:31:48.885250 | Merging changes 2025-10-18 18:31:49.483370 | Checking out repos 2025-10-18 18:31:49.548499 | Preparing playbooks 2025-10-18 18:31:50.616522 | Running Ansible setup 2025-10-18 18:31:57.257767 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-18 18:31:58.404847 | 2025-10-18 18:31:58.404988 | PLAY [Base pre] 2025-10-18 18:31:58.441654 | 2025-10-18 18:31:58.441789 | TASK [Setup log path fact] 2025-10-18 18:31:58.469742 | debian-bookworm | ok 2025-10-18 18:31:58.487967 | 2025-10-18 18:31:58.488088 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-18 18:31:58.516371 | debian-bookworm | ok 2025-10-18 18:31:58.526240 | 2025-10-18 18:31:58.526339 | TASK [emit-job-header : Print job information] 2025-10-18 18:31:58.564098 | # Job Information 2025-10-18 18:31:58.564253 | Ansible Version: 2.16.14 2025-10-18 18:31:58.564287 | Job: python-black 2025-10-18 18:31:58.564319 | Pipeline: check 2025-10-18 18:31:58.564343 | Executor: 521e9411259a 2025-10-18 18:31:58.564364 | Triggered by: https://github.com/osism/python-osism/pull/1731 2025-10-18 18:31:58.564387 | Event ID: afd37f40-ac50-11f0-9957-98d475b66d99 2025-10-18 18:31:58.569061 | 2025-10-18 18:31:58.569151 | LOOP [emit-job-header : Print node information] 2025-10-18 18:31:58.764730 | debian-bookworm | ok: 2025-10-18 18:31:58.764951 | debian-bookworm | # Node Information 2025-10-18 18:31:58.764984 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-18 18:31:58.765004 | debian-bookworm | Hostname: debian 2025-10-18 18:31:58.765022 | debian-bookworm | Username: zuul 2025-10-18 18:31:58.765039 | debian-bookworm | Distro: Debian 12.12 2025-10-18 18:31:58.765058 | debian-bookworm | Provider: regiocloud-a 2025-10-18 18:31:58.765076 | debian-bookworm | Region: 2025-10-18 18:31:58.765092 | debian-bookworm | Label: debian-bookworm 2025-10-18 18:31:58.765108 | debian-bookworm | Product Name: OpenStack Nova 2025-10-18 18:31:58.765124 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe4f:b932 2025-10-18 18:31:58.780780 | 2025-10-18 18:31:58.780898 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-18 18:31:59.399948 | debian-bookworm -> localhost | changed 2025-10-18 18:31:59.406645 | 2025-10-18 18:31:59.406744 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-18 18:32:00.815239 | debian-bookworm -> localhost | changed 2025-10-18 18:32:00.823659 | 2025-10-18 18:32:00.823738 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-18 18:32:01.259560 | debian-bookworm -> localhost | ok 2025-10-18 18:32:01.264354 | 2025-10-18 18:32:01.264431 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-18 18:32:01.310707 | debian-bookworm | ok 2025-10-18 18:32:01.329286 | debian-bookworm | included: /var/lib/zuul/builds/8a1116c7619a4b6c935ee0e865945a08/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-18 18:32:01.344180 | 2025-10-18 18:32:01.344255 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-18 18:32:03.359099 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-18 18:32:03.359301 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/8a1116c7619a4b6c935ee0e865945a08/work/8a1116c7619a4b6c935ee0e865945a08_id_rsa 2025-10-18 18:32:03.359342 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/8a1116c7619a4b6c935ee0e865945a08/work/8a1116c7619a4b6c935ee0e865945a08_id_rsa.pub 2025-10-18 18:32:03.359371 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-18 18:32:03.359394 | debian-bookworm -> localhost | SHA256:EXf+yLPDwVS4ZU1e5rNWCusWWd/OAU42Yf1lcjK6ync zuul-build-sshkey 2025-10-18 18:32:03.359415 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-18 18:32:03.359445 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-18 18:32:03.359468 | debian-bookworm -> localhost | | . . .+oo+| 2025-10-18 18:32:03.359489 | debian-bookworm -> localhost | | o oo.B=*| 2025-10-18 18:32:03.359509 | debian-bookworm -> localhost | | . +X.B*| 2025-10-18 18:32:03.359528 | debian-bookworm -> localhost | | . +*Boo*| 2025-10-18 18:32:03.359548 | debian-bookworm -> localhost | | S Xoo+o| 2025-10-18 18:32:03.359571 | debian-bookworm -> localhost | | o.=.o.| 2025-10-18 18:32:03.359591 | debian-bookworm -> localhost | | . .* o| 2025-10-18 18:32:03.359610 | debian-bookworm -> localhost | | o...E | 2025-10-18 18:32:03.359630 | debian-bookworm -> localhost | | . . | 2025-10-18 18:32:03.359649 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-18 18:32:03.359700 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.321940 2025-10-18 18:32:03.368037 | 2025-10-18 18:32:03.368129 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-18 18:32:03.386013 | debian-bookworm | ok 2025-10-18 18:32:03.395086 | debian-bookworm | included: /var/lib/zuul/builds/8a1116c7619a4b6c935ee0e865945a08/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-18 18:32:03.403634 | 2025-10-18 18:32:03.403718 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-18 18:32:03.416385 | debian-bookworm | skipping: Conditional result was False 2025-10-18 18:32:03.422058 | 2025-10-18 18:32:03.422141 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-18 18:32:03.983904 | debian-bookworm | changed 2025-10-18 18:32:03.988997 | 2025-10-18 18:32:03.989079 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-18 18:32:04.243088 | debian-bookworm | ok 2025-10-18 18:32:04.253466 | 2025-10-18 18:32:04.253599 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-18 18:32:04.856351 | debian-bookworm | changed 2025-10-18 18:32:04.862775 | 2025-10-18 18:32:04.862908 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-18 18:32:05.487938 | debian-bookworm | changed 2025-10-18 18:32:05.492227 | 2025-10-18 18:32:05.492300 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-18 18:32:05.535188 | debian-bookworm | skipping: Conditional result was False 2025-10-18 18:32:05.540365 | 2025-10-18 18:32:05.540449 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-18 18:32:06.146443 | debian-bookworm -> localhost | changed 2025-10-18 18:32:06.154933 | 2025-10-18 18:32:06.155025 | TASK [add-build-sshkey : Add back temp key] 2025-10-18 18:32:06.468337 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/8a1116c7619a4b6c935ee0e865945a08/work/8a1116c7619a4b6c935ee0e865945a08_id_rsa (zuul-build-sshkey) 2025-10-18 18:32:06.468542 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.014401 2025-10-18 18:32:06.475463 | 2025-10-18 18:32:06.475556 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-18 18:32:06.900718 | debian-bookworm | ok 2025-10-18 18:32:06.907432 | 2025-10-18 18:32:06.907534 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-18 18:32:06.930374 | debian-bookworm | skipping: Conditional result was False 2025-10-18 18:32:06.938643 | 2025-10-18 18:32:06.938732 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-18 18:32:07.350823 | debian-bookworm | ok 2025-10-18 18:32:07.359492 | 2025-10-18 18:32:07.359576 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-18 18:32:07.396100 | debian-bookworm | ok 2025-10-18 18:32:07.400017 | 2025-10-18 18:32:07.400086 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-18 18:32:07.836356 | debian-bookworm -> localhost | ok 2025-10-18 18:32:07.841361 | 2025-10-18 18:32:07.841439 | TASK [validate-host : Collect information about the host] 2025-10-18 18:32:08.956177 | debian-bookworm | ok 2025-10-18 18:32:08.968283 | 2025-10-18 18:32:08.968363 | TASK [validate-host : Sanitize hostname] 2025-10-18 18:32:09.062378 | debian-bookworm | ok 2025-10-18 18:32:09.112278 | 2025-10-18 18:32:09.112367 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-18 18:32:09.919340 | debian-bookworm -> localhost | changed 2025-10-18 18:32:09.926576 | 2025-10-18 18:32:09.926658 | TASK [validate-host : Collect information about zuul worker] 2025-10-18 18:32:10.469179 | debian-bookworm | ok 2025-10-18 18:32:10.472937 | 2025-10-18 18:32:10.473009 | TASK [validate-host : Write out all zuul information for each host] 2025-10-18 18:32:11.143129 | debian-bookworm -> localhost | changed 2025-10-18 18:32:11.154007 | 2025-10-18 18:32:11.154095 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-18 18:32:11.446558 | debian-bookworm | ok 2025-10-18 18:32:11.451564 | 2025-10-18 18:32:11.451649 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-18 18:32:12.565418 | debian-bookworm | changed: 2025-10-18 18:32:12.565554 | debian-bookworm | cd+++++++++ src/ 2025-10-18 18:32:12.565583 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-18 18:32:12.565603 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-18 18:32:12.565620 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-10-18 18:32:12.565637 | debian-bookworm | Containerfile 2025-10-18 18:32:12.565729 | debian-bookworm | Containerfile 2025-10-18 18:32:12.567689 | debian-bookworm | localhost | ok: Runtime: 0:00:00.004811 2025-10-18 18:32:38.886531 | 2025-10-18 18:32:38.886668 | TASK [upload-logs : Upload logs to log server] 2025-10-18 18:32:39.468623 | localhost | Output suppressed because no_log was given 2025-10-18 18:32:39.470491 | 2025-10-18 18:32:39.470597 | LOOP [upload-logs : Compress console log and json output] 2025-10-18 18:32:39.537435 | localhost | skipping: Conditional result was False 2025-10-18 18:32:39.551237 | localhost | skipping: Conditional result was False 2025-10-18 18:32:39.558115 | 2025-10-18 18:32:39.558223 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-18 18:32:39.632921 | localhost | skipping: Conditional result was False 2025-10-18 18:32:39.633651 | 2025-10-18 18:32:39.638405 | localhost | skipping: Conditional result was False 2025-10-18 18:32:39.650974 | 2025-10-18 18:32:39.651097 | LOOP [upload-logs : Upload console log and json output]