2026-07-19 02:22:53.019466 | Job console starting 2026-07-19 02:22:53.036511 | Updating git repos 2026-07-19 02:22:54.026172 | Cloning repos into workspace 2026-07-19 02:22:54.117039 | Restoring repo states 2026-07-19 02:22:54.142751 | Merging changes 2026-07-19 02:22:54.828446 | Checking out repos 2026-07-19 02:22:54.914056 | Preparing playbooks 2026-07-19 02:22:56.584161 | Running Ansible setup 2026-07-19 02:23:02.733678 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-07-19 02:23:05.281856 | 2026-07-19 02:23:05.285357 | PLAY [Base pre] 2026-07-19 02:23:05.342510 | 2026-07-19 02:23:05.342648 | TASK [Setup log path fact] 2026-07-19 02:23:05.372253 | debian-bookworm | ok 2026-07-19 02:23:05.419586 | 2026-07-19 02:23:05.419730 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-19 02:23:05.460963 | debian-bookworm | ok 2026-07-19 02:23:05.474334 | 2026-07-19 02:23:05.474451 | TASK [emit-job-header : Print job information] 2026-07-19 02:23:05.535415 | # Job Information 2026-07-19 02:23:05.535573 | Ansible Version: 2.16.14 2026-07-19 02:23:05.535609 | Job: python-black 2026-07-19 02:23:05.535643 | Pipeline: check 2026-07-19 02:23:05.535666 | Executor: 521e9411259a 2026-07-19 02:23:05.535687 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1245 2026-07-19 02:23:05.535710 | Event ID: b74a7540-8318-11f1-9bac-471859fe1461 2026-07-19 02:23:05.543540 | 2026-07-19 02:23:05.543648 | LOOP [emit-job-header : Print node information] 2026-07-19 02:23:05.725350 | debian-bookworm | ok: 2026-07-19 02:23:05.725493 | debian-bookworm | # Node Information 2026-07-19 02:23:05.725521 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-07-19 02:23:05.725542 | debian-bookworm | Hostname: debian 2026-07-19 02:23:05.725561 | debian-bookworm | Username: zuul 2026-07-19 02:23:05.725578 | debian-bookworm | Distro: Debian 12.15 2026-07-19 02:23:05.725597 | debian-bookworm | Provider: regiocloud-a 2026-07-19 02:23:05.725614 | debian-bookworm | Region: 2026-07-19 02:23:05.725631 | debian-bookworm | Label: debian-bookworm 2026-07-19 02:23:05.725649 | debian-bookworm | Product Name: OpenStack Nova 2026-07-19 02:23:05.725665 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe68:cfe9 2026-07-19 02:23:05.748295 | 2026-07-19 02:23:05.748403 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-07-19 02:23:06.357163 | debian-bookworm -> localhost | changed 2026-07-19 02:23:06.362969 | 2026-07-19 02:23:06.363060 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-07-19 02:23:08.141255 | debian-bookworm -> localhost | changed 2026-07-19 02:23:08.152526 | 2026-07-19 02:23:08.152633 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-07-19 02:23:09.068939 | debian-bookworm -> localhost | ok 2026-07-19 02:23:09.075062 | 2026-07-19 02:23:09.075161 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-07-19 02:23:09.126443 | debian-bookworm | ok 2026-07-19 02:23:09.165353 | debian-bookworm | included: /var/lib/zuul/builds/e542825fbc014223a649cc19b74c962d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-07-19 02:23:09.177497 | 2026-07-19 02:23:09.177595 | TASK [add-build-sshkey : Create Temp SSH key] 2026-07-19 02:23:11.836108 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-07-19 02:23:11.836300 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/e542825fbc014223a649cc19b74c962d/work/e542825fbc014223a649cc19b74c962d_id_rsa 2026-07-19 02:23:11.836336 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/e542825fbc014223a649cc19b74c962d/work/e542825fbc014223a649cc19b74c962d_id_rsa.pub 2026-07-19 02:23:11.836359 | debian-bookworm -> localhost | The key fingerprint is: 2026-07-19 02:23:11.836381 | debian-bookworm -> localhost | SHA256:4jlAEqKuH2gy+LmbIaTIoYlB9nhBIJkbDSZR/3zrxPA zuul-build-sshkey 2026-07-19 02:23:11.836400 | debian-bookworm -> localhost | The key's randomart image is: 2026-07-19 02:23:11.836430 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-07-19 02:23:11.836450 | debian-bookworm -> localhost | |*X+. | 2026-07-19 02:23:11.836468 | debian-bookworm -> localhost | |O.oo | 2026-07-19 02:23:11.836485 | debian-bookworm -> localhost | |.=..o | 2026-07-19 02:23:11.836502 | debian-bookworm -> localhost | |= oo.o | 2026-07-19 02:23:11.836519 | debian-bookworm -> localhost | |.= o. = S | 2026-07-19 02:23:11.836541 | debian-bookworm -> localhost | |X+o o B . | 2026-07-19 02:23:11.836559 | debian-bookworm -> localhost | |&oo + E | 2026-07-19 02:23:11.836575 | debian-bookworm -> localhost | |o= = + | 2026-07-19 02:23:11.836592 | debian-bookworm -> localhost | | Bo . | 2026-07-19 02:23:11.836608 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-07-19 02:23:11.836657 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.628165 2026-07-19 02:23:11.841775 | 2026-07-19 02:23:11.841859 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-07-19 02:23:11.909339 | debian-bookworm | ok 2026-07-19 02:23:11.918938 | debian-bookworm | included: /var/lib/zuul/builds/e542825fbc014223a649cc19b74c962d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-07-19 02:23:11.925597 | 2026-07-19 02:23:11.925679 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-07-19 02:23:11.957448 | debian-bookworm | skipping: Conditional result was False 2026-07-19 02:23:11.963955 | 2026-07-19 02:23:11.964093 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-07-19 02:23:12.632095 | debian-bookworm | changed 2026-07-19 02:23:12.637778 | 2026-07-19 02:23:12.637871 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-07-19 02:23:12.934857 | debian-bookworm | ok 2026-07-19 02:23:12.941336 | 2026-07-19 02:23:12.941438 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-07-19 02:23:13.645251 | debian-bookworm | changed 2026-07-19 02:23:13.684477 | 2026-07-19 02:23:13.684618 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-07-19 02:23:14.427028 | debian-bookworm | changed 2026-07-19 02:23:14.437884 | 2026-07-19 02:23:14.437997 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-07-19 02:23:14.481807 | debian-bookworm | skipping: Conditional result was False 2026-07-19 02:23:14.488233 | 2026-07-19 02:23:14.488362 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-07-19 02:23:15.291684 | debian-bookworm -> localhost | changed 2026-07-19 02:23:15.319083 | 2026-07-19 02:23:15.319213 | TASK [add-build-sshkey : Add back temp key] 2026-07-19 02:23:16.211800 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/e542825fbc014223a649cc19b74c962d/work/e542825fbc014223a649cc19b74c962d_id_rsa (zuul-build-sshkey) 2026-07-19 02:23:16.211993 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.024550 2026-07-19 02:23:16.218651 | 2026-07-19 02:23:16.218728 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-07-19 02:23:16.713973 | debian-bookworm | ok 2026-07-19 02:23:16.719108 | 2026-07-19 02:23:16.719195 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-07-19 02:23:16.745874 | debian-bookworm | skipping: Conditional result was False 2026-07-19 02:23:16.765582 | 2026-07-19 02:23:16.765682 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-07-19 02:23:17.356937 | debian-bookworm | ok 2026-07-19 02:23:17.369753 | 2026-07-19 02:23:17.369851 | TASK [validate-host : Define zuul_info_dir fact] 2026-07-19 02:23:17.437011 | debian-bookworm | ok 2026-07-19 02:23:17.441353 | 2026-07-19 02:23:17.441437 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-07-19 02:23:17.921026 | debian-bookworm -> localhost | ok 2026-07-19 02:23:17.926325 | 2026-07-19 02:23:17.926406 | TASK [validate-host : Collect information about the host] 2026-07-19 02:23:18.991317 | debian-bookworm | ok 2026-07-19 02:23:19.007802 | 2026-07-19 02:23:19.007912 | TASK [validate-host : Sanitize hostname] 2026-07-19 02:23:19.180955 | debian-bookworm | ok 2026-07-19 02:23:19.185340 | 2026-07-19 02:23:19.185428 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-07-19 02:23:19.997782 | debian-bookworm -> localhost | changed 2026-07-19 02:23:20.004441 | 2026-07-19 02:23:20.004610 | TASK [validate-host : Collect information about zuul worker] 2026-07-19 02:23:20.517295 | debian-bookworm | ok 2026-07-19 02:23:20.521956 | 2026-07-19 02:23:20.522047 | TASK [validate-host : Write out all zuul information for each host] 2026-07-19 02:23:21.199312 | debian-bookworm -> localhost | changed 2026-07-19 02:23:21.210352 | 2026-07-19 02:23:21.210447 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-07-19 02:23:21.492385 | debian-bookworm | ok 2026-07-19 02:23:21.497567 | 2026-07-19 02:23:21.497652 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-07-19 02:23:22.471136 | debian-bookworm | changed: 2026-07-19 02:23:22.471384 | debian-bookworm | cd+++++++++ src/ 2026-07-19 02:23:22.471429 | debian-bookworm | cd+++++++++ src/github.com/ 2026-07-19 02:23:22.471460 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-07-19 02:23:22.471489 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-07-19 02:23:22.471515 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/e542825fbc014223a649cc19b74c962d/work/logs" 2026-07-19 02:24:28.281243 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/e542825fbc014223a649cc19b74c962d/work/artifacts" 2026-07-19 02:24:28.976399 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/e542825fbc014223a649cc19b74c962d/work/docs" 2026-07-19 02:24:28.985649 | 2026-07-19 02:24:28.985756 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-07-19 02:24:30.301130 | debian-bookworm | changed: 2026-07-19 02:24:30.301322 | debian-bookworm | .d..t...... ./ 2026-07-19 02:24:30.301352 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-07-19 02:24:30.301371 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-07-19 02:24:30.301388 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-07-19 02:24:30.301404 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-07-19 02:24:30.301443 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-07-19 02:24:30.301482 | debian-bookworm | changed: All items complete 2026-07-19 02:24:30.301537 | 2026-07-19 02:24:31.311170 | debian-bookworm | changed: .d..t...... ./ 2026-07-19 02:24:32.308325 | debian-bookworm | changed: .d..t...... ./ 2026-07-19 02:24:32.327535 | 2026-07-19 02:24:32.327631 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-07-19 02:24:33.702779 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.040555 2026-07-19 02:24:34.680446 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.032560 2026-07-19 02:24:34.689371 | 2026-07-19 02:24:34.689465 | PLAY RECAP 2026-07-19 02:24:34.689509 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-07-19 02:24:34.689529 | 2026-07-19 02:24:34.963030 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-19 02:24:34.964698 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-19 02:24:36.649241 | 2026-07-19 02:24:36.649370 | PLAY [Base post] 2026-07-19 02:24:36.687356 | 2026-07-19 02:24:36.687492 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-07-19 02:24:37.626632 | debian-bookworm | changed 2026-07-19 02:24:37.632518 | 2026-07-19 02:24:37.632614 | PLAY RECAP 2026-07-19 02:24:37.632669 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-19 02:24:37.632718 | 2026-07-19 02:24:37.939464 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-19 02:24:37.940096 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-07-19 02:24:39.264285 | 2026-07-19 02:24:39.264434 | PLAY [Base post-logs] 2026-07-19 02:24:39.290068 | 2026-07-19 02:24:39.290211 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-07-19 02:24:40.509801 | localhost | changed 2026-07-19 02:24:40.517578 | 2026-07-19 02:24:40.517699 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-07-19 02:24:40.566545 | localhost | ok 2026-07-19 02:24:40.569882 | 2026-07-19 02:24:40.569967 | TASK [Set zuul-log-path fact] 2026-07-19 02:24:40.594300 | localhost | ok 2026-07-19 02:24:40.601694 | 2026-07-19 02:24:40.601779 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-19 02:24:40.656100 | localhost | ok 2026-07-19 02:24:40.658503 | 2026-07-19 02:24:40.658576 | TASK [upload-logs : Create log directories] 2026-07-19 02:24:41.388049 | localhost | changed 2026-07-19 02:24:41.392568 | 2026-07-19 02:24:41.392684 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-07-19 02:24:42.416823 | localhost -> localhost | ok: Runtime: 0:00:00.006378 2026-07-19 02:24:42.420425 | 2026-07-19 02:24:42.420520 | TASK [upload-logs : Upload logs to log server] 2026-07-19 02:24:43.448432 | localhost | Output suppressed because no_log was given 2026-07-19 02:24:43.451481 | 2026-07-19 02:24:43.451568 | LOOP [upload-logs : Compress console log and json output] 2026-07-19 02:24:43.551715 | localhost | skipping: Conditional result was False 2026-07-19 02:24:43.564097 | localhost | skipping: Conditional result was False 2026-07-19 02:24:43.571576 | 2026-07-19 02:24:43.571880 | LOOP [upload-logs : Upload compressed console log and json output] 2026-07-19 02:24:43.667260 | localhost | skipping: Conditional result was False 2026-07-19 02:24:43.667506 | 2026-07-19 02:24:43.684706 | localhost | skipping: Conditional result was False 2026-07-19 02:24:43.688822 | 2026-07-19 02:24:43.688937 | LOOP [upload-logs : Upload console log and json output]