2025-10-12 14:52:58.361390 | Job console starting 2025-10-12 14:52:58.389903 | Updating git repos 2025-10-12 14:52:58.480351 | Cloning repos into workspace 2025-10-12 14:52:58.570365 | Restoring repo states 2025-10-12 14:52:58.606692 | Merging changes 2025-10-12 14:52:59.212452 | Checking out repos 2025-10-12 14:52:59.282703 | Preparing playbooks 2025-10-12 14:53:00.442707 | Running Ansible setup 2025-10-12 14:53:06.224942 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-12 14:53:07.820630 | 2025-10-12 14:53:07.820764 | PLAY [Base pre] 2025-10-12 14:53:07.843635 | 2025-10-12 14:53:07.843749 | TASK [Setup log path fact] 2025-10-12 14:53:07.860526 | debian-bookworm | ok 2025-10-12 14:53:07.880359 | 2025-10-12 14:53:07.880517 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-12 14:53:07.938222 | debian-bookworm | ok 2025-10-12 14:53:07.946003 | 2025-10-12 14:53:07.946093 | TASK [emit-job-header : Print job information] 2025-10-12 14:53:07.982857 | # Job Information 2025-10-12 14:53:07.982986 | Ansible Version: 2.16.14 2025-10-12 14:53:07.983014 | Job: python-black 2025-10-12 14:53:07.983040 | Pipeline: check 2025-10-12 14:53:07.983059 | Executor: 521e9411259a 2025-10-12 14:53:07.983075 | Triggered by: https://github.com/osism/python-osism/pull/1750 2025-10-12 14:53:07.983093 | Event ID: 1fa8af50-a77b-11f0-8c76-9b9cbfa46dfa 2025-10-12 14:53:07.986987 | 2025-10-12 14:53:07.987064 | LOOP [emit-job-header : Print node information] 2025-10-12 14:53:08.089739 | debian-bookworm | ok: 2025-10-12 14:53:08.089869 | debian-bookworm | # Node Information 2025-10-12 14:53:08.089898 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-12 14:53:08.089918 | debian-bookworm | Hostname: debian 2025-10-12 14:53:08.089936 | debian-bookworm | Username: zuul 2025-10-12 14:53:08.089952 | debian-bookworm | Distro: Debian 12.12 2025-10-12 14:53:08.089971 | debian-bookworm | Provider: regiocloud-a 2025-10-12 14:53:08.089988 | debian-bookworm | Region: 2025-10-12 14:53:08.090005 | debian-bookworm | Label: debian-bookworm 2025-10-12 14:53:08.090022 | debian-bookworm | Product Name: OpenStack Nova 2025-10-12 14:53:08.090038 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe81:4d66 2025-10-12 14:53:08.098727 | 2025-10-12 14:53:08.098808 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-12 14:53:08.638858 | debian-bookworm -> localhost | changed 2025-10-12 14:53:08.644505 | 2025-10-12 14:53:08.644592 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-12 14:53:09.981014 | debian-bookworm -> localhost | changed 2025-10-12 14:53:09.989366 | 2025-10-12 14:53:09.989453 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-12 14:53:10.277373 | debian-bookworm -> localhost | ok 2025-10-12 14:53:10.282169 | 2025-10-12 14:53:10.282252 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-12 14:53:10.307322 | debian-bookworm | ok 2025-10-12 14:53:10.328716 | debian-bookworm | included: /var/lib/zuul/builds/f09bbb7bf6d4451986b9eef24b82d490/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-12 14:53:10.343636 | 2025-10-12 14:53:10.343728 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-12 14:53:12.943541 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-12 14:53:12.943701 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/f09bbb7bf6d4451986b9eef24b82d490/work/f09bbb7bf6d4451986b9eef24b82d490_id_rsa 2025-10-12 14:53:12.943732 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/f09bbb7bf6d4451986b9eef24b82d490/work/f09bbb7bf6d4451986b9eef24b82d490_id_rsa.pub 2025-10-12 14:53:12.943755 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-12 14:53:12.943775 | debian-bookworm -> localhost | SHA256:T1UkkwTHeYyG2jjYO0vJ/RgFumInjNoB/tpzZe3xtTg zuul-build-sshkey 2025-10-12 14:53:12.943794 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-12 14:53:12.943818 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-12 14:53:12.943836 | debian-bookworm -> localhost | | .==*o | 2025-10-12 14:53:12.943854 | debian-bookworm -> localhost | | o.*+o | 2025-10-12 14:53:12.943870 | debian-bookworm -> localhost | | o = o.. | 2025-10-12 14:53:12.943886 | debian-bookworm -> localhost | | . . * ... | 2025-10-12 14:53:12.943903 | debian-bookworm -> localhost | | . . o .SB.. | 2025-10-12 14:53:12.943923 | debian-bookworm -> localhost | | . o = @o= . | 2025-10-12 14:53:12.943941 | debian-bookworm -> localhost | | + o B +.* o . | 2025-10-12 14:53:12.943957 | debian-bookworm -> localhost | | ..+ . . o E . | 2025-10-12 14:53:12.943973 | debian-bookworm -> localhost | | ...o . | 2025-10-12 14:53:12.943989 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-12 14:53:12.944031 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.028525 2025-10-12 14:53:12.949050 | 2025-10-12 14:53:12.949149 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-12 14:53:12.965992 | debian-bookworm | ok 2025-10-12 14:53:12.973987 | debian-bookworm | included: /var/lib/zuul/builds/f09bbb7bf6d4451986b9eef24b82d490/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-12 14:53:12.981224 | 2025-10-12 14:53:12.981294 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-12 14:53:12.993824 | debian-bookworm | skipping: Conditional result was False 2025-10-12 14:53:12.998313 | 2025-10-12 14:53:12.998387 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-12 14:53:13.593712 | debian-bookworm | changed 2025-10-12 14:53:13.598908 | 2025-10-12 14:53:13.598997 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-12 14:53:13.856348 | debian-bookworm | ok 2025-10-12 14:53:13.865205 | 2025-10-12 14:53:13.865332 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-12 14:53:14.491824 | debian-bookworm | changed 2025-10-12 14:53:14.498113 | 2025-10-12 14:53:14.498218 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-12 14:53:15.164743 | debian-bookworm | changed 2025-10-12 14:53:15.172530 | 2025-10-12 14:53:15.172629 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-12 14:53:15.205815 | debian-bookworm | skipping: Conditional result was False 2025-10-12 14:53:15.211448 | 2025-10-12 14:53:15.211537 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-12 14:53:15.701290 | debian-bookworm -> localhost | changed 2025-10-12 14:53:15.711676 | 2025-10-12 14:53:15.711773 | TASK [add-build-sshkey : Add back temp key] 2025-10-12 14:53:16.017306 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/f09bbb7bf6d4451986b9eef24b82d490/work/f09bbb7bf6d4451986b9eef24b82d490_id_rsa (zuul-build-sshkey) 2025-10-12 14:53:16.017515 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011539 2025-10-12 14:53:16.025352 | 2025-10-12 14:53:16.025450 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-12 14:53:16.506196 | debian-bookworm | ok 2025-10-12 14:53:16.516652 | 2025-10-12 14:53:16.516772 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-12 14:53:16.541030 | debian-bookworm | skipping: Conditional result was False 2025-10-12 14:53:16.571878 | 2025-10-12 14:53:16.571983 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-12 14:53:17.044454 | debian-bookworm | ok 2025-10-12 14:53:17.054566 | 2025-10-12 14:53:17.054662 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-12 14:53:17.082330 | debian-bookworm | ok 2025-10-12 14:53:17.089324 | 2025-10-12 14:53:17.089413 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-12 14:53:17.352991 | debian-bookworm -> localhost | ok 2025-10-12 14:53:17.359073 | 2025-10-12 14:53:17.359187 | TASK [validate-host : Collect information about the host] 2025-10-12 14:53:18.525012 | debian-bookworm | ok 2025-10-12 14:53:18.535427 | 2025-10-12 14:53:18.535521 | TASK [validate-host : Sanitize hostname] 2025-10-12 14:53:18.624860 | debian-bookworm | ok 2025-10-12 14:53:18.668931 | 2025-10-12 14:53:18.669031 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-12 14:53:19.593480 | debian-bookworm -> localhost | changed 2025-10-12 14:53:19.598864 | 2025-10-12 14:53:19.598952 | TASK [validate-host : Collect information about zuul worker] 2025-10-12 14:53:19.997367 | debian-bookworm | ok 2025-10-12 14:53:20.001782 | 2025-10-12 14:53:20.001869 | TASK [validate-host : Write out all zuul information for each host] 2025-10-12 14:53:20.705350 | debian-bookworm -> localhost | changed 2025-10-12 14:53:20.729922 | 2025-10-12 14:53:20.730074 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-12 14:53:21.029680 | debian-bookworm | ok 2025-10-12 14:53:21.038243 | 2025-10-12 14:53:21.038348 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-12 14:53:22.332136 | debian-bookworm | changed: 2025-10-12 14:53:22.332277 | debian-bookworm | cd+++++++++ src/ 2025-10-12 14:53:22.332304 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-12 14:53:22.332323 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-12 14:53:22.332340 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-10-12 14:53:22.332356 | debian-bookworm | Containerfile 2025-10-12 14:53:22.332448 | debian-bookworm | Containerfile 2025-10-12 14:53:22.376842 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007232 2025-10-12 14:53:48.159999 | 2025-10-12 14:53:48.160181 | TASK [upload-logs : Upload logs to log server] 2025-10-12 14:53:48.717510 | localhost | Output suppressed because no_log was given 2025-10-12 14:53:48.722636 | 2025-10-12 14:53:48.722772 | LOOP [upload-logs : Compress console log and json output] 2025-10-12 14:53:48.783716 | localhost | skipping: Conditional result was False 2025-10-12 14:53:48.789140 | localhost | skipping: Conditional result was False 2025-10-12 14:53:48.800219 | 2025-10-12 14:53:48.800437 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-12 14:53:48.845146 | localhost | skipping: Conditional result was False 2025-10-12 14:53:48.845807 | 2025-10-12 14:53:48.848900 | localhost | skipping: Conditional result was False 2025-10-12 14:53:48.861967 | 2025-10-12 14:53:48.862231 | LOOP [upload-logs : Upload console log and json output]