2025-10-31 03:16:02.633817 | Job console starting 2025-10-31 03:16:02.639887 | Updating git repos 2025-10-31 03:16:02.675912 | Cloning repos into workspace 2025-10-31 03:16:02.730373 | Restoring repo states 2025-10-31 03:16:02.733599 | Merging changes 2025-10-31 03:16:02.733611 | Checking out repos 2025-10-31 03:16:02.779951 | Preparing playbooks 2025-10-31 03:16:03.769113 | Running Ansible setup 2025-10-31 03:16:09.350359 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-31 03:16:10.660551 | 2025-10-31 03:16:10.660659 | PLAY [Base pre] 2025-10-31 03:16:10.674786 | 2025-10-31 03:16:10.674914 | TASK [Setup log path fact] 2025-10-31 03:16:10.701513 | debian-bookworm | ok 2025-10-31 03:16:10.724738 | 2025-10-31 03:16:10.724832 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-31 03:16:10.751738 | debian-bookworm | ok 2025-10-31 03:16:10.763805 | 2025-10-31 03:16:10.763888 | TASK [emit-job-header : Print job information] 2025-10-31 03:16:10.790657 | # Job Information 2025-10-31 03:16:10.790777 | Ansible Version: 2.16.14 2025-10-31 03:16:10.790804 | Job: python-black 2025-10-31 03:16:10.790854 | Pipeline: periodic-daily 2025-10-31 03:16:10.790875 | Executor: 521e9411259a 2025-10-31 03:16:10.790892 | Triggered by: https://github.com/osism/sonic-manager 2025-10-31 03:16:10.790911 | Event ID: e3c95e058d3b45cb8013de90d21df1bc 2025-10-31 03:16:10.794704 | 2025-10-31 03:16:10.794775 | LOOP [emit-job-header : Print node information] 2025-10-31 03:16:10.877966 | debian-bookworm | ok: 2025-10-31 03:16:10.878225 | debian-bookworm | # Node Information 2025-10-31 03:16:10.878259 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-31 03:16:10.878280 | debian-bookworm | Hostname: debian 2025-10-31 03:16:10.878297 | debian-bookworm | Username: zuul 2025-10-31 03:16:10.878336 | debian-bookworm | Distro: Debian 12.12 2025-10-31 03:16:10.878359 | debian-bookworm | Provider: regiocloud-a 2025-10-31 03:16:10.878377 | debian-bookworm | Region: 2025-10-31 03:16:10.878393 | debian-bookworm | Label: debian-bookworm 2025-10-31 03:16:10.878409 | debian-bookworm | Product Name: OpenStack Nova 2025-10-31 03:16:10.878425 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fed2:45e4 2025-10-31 03:16:10.896168 | 2025-10-31 03:16:10.896242 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-31 03:16:11.367244 | debian-bookworm -> localhost | changed 2025-10-31 03:16:11.372894 | 2025-10-31 03:16:11.372977 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-31 03:16:13.081883 | debian-bookworm -> localhost | changed 2025-10-31 03:16:13.095712 | 2025-10-31 03:16:13.095836 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-31 03:16:13.665370 | debian-bookworm -> localhost | ok 2025-10-31 03:16:13.680650 | 2025-10-31 03:16:13.680747 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-31 03:16:13.736215 | debian-bookworm | ok 2025-10-31 03:16:13.783647 | debian-bookworm | included: /var/lib/zuul/builds/0306070149a64fea87b8035acc87e51c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-31 03:16:13.794289 | 2025-10-31 03:16:13.794399 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-31 03:16:15.561015 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-31 03:16:15.561208 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/0306070149a64fea87b8035acc87e51c/work/0306070149a64fea87b8035acc87e51c_id_rsa 2025-10-31 03:16:15.561245 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/0306070149a64fea87b8035acc87e51c/work/0306070149a64fea87b8035acc87e51c_id_rsa.pub 2025-10-31 03:16:15.561271 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-31 03:16:15.561297 | debian-bookworm -> localhost | SHA256:Em1eUuG988KPL54Hle16B/cOyV5Ms+x67Mbpim1DHu4 zuul-build-sshkey 2025-10-31 03:16:15.561330 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-31 03:16:15.561363 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-31 03:16:15.561385 | debian-bookworm -> localhost | | o. | 2025-10-31 03:16:15.561407 | debian-bookworm -> localhost | | . o . | 2025-10-31 03:16:15.561428 | debian-bookworm -> localhost | | . + o . o | 2025-10-31 03:16:15.561448 | debian-bookworm -> localhost | | + o .o .| 2025-10-31 03:16:15.561468 | debian-bookworm -> localhost | | . S o. o.| 2025-10-31 03:16:15.561491 | debian-bookworm -> localhost | | . ..*o+=| 2025-10-31 03:16:15.561511 | debian-bookworm -> localhost | | *.O*=| 2025-10-31 03:16:15.561530 | debian-bookworm -> localhost | | +@+O+| 2025-10-31 03:16:15.561550 | debian-bookworm -> localhost | | o*E%*o| 2025-10-31 03:16:15.561570 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-31 03:16:15.561616 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.145726 2025-10-31 03:16:15.567669 | 2025-10-31 03:16:15.567758 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-31 03:16:15.609742 | debian-bookworm | ok 2025-10-31 03:16:15.633929 | debian-bookworm | included: /var/lib/zuul/builds/0306070149a64fea87b8035acc87e51c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-31 03:16:15.642556 | 2025-10-31 03:16:15.642645 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-31 03:16:15.685235 | debian-bookworm | skipping: Conditional result was False 2025-10-31 03:16:15.691474 | 2025-10-31 03:16:15.691566 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-31 03:16:16.542039 | debian-bookworm | changed 2025-10-31 03:16:16.549595 | 2025-10-31 03:16:16.549700 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-31 03:16:16.865446 | debian-bookworm | ok 2025-10-31 03:16:16.876167 | 2025-10-31 03:16:16.876266 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-31 03:16:17.692657 | debian-bookworm | changed 2025-10-31 03:16:17.703785 | 2025-10-31 03:16:17.703874 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-31 03:16:18.515099 | debian-bookworm | changed 2025-10-31 03:16:18.519546 | 2025-10-31 03:16:18.519623 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-31 03:16:18.555029 | debian-bookworm | skipping: Conditional result was False 2025-10-31 03:16:18.562579 | 2025-10-31 03:16:18.562687 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-31 03:16:19.550794 | debian-bookworm -> localhost | changed 2025-10-31 03:16:19.559439 | 2025-10-31 03:16:19.559524 | TASK [add-build-sshkey : Add back temp key] 2025-10-31 03:16:20.134954 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/0306070149a64fea87b8035acc87e51c/work/0306070149a64fea87b8035acc87e51c_id_rsa (zuul-build-sshkey) 2025-10-31 03:16:20.135142 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.042760 2025-10-31 03:16:20.141495 | 2025-10-31 03:16:20.141581 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-31 03:16:20.592963 | debian-bookworm | ok 2025-10-31 03:16:20.598519 | 2025-10-31 03:16:20.598603 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-31 03:16:20.632100 | debian-bookworm | skipping: Conditional result was False 2025-10-31 03:16:20.640348 | 2025-10-31 03:16:20.640424 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-31 03:16:21.198453 | debian-bookworm | ok 2025-10-31 03:16:21.222536 | 2025-10-31 03:16:21.222632 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-31 03:16:21.264078 | debian-bookworm | ok 2025-10-31 03:16:21.270634 | 2025-10-31 03:16:21.270707 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-31 03:16:21.703266 | debian-bookworm -> localhost | ok 2025-10-31 03:16:21.709039 | 2025-10-31 03:16:21.709131 | TASK [validate-host : Collect information about the host] 2025-10-31 03:16:22.958591 | debian-bookworm | ok 2025-10-31 03:16:22.967495 | 2025-10-31 03:16:22.967570 | TASK [validate-host : Sanitize hostname] 2025-10-31 03:16:23.055632 | debian-bookworm | ok 2025-10-31 03:16:23.085371 | 2025-10-31 03:16:23.085455 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-31 03:16:23.930441 | debian-bookworm -> localhost | changed 2025-10-31 03:16:23.936982 | 2025-10-31 03:16:23.937075 | TASK [validate-host : Collect information about zuul worker] 2025-10-31 03:16:24.436707 | debian-bookworm | ok 2025-10-31 03:16:24.444900 | 2025-10-31 03:16:24.444998 | TASK [validate-host : Write out all zuul information for each host] 2025-10-31 03:16:25.087108 | debian-bookworm -> localhost | changed 2025-10-31 03:16:25.099256 | 2025-10-31 03:16:25.099401 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-31 03:16:25.363760 | debian-bookworm | ok 2025-10-31 03:16:25.373985 | 2025-10-31 03:16:25.374096 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-31 03:16:26.138199 | debian-bookworm | changed: 2025-10-31 03:16:26.138363 | debian-bookworm | cd+++++++++ src/ 2025-10-31 03:16:26.138393 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-31 03:16:26.138413 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-31 03:16:26.138431 | debian-bookworm | cd+++++++++ src/github.com/osism/sonic-manager/ 2025-10-31 03:16:26.138448 | debian-bookworm | localhost | ok: Runtime: 0:00:00.018571 2025-10-31 03:16:53.028413 | 2025-10-31 03:16:53.028534 | TASK [upload-logs : Upload logs to log server] 2025-10-31 03:16:53.947108 | localhost | Output suppressed because no_log was given 2025-10-31 03:16:53.948853 | 2025-10-31 03:16:53.948944 | LOOP [upload-logs : Compress console log and json output] 2025-10-31 03:16:54.044517 | localhost | skipping: Conditional result was False 2025-10-31 03:16:54.059319 | localhost | skipping: Conditional result was False 2025-10-31 03:16:54.072229 | 2025-10-31 03:16:54.072319 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-31 03:16:54.151578 | localhost | skipping: Conditional result was False 2025-10-31 03:16:54.151806 | 2025-10-31 03:16:54.165520 | localhost | skipping: Conditional result was False 2025-10-31 03:16:54.177591 | 2025-10-31 03:16:54.177680 | LOOP [upload-logs : Upload console log and json output]