2026-09-12 22:10:56.727283 | Job console starting 2026-09-12 22:10:56.746514 | Updating git repos 2026-09-12 22:10:56.819117 | Cloning repos into workspace 2026-09-12 22:10:56.883601 | Restoring repo states 2026-09-12 22:10:56.912372 | Merging changes 2026-09-12 22:10:58.090693 | Checking out repos 2026-09-12 22:10:58.205319 | Preparing playbooks 2026-09-12 22:10:59.792612 | Running Ansible setup 2026-09-12 22:11:05.055095 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-09-12 22:11:05.816770 | 2026-09-12 22:11:05.816885 | PLAY [Base pre] 2026-09-12 22:11:05.843365 | 2026-09-12 22:11:05.843482 | TASK [Setup log path fact] 2026-09-12 22:11:05.880699 | debian-bookworm | ok 2026-09-12 22:11:05.897278 | 2026-09-12 22:11:05.897382 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-12 22:11:05.950287 | debian-bookworm | ok 2026-09-12 22:11:05.958196 | 2026-09-12 22:11:05.958286 | TASK [emit-job-header : Print job information] 2026-09-12 22:11:06.044873 | # Job Information 2026-09-12 22:11:06.045020 | Ansible Version: 2.16.14 2026-09-12 22:11:06.045049 | Job: python-black 2026-09-12 22:11:06.045126 | Pipeline: check 2026-09-12 22:11:06.045150 | Executor: 521e9411259a 2026-09-12 22:11:06.045169 | Triggered by: https://github.com/osism/python-osism/pull/2692 2026-09-12 22:11:06.045188 | Event ID: ce5ee770-aef6-11f1-81e6-0779ac7a14ac 2026-09-12 22:11:06.049119 | 2026-09-12 22:11:06.049201 | LOOP [emit-job-header : Print node information] 2026-09-12 22:11:06.334315 | debian-bookworm | ok: 2026-09-12 22:11:06.334513 | debian-bookworm | # Node Information 2026-09-12 22:11:06.334545 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-09-12 22:11:06.334567 | debian-bookworm | Hostname: debian 2026-09-12 22:11:06.334586 | debian-bookworm | Username: zuul 2026-09-12 22:11:06.334603 | debian-bookworm | Distro: Debian 12.15 2026-09-12 22:11:06.334622 | debian-bookworm | Provider: regiocloud-a 2026-09-12 22:11:06.334640 | debian-bookworm | Region: 2026-09-12 22:11:06.334659 | debian-bookworm | Label: debian-bookworm 2026-09-12 22:11:06.334675 | debian-bookworm | Product Name: OpenStack Nova 2026-09-12 22:11:06.334691 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fea0:be73 2026-09-12 22:11:06.342991 | 2026-09-12 22:11:06.343081 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-12 22:11:07.191838 | debian-bookworm -> localhost | changed 2026-09-12 22:11:07.198864 | 2026-09-12 22:11:07.198964 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-12 22:11:09.320069 | debian-bookworm -> localhost | changed 2026-09-12 22:11:09.328717 | 2026-09-12 22:11:09.328795 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-12 22:11:09.994947 | debian-bookworm -> localhost | ok 2026-09-12 22:11:09.999810 | 2026-09-12 22:11:09.999893 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-12 22:11:10.047480 | debian-bookworm | ok 2026-09-12 22:11:10.066303 | debian-bookworm | included: /var/lib/zuul/builds/db03a73d2351471f8b898c46e6155947/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-12 22:11:10.079510 | 2026-09-12 22:11:10.079594 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-12 22:11:12.443115 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-09-12 22:11:12.443281 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/db03a73d2351471f8b898c46e6155947/work/db03a73d2351471f8b898c46e6155947_id_rsa 2026-09-12 22:11:12.443312 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/db03a73d2351471f8b898c46e6155947/work/db03a73d2351471f8b898c46e6155947_id_rsa.pub 2026-09-12 22:11:12.443334 | debian-bookworm -> localhost | The key fingerprint is: 2026-09-12 22:11:12.443355 | debian-bookworm -> localhost | SHA256:C0N880TYz2gj16oQZ0CMKKIslj4rLw3jAhO8i2Pj+ow zuul-build-sshkey 2026-09-12 22:11:12.443374 | debian-bookworm -> localhost | The key's randomart image is: 2026-09-12 22:11:12.443409 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-09-12 22:11:12.443428 | debian-bookworm -> localhost | | . +. o. | 2026-09-12 22:11:12.443445 | debian-bookworm -> localhost | |o . ..o ... | 2026-09-12 22:11:12.443462 | debian-bookworm -> localhost | |=.. o.o .= | 2026-09-12 22:11:12.443477 | debian-bookworm -> localhost | |+= ...++= + | 2026-09-12 22:11:12.443493 | debian-bookworm -> localhost | |+.. o+S+.o | 2026-09-12 22:11:12.443513 | debian-bookworm -> localhost | |=+ .o .. | 2026-09-12 22:11:12.443530 | debian-bookworm -> localhost | |+=+ ... | 2026-09-12 22:11:12.443546 | debian-bookworm -> localhost | |*O. . | 2026-09-12 22:11:12.443564 | debian-bookworm -> localhost | |E*= | 2026-09-12 22:11:12.443580 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-09-12 22:11:12.443624 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.485409 2026-09-12 22:11:12.448656 | 2026-09-12 22:11:12.448724 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-12 22:11:12.475592 | debian-bookworm | ok 2026-09-12 22:11:12.485243 | debian-bookworm | included: /var/lib/zuul/builds/db03a73d2351471f8b898c46e6155947/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-12 22:11:12.501187 | 2026-09-12 22:11:12.501254 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-12 22:11:12.528581 | debian-bookworm | skipping: Conditional result was False 2026-09-12 22:11:12.533705 | 2026-09-12 22:11:12.533789 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-12 22:11:13.371994 | debian-bookworm | changed 2026-09-12 22:11:13.383973 | 2026-09-12 22:11:13.384059 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-12 22:11:13.681649 | debian-bookworm | ok 2026-09-12 22:11:13.696434 | 2026-09-12 22:11:13.696597 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-12 22:11:14.450036 | debian-bookworm | changed 2026-09-12 22:11:14.456181 | 2026-09-12 22:11:14.456258 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-12 22:11:15.147672 | debian-bookworm | changed 2026-09-12 22:11:15.152970 | 2026-09-12 22:11:15.153098 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-12 22:11:15.177764 | debian-bookworm | skipping: Conditional result was False 2026-09-12 22:11:15.191227 | 2026-09-12 22:11:15.191371 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-12 22:11:15.827586 | debian-bookworm -> localhost | changed 2026-09-12 22:11:15.840526 | 2026-09-12 22:11:15.840628 | TASK [add-build-sshkey : Add back temp key] 2026-09-12 22:11:16.513869 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/db03a73d2351471f8b898c46e6155947/work/db03a73d2351471f8b898c46e6155947_id_rsa (zuul-build-sshkey) 2026-09-12 22:11:16.514083 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.021445 2026-09-12 22:11:16.521165 | 2026-09-12 22:11:16.521263 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-12 22:11:17.060834 | debian-bookworm | ok 2026-09-12 22:11:17.065762 | 2026-09-12 22:11:17.065855 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-12 22:11:17.098692 | debian-bookworm | skipping: Conditional result was False 2026-09-12 22:11:17.108649 | 2026-09-12 22:11:17.108749 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-09-12 22:11:17.554806 | debian-bookworm | ok 2026-09-12 22:11:17.573343 | 2026-09-12 22:11:17.573479 | TASK [validate-host : Define zuul_info_dir fact] 2026-09-12 22:11:17.611618 | debian-bookworm | ok 2026-09-12 22:11:17.616809 | 2026-09-12 22:11:17.616901 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-09-12 22:11:18.202817 | debian-bookworm -> localhost | ok 2026-09-12 22:11:18.208814 | 2026-09-12 22:11:18.208907 | TASK [validate-host : Collect information about the host] 2026-09-12 22:11:19.496653 | debian-bookworm | ok 2026-09-12 22:11:19.518090 | 2026-09-12 22:11:19.518183 | TASK [validate-host : Sanitize hostname] 2026-09-12 22:11:19.684838 | debian-bookworm | ok 2026-09-12 22:11:19.689463 | 2026-09-12 22:11:19.689576 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-09-12 22:11:21.216166 | debian-bookworm -> localhost | changed 2026-09-12 22:11:21.221339 | 2026-09-12 22:11:21.221491 | TASK [validate-host : Collect information about zuul worker] 2026-09-12 22:11:21.678259 | debian-bookworm | ok 2026-09-12 22:11:21.684073 | 2026-09-12 22:11:21.684160 | TASK [validate-host : Write out all zuul information for each host] 2026-09-12 22:11:22.279417 | debian-bookworm -> localhost | changed 2026-09-12 22:11:22.286942 | 2026-09-12 22:11:22.287019 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-09-12 22:11:22.605066 | debian-bookworm | ok 2026-09-12 22:11:22.610049 | 2026-09-12 22:11:22.610149 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-09-12 22:11:24.785676 | debian-bookworm | changed: 2026-09-12 22:11:24.785849 | debian-bookworm | cd+++++++++ src/ 2026-09-12 22:11:24.785883 | debian-bookworm | cd+++++++++ src/github.com/ 2026-09-12 22:11:24.785908 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-09-12 22:11:24.785930 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-09-12 22:11:24.785950 | debian-bookworm | Containerfile 2026-09-12 22:11:24.786079 | debian-bookworm | Containerfile 2026-09-12 22:11:24.793340 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/db03a73d2351471f8b898c46e6155947/work/logs" 2026-09-12 22:12:48.393479 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/db03a73d2351471f8b898c46e6155947/work/artifacts" 2026-09-12 22:12:48.676563 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/db03a73d2351471f8b898c46e6155947/work/docs" 2026-09-12 22:12:48.702450 | 2026-09-12 22:12:48.702634 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-12 22:12:49.445039 | debian-bookworm | changed: 2026-09-12 22:12:49.445474 | debian-bookworm | .d..t...... ./ 2026-09-12 22:12:49.445577 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-09-12 22:12:49.445632 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-09-12 22:12:49.445677 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-09-12 22:12:49.445722 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-09-12 22:12:49.445764 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-09-12 22:12:49.445835 | debian-bookworm | changed: All items complete 2026-09-12 22:12:49.445887 | 2026-09-12 22:12:49.987926 | debian-bookworm | changed: .d..t...... ./ 2026-09-12 22:12:50.534713 | debian-bookworm | changed: .d..t...... ./ 2026-09-12 22:12:50.556538 | 2026-09-12 22:12:50.556660 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-12 22:12:50.887553 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.009314 2026-09-12 22:12:51.171542 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.010644 2026-09-12 22:12:51.185993 | 2026-09-12 22:12:51.186079 | PLAY RECAP 2026-09-12 22:12:51.186131 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-09-12 22:12:51.186156 | 2026-09-12 22:12:51.320808 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-12 22:12:51.323082 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-12 22:12:52.056032 | 2026-09-12 22:12:52.056180 | PLAY [Base post] 2026-09-12 22:12:52.069759 | 2026-09-12 22:12:52.069883 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-12 22:12:52.725924 | debian-bookworm | changed 2026-09-12 22:12:52.735572 | 2026-09-12 22:12:52.735701 | PLAY RECAP 2026-09-12 22:12:52.735778 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-12 22:12:52.735854 | 2026-09-12 22:12:52.852162 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-12 22:12:52.854222 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-12 22:12:53.601223 | 2026-09-12 22:12:53.601430 | PLAY [Base post-logs] 2026-09-12 22:12:53.611958 | 2026-09-12 22:12:53.612095 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-12 22:12:54.095353 | localhost | changed 2026-09-12 22:12:54.111030 | 2026-09-12 22:12:54.111203 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-12 22:12:54.149496 | localhost | ok 2026-09-12 22:12:54.156921 | 2026-09-12 22:12:54.157089 | TASK [Set zuul-log-path fact] 2026-09-12 22:12:54.176308 | localhost | ok 2026-09-12 22:12:54.191222 | 2026-09-12 22:12:54.191411 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-12 22:12:54.228648 | localhost | ok 2026-09-12 22:12:54.235500 | 2026-09-12 22:12:54.235677 | TASK [upload-logs : Create log directories] 2026-09-12 22:12:54.729819 | localhost | changed 2026-09-12 22:12:54.732663 | 2026-09-12 22:12:54.732768 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-12 22:12:55.221595 | localhost -> localhost | ok: Runtime: 0:00:00.007660 2026-09-12 22:12:55.225850 | 2026-09-12 22:12:55.225972 | TASK [upload-logs : Upload logs to log server] 2026-09-12 22:12:55.779682 | localhost | Output suppressed because no_log was given 2026-09-12 22:12:55.784397 | 2026-09-12 22:12:55.784585 | LOOP [upload-logs : Compress console log and json output] 2026-09-12 22:12:55.848858 | localhost | skipping: Conditional result was False 2026-09-12 22:12:55.853929 | localhost | skipping: Conditional result was False 2026-09-12 22:12:55.866763 | 2026-09-12 22:12:55.866994 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-12 22:12:55.925762 | localhost | skipping: Conditional result was False 2026-09-12 22:12:55.926431 | 2026-09-12 22:12:55.929660 | localhost | skipping: Conditional result was False 2026-09-12 22:12:55.938634 | 2026-09-12 22:12:55.938867 | LOOP [upload-logs : Upload console log and json output]