2025-06-05 03:21:40.590292 | Job console starting 2025-06-05 03:21:40.618694 | Updating git repos 2025-06-05 03:21:40.693703 | Cloning repos into workspace 2025-06-05 03:21:40.862966 | Restoring repo states 2025-06-05 03:21:40.870969 | Merging changes 2025-06-05 03:21:40.870987 | Checking out repos 2025-06-05 03:21:41.196463 | Preparing playbooks 2025-06-05 03:21:41.963519 | Running Ansible setup 2025-06-05 03:21:47.665370 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-06-05 03:21:48.502712 | 2025-06-05 03:21:48.502994 | PLAY [Base pre] 2025-06-05 03:21:48.520775 | 2025-06-05 03:21:48.520945 | TASK [Setup log path fact] 2025-06-05 03:21:48.544299 | debian-bookworm | ok 2025-06-05 03:21:48.560317 | 2025-06-05 03:21:48.560536 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-06-05 03:21:48.612747 | debian-bookworm | ok 2025-06-05 03:21:48.623164 | 2025-06-05 03:21:48.623288 | TASK [emit-job-header : Print job information] 2025-06-05 03:21:48.664111 | # Job Information 2025-06-05 03:21:48.664320 | Ansible Version: 2.16.14 2025-06-05 03:21:48.664356 | Job: python-black 2025-06-05 03:21:48.664388 | Pipeline: periodic-daily 2025-06-05 03:21:48.664429 | Executor: 521e9411259a 2025-06-05 03:21:48.664450 | Triggered by: https://github.com/osism/testbed 2025-06-05 03:21:48.664471 | Event ID: c32e3ed013bc4284b4808b883a61683f 2025-06-05 03:21:48.669635 | 2025-06-05 03:21:48.669749 | LOOP [emit-job-header : Print node information] 2025-06-05 03:21:48.804500 | debian-bookworm | ok: 2025-06-05 03:21:48.804856 | debian-bookworm | # Node Information 2025-06-05 03:21:48.804902 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-06-05 03:21:48.804929 | debian-bookworm | Hostname: debian 2025-06-05 03:21:48.804951 | debian-bookworm | Username: zuul 2025-06-05 03:21:48.804973 | debian-bookworm | Distro: Debian 12.11 2025-06-05 03:21:48.804997 | debian-bookworm | Provider: regiocloud-a 2025-06-05 03:21:48.805018 | debian-bookworm | Region: 2025-06-05 03:21:48.805040 | debian-bookworm | Label: debian-bookworm 2025-06-05 03:21:48.805060 | debian-bookworm | Product Name: OpenStack Nova 2025-06-05 03:21:48.805081 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feed:1c0d 2025-06-05 03:21:48.827772 | 2025-06-05 03:21:48.827953 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-06-05 03:21:49.386012 | debian-bookworm -> localhost | changed 2025-06-05 03:21:49.401863 | 2025-06-05 03:21:49.402041 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-06-05 03:21:50.613972 | debian-bookworm -> localhost | changed 2025-06-05 03:21:50.626714 | 2025-06-05 03:21:50.626879 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-06-05 03:21:50.983660 | debian-bookworm -> localhost | ok 2025-06-05 03:21:50.997056 | 2025-06-05 03:21:50.997197 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-06-05 03:21:51.058809 | debian-bookworm | ok 2025-06-05 03:21:51.098149 | debian-bookworm | included: /var/lib/zuul/builds/b9155b2e7fae40b99ec08b2f4ac79987/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-06-05 03:21:51.107213 | 2025-06-05 03:21:51.107385 | TASK [add-build-sshkey : Create Temp SSH key] 2025-06-05 03:21:52.298731 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-06-05 03:21:52.299049 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/b9155b2e7fae40b99ec08b2f4ac79987/work/b9155b2e7fae40b99ec08b2f4ac79987_id_rsa 2025-06-05 03:21:52.299090 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/b9155b2e7fae40b99ec08b2f4ac79987/work/b9155b2e7fae40b99ec08b2f4ac79987_id_rsa.pub 2025-06-05 03:21:52.299118 | debian-bookworm -> localhost | The key fingerprint is: 2025-06-05 03:21:52.299145 | debian-bookworm -> localhost | SHA256:nkm/EoNEvnFDvy+1Chdfme75YoRifDpK7kkqBridcoQ zuul-build-sshkey 2025-06-05 03:21:52.299168 | debian-bookworm -> localhost | The key's randomart image is: 2025-06-05 03:21:52.299209 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-06-05 03:21:52.299231 | debian-bookworm -> localhost | | | 2025-06-05 03:21:52.299253 | debian-bookworm -> localhost | | . . | 2025-06-05 03:21:52.299274 | debian-bookworm -> localhost | | o . . | 2025-06-05 03:21:52.299294 | debian-bookworm -> localhost | | + o . o | 2025-06-05 03:21:52.299315 | debian-bookworm -> localhost | | o . =So.. .+ | 2025-06-05 03:21:52.299342 | debian-bookworm -> localhost | |E o ooo+=o+o. | 2025-06-05 03:21:52.299364 | debian-bookworm -> localhost | | + o B+o*.o. | 2025-06-05 03:21:52.299385 | debian-bookworm -> localhost | |o + o =.++.o.o. | 2025-06-05 03:21:52.299423 | debian-bookworm -> localhost | | o . ...=oo+ .oo.| 2025-06-05 03:21:52.299445 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-06-05 03:21:52.299509 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.588704 2025-06-05 03:21:52.306592 | 2025-06-05 03:21:52.306739 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-06-05 03:21:52.336678 | debian-bookworm | ok 2025-06-05 03:21:52.347016 | debian-bookworm | included: /var/lib/zuul/builds/b9155b2e7fae40b99ec08b2f4ac79987/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-06-05 03:21:52.358180 | 2025-06-05 03:21:52.358317 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-06-05 03:21:52.382956 | debian-bookworm | skipping: Conditional result was False 2025-06-05 03:21:52.390758 | 2025-06-05 03:21:52.390920 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-06-05 03:21:53.092259 | debian-bookworm | changed 2025-06-05 03:21:53.098183 | 2025-06-05 03:21:53.098307 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-06-05 03:21:53.354351 | debian-bookworm | ok 2025-06-05 03:21:53.360456 | 2025-06-05 03:21:53.360582 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-06-05 03:21:54.062307 | debian-bookworm | changed 2025-06-05 03:21:54.071983 | 2025-06-05 03:21:54.072113 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-06-05 03:21:54.735096 | debian-bookworm | changed 2025-06-05 03:21:54.744913 | 2025-06-05 03:21:54.745034 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-06-05 03:21:54.779502 | debian-bookworm | skipping: Conditional result was False 2025-06-05 03:21:54.789086 | 2025-06-05 03:21:54.789246 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-06-05 03:21:55.305027 | debian-bookworm -> localhost | changed 2025-06-05 03:21:55.321607 | 2025-06-05 03:21:55.321744 | TASK [add-build-sshkey : Add back temp key] 2025-06-05 03:21:55.855975 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/b9155b2e7fae40b99ec08b2f4ac79987/work/b9155b2e7fae40b99ec08b2f4ac79987_id_rsa (zuul-build-sshkey) 2025-06-05 03:21:55.856340 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.022470 2025-06-05 03:21:55.865188 | 2025-06-05 03:21:55.865331 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-06-05 03:21:56.301169 | debian-bookworm | ok 2025-06-05 03:21:56.306902 | 2025-06-05 03:21:56.307030 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-06-05 03:21:56.332459 | debian-bookworm | skipping: Conditional result was False 2025-06-05 03:21:56.344345 | 2025-06-05 03:21:56.344498 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-06-05 03:21:56.821679 | debian-bookworm | ok 2025-06-05 03:21:56.844429 | 2025-06-05 03:21:56.844580 | TASK [validate-host : Define zuul_info_dir fact] 2025-06-05 03:21:56.885365 | debian-bookworm | ok 2025-06-05 03:21:56.894376 | 2025-06-05 03:21:56.894593 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-06-05 03:21:57.225017 | debian-bookworm -> localhost | ok 2025-06-05 03:21:57.233840 | 2025-06-05 03:21:57.233984 | TASK [validate-host : Collect information about the host] 2025-06-05 03:21:58.457854 | debian-bookworm | ok 2025-06-05 03:21:58.475526 | 2025-06-05 03:21:58.476309 | TASK [validate-host : Sanitize hostname] 2025-06-05 03:21:58.605352 | debian-bookworm | ok 2025-06-05 03:21:58.661088 | 2025-06-05 03:21:58.661249 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-06-05 03:21:59.336477 | debian-bookworm -> localhost | changed 2025-06-05 03:21:59.352767 | 2025-06-05 03:21:59.352933 | TASK [validate-host : Collect information about zuul worker] 2025-06-05 03:21:59.813996 | debian-bookworm | ok 2025-06-05 03:21:59.821079 | 2025-06-05 03:21:59.821222 | TASK [validate-host : Write out all zuul information for each host] 2025-06-05 03:22:00.394673 | debian-bookworm -> localhost | changed 2025-06-05 03:22:00.407318 | 2025-06-05 03:22:00.407500 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-06-05 03:22:00.680937 | debian-bookworm | ok 2025-06-05 03:22:00.688335 | 2025-06-05 03:22:00.688470 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-06-05 03:22:01.902163 | debian-bookworm | changed: 2025-06-05 03:22:01.902648 | debian-bookworm | cd+++++++++ src/ 2025-06-05 03:22:01.902699 | debian-bookworm | cd+++++++++ src/github.com/ 2025-06-05 03:22:01.902724 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-06-05 03:22:01.902746 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2025-06-05 03:22:01.902767 | debian-bookworm | localhost | ok: Runtime: 0:00:00.025296 2025-06-05 03:22:30.059373 | 2025-06-05 03:22:30.059543 | TASK [upload-logs : Upload logs to log server] 2025-06-05 03:22:31.113769 | localhost | Output suppressed because no_log was given 2025-06-05 03:22:31.116723 | 2025-06-05 03:22:31.116853 | LOOP [upload-logs : Compress console log and json output] 2025-06-05 03:22:31.203868 | localhost | skipping: Conditional result was False 2025-06-05 03:22:31.211853 | localhost | skipping: Conditional result was False 2025-06-05 03:22:31.215472 | 2025-06-05 03:22:31.215603 | LOOP [upload-logs : Upload compressed console log and json output] 2025-06-05 03:22:31.344204 | localhost | skipping: Conditional result was False 2025-06-05 03:22:31.344575 | 2025-06-05 03:22:31.349642 | localhost | skipping: Conditional result was False 2025-06-05 03:22:31.365022 | 2025-06-05 03:22:31.365179 | LOOP [upload-logs : Upload console log and json output]