2025-10-12 19:39:56.081214 | Job console starting 2025-10-12 19:39:56.100083 | Updating git repos 2025-10-12 19:39:56.740663 | Cloning repos into workspace 2025-10-12 19:39:56.879903 | Restoring repo states 2025-10-12 19:39:56.923838 | Merging changes 2025-10-12 19:39:57.846038 | Checking out repos 2025-10-12 19:39:57.924864 | Preparing playbooks 2025-10-12 19:39:59.337431 | Running Ansible setup 2025-10-12 19:40:05.340940 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-12 19:40:06.591049 | 2025-10-12 19:40:06.591166 | PLAY [Base pre] 2025-10-12 19:40:06.641984 | 2025-10-12 19:40:06.642092 | TASK [Setup log path fact] 2025-10-12 19:40:06.660131 | debian-bookworm | ok 2025-10-12 19:40:06.677168 | 2025-10-12 19:40:06.677256 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-12 19:40:06.724753 | debian-bookworm | ok 2025-10-12 19:40:06.744545 | 2025-10-12 19:40:06.744657 | TASK [emit-job-header : Print job information] 2025-10-12 19:40:06.785132 | # Job Information 2025-10-12 19:40:06.785262 | Ansible Version: 2.16.14 2025-10-12 19:40:06.785291 | Job: python-black 2025-10-12 19:40:06.785319 | Pipeline: check 2025-10-12 19:40:06.785339 | Executor: 521e9411259a 2025-10-12 19:40:06.785357 | Triggered by: https://github.com/osism/container-image-kolla-ansible/pull/832 2025-10-12 19:40:06.785375 | Event ID: 35a4b560-a7a3-11f0-983f-2eaa1eeea1aa 2025-10-12 19:40:06.789269 | 2025-10-12 19:40:06.789349 | LOOP [emit-job-header : Print node information] 2025-10-12 19:40:06.896417 | debian-bookworm | ok: 2025-10-12 19:40:06.896554 | debian-bookworm | # Node Information 2025-10-12 19:40:06.896583 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-12 19:40:06.896615 | debian-bookworm | Hostname: debian 2025-10-12 19:40:06.896634 | debian-bookworm | Username: zuul 2025-10-12 19:40:06.896651 | debian-bookworm | Distro: Debian 12.12 2025-10-12 19:40:06.896671 | debian-bookworm | Provider: regiocloud-a 2025-10-12 19:40:06.896688 | debian-bookworm | Region: 2025-10-12 19:40:06.896705 | debian-bookworm | Label: debian-bookworm 2025-10-12 19:40:06.896722 | debian-bookworm | Product Name: OpenStack Nova 2025-10-12 19:40:06.896738 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe46:7025 2025-10-12 19:40:06.907794 | 2025-10-12 19:40:06.907902 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-12 19:40:07.586293 | debian-bookworm -> localhost | changed 2025-10-12 19:40:07.593255 | 2025-10-12 19:40:07.593342 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-12 19:40:09.286895 | debian-bookworm -> localhost | changed 2025-10-12 19:40:09.296325 | 2025-10-12 19:40:09.296418 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-12 19:40:09.773543 | debian-bookworm -> localhost | ok 2025-10-12 19:40:09.778338 | 2025-10-12 19:40:09.778415 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-12 19:40:09.804728 | debian-bookworm | ok 2025-10-12 19:40:09.838371 | debian-bookworm | included: /var/lib/zuul/builds/44188862fef44f33b202ad6bfe9b3434/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-12 19:40:09.850345 | 2025-10-12 19:40:09.850431 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-12 19:40:11.427909 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-12 19:40:11.428075 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/44188862fef44f33b202ad6bfe9b3434/work/44188862fef44f33b202ad6bfe9b3434_id_rsa 2025-10-12 19:40:11.428107 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/44188862fef44f33b202ad6bfe9b3434/work/44188862fef44f33b202ad6bfe9b3434_id_rsa.pub 2025-10-12 19:40:11.428128 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-12 19:40:11.428149 | debian-bookworm -> localhost | SHA256:pVsLGD4KR8MW89e/qZsa+tPFhcQQswq88pLhJHrKTxk zuul-build-sshkey 2025-10-12 19:40:11.428176 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-12 19:40:11.428194 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-12 19:40:11.428211 | debian-bookworm -> localhost | | o ++ | 2025-10-12 19:40:11.428228 | debian-bookworm -> localhost | | . = . oo | 2025-10-12 19:40:11.428245 | debian-bookworm -> localhost | | = = . +. . | 2025-10-12 19:40:11.428261 | debian-bookworm -> localhost | | o o * + .. . | 2025-10-12 19:40:11.428276 | debian-bookworm -> localhost | | oE= = S .... | 2025-10-12 19:40:11.428295 | debian-bookworm -> localhost | | . *o* . + .oo | 2025-10-12 19:40:11.428311 | debian-bookworm -> localhost | |. .o= . o...o | 2025-10-12 19:40:11.428327 | debian-bookworm -> localhost | |.o. . ....o | 2025-10-12 19:40:11.428343 | debian-bookworm -> localhost | |.... ..oo+. | 2025-10-12 19:40:11.428360 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-12 19:40:11.428404 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.078445 2025-10-12 19:40:11.433611 | 2025-10-12 19:40:11.433682 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-12 19:40:11.470204 | debian-bookworm | ok 2025-10-12 19:40:11.477883 | debian-bookworm | included: /var/lib/zuul/builds/44188862fef44f33b202ad6bfe9b3434/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-12 19:40:11.495811 | 2025-10-12 19:40:11.495883 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-12 19:40:11.528544 | debian-bookworm | skipping: Conditional result was False 2025-10-12 19:40:11.534828 | 2025-10-12 19:40:11.534914 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-12 19:40:12.117162 | debian-bookworm | changed 2025-10-12 19:40:12.121427 | 2025-10-12 19:40:12.121505 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-12 19:40:12.352090 | debian-bookworm | ok 2025-10-12 19:40:12.357540 | 2025-10-12 19:40:12.357629 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-12 19:40:12.939226 | debian-bookworm | changed 2025-10-12 19:40:12.947500 | 2025-10-12 19:40:12.947635 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-12 19:40:13.553357 | debian-bookworm | changed 2025-10-12 19:40:13.558554 | 2025-10-12 19:40:13.558645 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-12 19:40:13.571526 | debian-bookworm | skipping: Conditional result was False 2025-10-12 19:40:13.577728 | 2025-10-12 19:40:13.577811 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-12 19:40:14.077937 | debian-bookworm -> localhost | changed 2025-10-12 19:40:14.091254 | 2025-10-12 19:40:14.091350 | TASK [add-build-sshkey : Add back temp key] 2025-10-12 19:40:14.544932 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/44188862fef44f33b202ad6bfe9b3434/work/44188862fef44f33b202ad6bfe9b3434_id_rsa (zuul-build-sshkey) 2025-10-12 19:40:14.545135 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.007999 2025-10-12 19:40:14.552759 | 2025-10-12 19:40:14.552847 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-12 19:40:14.971262 | debian-bookworm | ok 2025-10-12 19:40:14.976018 | 2025-10-12 19:40:14.976101 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-12 19:40:15.000904 | debian-bookworm | skipping: Conditional result was False 2025-10-12 19:40:15.027722 | 2025-10-12 19:40:15.027833 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-12 19:40:15.454856 | debian-bookworm | ok 2025-10-12 19:40:15.471633 | 2025-10-12 19:40:15.471730 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-12 19:40:15.514243 | debian-bookworm | ok 2025-10-12 19:40:15.523913 | 2025-10-12 19:40:15.524059 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-12 19:40:16.074245 | debian-bookworm -> localhost | ok 2025-10-12 19:40:16.079284 | 2025-10-12 19:40:16.079352 | TASK [validate-host : Collect information about the host] 2025-10-12 19:40:17.171856 | debian-bookworm | ok 2025-10-12 19:40:17.179972 | 2025-10-12 19:40:17.180049 | TASK [validate-host : Sanitize hostname] 2025-10-12 19:40:17.267745 | debian-bookworm | ok 2025-10-12 19:40:17.341775 | 2025-10-12 19:40:17.341906 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-12 19:40:17.977151 | debian-bookworm -> localhost | changed 2025-10-12 19:40:17.983467 | 2025-10-12 19:40:17.983563 | TASK [validate-host : Collect information about zuul worker] 2025-10-12 19:40:18.534927 | debian-bookworm | ok 2025-10-12 19:40:18.539650 | 2025-10-12 19:40:18.539748 | TASK [validate-host : Write out all zuul information for each host] 2025-10-12 19:40:19.738764 | debian-bookworm -> localhost | changed 2025-10-12 19:40:19.748729 | 2025-10-12 19:40:19.748818 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-12 19:40:20.064657 | debian-bookworm | ok 2025-10-12 19:40:20.087379 | 2025-10-12 19:40:20.087490 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-12 19:40:21.225316 | debian-bookworm | changed: 2025-10-12 19:40:21.225498 | debian-bookworm | cd+++++++++ src/ 2025-10-12 19:40:21.226033 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-12 19:40:21.226065 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-12 19:40:21.226088 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-kolla-ansible/ 2025-10-12 19:40:21.226109 | debian-bookworm | Containerfile 2025-10-12 19:40:21.226245 | debian-bookworm | localhost | ok: Runtime: 0:00:00.003950 2025-10-12 19:40:51.143967 | 2025-10-12 19:40:51.144051 | TASK [upload-logs : Upload logs to log server] 2025-10-12 19:40:52.477351 | localhost | Output suppressed because no_log was given 2025-10-12 19:40:52.478728 | 2025-10-12 19:40:52.478804 | LOOP [upload-logs : Compress console log and json output] 2025-10-12 19:40:52.560239 | localhost | skipping: Conditional result was False 2025-10-12 19:40:52.590340 | localhost | skipping: Conditional result was False 2025-10-12 19:40:52.597296 | 2025-10-12 19:40:52.597703 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-12 19:40:52.634961 | localhost | skipping: Conditional result was False 2025-10-12 19:40:52.635338 | 2025-10-12 19:40:52.644038 | localhost | skipping: Conditional result was False 2025-10-12 19:40:52.654722 | 2025-10-12 19:40:52.654874 | LOOP [upload-logs : Upload console log and json output]