2025-09-22 07:08:53.459160 | Job console starting 2025-09-22 07:08:53.469655 | Updating git repos 2025-09-22 07:08:53.498386 | Cloning repos into workspace 2025-09-22 07:08:53.601322 | Restoring repo states 2025-09-22 07:08:53.608907 | Merging changes 2025-09-22 07:08:54.104662 | Checking out repos 2025-09-22 07:08:54.149521 | Preparing playbooks 2025-09-22 07:08:54.817947 | Running Ansible setup 2025-09-22 07:08:59.157213 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-22 07:08:59.900530 | 2025-09-22 07:08:59.900650 | PLAY [Base pre] 2025-09-22 07:08:59.915021 | 2025-09-22 07:08:59.915129 | TASK [Setup log path fact] 2025-09-22 07:08:59.932545 | debian-bookworm | ok 2025-09-22 07:08:59.946604 | 2025-09-22 07:08:59.946731 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-22 07:08:59.974925 | debian-bookworm | ok 2025-09-22 07:08:59.984067 | 2025-09-22 07:08:59.984165 | TASK [emit-job-header : Print job information] 2025-09-22 07:09:00.011574 | # Job Information 2025-09-22 07:09:00.011722 | Ansible Version: 2.16.14 2025-09-22 07:09:00.011756 | Job: python-black 2025-09-22 07:09:00.011787 | Pipeline: check 2025-09-22 07:09:00.011810 | Executor: 521e9411259a 2025-09-22 07:09:00.011831 | Triggered by: https://github.com/osism/testbed/pull/2766 2025-09-22 07:09:00.011852 | Event ID: f9bb26e0-9782-11f0-8a39-0691f3154b9b 2025-09-22 07:09:00.016463 | 2025-09-22 07:09:00.016552 | LOOP [emit-job-header : Print node information] 2025-09-22 07:09:00.121026 | debian-bookworm | ok: 2025-09-22 07:09:00.121238 | debian-bookworm | # Node Information 2025-09-22 07:09:00.121304 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-22 07:09:00.121333 | debian-bookworm | Hostname: debian 2025-09-22 07:09:00.121355 | debian-bookworm | Username: zuul 2025-09-22 07:09:00.121376 | debian-bookworm | Distro: Debian 12.12 2025-09-22 07:09:00.121399 | debian-bookworm | Provider: regiocloud-a 2025-09-22 07:09:00.121420 | debian-bookworm | Region: 2025-09-22 07:09:00.121441 | debian-bookworm | Label: debian-bookworm 2025-09-22 07:09:00.121461 | debian-bookworm | Product Name: OpenStack Nova 2025-09-22 07:09:00.121482 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feaa:853f 2025-09-22 07:09:00.141079 | 2025-09-22 07:09:00.141183 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-22 07:09:00.599115 | debian-bookworm -> localhost | changed 2025-09-22 07:09:00.605774 | 2025-09-22 07:09:00.605882 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-22 07:09:01.602110 | debian-bookworm -> localhost | changed 2025-09-22 07:09:01.612301 | 2025-09-22 07:09:01.612408 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-22 07:09:01.847150 | debian-bookworm -> localhost | ok 2025-09-22 07:09:01.852941 | 2025-09-22 07:09:01.853035 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-22 07:09:01.870666 | debian-bookworm | ok 2025-09-22 07:09:01.889912 | debian-bookworm | included: /var/lib/zuul/builds/cc4010b1809f473889e1d0d4b2342fe9/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-22 07:09:01.904381 | 2025-09-22 07:09:01.904472 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-22 07:09:03.025321 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-22 07:09:03.025584 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/cc4010b1809f473889e1d0d4b2342fe9/work/cc4010b1809f473889e1d0d4b2342fe9_id_rsa 2025-09-22 07:09:03.025644 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/cc4010b1809f473889e1d0d4b2342fe9/work/cc4010b1809f473889e1d0d4b2342fe9_id_rsa.pub 2025-09-22 07:09:03.025687 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-22 07:09:03.025726 | debian-bookworm -> localhost | SHA256:RGRWKjtFgrJaZZPB+4ro30osG4Ez8ErJ4VLXSJDaLCE zuul-build-sshkey 2025-09-22 07:09:03.025771 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-22 07:09:03.025847 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-22 07:09:03.025894 | debian-bookworm -> localhost | | .+o+..*.. | 2025-09-22 07:09:03.025960 | debian-bookworm -> localhost | |E o.Bo * . | 2025-09-22 07:09:03.026015 | debian-bookworm -> localhost | |o*.=ooo + | 2025-09-22 07:09:03.026049 | debian-bookworm -> localhost | |BoB.. = | 2025-09-22 07:09:03.026082 | debian-bookworm -> localhost | |=X. .o S | 2025-09-22 07:09:03.026118 | debian-bookworm -> localhost | |++o .. | 2025-09-22 07:09:03.026150 | debian-bookworm -> localhost | |.+ + . | 2025-09-22 07:09:03.026182 | debian-bookworm -> localhost | |. * o | 2025-09-22 07:09:03.026215 | debian-bookworm -> localhost | |.o.o.. | 2025-09-22 07:09:03.026247 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-22 07:09:03.026339 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.648336 2025-09-22 07:09:03.037047 | 2025-09-22 07:09:03.037183 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-22 07:09:03.055999 | debian-bookworm | ok 2025-09-22 07:09:03.066361 | debian-bookworm | included: /var/lib/zuul/builds/cc4010b1809f473889e1d0d4b2342fe9/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-22 07:09:03.074907 | 2025-09-22 07:09:03.074989 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-22 07:09:03.087466 | debian-bookworm | skipping: Conditional result was False 2025-09-22 07:09:03.092744 | 2025-09-22 07:09:03.092826 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-22 07:09:03.713972 | debian-bookworm | changed 2025-09-22 07:09:03.719096 | 2025-09-22 07:09:03.719187 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-22 07:09:03.973612 | debian-bookworm | ok 2025-09-22 07:09:03.981450 | 2025-09-22 07:09:03.981578 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-22 07:09:04.666394 | debian-bookworm | changed 2025-09-22 07:09:04.675597 | 2025-09-22 07:09:04.675711 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-22 07:09:05.309724 | debian-bookworm | changed 2025-09-22 07:09:05.321510 | 2025-09-22 07:09:05.321622 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-22 07:09:05.345026 | debian-bookworm | skipping: Conditional result was False 2025-09-22 07:09:05.357210 | 2025-09-22 07:09:05.357355 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-22 07:09:05.744706 | debian-bookworm -> localhost | changed 2025-09-22 07:09:05.754711 | 2025-09-22 07:09:05.754805 | TASK [add-build-sshkey : Add back temp key] 2025-09-22 07:09:06.030624 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/cc4010b1809f473889e1d0d4b2342fe9/work/cc4010b1809f473889e1d0d4b2342fe9_id_rsa (zuul-build-sshkey) 2025-09-22 07:09:06.030844 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.009415 2025-09-22 07:09:06.038052 | 2025-09-22 07:09:06.038139 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-22 07:09:06.412483 | debian-bookworm | ok 2025-09-22 07:09:06.418624 | 2025-09-22 07:09:06.418718 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-22 07:09:06.442032 | debian-bookworm | skipping: Conditional result was False 2025-09-22 07:09:06.451918 | 2025-09-22 07:09:06.452015 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-22 07:09:06.837199 | debian-bookworm | ok 2025-09-22 07:09:06.848182 | 2025-09-22 07:09:06.848298 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-22 07:09:06.875718 | debian-bookworm | ok 2025-09-22 07:09:06.880545 | 2025-09-22 07:09:06.880641 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-22 07:09:07.126977 | debian-bookworm -> localhost | ok 2025-09-22 07:09:07.132926 | 2025-09-22 07:09:07.133013 | TASK [validate-host : Collect information about the host] 2025-09-22 07:09:08.225982 | debian-bookworm | ok 2025-09-22 07:09:08.235884 | 2025-09-22 07:09:08.235968 | TASK [validate-host : Sanitize hostname] 2025-09-22 07:09:08.336703 | debian-bookworm | ok 2025-09-22 07:09:08.364961 | 2025-09-22 07:09:08.365059 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-22 07:09:08.822469 | debian-bookworm -> localhost | changed 2025-09-22 07:09:08.827835 | 2025-09-22 07:09:08.827924 | TASK [validate-host : Collect information about zuul worker] 2025-09-22 07:09:09.228074 | debian-bookworm | ok 2025-09-22 07:09:09.232872 | 2025-09-22 07:09:09.232971 | TASK [validate-host : Write out all zuul information for each host] 2025-09-22 07:09:09.701729 | debian-bookworm -> localhost | changed 2025-09-22 07:09:09.710617 | 2025-09-22 07:09:09.710712 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-22 07:09:09.970431 | debian-bookworm | ok 2025-09-22 07:09:09.976545 | 2025-09-22 07:09:09.976662 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-22 07:09:11.192527 | debian-bookworm | changed: 2025-09-22 07:09:11.192743 | debian-bookworm | cd+++++++++ src/ 2025-09-22 07:09:11.192779 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-22 07:09:11.192803 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-22 07:09:11.192824 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2025-09-22 07:09:11.192844 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007105 2025-09-22 07:09:35.325920 | 2025-09-22 07:09:35.326045 | TASK [upload-logs : Upload logs to log server] 2025-09-22 07:09:35.868113 | localhost | Output suppressed because no_log was given 2025-09-22 07:09:35.869989 | 2025-09-22 07:09:35.870088 | LOOP [upload-logs : Compress console log and json output] 2025-09-22 07:09:35.931896 | localhost | skipping: Conditional result was False 2025-09-22 07:09:35.939376 | localhost | skipping: Conditional result was False 2025-09-22 07:09:35.947164 | 2025-09-22 07:09:35.947270 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-22 07:09:35.991603 | localhost | skipping: Conditional result was False 2025-09-22 07:09:35.991880 | 2025-09-22 07:09:35.996574 | localhost | skipping: Conditional result was False 2025-09-22 07:09:35.999825 | 2025-09-22 07:09:35.999936 | LOOP [upload-logs : Upload console log and json output]