2025-10-31 08:19:46.798508 | Job console starting 2025-10-31 08:19:46.818564 | Updating git repos 2025-10-31 08:19:46.848360 | Cloning repos into workspace 2025-10-31 08:19:46.908154 | Restoring repo states 2025-10-31 08:19:46.916367 | Merging changes 2025-10-31 08:19:47.503489 | Checking out repos 2025-10-31 08:19:47.596575 | Preparing playbooks 2025-10-31 08:19:48.933279 | Running Ansible setup 2025-10-31 08:19:56.029527 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-31 08:19:57.731611 | 2025-10-31 08:19:57.731741 | PLAY [Base pre] 2025-10-31 08:19:57.773612 | 2025-10-31 08:19:57.773735 | TASK [Setup log path fact] 2025-10-31 08:19:57.812359 | debian-bookworm | ok 2025-10-31 08:19:57.838437 | 2025-10-31 08:19:57.838566 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-31 08:19:57.887723 | debian-bookworm | ok 2025-10-31 08:19:57.909377 | 2025-10-31 08:19:57.909485 | TASK [emit-job-header : Print job information] 2025-10-31 08:19:57.979240 | # Job Information 2025-10-31 08:19:57.979401 | Ansible Version: 2.16.14 2025-10-31 08:19:57.979437 | Job: python-black 2025-10-31 08:19:57.979470 | Pipeline: check 2025-10-31 08:19:57.979493 | Executor: 521e9411259a 2025-10-31 08:19:57.979514 | Triggered by: https://github.com/osism/cfg-cookiecutter/pull/568 2025-10-31 08:19:57.979535 | Event ID: 57748740-b632-11f0-9b03-d1343a70e86b 2025-10-31 08:19:57.984240 | 2025-10-31 08:19:57.984326 | LOOP [emit-job-header : Print node information] 2025-10-31 08:19:58.178707 | debian-bookworm | ok: 2025-10-31 08:19:58.178874 | debian-bookworm | # Node Information 2025-10-31 08:19:58.178904 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-31 08:19:58.178925 | debian-bookworm | Hostname: debian 2025-10-31 08:19:58.178944 | debian-bookworm | Username: zuul 2025-10-31 08:19:58.178962 | debian-bookworm | Distro: Debian 12.12 2025-10-31 08:19:58.178981 | debian-bookworm | Provider: regiocloud-a 2025-10-31 08:19:58.178999 | debian-bookworm | Region: 2025-10-31 08:19:58.179016 | debian-bookworm | Label: debian-bookworm 2025-10-31 08:19:58.179033 | debian-bookworm | Product Name: OpenStack Nova 2025-10-31 08:19:58.179049 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe96:768e 2025-10-31 08:19:58.198766 | 2025-10-31 08:19:58.206491 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-31 08:19:59.310661 | debian-bookworm -> localhost | changed 2025-10-31 08:19:59.317505 | 2025-10-31 08:19:59.317613 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-31 08:20:00.974568 | debian-bookworm -> localhost | changed 2025-10-31 08:20:00.987789 | 2025-10-31 08:20:00.987921 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-31 08:20:01.701400 | debian-bookworm -> localhost | ok 2025-10-31 08:20:01.707287 | 2025-10-31 08:20:01.707384 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-31 08:20:01.734328 | debian-bookworm | ok 2025-10-31 08:20:01.762816 | debian-bookworm | included: /var/lib/zuul/builds/d60c4c3b4fe74be0b8f520881d8dfa8a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-31 08:20:01.780767 | 2025-10-31 08:20:01.780854 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-31 08:20:04.037531 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-31 08:20:04.037723 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/d60c4c3b4fe74be0b8f520881d8dfa8a/work/d60c4c3b4fe74be0b8f520881d8dfa8a_id_rsa 2025-10-31 08:20:04.037768 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/d60c4c3b4fe74be0b8f520881d8dfa8a/work/d60c4c3b4fe74be0b8f520881d8dfa8a_id_rsa.pub 2025-10-31 08:20:04.037800 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-31 08:20:04.037832 | debian-bookworm -> localhost | SHA256:IyS/0/+FfKpvd5Pp7lxCrKLcMtkCe08wc7UMyaEux7U zuul-build-sshkey 2025-10-31 08:20:04.037860 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-31 08:20:04.037901 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-31 08:20:04.037929 | debian-bookworm -> localhost | | . | 2025-10-31 08:20:04.037957 | debian-bookworm -> localhost | | o o | 2025-10-31 08:20:04.037986 | debian-bookworm -> localhost | | . . . = . | 2025-10-31 08:20:04.038012 | debian-bookworm -> localhost | | + o . = o | 2025-10-31 08:20:04.038037 | debian-bookworm -> localhost | | + S E o o | 2025-10-31 08:20:04.038068 | debian-bookworm -> localhost | | .* * . + | 2025-10-31 08:20:04.038096 | debian-bookworm -> localhost | | oo.oo + + +| 2025-10-31 08:20:04.038135 | debian-bookworm -> localhost | | .o*=...+o=o| 2025-10-31 08:20:04.038163 | debian-bookworm -> localhost | | .o===+.+*.| 2025-10-31 08:20:04.038181 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-31 08:20:04.038229 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.342037 2025-10-31 08:20:04.043945 | 2025-10-31 08:20:04.044030 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-31 08:20:04.081023 | debian-bookworm | ok 2025-10-31 08:20:04.088809 | debian-bookworm | included: /var/lib/zuul/builds/d60c4c3b4fe74be0b8f520881d8dfa8a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-31 08:20:04.104644 | 2025-10-31 08:20:04.104732 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-31 08:20:04.137594 | debian-bookworm | skipping: Conditional result was False 2025-10-31 08:20:04.142449 | 2025-10-31 08:20:04.142530 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-31 08:20:04.841702 | debian-bookworm | changed 2025-10-31 08:20:04.847086 | 2025-10-31 08:20:04.847170 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-31 08:20:05.109799 | debian-bookworm | ok 2025-10-31 08:20:05.115931 | 2025-10-31 08:20:05.116020 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-31 08:20:05.787674 | debian-bookworm | changed 2025-10-31 08:20:05.798982 | 2025-10-31 08:20:05.799089 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-31 08:20:06.449385 | debian-bookworm | changed 2025-10-31 08:20:06.453860 | 2025-10-31 08:20:06.453934 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-31 08:20:06.499399 | debian-bookworm | skipping: Conditional result was False 2025-10-31 08:20:06.504275 | 2025-10-31 08:20:06.504358 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-31 08:20:06.997363 | debian-bookworm -> localhost | changed 2025-10-31 08:20:07.005868 | 2025-10-31 08:20:07.005951 | TASK [add-build-sshkey : Add back temp key] 2025-10-31 08:20:07.527780 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/d60c4c3b4fe74be0b8f520881d8dfa8a/work/d60c4c3b4fe74be0b8f520881d8dfa8a_id_rsa (zuul-build-sshkey) 2025-10-31 08:20:07.527965 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.014238 2025-10-31 08:20:07.534062 | 2025-10-31 08:20:07.534172 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-31 08:20:08.032298 | debian-bookworm | ok 2025-10-31 08:20:08.038261 | 2025-10-31 08:20:08.038370 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-31 08:20:08.061532 | debian-bookworm | skipping: Conditional result was False 2025-10-31 08:20:08.070143 | 2025-10-31 08:20:08.070233 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-31 08:20:08.487260 | debian-bookworm | ok 2025-10-31 08:20:08.499833 | 2025-10-31 08:20:08.499927 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-31 08:20:08.546533 | debian-bookworm | ok 2025-10-31 08:20:08.550544 | 2025-10-31 08:20:08.550625 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-31 08:20:08.987517 | debian-bookworm -> localhost | ok 2025-10-31 08:20:08.992480 | 2025-10-31 08:20:08.992557 | TASK [validate-host : Collect information about the host] 2025-10-31 08:20:10.224898 | debian-bookworm | ok 2025-10-31 08:20:10.235061 | 2025-10-31 08:20:10.235175 | TASK [validate-host : Sanitize hostname] 2025-10-31 08:20:10.325242 | debian-bookworm | ok 2025-10-31 08:20:10.355325 | 2025-10-31 08:20:10.355426 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-31 08:20:11.183173 | debian-bookworm -> localhost | changed 2025-10-31 08:20:11.189090 | 2025-10-31 08:20:11.189202 | TASK [validate-host : Collect information about zuul worker] 2025-10-31 08:20:11.727675 | debian-bookworm | ok 2025-10-31 08:20:11.738436 | 2025-10-31 08:20:11.738525 | TASK [validate-host : Write out all zuul information for each host] 2025-10-31 08:20:12.638039 | debian-bookworm -> localhost | changed 2025-10-31 08:20:12.645458 | 2025-10-31 08:20:12.645539 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-31 08:20:12.935827 | debian-bookworm | ok 2025-10-31 08:20:12.940150 | 2025-10-31 08:20:12.940228 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-31 08:20:13.977911 | debian-bookworm | changed: 2025-10-31 08:20:13.978062 | debian-bookworm | cd+++++++++ src/ 2025-10-31 08:20:13.978089 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-31 08:20:13.978119 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-31 08:20:13.978138 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2025-10-31 08:20:13.978155 | debian-bookworm | Containerfile 2025-10-31 08:20:13.978264 | debian-bookworm | localhost | ok: Runtime: 0:00:00.013590 2025-10-31 08:20:39.668310 | 2025-10-31 08:20:39.668437 | TASK [upload-logs : Upload logs to log server] 2025-10-31 08:20:40.267870 | localhost | Output suppressed because no_log was given 2025-10-31 08:20:40.271416 | 2025-10-31 08:20:40.271549 | LOOP [upload-logs : Compress console log and json output] 2025-10-31 08:20:40.318633 | localhost | skipping: Conditional result was False 2025-10-31 08:20:40.325172 | localhost | skipping: Conditional result was False 2025-10-31 08:20:40.338013 | 2025-10-31 08:20:40.338115 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-31 08:20:40.385316 | localhost | skipping: Conditional result was False 2025-10-31 08:20:40.385505 | 2025-10-31 08:20:40.391124 | localhost | skipping: Conditional result was False 2025-10-31 08:20:40.394166 | 2025-10-31 08:20:40.394270 | LOOP [upload-logs : Upload console log and json output]