2025-12-12 09:29:12.270133 | Job console starting 2025-12-12 09:29:12.284212 | Updating git repos 2025-12-12 09:29:12.318622 | Cloning repos into workspace 2025-12-12 09:29:12.398716 | Restoring repo states 2025-12-12 09:29:12.405272 | Merging changes 2025-12-12 09:29:13.006081 | Checking out repos 2025-12-12 09:29:13.103070 | Preparing playbooks 2025-12-12 09:29:13.945177 | Running Ansible setup 2025-12-12 09:29:18.932389 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-12 09:29:20.177605 | 2025-12-12 09:29:20.177777 | PLAY [Base pre] 2025-12-12 09:29:20.197319 | 2025-12-12 09:29:20.197496 | TASK [Setup log path fact] 2025-12-12 09:29:20.216607 | debian-bookworm | ok 2025-12-12 09:29:20.237820 | 2025-12-12 09:29:20.237988 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-12 09:29:20.268004 | debian-bookworm | ok 2025-12-12 09:29:20.278226 | 2025-12-12 09:29:20.278363 | TASK [emit-job-header : Print job information] 2025-12-12 09:29:20.318309 | # Job Information 2025-12-12 09:29:20.318504 | Ansible Version: 2.16.14 2025-12-12 09:29:20.318587 | Job: python-black 2025-12-12 09:29:20.318627 | Pipeline: check 2025-12-12 09:29:20.318651 | Executor: 521e9411259a 2025-12-12 09:29:20.318671 | Triggered by: https://github.com/osism/testbed/pull/2816 2025-12-12 09:29:20.318694 | Event ID: ff4f1db0-d73c-11f0-840a-025af294c69d 2025-12-12 09:29:20.325588 | 2025-12-12 09:29:20.325731 | LOOP [emit-job-header : Print node information] 2025-12-12 09:29:20.483096 | debian-bookworm | ok: 2025-12-12 09:29:20.483320 | debian-bookworm | # Node Information 2025-12-12 09:29:20.483359 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-12 09:29:20.483386 | debian-bookworm | Hostname: debian 2025-12-12 09:29:20.483410 | debian-bookworm | Username: zuul 2025-12-12 09:29:20.483430 | debian-bookworm | Distro: Debian 12.12 2025-12-12 09:29:20.483457 | debian-bookworm | Provider: regiocloud-a 2025-12-12 09:29:20.483478 | debian-bookworm | Region: 2025-12-12 09:29:20.483558 | debian-bookworm | Label: debian-bookworm 2025-12-12 09:29:20.483593 | debian-bookworm | Product Name: OpenStack Nova 2025-12-12 09:29:20.483620 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe8c:c8f7 2025-12-12 09:29:20.502368 | 2025-12-12 09:29:20.502532 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-12 09:29:21.117637 | debian-bookworm -> localhost | changed 2025-12-12 09:29:21.125958 | 2025-12-12 09:29:21.126098 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-12 09:29:22.653157 | debian-bookworm -> localhost | changed 2025-12-12 09:29:22.665766 | 2025-12-12 09:29:22.665981 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-12 09:29:22.993758 | debian-bookworm -> localhost | ok 2025-12-12 09:29:23.000241 | 2025-12-12 09:29:23.000366 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-12 09:29:23.020028 | debian-bookworm | ok 2025-12-12 09:29:23.041238 | debian-bookworm | included: /var/lib/zuul/builds/15c66adb6d524e52a564d9b1d1b37cdc/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-12 09:29:23.047524 | 2025-12-12 09:29:23.047666 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-12 09:29:24.501918 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-12 09:29:24.502203 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/15c66adb6d524e52a564d9b1d1b37cdc/work/15c66adb6d524e52a564d9b1d1b37cdc_id_rsa 2025-12-12 09:29:24.502255 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/15c66adb6d524e52a564d9b1d1b37cdc/work/15c66adb6d524e52a564d9b1d1b37cdc_id_rsa.pub 2025-12-12 09:29:24.502290 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-12 09:29:24.502322 | debian-bookworm -> localhost | SHA256:iz9LFW+eManE7NRwIDMjUG5VfaqTMjOYMV3JofyvvaQ zuul-build-sshkey 2025-12-12 09:29:24.502352 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-12 09:29:24.502396 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-12 09:29:24.502426 | debian-bookworm -> localhost | | .oo *o++ | 2025-12-12 09:29:24.502455 | debian-bookworm -> localhost | | . + *+.. . | 2025-12-12 09:29:24.502482 | debian-bookworm -> localhost | | o.o.o .o | 2025-12-12 09:29:24.502510 | debian-bookworm -> localhost | | .o .+ *.. | 2025-12-12 09:29:24.502536 | debian-bookworm -> localhost | | =S BoB | 2025-12-12 09:29:24.502592 | debian-bookworm -> localhost | | o.=*+= + | 2025-12-12 09:29:24.502623 | debian-bookworm -> localhost | | . o=o.= | 2025-12-12 09:29:24.502651 | debian-bookworm -> localhost | | o. = | 2025-12-12 09:29:24.502680 | debian-bookworm -> localhost | | ooE o. | 2025-12-12 09:29:24.502707 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-12 09:29:24.502772 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.970628 2025-12-12 09:29:24.510925 | 2025-12-12 09:29:24.511061 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-12 09:29:24.558769 | debian-bookworm | ok 2025-12-12 09:29:24.573672 | debian-bookworm | included: /var/lib/zuul/builds/15c66adb6d524e52a564d9b1d1b37cdc/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-12 09:29:24.583666 | 2025-12-12 09:29:24.583804 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-12 09:29:24.607837 | debian-bookworm | skipping: Conditional result was False 2025-12-12 09:29:24.614054 | 2025-12-12 09:29:24.614180 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-12 09:29:25.272422 | debian-bookworm | changed 2025-12-12 09:29:25.285114 | 2025-12-12 09:29:25.285269 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-12 09:29:25.553010 | debian-bookworm | ok 2025-12-12 09:29:25.561036 | 2025-12-12 09:29:25.561183 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-12 09:29:26.201645 | debian-bookworm | changed 2025-12-12 09:29:26.209654 | 2025-12-12 09:29:26.209826 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-12 09:29:26.892370 | debian-bookworm | changed 2025-12-12 09:29:26.920197 | 2025-12-12 09:29:26.921460 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-12 09:29:26.947168 | debian-bookworm | skipping: Conditional result was False 2025-12-12 09:29:26.954800 | 2025-12-12 09:29:26.954977 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-12 09:29:27.459806 | debian-bookworm -> localhost | changed 2025-12-12 09:29:27.470819 | 2025-12-12 09:29:27.470978 | TASK [add-build-sshkey : Add back temp key] 2025-12-12 09:29:27.829907 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/15c66adb6d524e52a564d9b1d1b37cdc/work/15c66adb6d524e52a564d9b1d1b37cdc_id_rsa (zuul-build-sshkey) 2025-12-12 09:29:27.830163 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.017430 2025-12-12 09:29:27.838228 | 2025-12-12 09:29:27.838359 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-12 09:29:28.248177 | debian-bookworm | ok 2025-12-12 09:29:28.254719 | 2025-12-12 09:29:28.254889 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-12 09:29:28.279001 | debian-bookworm | skipping: Conditional result was False 2025-12-12 09:29:28.290136 | 2025-12-12 09:29:28.290280 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-12 09:29:28.725053 | debian-bookworm | ok 2025-12-12 09:29:28.736169 | 2025-12-12 09:29:28.736305 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-12 09:29:28.775429 | debian-bookworm | ok 2025-12-12 09:29:28.781428 | 2025-12-12 09:29:28.781605 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-12 09:29:29.104964 | debian-bookworm -> localhost | ok 2025-12-12 09:29:29.118135 | 2025-12-12 09:29:29.118318 | TASK [validate-host : Collect information about the host] 2025-12-12 09:29:30.185223 | debian-bookworm | ok 2025-12-12 09:29:30.208332 | 2025-12-12 09:29:30.208498 | TASK [validate-host : Sanitize hostname] 2025-12-12 09:29:30.330567 | debian-bookworm | ok 2025-12-12 09:29:30.424627 | 2025-12-12 09:29:30.424786 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-12 09:29:31.140964 | debian-bookworm -> localhost | changed 2025-12-12 09:29:31.147026 | 2025-12-12 09:29:31.147147 | TASK [validate-host : Collect information about zuul worker] 2025-12-12 09:29:31.553252 | debian-bookworm | ok 2025-12-12 09:29:31.563325 | 2025-12-12 09:29:31.563572 | TASK [validate-host : Write out all zuul information for each host] 2025-12-12 09:29:32.318066 | debian-bookworm -> localhost | changed 2025-12-12 09:29:32.329303 | 2025-12-12 09:29:32.329451 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-12 09:29:32.613351 | debian-bookworm | ok 2025-12-12 09:29:32.620286 | 2025-12-12 09:29:32.620444 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-12 09:29:34.004884 | debian-bookworm | changed: 2025-12-12 09:29:34.005123 | debian-bookworm | cd+++++++++ src/ 2025-12-12 09:29:34.005159 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-12 09:29:34.005183 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-12 09:29:34.005205 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2025-12-12 09:29:34.005225 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007813 2025-12-12 09:29:58.751128 | 2025-12-12 09:29:58.751321 | TASK [upload-logs : Upload logs to log server] 2025-12-12 09:29:59.363316 | localhost | Output suppressed because no_log was given 2025-12-12 09:29:59.365196 | 2025-12-12 09:29:59.365301 | LOOP [upload-logs : Compress console log and json output] 2025-12-12 09:29:59.417131 | localhost | skipping: Conditional result was False 2025-12-12 09:29:59.423879 | localhost | skipping: Conditional result was False 2025-12-12 09:29:59.431933 | 2025-12-12 09:29:59.432062 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-12 09:29:59.483327 | localhost | skipping: Conditional result was False 2025-12-12 09:29:59.484159 | 2025-12-12 09:29:59.487596 | localhost | skipping: Conditional result was False 2025-12-12 09:29:59.502775 | 2025-12-12 09:29:59.503156 | LOOP [upload-logs : Upload console log and json output]