2025-06-26 09:55:07.057238 | Job console starting 2025-06-26 09:55:07.105875 | Updating git repos 2025-06-26 09:55:07.187012 | Cloning repos into workspace 2025-06-26 09:55:07.232796 | Restoring repo states 2025-06-26 09:55:07.255369 | Merging changes 2025-06-26 09:55:07.861536 | Checking out repos 2025-06-26 09:55:07.981912 | Preparing playbooks 2025-06-26 09:55:08.881030 | Running Ansible setup 2025-06-26 09:55:14.335773 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-06-26 09:55:15.432615 | 2025-06-26 09:55:15.432789 | PLAY [Base pre] 2025-06-26 09:55:15.478189 | 2025-06-26 09:55:15.478345 | TASK [Setup log path fact] 2025-06-26 09:55:15.508487 | debian-bookworm | ok 2025-06-26 09:55:15.529210 | 2025-06-26 09:55:15.529378 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-06-26 09:55:15.560466 | debian-bookworm | ok 2025-06-26 09:55:15.572403 | 2025-06-26 09:55:15.572538 | TASK [emit-job-header : Print job information] 2025-06-26 09:55:15.612490 | # Job Information 2025-06-26 09:55:15.612682 | Ansible Version: 2.16.14 2025-06-26 09:55:15.612717 | Job: python-black 2025-06-26 09:55:15.612748 | Pipeline: check 2025-06-26 09:55:15.612770 | Executor: 521e9411259a 2025-06-26 09:55:15.612790 | Triggered by: https://github.com/osism/ansible-collection-services/pull/1923 2025-06-26 09:55:15.612811 | Event ID: 9ea00810-5273-11f0-9541-caf12ada19f4 2025-06-26 09:55:15.617741 | 2025-06-26 09:55:15.617857 | LOOP [emit-job-header : Print node information] 2025-06-26 09:55:15.745424 | debian-bookworm | ok: 2025-06-26 09:55:15.745629 | debian-bookworm | # Node Information 2025-06-26 09:55:15.745663 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-06-26 09:55:15.745689 | debian-bookworm | Hostname: debian 2025-06-26 09:55:15.745710 | debian-bookworm | Username: zuul 2025-06-26 09:55:15.745730 | debian-bookworm | Distro: Debian 12.11 2025-06-26 09:55:15.745754 | debian-bookworm | Provider: regiocloud-a 2025-06-26 09:55:15.745774 | debian-bookworm | Region: 2025-06-26 09:55:15.745795 | debian-bookworm | Label: debian-bookworm 2025-06-26 09:55:15.745814 | debian-bookworm | Product Name: OpenStack Nova 2025-06-26 09:55:15.745834 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe03:397e 2025-06-26 09:55:15.764757 | 2025-06-26 09:55:15.764903 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-06-26 09:55:16.565808 | debian-bookworm -> localhost | changed 2025-06-26 09:55:16.574010 | 2025-06-26 09:55:16.574149 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-06-26 09:55:18.178663 | debian-bookworm -> localhost | changed 2025-06-26 09:55:18.192919 | 2025-06-26 09:55:18.193129 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-06-26 09:55:18.615786 | debian-bookworm -> localhost | ok 2025-06-26 09:55:18.636476 | 2025-06-26 09:55:18.636639 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-06-26 09:55:18.665735 | debian-bookworm | ok 2025-06-26 09:55:18.707142 | debian-bookworm | included: /var/lib/zuul/builds/86d761ce07ea41e786129804d3f34d20/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-06-26 09:55:18.720239 | 2025-06-26 09:55:18.720362 | TASK [add-build-sshkey : Create Temp SSH key] 2025-06-26 09:55:22.098037 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-06-26 09:55:22.098461 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/86d761ce07ea41e786129804d3f34d20/work/86d761ce07ea41e786129804d3f34d20_id_rsa 2025-06-26 09:55:22.098539 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/86d761ce07ea41e786129804d3f34d20/work/86d761ce07ea41e786129804d3f34d20_id_rsa.pub 2025-06-26 09:55:22.098606 | debian-bookworm -> localhost | The key fingerprint is: 2025-06-26 09:55:22.098669 | debian-bookworm -> localhost | SHA256:tV/x1umtwDKI9TCJ6cF7gjnUO0DtaJuq/k8NlUfa9e4 zuul-build-sshkey 2025-06-26 09:55:22.098710 | debian-bookworm -> localhost | The key's randomart image is: 2025-06-26 09:55:22.098764 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-06-26 09:55:22.098804 | debian-bookworm -> localhost | | . . | 2025-06-26 09:55:22.098870 | debian-bookworm -> localhost | | . = . . | 2025-06-26 09:55:22.098909 | debian-bookworm -> localhost | | . .+ o. .. | 2025-06-26 09:55:22.098944 | debian-bookworm -> localhost | | . =.o.o .. oo| 2025-06-26 09:55:22.098997 | debian-bookworm -> localhost | | =.B S . ...+| 2025-06-26 09:55:22.099046 | debian-bookworm -> localhost | | o Bo* = o.....| 2025-06-26 09:55:22.099086 | debian-bookworm -> localhost | | *.B.o + +E ..| 2025-06-26 09:55:22.099122 | debian-bookworm -> localhost | | ... + o . . | 2025-06-26 09:55:22.099158 | debian-bookworm -> localhost | |ooo... . | 2025-06-26 09:55:22.099194 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-06-26 09:55:22.099288 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.524434 2025-06-26 09:55:22.116087 | 2025-06-26 09:55:22.116282 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-06-26 09:55:22.165376 | debian-bookworm | ok 2025-06-26 09:55:22.181613 | debian-bookworm | included: /var/lib/zuul/builds/86d761ce07ea41e786129804d3f34d20/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-06-26 09:55:22.193451 | 2025-06-26 09:55:22.193589 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-06-26 09:55:22.229648 | debian-bookworm | skipping: Conditional result was False 2025-06-26 09:55:22.236155 | 2025-06-26 09:55:22.236283 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-06-26 09:55:22.926001 | debian-bookworm | changed 2025-06-26 09:55:22.931965 | 2025-06-26 09:55:22.932105 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-06-26 09:55:23.195722 | debian-bookworm | ok 2025-06-26 09:55:23.202420 | 2025-06-26 09:55:23.202545 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-06-26 09:55:23.867926 | debian-bookworm | changed 2025-06-26 09:55:23.890604 | 2025-06-26 09:55:23.891199 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-06-26 09:55:24.631524 | debian-bookworm | changed 2025-06-26 09:55:24.648148 | 2025-06-26 09:55:24.648302 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-06-26 09:55:24.716263 | debian-bookworm | skipping: Conditional result was False 2025-06-26 09:55:24.723747 | 2025-06-26 09:55:24.723871 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-06-26 09:55:25.429928 | debian-bookworm -> localhost | changed 2025-06-26 09:55:25.444292 | 2025-06-26 09:55:25.444439 | TASK [add-build-sshkey : Add back temp key] 2025-06-26 09:55:26.222226 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/86d761ce07ea41e786129804d3f34d20/work/86d761ce07ea41e786129804d3f34d20_id_rsa (zuul-build-sshkey) 2025-06-26 09:55:26.223523 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.016924 2025-06-26 09:55:26.278822 | 2025-06-26 09:55:26.280636 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-06-26 09:55:26.798757 | debian-bookworm | ok 2025-06-26 09:55:26.808911 | 2025-06-26 09:55:26.809176 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-06-26 09:55:26.942165 | debian-bookworm | skipping: Conditional result was False 2025-06-26 09:55:26.973800 | 2025-06-26 09:55:26.974157 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-06-26 09:55:27.828839 | debian-bookworm | ok 2025-06-26 09:55:27.844104 | 2025-06-26 09:55:27.844241 | TASK [validate-host : Define zuul_info_dir fact] 2025-06-26 09:55:27.877311 | debian-bookworm | ok 2025-06-26 09:55:27.883442 | 2025-06-26 09:55:27.883608 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-06-26 09:55:28.481425 | debian-bookworm -> localhost | ok 2025-06-26 09:55:28.488621 | 2025-06-26 09:55:28.488737 | TASK [validate-host : Collect information about the host] 2025-06-26 09:55:29.982052 | debian-bookworm | ok 2025-06-26 09:55:29.993848 | 2025-06-26 09:55:29.994019 | TASK [validate-host : Sanitize hostname] 2025-06-26 09:55:30.285377 | debian-bookworm | ok 2025-06-26 09:55:30.453855 | 2025-06-26 09:55:30.454101 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-06-26 09:55:31.749245 | debian-bookworm -> localhost | changed 2025-06-26 09:55:31.755821 | 2025-06-26 09:55:31.755951 | TASK [validate-host : Collect information about zuul worker] 2025-06-26 09:55:32.286599 | debian-bookworm | ok 2025-06-26 09:55:32.292884 | 2025-06-26 09:55:32.293081 | TASK [validate-host : Write out all zuul information for each host] 2025-06-26 09:55:33.562285 | debian-bookworm -> localhost | changed 2025-06-26 09:55:33.652079 | 2025-06-26 09:55:33.652245 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-06-26 09:55:33.972956 | debian-bookworm | ok 2025-06-26 09:55:33.982426 | 2025-06-26 09:55:33.982676 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-06-26 09:55:35.495695 | debian-bookworm | changed: 2025-06-26 09:55:35.495913 | debian-bookworm | cd+++++++++ src/ 2025-06-26 09:55:35.495952 | debian-bookworm | cd+++++++++ src/github.com/ 2025-06-26 09:55:35.496103 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-06-26 09:55:35.496133 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2025-06-26 09:55:35.496154 | debian-bookworm | localhost | ok: Runtime: 0:00:00.008306 2025-06-26 09:56:00.871538 | 2025-06-26 09:56:00.871812 | TASK [upload-logs : Upload logs to log server] 2025-06-26 09:56:01.470722 | localhost | Output suppressed because no_log was given 2025-06-26 09:56:01.472620 | 2025-06-26 09:56:01.472729 | LOOP [upload-logs : Compress console log and json output] 2025-06-26 09:56:01.526069 | localhost | skipping: Conditional result was False 2025-06-26 09:56:01.532631 | localhost | skipping: Conditional result was False 2025-06-26 09:56:01.544404 | 2025-06-26 09:56:01.544665 | LOOP [upload-logs : Upload compressed console log and json output] 2025-06-26 09:56:01.593791 | localhost | skipping: Conditional result was False 2025-06-26 09:56:01.594109 | 2025-06-26 09:56:01.601068 | localhost | skipping: Conditional result was False 2025-06-26 09:56:01.608629 | 2025-06-26 09:56:01.608853 | LOOP [upload-logs : Upload console log and json output]