2025-10-24 17:15:57.851268 | Job console starting 2025-10-24 17:15:57.874144 | Updating git repos 2025-10-24 17:15:57.934236 | Cloning repos into workspace 2025-10-24 17:15:58.000407 | Restoring repo states 2025-10-24 17:15:58.012992 | Merging changes 2025-10-24 17:15:58.720813 | Checking out repos 2025-10-24 17:15:58.799611 | Preparing playbooks 2025-10-24 17:15:59.910259 | Running Ansible setup 2025-10-24 17:16:05.934077 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-24 17:16:07.072915 | 2025-10-24 17:16:07.073093 | PLAY [Base pre] 2025-10-24 17:16:07.113582 | 2025-10-24 17:16:07.113740 | TASK [Setup log path fact] 2025-10-24 17:16:07.153201 | debian-bookworm | ok 2025-10-24 17:16:07.191135 | 2025-10-24 17:16:07.191317 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-24 17:16:07.242020 | debian-bookworm | ok 2025-10-24 17:16:07.263164 | 2025-10-24 17:16:07.263294 | TASK [emit-job-header : Print job information] 2025-10-24 17:16:07.333857 | # Job Information 2025-10-24 17:16:07.334049 | Ansible Version: 2.16.14 2025-10-24 17:16:07.334085 | Job: python-black 2025-10-24 17:16:07.334118 | Pipeline: check 2025-10-24 17:16:07.334141 | Executor: 521e9411259a 2025-10-24 17:16:07.334163 | Triggered by: https://github.com/osism/python-osism/pull/1714 2025-10-24 17:16:07.334185 | Event ID: 15c3bfd0-b0fd-11f0-96cb-65945ecc3bf9 2025-10-24 17:16:07.339239 | 2025-10-24 17:16:07.339358 | LOOP [emit-job-header : Print node information] 2025-10-24 17:16:07.585759 | debian-bookworm | ok: 2025-10-24 17:16:07.585963 | debian-bookworm | # Node Information 2025-10-24 17:16:07.585999 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-24 17:16:07.586024 | debian-bookworm | Hostname: debian 2025-10-24 17:16:07.586045 | debian-bookworm | Username: zuul 2025-10-24 17:16:07.586066 | debian-bookworm | Distro: Debian 12.12 2025-10-24 17:16:07.586089 | debian-bookworm | Provider: regiocloud-a 2025-10-24 17:16:07.586109 | debian-bookworm | Region: 2025-10-24 17:16:07.586130 | debian-bookworm | Label: debian-bookworm 2025-10-24 17:16:07.586149 | debian-bookworm | Product Name: OpenStack Nova 2025-10-24 17:16:07.586169 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe63:25c9 2025-10-24 17:16:07.604570 | 2025-10-24 17:16:07.604708 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-24 17:16:08.216322 | debian-bookworm -> localhost | changed 2025-10-24 17:16:08.222085 | 2025-10-24 17:16:08.222181 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-24 17:16:09.497896 | debian-bookworm -> localhost | changed 2025-10-24 17:16:09.507046 | 2025-10-24 17:16:09.507129 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-24 17:16:09.931930 | debian-bookworm -> localhost | ok 2025-10-24 17:16:09.937070 | 2025-10-24 17:16:09.937166 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-24 17:16:09.973912 | debian-bookworm | ok 2025-10-24 17:16:10.001742 | debian-bookworm | included: /var/lib/zuul/builds/57de79ad0abc4061b30d081047817138/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-24 17:16:10.011217 | 2025-10-24 17:16:10.011305 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-24 17:16:11.244672 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-24 17:16:11.244834 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/57de79ad0abc4061b30d081047817138/work/57de79ad0abc4061b30d081047817138_id_rsa 2025-10-24 17:16:11.244864 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/57de79ad0abc4061b30d081047817138/work/57de79ad0abc4061b30d081047817138_id_rsa.pub 2025-10-24 17:16:11.244885 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-24 17:16:11.244904 | debian-bookworm -> localhost | SHA256:dFo7+j6OcDkOou+gAI/LC7me24EHkufXHE8yOKjGybA zuul-build-sshkey 2025-10-24 17:16:11.244922 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-24 17:16:11.244948 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-24 17:16:11.244966 | debian-bookworm -> localhost | | | 2025-10-24 17:16:11.244984 | debian-bookworm -> localhost | | | 2025-10-24 17:16:11.245001 | debian-bookworm -> localhost | | . o | 2025-10-24 17:16:11.245018 | debian-bookworm -> localhost | | . . . . + . | 2025-10-24 17:16:11.245034 | debian-bookworm -> localhost | |=.o o + S o | 2025-10-24 17:16:11.245055 | debian-bookworm -> localhost | |*O+ + * o . | 2025-10-24 17:16:11.245072 | debian-bookworm -> localhost | |E*+oo = * | 2025-10-24 17:16:11.245088 | debian-bookworm -> localhost | |=+++.. = +. | 2025-10-24 17:16:11.245105 | debian-bookworm -> localhost | |=*++o oo+. | 2025-10-24 17:16:11.245121 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-24 17:16:11.245162 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.494493 2025-10-24 17:16:11.250202 | 2025-10-24 17:16:11.250280 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-24 17:16:11.286511 | debian-bookworm | ok 2025-10-24 17:16:11.295610 | debian-bookworm | included: /var/lib/zuul/builds/57de79ad0abc4061b30d081047817138/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-24 17:16:11.313488 | 2025-10-24 17:16:11.313587 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-24 17:16:11.336102 | debian-bookworm | skipping: Conditional result was False 2025-10-24 17:16:11.341340 | 2025-10-24 17:16:11.341419 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-24 17:16:11.977203 | debian-bookworm | changed 2025-10-24 17:16:11.981413 | 2025-10-24 17:16:11.981481 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-24 17:16:12.254809 | debian-bookworm | ok 2025-10-24 17:16:12.259343 | 2025-10-24 17:16:12.259415 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-24 17:16:13.013312 | debian-bookworm | changed 2025-10-24 17:16:13.018737 | 2025-10-24 17:16:13.018824 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-24 17:16:13.652016 | debian-bookworm | changed 2025-10-24 17:16:13.657383 | 2025-10-24 17:16:13.657454 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-24 17:16:13.669677 | debian-bookworm | skipping: Conditional result was False 2025-10-24 17:16:13.674140 | 2025-10-24 17:16:13.674206 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-24 17:16:14.084328 | debian-bookworm -> localhost | changed 2025-10-24 17:16:14.101489 | 2025-10-24 17:16:14.101640 | TASK [add-build-sshkey : Add back temp key] 2025-10-24 17:16:14.452209 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/57de79ad0abc4061b30d081047817138/work/57de79ad0abc4061b30d081047817138_id_rsa (zuul-build-sshkey) 2025-10-24 17:16:14.452779 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.017127 2025-10-24 17:16:14.460196 | 2025-10-24 17:16:14.460280 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-24 17:16:14.842299 | debian-bookworm | ok 2025-10-24 17:16:14.847123 | 2025-10-24 17:16:14.847206 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-24 17:16:14.869900 | debian-bookworm | skipping: Conditional result was False 2025-10-24 17:16:14.879545 | 2025-10-24 17:16:14.879640 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-24 17:16:15.351368 | debian-bookworm | ok 2025-10-24 17:16:15.369288 | 2025-10-24 17:16:15.369396 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-24 17:16:15.407282 | debian-bookworm | ok 2025-10-24 17:16:15.412019 | 2025-10-24 17:16:15.412102 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-24 17:16:15.881436 | debian-bookworm -> localhost | ok 2025-10-24 17:16:15.890002 | 2025-10-24 17:16:15.890099 | TASK [validate-host : Collect information about the host] 2025-10-24 17:16:17.033551 | debian-bookworm | ok 2025-10-24 17:16:17.046052 | 2025-10-24 17:16:17.046147 | TASK [validate-host : Sanitize hostname] 2025-10-24 17:16:17.144860 | debian-bookworm | ok 2025-10-24 17:16:17.181505 | 2025-10-24 17:16:17.181614 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-24 17:16:17.772315 | debian-bookworm -> localhost | changed 2025-10-24 17:16:17.777633 | 2025-10-24 17:16:17.777719 | TASK [validate-host : Collect information about zuul worker] 2025-10-24 17:16:18.175661 | debian-bookworm | ok 2025-10-24 17:16:18.181590 | 2025-10-24 17:16:18.181697 | TASK [validate-host : Write out all zuul information for each host] 2025-10-24 17:16:18.810923 | debian-bookworm -> localhost | changed 2025-10-24 17:16:18.824244 | 2025-10-24 17:16:18.824395 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-24 17:16:19.087647 | debian-bookworm | ok 2025-10-24 17:16:19.093704 | 2025-10-24 17:16:19.093797 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-24 17:16:20.200055 | debian-bookworm | changed: 2025-10-24 17:16:20.201116 | debian-bookworm | cd+++++++++ src/ 2025-10-24 17:16:20.201165 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-24 17:16:20.201191 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-24 17:16:20.201213 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-10-24 17:16:20.201234 | debian-bookworm | Containerfile 2025-10-24 17:16:20.201351 | debian-bookworm | Containerfile 2025-10-24 17:16:20.209294 | debian-bookworm | localhost | ok: Runtime: 0:00:00.003989 2025-10-24 17:16:46.430803 | 2025-10-24 17:16:46.430997 | TASK [upload-logs : Upload logs to log server] 2025-10-24 17:16:46.996337 | localhost | Output suppressed because no_log was given 2025-10-24 17:16:46.999900 | 2025-10-24 17:16:47.000079 | LOOP [upload-logs : Compress console log and json output] 2025-10-24 17:16:47.048849 | localhost | skipping: Conditional result was False 2025-10-24 17:16:47.053064 | localhost | skipping: Conditional result was False 2025-10-24 17:16:47.065505 | 2025-10-24 17:16:47.065758 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-24 17:16:47.115814 | localhost | skipping: Conditional result was False 2025-10-24 17:16:47.116359 | 2025-10-24 17:16:47.118955 | localhost | skipping: Conditional result was False 2025-10-24 17:16:47.128132 | 2025-10-24 17:16:47.128347 | LOOP [upload-logs : Upload console log and json output]