2026-04-09 12:48:44.379553 | Job console starting 2026-04-09 12:48:44.404007 | Updating git repos 2026-04-09 12:48:44.439924 | Cloning repos into workspace 2026-04-09 12:48:44.531917 | Restoring repo states 2026-04-09 12:48:44.540030 | Merging changes 2026-04-09 12:48:45.245933 | Checking out repos 2026-04-09 12:48:45.321658 | Preparing playbooks 2026-04-09 12:48:46.779063 | Running Ansible setup 2026-04-09 12:48:53.301608 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-04-09 12:48:54.952483 | 2026-04-09 12:48:54.952616 | PLAY [Base pre] 2026-04-09 12:48:54.979586 | 2026-04-09 12:48:54.979707 | TASK [Setup log path fact] 2026-04-09 12:48:55.020131 | debian-bookworm | ok 2026-04-09 12:48:55.042407 | 2026-04-09 12:48:55.042544 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-09 12:48:55.090337 | debian-bookworm | ok 2026-04-09 12:48:55.108273 | 2026-04-09 12:48:55.108384 | TASK [emit-job-header : Print job information] 2026-04-09 12:48:55.172033 | # Job Information 2026-04-09 12:48:55.172240 | Ansible Version: 2.16.14 2026-04-09 12:48:55.172277 | Job: python-black 2026-04-09 12:48:55.172314 | Pipeline: check 2026-04-09 12:48:55.172337 | Executor: 521e9411259a 2026-04-09 12:48:55.172357 | Triggered by: https://github.com/osism/cfg-cookiecutter/pull/827 2026-04-09 12:48:55.172380 | Event ID: 6a8060d0-3412-11f1-95d5-35a9d627b6ba 2026-04-09 12:48:55.177187 | 2026-04-09 12:48:55.177298 | LOOP [emit-job-header : Print node information] 2026-04-09 12:48:55.450660 | debian-bookworm | ok: 2026-04-09 12:48:55.450927 | debian-bookworm | # Node Information 2026-04-09 12:48:55.450984 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-04-09 12:48:55.451012 | debian-bookworm | Hostname: debian 2026-04-09 12:48:55.451036 | debian-bookworm | Username: zuul 2026-04-09 12:48:55.451057 | debian-bookworm | Distro: Debian 12.13 2026-04-09 12:48:55.451081 | debian-bookworm | Provider: regiocloud-a 2026-04-09 12:48:55.451102 | debian-bookworm | Region: 2026-04-09 12:48:55.451123 | debian-bookworm | Label: debian-bookworm 2026-04-09 12:48:55.451142 | debian-bookworm | Product Name: OpenStack Nova 2026-04-09 12:48:55.451162 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe59:6ac 2026-04-09 12:48:55.471014 | 2026-04-09 12:48:55.471156 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-09 12:48:56.719807 | debian-bookworm -> localhost | changed 2026-04-09 12:48:56.725455 | 2026-04-09 12:48:56.725546 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-09 12:48:58.881509 | debian-bookworm -> localhost | changed 2026-04-09 12:48:58.890166 | 2026-04-09 12:48:58.890258 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-09 12:48:59.462524 | debian-bookworm -> localhost | ok 2026-04-09 12:48:59.467658 | 2026-04-09 12:48:59.467754 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-09 12:48:59.504509 | debian-bookworm | ok 2026-04-09 12:48:59.525912 | debian-bookworm | included: /var/lib/zuul/builds/32329eb36da7495790a292833cfd861d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-09 12:48:59.551139 | 2026-04-09 12:48:59.551231 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-09 12:49:02.836366 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-04-09 12:49:02.836528 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/32329eb36da7495790a292833cfd861d/work/32329eb36da7495790a292833cfd861d_id_rsa 2026-04-09 12:49:02.836558 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/32329eb36da7495790a292833cfd861d/work/32329eb36da7495790a292833cfd861d_id_rsa.pub 2026-04-09 12:49:02.836579 | debian-bookworm -> localhost | The key fingerprint is: 2026-04-09 12:49:02.836599 | debian-bookworm -> localhost | SHA256:TX2mEFtgZtVU5mKd4k5nsItA5fOm0KeA+sWQ245j3+Q zuul-build-sshkey 2026-04-09 12:49:02.836617 | debian-bookworm -> localhost | The key's randomart image is: 2026-04-09 12:49:02.836644 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-04-09 12:49:02.836662 | debian-bookworm -> localhost | | *+oo..o| 2026-04-09 12:49:02.836680 | debian-bookworm -> localhost | | +o= .+.| 2026-04-09 12:49:02.836697 | debian-bookworm -> localhost | | .+o.o=.o| 2026-04-09 12:49:02.836713 | debian-bookworm -> localhost | | +o..+=+. | 2026-04-09 12:49:02.836729 | debian-bookworm -> localhost | | +S+...B o | 2026-04-09 12:49:02.836750 | debian-bookworm -> localhost | | . = + O + | 2026-04-09 12:49:02.836767 | debian-bookworm -> localhost | | . . + = o | 2026-04-09 12:49:02.836795 | debian-bookworm -> localhost | | .o+ + | 2026-04-09 12:49:02.836813 | debian-bookworm -> localhost | | .ooo E | 2026-04-09 12:49:02.836830 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-04-09 12:49:02.836872 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.138921 2026-04-09 12:49:02.842027 | 2026-04-09 12:49:02.842103 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-09 12:49:02.888508 | debian-bookworm | ok 2026-04-09 12:49:02.899700 | debian-bookworm | included: /var/lib/zuul/builds/32329eb36da7495790a292833cfd861d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-09 12:49:02.918744 | 2026-04-09 12:49:02.918817 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-09 12:49:02.972839 | debian-bookworm | skipping: Conditional result was False 2026-04-09 12:49:02.977466 | 2026-04-09 12:49:02.977542 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-09 12:49:03.816113 | debian-bookworm | changed 2026-04-09 12:49:03.820380 | 2026-04-09 12:49:03.820453 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-09 12:49:04.061742 | debian-bookworm | ok 2026-04-09 12:49:04.066084 | 2026-04-09 12:49:04.066166 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-09 12:49:04.709632 | debian-bookworm | changed 2026-04-09 12:49:04.717281 | 2026-04-09 12:49:04.717380 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-09 12:49:05.374017 | debian-bookworm | changed 2026-04-09 12:49:05.380473 | 2026-04-09 12:49:05.380570 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-09 12:49:05.423929 | debian-bookworm | skipping: Conditional result was False 2026-04-09 12:49:05.430339 | 2026-04-09 12:49:05.430475 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-09 12:49:05.946270 | debian-bookworm -> localhost | changed 2026-04-09 12:49:05.963648 | 2026-04-09 12:49:05.963755 | TASK [add-build-sshkey : Add back temp key] 2026-04-09 12:49:06.637165 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/32329eb36da7495790a292833cfd861d/work/32329eb36da7495790a292833cfd861d_id_rsa (zuul-build-sshkey) 2026-04-09 12:49:06.637377 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.038346 2026-04-09 12:49:06.645318 | 2026-04-09 12:49:06.645425 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-09 12:49:07.121358 | debian-bookworm | ok 2026-04-09 12:49:07.126190 | 2026-04-09 12:49:07.126281 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-09 12:49:07.169248 | debian-bookworm | skipping: Conditional result was False 2026-04-09 12:49:07.187561 | 2026-04-09 12:49:07.187671 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-04-09 12:49:07.933257 | debian-bookworm | ok 2026-04-09 12:49:07.943381 | 2026-04-09 12:49:07.943479 | TASK [validate-host : Define zuul_info_dir fact] 2026-04-09 12:49:07.980608 | debian-bookworm | ok 2026-04-09 12:49:07.989503 | 2026-04-09 12:49:07.989635 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-04-09 12:49:08.464673 | debian-bookworm -> localhost | ok 2026-04-09 12:49:08.470622 | 2026-04-09 12:49:08.470712 | TASK [validate-host : Collect information about the host] 2026-04-09 12:49:09.639121 | debian-bookworm | ok 2026-04-09 12:49:09.666736 | 2026-04-09 12:49:09.674892 | TASK [validate-host : Sanitize hostname] 2026-04-09 12:49:09.998410 | debian-bookworm | ok 2026-04-09 12:49:10.066479 | 2026-04-09 12:49:10.066658 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-04-09 12:49:10.661995 | debian-bookworm -> localhost | changed 2026-04-09 12:49:10.668839 | 2026-04-09 12:49:10.668967 | TASK [validate-host : Collect information about zuul worker] 2026-04-09 12:49:11.036986 | debian-bookworm | ok 2026-04-09 12:49:11.041759 | 2026-04-09 12:49:11.041859 | TASK [validate-host : Write out all zuul information for each host] 2026-04-09 12:49:12.583542 | debian-bookworm -> localhost | changed 2026-04-09 12:49:12.601368 | 2026-04-09 12:49:12.601468 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-04-09 12:49:12.914287 | debian-bookworm | ok 2026-04-09 12:49:12.919623 | 2026-04-09 12:49:12.919724 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-04-09 12:49:14.070801 | debian-bookworm | changed: 2026-04-09 12:49:14.074991 | debian-bookworm | cd+++++++++ src/ 2026-04-09 12:49:14.075029 | debian-bookworm | cd+++++++++ src/github.com/ 2026-04-09 12:49:14.075049 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-04-09 12:49:14.075067 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2026-04-09 12:49:14.075083 | debian-bookworm | Containerfile 2026-04-09 12:49:14.075186 | debian-bookworm | localhost | ok: Runtime: 0:00:00.005074 2026-04-09 12:49:38.661554 | 2026-04-09 12:49:38.661675 | TASK [upload-logs : Upload logs to log server] 2026-04-09 12:49:39.304315 | localhost | Output suppressed because no_log was given 2026-04-09 12:49:39.306179 | 2026-04-09 12:49:39.306292 | LOOP [upload-logs : Compress console log and json output] 2026-04-09 12:49:39.372412 | localhost | skipping: Conditional result was False 2026-04-09 12:49:39.378646 | localhost | skipping: Conditional result was False 2026-04-09 12:49:39.393467 | 2026-04-09 12:49:39.393716 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-09 12:49:39.448293 | localhost | skipping: Conditional result was False 2026-04-09 12:49:39.448598 | 2026-04-09 12:49:39.456838 | localhost | skipping: Conditional result was False 2026-04-09 12:49:39.462387 | 2026-04-09 12:49:39.462511 | LOOP [upload-logs : Upload console log and json output]