2026-04-18 18:32:19.497095 | Job console starting 2026-04-18 18:32:19.518237 | Updating git repos 2026-04-18 18:32:19.676377 | Cloning repos into workspace 2026-04-18 18:32:19.792537 | Restoring repo states 2026-04-18 18:32:19.840324 | Merging changes 2026-04-18 18:32:20.529999 | Checking out repos 2026-04-18 18:32:20.627500 | Preparing playbooks 2026-04-18 18:32:21.868465 | Running Ansible setup 2026-04-18 18:32:27.932600 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-04-18 18:32:29.349344 | 2026-04-18 18:32:29.366990 | PLAY [Base pre] 2026-04-18 18:32:29.401941 | 2026-04-18 18:32:29.402115 | TASK [Setup log path fact] 2026-04-18 18:32:29.454002 | debian-bookworm | ok 2026-04-18 18:32:29.480176 | 2026-04-18 18:32:29.480346 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-18 18:32:29.551260 | debian-bookworm | ok 2026-04-18 18:32:29.562354 | 2026-04-18 18:32:29.562482 | TASK [emit-job-header : Print job information] 2026-04-18 18:32:29.671122 | # Job Information 2026-04-18 18:32:29.671340 | Ansible Version: 2.16.14 2026-04-18 18:32:29.671377 | Job: python-black 2026-04-18 18:32:29.671411 | Pipeline: check 2026-04-18 18:32:29.671435 | Executor: 521e9411259a 2026-04-18 18:32:29.671456 | Triggered by: https://github.com/osism/python-osism/pull/2160 2026-04-18 18:32:29.671479 | Event ID: e98f2480-3b54-11f1-84bd-33330ceeb902 2026-04-18 18:32:29.676611 | 2026-04-18 18:32:29.676729 | LOOP [emit-job-header : Print node information] 2026-04-18 18:32:29.895424 | debian-bookworm | ok: 2026-04-18 18:32:29.896392 | debian-bookworm | # Node Information 2026-04-18 18:32:29.896468 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-04-18 18:32:29.896496 | debian-bookworm | Hostname: debian 2026-04-18 18:32:29.896520 | debian-bookworm | Username: zuul 2026-04-18 18:32:29.896542 | debian-bookworm | Distro: Debian 12.13 2026-04-18 18:32:29.896566 | debian-bookworm | Provider: regiocloud-a 2026-04-18 18:32:29.896588 | debian-bookworm | Region: 2026-04-18 18:32:29.896609 | debian-bookworm | Label: debian-bookworm 2026-04-18 18:32:29.896629 | debian-bookworm | Product Name: OpenStack Nova 2026-04-18 18:32:29.896649 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feaf:f03c 2026-04-18 18:32:29.916932 | 2026-04-18 18:32:29.917127 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-18 18:32:30.857507 | debian-bookworm -> localhost | changed 2026-04-18 18:32:30.863962 | 2026-04-18 18:32:30.864077 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-18 18:32:32.617003 | debian-bookworm -> localhost | changed 2026-04-18 18:32:32.625479 | 2026-04-18 18:32:32.625568 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-18 18:32:32.944971 | debian-bookworm -> localhost | ok 2026-04-18 18:32:32.949875 | 2026-04-18 18:32:32.949956 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-18 18:32:32.986892 | debian-bookworm | ok 2026-04-18 18:32:33.014693 | debian-bookworm | included: /var/lib/zuul/builds/0557327d18b647979f0ed05d16cc41de/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-18 18:32:33.031624 | 2026-04-18 18:32:33.031716 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-18 18:32:34.893055 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-04-18 18:32:34.893218 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/0557327d18b647979f0ed05d16cc41de/work/0557327d18b647979f0ed05d16cc41de_id_rsa 2026-04-18 18:32:34.893251 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/0557327d18b647979f0ed05d16cc41de/work/0557327d18b647979f0ed05d16cc41de_id_rsa.pub 2026-04-18 18:32:34.893273 | debian-bookworm -> localhost | The key fingerprint is: 2026-04-18 18:32:34.893293 | debian-bookworm -> localhost | SHA256:3hs3vuKNbcNFtCesTunQSOeSgQ1Ju/XX1W5AY2GMtP4 zuul-build-sshkey 2026-04-18 18:32:34.893311 | debian-bookworm -> localhost | The key's randomart image is: 2026-04-18 18:32:34.893337 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-04-18 18:32:34.893355 | debian-bookworm -> localhost | | ... ..o*. | 2026-04-18 18:32:34.893374 | debian-bookworm -> localhost | | o. .=o..| 2026-04-18 18:32:34.893391 | debian-bookworm -> localhost | | .+. .o..o| 2026-04-18 18:32:34.893408 | debian-bookworm -> localhost | | .o+o. =+o| 2026-04-18 18:32:34.893425 | debian-bookworm -> localhost | | S. Bo+.o+| 2026-04-18 18:32:34.893445 | debian-bookworm -> localhost | | . .= *o.. | 2026-04-18 18:32:34.893463 | debian-bookworm -> localhost | | . oBo.E | 2026-04-18 18:32:34.893481 | debian-bookworm -> localhost | | .O*. | 2026-04-18 18:32:34.893498 | debian-bookworm -> localhost | | .+o=o | 2026-04-18 18:32:34.893515 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-04-18 18:32:34.893557 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.152067 2026-04-18 18:32:34.898557 | 2026-04-18 18:32:34.898631 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-18 18:32:34.914774 | debian-bookworm | ok 2026-04-18 18:32:34.922199 | debian-bookworm | included: /var/lib/zuul/builds/0557327d18b647979f0ed05d16cc41de/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-18 18:32:34.929387 | 2026-04-18 18:32:34.929463 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-18 18:32:34.942102 | debian-bookworm | skipping: Conditional result was False 2026-04-18 18:32:34.946720 | 2026-04-18 18:32:34.946800 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-18 18:32:35.627919 | debian-bookworm | changed 2026-04-18 18:32:35.632467 | 2026-04-18 18:32:35.632537 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-18 18:32:35.871993 | debian-bookworm | ok 2026-04-18 18:32:35.878355 | 2026-04-18 18:32:35.878445 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-18 18:32:36.530582 | debian-bookworm | changed 2026-04-18 18:32:36.538676 | 2026-04-18 18:32:36.538778 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-18 18:32:37.191978 | debian-bookworm | changed 2026-04-18 18:32:37.197202 | 2026-04-18 18:32:37.197283 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-18 18:32:37.224477 | debian-bookworm | skipping: Conditional result was False 2026-04-18 18:32:37.230477 | 2026-04-18 18:32:37.230574 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-18 18:32:37.739276 | debian-bookworm -> localhost | changed 2026-04-18 18:32:37.747929 | 2026-04-18 18:32:37.749008 | TASK [add-build-sshkey : Add back temp key] 2026-04-18 18:32:38.169511 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/0557327d18b647979f0ed05d16cc41de/work/0557327d18b647979f0ed05d16cc41de_id_rsa (zuul-build-sshkey) 2026-04-18 18:32:38.169790 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.009475 2026-04-18 18:32:38.188234 | 2026-04-18 18:32:38.188350 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-18 18:32:38.593749 | debian-bookworm | ok 2026-04-18 18:32:38.603208 | 2026-04-18 18:32:38.603308 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-18 18:32:38.660552 | debian-bookworm | skipping: Conditional result was False 2026-04-18 18:32:38.671824 | 2026-04-18 18:32:38.671920 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-04-18 18:32:39.116676 | debian-bookworm | ok 2026-04-18 18:32:39.133176 | 2026-04-18 18:32:39.133290 | TASK [validate-host : Define zuul_info_dir fact] 2026-04-18 18:32:39.184393 | debian-bookworm | ok 2026-04-18 18:32:39.189524 | 2026-04-18 18:32:39.189623 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-04-18 18:32:39.603383 | debian-bookworm -> localhost | ok 2026-04-18 18:32:39.609979 | 2026-04-18 18:32:39.610084 | TASK [validate-host : Collect information about the host] 2026-04-18 18:32:40.667605 | debian-bookworm | ok 2026-04-18 18:32:40.682219 | 2026-04-18 18:32:40.682318 | TASK [validate-host : Sanitize hostname] 2026-04-18 18:32:40.823178 | debian-bookworm | ok 2026-04-18 18:32:40.890157 | 2026-04-18 18:32:40.890274 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-04-18 18:32:41.520768 | debian-bookworm -> localhost | changed 2026-04-18 18:32:41.526488 | 2026-04-18 18:32:41.526584 | TASK [validate-host : Collect information about zuul worker] 2026-04-18 18:32:41.970158 | debian-bookworm | ok 2026-04-18 18:32:41.974638 | 2026-04-18 18:32:41.974727 | TASK [validate-host : Write out all zuul information for each host] 2026-04-18 18:32:42.615399 | debian-bookworm -> localhost | changed 2026-04-18 18:32:42.624425 | 2026-04-18 18:32:42.624513 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-04-18 18:32:42.915049 | debian-bookworm | ok 2026-04-18 18:32:42.920489 | 2026-04-18 18:32:42.920577 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-04-18 18:32:43.899132 | debian-bookworm | changed: 2026-04-18 18:32:43.899310 | debian-bookworm | cd+++++++++ src/ 2026-04-18 18:32:43.899345 | debian-bookworm | cd+++++++++ src/github.com/ 2026-04-18 18:32:43.899370 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-04-18 18:32:43.899392 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-04-18 18:32:43.899412 | debian-bookworm | Containerfile 2026-04-18 18:32:43.899541 | debian-bookworm | Containerfile 2026-04-18 18:32:43.906053 | debian-bookworm | localhost | ok: Runtime: 0:00:00.009347 2026-04-18 18:33:13.198390 | 2026-04-18 18:33:13.198505 | TASK [upload-logs : Upload logs to log server] 2026-04-18 18:33:13.797219 | localhost | Output suppressed because no_log was given 2026-04-18 18:33:13.801330 | 2026-04-18 18:33:13.801539 | LOOP [upload-logs : Compress console log and json output] 2026-04-18 18:33:13.859477 | localhost | skipping: Conditional result was False 2026-04-18 18:33:13.865416 | localhost | skipping: Conditional result was False 2026-04-18 18:33:13.881108 | 2026-04-18 18:33:13.881411 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-18 18:33:13.941091 | localhost | skipping: Conditional result was False 2026-04-18 18:33:13.941389 | 2026-04-18 18:33:13.946226 | localhost | skipping: Conditional result was False 2026-04-18 18:33:13.951845 | 2026-04-18 18:33:13.951982 | LOOP [upload-logs : Upload console log and json output]