2025-05-21 07:37:29.434778 | Job console starting 2025-05-21 07:37:29.461083 | Updating git repos 2025-05-21 07:37:29.524898 | Cloning repos into workspace 2025-05-21 07:37:29.601211 | Restoring repo states 2025-05-21 07:37:29.614689 | Merging changes 2025-05-21 07:37:30.166741 | Checking out repos 2025-05-21 07:37:30.222446 | Preparing playbooks 2025-05-21 07:37:31.489567 | Running Ansible setup 2025-05-21 07:37:38.308099 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-05-21 07:37:39.420154 | 2025-05-21 07:37:39.420328 | PLAY [Base pre] 2025-05-21 07:37:39.457777 | 2025-05-21 07:37:39.457956 | TASK [Setup log path fact] 2025-05-21 07:37:39.501788 | debian-bookworm | ok 2025-05-21 07:37:39.530289 | 2025-05-21 07:37:39.530470 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-05-21 07:37:39.623997 | debian-bookworm | ok 2025-05-21 07:37:39.647387 | 2025-05-21 07:37:39.647575 | TASK [emit-job-header : Print job information] 2025-05-21 07:37:39.718386 | # Job Information 2025-05-21 07:37:39.718613 | Ansible Version: 2.16.14 2025-05-21 07:37:39.718650 | Job: python-black 2025-05-21 07:37:39.718683 | Pipeline: check 2025-05-21 07:37:39.718706 | Executor: 521e9411259a 2025-05-21 07:37:39.718727 | Triggered by: https://github.com/osism/cfg-cookiecutter/pull/745 2025-05-21 07:37:39.718749 | Event ID: 6cb447e0-3616-11f0-8857-eda2c46e5588 2025-05-21 07:37:39.724270 | 2025-05-21 07:37:39.724412 | LOOP [emit-job-header : Print node information] 2025-05-21 07:37:39.848812 | debian-bookworm | ok: 2025-05-21 07:37:39.849091 | debian-bookworm | # Node Information 2025-05-21 07:37:39.849127 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-05-21 07:37:39.849152 | debian-bookworm | Hostname: debian 2025-05-21 07:37:39.849174 | debian-bookworm | Username: zuul 2025-05-21 07:37:39.849195 | debian-bookworm | Distro: Debian 12.11 2025-05-21 07:37:39.849219 | debian-bookworm | Provider: regiocloud-a 2025-05-21 07:37:39.849240 | debian-bookworm | Region: 2025-05-21 07:37:39.849260 | debian-bookworm | Label: debian-bookworm 2025-05-21 07:37:39.849279 | debian-bookworm | Product Name: OpenStack Nova 2025-05-21 07:37:39.849299 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe54:3147 2025-05-21 07:37:39.875402 | 2025-05-21 07:37:39.875660 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-05-21 07:37:40.674574 | debian-bookworm -> localhost | changed 2025-05-21 07:37:40.682977 | 2025-05-21 07:37:40.683172 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-05-21 07:37:42.456651 | debian-bookworm -> localhost | changed 2025-05-21 07:37:42.487115 | 2025-05-21 07:37:42.487292 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-05-21 07:37:43.127050 | debian-bookworm -> localhost | ok 2025-05-21 07:37:43.133603 | 2025-05-21 07:37:43.133737 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-05-21 07:37:43.185113 | debian-bookworm | ok 2025-05-21 07:37:43.215947 | debian-bookworm | included: /var/lib/zuul/builds/8e5cf06e854e4a2fb5419aa3e50f5d90/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-05-21 07:37:43.234567 | 2025-05-21 07:37:43.234714 | TASK [add-build-sshkey : Create Temp SSH key] 2025-05-21 07:37:45.442187 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-05-21 07:37:45.442738 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/8e5cf06e854e4a2fb5419aa3e50f5d90/work/8e5cf06e854e4a2fb5419aa3e50f5d90_id_rsa 2025-05-21 07:37:45.442884 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/8e5cf06e854e4a2fb5419aa3e50f5d90/work/8e5cf06e854e4a2fb5419aa3e50f5d90_id_rsa.pub 2025-05-21 07:37:45.442959 | debian-bookworm -> localhost | The key fingerprint is: 2025-05-21 07:37:45.443022 | debian-bookworm -> localhost | SHA256:J3n5kp8l2o4mLd2DXYSaOq51Qb0MWtVAByeTtStm6dw zuul-build-sshkey 2025-05-21 07:37:45.443080 | debian-bookworm -> localhost | The key's randomart image is: 2025-05-21 07:37:45.443156 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-05-21 07:37:45.443214 | debian-bookworm -> localhost | | .B*+ | 2025-05-21 07:37:45.443271 | debian-bookworm -> localhost | | o.=.. | 2025-05-21 07:37:45.443324 | debian-bookworm -> localhost | | + ... | 2025-05-21 07:37:45.443375 | debian-bookworm -> localhost | | = +.o.. | 2025-05-21 07:37:45.443426 | debian-bookworm -> localhost | | S =oB.. | 2025-05-21 07:37:45.443540 | debian-bookworm -> localhost | | +oO o. | 2025-05-21 07:37:45.443604 | debian-bookworm -> localhost | | .+++=.E | 2025-05-21 07:37:45.443657 | debian-bookworm -> localhost | | .=.=*++ | 2025-05-21 07:37:45.443702 | debian-bookworm -> localhost | | .o.=o.=. | 2025-05-21 07:37:45.443745 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-05-21 07:37:45.443876 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.470181 2025-05-21 07:37:45.458644 | 2025-05-21 07:37:45.458821 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-05-21 07:37:45.501229 | debian-bookworm | ok 2025-05-21 07:37:45.525587 | debian-bookworm | included: /var/lib/zuul/builds/8e5cf06e854e4a2fb5419aa3e50f5d90/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-05-21 07:37:45.540048 | 2025-05-21 07:37:45.540174 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-05-21 07:37:45.568916 | debian-bookworm | skipping: Conditional result was False 2025-05-21 07:37:45.576785 | 2025-05-21 07:37:45.576928 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-05-21 07:37:46.380642 | debian-bookworm | changed 2025-05-21 07:37:46.388932 | 2025-05-21 07:37:46.389064 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-05-21 07:37:46.708408 | debian-bookworm | ok 2025-05-21 07:37:46.714408 | 2025-05-21 07:37:46.714544 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-05-21 07:37:47.444661 | debian-bookworm | changed 2025-05-21 07:37:47.459996 | 2025-05-21 07:37:47.460313 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-05-21 07:37:48.199025 | debian-bookworm | changed 2025-05-21 07:37:48.206090 | 2025-05-21 07:37:48.206230 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-05-21 07:37:48.237013 | debian-bookworm | skipping: Conditional result was False 2025-05-21 07:37:48.243618 | 2025-05-21 07:37:48.243752 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-05-21 07:37:49.058900 | debian-bookworm -> localhost | changed 2025-05-21 07:37:49.078234 | 2025-05-21 07:37:49.078378 | TASK [add-build-sshkey : Add back temp key] 2025-05-21 07:37:49.650263 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/8e5cf06e854e4a2fb5419aa3e50f5d90/work/8e5cf06e854e4a2fb5419aa3e50f5d90_id_rsa (zuul-build-sshkey) 2025-05-21 07:37:49.650583 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.020904 2025-05-21 07:37:49.659558 | 2025-05-21 07:37:49.659716 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-05-21 07:37:50.301377 | debian-bookworm | ok 2025-05-21 07:37:50.306697 | 2025-05-21 07:37:50.306814 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-05-21 07:37:50.330629 | debian-bookworm | skipping: Conditional result was False 2025-05-21 07:37:50.344798 | 2025-05-21 07:37:50.344927 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-05-21 07:37:50.822883 | debian-bookworm | ok 2025-05-21 07:37:50.835539 | 2025-05-21 07:37:50.835690 | TASK [validate-host : Define zuul_info_dir fact] 2025-05-21 07:37:50.887733 | debian-bookworm | ok 2025-05-21 07:37:50.893853 | 2025-05-21 07:37:50.893984 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-05-21 07:37:51.285657 | debian-bookworm -> localhost | ok 2025-05-21 07:37:51.292835 | 2025-05-21 07:37:51.292976 | TASK [validate-host : Collect information about the host] 2025-05-21 07:37:52.629943 | debian-bookworm | ok 2025-05-21 07:37:52.654922 | 2025-05-21 07:37:52.655117 | TASK [validate-host : Sanitize hostname] 2025-05-21 07:37:52.780288 | debian-bookworm | ok 2025-05-21 07:37:52.864682 | 2025-05-21 07:37:52.864844 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-05-21 07:37:53.800050 | debian-bookworm -> localhost | changed 2025-05-21 07:37:53.806247 | 2025-05-21 07:37:53.806368 | TASK [validate-host : Collect information about zuul worker] 2025-05-21 07:37:54.252150 | debian-bookworm | ok 2025-05-21 07:37:54.257211 | 2025-05-21 07:37:54.257332 | TASK [validate-host : Write out all zuul information for each host] 2025-05-21 07:37:54.947181 | debian-bookworm -> localhost | changed 2025-05-21 07:37:54.957541 | 2025-05-21 07:37:54.957676 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-05-21 07:37:55.275808 | debian-bookworm | ok 2025-05-21 07:37:55.290400 | 2025-05-21 07:37:55.290563 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-05-21 07:37:56.270297 | debian-bookworm | changed: 2025-05-21 07:37:56.270570 | debian-bookworm | cd+++++++++ src/ 2025-05-21 07:37:56.270619 | debian-bookworm | cd+++++++++ src/github.com/ 2025-05-21 07:37:56.270644 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-05-21 07:37:56.270699 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2025-05-21 07:37:56.270722 | debian-bookworm | Containerfile 2025-05-21 07:37:56.271190 | debian-bookworm | localhost | ok: Runtime: 0:00:00.013393 2025-05-21 07:38:24.011004 | 2025-05-21 07:38:24.011086 | TASK [upload-logs : Upload logs to log server] 2025-05-21 07:38:24.823702 | localhost | Output suppressed because no_log was given 2025-05-21 07:38:24.825205 | 2025-05-21 07:38:24.825285 | LOOP [upload-logs : Compress console log and json output] 2025-05-21 07:38:24.923146 | localhost | skipping: Conditional result was False 2025-05-21 07:38:24.933928 | localhost | skipping: Conditional result was False 2025-05-21 07:38:24.937143 | 2025-05-21 07:38:24.937256 | LOOP [upload-logs : Upload compressed console log and json output] 2025-05-21 07:38:25.032616 | localhost | skipping: Conditional result was False 2025-05-21 07:38:25.032841 | 2025-05-21 07:38:25.043373 | localhost | skipping: Conditional result was False 2025-05-21 07:38:25.058354 | 2025-05-21 07:38:25.058707 | LOOP [upload-logs : Upload console log and json output]