2025-12-03 18:16:47.211162 | Job console starting 2025-12-03 18:16:47.223196 | Updating git repos 2025-12-03 18:16:47.275736 | Cloning repos into workspace 2025-12-03 18:16:47.459011 | Restoring repo states 2025-12-03 18:16:47.518198 | Merging changes 2025-12-03 18:16:48.422391 | Checking out repos 2025-12-03 18:16:48.523371 | Preparing playbooks 2025-12-03 18:16:49.968821 | Running Ansible setup 2025-12-03 18:17:01.365281 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-03 18:17:04.616254 | 2025-12-03 18:17:04.616431 | PLAY [Base pre] 2025-12-03 18:17:04.671646 | 2025-12-03 18:17:04.671850 | TASK [Setup log path fact] 2025-12-03 18:17:04.717836 | debian-bookworm | ok 2025-12-03 18:17:04.775338 | 2025-12-03 18:17:04.775537 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-03 18:17:04.847019 | debian-bookworm | ok 2025-12-03 18:17:04.867297 | 2025-12-03 18:17:04.867447 | TASK [emit-job-header : Print job information] 2025-12-03 18:17:04.984915 | # Job Information 2025-12-03 18:17:04.985228 | Ansible Version: 2.16.14 2025-12-03 18:17:04.985273 | Job: python-black 2025-12-03 18:17:04.985311 | Pipeline: check 2025-12-03 18:17:04.985338 | Executor: 521e9411259a 2025-12-03 18:17:04.985360 | Triggered by: https://github.com/osism/python-osism/pull/1731 2025-12-03 18:17:04.985383 | Event ID: 72e14df0-d073-11f0-918c-29d4fcbed006 2025-12-03 18:17:05.015372 | 2025-12-03 18:17:05.015554 | LOOP [emit-job-header : Print node information] 2025-12-03 18:17:05.451172 | debian-bookworm | ok: 2025-12-03 18:17:05.451440 | debian-bookworm | # Node Information 2025-12-03 18:17:05.451478 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-03 18:17:05.451503 | debian-bookworm | Hostname: debian 2025-12-03 18:17:05.451526 | debian-bookworm | Username: zuul 2025-12-03 18:17:05.451546 | debian-bookworm | Distro: Debian 12.12 2025-12-03 18:17:05.451577 | debian-bookworm | Provider: regiocloud-a 2025-12-03 18:17:05.451639 | debian-bookworm | Region: 2025-12-03 18:17:05.451665 | debian-bookworm | Label: debian-bookworm 2025-12-03 18:17:05.451686 | debian-bookworm | Product Name: OpenStack Nova 2025-12-03 18:17:05.451707 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fed7:72a0 2025-12-03 18:17:05.476741 | 2025-12-03 18:17:05.476902 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-03 18:17:07.947653 | debian-bookworm -> localhost | changed 2025-12-03 18:17:07.955892 | 2025-12-03 18:17:07.956025 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-03 18:17:11.183825 | debian-bookworm -> localhost | changed 2025-12-03 18:17:11.205977 | 2025-12-03 18:17:11.206131 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-03 18:17:12.048305 | debian-bookworm -> localhost | ok 2025-12-03 18:17:12.055963 | 2025-12-03 18:17:12.056099 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-03 18:17:12.090345 | debian-bookworm | ok 2025-12-03 18:17:12.224654 | debian-bookworm | included: /var/lib/zuul/builds/0448aaf46c604e73b7cfc18176b2a5c6/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-03 18:17:12.244504 | 2025-12-03 18:17:12.244690 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-03 18:17:14.709798 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-03 18:17:14.710049 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/0448aaf46c604e73b7cfc18176b2a5c6/work/0448aaf46c604e73b7cfc18176b2a5c6_id_rsa 2025-12-03 18:17:14.710091 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/0448aaf46c604e73b7cfc18176b2a5c6/work/0448aaf46c604e73b7cfc18176b2a5c6_id_rsa.pub 2025-12-03 18:17:14.710118 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-03 18:17:14.710142 | debian-bookworm -> localhost | SHA256:pooXBlY0QpoPGVPyA0KKeMQj1BZZC2kf3n8H4JPxsuI zuul-build-sshkey 2025-12-03 18:17:14.710164 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-03 18:17:14.710200 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-03 18:17:14.710222 | debian-bookworm -> localhost | |O**+B. | 2025-12-03 18:17:14.710244 | debian-bookworm -> localhost | |*@oBoo. o | 2025-12-03 18:17:14.710264 | debian-bookworm -> localhost | |O.*oo.o . = | 2025-12-03 18:17:14.710283 | debian-bookworm -> localhost | | +o. o . = o | 2025-12-03 18:17:14.710302 | debian-bookworm -> localhost | | ... S + . | 2025-12-03 18:17:14.710328 | debian-bookworm -> localhost | | o + o . . | 2025-12-03 18:17:14.710347 | debian-bookworm -> localhost | | . .o . . . | 2025-12-03 18:17:14.710366 | debian-bookworm -> localhost | | ... E | 2025-12-03 18:17:14.710386 | debian-bookworm -> localhost | | ... | 2025-12-03 18:17:14.710406 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-03 18:17:14.710457 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.175397 2025-12-03 18:17:14.731890 | 2025-12-03 18:17:14.732033 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-03 18:17:14.775556 | debian-bookworm | ok 2025-12-03 18:17:14.794041 | debian-bookworm | included: /var/lib/zuul/builds/0448aaf46c604e73b7cfc18176b2a5c6/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-03 18:17:14.831004 | 2025-12-03 18:17:14.831156 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-03 18:17:14.875802 | debian-bookworm | skipping: Conditional result was False 2025-12-03 18:17:14.882855 | 2025-12-03 18:17:14.882993 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-03 18:17:16.005045 | debian-bookworm | changed 2025-12-03 18:17:16.011646 | 2025-12-03 18:17:16.011773 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-03 18:17:16.304349 | debian-bookworm | ok 2025-12-03 18:17:16.314142 | 2025-12-03 18:17:16.314287 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-03 18:17:17.142862 | debian-bookworm | changed 2025-12-03 18:17:17.149979 | 2025-12-03 18:17:17.150108 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-03 18:17:17.970347 | debian-bookworm | changed 2025-12-03 18:17:17.989165 | 2025-12-03 18:17:17.989319 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-03 18:17:18.037811 | debian-bookworm | skipping: Conditional result was False 2025-12-03 18:17:18.045013 | 2025-12-03 18:17:18.045145 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-03 18:17:19.192251 | debian-bookworm -> localhost | changed 2025-12-03 18:17:19.209046 | 2025-12-03 18:17:19.209197 | TASK [add-build-sshkey : Add back temp key] 2025-12-03 18:17:19.916396 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/0448aaf46c604e73b7cfc18176b2a5c6/work/0448aaf46c604e73b7cfc18176b2a5c6_id_rsa (zuul-build-sshkey) 2025-12-03 18:17:19.916684 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.025088 2025-12-03 18:17:19.926429 | 2025-12-03 18:17:19.926565 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-03 18:17:20.810082 | debian-bookworm | ok 2025-12-03 18:17:20.837288 | 2025-12-03 18:17:20.837475 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-03 18:17:20.890560 | debian-bookworm | skipping: Conditional result was False 2025-12-03 18:17:20.904172 | 2025-12-03 18:17:20.904305 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-03 18:17:21.602742 | debian-bookworm | ok 2025-12-03 18:17:21.615745 | 2025-12-03 18:17:21.615881 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-03 18:17:21.659992 | debian-bookworm | ok 2025-12-03 18:17:21.668019 | 2025-12-03 18:17:21.668167 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-03 18:17:22.001472 | debian-bookworm -> localhost | ok 2025-12-03 18:17:22.011573 | 2025-12-03 18:17:22.011769 | TASK [validate-host : Collect information about the host] 2025-12-03 18:17:23.240995 | debian-bookworm | ok 2025-12-03 18:17:23.252730 | 2025-12-03 18:17:23.252893 | TASK [validate-host : Sanitize hostname] 2025-12-03 18:17:23.395644 | debian-bookworm | ok 2025-12-03 18:17:23.443584 | 2025-12-03 18:17:23.443756 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-03 18:17:24.064955 | debian-bookworm -> localhost | changed 2025-12-03 18:17:24.071037 | 2025-12-03 18:17:24.071176 | TASK [validate-host : Collect information about zuul worker] 2025-12-03 18:17:24.493797 | debian-bookworm | ok 2025-12-03 18:17:24.502973 | 2025-12-03 18:17:24.503134 | TASK [validate-host : Write out all zuul information for each host] 2025-12-03 18:17:25.285546 | debian-bookworm -> localhost | changed 2025-12-03 18:17:25.297988 | 2025-12-03 18:17:25.298123 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-03 18:17:25.583761 | debian-bookworm | ok 2025-12-03 18:17:25.589934 | 2025-12-03 18:17:25.590065 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-03 18:17:26.832429 | debian-bookworm | changed: 2025-12-03 18:17:26.833104 | debian-bookworm | cd+++++++++ src/ 2025-12-03 18:17:26.833171 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-03 18:17:26.833196 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-03 18:17:26.833217 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-12-03 18:17:26.833238 | debian-bookworm | Containerfile 2025-12-03 18:17:26.833351 | debian-bookworm | Containerfile 2025-12-03 18:17:26.872729 | debian-bookworm | localhost | ok: Runtime: 0:00:00.004846 2025-12-03 18:17:55.171692 | 2025-12-03 18:17:55.171824 | TASK [upload-logs : Upload logs to log server] 2025-12-03 18:17:55.837353 | localhost | Output suppressed because no_log was given 2025-12-03 18:17:55.839494 | 2025-12-03 18:17:55.839674 | LOOP [upload-logs : Compress console log and json output] 2025-12-03 18:17:55.890795 | localhost | skipping: Conditional result was False 2025-12-03 18:17:55.898155 | localhost | skipping: Conditional result was False 2025-12-03 18:17:55.911955 | 2025-12-03 18:17:55.912181 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-03 18:17:55.972748 | localhost | skipping: Conditional result was False 2025-12-03 18:17:55.973065 | 2025-12-03 18:17:55.980575 | localhost | skipping: Conditional result was False 2025-12-03 18:17:55.996117 | 2025-12-03 18:17:55.996300 | LOOP [upload-logs : Upload console log and json output]