2026-01-19 18:15:59.278467 | Job console starting 2026-01-19 18:15:59.315671 | Updating git repos 2026-01-19 18:15:59.423565 | Cloning repos into workspace 2026-01-19 18:15:59.591500 | Restoring repo states 2026-01-19 18:15:59.626040 | Merging changes 2026-01-19 18:16:00.254692 | Checking out repos 2026-01-19 18:16:00.359604 | Preparing playbooks 2026-01-19 18:16:01.960303 | Running Ansible setup 2026-01-19 18:16:07.015198 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-01-19 18:16:08.282988 | 2026-01-19 18:16:08.283151 | PLAY [Base pre] 2026-01-19 18:16:08.323280 | 2026-01-19 18:16:08.323486 | TASK [Setup log path fact] 2026-01-19 18:16:08.374397 | debian-bookworm | ok 2026-01-19 18:16:08.397254 | 2026-01-19 18:16:08.397425 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-19 18:16:08.457294 | debian-bookworm | ok 2026-01-19 18:16:08.498342 | 2026-01-19 18:16:08.498488 | TASK [emit-job-header : Print job information] 2026-01-19 18:16:08.578154 | # Job Information 2026-01-19 18:16:08.578360 | Ansible Version: 2.16.14 2026-01-19 18:16:08.578397 | Job: python-black 2026-01-19 18:16:08.578430 | Pipeline: check 2026-01-19 18:16:08.578454 | Executor: 521e9411259a 2026-01-19 18:16:08.578475 | Triggered by: https://github.com/osism/python-osism/pull/1946 2026-01-19 18:16:08.578498 | Event ID: e28e1d90-f562-11f0-8797-7d4dcd412294 2026-01-19 18:16:08.583614 | 2026-01-19 18:16:08.583732 | LOOP [emit-job-header : Print node information] 2026-01-19 18:16:08.751768 | debian-bookworm | ok: 2026-01-19 18:16:08.751953 | debian-bookworm | # Node Information 2026-01-19 18:16:08.751989 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-01-19 18:16:08.752014 | debian-bookworm | Hostname: debian 2026-01-19 18:16:08.752037 | debian-bookworm | Username: zuul 2026-01-19 18:16:08.752058 | debian-bookworm | Distro: Debian 12.13 2026-01-19 18:16:08.752081 | debian-bookworm | Provider: regiocloud-a 2026-01-19 18:16:08.752102 | debian-bookworm | Region: 2026-01-19 18:16:08.752123 | debian-bookworm | Label: debian-bookworm 2026-01-19 18:16:08.752143 | debian-bookworm | Product Name: OpenStack Nova 2026-01-19 18:16:08.752163 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe11:e35a 2026-01-19 18:16:08.770685 | 2026-01-19 18:16:08.770822 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-01-19 18:16:09.710140 | debian-bookworm -> localhost | changed 2026-01-19 18:16:09.717554 | 2026-01-19 18:16:09.717689 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-01-19 18:16:11.471193 | debian-bookworm -> localhost | changed 2026-01-19 18:16:11.479745 | 2026-01-19 18:16:11.479821 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-01-19 18:16:11.789947 | debian-bookworm -> localhost | ok 2026-01-19 18:16:11.800730 | 2026-01-19 18:16:11.800876 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-01-19 18:16:11.828879 | debian-bookworm | ok 2026-01-19 18:16:11.858607 | debian-bookworm | included: /var/lib/zuul/builds/1b32346de00d4f95b960f4ac0cbee707/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-01-19 18:16:11.874797 | 2026-01-19 18:16:11.874914 | TASK [add-build-sshkey : Create Temp SSH key] 2026-01-19 18:16:13.299555 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-01-19 18:16:13.299747 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/1b32346de00d4f95b960f4ac0cbee707/work/1b32346de00d4f95b960f4ac0cbee707_id_rsa 2026-01-19 18:16:13.299784 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/1b32346de00d4f95b960f4ac0cbee707/work/1b32346de00d4f95b960f4ac0cbee707_id_rsa.pub 2026-01-19 18:16:13.299810 | debian-bookworm -> localhost | The key fingerprint is: 2026-01-19 18:16:13.299835 | debian-bookworm -> localhost | SHA256:4luuKzlNy9V5Cms2ZPbWmwDnTSjJUtzM2tBqoRl1Nnw zuul-build-sshkey 2026-01-19 18:16:13.299857 | debian-bookworm -> localhost | The key's randomart image is: 2026-01-19 18:16:13.299888 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-01-19 18:16:13.299910 | debian-bookworm -> localhost | | ..+ | 2026-01-19 18:16:13.299932 | debian-bookworm -> localhost | | o B..E | 2026-01-19 18:16:13.299954 | debian-bookworm -> localhost | | . = =. | 2026-01-19 18:16:13.299974 | debian-bookworm -> localhost | | * B . | 2026-01-19 18:16:13.299994 | debian-bookworm -> localhost | | = S.+.. | 2026-01-19 18:16:13.300018 | debian-bookworm -> localhost | | ..+*=oo. | 2026-01-19 18:16:13.300039 | debian-bookworm -> localhost | | =.*.+o+. | 2026-01-19 18:16:13.300058 | debian-bookworm -> localhost | | + ++= +... | 2026-01-19 18:16:13.300079 | debian-bookworm -> localhost | | o+=.o o. | 2026-01-19 18:16:13.300099 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-01-19 18:16:13.300148 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.642745 2026-01-19 18:16:13.306137 | 2026-01-19 18:16:13.306242 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-01-19 18:16:13.343348 | debian-bookworm | ok 2026-01-19 18:16:13.360325 | debian-bookworm | included: /var/lib/zuul/builds/1b32346de00d4f95b960f4ac0cbee707/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-01-19 18:16:13.390212 | 2026-01-19 18:16:13.390294 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-01-19 18:16:13.423067 | debian-bookworm | skipping: Conditional result was False 2026-01-19 18:16:13.428531 | 2026-01-19 18:16:13.428649 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-01-19 18:16:14.144950 | debian-bookworm | changed 2026-01-19 18:16:14.154162 | 2026-01-19 18:16:14.154285 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-01-19 18:16:14.373724 | debian-bookworm | ok 2026-01-19 18:16:14.378988 | 2026-01-19 18:16:14.379073 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-01-19 18:16:14.968260 | debian-bookworm | changed 2026-01-19 18:16:14.976356 | 2026-01-19 18:16:14.976467 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-01-19 18:16:15.584765 | debian-bookworm | changed 2026-01-19 18:16:15.592643 | 2026-01-19 18:16:15.592763 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-01-19 18:16:15.615925 | debian-bookworm | skipping: Conditional result was False 2026-01-19 18:16:15.622736 | 2026-01-19 18:16:15.622827 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-01-19 18:16:16.010805 | debian-bookworm -> localhost | changed 2026-01-19 18:16:16.034155 | 2026-01-19 18:16:16.034320 | TASK [add-build-sshkey : Add back temp key] 2026-01-19 18:16:16.367860 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/1b32346de00d4f95b960f4ac0cbee707/work/1b32346de00d4f95b960f4ac0cbee707_id_rsa (zuul-build-sshkey) 2026-01-19 18:16:16.368310 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.040218 2026-01-19 18:16:16.383020 | 2026-01-19 18:16:16.383130 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-01-19 18:16:16.779810 | debian-bookworm | ok 2026-01-19 18:16:16.785748 | 2026-01-19 18:16:16.785847 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-01-19 18:16:16.818975 | debian-bookworm | skipping: Conditional result was False 2026-01-19 18:16:16.831472 | 2026-01-19 18:16:16.831575 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-01-19 18:16:17.259254 | debian-bookworm | ok 2026-01-19 18:16:17.280890 | 2026-01-19 18:16:17.281003 | TASK [validate-host : Define zuul_info_dir fact] 2026-01-19 18:16:17.329784 | debian-bookworm | ok 2026-01-19 18:16:17.334701 | 2026-01-19 18:16:17.334797 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-01-19 18:16:17.769070 | debian-bookworm -> localhost | ok 2026-01-19 18:16:17.775135 | 2026-01-19 18:16:17.775234 | TASK [validate-host : Collect information about the host] 2026-01-19 18:16:18.815490 | debian-bookworm | ok 2026-01-19 18:16:18.830252 | 2026-01-19 18:16:18.830343 | TASK [validate-host : Sanitize hostname] 2026-01-19 18:16:18.928984 | debian-bookworm | ok 2026-01-19 18:16:18.959176 | 2026-01-19 18:16:18.959272 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-01-19 18:16:19.461250 | debian-bookworm -> localhost | changed 2026-01-19 18:16:19.465720 | 2026-01-19 18:16:19.465793 | TASK [validate-host : Collect information about zuul worker] 2026-01-19 18:16:19.835476 | debian-bookworm | ok 2026-01-19 18:16:19.839715 | 2026-01-19 18:16:19.839793 | TASK [validate-host : Write out all zuul information for each host] 2026-01-19 18:16:20.577422 | debian-bookworm -> localhost | changed 2026-01-19 18:16:20.586489 | 2026-01-19 18:16:20.586579 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-01-19 18:16:20.823842 | debian-bookworm | ok 2026-01-19 18:16:20.828922 | 2026-01-19 18:16:20.829010 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-01-19 18:16:21.861493 | debian-bookworm | changed: 2026-01-19 18:16:21.861685 | debian-bookworm | cd+++++++++ src/ 2026-01-19 18:16:21.861718 | debian-bookworm | cd+++++++++ src/github.com/ 2026-01-19 18:16:21.861742 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-01-19 18:16:21.861763 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-01-19 18:16:21.861783 | debian-bookworm | Containerfile 2026-01-19 18:16:21.861914 | debian-bookworm | Containerfile 2026-01-19 18:16:21.907369 | debian-bookworm | localhost | ok: Runtime: 0:00:00.009016 2026-01-19 18:16:48.326340 | 2026-01-19 18:16:48.326506 | TASK [upload-logs : Upload logs to log server] 2026-01-19 18:16:48.897479 | localhost | Output suppressed because no_log was given 2026-01-19 18:16:48.901798 | 2026-01-19 18:16:48.902014 | LOOP [upload-logs : Compress console log and json output] 2026-01-19 18:16:48.961380 | localhost | skipping: Conditional result was False 2026-01-19 18:16:48.966891 | localhost | skipping: Conditional result was False 2026-01-19 18:16:48.972774 | 2026-01-19 18:16:48.972935 | LOOP [upload-logs : Upload compressed console log and json output] 2026-01-19 18:16:49.041011 | localhost | skipping: Conditional result was False 2026-01-19 18:16:49.041615 | 2026-01-19 18:16:49.046546 | localhost | skipping: Conditional result was False 2026-01-19 18:16:49.055295 | 2026-01-19 18:16:49.055518 | LOOP [upload-logs : Upload console log and json output]