2025-11-25 18:00:56.670349 | Job console starting 2025-11-25 18:00:56.686213 | Updating git repos 2025-11-25 18:00:56.717401 | Cloning repos into workspace 2025-11-25 18:00:56.780660 | Restoring repo states 2025-11-25 18:00:56.797250 | Merging changes 2025-11-25 18:00:57.369523 | Checking out repos 2025-11-25 18:00:57.400641 | Preparing playbooks 2025-11-25 18:00:58.445683 | Running Ansible setup 2025-11-25 18:01:03.646996 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-25 18:01:04.628899 | 2025-11-25 18:01:04.629072 | PLAY [Base pre] 2025-11-25 18:01:04.661277 | 2025-11-25 18:01:04.661504 | TASK [Setup log path fact] 2025-11-25 18:01:04.704483 | debian-bookworm | ok 2025-11-25 18:01:04.727832 | 2025-11-25 18:01:04.728040 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-25 18:01:04.760545 | debian-bookworm | ok 2025-11-25 18:01:04.792300 | 2025-11-25 18:01:04.792452 | TASK [emit-job-header : Print job information] 2025-11-25 18:01:04.851861 | # Job Information 2025-11-25 18:01:04.852059 | Ansible Version: 2.16.14 2025-11-25 18:01:04.852147 | Job: python-black 2025-11-25 18:01:04.852183 | Pipeline: check 2025-11-25 18:01:04.852207 | Executor: 521e9411259a 2025-11-25 18:01:04.852228 | Triggered by: https://github.com/osism/container-image-osism-ansible/pull/706 2025-11-25 18:01:04.852252 | Event ID: ab5e4530-ca28-11f0-97a1-2477756f3c16 2025-11-25 18:01:04.857283 | 2025-11-25 18:01:04.857395 | LOOP [emit-job-header : Print node information] 2025-11-25 18:01:04.991966 | debian-bookworm | ok: 2025-11-25 18:01:04.998970 | debian-bookworm | # Node Information 2025-11-25 18:01:04.999080 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-25 18:01:04.999112 | debian-bookworm | Hostname: debian 2025-11-25 18:01:04.999712 | debian-bookworm | Username: zuul 2025-11-25 18:01:04.999758 | debian-bookworm | Distro: Debian 12.12 2025-11-25 18:01:04.999790 | debian-bookworm | Provider: regiocloud-a 2025-11-25 18:01:04.999814 | debian-bookworm | Region: 2025-11-25 18:01:04.999836 | debian-bookworm | Label: debian-bookworm 2025-11-25 18:01:04.999857 | debian-bookworm | Product Name: OpenStack Nova 2025-11-25 18:01:04.999877 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe92:b17b 2025-11-25 18:01:05.013776 | 2025-11-25 18:01:05.013928 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-25 18:01:05.607205 | debian-bookworm -> localhost | changed 2025-11-25 18:01:05.615024 | 2025-11-25 18:01:05.615164 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-25 18:01:07.282385 | debian-bookworm -> localhost | changed 2025-11-25 18:01:07.303709 | 2025-11-25 18:01:07.303859 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-25 18:01:07.754537 | debian-bookworm -> localhost | ok 2025-11-25 18:01:07.761220 | 2025-11-25 18:01:07.761351 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-25 18:01:07.790232 | debian-bookworm | ok 2025-11-25 18:01:07.825987 | debian-bookworm | included: /var/lib/zuul/builds/b6b7e86dac1149059fea0749046e8037/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-25 18:01:07.843205 | 2025-11-25 18:01:07.843351 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-25 18:01:09.745981 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-25 18:01:09.746218 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/b6b7e86dac1149059fea0749046e8037/work/b6b7e86dac1149059fea0749046e8037_id_rsa 2025-11-25 18:01:09.746258 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/b6b7e86dac1149059fea0749046e8037/work/b6b7e86dac1149059fea0749046e8037_id_rsa.pub 2025-11-25 18:01:09.746286 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-25 18:01:09.746312 | debian-bookworm -> localhost | SHA256:2zlwqgLf2WvzwlgDiHfkN0693o7cqj+cs70hJk3Isoo zuul-build-sshkey 2025-11-25 18:01:09.746351 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-25 18:01:09.746374 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-25 18:01:09.746395 | debian-bookworm -> localhost | | | 2025-11-25 18:01:09.746485 | debian-bookworm -> localhost | | . | 2025-11-25 18:01:09.746510 | debian-bookworm -> localhost | | . + . | 2025-11-25 18:01:09.746563 | debian-bookworm -> localhost | | . o +.+.. | 2025-11-25 18:01:09.746585 | debian-bookworm -> localhost | | . ..=S.o. | 2025-11-25 18:01:09.746614 | debian-bookworm -> localhost | | . o+O.. | 2025-11-25 18:01:09.746635 | debian-bookworm -> localhost | | o ..*++Bo. | 2025-11-25 18:01:09.746655 | debian-bookworm -> localhost | | .o.+.*+**.. | 2025-11-25 18:01:09.746677 | debian-bookworm -> localhost | | E ....oBB*=. | 2025-11-25 18:01:09.746698 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-25 18:01:09.746759 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.086582 2025-11-25 18:01:09.761716 | 2025-11-25 18:01:09.761837 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-25 18:01:09.804714 | debian-bookworm | ok 2025-11-25 18:01:09.822854 | debian-bookworm | included: /var/lib/zuul/builds/b6b7e86dac1149059fea0749046e8037/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-25 18:01:09.850408 | 2025-11-25 18:01:09.850579 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-25 18:01:09.888796 | debian-bookworm | skipping: Conditional result was False 2025-11-25 18:01:09.896108 | 2025-11-25 18:01:09.896247 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-25 18:01:10.747603 | debian-bookworm | changed 2025-11-25 18:01:10.753196 | 2025-11-25 18:01:10.753308 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-25 18:01:11.030191 | debian-bookworm | ok 2025-11-25 18:01:11.042956 | 2025-11-25 18:01:11.043114 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-25 18:01:11.692656 | debian-bookworm | changed 2025-11-25 18:01:11.703094 | 2025-11-25 18:01:11.703238 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-25 18:01:12.385458 | debian-bookworm | changed 2025-11-25 18:01:12.393436 | 2025-11-25 18:01:12.393622 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-25 18:01:12.418819 | debian-bookworm | skipping: Conditional result was False 2025-11-25 18:01:12.427092 | 2025-11-25 18:01:12.427244 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-25 18:01:12.979913 | debian-bookworm -> localhost | changed 2025-11-25 18:01:12.994335 | 2025-11-25 18:01:12.994470 | TASK [add-build-sshkey : Add back temp key] 2025-11-25 18:01:13.397621 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/b6b7e86dac1149059fea0749046e8037/work/b6b7e86dac1149059fea0749046e8037_id_rsa (zuul-build-sshkey) 2025-11-25 18:01:13.397882 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.021912 2025-11-25 18:01:13.406200 | 2025-11-25 18:01:13.406329 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-25 18:01:13.832162 | debian-bookworm | ok 2025-11-25 18:01:13.841781 | 2025-11-25 18:01:13.841920 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-25 18:01:13.867329 | debian-bookworm | skipping: Conditional result was False 2025-11-25 18:01:13.897109 | 2025-11-25 18:01:13.897266 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-25 18:01:14.417219 | debian-bookworm | ok 2025-11-25 18:01:14.436991 | 2025-11-25 18:01:14.437136 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-25 18:01:14.473183 | debian-bookworm | ok 2025-11-25 18:01:14.478693 | 2025-11-25 18:01:14.478812 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-25 18:01:14.920002 | debian-bookworm -> localhost | ok 2025-11-25 18:01:14.926924 | 2025-11-25 18:01:14.927049 | TASK [validate-host : Collect information about the host] 2025-11-25 18:01:16.139076 | debian-bookworm | ok 2025-11-25 18:01:16.150076 | 2025-11-25 18:01:16.150216 | TASK [validate-host : Sanitize hostname] 2025-11-25 18:01:16.251227 | debian-bookworm | ok 2025-11-25 18:01:16.294207 | 2025-11-25 18:01:16.294339 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-25 18:01:17.098311 | debian-bookworm -> localhost | changed 2025-11-25 18:01:17.104194 | 2025-11-25 18:01:17.104314 | TASK [validate-host : Collect information about zuul worker] 2025-11-25 18:01:17.544019 | debian-bookworm | ok 2025-11-25 18:01:17.549075 | 2025-11-25 18:01:17.549199 | TASK [validate-host : Write out all zuul information for each host] 2025-11-25 18:01:18.201159 | debian-bookworm -> localhost | changed 2025-11-25 18:01:18.211839 | 2025-11-25 18:01:18.211976 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-25 18:01:18.494483 | debian-bookworm | ok 2025-11-25 18:01:18.501589 | 2025-11-25 18:01:18.506159 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-25 18:01:19.475482 | debian-bookworm | changed: 2025-11-25 18:01:19.475704 | debian-bookworm | cd+++++++++ src/ 2025-11-25 18:01:19.475741 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-25 18:01:19.475767 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-25 18:01:19.475788 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-osism-ansible/ 2025-11-25 18:01:19.475809 | debian-bookworm | Containerfile 2025-11-25 18:01:19.475943 | debian-bookworm | localhost | ok: Runtime: 0:00:00.005250 2025-11-25 18:01:44.975536 | 2025-11-25 18:01:44.975656 | TASK [upload-logs : Upload logs to log server] 2025-11-25 18:01:45.621853 | localhost | Output suppressed because no_log was given 2025-11-25 18:01:45.623829 | 2025-11-25 18:01:45.623934 | LOOP [upload-logs : Compress console log and json output] 2025-11-25 18:01:45.700977 | localhost | skipping: Conditional result was False 2025-11-25 18:01:45.716446 | localhost | skipping: Conditional result was False 2025-11-25 18:01:45.730401 | 2025-11-25 18:01:45.730605 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-25 18:01:45.784672 | localhost | skipping: Conditional result was False 2025-11-25 18:01:45.784969 | 2025-11-25 18:01:45.792315 | localhost | skipping: Conditional result was False 2025-11-25 18:01:45.798353 | 2025-11-25 18:01:45.798467 | LOOP [upload-logs : Upload console log and json output]