2026-01-30 15:27:13.099557 | Job console starting 2026-01-30 15:27:13.123144 | Updating git repos 2026-01-30 15:27:13.154614 | Cloning repos into workspace 2026-01-30 15:27:13.209702 | Restoring repo states 2026-01-30 15:27:13.216721 | Merging changes 2026-01-30 15:27:13.709120 | Checking out repos 2026-01-30 15:27:13.793879 | Preparing playbooks 2026-01-30 15:27:14.583423 | Running Ansible setup 2026-01-30 15:27:19.288780 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-01-30 15:27:20.080739 | 2026-01-30 15:27:20.080904 | PLAY [Base pre] 2026-01-30 15:27:20.099529 | 2026-01-30 15:27:20.099688 | TASK [Setup log path fact] 2026-01-30 15:27:20.130897 | debian-bookworm | ok 2026-01-30 15:27:20.146364 | 2026-01-30 15:27:20.146536 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-30 15:27:20.177218 | debian-bookworm | ok 2026-01-30 15:27:20.188664 | 2026-01-30 15:27:20.188796 | TASK [emit-job-header : Print job information] 2026-01-30 15:27:20.229450 | # Job Information 2026-01-30 15:27:20.229637 | Ansible Version: 2.16.14 2026-01-30 15:27:20.229672 | Job: python-black 2026-01-30 15:27:20.229705 | Pipeline: check 2026-01-30 15:27:20.229728 | Executor: 521e9411259a 2026-01-30 15:27:20.229749 | Triggered by: https://github.com/osism/testbed/pull/2844 2026-01-30 15:27:20.229772 | Event ID: 20b55b20-fdf0-11f0-8799-c52acb662b13 2026-01-30 15:27:20.235404 | 2026-01-30 15:27:20.235532 | LOOP [emit-job-header : Print node information] 2026-01-30 15:27:20.353467 | debian-bookworm | ok: 2026-01-30 15:27:20.353794 | debian-bookworm | # Node Information 2026-01-30 15:27:20.353837 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-01-30 15:27:20.353864 | debian-bookworm | Hostname: debian 2026-01-30 15:27:20.353887 | debian-bookworm | Username: zuul 2026-01-30 15:27:20.353907 | debian-bookworm | Distro: Debian 12.13 2026-01-30 15:27:20.353977 | debian-bookworm | Provider: regiocloud-a 2026-01-30 15:27:20.354006 | debian-bookworm | Region: 2026-01-30 15:27:20.354027 | debian-bookworm | Label: debian-bookworm 2026-01-30 15:27:20.354048 | debian-bookworm | Product Name: OpenStack Nova 2026-01-30 15:27:20.354068 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feac:337 2026-01-30 15:27:20.380762 | 2026-01-30 15:27:20.380915 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-01-30 15:27:20.948151 | debian-bookworm -> localhost | changed 2026-01-30 15:27:20.964383 | 2026-01-30 15:27:20.964574 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-01-30 15:27:22.144896 | debian-bookworm -> localhost | changed 2026-01-30 15:27:22.155738 | 2026-01-30 15:27:22.155860 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-01-30 15:27:22.430473 | debian-bookworm -> localhost | ok 2026-01-30 15:27:22.436623 | 2026-01-30 15:27:22.436740 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-01-30 15:27:22.465269 | debian-bookworm | ok 2026-01-30 15:27:22.483351 | debian-bookworm | included: /var/lib/zuul/builds/18f8e1ccdbb649188308707f7ad78656/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-01-30 15:27:22.489474 | 2026-01-30 15:27:22.489585 | TASK [add-build-sshkey : Create Temp SSH key] 2026-01-30 15:27:24.035420 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-01-30 15:27:24.035660 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/18f8e1ccdbb649188308707f7ad78656/work/18f8e1ccdbb649188308707f7ad78656_id_rsa 2026-01-30 15:27:24.035700 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/18f8e1ccdbb649188308707f7ad78656/work/18f8e1ccdbb649188308707f7ad78656_id_rsa.pub 2026-01-30 15:27:24.035726 | debian-bookworm -> localhost | The key fingerprint is: 2026-01-30 15:27:24.035750 | debian-bookworm -> localhost | SHA256:+oGlbIitv+E2/dRsrD5lbOtGLfBT4fQFnh6T4aytqoY zuul-build-sshkey 2026-01-30 15:27:24.035771 | debian-bookworm -> localhost | The key's randomart image is: 2026-01-30 15:27:24.035806 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-01-30 15:27:24.035828 | debian-bookworm -> localhost | | o. | 2026-01-30 15:27:24.035850 | debian-bookworm -> localhost | | o+ +.| 2026-01-30 15:27:24.035869 | debian-bookworm -> localhost | | o oO. | 2026-01-30 15:27:24.035889 | debian-bookworm -> localhost | | . o+.o | 2026-01-30 15:27:24.035908 | debian-bookworm -> localhost | | S+ o. o | 2026-01-30 15:27:24.035950 | debian-bookworm -> localhost | | o o = +X .. | 2026-01-30 15:27:24.035976 | debian-bookworm -> localhost | | . +.*.o==+. | 2026-01-30 15:27:24.035996 | debian-bookworm -> localhost | | oooEoo+o. | 2026-01-30 15:27:24.036018 | debian-bookworm -> localhost | | .o+o +*=o | 2026-01-30 15:27:24.036038 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-01-30 15:27:24.036092 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.945661 2026-01-30 15:27:24.042696 | 2026-01-30 15:27:24.042804 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-01-30 15:27:24.071482 | debian-bookworm | ok 2026-01-30 15:27:24.081135 | debian-bookworm | included: /var/lib/zuul/builds/18f8e1ccdbb649188308707f7ad78656/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-01-30 15:27:24.090371 | 2026-01-30 15:27:24.090476 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-01-30 15:27:24.124819 | debian-bookworm | skipping: Conditional result was False 2026-01-30 15:27:24.139030 | 2026-01-30 15:27:24.139199 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-01-30 15:27:24.809486 | debian-bookworm | changed 2026-01-30 15:27:24.817887 | 2026-01-30 15:27:24.818041 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-01-30 15:27:25.076436 | debian-bookworm | ok 2026-01-30 15:27:25.084862 | 2026-01-30 15:27:25.085042 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-01-30 15:27:25.761185 | debian-bookworm | changed 2026-01-30 15:27:25.769338 | 2026-01-30 15:27:25.769464 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-01-30 15:27:26.419497 | debian-bookworm | changed 2026-01-30 15:27:26.425085 | 2026-01-30 15:27:26.425189 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-01-30 15:27:26.448917 | debian-bookworm | skipping: Conditional result was False 2026-01-30 15:27:26.454951 | 2026-01-30 15:27:26.455062 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-01-30 15:27:26.946273 | debian-bookworm -> localhost | changed 2026-01-30 15:27:26.957606 | 2026-01-30 15:27:26.957736 | TASK [add-build-sshkey : Add back temp key] 2026-01-30 15:27:27.285260 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/18f8e1ccdbb649188308707f7ad78656/work/18f8e1ccdbb649188308707f7ad78656_id_rsa (zuul-build-sshkey) 2026-01-30 15:27:27.285565 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.010711 2026-01-30 15:27:27.293929 | 2026-01-30 15:27:27.294084 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-01-30 15:27:27.699156 | debian-bookworm | ok 2026-01-30 15:27:27.707829 | 2026-01-30 15:27:27.708028 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-01-30 15:27:27.733530 | debian-bookworm | skipping: Conditional result was False 2026-01-30 15:27:27.747349 | 2026-01-30 15:27:27.747467 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-01-30 15:27:28.187624 | debian-bookworm | ok 2026-01-30 15:27:28.205196 | 2026-01-30 15:27:28.205354 | TASK [validate-host : Define zuul_info_dir fact] 2026-01-30 15:27:28.240672 | debian-bookworm | ok 2026-01-30 15:27:28.245738 | 2026-01-30 15:27:28.245836 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-01-30 15:27:28.585310 | debian-bookworm -> localhost | ok 2026-01-30 15:27:28.592108 | 2026-01-30 15:27:28.592236 | TASK [validate-host : Collect information about the host] 2026-01-30 15:27:29.723804 | debian-bookworm | ok 2026-01-30 15:27:29.737583 | 2026-01-30 15:27:29.737713 | TASK [validate-host : Sanitize hostname] 2026-01-30 15:27:29.848830 | debian-bookworm | ok 2026-01-30 15:27:29.891466 | 2026-01-30 15:27:29.891601 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-01-30 15:27:30.471262 | debian-bookworm -> localhost | changed 2026-01-30 15:27:30.477244 | 2026-01-30 15:27:30.477357 | TASK [validate-host : Collect information about zuul worker] 2026-01-30 15:27:30.939735 | debian-bookworm | ok 2026-01-30 15:27:30.944757 | 2026-01-30 15:27:30.944869 | TASK [validate-host : Write out all zuul information for each host] 2026-01-30 15:27:31.495956 | debian-bookworm -> localhost | changed 2026-01-30 15:27:31.507275 | 2026-01-30 15:27:31.507400 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-01-30 15:27:31.778799 | debian-bookworm | ok 2026-01-30 15:27:31.784552 | 2026-01-30 15:27:31.784662 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-01-30 15:27:33.153532 | debian-bookworm | changed: 2026-01-30 15:27:33.153767 | debian-bookworm | cd+++++++++ src/ 2026-01-30 15:27:33.153805 | debian-bookworm | cd+++++++++ src/github.com/ 2026-01-30 15:27:33.153830 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-01-30 15:27:33.153851 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2026-01-30 15:27:33.153871 | debian-bookworm | localhost | ok: Runtime: 0:00:00.008015 2026-01-30 15:27:58.679751 | 2026-01-30 15:27:58.679873 | TASK [upload-logs : Upload logs to log server] 2026-01-30 15:27:59.255162 | localhost | Output suppressed because no_log was given 2026-01-30 15:27:59.257091 | 2026-01-30 15:27:59.257201 | LOOP [upload-logs : Compress console log and json output] 2026-01-30 15:27:59.311272 | localhost | skipping: Conditional result was False 2026-01-30 15:27:59.316457 | localhost | skipping: Conditional result was False 2026-01-30 15:27:59.329862 | 2026-01-30 15:27:59.330127 | LOOP [upload-logs : Upload compressed console log and json output] 2026-01-30 15:27:59.381593 | localhost | skipping: Conditional result was False 2026-01-30 15:27:59.382084 | 2026-01-30 15:27:59.386299 | localhost | skipping: Conditional result was False 2026-01-30 15:27:59.391594 | 2026-01-30 15:27:59.391757 | LOOP [upload-logs : Upload console log and json output]