2025-12-04 21:08:04.493732 | Job console starting 2025-12-04 21:08:04.537954 | Updating git repos 2025-12-04 21:08:04.615145 | Cloning repos into workspace 2025-12-04 21:08:04.731554 | Restoring repo states 2025-12-04 21:08:04.765943 | Merging changes 2025-12-04 21:08:05.432022 | Checking out repos 2025-12-04 21:08:05.505247 | Preparing playbooks 2025-12-04 21:08:06.727777 | Running Ansible setup 2025-12-04 21:08:14.325290 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-04 21:08:15.583185 | 2025-12-04 21:08:15.583430 | PLAY [Base pre] 2025-12-04 21:08:15.709524 | 2025-12-04 21:08:15.709698 | TASK [Setup log path fact] 2025-12-04 21:08:15.763791 | debian-bookworm | ok 2025-12-04 21:08:15.804080 | 2025-12-04 21:08:15.804305 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-04 21:08:15.876009 | debian-bookworm | ok 2025-12-04 21:08:15.897769 | 2025-12-04 21:08:15.900085 | TASK [emit-job-header : Print job information] 2025-12-04 21:08:15.954722 | # Job Information 2025-12-04 21:08:15.954929 | Ansible Version: 2.16.14 2025-12-04 21:08:15.954966 | Job: python-black 2025-12-04 21:08:15.954999 | Pipeline: check 2025-12-04 21:08:15.955022 | Executor: 521e9411259a 2025-12-04 21:08:15.955042 | Triggered by: https://github.com/osism/python-osism/pull/1893 2025-12-04 21:08:15.955094 | Event ID: 34b1ac90-d155-11f0-9012-e34485f981bf 2025-12-04 21:08:15.960530 | 2025-12-04 21:08:15.960671 | LOOP [emit-job-header : Print node information] 2025-12-04 21:08:16.110428 | debian-bookworm | ok: 2025-12-04 21:08:16.112558 | debian-bookworm | # Node Information 2025-12-04 21:08:16.112653 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-04 21:08:16.112682 | debian-bookworm | Hostname: debian 2025-12-04 21:08:16.112706 | debian-bookworm | Username: zuul 2025-12-04 21:08:16.112728 | debian-bookworm | Distro: Debian 12.12 2025-12-04 21:08:16.112752 | debian-bookworm | Provider: regiocloud-a 2025-12-04 21:08:16.112774 | debian-bookworm | Region: 2025-12-04 21:08:16.112796 | debian-bookworm | Label: debian-bookworm 2025-12-04 21:08:16.112815 | debian-bookworm | Product Name: OpenStack Nova 2025-12-04 21:08:16.112835 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe2e:a0df 2025-12-04 21:08:16.135634 | 2025-12-04 21:08:16.136384 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-04 21:08:16.958953 | debian-bookworm -> localhost | changed 2025-12-04 21:08:16.966748 | 2025-12-04 21:08:16.966920 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-04 21:08:18.794482 | debian-bookworm -> localhost | changed 2025-12-04 21:08:18.812882 | 2025-12-04 21:08:18.813016 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-04 21:08:19.448437 | debian-bookworm -> localhost | ok 2025-12-04 21:08:19.455681 | 2025-12-04 21:08:19.455815 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-04 21:08:19.504351 | debian-bookworm | ok 2025-12-04 21:08:19.549269 | debian-bookworm | included: /var/lib/zuul/builds/c246217bca864ca5af2f7ae033dff9dd/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-04 21:08:19.601294 | 2025-12-04 21:08:19.601432 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-04 21:08:25.921874 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-04 21:08:25.922118 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/c246217bca864ca5af2f7ae033dff9dd/work/c246217bca864ca5af2f7ae033dff9dd_id_rsa 2025-12-04 21:08:25.922158 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/c246217bca864ca5af2f7ae033dff9dd/work/c246217bca864ca5af2f7ae033dff9dd_id_rsa.pub 2025-12-04 21:08:25.922184 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-04 21:08:25.922208 | debian-bookworm -> localhost | SHA256:/PMMBeEZl55jMqP0PLUhpb3zD0+3VY4DEIIC1+nzta4 zuul-build-sshkey 2025-12-04 21:08:25.922231 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-04 21:08:25.922332 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-04 21:08:25.922356 | debian-bookworm -> localhost | | .... o. + .. | 2025-12-04 21:08:25.922378 | debian-bookworm -> localhost | | .. + o *o | 2025-12-04 21:08:25.922399 | debian-bookworm -> localhost | | o == . | 2025-12-04 21:08:25.922419 | debian-bookworm -> localhost | | o.. BoO | 2025-12-04 21:08:25.922438 | debian-bookworm -> localhost | | +S= Oo= .| 2025-12-04 21:08:25.922467 | debian-bookworm -> localhost | | o.=.+. o.| 2025-12-04 21:08:25.922490 | debian-bookworm -> localhost | | .+. o+ =| 2025-12-04 21:08:25.922511 | debian-bookworm -> localhost | | .= .=+| 2025-12-04 21:08:25.922531 | debian-bookworm -> localhost | | E. o oo| 2025-12-04 21:08:25.922551 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-04 21:08:25.922612 | debian-bookworm -> localhost | ok: Runtime: 0:00:04.153810 2025-12-04 21:08:25.930767 | 2025-12-04 21:08:25.930938 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-04 21:08:26.023003 | debian-bookworm | ok 2025-12-04 21:08:26.064989 | debian-bookworm | included: /var/lib/zuul/builds/c246217bca864ca5af2f7ae033dff9dd/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-04 21:08:26.127932 | 2025-12-04 21:08:26.128081 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-04 21:08:26.226158 | debian-bookworm | skipping: Conditional result was False 2025-12-04 21:08:26.232808 | 2025-12-04 21:08:26.232942 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-04 21:08:27.430659 | debian-bookworm | changed 2025-12-04 21:08:27.453923 | 2025-12-04 21:08:27.454070 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-04 21:08:27.762117 | debian-bookworm | ok 2025-12-04 21:08:27.793647 | 2025-12-04 21:08:27.793813 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-04 21:08:28.928450 | debian-bookworm | changed 2025-12-04 21:08:28.973937 | 2025-12-04 21:08:28.974093 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-04 21:08:29.985974 | debian-bookworm | changed 2025-12-04 21:08:29.997499 | 2025-12-04 21:08:29.997657 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-04 21:08:30.050028 | debian-bookworm | skipping: Conditional result was False 2025-12-04 21:08:30.057130 | 2025-12-04 21:08:30.057288 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-04 21:08:31.041620 | debian-bookworm -> localhost | changed 2025-12-04 21:08:31.060337 | 2025-12-04 21:08:31.060495 | TASK [add-build-sshkey : Add back temp key] 2025-12-04 21:08:31.866055 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/c246217bca864ca5af2f7ae033dff9dd/work/c246217bca864ca5af2f7ae033dff9dd_id_rsa (zuul-build-sshkey) 2025-12-04 21:08:31.866343 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.041099 2025-12-04 21:08:31.876489 | 2025-12-04 21:08:31.876629 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-04 21:08:32.465324 | debian-bookworm | ok 2025-12-04 21:08:32.473006 | 2025-12-04 21:08:32.473187 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-04 21:08:32.547267 | debian-bookworm | skipping: Conditional result was False 2025-12-04 21:08:32.559890 | 2025-12-04 21:08:32.560046 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-04 21:08:33.630540 | debian-bookworm | ok 2025-12-04 21:08:33.708445 | 2025-12-04 21:08:33.708614 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-04 21:08:33.819820 | debian-bookworm | ok 2025-12-04 21:08:33.828169 | 2025-12-04 21:08:33.828340 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-04 21:08:34.897023 | debian-bookworm -> localhost | ok 2025-12-04 21:08:34.904233 | 2025-12-04 21:08:34.904433 | TASK [validate-host : Collect information about the host] 2025-12-04 21:08:36.860645 | debian-bookworm | ok 2025-12-04 21:08:36.916825 | 2025-12-04 21:08:36.916976 | TASK [validate-host : Sanitize hostname] 2025-12-04 21:08:37.214337 | debian-bookworm | ok 2025-12-04 21:08:37.295822 | 2025-12-04 21:08:37.295962 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-04 21:08:39.262028 | debian-bookworm -> localhost | changed 2025-12-04 21:08:39.268872 | 2025-12-04 21:08:39.269007 | TASK [validate-host : Collect information about zuul worker] 2025-12-04 21:08:39.990233 | debian-bookworm | ok 2025-12-04 21:08:40.005096 | 2025-12-04 21:08:40.005270 | TASK [validate-host : Write out all zuul information for each host] 2025-12-04 21:08:43.030136 | debian-bookworm -> localhost | changed 2025-12-04 21:08:43.041527 | 2025-12-04 21:08:43.041677 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-04 21:08:43.501705 | debian-bookworm | ok 2025-12-04 21:08:43.513590 | 2025-12-04 21:08:43.513729 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-04 21:08:46.607532 | debian-bookworm | changed: 2025-12-04 21:08:46.607777 | debian-bookworm | cd+++++++++ src/ 2025-12-04 21:08:46.607814 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-04 21:08:46.607837 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-04 21:08:46.607858 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-12-04 21:08:46.607878 | debian-bookworm | Containerfile 2025-12-04 21:08:46.608009 | debian-bookworm | Containerfile 2025-12-04 21:08:46.702749 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007546 2025-12-04 21:09:24.055674 | 2025-12-04 21:09:24.055820 | TASK [upload-logs : Upload logs to log server] 2025-12-04 21:09:25.361009 | localhost | Output suppressed because no_log was given 2025-12-04 21:09:25.369732 | 2025-12-04 21:09:25.369870 | LOOP [upload-logs : Compress console log and json output] 2025-12-04 21:09:25.516862 | localhost | skipping: Conditional result was False 2025-12-04 21:09:25.529664 | localhost | skipping: Conditional result was False 2025-12-04 21:09:25.540737 | 2025-12-04 21:09:25.540879 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-04 21:09:25.603930 | localhost | skipping: Conditional result was False 2025-12-04 21:09:25.604237 | 2025-12-04 21:09:25.609529 | localhost | skipping: Conditional result was False 2025-12-04 21:09:25.619074 | 2025-12-04 21:09:25.619220 | LOOP [upload-logs : Upload console log and json output]