2026-09-04 18:16:53.637474 | Job console starting 2026-09-04 18:16:53.648084 | Updating git repos 2026-09-04 18:16:53.719729 | Cloning repos into workspace 2026-09-04 18:16:53.766964 | Restoring repo states 2026-09-04 18:16:53.784327 | Merging changes 2026-09-04 18:16:54.546203 | Checking out repos 2026-09-04 18:16:54.677758 | Preparing playbooks 2026-09-04 18:16:56.171334 | Running Ansible setup 2026-09-04 18:17:02.729966 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-09-04 18:17:04.366699 | 2026-09-04 18:17:04.366826 | PLAY [Base pre] 2026-09-04 18:17:04.398349 | 2026-09-04 18:17:04.398477 | TASK [Setup log path fact] 2026-09-04 18:17:04.430415 | debian-bookworm | ok 2026-09-04 18:17:04.458231 | 2026-09-04 18:17:04.458381 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-04 18:17:04.497796 | debian-bookworm | ok 2026-09-04 18:17:04.518426 | 2026-09-04 18:17:04.518540 | TASK [emit-job-header : Print job information] 2026-09-04 18:17:04.566884 | # Job Information 2026-09-04 18:17:04.567100 | Ansible Version: 2.16.14 2026-09-04 18:17:04.567138 | Job: python-black 2026-09-04 18:17:04.567169 | Pipeline: check 2026-09-04 18:17:04.567191 | Executor: 521e9411259a 2026-09-04 18:17:04.567211 | Triggered by: https://github.com/osism/python-osism/pull/2674 2026-09-04 18:17:04.567234 | Event ID: c6e573d0-a88c-11f1-9a79-973937c23766 2026-09-04 18:17:04.572173 | 2026-09-04 18:17:04.572278 | LOOP [emit-job-header : Print node information] 2026-09-04 18:17:04.700215 | debian-bookworm | ok: 2026-09-04 18:17:04.700399 | debian-bookworm | # Node Information 2026-09-04 18:17:04.700428 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-09-04 18:17:04.700449 | debian-bookworm | Hostname: debian 2026-09-04 18:17:04.700467 | debian-bookworm | Username: zuul 2026-09-04 18:17:04.700484 | debian-bookworm | Distro: Debian 12.15 2026-09-04 18:17:04.700503 | debian-bookworm | Provider: regiocloud-a 2026-09-04 18:17:04.700521 | debian-bookworm | Region: 2026-09-04 18:17:04.700538 | debian-bookworm | Label: debian-bookworm 2026-09-04 18:17:04.700554 | debian-bookworm | Product Name: OpenStack Nova 2026-09-04 18:17:04.700570 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe31:b0bf 2026-09-04 18:17:04.727196 | 2026-09-04 18:17:04.727349 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-04 18:17:05.488332 | debian-bookworm -> localhost | changed 2026-09-04 18:17:05.495109 | 2026-09-04 18:17:05.495214 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-04 18:17:06.794450 | debian-bookworm -> localhost | changed 2026-09-04 18:17:06.803092 | 2026-09-04 18:17:06.803170 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-04 18:17:07.340469 | debian-bookworm -> localhost | ok 2026-09-04 18:17:07.345273 | 2026-09-04 18:17:07.345358 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-04 18:17:07.372773 | debian-bookworm | ok 2026-09-04 18:17:07.392968 | debian-bookworm | included: /var/lib/zuul/builds/5b865afeec4a4eb688833207c6678c50/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-04 18:17:07.415888 | 2026-09-04 18:17:07.415980 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-04 18:17:09.216144 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-09-04 18:17:09.216371 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/5b865afeec4a4eb688833207c6678c50/work/5b865afeec4a4eb688833207c6678c50_id_rsa 2026-09-04 18:17:09.216409 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/5b865afeec4a4eb688833207c6678c50/work/5b865afeec4a4eb688833207c6678c50_id_rsa.pub 2026-09-04 18:17:09.216436 | debian-bookworm -> localhost | The key fingerprint is: 2026-09-04 18:17:09.216461 | debian-bookworm -> localhost | SHA256:eYfANTtzi/j8MRO/FXdTtrL5ijQVT1WuZFHQzZp1crQ zuul-build-sshkey 2026-09-04 18:17:09.216484 | debian-bookworm -> localhost | The key's randomart image is: 2026-09-04 18:17:09.216514 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-09-04 18:17:09.216537 | debian-bookworm -> localhost | | o o*B| 2026-09-04 18:17:09.216558 | debian-bookworm -> localhost | | . . o .oX| 2026-09-04 18:17:09.216578 | debian-bookworm -> localhost | | o + ..oE=| 2026-09-04 18:17:09.216597 | debian-bookworm -> localhost | | + * +*oo| 2026-09-04 18:17:09.216617 | debian-bookworm -> localhost | | S + +o.=o| 2026-09-04 18:17:09.216640 | debian-bookworm -> localhost | | + ..o+ =| 2026-09-04 18:17:09.216660 | debian-bookworm -> localhost | | oo+o. .| 2026-09-04 18:17:09.216679 | debian-bookworm -> localhost | | ..o+.o | 2026-09-04 18:17:09.216733 | debian-bookworm -> localhost | | ...o. | 2026-09-04 18:17:09.216756 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-09-04 18:17:09.216801 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.002107 2026-09-04 18:17:09.222255 | 2026-09-04 18:17:09.222331 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-04 18:17:09.238109 | debian-bookworm | ok 2026-09-04 18:17:09.246044 | debian-bookworm | included: /var/lib/zuul/builds/5b865afeec4a4eb688833207c6678c50/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-04 18:17:09.252815 | 2026-09-04 18:17:09.252884 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-04 18:17:09.265110 | debian-bookworm | skipping: Conditional result was False 2026-09-04 18:17:09.269722 | 2026-09-04 18:17:09.269790 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-04 18:17:09.877644 | debian-bookworm | changed 2026-09-04 18:17:09.883858 | 2026-09-04 18:17:09.883948 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-04 18:17:10.146984 | debian-bookworm | ok 2026-09-04 18:17:10.152639 | 2026-09-04 18:17:10.152726 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-04 18:17:10.796836 | debian-bookworm | changed 2026-09-04 18:17:10.801901 | 2026-09-04 18:17:10.801988 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-04 18:17:11.555763 | debian-bookworm | changed 2026-09-04 18:17:11.561059 | 2026-09-04 18:17:11.561140 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-04 18:17:11.588934 | debian-bookworm | skipping: Conditional result was False 2026-09-04 18:17:11.594732 | 2026-09-04 18:17:11.595365 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-04 18:17:12.407022 | debian-bookworm -> localhost | changed 2026-09-04 18:17:12.417830 | 2026-09-04 18:17:12.417925 | TASK [add-build-sshkey : Add back temp key] 2026-09-04 18:17:13.042023 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/5b865afeec4a4eb688833207c6678c50/work/5b865afeec4a4eb688833207c6678c50_id_rsa (zuul-build-sshkey) 2026-09-04 18:17:13.042221 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.035545 2026-09-04 18:17:13.049406 | 2026-09-04 18:17:13.049495 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-04 18:17:13.472470 | debian-bookworm | ok 2026-09-04 18:17:13.477498 | 2026-09-04 18:17:13.477590 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-04 18:17:13.535634 | debian-bookworm | skipping: Conditional result was False 2026-09-04 18:17:13.550539 | 2026-09-04 18:17:13.551019 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-09-04 18:17:14.179203 | debian-bookworm | ok 2026-09-04 18:17:14.196393 | 2026-09-04 18:17:14.196483 | TASK [validate-host : Define zuul_info_dir fact] 2026-09-04 18:17:14.239583 | debian-bookworm | ok 2026-09-04 18:17:14.244040 | 2026-09-04 18:17:14.244115 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-09-04 18:17:14.844899 | debian-bookworm -> localhost | ok 2026-09-04 18:17:14.849958 | 2026-09-04 18:17:14.850041 | TASK [validate-host : Collect information about the host] 2026-09-04 18:17:15.960163 | debian-bookworm | ok 2026-09-04 18:17:15.970576 | 2026-09-04 18:17:15.970658 | TASK [validate-host : Sanitize hostname] 2026-09-04 18:17:16.157583 | debian-bookworm | ok 2026-09-04 18:17:16.170199 | 2026-09-04 18:17:16.170296 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-09-04 18:17:16.916093 | debian-bookworm -> localhost | changed 2026-09-04 18:17:16.922063 | 2026-09-04 18:17:16.922153 | TASK [validate-host : Collect information about zuul worker] 2026-09-04 18:17:17.529107 | debian-bookworm | ok 2026-09-04 18:17:17.547158 | 2026-09-04 18:17:17.547322 | TASK [validate-host : Write out all zuul information for each host] 2026-09-04 18:17:18.157204 | debian-bookworm -> localhost | changed 2026-09-04 18:17:18.164683 | 2026-09-04 18:17:18.164766 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-09-04 18:17:18.412064 | debian-bookworm | ok 2026-09-04 18:17:18.416584 | 2026-09-04 18:17:18.416665 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-09-04 18:17:20.614262 | debian-bookworm | changed: 2026-09-04 18:17:20.615051 | debian-bookworm | cd+++++++++ src/ 2026-09-04 18:17:20.615108 | debian-bookworm | cd+++++++++ src/github.com/ 2026-09-04 18:17:20.615131 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-09-04 18:17:20.615151 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-09-04 18:17:20.615168 | debian-bookworm | Containerfile 2026-09-04 18:17:20.615363 | debian-bookworm | Containerfile 2026-09-04 18:17:20.628475 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/5b865afeec4a4eb688833207c6678c50/work/logs" 2026-09-04 18:18:35.836285 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/5b865afeec4a4eb688833207c6678c50/work/artifacts" 2026-09-04 18:18:36.178901 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/5b865afeec4a4eb688833207c6678c50/work/docs" 2026-09-04 18:18:36.197405 | 2026-09-04 18:18:36.197568 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-04 18:18:37.110603 | debian-bookworm | changed: 2026-09-04 18:18:37.110826 | debian-bookworm | .d..t...... ./ 2026-09-04 18:18:37.114669 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-09-04 18:18:37.114706 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-09-04 18:18:37.114731 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-09-04 18:18:37.114754 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-09-04 18:18:37.114775 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-09-04 18:18:37.114843 | debian-bookworm | changed: All items complete 2026-09-04 18:18:37.114874 | 2026-09-04 18:18:37.703636 | debian-bookworm | changed: .d..t...... ./ 2026-09-04 18:18:38.828630 | debian-bookworm | changed: .d..t...... ./ 2026-09-04 18:18:38.856163 | 2026-09-04 18:18:38.856308 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-04 18:18:39.852734 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.015914 2026-09-04 18:18:40.382907 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.009257 2026-09-04 18:18:40.401307 | 2026-09-04 18:18:40.401393 | PLAY RECAP 2026-09-04 18:18:40.401440 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-09-04 18:18:40.401465 | 2026-09-04 18:18:40.590490 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-04 18:18:40.592129 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-04 18:18:41.780456 | 2026-09-04 18:18:41.780584 | PLAY [Base post] 2026-09-04 18:18:41.811052 | 2026-09-04 18:18:41.811204 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-04 18:18:42.431612 | debian-bookworm | changed 2026-09-04 18:18:42.436386 | 2026-09-04 18:18:42.436463 | PLAY RECAP 2026-09-04 18:18:42.436513 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-04 18:18:42.436564 | 2026-09-04 18:18:42.528541 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-04 18:18:42.529189 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-04 18:18:43.958603 | 2026-09-04 18:18:43.958720 | PLAY [Base post-logs] 2026-09-04 18:18:44.000178 | 2026-09-04 18:18:44.000303 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-04 18:18:45.083877 | localhost | changed 2026-09-04 18:18:45.091762 | 2026-09-04 18:18:45.091861 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-04 18:18:45.131670 | localhost | ok 2026-09-04 18:18:45.133978 | 2026-09-04 18:18:45.134055 | TASK [Set zuul-log-path fact] 2026-09-04 18:18:45.157883 | localhost | ok 2026-09-04 18:18:45.164260 | 2026-09-04 18:18:45.164350 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-04 18:18:45.188055 | localhost | ok 2026-09-04 18:18:45.190426 | 2026-09-04 18:18:45.194772 | TASK [upload-logs : Create log directories] 2026-09-04 18:18:45.684625 | localhost | changed 2026-09-04 18:18:45.689895 | 2026-09-04 18:18:45.689986 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-04 18:18:46.225019 | localhost -> localhost | ok: Runtime: 0:00:00.006014 2026-09-04 18:18:46.229020 | 2026-09-04 18:18:46.229121 | TASK [upload-logs : Upload logs to log server] 2026-09-04 18:18:46.746517 | localhost | Output suppressed because no_log was given 2026-09-04 18:18:46.748473 | 2026-09-04 18:18:46.748566 | LOOP [upload-logs : Compress console log and json output] 2026-09-04 18:18:46.837209 | localhost | skipping: Conditional result was False 2026-09-04 18:18:46.844473 | localhost | skipping: Conditional result was False 2026-09-04 18:18:46.848633 | 2026-09-04 18:18:46.848741 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-04 18:18:46.889876 | localhost | skipping: Conditional result was False 2026-09-04 18:18:46.890215 | 2026-09-04 18:18:46.893999 | localhost | skipping: Conditional result was False 2026-09-04 18:18:46.896824 | 2026-09-04 18:18:46.896978 | LOOP [upload-logs : Upload console log and json output]