2026-01-15 09:30:50.164367 | Job console starting 2026-01-15 09:30:50.184694 | Updating git repos 2026-01-15 09:30:50.278900 | Cloning repos into workspace 2026-01-15 09:30:50.402542 | Restoring repo states 2026-01-15 09:30:50.434226 | Merging changes 2026-01-15 09:30:51.125900 | Checking out repos 2026-01-15 09:30:51.188851 | Preparing playbooks 2026-01-15 09:30:52.261394 | Running Ansible setup 2026-01-15 09:30:58.002216 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-01-15 09:30:59.256120 | 2026-01-15 09:30:59.256372 | PLAY [Base pre] 2026-01-15 09:30:59.293022 | 2026-01-15 09:30:59.293192 | TASK [Setup log path fact] 2026-01-15 09:30:59.328891 | debian-bookworm | ok 2026-01-15 09:30:59.370687 | 2026-01-15 09:30:59.370894 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-15 09:30:59.445703 | debian-bookworm | ok 2026-01-15 09:30:59.495602 | 2026-01-15 09:30:59.495781 | TASK [emit-job-header : Print job information] 2026-01-15 09:30:59.582106 | # Job Information 2026-01-15 09:30:59.582339 | Ansible Version: 2.16.14 2026-01-15 09:30:59.582380 | Job: python-black 2026-01-15 09:30:59.582414 | Pipeline: check 2026-01-15 09:30:59.582438 | Executor: 521e9411259a 2026-01-15 09:30:59.582460 | Triggered by: https://github.com/osism/python-osism/pull/1938 2026-01-15 09:30:59.582484 | Event ID: d942e700-f1f4-11f0-8191-1c1481afb690 2026-01-15 09:30:59.587700 | 2026-01-15 09:30:59.587828 | LOOP [emit-job-header : Print node information] 2026-01-15 09:30:59.843111 | debian-bookworm | ok: 2026-01-15 09:30:59.843379 | debian-bookworm | # Node Information 2026-01-15 09:30:59.843420 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-01-15 09:30:59.843447 | debian-bookworm | Hostname: debian 2026-01-15 09:30:59.843471 | debian-bookworm | Username: zuul 2026-01-15 09:30:59.843492 | debian-bookworm | Distro: Debian 12.13 2026-01-15 09:30:59.843517 | debian-bookworm | Provider: regiocloud-a 2026-01-15 09:30:59.843539 | debian-bookworm | Region: 2026-01-15 09:30:59.843560 | debian-bookworm | Label: debian-bookworm 2026-01-15 09:30:59.843580 | debian-bookworm | Product Name: OpenStack Nova 2026-01-15 09:30:59.843599 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe71:4c12 2026-01-15 09:30:59.864753 | 2026-01-15 09:30:59.864901 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-01-15 09:31:00.847764 | debian-bookworm -> localhost | changed 2026-01-15 09:31:00.863582 | 2026-01-15 09:31:00.863740 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-01-15 09:31:03.074490 | debian-bookworm -> localhost | changed 2026-01-15 09:31:03.092726 | 2026-01-15 09:31:03.092871 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-01-15 09:31:03.752736 | debian-bookworm -> localhost | ok 2026-01-15 09:31:03.759508 | 2026-01-15 09:31:03.759647 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-01-15 09:31:03.802498 | debian-bookworm | ok 2026-01-15 09:31:03.855132 | debian-bookworm | included: /var/lib/zuul/builds/a8e7b833409147c6956efbabf1ba2d64/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-01-15 09:31:03.870558 | 2026-01-15 09:31:03.870708 | TASK [add-build-sshkey : Create Temp SSH key] 2026-01-15 09:31:06.875297 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-01-15 09:31:06.875543 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/a8e7b833409147c6956efbabf1ba2d64/work/a8e7b833409147c6956efbabf1ba2d64_id_rsa 2026-01-15 09:31:06.875585 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/a8e7b833409147c6956efbabf1ba2d64/work/a8e7b833409147c6956efbabf1ba2d64_id_rsa.pub 2026-01-15 09:31:06.875614 | debian-bookworm -> localhost | The key fingerprint is: 2026-01-15 09:31:06.875641 | debian-bookworm -> localhost | SHA256:LcdSIIKALHedtYQhKFH16WnxPwm62Rn6PSO8FQCyns0 zuul-build-sshkey 2026-01-15 09:31:06.875666 | debian-bookworm -> localhost | The key's randomart image is: 2026-01-15 09:31:06.875700 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-01-15 09:31:06.875725 | debian-bookworm -> localhost | |=+.+=.+=+ | 2026-01-15 09:31:06.875749 | debian-bookworm -> localhost | |+.+ .*+= o | 2026-01-15 09:31:06.875772 | debian-bookworm -> localhost | |.o .. + o . | 2026-01-15 09:31:06.875794 | debian-bookworm -> localhost | | . = + = | 2026-01-15 09:31:06.875816 | debian-bookworm -> localhost | | o E S = | 2026-01-15 09:31:06.875841 | debian-bookworm -> localhost | | . . * o | 2026-01-15 09:31:06.875864 | debian-bookworm -> localhost | | ... = | 2026-01-15 09:31:06.875886 | debian-bookworm -> localhost | | =o=o. | 2026-01-15 09:31:06.875909 | debian-bookworm -> localhost | | +.=o.o | 2026-01-15 09:31:06.875942 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-01-15 09:31:06.876011 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.164071 2026-01-15 09:31:06.884309 | 2026-01-15 09:31:06.884466 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-01-15 09:31:06.943930 | debian-bookworm | ok 2026-01-15 09:31:06.973481 | debian-bookworm | included: /var/lib/zuul/builds/a8e7b833409147c6956efbabf1ba2d64/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-01-15 09:31:06.999094 | 2026-01-15 09:31:06.999389 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-01-15 09:31:07.047372 | debian-bookworm | skipping: Conditional result was False 2026-01-15 09:31:07.057600 | 2026-01-15 09:31:07.057791 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-01-15 09:31:07.854588 | debian-bookworm | changed 2026-01-15 09:31:07.862369 | 2026-01-15 09:31:07.862506 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-01-15 09:31:08.144597 | debian-bookworm | ok 2026-01-15 09:31:08.150788 | 2026-01-15 09:31:08.154766 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-01-15 09:31:08.820493 | debian-bookworm | changed 2026-01-15 09:31:08.833757 | 2026-01-15 09:31:08.833901 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-01-15 09:31:09.506500 | debian-bookworm | changed 2026-01-15 09:31:09.523195 | 2026-01-15 09:31:09.523377 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-01-15 09:31:09.563640 | debian-bookworm | skipping: Conditional result was False 2026-01-15 09:31:09.572211 | 2026-01-15 09:31:09.572392 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-01-15 09:31:10.265732 | debian-bookworm -> localhost | changed 2026-01-15 09:31:10.286646 | 2026-01-15 09:31:10.286870 | TASK [add-build-sshkey : Add back temp key] 2026-01-15 09:31:10.913622 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/a8e7b833409147c6956efbabf1ba2d64/work/a8e7b833409147c6956efbabf1ba2d64_id_rsa (zuul-build-sshkey) 2026-01-15 09:31:10.914391 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.021842 2026-01-15 09:31:10.923172 | 2026-01-15 09:31:10.923327 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-01-15 09:31:11.445773 | debian-bookworm | ok 2026-01-15 09:31:11.453107 | 2026-01-15 09:31:11.453247 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-01-15 09:31:11.501824 | debian-bookworm | skipping: Conditional result was False 2026-01-15 09:31:11.517109 | 2026-01-15 09:31:11.517330 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-01-15 09:31:12.160683 | debian-bookworm | ok 2026-01-15 09:31:12.194604 | 2026-01-15 09:31:12.194806 | TASK [validate-host : Define zuul_info_dir fact] 2026-01-15 09:31:12.251484 | debian-bookworm | ok 2026-01-15 09:31:12.258001 | 2026-01-15 09:31:12.258134 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-01-15 09:31:12.651001 | debian-bookworm -> localhost | ok 2026-01-15 09:31:12.657854 | 2026-01-15 09:31:12.657992 | TASK [validate-host : Collect information about the host] 2026-01-15 09:31:14.148339 | debian-bookworm | ok 2026-01-15 09:31:14.162412 | 2026-01-15 09:31:14.162579 | TASK [validate-host : Sanitize hostname] 2026-01-15 09:31:14.417801 | debian-bookworm | ok 2026-01-15 09:31:14.546451 | 2026-01-15 09:31:14.546618 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-01-15 09:31:16.149918 | debian-bookworm -> localhost | changed 2026-01-15 09:31:16.158671 | 2026-01-15 09:31:16.158801 | TASK [validate-host : Collect information about zuul worker] 2026-01-15 09:31:16.632080 | debian-bookworm | ok 2026-01-15 09:31:16.647037 | 2026-01-15 09:31:16.647204 | TASK [validate-host : Write out all zuul information for each host] 2026-01-15 09:31:18.147786 | debian-bookworm -> localhost | changed 2026-01-15 09:31:18.158053 | 2026-01-15 09:31:18.158186 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-01-15 09:31:18.494237 | debian-bookworm | ok 2026-01-15 09:31:18.502008 | 2026-01-15 09:31:18.502139 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-01-15 09:31:19.792986 | debian-bookworm | changed: 2026-01-15 09:31:19.793209 | debian-bookworm | cd+++++++++ src/ 2026-01-15 09:31:19.793245 | debian-bookworm | cd+++++++++ src/github.com/ 2026-01-15 09:31:19.793292 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-01-15 09:31:19.793316 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-01-15 09:31:19.793338 | debian-bookworm | Containerfile 2026-01-15 09:31:19.793474 | debian-bookworm | Containerfile 2026-01-15 09:31:19.809664 | debian-bookworm | localhost | ok: Runtime: 0:00:00.011530 2026-01-15 09:31:47.568754 | 2026-01-15 09:31:47.568930 | TASK [upload-logs : Upload logs to log server] 2026-01-15 09:31:48.188065 | localhost | Output suppressed because no_log was given 2026-01-15 09:31:48.190009 | 2026-01-15 09:31:48.190118 | LOOP [upload-logs : Compress console log and json output] 2026-01-15 09:31:48.245130 | localhost | skipping: Conditional result was False 2026-01-15 09:31:48.249189 | localhost | skipping: Conditional result was False 2026-01-15 09:31:48.263457 | 2026-01-15 09:31:48.263586 | LOOP [upload-logs : Upload compressed console log and json output] 2026-01-15 09:31:48.322601 | localhost | skipping: Conditional result was False 2026-01-15 09:31:48.323017 | 2026-01-15 09:31:48.338771 | localhost | skipping: Conditional result was False 2026-01-15 09:31:48.346867 | 2026-01-15 09:31:48.347117 | LOOP [upload-logs : Upload console log and json output]