2025-12-09 03:07:26.563840 | Job console starting 2025-12-09 03:07:26.586699 | Updating git repos 2025-12-09 03:07:26.627904 | Cloning repos into workspace 2025-12-09 03:07:26.729347 | Restoring repo states 2025-12-09 03:07:26.736108 | Merging changes 2025-12-09 03:07:26.736127 | Checking out repos 2025-12-09 03:07:26.798667 | Preparing playbooks 2025-12-09 03:07:28.096329 | Running Ansible setup 2025-12-09 03:07:34.334516 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-09 03:07:36.081519 | 2025-12-09 03:07:36.081718 | PLAY [Base pre] 2025-12-09 03:07:36.108650 | 2025-12-09 03:07:36.108816 | TASK [Setup log path fact] 2025-12-09 03:07:36.155629 | debian-bookworm | ok 2025-12-09 03:07:36.185881 | 2025-12-09 03:07:36.186150 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-09 03:07:36.219678 | debian-bookworm | ok 2025-12-09 03:07:36.237527 | 2025-12-09 03:07:36.237689 | TASK [emit-job-header : Print job information] 2025-12-09 03:07:36.301203 | # Job Information 2025-12-09 03:07:36.301431 | Ansible Version: 2.16.14 2025-12-09 03:07:36.301485 | Job: python-black 2025-12-09 03:07:36.301533 | Pipeline: periodic-daily 2025-12-09 03:07:36.301560 | Executor: 521e9411259a 2025-12-09 03:07:36.301582 | Triggered by: https://github.com/osism/sonic-manager 2025-12-09 03:07:36.301607 | Event ID: cbdb4017e9e4480cbca0088499a0c47f 2025-12-09 03:07:36.312516 | 2025-12-09 03:07:36.312679 | LOOP [emit-job-header : Print node information] 2025-12-09 03:07:36.620090 | debian-bookworm | ok: 2025-12-09 03:07:36.620360 | debian-bookworm | # Node Information 2025-12-09 03:07:36.620399 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-09 03:07:36.620432 | debian-bookworm | Hostname: debian 2025-12-09 03:07:36.620460 | debian-bookworm | Username: zuul 2025-12-09 03:07:36.620488 | debian-bookworm | Distro: Debian 12.12 2025-12-09 03:07:36.620519 | debian-bookworm | Provider: regiocloud-a 2025-12-09 03:07:36.620546 | debian-bookworm | Region: 2025-12-09 03:07:36.620574 | debian-bookworm | Label: debian-bookworm 2025-12-09 03:07:36.620600 | debian-bookworm | Product Name: OpenStack Nova 2025-12-09 03:07:36.620626 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe7b:d997 2025-12-09 03:07:36.650480 | 2025-12-09 03:07:36.650637 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-09 03:07:37.596505 | debian-bookworm -> localhost | changed 2025-12-09 03:07:37.604179 | 2025-12-09 03:07:37.604331 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-09 03:07:39.534414 | debian-bookworm -> localhost | changed 2025-12-09 03:07:39.595469 | 2025-12-09 03:07:39.595620 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-09 03:07:40.610036 | debian-bookworm -> localhost | ok 2025-12-09 03:07:40.617007 | 2025-12-09 03:07:40.617150 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-09 03:07:40.713418 | debian-bookworm | ok 2025-12-09 03:07:40.779640 | debian-bookworm | included: /var/lib/zuul/builds/e5b78525e3b8485288f7d6c01ba67e9e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-09 03:07:40.820910 | 2025-12-09 03:07:40.821077 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-09 03:07:44.292568 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-09 03:07:44.292903 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/e5b78525e3b8485288f7d6c01ba67e9e/work/e5b78525e3b8485288f7d6c01ba67e9e_id_rsa 2025-12-09 03:07:44.293005 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/e5b78525e3b8485288f7d6c01ba67e9e/work/e5b78525e3b8485288f7d6c01ba67e9e_id_rsa.pub 2025-12-09 03:07:44.293035 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-09 03:07:44.293061 | debian-bookworm -> localhost | SHA256:hIVEqHrOjBN/4dEP/f9OZ6eoTgAO8rPug2uDkGzYPxw zuul-build-sshkey 2025-12-09 03:07:44.293085 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-09 03:07:44.293128 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-09 03:07:44.293150 | debian-bookworm -> localhost | | +o.. | 2025-12-09 03:07:44.293172 | debian-bookworm -> localhost | | . .o | 2025-12-09 03:07:44.293192 | debian-bookworm -> localhost | | ... o . | 2025-12-09 03:07:44.293212 | debian-bookworm -> localhost | | .o o o | 2025-12-09 03:07:44.293232 | debian-bookworm -> localhost | |o+ o...S | 2025-12-09 03:07:44.293255 | debian-bookworm -> localhost | |*oo Eoo .. | 2025-12-09 03:07:44.293275 | debian-bookworm -> localhost | |oX =.+ o .. . +| 2025-12-09 03:07:44.293295 | debian-bookworm -> localhost | |+ O.B ... o +.| 2025-12-09 03:07:44.293316 | debian-bookworm -> localhost | | o.=oo .oooo+ | 2025-12-09 03:07:44.293336 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-09 03:07:44.293401 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.311494 2025-12-09 03:07:44.300482 | 2025-12-09 03:07:44.300621 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-09 03:07:44.373201 | debian-bookworm | ok 2025-12-09 03:07:44.402121 | debian-bookworm | included: /var/lib/zuul/builds/e5b78525e3b8485288f7d6c01ba67e9e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-09 03:07:44.414821 | 2025-12-09 03:07:44.415062 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-09 03:07:44.440193 | debian-bookworm | skipping: Conditional result was False 2025-12-09 03:07:44.447292 | 2025-12-09 03:07:44.447443 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-09 03:07:45.443567 | debian-bookworm | changed 2025-12-09 03:07:45.455541 | 2025-12-09 03:07:45.455678 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-09 03:07:45.817091 | debian-bookworm | ok 2025-12-09 03:07:45.826426 | 2025-12-09 03:07:45.826561 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-09 03:07:46.678807 | debian-bookworm | changed 2025-12-09 03:07:46.716502 | 2025-12-09 03:07:46.716657 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-09 03:07:47.592741 | debian-bookworm | changed 2025-12-09 03:07:47.608236 | 2025-12-09 03:07:47.608413 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-09 03:07:47.676816 | debian-bookworm | skipping: Conditional result was False 2025-12-09 03:07:47.684594 | 2025-12-09 03:07:47.684748 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-09 03:07:49.440194 | debian-bookworm -> localhost | changed 2025-12-09 03:07:49.452953 | 2025-12-09 03:07:49.459752 | TASK [add-build-sshkey : Add back temp key] 2025-12-09 03:07:50.987689 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/e5b78525e3b8485288f7d6c01ba67e9e/work/e5b78525e3b8485288f7d6c01ba67e9e_id_rsa (zuul-build-sshkey) 2025-12-09 03:07:50.988040 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.039770 2025-12-09 03:07:50.996852 | 2025-12-09 03:07:50.997034 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-09 03:07:51.845689 | debian-bookworm | ok 2025-12-09 03:07:51.851500 | 2025-12-09 03:07:51.851626 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-09 03:07:52.026723 | debian-bookworm | skipping: Conditional result was False 2025-12-09 03:07:52.066587 | 2025-12-09 03:07:52.066742 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-09 03:07:53.448171 | debian-bookworm | ok 2025-12-09 03:07:53.481750 | 2025-12-09 03:07:53.481906 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-09 03:07:53.554485 | debian-bookworm | ok 2025-12-09 03:07:53.564578 | 2025-12-09 03:07:53.564711 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-09 03:07:54.913135 | debian-bookworm -> localhost | ok 2025-12-09 03:07:54.920212 | 2025-12-09 03:07:54.920340 | TASK [validate-host : Collect information about the host] 2025-12-09 03:07:57.774955 | debian-bookworm | ok 2025-12-09 03:07:57.798390 | 2025-12-09 03:07:57.798535 | TASK [validate-host : Sanitize hostname] 2025-12-09 03:07:58.329800 | debian-bookworm | ok 2025-12-09 03:07:58.553489 | 2025-12-09 03:07:58.553645 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-09 03:08:00.553857 | debian-bookworm -> localhost | changed 2025-12-09 03:08:00.564271 | 2025-12-09 03:08:00.564390 | TASK [validate-host : Collect information about zuul worker] 2025-12-09 03:08:01.407943 | debian-bookworm | ok 2025-12-09 03:08:01.412459 | 2025-12-09 03:08:01.412562 | TASK [validate-host : Write out all zuul information for each host] 2025-12-09 03:08:03.083758 | debian-bookworm -> localhost | changed 2025-12-09 03:08:03.104449 | 2025-12-09 03:08:03.104557 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-09 03:08:03.389034 | debian-bookworm | ok 2025-12-09 03:08:03.394608 | 2025-12-09 03:08:03.394711 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-09 03:08:04.843239 | debian-bookworm | changed: 2025-12-09 03:08:04.843412 | debian-bookworm | cd+++++++++ src/ 2025-12-09 03:08:04.843445 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-09 03:08:04.843470 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-09 03:08:04.843491 | debian-bookworm | cd+++++++++ src/github.com/osism/sonic-manager/ 2025-12-09 03:08:04.843512 | debian-bookworm | localhost | ok: Runtime: 0:00:00.030186 2025-12-09 03:08:39.841617 | 2025-12-09 03:08:39.841756 | TASK [upload-logs : Upload logs to log server] 2025-12-09 03:08:41.952506 | localhost | Output suppressed because no_log was given 2025-12-09 03:08:41.954649 | 2025-12-09 03:08:41.954768 | LOOP [upload-logs : Compress console log and json output] 2025-12-09 03:08:42.387689 | localhost | skipping: Conditional result was False 2025-12-09 03:08:42.465242 | localhost | skipping: Conditional result was False 2025-12-09 03:08:42.481728 | 2025-12-09 03:08:42.482747 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-09 03:08:42.749024 | localhost | skipping: Conditional result was False 2025-12-09 03:08:42.749331 | 2025-12-09 03:08:42.808969 | localhost | skipping: Conditional result was False 2025-12-09 03:08:42.817606 | 2025-12-09 03:08:42.817760 | LOOP [upload-logs : Upload console log and json output]