2025-11-01 23:01:15.104599 | Job console starting 2025-11-01 23:01:15.112608 | Updating git repos 2025-11-01 23:01:15.146970 | Cloning repos into workspace 2025-11-01 23:01:15.183252 | Restoring repo states 2025-11-01 23:01:15.203763 | Merging changes 2025-11-01 23:01:15.703254 | Checking out repos 2025-11-01 23:01:15.776958 | Preparing playbooks 2025-11-01 23:01:16.549301 | Running Ansible setup 2025-11-01 23:01:20.642908 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-01 23:01:21.568594 | 2025-11-01 23:01:21.568715 | PLAY [Base pre] 2025-11-01 23:01:21.597313 | 2025-11-01 23:01:21.597437 | TASK [Setup log path fact] 2025-11-01 23:01:21.615278 | debian-bookworm | ok 2025-11-01 23:01:21.629551 | 2025-11-01 23:01:21.629666 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-01 23:01:21.658122 | debian-bookworm | ok 2025-11-01 23:01:21.670199 | 2025-11-01 23:01:21.670300 | TASK [emit-job-header : Print job information] 2025-11-01 23:01:21.709469 | # Job Information 2025-11-01 23:01:21.709626 | Ansible Version: 2.16.14 2025-11-01 23:01:21.709661 | Job: python-black 2025-11-01 23:01:21.709695 | Pipeline: check 2025-11-01 23:01:21.709719 | Executor: 521e9411259a 2025-11-01 23:01:21.709741 | Triggered by: https://github.com/osism/python-osism/pull/1786 2025-11-01 23:01:21.709764 | Event ID: 7ed975d0-b776-11f0-942a-8895db1ae85f 2025-11-01 23:01:21.715210 | 2025-11-01 23:01:21.715316 | LOOP [emit-job-header : Print node information] 2025-11-01 23:01:21.830044 | debian-bookworm | ok: 2025-11-01 23:01:21.830247 | debian-bookworm | # Node Information 2025-11-01 23:01:21.830284 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-01 23:01:21.830309 | debian-bookworm | Hostname: debian 2025-11-01 23:01:21.830332 | debian-bookworm | Username: zuul 2025-11-01 23:01:21.830353 | debian-bookworm | Distro: Debian 12.12 2025-11-01 23:01:21.830378 | debian-bookworm | Provider: regiocloud-a 2025-11-01 23:01:21.830399 | debian-bookworm | Region: 2025-11-01 23:01:21.830420 | debian-bookworm | Label: debian-bookworm 2025-11-01 23:01:21.830441 | debian-bookworm | Product Name: OpenStack Nova 2025-11-01 23:01:21.830460 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe50:dab9 2025-11-01 23:01:21.849934 | 2025-11-01 23:01:21.850030 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-01 23:01:22.277440 | debian-bookworm -> localhost | changed 2025-11-01 23:01:22.284115 | 2025-11-01 23:01:22.284260 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-01 23:01:23.451929 | debian-bookworm -> localhost | changed 2025-11-01 23:01:23.472453 | 2025-11-01 23:01:23.472560 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-01 23:01:23.751352 | debian-bookworm -> localhost | ok 2025-11-01 23:01:23.761231 | 2025-11-01 23:01:23.761378 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-01 23:01:23.798641 | debian-bookworm | ok 2025-11-01 23:01:23.854241 | debian-bookworm | included: /var/lib/zuul/builds/aac56681ecd946639f3c37f4f939154d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-01 23:01:23.869711 | 2025-11-01 23:01:23.869852 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-01 23:01:26.434868 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-01 23:01:26.435066 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/aac56681ecd946639f3c37f4f939154d/work/aac56681ecd946639f3c37f4f939154d_id_rsa 2025-11-01 23:01:26.435101 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/aac56681ecd946639f3c37f4f939154d/work/aac56681ecd946639f3c37f4f939154d_id_rsa.pub 2025-11-01 23:01:26.435123 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-01 23:01:26.435142 | debian-bookworm -> localhost | SHA256:vANWkREX+osZkWXWNIqMv9PbVHFaOWuah7pwmPoy2es zuul-build-sshkey 2025-11-01 23:01:26.435160 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-01 23:01:26.435209 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-01 23:01:26.435228 | debian-bookworm -> localhost | | ++*+o | 2025-11-01 23:01:26.435246 | debian-bookworm -> localhost | | o.X ... .| 2025-11-01 23:01:26.435263 | debian-bookworm -> localhost | | . B . .oo| 2025-11-01 23:01:26.435279 | debian-bookworm -> localhost | | + o =o| 2025-11-01 23:01:26.435295 | debian-bookworm -> localhost | | o S . oo | 2025-11-01 23:01:26.435317 | debian-bookworm -> localhost | | . . Bo. .= | 2025-11-01 23:01:26.435336 | debian-bookworm -> localhost | | X+o..+ . | 2025-11-01 23:01:26.435352 | debian-bookworm -> localhost | | +.+o+. . | 2025-11-01 23:01:26.435369 | debian-bookworm -> localhost | | .=Eooo | 2025-11-01 23:01:26.435385 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-01 23:01:26.435431 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.995671 2025-11-01 23:01:26.440542 | 2025-11-01 23:01:26.440624 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-01 23:01:26.466795 | debian-bookworm | ok 2025-11-01 23:01:26.474412 | debian-bookworm | included: /var/lib/zuul/builds/aac56681ecd946639f3c37f4f939154d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-01 23:01:26.482059 | 2025-11-01 23:01:26.482131 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-01 23:01:26.494813 | debian-bookworm | skipping: Conditional result was False 2025-11-01 23:01:26.499784 | 2025-11-01 23:01:26.499862 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-01 23:01:27.193035 | debian-bookworm | changed 2025-11-01 23:01:27.197657 | 2025-11-01 23:01:27.197741 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-01 23:01:27.445347 | debian-bookworm | ok 2025-11-01 23:01:27.462666 | 2025-11-01 23:01:27.462775 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-01 23:01:28.157323 | debian-bookworm | changed 2025-11-01 23:01:28.163755 | 2025-11-01 23:01:28.163855 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-01 23:01:28.914110 | debian-bookworm | changed 2025-11-01 23:01:28.922163 | 2025-11-01 23:01:28.922348 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-01 23:01:28.946050 | debian-bookworm | skipping: Conditional result was False 2025-11-01 23:01:28.952566 | 2025-11-01 23:01:28.952655 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-01 23:01:29.470664 | debian-bookworm -> localhost | changed 2025-11-01 23:01:29.479647 | 2025-11-01 23:01:29.479734 | TASK [add-build-sshkey : Add back temp key] 2025-11-01 23:01:29.847594 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/aac56681ecd946639f3c37f4f939154d/work/aac56681ecd946639f3c37f4f939154d_id_rsa (zuul-build-sshkey) 2025-11-01 23:01:29.847800 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.020804 2025-11-01 23:01:29.856029 | 2025-11-01 23:01:29.856122 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-01 23:01:30.276336 | debian-bookworm | ok 2025-11-01 23:01:30.283215 | 2025-11-01 23:01:30.283323 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-01 23:01:30.306870 | debian-bookworm | skipping: Conditional result was False 2025-11-01 23:01:30.326452 | 2025-11-01 23:01:30.326565 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-01 23:01:30.735466 | debian-bookworm | ok 2025-11-01 23:01:30.755497 | 2025-11-01 23:01:30.755602 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-01 23:01:30.782599 | debian-bookworm | ok 2025-11-01 23:01:30.786566 | 2025-11-01 23:01:30.786637 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-01 23:01:31.193625 | debian-bookworm -> localhost | ok 2025-11-01 23:01:31.213541 | 2025-11-01 23:01:31.213645 | TASK [validate-host : Collect information about the host] 2025-11-01 23:01:32.260511 | debian-bookworm | ok 2025-11-01 23:01:32.270231 | 2025-11-01 23:01:32.270320 | TASK [validate-host : Sanitize hostname] 2025-11-01 23:01:32.359580 | debian-bookworm | ok 2025-11-01 23:01:32.387764 | 2025-11-01 23:01:32.387863 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-01 23:01:32.875105 | debian-bookworm -> localhost | changed 2025-11-01 23:01:32.880431 | 2025-11-01 23:01:32.880531 | TASK [validate-host : Collect information about zuul worker] 2025-11-01 23:01:33.253182 | debian-bookworm | ok 2025-11-01 23:01:33.258943 | 2025-11-01 23:01:33.259047 | TASK [validate-host : Write out all zuul information for each host] 2025-11-01 23:01:33.760849 | debian-bookworm -> localhost | changed 2025-11-01 23:01:33.777580 | 2025-11-01 23:01:33.777698 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-01 23:01:34.045551 | debian-bookworm | ok 2025-11-01 23:01:34.055521 | 2025-11-01 23:01:34.055665 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-01 23:01:34.984803 | debian-bookworm | changed: 2025-11-01 23:01:34.985663 | debian-bookworm | cd+++++++++ src/ 2025-11-01 23:01:34.985769 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-01 23:01:34.985816 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-01 23:01:34.985855 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-11-01 23:01:34.985893 | debian-bookworm | Containerfile 2025-11-01 23:01:34.986094 | debian-bookworm | Containerfile 2025-11-01 23:01:34.990954 | debian-bookworm | localhost | ok: Runtime: 0:00:00.022368 2025-11-01 23:02:01.972022 | 2025-11-01 23:02:01.972115 | TASK [upload-logs : Upload logs to log server] 2025-11-01 23:02:02.571120 | localhost | Output suppressed because no_log was given 2025-11-01 23:02:02.574448 | 2025-11-01 23:02:02.574609 | LOOP [upload-logs : Compress console log and json output] 2025-11-01 23:02:02.647451 | localhost | skipping: Conditional result was False 2025-11-01 23:02:02.654634 | localhost | skipping: Conditional result was False 2025-11-01 23:02:02.660947 | 2025-11-01 23:02:02.661031 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-01 23:02:02.694476 | localhost | skipping: Conditional result was False 2025-11-01 23:02:02.694678 | 2025-11-01 23:02:02.699671 | localhost | skipping: Conditional result was False 2025-11-01 23:02:02.707638 | 2025-11-01 23:02:02.707717 | LOOP [upload-logs : Upload console log and json output]