2025-09-21 00:18:44.177192 | Job console starting 2025-09-21 00:18:44.192828 | Updating git repos 2025-09-21 00:18:44.223854 | Cloning repos into workspace 2025-09-21 00:18:44.293613 | Restoring repo states 2025-09-21 00:18:44.305221 | Merging changes 2025-09-21 00:18:44.884867 | Checking out repos 2025-09-21 00:18:44.965454 | Preparing playbooks 2025-09-21 00:18:45.968250 | Running Ansible setup 2025-09-21 00:18:51.161454 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-21 00:18:52.236904 | 2025-09-21 00:18:52.237046 | PLAY [Base pre] 2025-09-21 00:18:52.273198 | 2025-09-21 00:18:52.273372 | TASK [Setup log path fact] 2025-09-21 00:18:52.305108 | debian-bookworm | ok 2025-09-21 00:18:52.333890 | 2025-09-21 00:18:52.334038 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-21 00:18:52.386101 | debian-bookworm | ok 2025-09-21 00:18:52.412929 | 2025-09-21 00:18:52.413052 | TASK [emit-job-header : Print job information] 2025-09-21 00:18:52.481887 | # Job Information 2025-09-21 00:18:52.482073 | Ansible Version: 2.16.14 2025-09-21 00:18:52.482135 | Job: python-black 2025-09-21 00:18:52.482256 | Pipeline: check 2025-09-21 00:18:52.482285 | Executor: 521e9411259a 2025-09-21 00:18:52.482414 | Triggered by: https://github.com/osism/openstack-image-manager/pull/918 2025-09-21 00:18:52.482549 | Event ID: 651d6190-9680-11f0-9114-6f36c6501891 2025-09-21 00:18:52.492448 | 2025-09-21 00:18:52.492554 | LOOP [emit-job-header : Print node information] 2025-09-21 00:18:52.648547 | debian-bookworm | ok: 2025-09-21 00:18:52.648681 | debian-bookworm | # Node Information 2025-09-21 00:18:52.648710 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-21 00:18:52.648732 | debian-bookworm | Hostname: debian 2025-09-21 00:18:52.648750 | debian-bookworm | Username: zuul 2025-09-21 00:18:52.648768 | debian-bookworm | Distro: Debian 12.12 2025-09-21 00:18:52.648788 | debian-bookworm | Provider: regiocloud-a 2025-09-21 00:18:52.648806 | debian-bookworm | Region: 2025-09-21 00:18:52.648823 | debian-bookworm | Label: debian-bookworm 2025-09-21 00:18:52.648839 | debian-bookworm | Product Name: OpenStack Nova 2025-09-21 00:18:52.648855 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fed1:f849 2025-09-21 00:18:52.667755 | 2025-09-21 00:18:52.667860 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-21 00:18:53.095658 | debian-bookworm -> localhost | changed 2025-09-21 00:18:53.101488 | 2025-09-21 00:18:53.103236 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-21 00:18:54.351269 | debian-bookworm -> localhost | changed 2025-09-21 00:18:54.365102 | 2025-09-21 00:18:54.365206 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-21 00:18:54.802797 | debian-bookworm -> localhost | ok 2025-09-21 00:18:54.809112 | 2025-09-21 00:18:54.809213 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-21 00:18:54.847063 | debian-bookworm | ok 2025-09-21 00:18:54.873515 | debian-bookworm | included: /var/lib/zuul/builds/d300054293314ac190e996d124779225/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-21 00:18:54.878533 | 2025-09-21 00:18:54.878608 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-21 00:18:56.881969 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-21 00:18:56.882171 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/d300054293314ac190e996d124779225/work/d300054293314ac190e996d124779225_id_rsa 2025-09-21 00:18:56.882207 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/d300054293314ac190e996d124779225/work/d300054293314ac190e996d124779225_id_rsa.pub 2025-09-21 00:18:56.882229 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-21 00:18:56.882252 | debian-bookworm -> localhost | SHA256:H96g5FDPCbQTSmUdnUgRaBB5xMNsGBFLsLiQE3F3sx8 zuul-build-sshkey 2025-09-21 00:18:56.882270 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-21 00:18:56.882293 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-21 00:18:56.882311 | debian-bookworm -> localhost | |o.. o.@#*+=* . | 2025-09-21 00:18:56.882329 | debian-bookworm -> localhost | | + o =oBXoo o | 2025-09-21 00:18:56.882346 | debian-bookworm -> localhost | |+ . . ++E. | 2025-09-21 00:18:56.882362 | debian-bookworm -> localhost | | o . o * . | 2025-09-21 00:18:56.882379 | debian-bookworm -> localhost | | . . S * | 2025-09-21 00:18:56.882397 | debian-bookworm -> localhost | | + + + | 2025-09-21 00:18:56.882414 | debian-bookworm -> localhost | | o o . | 2025-09-21 00:18:56.882431 | debian-bookworm -> localhost | | | 2025-09-21 00:18:56.882449 | debian-bookworm -> localhost | | | 2025-09-21 00:18:56.882466 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-21 00:18:56.882511 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.254579 2025-09-21 00:18:56.887561 | 2025-09-21 00:18:56.887638 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-21 00:18:56.904674 | debian-bookworm | ok 2025-09-21 00:18:56.930393 | debian-bookworm | included: /var/lib/zuul/builds/d300054293314ac190e996d124779225/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-21 00:18:56.949432 | 2025-09-21 00:18:56.949519 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-21 00:18:56.986511 | debian-bookworm | skipping: Conditional result was False 2025-09-21 00:18:56.991236 | 2025-09-21 00:18:56.991310 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-21 00:18:57.705411 | debian-bookworm | changed 2025-09-21 00:18:57.709922 | 2025-09-21 00:18:57.710000 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-21 00:18:58.024618 | debian-bookworm | ok 2025-09-21 00:18:58.029165 | 2025-09-21 00:18:58.029243 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-21 00:18:58.826173 | debian-bookworm | changed 2025-09-21 00:18:58.831731 | 2025-09-21 00:18:58.831815 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-21 00:18:59.430793 | debian-bookworm | changed 2025-09-21 00:18:59.435431 | 2025-09-21 00:18:59.435511 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-21 00:18:59.471220 | debian-bookworm | skipping: Conditional result was False 2025-09-21 00:18:59.481681 | 2025-09-21 00:18:59.481770 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-21 00:19:00.301112 | debian-bookworm -> localhost | changed 2025-09-21 00:19:00.309716 | 2025-09-21 00:19:00.309811 | TASK [add-build-sshkey : Add back temp key] 2025-09-21 00:19:00.968837 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/d300054293314ac190e996d124779225/work/d300054293314ac190e996d124779225_id_rsa (zuul-build-sshkey) 2025-09-21 00:19:00.969052 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.023915 2025-09-21 00:19:00.978499 | 2025-09-21 00:19:00.978588 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-21 00:19:01.498430 | debian-bookworm | ok 2025-09-21 00:19:01.506327 | 2025-09-21 00:19:01.506415 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-21 00:19:01.539677 | debian-bookworm | skipping: Conditional result was False 2025-09-21 00:19:01.551597 | 2025-09-21 00:19:01.551687 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-21 00:19:01.994247 | debian-bookworm | ok 2025-09-21 00:19:02.017589 | 2025-09-21 00:19:02.018413 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-21 00:19:02.074395 | debian-bookworm | ok 2025-09-21 00:19:02.080817 | 2025-09-21 00:19:02.080905 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-21 00:19:02.577899 | debian-bookworm -> localhost | ok 2025-09-21 00:19:02.591232 | 2025-09-21 00:19:02.591331 | TASK [validate-host : Collect information about the host] 2025-09-21 00:19:03.861685 | debian-bookworm | ok 2025-09-21 00:19:03.877408 | 2025-09-21 00:19:03.877496 | TASK [validate-host : Sanitize hostname] 2025-09-21 00:19:03.975657 | debian-bookworm | ok 2025-09-21 00:19:04.013166 | 2025-09-21 00:19:04.013261 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-21 00:19:04.824841 | debian-bookworm -> localhost | changed 2025-09-21 00:19:04.829321 | 2025-09-21 00:19:04.829404 | TASK [validate-host : Collect information about zuul worker] 2025-09-21 00:19:05.321219 | debian-bookworm | ok 2025-09-21 00:19:05.326163 | 2025-09-21 00:19:05.326349 | TASK [validate-host : Write out all zuul information for each host] 2025-09-21 00:19:06.613815 | debian-bookworm -> localhost | changed 2025-09-21 00:19:06.621829 | 2025-09-21 00:19:06.621911 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-21 00:19:06.907547 | debian-bookworm | ok 2025-09-21 00:19:06.913850 | 2025-09-21 00:19:06.913942 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-21 00:19:08.069329 | debian-bookworm | changed: 2025-09-21 00:19:08.069480 | debian-bookworm | cd+++++++++ src/ 2025-09-21 00:19:08.069507 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-21 00:19:08.069527 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-21 00:19:08.069544 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-09-21 00:19:08.069561 | debian-bookworm | localhost | ok: Runtime: 0:00:00.020131 2025-09-21 00:19:35.793217 | 2025-09-21 00:19:35.793346 | TASK [upload-logs : Upload logs to log server] 2025-09-21 00:19:36.373973 | localhost | Output suppressed because no_log was given 2025-09-21 00:19:36.375610 | 2025-09-21 00:19:36.375693 | LOOP [upload-logs : Compress console log and json output] 2025-09-21 00:19:36.416736 | localhost | skipping: Conditional result was False 2025-09-21 00:19:36.422496 | localhost | skipping: Conditional result was False 2025-09-21 00:19:36.430790 | 2025-09-21 00:19:36.430904 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-21 00:19:36.485086 | localhost | skipping: Conditional result was False 2025-09-21 00:19:36.485311 | 2025-09-21 00:19:36.489832 | localhost | skipping: Conditional result was False 2025-09-21 00:19:36.496207 | 2025-09-21 00:19:36.496303 | LOOP [upload-logs : Upload console log and json output]