2026-05-20 10:37:43.903364 | Job console starting 2026-05-20 10:37:43.945813 | Updating git repos 2026-05-20 10:37:44.056980 | Cloning repos into workspace 2026-05-20 10:37:44.143467 | Restoring repo states 2026-05-20 10:37:44.189036 | Merging changes 2026-05-20 10:37:44.961229 | Checking out repos 2026-05-20 10:37:45.078814 | Preparing playbooks 2026-05-20 10:37:46.535099 | Running Ansible setup 2026-05-20 10:37:52.460672 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-20 10:37:53.512937 | 2026-05-20 10:37:53.513073 | PLAY [Base pre] 2026-05-20 10:37:53.572624 | 2026-05-20 10:37:53.572753 | TASK [Setup log path fact] 2026-05-20 10:37:53.641025 | debian-bookworm | ok 2026-05-20 10:37:53.693811 | 2026-05-20 10:37:53.693978 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-20 10:37:53.753641 | debian-bookworm | ok 2026-05-20 10:37:53.773544 | 2026-05-20 10:37:53.773656 | TASK [emit-job-header : Print job information] 2026-05-20 10:37:53.843150 | # Job Information 2026-05-20 10:37:53.843309 | Ansible Version: 2.16.14 2026-05-20 10:37:53.843344 | Job: python-black 2026-05-20 10:37:53.843378 | Pipeline: check 2026-05-20 10:37:53.843401 | Executor: 521e9411259a 2026-05-20 10:37:53.843422 | Triggered by: https://github.com/osism/python-osism/pull/2300 2026-05-20 10:37:53.843444 | Event ID: e8ffaac0-5437-11f1-8663-b44bfb9d014a 2026-05-20 10:37:53.848319 | 2026-05-20 10:37:53.848413 | LOOP [emit-job-header : Print node information] 2026-05-20 10:37:54.131580 | debian-bookworm | ok: 2026-05-20 10:37:54.131755 | debian-bookworm | # Node Information 2026-05-20 10:37:54.131826 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-20 10:37:54.131866 | debian-bookworm | Hostname: debian 2026-05-20 10:37:54.131890 | debian-bookworm | Username: zuul 2026-05-20 10:37:54.131911 | debian-bookworm | Distro: Debian 12.14 2026-05-20 10:37:54.131935 | debian-bookworm | Provider: regiocloud-a 2026-05-20 10:37:54.131956 | debian-bookworm | Region: 2026-05-20 10:37:54.131977 | debian-bookworm | Label: debian-bookworm 2026-05-20 10:37:54.131997 | debian-bookworm | Product Name: OpenStack Nova 2026-05-20 10:37:54.132016 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fef1:741a 2026-05-20 10:37:54.153394 | 2026-05-20 10:37:54.153511 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-20 10:37:55.123871 | debian-bookworm -> localhost | changed 2026-05-20 10:37:55.130705 | 2026-05-20 10:37:55.130815 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-20 10:37:56.850240 | debian-bookworm -> localhost | changed 2026-05-20 10:37:56.859792 | 2026-05-20 10:37:56.859904 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-20 10:37:57.495189 | debian-bookworm -> localhost | ok 2026-05-20 10:37:57.501610 | 2026-05-20 10:37:57.501730 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-20 10:37:57.542131 | debian-bookworm | ok 2026-05-20 10:37:57.579303 | debian-bookworm | included: /var/lib/zuul/builds/cc7fe3ed300d418d97fa49adfc94b347/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-20 10:37:57.616142 | 2026-05-20 10:37:57.616250 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-20 10:37:59.680802 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-20 10:37:59.681014 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/cc7fe3ed300d418d97fa49adfc94b347/work/cc7fe3ed300d418d97fa49adfc94b347_id_rsa 2026-05-20 10:37:59.681055 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/cc7fe3ed300d418d97fa49adfc94b347/work/cc7fe3ed300d418d97fa49adfc94b347_id_rsa.pub 2026-05-20 10:37:59.681082 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-20 10:37:59.681106 | debian-bookworm -> localhost | SHA256:3rWWfYAidtfZm6JFU/8k8ThmFaVpUImmoCrRXagCe+A zuul-build-sshkey 2026-05-20 10:37:59.681128 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-20 10:37:59.681163 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-20 10:37:59.681184 | debian-bookworm -> localhost | | . .o.oo| 2026-05-20 10:37:59.681205 | debian-bookworm -> localhost | |o . o o..o.| 2026-05-20 10:37:59.681227 | debian-bookworm -> localhost | |.+ . o o . o =..| 2026-05-20 10:37:59.681247 | debian-bookworm -> localhost | |.E+ o o . +.B.| 2026-05-20 10:37:59.681267 | debian-bookworm -> localhost | | . o . S o +oX =| 2026-05-20 10:37:59.681295 | debian-bookworm -> localhost | | . . o + +.*.=+| 2026-05-20 10:37:59.681317 | debian-bookworm -> localhost | | . . . +o.oo| 2026-05-20 10:37:59.681345 | debian-bookworm -> localhost | | .o .. | 2026-05-20 10:37:59.681371 | debian-bookworm -> localhost | | . | 2026-05-20 10:37:59.681390 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-20 10:37:59.681441 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.998521 2026-05-20 10:37:59.687703 | 2026-05-20 10:37:59.687808 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-20 10:37:59.719241 | debian-bookworm | ok 2026-05-20 10:37:59.737735 | debian-bookworm | included: /var/lib/zuul/builds/cc7fe3ed300d418d97fa49adfc94b347/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-20 10:37:59.761656 | 2026-05-20 10:37:59.761768 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-20 10:37:59.795267 | debian-bookworm | skipping: Conditional result was False 2026-05-20 10:37:59.801149 | 2026-05-20 10:37:59.801257 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-20 10:38:00.564582 | debian-bookworm | changed 2026-05-20 10:38:00.569869 | 2026-05-20 10:38:00.569994 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-20 10:38:00.822790 | debian-bookworm | ok 2026-05-20 10:38:00.829205 | 2026-05-20 10:38:00.829305 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-20 10:38:01.485676 | debian-bookworm | changed 2026-05-20 10:38:01.494666 | 2026-05-20 10:38:01.494776 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-20 10:38:02.152622 | debian-bookworm | changed 2026-05-20 10:38:02.161182 | 2026-05-20 10:38:02.161283 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-20 10:38:02.199016 | debian-bookworm | skipping: Conditional result was False 2026-05-20 10:38:02.205709 | 2026-05-20 10:38:02.205810 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-20 10:38:02.717155 | debian-bookworm -> localhost | changed 2026-05-20 10:38:02.729238 | 2026-05-20 10:38:02.729328 | TASK [add-build-sshkey : Add back temp key] 2026-05-20 10:38:03.227011 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/cc7fe3ed300d418d97fa49adfc94b347/work/cc7fe3ed300d418d97fa49adfc94b347_id_rsa (zuul-build-sshkey) 2026-05-20 10:38:03.227286 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.034026 2026-05-20 10:38:03.234761 | 2026-05-20 10:38:03.234950 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-20 10:38:03.666894 | debian-bookworm | ok 2026-05-20 10:38:03.671784 | 2026-05-20 10:38:03.671871 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-20 10:38:03.697207 | debian-bookworm | skipping: Conditional result was False 2026-05-20 10:38:03.715201 | 2026-05-20 10:38:03.715311 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-20 10:38:04.146790 | debian-bookworm | ok 2026-05-20 10:38:04.172023 | 2026-05-20 10:38:04.172129 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-20 10:38:04.210180 | debian-bookworm | ok 2026-05-20 10:38:04.221192 | 2026-05-20 10:38:04.221295 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-20 10:38:04.580390 | debian-bookworm -> localhost | ok 2026-05-20 10:38:04.585893 | 2026-05-20 10:38:04.586004 | TASK [validate-host : Collect information about the host] 2026-05-20 10:38:05.818191 | debian-bookworm | ok 2026-05-20 10:38:05.839028 | 2026-05-20 10:38:05.839138 | TASK [validate-host : Sanitize hostname] 2026-05-20 10:38:05.926815 | debian-bookworm | ok 2026-05-20 10:38:05.952692 | 2026-05-20 10:38:05.952777 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-20 10:38:06.739487 | debian-bookworm -> localhost | changed 2026-05-20 10:38:06.745111 | 2026-05-20 10:38:06.745207 | TASK [validate-host : Collect information about zuul worker] 2026-05-20 10:38:07.228586 | debian-bookworm | ok 2026-05-20 10:38:07.233245 | 2026-05-20 10:38:07.233338 | TASK [validate-host : Write out all zuul information for each host] 2026-05-20 10:38:08.102255 | debian-bookworm -> localhost | changed 2026-05-20 10:38:08.111671 | 2026-05-20 10:38:08.111762 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-20 10:38:08.425371 | debian-bookworm | ok 2026-05-20 10:38:08.431566 | 2026-05-20 10:38:08.431659 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-20 10:38:09.576127 | debian-bookworm | changed: 2026-05-20 10:38:09.576443 | debian-bookworm | cd+++++++++ src/ 2026-05-20 10:38:09.576483 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-20 10:38:09.576596 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-20 10:38:09.576623 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-05-20 10:38:09.576816 | debian-bookworm | Containerfile 2026-05-20 10:38:09.577237 | debian-bookworm | Containerfile 2026-05-20 10:38:09.613237 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/cc7fe3ed300d418d97fa49adfc94b347/work/logs" 2026-05-20 10:38:42.771345 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/cc7fe3ed300d418d97fa49adfc94b347/work/artifacts" 2026-05-20 10:38:43.043431 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/cc7fe3ed300d418d97fa49adfc94b347/work/docs" 2026-05-20 10:38:43.063803 | 2026-05-20 10:38:43.063980 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-20 10:38:43.883493 | debian-bookworm | changed: 2026-05-20 10:38:43.883916 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-20 10:38:43.883985 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-20 10:38:43.884036 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-20 10:38:43.884114 | debian-bookworm | changed: All items complete 2026-05-20 10:38:43.884178 | 2026-05-20 10:38:44.426711 | debian-bookworm | changed: .d..t...... ./ 2026-05-20 10:38:44.985280 | debian-bookworm | changed: .d..t...... ./ 2026-05-20 10:38:45.007494 | 2026-05-20 10:38:45.007695 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-20 10:38:45.594456 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.006547 2026-05-20 10:38:45.869951 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.012269 2026-05-20 10:38:45.893679 | 2026-05-20 10:38:45.893817 | PLAY RECAP 2026-05-20 10:38:45.893899 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-20 10:38:45.893941 | 2026-05-20 10:38:46.050764 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-20 10:38:46.052047 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-20 10:38:46.820583 | 2026-05-20 10:38:46.820868 | PLAY [Base post] 2026-05-20 10:38:46.835106 | 2026-05-20 10:38:46.835270 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-20 10:38:47.497757 | debian-bookworm | changed 2026-05-20 10:38:47.506981 | 2026-05-20 10:38:47.507156 | PLAY RECAP 2026-05-20 10:38:47.507342 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-20 10:38:47.507436 | 2026-05-20 10:38:47.662758 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-20 10:38:47.663742 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-20 10:38:48.536804 | 2026-05-20 10:38:48.536990 | PLAY [Base post-logs] 2026-05-20 10:38:48.548703 | 2026-05-20 10:38:48.548858 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-20 10:38:49.022771 | localhost | changed 2026-05-20 10:38:49.041316 | 2026-05-20 10:38:49.041503 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-20 10:38:49.081005 | localhost | ok 2026-05-20 10:38:49.087055 | 2026-05-20 10:38:49.087294 | TASK [Set zuul-log-path fact] 2026-05-20 10:38:49.116328 | localhost | ok 2026-05-20 10:38:49.131311 | 2026-05-20 10:38:49.131469 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-20 10:38:49.169674 | localhost | ok 2026-05-20 10:38:49.177148 | 2026-05-20 10:38:49.177359 | TASK [upload-logs : Create log directories] 2026-05-20 10:38:49.726718 | localhost | changed 2026-05-20 10:38:49.731460 | 2026-05-20 10:38:49.732659 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-20 10:38:50.260449 | localhost -> localhost | ok: Runtime: 0:00:00.014601 2026-05-20 10:38:50.269513 | 2026-05-20 10:38:50.269710 | TASK [upload-logs : Upload logs to log server] 2026-05-20 10:38:50.853944 | localhost | Output suppressed because no_log was given 2026-05-20 10:38:50.859926 | 2026-05-20 10:38:50.860245 | LOOP [upload-logs : Compress console log and json output] 2026-05-20 10:38:50.909253 | localhost | skipping: Conditional result was False 2026-05-20 10:38:50.915423 | localhost | skipping: Conditional result was False 2026-05-20 10:38:50.930376 | 2026-05-20 10:38:50.930539 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-20 10:38:50.981861 | localhost | skipping: Conditional result was False 2026-05-20 10:38:50.982411 | 2026-05-20 10:38:50.983725 | localhost | skipping: Conditional result was False 2026-05-20 10:38:50.995834 | 2026-05-20 10:38:51.006448 | LOOP [upload-logs : Upload console log and json output]