2025-09-09 18:19:03.051512 | Job console starting 2025-09-09 18:19:03.059718 | Updating git repos 2025-09-09 18:19:03.083433 | Cloning repos into workspace 2025-09-09 18:19:03.111438 | Restoring repo states 2025-09-09 18:19:03.114567 | Merging changes 2025-09-09 18:19:03.534418 | Checking out repos 2025-09-09 18:19:03.557734 | Preparing playbooks 2025-09-09 18:19:04.086338 | Running Ansible setup 2025-09-09 18:19:08.808028 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-09 18:19:09.739750 | 2025-09-09 18:19:09.739956 | PLAY [Base pre] 2025-09-09 18:19:09.767765 | 2025-09-09 18:19:09.767950 | TASK [Setup log path fact] 2025-09-09 18:19:09.787464 | debian-bookworm | ok 2025-09-09 18:19:09.806031 | 2025-09-09 18:19:09.807199 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-09 18:19:09.861955 | debian-bookworm | ok 2025-09-09 18:19:09.901703 | 2025-09-09 18:19:09.901882 | TASK [emit-job-header : Print job information] 2025-09-09 18:19:09.975567 | # Job Information 2025-09-09 18:19:09.975760 | Ansible Version: 2.16.14 2025-09-09 18:19:09.975833 | Job: python-black 2025-09-09 18:19:09.975869 | Pipeline: check 2025-09-09 18:19:09.975892 | Executor: 521e9411259a 2025-09-09 18:19:09.975913 | Triggered by: https://github.com/osism/cfg-cookiecutter/pull/778 2025-09-09 18:19:09.975935 | Event ID: 37b790f0-8da6-11f0-8cd6-fd73a832964c 2025-09-09 18:19:09.993013 | 2025-09-09 18:19:09.993162 | LOOP [emit-job-header : Print node information] 2025-09-09 18:19:10.229451 | debian-bookworm | ok: 2025-09-09 18:19:10.229931 | debian-bookworm | # Node Information 2025-09-09 18:19:10.230208 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-09 18:19:10.230247 | debian-bookworm | Hostname: debian 2025-09-09 18:19:10.230274 | debian-bookworm | Username: zuul 2025-09-09 18:19:10.230297 | debian-bookworm | Distro: Debian 12.12 2025-09-09 18:19:10.230436 | debian-bookworm | Provider: regiocloud-a 2025-09-09 18:19:10.230463 | debian-bookworm | Region: 2025-09-09 18:19:10.230485 | debian-bookworm | Label: debian-bookworm 2025-09-09 18:19:10.230506 | debian-bookworm | Product Name: OpenStack Nova 2025-09-09 18:19:10.230526 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe34:8f60 2025-09-09 18:19:10.253985 | 2025-09-09 18:19:10.254484 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-09 18:19:10.832736 | debian-bookworm -> localhost | changed 2025-09-09 18:19:10.840346 | 2025-09-09 18:19:10.840477 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-09 18:19:12.125610 | debian-bookworm -> localhost | changed 2025-09-09 18:19:12.139852 | 2025-09-09 18:19:12.139989 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-09 18:19:12.539037 | debian-bookworm -> localhost | ok 2025-09-09 18:19:12.545523 | 2025-09-09 18:19:12.545652 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-09 18:19:12.585694 | debian-bookworm | ok 2025-09-09 18:19:12.612491 | debian-bookworm | included: /var/lib/zuul/builds/392fa4764b654ead822e9ffa8b9aae32/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-09 18:19:12.625302 | 2025-09-09 18:19:12.625422 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-09 18:19:14.178035 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-09 18:19:14.178280 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/392fa4764b654ead822e9ffa8b9aae32/work/392fa4764b654ead822e9ffa8b9aae32_id_rsa 2025-09-09 18:19:14.178321 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/392fa4764b654ead822e9ffa8b9aae32/work/392fa4764b654ead822e9ffa8b9aae32_id_rsa.pub 2025-09-09 18:19:14.178349 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-09 18:19:14.178372 | debian-bookworm -> localhost | SHA256:ZW4qF4W+M9HV7nqqKEfRFYK4ckzIYjUWPa4A3Vtl6aU zuul-build-sshkey 2025-09-09 18:19:14.178394 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-09 18:19:14.178451 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-09 18:19:14.178474 | debian-bookworm -> localhost | | . +=+ ooo. .. | 2025-09-09 18:19:14.178495 | debian-bookworm -> localhost | |. +.+.*.o..... | 2025-09-09 18:19:14.178515 | debian-bookworm -> localhost | | o . * +.++.. . | 2025-09-09 18:19:14.178535 | debian-bookworm -> localhost | | . o =.E*.. . | 2025-09-09 18:19:14.178555 | debian-bookworm -> localhost | | . + S.+ . | 2025-09-09 18:19:14.178584 | debian-bookworm -> localhost | | . .* . | 2025-09-09 18:19:14.178606 | debian-bookworm -> localhost | | ..* . | 2025-09-09 18:19:14.178625 | debian-bookworm -> localhost | | .o.+ .. | 2025-09-09 18:19:14.178647 | debian-bookworm -> localhost | | o. ..oo | 2025-09-09 18:19:14.178668 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-09 18:19:14.178724 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.472405 2025-09-09 18:19:14.185427 | 2025-09-09 18:19:14.185556 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-09 18:19:14.214122 | debian-bookworm | ok 2025-09-09 18:19:14.223672 | debian-bookworm | included: /var/lib/zuul/builds/392fa4764b654ead822e9ffa8b9aae32/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-09 18:19:14.232826 | 2025-09-09 18:19:14.232944 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-09 18:19:14.267037 | debian-bookworm | skipping: Conditional result was False 2025-09-09 18:19:14.273575 | 2025-09-09 18:19:14.273697 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-09 18:19:15.007062 | debian-bookworm | changed 2025-09-09 18:19:15.012567 | 2025-09-09 18:19:15.012675 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-09 18:19:15.267155 | debian-bookworm | ok 2025-09-09 18:19:15.273399 | 2025-09-09 18:19:15.273519 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-09 18:19:15.986634 | debian-bookworm | changed 2025-09-09 18:19:15.998543 | 2025-09-09 18:19:15.998687 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-09 18:19:16.659313 | debian-bookworm | changed 2025-09-09 18:19:16.665022 | 2025-09-09 18:19:16.665133 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-09 18:19:16.690335 | debian-bookworm | skipping: Conditional result was False 2025-09-09 18:19:16.696607 | 2025-09-09 18:19:16.696719 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-09 18:19:17.314907 | debian-bookworm -> localhost | changed 2025-09-09 18:19:17.336678 | 2025-09-09 18:19:17.336835 | TASK [add-build-sshkey : Add back temp key] 2025-09-09 18:19:17.979198 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/392fa4764b654ead822e9ffa8b9aae32/work/392fa4764b654ead822e9ffa8b9aae32_id_rsa (zuul-build-sshkey) 2025-09-09 18:19:17.979449 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.019654 2025-09-09 18:19:17.988159 | 2025-09-09 18:19:17.988278 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-09 18:19:18.433703 | debian-bookworm | ok 2025-09-09 18:19:18.444337 | 2025-09-09 18:19:18.444462 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-09 18:19:18.488533 | debian-bookworm | skipping: Conditional result was False 2025-09-09 18:19:18.500091 | 2025-09-09 18:19:18.500215 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-09 18:19:18.935370 | debian-bookworm | ok 2025-09-09 18:19:18.959551 | 2025-09-09 18:19:18.959684 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-09 18:19:19.019201 | debian-bookworm | ok 2025-09-09 18:19:19.024851 | 2025-09-09 18:19:19.024978 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-09 18:19:19.418316 | debian-bookworm -> localhost | ok 2025-09-09 18:19:19.425099 | 2025-09-09 18:19:19.425225 | TASK [validate-host : Collect information about the host] 2025-09-09 18:19:20.554223 | debian-bookworm | ok 2025-09-09 18:19:20.565422 | 2025-09-09 18:19:20.565539 | TASK [validate-host : Sanitize hostname] 2025-09-09 18:19:20.704532 | debian-bookworm | ok 2025-09-09 18:19:20.750546 | 2025-09-09 18:19:20.750670 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-09 18:19:21.330286 | debian-bookworm -> localhost | changed 2025-09-09 18:19:21.343440 | 2025-09-09 18:19:21.343802 | TASK [validate-host : Collect information about zuul worker] 2025-09-09 18:19:21.775821 | debian-bookworm | ok 2025-09-09 18:19:21.787610 | 2025-09-09 18:19:21.787754 | TASK [validate-host : Write out all zuul information for each host] 2025-09-09 18:19:22.373501 | debian-bookworm -> localhost | changed 2025-09-09 18:19:22.389671 | 2025-09-09 18:19:22.390088 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-09 18:19:22.685306 | debian-bookworm | ok 2025-09-09 18:19:22.692580 | 2025-09-09 18:19:22.692690 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-09 18:19:23.569356 | debian-bookworm | changed: 2025-09-09 18:19:23.569654 | debian-bookworm | cd+++++++++ src/ 2025-09-09 18:19:23.569702 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-09 18:19:23.569733 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-09 18:19:23.569760 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2025-09-09 18:19:23.570018 | debian-bookworm | Containerfile 2025-09-09 18:19:23.570201 | debian-bookworm | localhost | ok: Runtime: 0:00:00.008466 2025-09-09 18:19:49.969704 | 2025-09-09 18:19:49.969838 | TASK [upload-logs : Upload logs to log server] 2025-09-09 18:19:50.743806 | localhost | Output suppressed because no_log was given 2025-09-09 18:19:50.745400 | 2025-09-09 18:19:50.745484 | LOOP [upload-logs : Compress console log and json output] 2025-09-09 18:19:50.786534 | localhost | skipping: Conditional result was False 2025-09-09 18:19:50.792051 | localhost | skipping: Conditional result was False 2025-09-09 18:19:50.800648 | 2025-09-09 18:19:50.800742 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-09 18:19:50.871714 | localhost | skipping: Conditional result was False 2025-09-09 18:19:50.871953 | 2025-09-09 18:19:50.877183 | localhost | skipping: Conditional result was False 2025-09-09 18:19:50.892639 | 2025-09-09 18:19:50.892876 | LOOP [upload-logs : Upload console log and json output]