2026-09-17 11:32:33.182192 | Job console starting 2026-09-17 11:32:33.194047 | Updating git repos 2026-09-17 11:32:33.237226 | Cloning repos into workspace 2026-09-17 11:32:33.280500 | Restoring repo states 2026-09-17 11:32:33.294180 | Merging changes 2026-09-17 11:32:34.043165 | Checking out repos 2026-09-17 11:32:34.086245 | Preparing playbooks 2026-09-17 11:32:34.886387 | Running Ansible setup 2026-09-17 11:32:39.537621 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-09-17 11:32:40.388646 | 2026-09-17 11:32:40.388808 | PLAY [Base pre] 2026-09-17 11:32:40.413975 | 2026-09-17 11:32:40.414160 | TASK [Setup log path fact] 2026-09-17 11:32:40.434314 | debian-bookworm | ok 2026-09-17 11:32:40.450775 | 2026-09-17 11:32:40.450912 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-17 11:32:40.485072 | debian-bookworm | ok 2026-09-17 11:32:40.495574 | 2026-09-17 11:32:40.495687 | TASK [emit-job-header : Print job information] 2026-09-17 11:32:40.545058 | # Job Information 2026-09-17 11:32:40.545255 | Ansible Version: 2.16.14 2026-09-17 11:32:40.545289 | Job: python-black 2026-09-17 11:32:40.545322 | Pipeline: check 2026-09-17 11:32:40.545345 | Executor: 521e9411259a 2026-09-17 11:32:40.545366 | Triggered by: https://github.com/osism/python-osism/pull/2705 2026-09-17 11:32:40.545389 | Event ID: 4ace0510-b28b-11f1-8356-557030bebd17 2026-09-17 11:32:40.551024 | 2026-09-17 11:32:40.551159 | LOOP [emit-job-header : Print node information] 2026-09-17 11:32:40.657733 | debian-bookworm | ok: 2026-09-17 11:32:40.658024 | debian-bookworm | # Node Information 2026-09-17 11:32:40.658081 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-09-17 11:32:40.658108 | debian-bookworm | Hostname: debian 2026-09-17 11:32:40.658130 | debian-bookworm | Username: zuul 2026-09-17 11:32:40.658151 | debian-bookworm | Distro: Debian 12.15 2026-09-17 11:32:40.658176 | debian-bookworm | Provider: regiocloud-a 2026-09-17 11:32:40.658197 | debian-bookworm | Region: 2026-09-17 11:32:40.658219 | debian-bookworm | Label: debian-bookworm 2026-09-17 11:32:40.658239 | debian-bookworm | Product Name: OpenStack Nova 2026-09-17 11:32:40.658260 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe81:a2c3 2026-09-17 11:32:40.677803 | 2026-09-17 11:32:40.677936 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-17 11:32:41.188393 | debian-bookworm -> localhost | changed 2026-09-17 11:32:41.196557 | 2026-09-17 11:32:41.196684 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-17 11:32:42.334497 | debian-bookworm -> localhost | changed 2026-09-17 11:32:42.346706 | 2026-09-17 11:32:42.346835 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-17 11:32:42.667016 | debian-bookworm -> localhost | ok 2026-09-17 11:32:42.675006 | 2026-09-17 11:32:42.675158 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-17 11:32:42.717728 | debian-bookworm | ok 2026-09-17 11:32:42.751972 | debian-bookworm | included: /var/lib/zuul/builds/c86ec7bf8be24158b18b3328d6336fc7/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-17 11:32:42.766413 | 2026-09-17 11:32:42.766535 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-17 11:32:43.801105 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-09-17 11:32:43.801330 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/c86ec7bf8be24158b18b3328d6336fc7/work/c86ec7bf8be24158b18b3328d6336fc7_id_rsa 2026-09-17 11:32:43.801370 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/c86ec7bf8be24158b18b3328d6336fc7/work/c86ec7bf8be24158b18b3328d6336fc7_id_rsa.pub 2026-09-17 11:32:43.801399 | debian-bookworm -> localhost | The key fingerprint is: 2026-09-17 11:32:43.801424 | debian-bookworm -> localhost | SHA256:tTSi7EAmoagR7IzmeBOqExlXcZuiVVDPHt/YFv8XbbM zuul-build-sshkey 2026-09-17 11:32:43.801447 | debian-bookworm -> localhost | The key's randomart image is: 2026-09-17 11:32:43.801486 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-09-17 11:32:43.801509 | debian-bookworm -> localhost | |o . o++ | 2026-09-17 11:32:43.801531 | debian-bookworm -> localhost | |.+ ..o = | 2026-09-17 11:32:43.801577 | debian-bookworm -> localhost | |B ..= o = + . | 2026-09-17 11:32:43.801601 | debian-bookworm -> localhost | |+=o* o o * * o .| 2026-09-17 11:32:43.801623 | debian-bookworm -> localhost | |==... o S + + .oo| 2026-09-17 11:32:43.801648 | debian-bookworm -> localhost | |=.o o . o+| 2026-09-17 11:32:43.801683 | debian-bookworm -> localhost | |.o . . Eo| 2026-09-17 11:32:43.801704 | debian-bookworm -> localhost | |o .| 2026-09-17 11:32:43.801726 | debian-bookworm -> localhost | | . | 2026-09-17 11:32:43.801746 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-09-17 11:32:43.801803 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.429921 2026-09-17 11:32:43.808416 | 2026-09-17 11:32:43.808523 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-17 11:32:43.828072 | debian-bookworm | ok 2026-09-17 11:32:43.839636 | debian-bookworm | included: /var/lib/zuul/builds/c86ec7bf8be24158b18b3328d6336fc7/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-17 11:32:43.849641 | 2026-09-17 11:32:43.849744 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-17 11:32:43.873181 | debian-bookworm | skipping: Conditional result was False 2026-09-17 11:32:43.878917 | 2026-09-17 11:32:43.879020 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-17 11:32:44.712213 | debian-bookworm | changed 2026-09-17 11:32:44.717904 | 2026-09-17 11:32:44.718023 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-17 11:32:45.003145 | debian-bookworm | ok 2026-09-17 11:32:45.014162 | 2026-09-17 11:32:45.014292 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-17 11:32:45.715495 | debian-bookworm | changed 2026-09-17 11:32:45.722511 | 2026-09-17 11:32:45.722633 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-17 11:32:46.368332 | debian-bookworm | changed 2026-09-17 11:32:46.376703 | 2026-09-17 11:32:46.376820 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-17 11:32:46.403097 | debian-bookworm | skipping: Conditional result was False 2026-09-17 11:32:46.411359 | 2026-09-17 11:32:46.411466 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-17 11:32:46.991526 | debian-bookworm -> localhost | changed 2026-09-17 11:32:47.011420 | 2026-09-17 11:32:47.011738 | TASK [add-build-sshkey : Add back temp key] 2026-09-17 11:32:47.404306 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/c86ec7bf8be24158b18b3328d6336fc7/work/c86ec7bf8be24158b18b3328d6336fc7_id_rsa (zuul-build-sshkey) 2026-09-17 11:32:47.404568 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.020241 2026-09-17 11:32:47.414528 | 2026-09-17 11:32:47.414662 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-17 11:32:47.861729 | debian-bookworm | ok 2026-09-17 11:32:47.868283 | 2026-09-17 11:32:47.868406 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-17 11:32:47.892659 | debian-bookworm | skipping: Conditional result was False 2026-09-17 11:32:47.904580 | 2026-09-17 11:32:47.904700 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-09-17 11:32:48.365778 | debian-bookworm | ok 2026-09-17 11:32:48.384705 | 2026-09-17 11:32:48.384844 | TASK [validate-host : Define zuul_info_dir fact] 2026-09-17 11:32:48.424592 | debian-bookworm | ok 2026-09-17 11:32:48.430180 | 2026-09-17 11:32:48.430290 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-09-17 11:32:48.777947 | debian-bookworm -> localhost | ok 2026-09-17 11:32:48.784769 | 2026-09-17 11:32:48.784876 | TASK [validate-host : Collect information about the host] 2026-09-17 11:32:50.950578 | debian-bookworm | ok 2026-09-17 11:32:50.985371 | 2026-09-17 11:32:50.985509 | TASK [validate-host : Sanitize hostname] 2026-09-17 11:32:51.162524 | debian-bookworm | ok 2026-09-17 11:32:51.167805 | 2026-09-17 11:32:51.167921 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-09-17 11:32:51.959402 | debian-bookworm -> localhost | changed 2026-09-17 11:32:51.967807 | 2026-09-17 11:32:51.967937 | TASK [validate-host : Collect information about zuul worker] 2026-09-17 11:32:52.504688 | debian-bookworm | ok 2026-09-17 11:32:52.510581 | 2026-09-17 11:32:52.510678 | TASK [validate-host : Write out all zuul information for each host] 2026-09-17 11:32:53.064860 | debian-bookworm -> localhost | changed 2026-09-17 11:32:53.072648 | 2026-09-17 11:32:53.072731 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-09-17 11:32:53.370882 | debian-bookworm | ok 2026-09-17 11:32:53.380605 | 2026-09-17 11:32:53.380730 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-09-17 11:32:55.285347 | debian-bookworm | changed: 2026-09-17 11:32:55.285506 | debian-bookworm | cd+++++++++ src/ 2026-09-17 11:32:55.285540 | debian-bookworm | cd+++++++++ src/github.com/ 2026-09-17 11:32:55.285632 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-09-17 11:32:55.285656 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-09-17 11:32:55.285677 | debian-bookworm | Containerfile 2026-09-17 11:32:55.285808 | debian-bookworm | Containerfile 2026-09-17 11:32:55.300581 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/c86ec7bf8be24158b18b3328d6336fc7/work/logs" 2026-09-17 11:34:11.594520 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/c86ec7bf8be24158b18b3328d6336fc7/work/artifacts" 2026-09-17 11:34:12.083422 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/c86ec7bf8be24158b18b3328d6336fc7/work/docs" 2026-09-17 11:34:12.095885 | 2026-09-17 11:34:12.095992 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-17 11:34:12.987274 | debian-bookworm | changed: 2026-09-17 11:34:12.987616 | debian-bookworm | .d..t...... ./ 2026-09-17 11:34:12.987659 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-09-17 11:34:12.987735 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-09-17 11:34:12.987765 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-09-17 11:34:12.987801 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-09-17 11:34:12.987824 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-09-17 11:34:12.987869 | debian-bookworm | changed: All items complete 2026-09-17 11:34:12.987898 | 2026-09-17 11:34:13.651020 | debian-bookworm | changed: .d..t...... ./ 2026-09-17 11:34:14.315019 | debian-bookworm | changed: .d..t...... ./ 2026-09-17 11:34:14.329243 | 2026-09-17 11:34:14.329330 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-17 11:34:14.773807 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.004710 2026-09-17 11:34:15.382540 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.020530 2026-09-17 11:34:15.390293 | 2026-09-17 11:34:15.390361 | PLAY RECAP 2026-09-17 11:34:15.390411 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-09-17 11:34:15.390436 | 2026-09-17 11:34:15.501393 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-17 11:34:15.502311 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-17 11:34:16.269518 | 2026-09-17 11:34:16.269738 | PLAY [Base post] 2026-09-17 11:34:16.281856 | 2026-09-17 11:34:16.281969 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-17 11:34:16.795655 | debian-bookworm | changed 2026-09-17 11:34:16.804068 | 2026-09-17 11:34:16.804163 | PLAY RECAP 2026-09-17 11:34:16.804223 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-17 11:34:16.804283 | 2026-09-17 11:34:16.904047 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-17 11:34:16.904664 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-17 11:34:17.648566 | 2026-09-17 11:34:17.648686 | PLAY [Base post-logs] 2026-09-17 11:34:17.656856 | 2026-09-17 11:34:17.656953 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-17 11:34:18.142026 | localhost | changed 2026-09-17 11:34:18.150592 | 2026-09-17 11:34:18.150706 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-17 11:34:18.197237 | localhost | ok 2026-09-17 11:34:18.199671 | 2026-09-17 11:34:18.199747 | TASK [Set zuul-log-path fact] 2026-09-17 11:34:18.213468 | localhost | ok 2026-09-17 11:34:18.219592 | 2026-09-17 11:34:18.219666 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-17 11:34:18.245991 | localhost | ok 2026-09-17 11:34:18.248338 | 2026-09-17 11:34:18.248407 | TASK [upload-logs : Create log directories] 2026-09-17 11:34:18.770753 | localhost | changed 2026-09-17 11:34:18.773339 | 2026-09-17 11:34:18.773425 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-17 11:34:19.479669 | localhost -> localhost | ok: Runtime: 0:00:00.011797 2026-09-17 11:34:19.486325 | 2026-09-17 11:34:19.486456 | TASK [upload-logs : Upload logs to log server] 2026-09-17 11:34:20.674891 | localhost | Output suppressed because no_log was given 2026-09-17 11:34:20.676254 | 2026-09-17 11:34:20.676323 | LOOP [upload-logs : Compress console log and json output] 2026-09-17 11:34:20.714692 | localhost | skipping: Conditional result was False 2026-09-17 11:34:20.717845 | localhost | skipping: Conditional result was False 2026-09-17 11:34:20.720689 | 2026-09-17 11:34:20.720771 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-17 11:34:20.810534 | localhost | skipping: Conditional result was False 2026-09-17 11:34:20.810733 | 2026-09-17 11:34:20.822573 | localhost | skipping: Conditional result was False 2026-09-17 11:34:20.825411 | 2026-09-17 11:34:20.825492 | LOOP [upload-logs : Upload console log and json output]