2026-09-07 06:47:16.256947 | Job console starting 2026-09-07 06:47:16.308963 | Updating git repos 2026-09-07 06:47:16.365484 | Cloning repos into workspace 2026-09-07 06:47:16.420770 | Restoring repo states 2026-09-07 06:47:16.439760 | Merging changes 2026-09-07 06:47:17.202769 | Checking out repos 2026-09-07 06:47:17.253854 | Preparing playbooks 2026-09-07 06:47:18.549870 | Running Ansible setup 2026-09-07 06:47:24.056259 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-09-07 06:47:25.426804 | 2026-09-07 06:47:25.426989 | PLAY [Base pre] 2026-09-07 06:47:25.445598 | 2026-09-07 06:47:25.445737 | TASK [Setup log path fact] 2026-09-07 06:47:25.464266 | debian-bookworm | ok 2026-09-07 06:47:25.481517 | 2026-09-07 06:47:25.481665 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-07 06:47:25.511187 | debian-bookworm | ok 2026-09-07 06:47:25.520216 | 2026-09-07 06:47:25.520320 | TASK [emit-job-header : Print job information] 2026-09-07 06:47:25.549349 | # Job Information 2026-09-07 06:47:25.549551 | Ansible Version: 2.16.14 2026-09-07 06:47:25.549581 | Job: python-black 2026-09-07 06:47:25.549614 | Pipeline: check 2026-09-07 06:47:25.549637 | Executor: 521e9411259a 2026-09-07 06:47:25.549653 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1269 2026-09-07 06:47:25.549671 | Event ID: f0f39c40-aa87-11f1-87e6-0a89ceb39b2b 2026-09-07 06:47:25.553889 | 2026-09-07 06:47:25.553987 | LOOP [emit-job-header : Print node information] 2026-09-07 06:47:25.640124 | debian-bookworm | ok: 2026-09-07 06:47:25.640327 | debian-bookworm | # Node Information 2026-09-07 06:47:25.640358 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-09-07 06:47:25.640379 | debian-bookworm | Hostname: debian 2026-09-07 06:47:25.640396 | debian-bookworm | Username: zuul 2026-09-07 06:47:25.640412 | debian-bookworm | Distro: Debian 12.15 2026-09-07 06:47:25.640431 | debian-bookworm | Provider: regiocloud-a 2026-09-07 06:47:25.640448 | debian-bookworm | Region: 2026-09-07 06:47:25.640465 | debian-bookworm | Label: debian-bookworm 2026-09-07 06:47:25.640480 | debian-bookworm | Product Name: OpenStack Nova 2026-09-07 06:47:25.640496 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe78:1da8 2026-09-07 06:47:25.657921 | 2026-09-07 06:47:25.658072 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-07 06:47:26.284345 | debian-bookworm -> localhost | changed 2026-09-07 06:47:26.291021 | 2026-09-07 06:47:26.291103 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-07 06:47:27.594332 | debian-bookworm -> localhost | changed 2026-09-07 06:47:27.604310 | 2026-09-07 06:47:27.604402 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-07 06:47:28.233414 | debian-bookworm -> localhost | ok 2026-09-07 06:47:28.238174 | 2026-09-07 06:47:28.238254 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-07 06:47:28.286001 | debian-bookworm | ok 2026-09-07 06:47:28.309844 | debian-bookworm | included: /var/lib/zuul/builds/3171a4baa33247cd99313c08d1b3e6bd/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-07 06:47:28.314508 | 2026-09-07 06:47:28.314577 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-07 06:47:30.120834 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-09-07 06:47:30.120998 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/3171a4baa33247cd99313c08d1b3e6bd/work/3171a4baa33247cd99313c08d1b3e6bd_id_rsa 2026-09-07 06:47:30.121030 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/3171a4baa33247cd99313c08d1b3e6bd/work/3171a4baa33247cd99313c08d1b3e6bd_id_rsa.pub 2026-09-07 06:47:30.121052 | debian-bookworm -> localhost | The key fingerprint is: 2026-09-07 06:47:30.121073 | debian-bookworm -> localhost | SHA256:Q4E8rSmyKjXdyu4mNgKFmm1/YJ0YfhOSizmnYofbb2Y zuul-build-sshkey 2026-09-07 06:47:30.121092 | debian-bookworm -> localhost | The key's randomart image is: 2026-09-07 06:47:30.121121 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-09-07 06:47:30.121140 | debian-bookworm -> localhost | | . o. | 2026-09-07 06:47:30.121159 | debian-bookworm -> localhost | | + .. | 2026-09-07 06:47:30.121176 | debian-bookworm -> localhost | | . . +. | 2026-09-07 06:47:30.121193 | debian-bookworm -> localhost | |. o = +. | 2026-09-07 06:47:30.121210 | debian-bookworm -> localhost | |.+ B O oS | 2026-09-07 06:47:30.121230 | debian-bookworm -> localhost | |+ X O * . | 2026-09-07 06:47:30.121248 | debian-bookworm -> localhost | |.+.O + . | 2026-09-07 06:47:30.121265 | debian-bookworm -> localhost | |=o*.=E. | 2026-09-07 06:47:30.121282 | debian-bookworm -> localhost | |o=oBBo | 2026-09-07 06:47:30.121299 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-09-07 06:47:30.121340 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.974227 2026-09-07 06:47:30.126339 | 2026-09-07 06:47:30.126415 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-07 06:47:30.142410 | debian-bookworm | ok 2026-09-07 06:47:30.150479 | debian-bookworm | included: /var/lib/zuul/builds/3171a4baa33247cd99313c08d1b3e6bd/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-07 06:47:30.156893 | 2026-09-07 06:47:30.156963 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-07 06:47:30.169364 | debian-bookworm | skipping: Conditional result was False 2026-09-07 06:47:30.173768 | 2026-09-07 06:47:30.173846 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-07 06:47:30.748867 | debian-bookworm | changed 2026-09-07 06:47:30.774636 | 2026-09-07 06:47:30.774978 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-07 06:47:31.024172 | debian-bookworm | ok 2026-09-07 06:47:31.039981 | 2026-09-07 06:47:31.040611 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-07 06:47:31.632777 | debian-bookworm | changed 2026-09-07 06:47:31.638062 | 2026-09-07 06:47:31.638144 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-07 06:47:32.270180 | debian-bookworm | changed 2026-09-07 06:47:32.275548 | 2026-09-07 06:47:32.275635 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-07 06:47:32.298335 | debian-bookworm | skipping: Conditional result was False 2026-09-07 06:47:32.303893 | 2026-09-07 06:47:32.303986 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-07 06:47:32.863127 | debian-bookworm -> localhost | changed 2026-09-07 06:47:32.874563 | 2026-09-07 06:47:32.874659 | TASK [add-build-sshkey : Add back temp key] 2026-09-07 06:47:33.243409 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/3171a4baa33247cd99313c08d1b3e6bd/work/3171a4baa33247cd99313c08d1b3e6bd_id_rsa (zuul-build-sshkey) 2026-09-07 06:47:33.243817 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011549 2026-09-07 06:47:33.255292 | 2026-09-07 06:47:33.255391 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-07 06:47:33.606558 | debian-bookworm | ok 2026-09-07 06:47:33.611500 | 2026-09-07 06:47:33.611587 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-07 06:47:33.634418 | debian-bookworm | skipping: Conditional result was False 2026-09-07 06:47:33.644175 | 2026-09-07 06:47:33.644265 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-09-07 06:47:34.029163 | debian-bookworm | ok 2026-09-07 06:47:34.039237 | 2026-09-07 06:47:34.039328 | TASK [validate-host : Define zuul_info_dir fact] 2026-09-07 06:47:34.066566 | debian-bookworm | ok 2026-09-07 06:47:34.071420 | 2026-09-07 06:47:34.071502 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-09-07 06:47:34.362452 | debian-bookworm -> localhost | ok 2026-09-07 06:47:34.367524 | 2026-09-07 06:47:34.367606 | TASK [validate-host : Collect information about the host] 2026-09-07 06:47:35.416845 | debian-bookworm | ok 2026-09-07 06:47:35.426637 | 2026-09-07 06:47:35.426725 | TASK [validate-host : Sanitize hostname] 2026-09-07 06:47:35.537100 | debian-bookworm | ok 2026-09-07 06:47:35.540617 | 2026-09-07 06:47:35.540693 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-09-07 06:47:36.133216 | debian-bookworm -> localhost | changed 2026-09-07 06:47:36.138420 | 2026-09-07 06:47:36.138498 | TASK [validate-host : Collect information about zuul worker] 2026-09-07 06:47:36.572470 | debian-bookworm | ok 2026-09-07 06:47:36.576946 | 2026-09-07 06:47:36.577035 | TASK [validate-host : Write out all zuul information for each host] 2026-09-07 06:47:37.024056 | debian-bookworm -> localhost | changed 2026-09-07 06:47:37.032905 | 2026-09-07 06:47:37.032997 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-09-07 06:47:37.302719 | debian-bookworm | ok 2026-09-07 06:47:37.307025 | 2026-09-07 06:47:37.307096 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-09-07 06:47:38.176557 | debian-bookworm | changed: 2026-09-07 06:47:38.176759 | debian-bookworm | cd+++++++++ src/ 2026-09-07 06:47:38.176845 | debian-bookworm | cd+++++++++ src/github.com/ 2026-09-07 06:47:38.176880 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-09-07 06:47:38.176909 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-09-07 06:47:38.176937 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/3171a4baa33247cd99313c08d1b3e6bd/work/logs" 2026-09-07 06:48:41.937001 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/3171a4baa33247cd99313c08d1b3e6bd/work/artifacts" 2026-09-07 06:48:42.197829 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/3171a4baa33247cd99313c08d1b3e6bd/work/docs" 2026-09-07 06:48:42.215123 | 2026-09-07 06:48:42.215372 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-07 06:48:42.953453 | debian-bookworm | changed: 2026-09-07 06:48:42.953690 | debian-bookworm | .d..t...... ./ 2026-09-07 06:48:42.953727 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-09-07 06:48:42.953751 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-09-07 06:48:42.953773 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-09-07 06:48:42.953793 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-09-07 06:48:42.953813 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-09-07 06:48:42.953872 | debian-bookworm | changed: All items complete 2026-09-07 06:48:42.953899 | 2026-09-07 06:48:43.487286 | debian-bookworm | changed: .d..t...... ./ 2026-09-07 06:48:44.023348 | debian-bookworm | changed: .d..t...... ./ 2026-09-07 06:48:44.045322 | 2026-09-07 06:48:44.045440 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-07 06:48:44.380968 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.008956 2026-09-07 06:48:44.635363 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.014931 2026-09-07 06:48:44.643624 | 2026-09-07 06:48:44.643717 | PLAY RECAP 2026-09-07 06:48:44.643768 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-09-07 06:48:44.643794 | 2026-09-07 06:48:44.786926 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-07 06:48:44.787735 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-07 06:48:45.504659 | 2026-09-07 06:48:45.504819 | PLAY [Base post] 2026-09-07 06:48:45.518586 | 2026-09-07 06:48:45.518736 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-07 06:48:46.067140 | debian-bookworm | changed 2026-09-07 06:48:46.087055 | 2026-09-07 06:48:46.087180 | PLAY RECAP 2026-09-07 06:48:46.087246 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-07 06:48:46.087308 | 2026-09-07 06:48:46.233215 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-07 06:48:46.234045 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-07 06:48:47.079039 | 2026-09-07 06:48:47.079529 | PLAY [Base post-logs] 2026-09-07 06:48:47.102258 | 2026-09-07 06:48:47.102410 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-07 06:48:47.645321 | localhost | changed 2026-09-07 06:48:47.661545 | 2026-09-07 06:48:47.661714 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-07 06:48:47.696654 | localhost | ok 2026-09-07 06:48:47.705912 | 2026-09-07 06:48:47.706063 | TASK [Set zuul-log-path fact] 2026-09-07 06:48:47.724791 | localhost | ok 2026-09-07 06:48:47.736817 | 2026-09-07 06:48:47.736960 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-07 06:48:47.762567 | localhost | ok 2026-09-07 06:48:47.767146 | 2026-09-07 06:48:47.767309 | TASK [upload-logs : Create log directories] 2026-09-07 06:48:48.241934 | localhost | changed 2026-09-07 06:48:48.244541 | 2026-09-07 06:48:48.244629 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-07 06:48:48.653510 | localhost -> localhost | ok: Runtime: 0:00:00.003504 2026-09-07 06:48:48.657021 | 2026-09-07 06:48:48.657110 | TASK [upload-logs : Upload logs to log server] 2026-09-07 06:48:49.110146 | localhost | Output suppressed because no_log was given 2026-09-07 06:48:49.116638 | 2026-09-07 06:48:49.116810 | LOOP [upload-logs : Compress console log and json output] 2026-09-07 06:48:49.169926 | localhost | skipping: Conditional result was False 2026-09-07 06:48:49.175503 | localhost | skipping: Conditional result was False 2026-09-07 06:48:49.185982 | 2026-09-07 06:48:49.186147 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-07 06:48:49.243110 | localhost | skipping: Conditional result was False 2026-09-07 06:48:49.243461 | 2026-09-07 06:48:49.247171 | localhost | skipping: Conditional result was False 2026-09-07 06:48:49.251270 | 2026-09-07 06:48:49.251360 | LOOP [upload-logs : Upload console log and json output]