2025-07-16 18:17:09.347344 | Job console starting 2025-07-16 18:17:09.363158 | Updating git repos 2025-07-16 18:17:09.399171 | Cloning repos into workspace 2025-07-16 18:17:09.445121 | Restoring repo states 2025-07-16 18:17:09.453273 | Merging changes 2025-07-16 18:17:09.955237 | Checking out repos 2025-07-16 18:17:09.993097 | Preparing playbooks 2025-07-16 18:17:10.620907 | Running Ansible setup 2025-07-16 18:17:15.792421 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-07-16 18:17:16.596760 | 2025-07-16 18:17:16.596924 | PLAY [Base pre] 2025-07-16 18:17:16.613568 | 2025-07-16 18:17:16.613721 | TASK [Setup log path fact] 2025-07-16 18:17:16.647429 | debian-bookworm | ok 2025-07-16 18:17:16.668403 | 2025-07-16 18:17:16.668610 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-07-16 18:17:16.715017 | debian-bookworm | ok 2025-07-16 18:17:16.728322 | 2025-07-16 18:17:16.728451 | TASK [emit-job-header : Print job information] 2025-07-16 18:17:16.788646 | # Job Information 2025-07-16 18:17:16.788832 | Ansible Version: 2.16.14 2025-07-16 18:17:16.788867 | Job: python-black 2025-07-16 18:17:16.788899 | Pipeline: check 2025-07-16 18:17:16.788922 | Executor: 521e9411259a 2025-07-16 18:17:16.788942 | Triggered by: https://github.com/osism/cfg-cookiecutter/pull/766 2025-07-16 18:17:16.788965 | Event ID: 580dc4a0-626d-11f0-9588-43436b67625b 2025-07-16 18:17:16.794040 | 2025-07-16 18:17:16.794155 | LOOP [emit-job-header : Print node information] 2025-07-16 18:17:16.920529 | debian-bookworm | ok: 2025-07-16 18:17:16.920904 | debian-bookworm | # Node Information 2025-07-16 18:17:16.920976 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-07-16 18:17:16.921030 | debian-bookworm | Hostname: debian 2025-07-16 18:17:16.921078 | debian-bookworm | Username: zuul 2025-07-16 18:17:16.921123 | debian-bookworm | Distro: Debian 12.11 2025-07-16 18:17:16.921175 | debian-bookworm | Provider: regiocloud-a 2025-07-16 18:17:16.921221 | debian-bookworm | Region: 2025-07-16 18:17:16.921265 | debian-bookworm | Label: debian-bookworm 2025-07-16 18:17:16.921306 | debian-bookworm | Product Name: OpenStack Nova 2025-07-16 18:17:16.921349 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe2a:9fd5 2025-07-16 18:17:16.937088 | 2025-07-16 18:17:16.937231 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-07-16 18:17:17.408002 | debian-bookworm -> localhost | changed 2025-07-16 18:17:17.415635 | 2025-07-16 18:17:17.415767 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-07-16 18:17:18.520258 | debian-bookworm -> localhost | changed 2025-07-16 18:17:18.533612 | 2025-07-16 18:17:18.533840 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-07-16 18:17:18.820568 | debian-bookworm -> localhost | ok 2025-07-16 18:17:18.826998 | 2025-07-16 18:17:18.827119 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-07-16 18:17:18.855734 | debian-bookworm | ok 2025-07-16 18:17:18.874010 | debian-bookworm | included: /var/lib/zuul/builds/e52003eb75e94e85a89623b4714b64da/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-07-16 18:17:18.881485 | 2025-07-16 18:17:18.881627 | TASK [add-build-sshkey : Create Temp SSH key] 2025-07-16 18:17:20.027566 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-07-16 18:17:20.027829 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/e52003eb75e94e85a89623b4714b64da/work/e52003eb75e94e85a89623b4714b64da_id_rsa 2025-07-16 18:17:20.027869 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/e52003eb75e94e85a89623b4714b64da/work/e52003eb75e94e85a89623b4714b64da_id_rsa.pub 2025-07-16 18:17:20.027896 | debian-bookworm -> localhost | The key fingerprint is: 2025-07-16 18:17:20.027920 | debian-bookworm -> localhost | SHA256:/sO2WeTlVh/HkcaBDG9ScbCn9GWOs7AiQisO9iXgwug zuul-build-sshkey 2025-07-16 18:17:20.027942 | debian-bookworm -> localhost | The key's randomart image is: 2025-07-16 18:17:20.027977 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-07-16 18:17:20.027999 | debian-bookworm -> localhost | | .o++o | 2025-07-16 18:17:20.028021 | debian-bookworm -> localhost | | oo+ o| 2025-07-16 18:17:20.028042 | debian-bookworm -> localhost | | . = *o| 2025-07-16 18:17:20.028061 | debian-bookworm -> localhost | | + ==o| 2025-07-16 18:17:20.028081 | debian-bookworm -> localhost | | . . S o.+o=| 2025-07-16 18:17:20.028106 | debian-bookworm -> localhost | |o. . . o o = ++| 2025-07-16 18:17:20.028127 | debian-bookworm -> localhost | |o.+ o + o.. + + .| 2025-07-16 18:17:20.028147 | debian-bookworm -> localhost | |.o + + . o++ . | 2025-07-16 18:17:20.028168 | debian-bookworm -> localhost | | E o .+o | 2025-07-16 18:17:20.028188 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-07-16 18:17:20.028245 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.642312 2025-07-16 18:17:20.035026 | 2025-07-16 18:17:20.035187 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-07-16 18:17:20.071053 | debian-bookworm | ok 2025-07-16 18:17:20.088511 | debian-bookworm | included: /var/lib/zuul/builds/e52003eb75e94e85a89623b4714b64da/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-07-16 18:17:20.105716 | 2025-07-16 18:17:20.105854 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-07-16 18:17:20.133611 | debian-bookworm | skipping: Conditional result was False 2025-07-16 18:17:20.152013 | 2025-07-16 18:17:20.152232 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-07-16 18:17:20.807246 | debian-bookworm | changed 2025-07-16 18:17:20.814935 | 2025-07-16 18:17:20.815064 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-07-16 18:17:21.076196 | debian-bookworm | ok 2025-07-16 18:17:21.085225 | 2025-07-16 18:17:21.085367 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-07-16 18:17:21.777280 | debian-bookworm | changed 2025-07-16 18:17:21.788182 | 2025-07-16 18:17:21.788331 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-07-16 18:17:22.453782 | debian-bookworm | changed 2025-07-16 18:17:22.464832 | 2025-07-16 18:17:22.465002 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-07-16 18:17:22.492188 | debian-bookworm | skipping: Conditional result was False 2025-07-16 18:17:22.502906 | 2025-07-16 18:17:22.503064 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-07-16 18:17:23.009821 | debian-bookworm -> localhost | changed 2025-07-16 18:17:23.023134 | 2025-07-16 18:17:23.023274 | TASK [add-build-sshkey : Add back temp key] 2025-07-16 18:17:23.399606 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/e52003eb75e94e85a89623b4714b64da/work/e52003eb75e94e85a89623b4714b64da_id_rsa (zuul-build-sshkey) 2025-07-16 18:17:23.399893 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.021385 2025-07-16 18:17:23.410213 | 2025-07-16 18:17:23.410323 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-07-16 18:17:23.835569 | debian-bookworm | ok 2025-07-16 18:17:23.844060 | 2025-07-16 18:17:23.844227 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-07-16 18:17:23.869617 | debian-bookworm | skipping: Conditional result was False 2025-07-16 18:17:23.888785 | 2025-07-16 18:17:23.888917 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-07-16 18:17:24.365265 | debian-bookworm | ok 2025-07-16 18:17:24.379990 | 2025-07-16 18:17:24.380115 | TASK [validate-host : Define zuul_info_dir fact] 2025-07-16 18:17:24.420869 | debian-bookworm | ok 2025-07-16 18:17:24.426871 | 2025-07-16 18:17:24.426984 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-07-16 18:17:24.736265 | debian-bookworm -> localhost | ok 2025-07-16 18:17:24.747109 | 2025-07-16 18:17:24.747241 | TASK [validate-host : Collect information about the host] 2025-07-16 18:17:26.014101 | debian-bookworm | ok 2025-07-16 18:17:26.027478 | 2025-07-16 18:17:26.027621 | TASK [validate-host : Sanitize hostname] 2025-07-16 18:17:26.147768 | debian-bookworm | ok 2025-07-16 18:17:26.225692 | 2025-07-16 18:17:26.225936 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-07-16 18:17:26.816882 | debian-bookworm -> localhost | changed 2025-07-16 18:17:26.831034 | 2025-07-16 18:17:26.831201 | TASK [validate-host : Collect information about zuul worker] 2025-07-16 18:17:27.284010 | debian-bookworm | ok 2025-07-16 18:17:27.291198 | 2025-07-16 18:17:27.291337 | TASK [validate-host : Write out all zuul information for each host] 2025-07-16 18:17:27.907030 | debian-bookworm -> localhost | changed 2025-07-16 18:17:27.919068 | 2025-07-16 18:17:27.919191 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-07-16 18:17:28.227043 | debian-bookworm | ok 2025-07-16 18:17:28.235770 | 2025-07-16 18:17:28.235924 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-07-16 18:17:29.126063 | debian-bookworm | changed: 2025-07-16 18:17:29.126451 | debian-bookworm | cd+++++++++ src/ 2025-07-16 18:17:29.126521 | debian-bookworm | cd+++++++++ src/github.com/ 2025-07-16 18:17:29.126625 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-07-16 18:17:29.126667 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2025-07-16 18:17:29.126705 | debian-bookworm | Containerfile 2025-07-16 18:17:29.126985 | debian-bookworm | localhost | ok: Runtime: 0:00:00.019011 2025-07-16 18:17:59.359209 | 2025-07-16 18:17:59.359287 | TASK [upload-logs : Upload logs to log server] 2025-07-16 18:18:00.885117 | localhost | Output suppressed because no_log was given 2025-07-16 18:18:00.886536 | 2025-07-16 18:18:00.886624 | LOOP [upload-logs : Compress console log and json output] 2025-07-16 18:18:00.988317 | localhost | skipping: Conditional result was False 2025-07-16 18:18:01.007019 | localhost | skipping: Conditional result was False 2025-07-16 18:18:01.033744 | 2025-07-16 18:18:01.033839 | LOOP [upload-logs : Upload compressed console log and json output] 2025-07-16 18:18:01.191360 | localhost | skipping: Conditional result was False 2025-07-16 18:18:01.191603 | 2025-07-16 18:18:01.210764 | localhost | skipping: Conditional result was False 2025-07-16 18:18:01.213463 | 2025-07-16 18:18:01.213569 | LOOP [upload-logs : Upload console log and json output]