2025-09-25 03:12:22.553187 | Job console starting 2025-09-25 03:12:22.593120 | Updating git repos 2025-09-25 03:12:22.640777 | Cloning repos into workspace 2025-09-25 03:12:22.743753 | Restoring repo states 2025-09-25 03:12:22.750262 | Merging changes 2025-09-25 03:12:22.750281 | Checking out repos 2025-09-25 03:12:22.889798 | Preparing playbooks 2025-09-25 03:12:23.825471 | Running Ansible setup 2025-09-25 03:12:28.133785 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-25 03:12:28.906592 | 2025-09-25 03:12:28.906763 | PLAY [Base pre] 2025-09-25 03:12:28.939385 | 2025-09-25 03:12:28.939548 | TASK [Setup log path fact] 2025-09-25 03:12:28.975082 | debian-bookworm | ok 2025-09-25 03:12:29.006124 | 2025-09-25 03:12:29.006291 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-25 03:12:29.056641 | debian-bookworm | ok 2025-09-25 03:12:29.077834 | 2025-09-25 03:12:29.077979 | TASK [emit-job-header : Print job information] 2025-09-25 03:12:29.165102 | # Job Information 2025-09-25 03:12:29.165306 | Ansible Version: 2.16.14 2025-09-25 03:12:29.165342 | Job: python-black 2025-09-25 03:12:29.165375 | Pipeline: periodic-daily 2025-09-25 03:12:29.165398 | Executor: 521e9411259a 2025-09-25 03:12:29.165419 | Triggered by: https://github.com/osism/testbed 2025-09-25 03:12:29.165440 | Event ID: 1f08b74e40554dda863478d132be4288 2025-09-25 03:12:29.173103 | 2025-09-25 03:12:29.173249 | LOOP [emit-job-header : Print node information] 2025-09-25 03:12:29.320889 | debian-bookworm | ok: 2025-09-25 03:12:29.321081 | debian-bookworm | # Node Information 2025-09-25 03:12:29.321114 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-25 03:12:29.321139 | debian-bookworm | Hostname: debian 2025-09-25 03:12:29.321161 | debian-bookworm | Username: zuul 2025-09-25 03:12:29.321182 | debian-bookworm | Distro: Debian 12.12 2025-09-25 03:12:29.321206 | debian-bookworm | Provider: regiocloud-a 2025-09-25 03:12:29.321227 | debian-bookworm | Region: 2025-09-25 03:12:29.321248 | debian-bookworm | Label: debian-bookworm 2025-09-25 03:12:29.321268 | debian-bookworm | Product Name: OpenStack Nova 2025-09-25 03:12:29.321287 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe96:6bf7 2025-09-25 03:12:29.343266 | 2025-09-25 03:12:29.343410 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-25 03:12:29.914081 | debian-bookworm -> localhost | changed 2025-09-25 03:12:29.921707 | 2025-09-25 03:12:29.921831 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-25 03:12:31.045954 | debian-bookworm -> localhost | changed 2025-09-25 03:12:31.060954 | 2025-09-25 03:12:31.061085 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-25 03:12:31.400362 | debian-bookworm -> localhost | ok 2025-09-25 03:12:31.407215 | 2025-09-25 03:12:31.407351 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-25 03:12:31.436538 | debian-bookworm | ok 2025-09-25 03:12:31.455450 | debian-bookworm | included: /var/lib/zuul/builds/08a8da3f4942413e82e760203beb259e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-25 03:12:31.463138 | 2025-09-25 03:12:31.463271 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-25 03:12:33.792395 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-25 03:12:33.792964 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/08a8da3f4942413e82e760203beb259e/work/08a8da3f4942413e82e760203beb259e_id_rsa 2025-09-25 03:12:33.793080 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/08a8da3f4942413e82e760203beb259e/work/08a8da3f4942413e82e760203beb259e_id_rsa.pub 2025-09-25 03:12:33.793157 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-25 03:12:33.793228 | debian-bookworm -> localhost | SHA256:CS+4mPA+HiyuIRdO20HV8SmoeFubH//tr9MgqjIkdl8 zuul-build-sshkey 2025-09-25 03:12:33.793292 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-25 03:12:33.793375 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-25 03:12:33.793441 | debian-bookworm -> localhost | | .... | 2025-09-25 03:12:33.793506 | debian-bookworm -> localhost | | . ... . | 2025-09-25 03:12:33.793587 | debian-bookworm -> localhost | | . o . o | 2025-09-25 03:12:33.793653 | debian-bookworm -> localhost | | o o o o | 2025-09-25 03:12:33.793714 | debian-bookworm -> localhost | |. + = o S | 2025-09-25 03:12:33.793782 | debian-bookworm -> localhost | | * Bo=o+ E . . | 2025-09-25 03:12:33.793843 | debian-bookworm -> localhost | |+ X.++o... . . o | 2025-09-25 03:12:33.793903 | debian-bookworm -> localhost | |o=.. o..o. .. .| 2025-09-25 03:12:33.793966 | debian-bookworm -> localhost | |ooo. oo.....++.| 2025-09-25 03:12:33.794024 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-25 03:12:33.794157 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.782567 2025-09-25 03:12:33.807839 | 2025-09-25 03:12:33.807999 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-25 03:12:33.837644 | debian-bookworm | ok 2025-09-25 03:12:33.847178 | debian-bookworm | included: /var/lib/zuul/builds/08a8da3f4942413e82e760203beb259e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-25 03:12:33.856215 | 2025-09-25 03:12:33.856406 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-25 03:12:33.880819 | debian-bookworm | skipping: Conditional result was False 2025-09-25 03:12:33.886828 | 2025-09-25 03:12:33.886958 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-25 03:12:34.580730 | debian-bookworm | changed 2025-09-25 03:12:34.588337 | 2025-09-25 03:12:34.588455 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-25 03:12:34.850768 | debian-bookworm | ok 2025-09-25 03:12:34.856583 | 2025-09-25 03:12:34.856696 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-25 03:12:35.521837 | debian-bookworm | changed 2025-09-25 03:12:35.534561 | 2025-09-25 03:12:35.534743 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-25 03:12:36.239377 | debian-bookworm | changed 2025-09-25 03:12:36.247520 | 2025-09-25 03:12:36.249190 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-25 03:12:36.281105 | debian-bookworm | skipping: Conditional result was False 2025-09-25 03:12:36.287677 | 2025-09-25 03:12:36.287808 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-25 03:12:36.979398 | debian-bookworm -> localhost | changed 2025-09-25 03:12:36.992675 | 2025-09-25 03:12:36.992807 | TASK [add-build-sshkey : Add back temp key] 2025-09-25 03:12:37.581779 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/08a8da3f4942413e82e760203beb259e/work/08a8da3f4942413e82e760203beb259e_id_rsa (zuul-build-sshkey) 2025-09-25 03:12:37.582036 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.015185 2025-09-25 03:12:37.593498 | 2025-09-25 03:12:37.593642 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-25 03:12:38.139716 | debian-bookworm | ok 2025-09-25 03:12:38.153764 | 2025-09-25 03:12:38.153884 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-25 03:12:38.182802 | debian-bookworm | skipping: Conditional result was False 2025-09-25 03:12:38.205161 | 2025-09-25 03:12:38.205266 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-25 03:12:38.637473 | debian-bookworm | ok 2025-09-25 03:12:38.648629 | 2025-09-25 03:12:38.648725 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-25 03:12:38.679166 | debian-bookworm | ok 2025-09-25 03:12:38.684668 | 2025-09-25 03:12:38.684762 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-25 03:12:38.969982 | debian-bookworm -> localhost | ok 2025-09-25 03:12:38.976701 | 2025-09-25 03:12:38.976794 | TASK [validate-host : Collect information about the host] 2025-09-25 03:12:40.217050 | debian-bookworm | ok 2025-09-25 03:12:40.241791 | 2025-09-25 03:12:40.241901 | TASK [validate-host : Sanitize hostname] 2025-09-25 03:12:40.327376 | debian-bookworm | ok 2025-09-25 03:12:40.360375 | 2025-09-25 03:12:40.360478 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-25 03:12:41.229909 | debian-bookworm -> localhost | changed 2025-09-25 03:12:41.235672 | 2025-09-25 03:12:41.235767 | TASK [validate-host : Collect information about zuul worker] 2025-09-25 03:12:41.758495 | debian-bookworm | ok 2025-09-25 03:12:41.762948 | 2025-09-25 03:12:41.763043 | TASK [validate-host : Write out all zuul information for each host] 2025-09-25 03:12:42.464508 | debian-bookworm -> localhost | changed 2025-09-25 03:12:42.471825 | 2025-09-25 03:12:42.471897 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-25 03:12:42.702461 | debian-bookworm | ok 2025-09-25 03:12:42.715952 | 2025-09-25 03:12:42.716036 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-25 03:12:43.798016 | debian-bookworm | changed: 2025-09-25 03:12:43.798194 | debian-bookworm | cd+++++++++ src/ 2025-09-25 03:12:43.798229 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-25 03:12:43.798253 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-25 03:12:43.798274 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2025-09-25 03:12:43.798294 | debian-bookworm | localhost | ok: Runtime: 0:00:00.003765 2025-09-25 03:13:11.681851 | 2025-09-25 03:13:11.682014 | TASK [upload-logs : Upload logs to log server] 2025-09-25 03:13:12.880595 | localhost | Output suppressed because no_log was given 2025-09-25 03:13:12.882200 | 2025-09-25 03:13:12.882284 | LOOP [upload-logs : Compress console log and json output] 2025-09-25 03:13:13.052226 | localhost | skipping: Conditional result was False 2025-09-25 03:13:13.074287 | localhost | skipping: Conditional result was False 2025-09-25 03:13:13.079936 | 2025-09-25 03:13:13.080047 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-25 03:13:13.123955 | localhost | skipping: Conditional result was False 2025-09-25 03:13:13.124166 | 2025-09-25 03:13:13.128561 | localhost | skipping: Conditional result was False 2025-09-25 03:13:13.131482 | 2025-09-25 03:13:13.131603 | LOOP [upload-logs : Upload console log and json output]