2025-11-28 09:29:10.031794 | Job console starting 2025-11-28 09:29:10.045604 | Updating git repos 2025-11-28 09:29:10.080545 | Cloning repos into workspace 2025-11-28 09:29:10.140832 | Restoring repo states 2025-11-28 09:29:10.148753 | Merging changes 2025-11-28 09:29:10.612835 | Checking out repos 2025-11-28 09:29:10.657511 | Preparing playbooks 2025-11-28 09:29:11.264433 | Running Ansible setup 2025-11-28 09:29:16.031432 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-28 09:29:18.110010 | 2025-11-28 09:29:18.110190 | PLAY [Base pre] 2025-11-28 09:29:18.190266 | 2025-11-28 09:29:18.190508 | TASK [Setup log path fact] 2025-11-28 09:29:18.251844 | debian-bookworm | ok 2025-11-28 09:29:18.289765 | 2025-11-28 09:29:18.289954 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-28 09:29:18.338199 | debian-bookworm | ok 2025-11-28 09:29:18.362492 | 2025-11-28 09:29:18.362987 | TASK [emit-job-header : Print job information] 2025-11-28 09:29:18.488929 | # Job Information 2025-11-28 09:29:18.489418 | Ansible Version: 2.16.14 2025-11-28 09:29:18.489895 | Job: python-black 2025-11-28 09:29:18.490069 | Pipeline: check 2025-11-28 09:29:18.490301 | Executor: 521e9411259a 2025-11-28 09:29:18.490507 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1010 2025-11-28 09:29:18.490699 | Event ID: 8efced90-cc3c-11f0-89f3-576054c1b2f5 2025-11-28 09:29:18.507752 | 2025-11-28 09:29:18.507896 | LOOP [emit-job-header : Print node information] 2025-11-28 09:29:18.789966 | debian-bookworm | ok: 2025-11-28 09:29:18.794919 | debian-bookworm | # Node Information 2025-11-28 09:29:18.795022 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-28 09:29:18.795055 | debian-bookworm | Hostname: debian 2025-11-28 09:29:18.795080 | debian-bookworm | Username: zuul 2025-11-28 09:29:18.795103 | debian-bookworm | Distro: Debian 12.12 2025-11-28 09:29:18.795128 | debian-bookworm | Provider: regiocloud-a 2025-11-28 09:29:18.795150 | debian-bookworm | Region: 2025-11-28 09:29:18.795172 | debian-bookworm | Label: debian-bookworm 2025-11-28 09:29:18.795193 | debian-bookworm | Product Name: OpenStack Nova 2025-11-28 09:29:18.795213 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe32:d6a1 2025-11-28 09:29:18.823749 | 2025-11-28 09:29:18.825044 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-28 09:29:20.763829 | debian-bookworm -> localhost | changed 2025-11-28 09:29:20.771723 | 2025-11-28 09:29:20.771899 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-28 09:29:23.997061 | debian-bookworm -> localhost | changed 2025-11-28 09:29:24.005802 | 2025-11-28 09:29:24.005894 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-28 09:29:24.811833 | debian-bookworm -> localhost | ok 2025-11-28 09:29:24.816839 | 2025-11-28 09:29:24.816933 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-28 09:29:24.834041 | debian-bookworm | ok 2025-11-28 09:29:24.876008 | debian-bookworm | included: /var/lib/zuul/builds/b43525207e4549c59b0291011c3881c1/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-28 09:29:24.880991 | 2025-11-28 09:29:24.881073 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-28 09:29:26.807206 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-28 09:29:26.807404 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/b43525207e4549c59b0291011c3881c1/work/b43525207e4549c59b0291011c3881c1_id_rsa 2025-11-28 09:29:26.807454 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/b43525207e4549c59b0291011c3881c1/work/b43525207e4549c59b0291011c3881c1_id_rsa.pub 2025-11-28 09:29:26.807481 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-28 09:29:26.807505 | debian-bookworm -> localhost | SHA256:duDGGft6/0b4mgZDVm1jzT7WWpdVqL7D6tS8UF/tIKA zuul-build-sshkey 2025-11-28 09:29:26.807527 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-28 09:29:26.807556 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-28 09:29:26.807579 | debian-bookworm -> localhost | | . +o| 2025-11-28 09:29:26.807600 | debian-bookworm -> localhost | | . * +| 2025-11-28 09:29:26.807621 | debian-bookworm -> localhost | | o .. + o+| 2025-11-28 09:29:26.807641 | debian-bookworm -> localhost | | o *o.. +*| 2025-11-28 09:29:26.807660 | debian-bookworm -> localhost | | Eo..o.oo=| 2025-11-28 09:29:26.807683 | debian-bookworm -> localhost | | o oo+ooo+ | 2025-11-28 09:29:26.807704 | debian-bookworm -> localhost | | ++o+. .| 2025-11-28 09:29:26.807724 | debian-bookworm -> localhost | | o..=oo | 2025-11-28 09:29:26.807745 | debian-bookworm -> localhost | | .oo+==. | 2025-11-28 09:29:26.807764 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-28 09:29:26.807814 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.968720 2025-11-28 09:29:26.814745 | 2025-11-28 09:29:26.814854 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-28 09:29:26.842213 | debian-bookworm | ok 2025-11-28 09:29:26.855233 | debian-bookworm | included: /var/lib/zuul/builds/b43525207e4549c59b0291011c3881c1/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-28 09:29:26.880288 | 2025-11-28 09:29:26.880398 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-28 09:29:26.931446 | debian-bookworm | skipping: Conditional result was False 2025-11-28 09:29:26.937172 | 2025-11-28 09:29:26.937276 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-28 09:29:27.807461 | debian-bookworm | changed 2025-11-28 09:29:27.812976 | 2025-11-28 09:29:27.813082 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-28 09:29:28.128514 | debian-bookworm | ok 2025-11-28 09:29:28.136074 | 2025-11-28 09:29:28.136186 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-28 09:29:28.843323 | debian-bookworm | changed 2025-11-28 09:29:28.852897 | 2025-11-28 09:29:28.853005 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-28 09:29:29.607216 | debian-bookworm | changed 2025-11-28 09:29:29.616758 | 2025-11-28 09:29:29.616853 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-28 09:29:29.671746 | debian-bookworm | skipping: Conditional result was False 2025-11-28 09:29:29.677773 | 2025-11-28 09:29:29.677873 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-28 09:29:30.550339 | debian-bookworm -> localhost | changed 2025-11-28 09:29:30.559319 | 2025-11-28 09:29:30.559415 | TASK [add-build-sshkey : Add back temp key] 2025-11-28 09:29:31.094001 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/b43525207e4549c59b0291011c3881c1/work/b43525207e4549c59b0291011c3881c1_id_rsa (zuul-build-sshkey) 2025-11-28 09:29:31.094209 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.010426 2025-11-28 09:29:31.101923 | 2025-11-28 09:29:31.102029 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-28 09:29:31.723330 | debian-bookworm | ok 2025-11-28 09:29:31.738570 | 2025-11-28 09:29:31.738684 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-28 09:29:31.772157 | debian-bookworm | skipping: Conditional result was False 2025-11-28 09:29:31.788324 | 2025-11-28 09:29:31.788434 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-28 09:29:32.246733 | debian-bookworm | ok 2025-11-28 09:29:32.276048 | 2025-11-28 09:29:32.276160 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-28 09:29:32.320955 | debian-bookworm | ok 2025-11-28 09:29:32.327816 | 2025-11-28 09:29:32.327913 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-28 09:29:32.830558 | debian-bookworm -> localhost | ok 2025-11-28 09:29:32.835941 | 2025-11-28 09:29:32.836018 | TASK [validate-host : Collect information about the host] 2025-11-28 09:29:33.893214 | debian-bookworm | ok 2025-11-28 09:29:33.903369 | 2025-11-28 09:29:33.903559 | TASK [validate-host : Sanitize hostname] 2025-11-28 09:29:34.002411 | debian-bookworm | ok 2025-11-28 09:29:34.035808 | 2025-11-28 09:29:34.035916 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-28 09:29:34.567131 | debian-bookworm -> localhost | changed 2025-11-28 09:29:34.572727 | 2025-11-28 09:29:34.572825 | TASK [validate-host : Collect information about zuul worker] 2025-11-28 09:29:34.988576 | debian-bookworm | ok 2025-11-28 09:29:34.997012 | 2025-11-28 09:29:34.997151 | TASK [validate-host : Write out all zuul information for each host] 2025-11-28 09:29:35.512567 | debian-bookworm -> localhost | changed 2025-11-28 09:29:35.521845 | 2025-11-28 09:29:35.521948 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-28 09:29:35.779278 | debian-bookworm | ok 2025-11-28 09:29:35.787247 | 2025-11-28 09:29:35.787366 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-28 09:29:36.679916 | debian-bookworm | changed: 2025-11-28 09:29:36.680136 | debian-bookworm | cd+++++++++ src/ 2025-11-28 09:29:36.680183 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-28 09:29:36.680214 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-28 09:29:36.680242 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-11-28 09:29:36.680268 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007657 2025-11-28 09:30:00.700231 | 2025-11-28 09:30:00.700365 | TASK [upload-logs : Upload logs to log server] 2025-11-28 09:30:01.361386 | localhost | Output suppressed because no_log was given 2025-11-28 09:30:01.364371 | 2025-11-28 09:30:01.364549 | LOOP [upload-logs : Compress console log and json output] 2025-11-28 09:30:01.440367 | localhost | skipping: Conditional result was False 2025-11-28 09:30:01.445895 | localhost | skipping: Conditional result was False 2025-11-28 09:30:01.462500 | 2025-11-28 09:30:01.462789 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-28 09:30:01.522784 | localhost | skipping: Conditional result was False 2025-11-28 09:30:01.523582 | 2025-11-28 09:30:01.528378 | localhost | skipping: Conditional result was False 2025-11-28 09:30:01.540694 | 2025-11-28 09:30:01.540857 | LOOP [upload-logs : Upload console log and json output]