2025-12-31 00:19:22.334707 | Job console starting 2025-12-31 00:19:22.361457 | Updating git repos 2025-12-31 00:19:22.470598 | Cloning repos into workspace 2025-12-31 00:19:22.561341 | Restoring repo states 2025-12-31 00:19:22.582964 | Merging changes 2025-12-31 00:19:23.166339 | Checking out repos 2025-12-31 00:19:23.238620 | Preparing playbooks 2025-12-31 00:19:24.882890 | Running Ansible setup 2025-12-31 00:19:30.996676 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-31 00:19:32.722351 | 2025-12-31 00:19:32.722520 | PLAY [Base pre] 2025-12-31 00:19:32.753526 | 2025-12-31 00:19:32.753742 | TASK [Setup log path fact] 2025-12-31 00:19:32.804457 | debian-bookworm | ok 2025-12-31 00:19:32.839315 | 2025-12-31 00:19:32.839492 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-31 00:19:32.890591 | debian-bookworm | ok 2025-12-31 00:19:32.905063 | 2025-12-31 00:19:32.905259 | TASK [emit-job-header : Print job information] 2025-12-31 00:19:33.027633 | # Job Information 2025-12-31 00:19:33.027831 | Ansible Version: 2.16.14 2025-12-31 00:19:33.027867 | Job: python-black 2025-12-31 00:19:33.027902 | Pipeline: check 2025-12-31 00:19:33.027925 | Executor: 521e9411259a 2025-12-31 00:19:33.027945 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1064 2025-12-31 00:19:33.027969 | Event ID: 546d6040-e5de-11f0-986f-91ba01595c3c 2025-12-31 00:19:33.033753 | 2025-12-31 00:19:33.033882 | LOOP [emit-job-header : Print node information] 2025-12-31 00:19:33.170824 | debian-bookworm | ok: 2025-12-31 00:19:33.171065 | debian-bookworm | # Node Information 2025-12-31 00:19:33.171101 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-31 00:19:33.171189 | debian-bookworm | Hostname: debian 2025-12-31 00:19:33.171229 | debian-bookworm | Username: zuul 2025-12-31 00:19:33.171252 | debian-bookworm | Distro: Debian 12.12 2025-12-31 00:19:33.171275 | debian-bookworm | Provider: regiocloud-a 2025-12-31 00:19:33.171297 | debian-bookworm | Region: 2025-12-31 00:19:33.171326 | debian-bookworm | Label: debian-bookworm 2025-12-31 00:19:33.171346 | debian-bookworm | Product Name: OpenStack Nova 2025-12-31 00:19:33.171366 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe97:591d 2025-12-31 00:19:33.187496 | 2025-12-31 00:19:33.187650 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-31 00:19:34.210612 | debian-bookworm -> localhost | changed 2025-12-31 00:19:34.218212 | 2025-12-31 00:19:34.218347 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-31 00:19:35.943283 | debian-bookworm -> localhost | changed 2025-12-31 00:19:35.954177 | 2025-12-31 00:19:35.954315 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-31 00:19:36.597072 | debian-bookworm -> localhost | ok 2025-12-31 00:19:36.603891 | 2025-12-31 00:19:36.604034 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-31 00:19:36.654536 | debian-bookworm | ok 2025-12-31 00:19:36.684695 | debian-bookworm | included: /var/lib/zuul/builds/11fd01844b3748df91a6d000b9bad1e8/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-31 00:19:36.692996 | 2025-12-31 00:19:36.693177 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-31 00:19:38.612800 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-31 00:19:38.613145 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/11fd01844b3748df91a6d000b9bad1e8/work/11fd01844b3748df91a6d000b9bad1e8_id_rsa 2025-12-31 00:19:38.613189 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/11fd01844b3748df91a6d000b9bad1e8/work/11fd01844b3748df91a6d000b9bad1e8_id_rsa.pub 2025-12-31 00:19:38.613216 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-31 00:19:38.613241 | debian-bookworm -> localhost | SHA256:JM++n8+QQZyGleM6hnD/2VqVqsmGYo4aUagTN7Zpjhs zuul-build-sshkey 2025-12-31 00:19:38.613264 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-31 00:19:38.613346 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-31 00:19:38.613372 | debian-bookworm -> localhost | | .. | 2025-12-31 00:19:38.613395 | debian-bookworm -> localhost | | . +o. | 2025-12-31 00:19:38.613483 | debian-bookworm -> localhost | |. = . . o.=. | 2025-12-31 00:19:38.613506 | debian-bookworm -> localhost | | = =. .= o. . | 2025-12-31 00:19:38.613527 | debian-bookworm -> localhost | |o = o oS.. o | 2025-12-31 00:19:38.613590 | debian-bookworm -> localhost | | = . ..= o o | 2025-12-31 00:19:38.613614 | debian-bookworm -> localhost | |E o ..+ooo | 2025-12-31 00:19:38.613634 | debian-bookworm -> localhost | | o . .o .o+B. | 2025-12-31 00:19:38.613656 | debian-bookworm -> localhost | |. ...o...oBoo | 2025-12-31 00:19:38.613676 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-31 00:19:38.613769 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.153647 2025-12-31 00:19:38.622849 | 2025-12-31 00:19:38.623077 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-31 00:19:38.667376 | debian-bookworm | ok 2025-12-31 00:19:38.687874 | debian-bookworm | included: /var/lib/zuul/builds/11fd01844b3748df91a6d000b9bad1e8/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-31 00:19:38.712848 | 2025-12-31 00:19:38.713276 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-31 00:19:38.762870 | debian-bookworm | skipping: Conditional result was False 2025-12-31 00:19:38.771428 | 2025-12-31 00:19:38.771614 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-31 00:19:39.600435 | debian-bookworm | changed 2025-12-31 00:19:39.606122 | 2025-12-31 00:19:39.606253 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-31 00:19:39.880767 | debian-bookworm | ok 2025-12-31 00:19:39.888886 | 2025-12-31 00:19:39.889019 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-31 00:19:40.591039 | debian-bookworm | changed 2025-12-31 00:19:40.600175 | 2025-12-31 00:19:40.600375 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-31 00:19:41.369349 | debian-bookworm | changed 2025-12-31 00:19:41.378753 | 2025-12-31 00:19:41.378905 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-31 00:19:41.402741 | debian-bookworm | skipping: Conditional result was False 2025-12-31 00:19:41.409480 | 2025-12-31 00:19:41.409609 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-31 00:19:41.992943 | debian-bookworm -> localhost | changed 2025-12-31 00:19:42.021660 | 2025-12-31 00:19:42.021812 | TASK [add-build-sshkey : Add back temp key] 2025-12-31 00:19:42.544883 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/11fd01844b3748df91a6d000b9bad1e8/work/11fd01844b3748df91a6d000b9bad1e8_id_rsa (zuul-build-sshkey) 2025-12-31 00:19:42.545197 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.013601 2025-12-31 00:19:42.554672 | 2025-12-31 00:19:42.554885 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-31 00:19:43.048086 | debian-bookworm | ok 2025-12-31 00:19:43.064954 | 2025-12-31 00:19:43.065098 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-31 00:19:43.119503 | debian-bookworm | skipping: Conditional result was False 2025-12-31 00:19:43.131444 | 2025-12-31 00:19:43.131586 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-31 00:19:43.715224 | debian-bookworm | ok 2025-12-31 00:19:43.738953 | 2025-12-31 00:19:43.739106 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-31 00:19:43.785064 | debian-bookworm | ok 2025-12-31 00:19:43.790946 | 2025-12-31 00:19:43.791077 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-31 00:19:44.324599 | debian-bookworm -> localhost | ok 2025-12-31 00:19:44.331501 | 2025-12-31 00:19:44.331630 | TASK [validate-host : Collect information about the host] 2025-12-31 00:19:45.595876 | debian-bookworm | ok 2025-12-31 00:19:45.606689 | 2025-12-31 00:19:45.606813 | TASK [validate-host : Sanitize hostname] 2025-12-31 00:19:45.729609 | debian-bookworm | ok 2025-12-31 00:19:45.787235 | 2025-12-31 00:19:45.787374 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-31 00:19:46.683612 | debian-bookworm -> localhost | changed 2025-12-31 00:19:46.690476 | 2025-12-31 00:19:46.690610 | TASK [validate-host : Collect information about zuul worker] 2025-12-31 00:19:47.167556 | debian-bookworm | ok 2025-12-31 00:19:47.177974 | 2025-12-31 00:19:47.178117 | TASK [validate-host : Write out all zuul information for each host] 2025-12-31 00:19:48.043321 | debian-bookworm -> localhost | changed 2025-12-31 00:19:48.053741 | 2025-12-31 00:19:48.053850 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-31 00:19:48.337081 | debian-bookworm | ok 2025-12-31 00:19:48.348269 | 2025-12-31 00:19:48.348683 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-31 00:19:49.658625 | debian-bookworm | changed: 2025-12-31 00:19:49.658906 | debian-bookworm | cd+++++++++ src/ 2025-12-31 00:19:49.658948 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-31 00:19:49.658973 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-31 00:19:49.658994 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-12-31 00:19:49.659014 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006691 2025-12-31 00:20:17.425752 | 2025-12-31 00:20:17.425883 | TASK [upload-logs : Upload logs to log server] 2025-12-31 00:20:18.029158 | localhost | Output suppressed because no_log was given 2025-12-31 00:20:18.032241 | 2025-12-31 00:20:18.032378 | LOOP [upload-logs : Compress console log and json output] 2025-12-31 00:20:18.088600 | localhost | skipping: Conditional result was False 2025-12-31 00:20:18.096462 | localhost | skipping: Conditional result was False 2025-12-31 00:20:18.101995 | 2025-12-31 00:20:18.102177 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-31 00:20:18.153427 | localhost | skipping: Conditional result was False 2025-12-31 00:20:18.153718 | 2025-12-31 00:20:18.159264 | localhost | skipping: Conditional result was False 2025-12-31 00:20:18.170263 | 2025-12-31 00:20:18.170406 | LOOP [upload-logs : Upload console log and json output]