2026-08-24 06:52:07.979145 | Job console starting 2026-08-24 06:52:07.988862 | Updating git repos 2026-08-24 06:52:08.063723 | Cloning repos into workspace 2026-08-24 06:52:08.120252 | Restoring repo states 2026-08-24 06:52:08.132183 | Merging changes 2026-08-24 06:52:08.939548 | Checking out repos 2026-08-24 06:52:09.055757 | Preparing playbooks 2026-08-24 06:52:10.058893 | Running Ansible setup 2026-08-24 06:52:15.274966 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-08-24 06:52:16.173589 | 2026-08-24 06:52:16.173877 | PLAY [Base pre] 2026-08-24 06:52:16.193340 | 2026-08-24 06:52:16.193504 | TASK [Setup log path fact] 2026-08-24 06:52:16.216116 | debian-bookworm | ok 2026-08-24 06:52:16.238266 | 2026-08-24 06:52:16.238439 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-24 06:52:16.279318 | debian-bookworm | ok 2026-08-24 06:52:16.290083 | 2026-08-24 06:52:16.290222 | TASK [emit-job-header : Print job information] 2026-08-24 06:52:16.379340 | # Job Information 2026-08-24 06:52:16.379552 | Ansible Version: 2.16.14 2026-08-24 06:52:16.379588 | Job: python-black 2026-08-24 06:52:16.379619 | Pipeline: check 2026-08-24 06:52:16.379642 | Executor: 521e9411259a 2026-08-24 06:52:16.379663 | Triggered by: https://github.com/osism/python-osism/pull/2581 2026-08-24 06:52:16.379685 | Event ID: 43b30390-9f88-11f1-9292-08ec5babdd7e 2026-08-24 06:52:16.386428 | 2026-08-24 06:52:16.388770 | LOOP [emit-job-header : Print node information] 2026-08-24 06:52:16.745479 | debian-bookworm | ok: 2026-08-24 06:52:16.745872 | debian-bookworm | # Node Information 2026-08-24 06:52:16.745921 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-08-24 06:52:16.745948 | debian-bookworm | Hostname: debian 2026-08-24 06:52:16.745971 | debian-bookworm | Username: zuul 2026-08-24 06:52:16.745991 | debian-bookworm | Distro: Debian 12.15 2026-08-24 06:52:16.746015 | debian-bookworm | Provider: regiocloud-a 2026-08-24 06:52:16.746035 | debian-bookworm | Region: 2026-08-24 06:52:16.746055 | debian-bookworm | Label: debian-bookworm 2026-08-24 06:52:16.746074 | debian-bookworm | Product Name: OpenStack Nova 2026-08-24 06:52:16.746092 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feca:bc33 2026-08-24 06:52:16.766248 | 2026-08-24 06:52:16.766424 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-24 06:52:18.319575 | debian-bookworm -> localhost | changed 2026-08-24 06:52:18.325545 | 2026-08-24 06:52:18.325653 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-24 06:52:20.891112 | debian-bookworm -> localhost | changed 2026-08-24 06:52:20.906070 | 2026-08-24 06:52:20.906182 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-24 06:52:21.258163 | debian-bookworm -> localhost | ok 2026-08-24 06:52:21.264460 | 2026-08-24 06:52:21.264575 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-24 06:52:21.317958 | debian-bookworm | ok 2026-08-24 06:52:21.351121 | debian-bookworm | included: /var/lib/zuul/builds/41388b9095d94e9796f24ffe4c9c9425/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-24 06:52:21.360727 | 2026-08-24 06:52:21.361012 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-24 06:52:23.337125 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-08-24 06:52:23.337484 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/41388b9095d94e9796f24ffe4c9c9425/work/41388b9095d94e9796f24ffe4c9c9425_id_rsa 2026-08-24 06:52:23.337586 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/41388b9095d94e9796f24ffe4c9c9425/work/41388b9095d94e9796f24ffe4c9c9425_id_rsa.pub 2026-08-24 06:52:23.337640 | debian-bookworm -> localhost | The key fingerprint is: 2026-08-24 06:52:23.337690 | debian-bookworm -> localhost | SHA256:JL9SqaolPn58JWB7Bn9U1pTF5nk/4egZ9prgmbkw4Uw zuul-build-sshkey 2026-08-24 06:52:23.337747 | debian-bookworm -> localhost | The key's randomart image is: 2026-08-24 06:52:23.337850 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-08-24 06:52:23.337900 | debian-bookworm -> localhost | | o.+. | 2026-08-24 06:52:23.337945 | debian-bookworm -> localhost | | o o o | 2026-08-24 06:52:23.337986 | debian-bookworm -> localhost | | . .o o . | 2026-08-24 06:52:23.338027 | debian-bookworm -> localhost | | + +.. o..| 2026-08-24 06:52:23.338082 | debian-bookworm -> localhost | | . = .SE o.o| 2026-08-24 06:52:23.338132 | debian-bookworm -> localhost | | . =o*.. + o.| 2026-08-24 06:52:23.338175 | debian-bookworm -> localhost | | ...oo+.= .o + .| 2026-08-24 06:52:23.338217 | debian-bookworm -> localhost | | ..oo... + =o.. | 2026-08-24 06:52:23.338259 | debian-bookworm -> localhost | | .++.. *.o. | 2026-08-24 06:52:23.338302 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-08-24 06:52:23.338400 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.174585 2026-08-24 06:52:23.349568 | 2026-08-24 06:52:23.349704 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-24 06:52:23.369547 | debian-bookworm | ok 2026-08-24 06:52:23.381576 | debian-bookworm | included: /var/lib/zuul/builds/41388b9095d94e9796f24ffe4c9c9425/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-24 06:52:23.389451 | 2026-08-24 06:52:23.389542 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-24 06:52:23.405187 | debian-bookworm | skipping: Conditional result was False 2026-08-24 06:52:23.421308 | 2026-08-24 06:52:23.421474 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-24 06:52:24.143864 | debian-bookworm | changed 2026-08-24 06:52:24.151510 | 2026-08-24 06:52:24.151628 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-24 06:52:24.421323 | debian-bookworm | ok 2026-08-24 06:52:24.428599 | 2026-08-24 06:52:24.428714 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-24 06:52:25.094593 | debian-bookworm | changed 2026-08-24 06:52:25.100663 | 2026-08-24 06:52:25.100776 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-24 06:52:25.782819 | debian-bookworm | changed 2026-08-24 06:52:25.793843 | 2026-08-24 06:52:25.793947 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-24 06:52:25.840748 | debian-bookworm | skipping: Conditional result was False 2026-08-24 06:52:25.847734 | 2026-08-24 06:52:25.847862 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-24 06:52:26.397133 | debian-bookworm -> localhost | changed 2026-08-24 06:52:26.405977 | 2026-08-24 06:52:26.406075 | TASK [add-build-sshkey : Add back temp key] 2026-08-24 06:52:26.804580 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/41388b9095d94e9796f24ffe4c9c9425/work/41388b9095d94e9796f24ffe4c9c9425_id_rsa (zuul-build-sshkey) 2026-08-24 06:52:26.804763 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.017996 2026-08-24 06:52:26.811587 | 2026-08-24 06:52:26.811670 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-24 06:52:27.194296 | debian-bookworm | ok 2026-08-24 06:52:27.200125 | 2026-08-24 06:52:27.200215 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-24 06:52:27.223613 | debian-bookworm | skipping: Conditional result was False 2026-08-24 06:52:27.232305 | 2026-08-24 06:52:27.232404 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-08-24 06:52:27.688502 | debian-bookworm | ok 2026-08-24 06:52:27.699339 | 2026-08-24 06:52:27.699456 | TASK [validate-host : Define zuul_info_dir fact] 2026-08-24 06:52:27.727251 | debian-bookworm | ok 2026-08-24 06:52:27.732262 | 2026-08-24 06:52:27.732352 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-08-24 06:52:27.987924 | debian-bookworm -> localhost | ok 2026-08-24 06:52:27.994067 | 2026-08-24 06:52:27.994160 | TASK [validate-host : Collect information about the host] 2026-08-24 06:52:29.177053 | debian-bookworm | ok 2026-08-24 06:52:29.193206 | 2026-08-24 06:52:29.193347 | TASK [validate-host : Sanitize hostname] 2026-08-24 06:52:29.339937 | debian-bookworm | ok 2026-08-24 06:52:29.345592 | 2026-08-24 06:52:29.345685 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-08-24 06:52:30.015271 | debian-bookworm -> localhost | changed 2026-08-24 06:52:30.020927 | 2026-08-24 06:52:30.021025 | TASK [validate-host : Collect information about zuul worker] 2026-08-24 06:52:30.455406 | debian-bookworm | ok 2026-08-24 06:52:30.460321 | 2026-08-24 06:52:30.460421 | TASK [validate-host : Write out all zuul information for each host] 2026-08-24 06:52:31.115579 | debian-bookworm -> localhost | changed 2026-08-24 06:52:31.126674 | 2026-08-24 06:52:31.126828 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-08-24 06:52:31.403299 | debian-bookworm | ok 2026-08-24 06:52:31.413306 | 2026-08-24 06:52:31.413455 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-08-24 06:52:33.117311 | debian-bookworm | changed: 2026-08-24 06:52:33.117542 | debian-bookworm | cd+++++++++ src/ 2026-08-24 06:52:33.117579 | debian-bookworm | cd+++++++++ src/github.com/ 2026-08-24 06:52:33.117604 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-08-24 06:52:33.117625 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-08-24 06:52:33.117646 | debian-bookworm | Containerfile 2026-08-24 06:52:33.117822 | debian-bookworm | Containerfile 2026-08-24 06:52:33.134737 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/41388b9095d94e9796f24ffe4c9c9425/work/logs" 2026-08-24 06:53:46.935314 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/41388b9095d94e9796f24ffe4c9c9425/work/artifacts" 2026-08-24 06:53:47.336047 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/41388b9095d94e9796f24ffe4c9c9425/work/docs" 2026-08-24 06:53:47.365045 | 2026-08-24 06:53:47.365261 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-24 06:53:48.257560 | debian-bookworm | changed: 2026-08-24 06:53:48.257888 | debian-bookworm | .d..t...... ./ 2026-08-24 06:53:48.257930 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-08-24 06:53:48.257955 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-08-24 06:53:48.257976 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-08-24 06:53:48.257998 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-08-24 06:53:48.258018 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-08-24 06:53:48.258063 | debian-bookworm | changed: All items complete 2026-08-24 06:53:48.258091 | 2026-08-24 06:53:48.938229 | debian-bookworm | changed: .d..t...... ./ 2026-08-24 06:53:49.557787 | debian-bookworm | changed: .d..t...... ./ 2026-08-24 06:53:49.602105 | 2026-08-24 06:53:49.602276 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-24 06:53:50.037900 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.007924 2026-08-24 06:53:50.341129 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.009567 2026-08-24 06:53:50.355280 | 2026-08-24 06:53:50.355402 | PLAY RECAP 2026-08-24 06:53:50.355460 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-08-24 06:53:50.355490 | 2026-08-24 06:53:50.518939 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-08-24 06:53:50.520128 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-24 06:53:51.344953 | 2026-08-24 06:53:51.345142 | PLAY [Base post] 2026-08-24 06:53:51.360123 | 2026-08-24 06:53:51.360284 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-24 06:53:52.008879 | debian-bookworm | changed 2026-08-24 06:53:52.018568 | 2026-08-24 06:53:52.018730 | PLAY RECAP 2026-08-24 06:53:52.018811 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-24 06:53:52.018945 | 2026-08-24 06:53:52.174679 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-24 06:53:52.175792 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-24 06:53:53.196600 | 2026-08-24 06:53:53.196799 | PLAY [Base post-logs] 2026-08-24 06:53:53.210602 | 2026-08-24 06:53:53.210779 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-24 06:53:53.700316 | localhost | changed 2026-08-24 06:53:53.719018 | 2026-08-24 06:53:53.719229 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-24 06:53:53.771100 | localhost | ok 2026-08-24 06:53:53.778495 | 2026-08-24 06:53:53.778654 | TASK [Set zuul-log-path fact] 2026-08-24 06:53:53.806475 | localhost | ok 2026-08-24 06:53:53.815989 | 2026-08-24 06:53:53.816125 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-24 06:53:53.843637 | localhost | ok 2026-08-24 06:53:53.847204 | 2026-08-24 06:53:53.847317 | TASK [upload-logs : Create log directories] 2026-08-24 06:53:54.562864 | localhost | changed 2026-08-24 06:53:54.566145 | 2026-08-24 06:53:54.566284 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-24 06:53:55.171249 | localhost -> localhost | ok: Runtime: 0:00:00.005998 2026-08-24 06:53:55.175603 | 2026-08-24 06:53:55.175742 | TASK [upload-logs : Upload logs to log server] 2026-08-24 06:53:55.791793 | localhost | Output suppressed because no_log was given 2026-08-24 06:53:55.795227 | 2026-08-24 06:53:55.795392 | LOOP [upload-logs : Compress console log and json output] 2026-08-24 06:53:55.852894 | localhost | skipping: Conditional result was False 2026-08-24 06:53:55.860713 | localhost | skipping: Conditional result was False 2026-08-24 06:53:55.868432 | 2026-08-24 06:53:55.868877 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-24 06:53:55.935055 | localhost | skipping: Conditional result was False 2026-08-24 06:53:55.935386 | 2026-08-24 06:53:55.940489 | localhost | skipping: Conditional result was False 2026-08-24 06:53:55.945968 | 2026-08-24 06:53:55.946102 | LOOP [upload-logs : Upload console log and json output]