2025-11-01 11:14:30.629205 | Job console starting 2025-11-01 11:14:30.652559 | Updating git repos 2025-11-01 11:14:30.690442 | Cloning repos into workspace 2025-11-01 11:14:30.732066 | Restoring repo states 2025-11-01 11:14:30.746024 | Merging changes 2025-11-01 11:14:31.258456 | Checking out repos 2025-11-01 11:14:31.302373 | Preparing playbooks 2025-11-01 11:14:31.994435 | Running Ansible setup 2025-11-01 11:14:36.585465 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-01 11:14:37.332302 | 2025-11-01 11:14:37.332480 | PLAY [Base pre] 2025-11-01 11:14:37.357432 | 2025-11-01 11:14:37.357596 | TASK [Setup log path fact] 2025-11-01 11:14:37.377298 | debian-bookworm | ok 2025-11-01 11:14:37.392693 | 2025-11-01 11:14:37.392851 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-01 11:14:37.432478 | debian-bookworm | ok 2025-11-01 11:14:37.442295 | 2025-11-01 11:14:37.442415 | TASK [emit-job-header : Print job information] 2025-11-01 11:14:37.481057 | # Job Information 2025-11-01 11:14:37.481260 | Ansible Version: 2.16.14 2025-11-01 11:14:37.481296 | Job: python-black 2025-11-01 11:14:37.481329 | Pipeline: check 2025-11-01 11:14:37.481352 | Executor: 521e9411259a 2025-11-01 11:14:37.481373 | Triggered by: https://github.com/osism/testbed/pull/2781 2025-11-01 11:14:37.481395 | Event ID: eaab1e70-b713-11f0-9f9f-8975e4d765af 2025-11-01 11:14:37.486693 | 2025-11-01 11:14:37.486817 | LOOP [emit-job-header : Print node information] 2025-11-01 11:14:37.591348 | debian-bookworm | ok: 2025-11-01 11:14:37.591550 | debian-bookworm | # Node Information 2025-11-01 11:14:37.591586 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-01 11:14:37.591610 | debian-bookworm | Hostname: debian 2025-11-01 11:14:37.591633 | debian-bookworm | Username: zuul 2025-11-01 11:14:37.591667 | debian-bookworm | Distro: Debian 12.12 2025-11-01 11:14:37.591698 | debian-bookworm | Provider: regiocloud-a 2025-11-01 11:14:37.591725 | debian-bookworm | Region: 2025-11-01 11:14:37.591752 | debian-bookworm | Label: debian-bookworm 2025-11-01 11:14:37.591778 | debian-bookworm | Product Name: OpenStack Nova 2025-11-01 11:14:37.591804 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe81:c503 2025-11-01 11:14:37.613307 | 2025-11-01 11:14:37.613459 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-01 11:14:38.175451 | debian-bookworm -> localhost | changed 2025-11-01 11:14:38.182943 | 2025-11-01 11:14:38.183075 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-01 11:14:39.070619 | debian-bookworm -> localhost | changed 2025-11-01 11:14:39.080775 | 2025-11-01 11:14:39.080874 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-01 11:14:39.285769 | debian-bookworm -> localhost | ok 2025-11-01 11:14:39.295790 | 2025-11-01 11:14:39.295933 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-01 11:14:39.324902 | debian-bookworm | ok 2025-11-01 11:14:39.341297 | debian-bookworm | included: /var/lib/zuul/builds/4853ecfe7b6b49f99e271a19270c8ec9/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-01 11:14:39.347148 | 2025-11-01 11:14:39.347244 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-01 11:14:39.989453 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-01 11:14:39.989634 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/4853ecfe7b6b49f99e271a19270c8ec9/work/4853ecfe7b6b49f99e271a19270c8ec9_id_rsa 2025-11-01 11:14:39.989673 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/4853ecfe7b6b49f99e271a19270c8ec9/work/4853ecfe7b6b49f99e271a19270c8ec9_id_rsa.pub 2025-11-01 11:14:39.989701 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-01 11:14:39.989727 | debian-bookworm -> localhost | SHA256:Pzxd5lJtbTof2FbaAG1C/Q5EFmS/MqIa+WdVqUzGofU zuul-build-sshkey 2025-11-01 11:14:39.989750 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-01 11:14:39.989781 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-01 11:14:39.989804 | debian-bookworm -> localhost | | .+*. | 2025-11-01 11:14:39.989827 | debian-bookworm -> localhost | | . *o. | 2025-11-01 11:14:39.989848 | debian-bookworm -> localhost | | *.=.o| 2025-11-01 11:14:39.989869 | debian-bookworm -> localhost | | . B.E+| 2025-11-01 11:14:39.989889 | debian-bookworm -> localhost | | S .+oB+*| 2025-11-01 11:14:39.989913 | debian-bookworm -> localhost | | .o...O=Bo| 2025-11-01 11:14:39.989934 | debian-bookworm -> localhost | | o .= +.=+.| 2025-11-01 11:14:39.989963 | debian-bookworm -> localhost | | + = ..o.| 2025-11-01 11:14:39.989984 | debian-bookworm -> localhost | | . .o .| 2025-11-01 11:14:39.990006 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-01 11:14:39.990055 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.216794 2025-11-01 11:14:39.996278 | 2025-11-01 11:14:39.996364 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-01 11:14:40.013106 | debian-bookworm | ok 2025-11-01 11:14:40.022694 | debian-bookworm | included: /var/lib/zuul/builds/4853ecfe7b6b49f99e271a19270c8ec9/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-01 11:14:40.031093 | 2025-11-01 11:14:40.031171 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-01 11:14:40.043585 | debian-bookworm | skipping: Conditional result was False 2025-11-01 11:14:40.048888 | 2025-11-01 11:14:40.048968 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-01 11:14:40.804833 | debian-bookworm | changed 2025-11-01 11:14:40.809948 | 2025-11-01 11:14:40.810029 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-01 11:14:41.074345 | debian-bookworm | ok 2025-11-01 11:14:41.083527 | 2025-11-01 11:14:41.083656 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-01 11:14:41.808083 | debian-bookworm | changed 2025-11-01 11:14:41.817866 | 2025-11-01 11:14:41.817974 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-01 11:14:42.479562 | debian-bookworm | changed 2025-11-01 11:14:42.484886 | 2025-11-01 11:14:42.484977 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-01 11:14:42.498013 | debian-bookworm | skipping: Conditional result was False 2025-11-01 11:14:42.504282 | 2025-11-01 11:14:42.504388 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-01 11:14:42.887312 | debian-bookworm -> localhost | changed 2025-11-01 11:14:42.903080 | 2025-11-01 11:14:42.903217 | TASK [add-build-sshkey : Add back temp key] 2025-11-01 11:14:43.220166 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/4853ecfe7b6b49f99e271a19270c8ec9/work/4853ecfe7b6b49f99e271a19270c8ec9_id_rsa (zuul-build-sshkey) 2025-11-01 11:14:43.220400 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.024956 2025-11-01 11:14:43.227594 | 2025-11-01 11:14:43.227684 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-01 11:14:43.655467 | debian-bookworm | ok 2025-11-01 11:14:43.660269 | 2025-11-01 11:14:43.660359 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-01 11:14:43.683275 | debian-bookworm | skipping: Conditional result was False 2025-11-01 11:14:43.693803 | 2025-11-01 11:14:43.693898 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-01 11:14:44.105831 | debian-bookworm | ok 2025-11-01 11:14:44.117020 | 2025-11-01 11:14:44.117155 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-01 11:14:44.156642 | debian-bookworm | ok 2025-11-01 11:14:44.162254 | 2025-11-01 11:14:44.162362 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-01 11:14:44.449506 | debian-bookworm -> localhost | ok 2025-11-01 11:14:44.456249 | 2025-11-01 11:14:44.456363 | TASK [validate-host : Collect information about the host] 2025-11-01 11:14:45.642362 | debian-bookworm | ok 2025-11-01 11:14:45.656662 | 2025-11-01 11:14:45.656790 | TASK [validate-host : Sanitize hostname] 2025-11-01 11:14:45.765387 | debian-bookworm | ok 2025-11-01 11:14:45.807172 | 2025-11-01 11:14:45.807332 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-01 11:14:46.417785 | debian-bookworm -> localhost | changed 2025-11-01 11:14:46.423939 | 2025-11-01 11:14:46.424055 | TASK [validate-host : Collect information about zuul worker] 2025-11-01 11:14:46.827920 | debian-bookworm | ok 2025-11-01 11:14:46.832831 | 2025-11-01 11:14:46.832947 | TASK [validate-host : Write out all zuul information for each host] 2025-11-01 11:14:47.349791 | debian-bookworm -> localhost | changed 2025-11-01 11:14:47.359595 | 2025-11-01 11:14:47.359711 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-01 11:14:47.654566 | debian-bookworm | ok 2025-11-01 11:14:47.660429 | 2025-11-01 11:14:47.660547 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-01 11:14:48.849294 | debian-bookworm | changed: 2025-11-01 11:14:48.849508 | debian-bookworm | cd+++++++++ src/ 2025-11-01 11:14:48.849551 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-01 11:14:48.849575 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-01 11:14:48.849597 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2025-11-01 11:14:48.849618 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007086 2025-11-01 11:15:14.982231 | 2025-11-01 11:15:14.982354 | TASK [upload-logs : Upload logs to log server] 2025-11-01 11:15:15.538005 | localhost | Output suppressed because no_log was given 2025-11-01 11:15:15.540230 | 2025-11-01 11:15:15.540356 | LOOP [upload-logs : Compress console log and json output] 2025-11-01 11:15:15.599572 | localhost | skipping: Conditional result was False 2025-11-01 11:15:15.610494 | localhost | skipping: Conditional result was False 2025-11-01 11:15:15.622421 | 2025-11-01 11:15:15.622593 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-01 11:15:15.675163 | localhost | skipping: Conditional result was False 2025-11-01 11:15:15.675432 | 2025-11-01 11:15:15.680251 | localhost | skipping: Conditional result was False 2025-11-01 11:15:15.691093 | 2025-11-01 11:15:15.691289 | LOOP [upload-logs : Upload console log and json output]