2025-10-06 09:53:37.569140 | Job console starting 2025-10-06 09:53:37.578702 | Updating git repos 2025-10-06 09:53:37.628817 | Cloning repos into workspace 2025-10-06 09:53:37.691326 | Restoring repo states 2025-10-06 09:53:37.717691 | Merging changes 2025-10-06 09:53:38.313628 | Checking out repos 2025-10-06 09:53:38.397465 | Preparing playbooks 2025-10-06 09:53:39.390227 | Running Ansible setup 2025-10-06 09:53:45.289931 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-06 09:53:46.444127 | 2025-10-06 09:53:46.444287 | PLAY [Base pre] 2025-10-06 09:53:46.460713 | 2025-10-06 09:53:46.460851 | TASK [Setup log path fact] 2025-10-06 09:53:46.513356 | debian-bookworm | ok 2025-10-06 09:53:46.528985 | 2025-10-06 09:53:46.529142 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-06 09:53:46.561114 | debian-bookworm | ok 2025-10-06 09:53:46.582189 | 2025-10-06 09:53:46.582318 | TASK [emit-job-header : Print job information] 2025-10-06 09:53:46.622393 | # Job Information 2025-10-06 09:53:46.622578 | Ansible Version: 2.16.14 2025-10-06 09:53:46.622647 | Job: python-black 2025-10-06 09:53:46.622681 | Pipeline: check 2025-10-06 09:53:46.622704 | Executor: 521e9411259a 2025-10-06 09:53:46.622725 | Triggered by: https://github.com/osism/ansible-collection-services/pull/1782 2025-10-06 09:53:46.622749 | Event ID: 4e78faa0-a29a-11f0-98fb-f6eefeb8630d 2025-10-06 09:53:46.627688 | 2025-10-06 09:53:46.627800 | LOOP [emit-job-header : Print node information] 2025-10-06 09:53:46.737891 | debian-bookworm | ok: 2025-10-06 09:53:46.738091 | debian-bookworm | # Node Information 2025-10-06 09:53:46.738128 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-06 09:53:46.738154 | debian-bookworm | Hostname: debian 2025-10-06 09:53:46.738177 | debian-bookworm | Username: zuul 2025-10-06 09:53:46.738198 | debian-bookworm | Distro: Debian 12.12 2025-10-06 09:53:46.738223 | debian-bookworm | Provider: regiocloud-a 2025-10-06 09:53:46.738245 | debian-bookworm | Region: 2025-10-06 09:53:46.738266 | debian-bookworm | Label: debian-bookworm 2025-10-06 09:53:46.738285 | debian-bookworm | Product Name: OpenStack Nova 2025-10-06 09:53:46.738304 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe0d:9724 2025-10-06 09:53:46.757333 | 2025-10-06 09:53:46.757475 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-06 09:53:47.310223 | debian-bookworm -> localhost | changed 2025-10-06 09:53:47.316914 | 2025-10-06 09:53:47.317019 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-06 09:53:48.388433 | debian-bookworm -> localhost | changed 2025-10-06 09:53:48.398521 | 2025-10-06 09:53:48.398629 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-06 09:53:48.820196 | debian-bookworm -> localhost | ok 2025-10-06 09:53:48.826025 | 2025-10-06 09:53:48.826131 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-06 09:53:48.864220 | debian-bookworm | ok 2025-10-06 09:53:48.880315 | debian-bookworm | included: /var/lib/zuul/builds/2056500df9b24303a3b2e5496c5e4da2/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-06 09:53:48.887290 | 2025-10-06 09:53:48.887383 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-06 09:53:51.642355 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-06 09:53:51.642544 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/2056500df9b24303a3b2e5496c5e4da2/work/2056500df9b24303a3b2e5496c5e4da2_id_rsa 2025-10-06 09:53:51.642584 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/2056500df9b24303a3b2e5496c5e4da2/work/2056500df9b24303a3b2e5496c5e4da2_id_rsa.pub 2025-10-06 09:53:51.642623 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-06 09:53:51.642649 | debian-bookworm -> localhost | SHA256:HNnOjHh2huEhvX+hcpBupcBOIgW2Kwng6ud1KIDSgAs zuul-build-sshkey 2025-10-06 09:53:51.642672 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-06 09:53:51.642700 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-06 09:53:51.642721 | debian-bookworm -> localhost | |. o | 2025-10-06 09:53:51.642742 | debian-bookworm -> localhost | |+. o . o | 2025-10-06 09:53:51.642762 | debian-bookworm -> localhost | |E.. . . * . | 2025-10-06 09:53:51.642782 | debian-bookworm -> localhost | |== o . = % | 2025-10-06 09:53:51.642802 | debian-bookworm -> localhost | |B.+ . = S B . | 2025-10-06 09:53:51.642826 | debian-bookworm -> localhost | |o... +.= B . . | 2025-10-06 09:53:51.642864 | debian-bookworm -> localhost | | . o o..= + . | 2025-10-06 09:53:51.642884 | debian-bookworm -> localhost | | o o .. o . | 2025-10-06 09:53:51.642906 | debian-bookworm -> localhost | | . | 2025-10-06 09:53:51.642926 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-06 09:53:51.642979 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.852190 2025-10-06 09:53:51.649171 | 2025-10-06 09:53:51.649429 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-06 09:53:51.677798 | debian-bookworm | ok 2025-10-06 09:53:51.701228 | debian-bookworm | included: /var/lib/zuul/builds/2056500df9b24303a3b2e5496c5e4da2/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-06 09:53:51.715865 | 2025-10-06 09:53:51.715968 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-06 09:53:51.739398 | debian-bookworm | skipping: Conditional result was False 2025-10-06 09:53:51.746228 | 2025-10-06 09:53:51.746342 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-06 09:53:52.383834 | debian-bookworm | changed 2025-10-06 09:53:52.388121 | 2025-10-06 09:53:52.388196 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-06 09:53:52.619191 | debian-bookworm | ok 2025-10-06 09:53:52.624352 | 2025-10-06 09:53:52.624436 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-06 09:53:53.288558 | debian-bookworm | changed 2025-10-06 09:53:53.295012 | 2025-10-06 09:53:53.295100 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-06 09:53:53.969593 | debian-bookworm | changed 2025-10-06 09:53:53.974915 | 2025-10-06 09:53:53.975004 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-06 09:53:53.998004 | debian-bookworm | skipping: Conditional result was False 2025-10-06 09:53:54.003819 | 2025-10-06 09:53:54.003911 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-06 09:53:54.534050 | debian-bookworm -> localhost | changed 2025-10-06 09:53:54.544469 | 2025-10-06 09:53:54.544565 | TASK [add-build-sshkey : Add back temp key] 2025-10-06 09:53:54.864051 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/2056500df9b24303a3b2e5496c5e4da2/work/2056500df9b24303a3b2e5496c5e4da2_id_rsa (zuul-build-sshkey) 2025-10-06 09:53:54.864258 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.019926 2025-10-06 09:53:54.872028 | 2025-10-06 09:53:54.872161 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-06 09:53:55.267894 | debian-bookworm | ok 2025-10-06 09:53:55.273524 | 2025-10-06 09:53:55.273642 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-06 09:53:55.296362 | debian-bookworm | skipping: Conditional result was False 2025-10-06 09:53:55.306946 | 2025-10-06 09:53:55.307024 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-06 09:53:55.736831 | debian-bookworm | ok 2025-10-06 09:53:55.745612 | 2025-10-06 09:53:55.745693 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-06 09:53:55.772064 | debian-bookworm | ok 2025-10-06 09:53:55.776005 | 2025-10-06 09:53:55.776077 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-06 09:53:56.142345 | debian-bookworm -> localhost | ok 2025-10-06 09:53:56.148387 | 2025-10-06 09:53:56.148474 | TASK [validate-host : Collect information about the host] 2025-10-06 09:53:57.235045 | debian-bookworm | ok 2025-10-06 09:53:57.247005 | 2025-10-06 09:53:57.247107 | TASK [validate-host : Sanitize hostname] 2025-10-06 09:53:57.325689 | debian-bookworm | ok 2025-10-06 09:53:57.357843 | 2025-10-06 09:53:57.357948 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-06 09:53:57.984256 | debian-bookworm -> localhost | changed 2025-10-06 09:53:57.989534 | 2025-10-06 09:53:57.989641 | TASK [validate-host : Collect information about zuul worker] 2025-10-06 09:53:58.426169 | debian-bookworm | ok 2025-10-06 09:53:58.433778 | 2025-10-06 09:53:58.433904 | TASK [validate-host : Write out all zuul information for each host] 2025-10-06 09:53:59.063485 | debian-bookworm -> localhost | changed 2025-10-06 09:53:59.072306 | 2025-10-06 09:53:59.072399 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-06 09:53:59.388680 | debian-bookworm | ok 2025-10-06 09:53:59.393957 | 2025-10-06 09:53:59.394041 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-06 09:54:00.611941 | debian-bookworm | changed: 2025-10-06 09:54:00.612189 | debian-bookworm | cd+++++++++ src/ 2025-10-06 09:54:00.612227 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-06 09:54:00.612250 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-06 09:54:00.612272 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2025-10-06 09:54:00.612291 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006714 2025-10-06 09:54:26.539450 | 2025-10-06 09:54:26.539573 | TASK [upload-logs : Upload logs to log server] 2025-10-06 09:54:27.115952 | localhost | Output suppressed because no_log was given 2025-10-06 09:54:27.119653 | 2025-10-06 09:54:27.119826 | LOOP [upload-logs : Compress console log and json output] 2025-10-06 09:54:27.179021 | localhost | skipping: Conditional result was False 2025-10-06 09:54:27.184686 | localhost | skipping: Conditional result was False 2025-10-06 09:54:27.188269 | 2025-10-06 09:54:27.188376 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-06 09:54:27.250871 | localhost | skipping: Conditional result was False 2025-10-06 09:54:27.251161 | 2025-10-06 09:54:27.257147 | localhost | skipping: Conditional result was False 2025-10-06 09:54:27.264794 | 2025-10-06 09:54:27.264912 | LOOP [upload-logs : Upload console log and json output]