2025-11-25 15:37:06.867555 | Job console starting 2025-11-25 15:37:06.903143 | Updating git repos 2025-11-25 15:37:06.950775 | Cloning repos into workspace 2025-11-25 15:37:07.016200 | Restoring repo states 2025-11-25 15:37:07.074088 | Merging changes 2025-11-25 15:37:07.789141 | Checking out repos 2025-11-25 15:37:07.892839 | Preparing playbooks 2025-11-25 15:37:09.106818 | Running Ansible setup 2025-11-25 15:37:15.197250 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-25 15:37:16.687085 | 2025-11-25 15:37:16.687256 | PLAY [Base pre] 2025-11-25 15:37:16.731574 | 2025-11-25 15:37:16.731739 | TASK [Setup log path fact] 2025-11-25 15:37:16.767301 | debian-bookworm | ok 2025-11-25 15:37:16.801094 | 2025-11-25 15:37:16.801276 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-25 15:37:16.852610 | debian-bookworm | ok 2025-11-25 15:37:16.885705 | 2025-11-25 15:37:16.888094 | TASK [emit-job-header : Print job information] 2025-11-25 15:37:16.964996 | # Job Information 2025-11-25 15:37:16.965395 | Ansible Version: 2.16.14 2025-11-25 15:37:16.965446 | Job: python-black 2025-11-25 15:37:16.965486 | Pipeline: check 2025-11-25 15:37:16.965510 | Executor: 521e9411259a 2025-11-25 15:37:16.965532 | Triggered by: https://github.com/osism/python-osism/pull/1786 2025-11-25 15:37:16.965559 | Event ID: 9380e4e0-ca14-11f0-96f5-4ce0940acedf 2025-11-25 15:37:16.971129 | 2025-11-25 15:37:16.971279 | LOOP [emit-job-header : Print node information] 2025-11-25 15:37:17.102640 | debian-bookworm | ok: 2025-11-25 15:37:17.104999 | debian-bookworm | # Node Information 2025-11-25 15:37:17.105093 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-25 15:37:17.105128 | debian-bookworm | Hostname: debian 2025-11-25 15:37:17.105152 | debian-bookworm | Username: zuul 2025-11-25 15:37:17.105173 | debian-bookworm | Distro: Debian 12.12 2025-11-25 15:37:17.105199 | debian-bookworm | Provider: regiocloud-a 2025-11-25 15:37:17.105220 | debian-bookworm | Region: 2025-11-25 15:37:17.105241 | debian-bookworm | Label: debian-bookworm 2025-11-25 15:37:17.105261 | debian-bookworm | Product Name: OpenStack Nova 2025-11-25 15:37:17.105279 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe23:990a 2025-11-25 15:37:17.118496 | 2025-11-25 15:37:17.118638 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-25 15:37:18.091749 | debian-bookworm -> localhost | changed 2025-11-25 15:37:18.099604 | 2025-11-25 15:37:18.099742 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-25 15:37:19.879204 | debian-bookworm -> localhost | changed 2025-11-25 15:37:19.887846 | 2025-11-25 15:37:19.887939 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-25 15:37:20.379849 | debian-bookworm -> localhost | ok 2025-11-25 15:37:20.384717 | 2025-11-25 15:37:20.384803 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-25 15:37:20.427062 | debian-bookworm | ok 2025-11-25 15:37:20.450893 | debian-bookworm | included: /var/lib/zuul/builds/711736591f964c43a39a9f1579ae7064/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-25 15:37:20.456027 | 2025-11-25 15:37:20.456111 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-25 15:37:22.768996 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-25 15:37:22.769203 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/711736591f964c43a39a9f1579ae7064/work/711736591f964c43a39a9f1579ae7064_id_rsa 2025-11-25 15:37:22.769240 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/711736591f964c43a39a9f1579ae7064/work/711736591f964c43a39a9f1579ae7064_id_rsa.pub 2025-11-25 15:37:22.769266 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-25 15:37:22.769290 | debian-bookworm -> localhost | SHA256:rDyBwHOqFQKqj+nuqz9WjJFstGoEkoGWSrN9RSmSz+s zuul-build-sshkey 2025-11-25 15:37:22.769311 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-25 15:37:22.769341 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-25 15:37:22.769396 | debian-bookworm -> localhost | |+o. . ... | 2025-11-25 15:37:22.769418 | debian-bookworm -> localhost | |B*.o . o | 2025-11-25 15:37:22.769438 | debian-bookworm -> localhost | |OoOo= o | 2025-11-25 15:37:22.769458 | debian-bookworm -> localhost | |o+*B = . | 2025-11-25 15:37:22.769477 | debian-bookworm -> localhost | |ooo+o o S | 2025-11-25 15:37:22.769498 | debian-bookworm -> localhost | |.B. oo o | 2025-11-25 15:37:22.769518 | debian-bookworm -> localhost | |= ... + | 2025-11-25 15:37:22.769538 | debian-bookworm -> localhost | |. o E . | 2025-11-25 15:37:22.769558 | debian-bookworm -> localhost | |=Bo. | 2025-11-25 15:37:22.769578 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-25 15:37:22.769626 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.582905 2025-11-25 15:37:22.775735 | 2025-11-25 15:37:22.775868 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-25 15:37:22.793080 | debian-bookworm | ok 2025-11-25 15:37:22.802251 | debian-bookworm | included: /var/lib/zuul/builds/711736591f964c43a39a9f1579ae7064/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-25 15:37:22.811067 | 2025-11-25 15:37:22.811155 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-25 15:37:22.834280 | debian-bookworm | skipping: Conditional result was False 2025-11-25 15:37:22.839831 | 2025-11-25 15:37:22.839918 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-25 15:37:23.441781 | debian-bookworm | changed 2025-11-25 15:37:23.449641 | 2025-11-25 15:37:23.449752 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-25 15:37:23.701729 | debian-bookworm | ok 2025-11-25 15:37:23.707146 | 2025-11-25 15:37:23.707234 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-25 15:37:24.352220 | debian-bookworm | changed 2025-11-25 15:37:24.358769 | 2025-11-25 15:37:24.358878 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-25 15:37:25.044429 | debian-bookworm | changed 2025-11-25 15:37:25.049754 | 2025-11-25 15:37:25.049847 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-25 15:37:25.088033 | debian-bookworm | skipping: Conditional result was False 2025-11-25 15:37:25.093734 | 2025-11-25 15:37:25.093830 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-25 15:37:25.622341 | debian-bookworm -> localhost | changed 2025-11-25 15:37:25.632500 | 2025-11-25 15:37:25.632599 | TASK [add-build-sshkey : Add back temp key] 2025-11-25 15:37:26.101049 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/711736591f964c43a39a9f1579ae7064/work/711736591f964c43a39a9f1579ae7064_id_rsa (zuul-build-sshkey) 2025-11-25 15:37:26.101321 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.012653 2025-11-25 15:37:26.110160 | 2025-11-25 15:37:26.110298 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-25 15:37:26.535555 | debian-bookworm | ok 2025-11-25 15:37:26.540896 | 2025-11-25 15:37:26.541016 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-25 15:37:26.592961 | debian-bookworm | skipping: Conditional result was False 2025-11-25 15:37:26.604139 | 2025-11-25 15:37:26.604271 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-25 15:37:27.065659 | debian-bookworm | ok 2025-11-25 15:37:27.089583 | 2025-11-25 15:37:27.089739 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-25 15:37:27.161113 | debian-bookworm | ok 2025-11-25 15:37:27.169610 | 2025-11-25 15:37:27.169760 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-25 15:37:27.521804 | debian-bookworm -> localhost | ok 2025-11-25 15:37:27.531723 | 2025-11-25 15:37:27.531866 | TASK [validate-host : Collect information about the host] 2025-11-25 15:37:28.689941 | debian-bookworm | ok 2025-11-25 15:37:28.701991 | 2025-11-25 15:37:28.702127 | TASK [validate-host : Sanitize hostname] 2025-11-25 15:37:28.813663 | debian-bookworm | ok 2025-11-25 15:37:28.862628 | 2025-11-25 15:37:28.862763 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-25 15:37:29.944017 | debian-bookworm -> localhost | changed 2025-11-25 15:37:29.950150 | 2025-11-25 15:37:29.950274 | TASK [validate-host : Collect information about zuul worker] 2025-11-25 15:37:30.394575 | debian-bookworm | ok 2025-11-25 15:37:30.399545 | 2025-11-25 15:37:30.399671 | TASK [validate-host : Write out all zuul information for each host] 2025-11-25 15:37:31.407470 | debian-bookworm -> localhost | changed 2025-11-25 15:37:31.417809 | 2025-11-25 15:37:31.417951 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-25 15:37:31.741585 | debian-bookworm | ok 2025-11-25 15:37:31.756620 | 2025-11-25 15:37:31.756818 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-25 15:37:33.106805 | debian-bookworm | changed: 2025-11-25 15:37:33.107146 | debian-bookworm | cd+++++++++ src/ 2025-11-25 15:37:33.107185 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-25 15:37:33.107210 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-25 15:37:33.107232 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-11-25 15:37:33.107253 | debian-bookworm | Containerfile 2025-11-25 15:37:33.107381 | debian-bookworm | Containerfile 2025-11-25 15:37:33.152214 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007364 2025-11-25 15:38:01.265570 | 2025-11-25 15:38:01.265740 | TASK [upload-logs : Upload logs to log server] 2025-11-25 15:38:01.925026 | localhost | Output suppressed because no_log was given 2025-11-25 15:38:01.927005 | 2025-11-25 15:38:01.927117 | LOOP [upload-logs : Compress console log and json output] 2025-11-25 15:38:01.985739 | localhost | skipping: Conditional result was False 2025-11-25 15:38:01.991424 | localhost | skipping: Conditional result was False 2025-11-25 15:38:02.000797 | 2025-11-25 15:38:02.001031 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-25 15:38:02.065746 | localhost | skipping: Conditional result was False 2025-11-25 15:38:02.066040 | 2025-11-25 15:38:02.073307 | localhost | skipping: Conditional result was False 2025-11-25 15:38:02.080335 | 2025-11-25 15:38:02.080485 | LOOP [upload-logs : Upload console log and json output]