2026-01-07 18:30:44.086567 | Job console starting 2026-01-07 18:30:44.100363 | Updating git repos 2026-01-07 18:30:44.155176 | Cloning repos into workspace 2026-01-07 18:30:44.225153 | Restoring repo states 2026-01-07 18:30:44.272749 | Merging changes 2026-01-07 18:30:44.985539 | Checking out repos 2026-01-07 18:30:45.097929 | Preparing playbooks 2026-01-07 18:30:46.061912 | Running Ansible setup 2026-01-07 18:30:52.561957 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-01-07 18:30:53.825664 | 2026-01-07 18:30:53.825846 | PLAY [Base pre] 2026-01-07 18:30:53.869393 | 2026-01-07 18:30:53.869553 | TASK [Setup log path fact] 2026-01-07 18:30:53.910773 | debian-bookworm | ok 2026-01-07 18:30:53.943535 | 2026-01-07 18:30:53.943708 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-07 18:30:54.017492 | debian-bookworm | ok 2026-01-07 18:30:54.035301 | 2026-01-07 18:30:54.035449 | TASK [emit-job-header : Print job information] 2026-01-07 18:30:54.132461 | # Job Information 2026-01-07 18:30:54.132666 | Ansible Version: 2.16.14 2026-01-07 18:30:54.132702 | Job: python-black 2026-01-07 18:30:54.132734 | Pipeline: check 2026-01-07 18:30:54.132758 | Executor: 521e9411259a 2026-01-07 18:30:54.132779 | Triggered by: https://github.com/osism/python-osism/pull/1924 2026-01-07 18:30:54.132802 | Event ID: 9af22cd0-ebf6-11f0-8c3a-08cd3a937f44 2026-01-07 18:30:54.138256 | 2026-01-07 18:30:54.138402 | LOOP [emit-job-header : Print node information] 2026-01-07 18:30:54.322563 | debian-bookworm | ok: 2026-01-07 18:30:54.324299 | debian-bookworm | # Node Information 2026-01-07 18:30:54.324373 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-01-07 18:30:54.324402 | debian-bookworm | Hostname: debian 2026-01-07 18:30:54.324426 | debian-bookworm | Username: zuul 2026-01-07 18:30:54.324448 | debian-bookworm | Distro: Debian 12.12 2026-01-07 18:30:54.324473 | debian-bookworm | Provider: regiocloud-a 2026-01-07 18:30:54.324495 | debian-bookworm | Region: 2026-01-07 18:30:54.324516 | debian-bookworm | Label: debian-bookworm 2026-01-07 18:30:54.324536 | debian-bookworm | Product Name: OpenStack Nova 2026-01-07 18:30:54.324555 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe0a:4d92 2026-01-07 18:30:54.351694 | 2026-01-07 18:30:54.351907 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-01-07 18:30:55.531603 | debian-bookworm -> localhost | changed 2026-01-07 18:30:55.541038 | 2026-01-07 18:30:55.541179 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-01-07 18:30:57.859170 | debian-bookworm -> localhost | changed 2026-01-07 18:30:57.886026 | 2026-01-07 18:30:57.886206 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-01-07 18:30:58.545159 | debian-bookworm -> localhost | ok 2026-01-07 18:30:58.551864 | 2026-01-07 18:30:58.551998 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-01-07 18:30:58.585156 | debian-bookworm | ok 2026-01-07 18:30:58.682197 | debian-bookworm | included: /var/lib/zuul/builds/55a17bda6fb34dca82f9177a503df366/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-01-07 18:30:58.702917 | 2026-01-07 18:30:58.703078 | TASK [add-build-sshkey : Create Temp SSH key] 2026-01-07 18:31:00.757719 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-01-07 18:31:00.757993 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/55a17bda6fb34dca82f9177a503df366/work/55a17bda6fb34dca82f9177a503df366_id_rsa 2026-01-07 18:31:00.758056 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/55a17bda6fb34dca82f9177a503df366/work/55a17bda6fb34dca82f9177a503df366_id_rsa.pub 2026-01-07 18:31:00.758084 | debian-bookworm -> localhost | The key fingerprint is: 2026-01-07 18:31:00.758108 | debian-bookworm -> localhost | SHA256:HEUOSZU+M1MYGnMCQf42mdnVzv+4bRGM1JcyhOigE7g zuul-build-sshkey 2026-01-07 18:31:00.758129 | debian-bookworm -> localhost | The key's randomart image is: 2026-01-07 18:31:00.758162 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-01-07 18:31:00.758185 | debian-bookworm -> localhost | | ..++*+B+o.. .| 2026-01-07 18:31:00.758207 | debian-bookworm -> localhost | | . o ..@o..= o.| 2026-01-07 18:31:00.758226 | debian-bookworm -> localhost | | . + =...o * .| 2026-01-07 18:31:00.758246 | debian-bookworm -> localhost | | E o o B*. + o | 2026-01-07 18:31:00.758266 | debian-bookworm -> localhost | | . S .= o .| 2026-01-07 18:31:00.758290 | debian-bookworm -> localhost | | . . o | 2026-01-07 18:31:00.758310 | debian-bookworm -> localhost | | o| 2026-01-07 18:31:00.758331 | debian-bookworm -> localhost | | oo| 2026-01-07 18:31:00.758351 | debian-bookworm -> localhost | | ooo| 2026-01-07 18:31:00.758482 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-01-07 18:31:00.758562 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.735112 2026-01-07 18:31:00.767060 | 2026-01-07 18:31:00.767208 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-01-07 18:31:00.822727 | debian-bookworm | ok 2026-01-07 18:31:00.836872 | debian-bookworm | included: /var/lib/zuul/builds/55a17bda6fb34dca82f9177a503df366/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-01-07 18:31:00.856680 | 2026-01-07 18:31:00.856820 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-01-07 18:31:00.885463 | debian-bookworm | skipping: Conditional result was False 2026-01-07 18:31:00.897371 | 2026-01-07 18:31:00.897527 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-01-07 18:31:01.680089 | debian-bookworm | changed 2026-01-07 18:31:01.713438 | 2026-01-07 18:31:01.714175 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-01-07 18:31:02.035549 | debian-bookworm | ok 2026-01-07 18:31:02.041922 | 2026-01-07 18:31:02.042072 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-01-07 18:31:02.730932 | debian-bookworm | changed 2026-01-07 18:31:02.739732 | 2026-01-07 18:31:02.739866 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-01-07 18:31:03.459154 | debian-bookworm | changed 2026-01-07 18:31:03.489315 | 2026-01-07 18:31:03.489995 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-01-07 18:31:03.526601 | debian-bookworm | skipping: Conditional result was False 2026-01-07 18:31:03.537085 | 2026-01-07 18:31:03.537227 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-01-07 18:31:04.381915 | debian-bookworm -> localhost | changed 2026-01-07 18:31:04.399376 | 2026-01-07 18:31:04.399521 | TASK [add-build-sshkey : Add back temp key] 2026-01-07 18:31:04.888231 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/55a17bda6fb34dca82f9177a503df366/work/55a17bda6fb34dca82f9177a503df366_id_rsa (zuul-build-sshkey) 2026-01-07 18:31:04.888508 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.012690 2026-01-07 18:31:04.898575 | 2026-01-07 18:31:04.898743 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-01-07 18:31:05.349582 | debian-bookworm | ok 2026-01-07 18:31:05.356455 | 2026-01-07 18:31:05.356594 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-01-07 18:31:05.391718 | debian-bookworm | skipping: Conditional result was False 2026-01-07 18:31:05.417607 | 2026-01-07 18:31:05.417844 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-01-07 18:31:05.878153 | debian-bookworm | ok 2026-01-07 18:31:05.890133 | 2026-01-07 18:31:05.890283 | TASK [validate-host : Define zuul_info_dir fact] 2026-01-07 18:31:05.922169 | debian-bookworm | ok 2026-01-07 18:31:05.931171 | 2026-01-07 18:31:05.931309 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-01-07 18:31:06.389902 | debian-bookworm -> localhost | ok 2026-01-07 18:31:06.396626 | 2026-01-07 18:31:06.396750 | TASK [validate-host : Collect information about the host] 2026-01-07 18:31:07.888159 | debian-bookworm | ok 2026-01-07 18:31:07.902081 | 2026-01-07 18:31:07.902214 | TASK [validate-host : Sanitize hostname] 2026-01-07 18:31:08.047877 | debian-bookworm | ok 2026-01-07 18:31:08.122627 | 2026-01-07 18:31:08.122769 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-01-07 18:31:08.897623 | debian-bookworm -> localhost | changed 2026-01-07 18:31:08.909656 | 2026-01-07 18:31:08.909860 | TASK [validate-host : Collect information about zuul worker] 2026-01-07 18:31:09.362192 | debian-bookworm | ok 2026-01-07 18:31:09.368818 | 2026-01-07 18:31:09.368966 | TASK [validate-host : Write out all zuul information for each host] 2026-01-07 18:31:10.022460 | debian-bookworm -> localhost | changed 2026-01-07 18:31:10.039730 | 2026-01-07 18:31:10.039872 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-01-07 18:31:10.371863 | debian-bookworm | ok 2026-01-07 18:31:10.381687 | 2026-01-07 18:31:10.381860 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-01-07 18:31:11.406824 | debian-bookworm | changed: 2026-01-07 18:31:11.407102 | debian-bookworm | cd+++++++++ src/ 2026-01-07 18:31:11.407143 | debian-bookworm | cd+++++++++ src/github.com/ 2026-01-07 18:31:11.407167 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-01-07 18:31:11.407190 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-01-07 18:31:11.407211 | debian-bookworm | Containerfile 2026-01-07 18:31:11.407498 | debian-bookworm | Containerfile 2026-01-07 18:31:11.420300 | debian-bookworm | localhost | ok: Runtime: 0:00:00.005734 2026-01-07 18:31:40.227143 | 2026-01-07 18:31:40.227273 | TASK [upload-logs : Upload logs to log server] 2026-01-07 18:31:41.243987 | localhost | Output suppressed because no_log was given 2026-01-07 18:31:41.245895 | 2026-01-07 18:31:41.246001 | LOOP [upload-logs : Compress console log and json output] 2026-01-07 18:31:41.303749 | localhost | skipping: Conditional result was False 2026-01-07 18:31:41.310538 | localhost | skipping: Conditional result was False 2026-01-07 18:31:41.314422 | 2026-01-07 18:31:41.314542 | LOOP [upload-logs : Upload compressed console log and json output] 2026-01-07 18:31:41.365732 | localhost | skipping: Conditional result was False 2026-01-07 18:31:41.366048 | 2026-01-07 18:31:41.371414 | localhost | skipping: Conditional result was False 2026-01-07 18:31:41.381403 | 2026-01-07 18:31:41.381533 | LOOP [upload-logs : Upload console log and json output]