2025-06-01 14:31:59.590482 | Job console starting 2025-06-01 14:31:59.620813 | Updating git repos 2025-06-01 14:31:59.676559 | Cloning repos into workspace 2025-06-01 14:31:59.746732 | Restoring repo states 2025-06-01 14:31:59.757790 | Merging changes 2025-06-01 14:32:00.285029 | Checking out repos 2025-06-01 14:32:00.357636 | Preparing playbooks 2025-06-01 14:32:01.332456 | Running Ansible setup 2025-06-01 14:32:05.907615 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-06-01 14:32:06.761541 | 2025-06-01 14:32:06.761743 | PLAY [Base pre] 2025-06-01 14:32:06.779687 | 2025-06-01 14:32:06.779856 | TASK [Setup log path fact] 2025-06-01 14:32:06.803697 | debian-bookworm | ok 2025-06-01 14:32:06.823910 | 2025-06-01 14:32:06.824079 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-06-01 14:32:06.865705 | debian-bookworm | ok 2025-06-01 14:32:06.885525 | 2025-06-01 14:32:06.885674 | TASK [emit-job-header : Print job information] 2025-06-01 14:32:06.946659 | # Job Information 2025-06-01 14:32:06.947015 | Ansible Version: 2.16.14 2025-06-01 14:32:06.947057 | Job: python-black 2025-06-01 14:32:06.947099 | Pipeline: check 2025-06-01 14:32:06.947128 | Executor: 521e9411259a 2025-06-01 14:32:06.947149 | Triggered by: https://github.com/osism/python-osism/pull/1384 2025-06-01 14:32:06.947172 | Event ID: 280a5200-3ef5-11f0-8539-26d382079500 2025-06-01 14:32:06.967041 | 2025-06-01 14:32:06.967208 | LOOP [emit-job-header : Print node information] 2025-06-01 14:32:07.132804 | debian-bookworm | ok: 2025-06-01 14:32:07.133152 | debian-bookworm | # Node Information 2025-06-01 14:32:07.133193 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-06-01 14:32:07.133218 | debian-bookworm | Hostname: debian 2025-06-01 14:32:07.133242 | debian-bookworm | Username: zuul 2025-06-01 14:32:07.133263 | debian-bookworm | Distro: Debian 12.11 2025-06-01 14:32:07.133332 | debian-bookworm | Provider: regiocloud-a 2025-06-01 14:32:07.133354 | debian-bookworm | Region: 2025-06-01 14:32:07.133375 | debian-bookworm | Label: debian-bookworm 2025-06-01 14:32:07.133396 | debian-bookworm | Product Name: OpenStack Nova 2025-06-01 14:32:07.133416 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe04:7dc6 2025-06-01 14:32:07.157411 | 2025-06-01 14:32:07.157583 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-06-01 14:32:07.882035 | debian-bookworm -> localhost | changed 2025-06-01 14:32:07.890528 | 2025-06-01 14:32:07.890686 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-06-01 14:32:09.373991 | debian-bookworm -> localhost | changed 2025-06-01 14:32:09.386603 | 2025-06-01 14:32:09.386745 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-06-01 14:32:09.696412 | debian-bookworm -> localhost | ok 2025-06-01 14:32:09.704908 | 2025-06-01 14:32:09.705110 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-06-01 14:32:09.735180 | debian-bookworm | ok 2025-06-01 14:32:09.757451 | debian-bookworm | included: /var/lib/zuul/builds/ecc6220d4eed4a289638102102dbe989/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-06-01 14:32:09.763797 | 2025-06-01 14:32:09.763898 | TASK [add-build-sshkey : Create Temp SSH key] 2025-06-01 14:32:11.670761 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-06-01 14:32:11.671088 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/ecc6220d4eed4a289638102102dbe989/work/ecc6220d4eed4a289638102102dbe989_id_rsa 2025-06-01 14:32:11.671132 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/ecc6220d4eed4a289638102102dbe989/work/ecc6220d4eed4a289638102102dbe989_id_rsa.pub 2025-06-01 14:32:11.671158 | debian-bookworm -> localhost | The key fingerprint is: 2025-06-01 14:32:11.671183 | debian-bookworm -> localhost | SHA256:7KH6Sby4FpThSc4YrQ4qlP3ZxasBgz3r+3K0EwZ4Ak8 zuul-build-sshkey 2025-06-01 14:32:11.671205 | debian-bookworm -> localhost | The key's randomart image is: 2025-06-01 14:32:11.671239 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-06-01 14:32:11.671261 | debian-bookworm -> localhost | | . | 2025-06-01 14:32:11.671318 | debian-bookworm -> localhost | | ..E+ | 2025-06-01 14:32:11.671340 | debian-bookworm -> localhost | | *O++ . | 2025-06-01 14:32:11.671360 | debian-bookworm -> localhost | |.oo*BB . o | 2025-06-01 14:32:11.671380 | debian-bookworm -> localhost | |oo .+ O S . | 2025-06-01 14:32:11.671407 | debian-bookworm -> localhost | |o . .= O o | 2025-06-01 14:32:11.671427 | debian-bookworm -> localhost | |. ..* * | 2025-06-01 14:32:11.671448 | debian-bookworm -> localhost | | .* B | 2025-06-01 14:32:11.671470 | debian-bookworm -> localhost | | .++O.. | 2025-06-01 14:32:11.671491 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-06-01 14:32:11.671565 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.171516 2025-06-01 14:32:11.678694 | 2025-06-01 14:32:11.678811 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-06-01 14:32:11.727870 | debian-bookworm | ok 2025-06-01 14:32:11.770940 | debian-bookworm | included: /var/lib/zuul/builds/ecc6220d4eed4a289638102102dbe989/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-06-01 14:32:11.784010 | 2025-06-01 14:32:11.784149 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-06-01 14:32:11.857964 | debian-bookworm | skipping: Conditional result was False 2025-06-01 14:32:11.864926 | 2025-06-01 14:32:11.865056 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-06-01 14:32:12.566037 | debian-bookworm | changed 2025-06-01 14:32:12.585996 | 2025-06-01 14:32:12.586125 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-06-01 14:32:12.839436 | debian-bookworm | ok 2025-06-01 14:32:12.846858 | 2025-06-01 14:32:12.847014 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-06-01 14:32:13.521876 | debian-bookworm | changed 2025-06-01 14:32:13.531952 | 2025-06-01 14:32:13.532087 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-06-01 14:32:14.208621 | debian-bookworm | changed 2025-06-01 14:32:14.220118 | 2025-06-01 14:32:14.220289 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-06-01 14:32:14.245236 | debian-bookworm | skipping: Conditional result was False 2025-06-01 14:32:14.259728 | 2025-06-01 14:32:14.259965 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-06-01 14:32:14.806497 | debian-bookworm -> localhost | changed 2025-06-01 14:32:14.820393 | 2025-06-01 14:32:14.820553 | TASK [add-build-sshkey : Add back temp key] 2025-06-01 14:32:15.264526 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/ecc6220d4eed4a289638102102dbe989/work/ecc6220d4eed4a289638102102dbe989_id_rsa (zuul-build-sshkey) 2025-06-01 14:32:15.264975 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.019532 2025-06-01 14:32:15.277771 | 2025-06-01 14:32:15.277921 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-06-01 14:32:15.707889 | debian-bookworm | ok 2025-06-01 14:32:15.713454 | 2025-06-01 14:32:15.713585 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-06-01 14:32:15.739229 | debian-bookworm | skipping: Conditional result was False 2025-06-01 14:32:15.761213 | 2025-06-01 14:32:15.761429 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-06-01 14:32:16.233605 | debian-bookworm | ok 2025-06-01 14:32:16.249721 | 2025-06-01 14:32:16.249879 | TASK [validate-host : Define zuul_info_dir fact] 2025-06-01 14:32:16.299588 | debian-bookworm | ok 2025-06-01 14:32:16.306926 | 2025-06-01 14:32:16.307060 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-06-01 14:32:16.624129 | debian-bookworm -> localhost | ok 2025-06-01 14:32:16.631487 | 2025-06-01 14:32:16.631620 | TASK [validate-host : Collect information about the host] 2025-06-01 14:32:17.779577 | debian-bookworm | ok 2025-06-01 14:32:17.791218 | 2025-06-01 14:32:17.791390 | TASK [validate-host : Sanitize hostname] 2025-06-01 14:32:17.905109 | debian-bookworm | ok 2025-06-01 14:32:17.961107 | 2025-06-01 14:32:17.961324 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-06-01 14:32:18.558216 | debian-bookworm -> localhost | changed 2025-06-01 14:32:18.564514 | 2025-06-01 14:32:18.564634 | TASK [validate-host : Collect information about zuul worker] 2025-06-01 14:32:18.973342 | debian-bookworm | ok 2025-06-01 14:32:18.978202 | 2025-06-01 14:32:18.978355 | TASK [validate-host : Write out all zuul information for each host] 2025-06-01 14:32:19.640659 | debian-bookworm -> localhost | changed 2025-06-01 14:32:19.653969 | 2025-06-01 14:32:19.654098 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-06-01 14:32:19.917218 | debian-bookworm | ok 2025-06-01 14:32:19.928935 | 2025-06-01 14:32:19.929067 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-06-01 14:32:20.894462 | debian-bookworm | changed: 2025-06-01 14:32:20.894670 | debian-bookworm | cd+++++++++ src/ 2025-06-01 14:32:20.894705 | debian-bookworm | cd+++++++++ src/github.com/ 2025-06-01 14:32:20.894729 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-06-01 14:32:20.894750 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-06-01 14:32:20.894770 | debian-bookworm | Containerfile 2025-06-01 14:32:20.894909 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007248 2025-06-01 14:32:47.220646 | 2025-06-01 14:32:47.220838 | TASK [upload-logs : Upload logs to log server] 2025-06-01 14:32:47.776201 | localhost | Output suppressed because no_log was given 2025-06-01 14:32:47.778432 | 2025-06-01 14:32:47.778602 | LOOP [upload-logs : Compress console log and json output] 2025-06-01 14:32:47.835003 | localhost | skipping: Conditional result was False 2025-06-01 14:32:47.840322 | localhost | skipping: Conditional result was False 2025-06-01 14:32:47.849620 | 2025-06-01 14:32:47.849827 | LOOP [upload-logs : Upload compressed console log and json output] 2025-06-01 14:32:47.896597 | localhost | skipping: Conditional result was False 2025-06-01 14:32:47.896968 | 2025-06-01 14:32:47.902107 | localhost | skipping: Conditional result was False 2025-06-01 14:32:47.911048 | 2025-06-01 14:32:47.911275 | LOOP [upload-logs : Upload console log and json output]