2025-12-27 03:11:28.335741 | Job console starting 2025-12-27 03:11:28.350774 | Updating git repos 2025-12-27 03:11:28.400744 | Cloning repos into workspace 2025-12-27 03:11:28.507486 | Restoring repo states 2025-12-27 03:11:28.521890 | Merging changes 2025-12-27 03:11:28.521915 | Checking out repos 2025-12-27 03:11:28.621035 | Preparing playbooks 2025-12-27 03:11:30.076746 | Running Ansible setup 2025-12-27 03:11:40.397906 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-27 03:11:42.702977 | 2025-12-27 03:11:42.703135 | PLAY [Base pre] 2025-12-27 03:11:42.765983 | 2025-12-27 03:11:42.766134 | TASK [Setup log path fact] 2025-12-27 03:11:42.814711 | debian-bookworm | ok 2025-12-27 03:11:42.860823 | 2025-12-27 03:11:42.860975 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-27 03:11:42.925301 | debian-bookworm | ok 2025-12-27 03:11:42.941456 | 2025-12-27 03:11:42.941574 | TASK [emit-job-header : Print job information] 2025-12-27 03:11:43.023137 | # Job Information 2025-12-27 03:11:43.023305 | Ansible Version: 2.16.14 2025-12-27 03:11:43.023341 | Job: python-black 2025-12-27 03:11:43.023374 | Pipeline: periodic-daily 2025-12-27 03:11:43.023397 | Executor: 521e9411259a 2025-12-27 03:11:43.023417 | Triggered by: https://github.com/osism/testbed 2025-12-27 03:11:43.023438 | Event ID: 44577c256c45427aac7ea50fccdd5509 2025-12-27 03:11:43.031875 | 2025-12-27 03:11:43.032400 | LOOP [emit-job-header : Print node information] 2025-12-27 03:11:43.285390 | debian-bookworm | ok: 2025-12-27 03:11:43.285634 | debian-bookworm | # Node Information 2025-12-27 03:11:43.285672 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-27 03:11:43.285697 | debian-bookworm | Hostname: debian 2025-12-27 03:11:43.285719 | debian-bookworm | Username: zuul 2025-12-27 03:11:43.285740 | debian-bookworm | Distro: Debian 12.12 2025-12-27 03:11:43.285765 | debian-bookworm | Provider: regiocloud-a 2025-12-27 03:11:43.285786 | debian-bookworm | Region: 2025-12-27 03:11:43.285807 | debian-bookworm | Label: debian-bookworm 2025-12-27 03:11:43.285827 | debian-bookworm | Product Name: OpenStack Nova 2025-12-27 03:11:43.285847 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fea8:7c39 2025-12-27 03:11:43.297968 | 2025-12-27 03:11:43.298121 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-27 03:11:45.005465 | debian-bookworm -> localhost | changed 2025-12-27 03:11:45.013025 | 2025-12-27 03:11:45.013204 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-27 03:11:49.041949 | debian-bookworm -> localhost | changed 2025-12-27 03:11:49.061027 | 2025-12-27 03:11:49.061154 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-27 03:11:50.074204 | debian-bookworm -> localhost | ok 2025-12-27 03:11:50.083669 | 2025-12-27 03:11:50.083780 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-27 03:11:50.135421 | debian-bookworm | ok 2025-12-27 03:11:50.200676 | debian-bookworm | included: /var/lib/zuul/builds/de54dacb9912480db7c9229e23cb3b9f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-27 03:11:50.243999 | 2025-12-27 03:11:50.244145 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-27 03:11:54.477311 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-27 03:11:54.477524 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/de54dacb9912480db7c9229e23cb3b9f/work/de54dacb9912480db7c9229e23cb3b9f_id_rsa 2025-12-27 03:11:54.477562 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/de54dacb9912480db7c9229e23cb3b9f/work/de54dacb9912480db7c9229e23cb3b9f_id_rsa.pub 2025-12-27 03:11:54.477588 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-27 03:11:54.477611 | debian-bookworm -> localhost | SHA256:NzqrJX/PjM3NMVvjl7sXp/7TxhPENlPlcksYj71Ncc8 zuul-build-sshkey 2025-12-27 03:11:54.477633 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-27 03:11:54.477669 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-27 03:11:54.477691 | debian-bookworm -> localhost | | . .+| 2025-12-27 03:11:54.477712 | debian-bookworm -> localhost | | *o=| 2025-12-27 03:11:54.477732 | debian-bookworm -> localhost | | oo+E| 2025-12-27 03:11:54.477752 | debian-bookworm -> localhost | | .X+| 2025-12-27 03:11:54.477771 | debian-bookworm -> localhost | | S o oo+| 2025-12-27 03:11:54.477794 | debian-bookworm -> localhost | | o . o.| 2025-12-27 03:11:54.477815 | debian-bookworm -> localhost | | . + o+B| 2025-12-27 03:11:54.477836 | debian-bookworm -> localhost | | + o.* ooOB| 2025-12-27 03:11:54.477856 | debian-bookworm -> localhost | | ..o...*.=*O| 2025-12-27 03:11:54.477877 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-27 03:11:54.477927 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.074282 2025-12-27 03:11:54.484556 | 2025-12-27 03:11:54.484665 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-27 03:11:54.516898 | debian-bookworm | ok 2025-12-27 03:11:54.536850 | debian-bookworm | included: /var/lib/zuul/builds/de54dacb9912480db7c9229e23cb3b9f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-27 03:11:54.552406 | 2025-12-27 03:11:54.552526 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-27 03:11:54.620304 | debian-bookworm | skipping: Conditional result was False 2025-12-27 03:11:54.626178 | 2025-12-27 03:11:54.626282 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-27 03:11:55.991676 | debian-bookworm | changed 2025-12-27 03:11:56.001720 | 2025-12-27 03:11:56.001827 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-27 03:11:56.318035 | debian-bookworm | ok 2025-12-27 03:11:56.328915 | 2025-12-27 03:11:56.329024 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-27 03:11:56.996935 | debian-bookworm | changed 2025-12-27 03:11:57.009252 | 2025-12-27 03:11:57.009361 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-27 03:11:57.690612 | debian-bookworm | changed 2025-12-27 03:11:57.704499 | 2025-12-27 03:11:57.704631 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-27 03:11:57.728473 | debian-bookworm | skipping: Conditional result was False 2025-12-27 03:11:57.737035 | 2025-12-27 03:11:57.737198 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-27 03:11:58.197130 | debian-bookworm -> localhost | changed 2025-12-27 03:11:58.220866 | 2025-12-27 03:11:58.220982 | TASK [add-build-sshkey : Add back temp key] 2025-12-27 03:11:58.804215 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/de54dacb9912480db7c9229e23cb3b9f/work/de54dacb9912480db7c9229e23cb3b9f_id_rsa (zuul-build-sshkey) 2025-12-27 03:11:58.804423 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.014781 2025-12-27 03:11:58.814588 | 2025-12-27 03:11:58.814694 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-27 03:11:59.423042 | debian-bookworm | ok 2025-12-27 03:11:59.432533 | 2025-12-27 03:11:59.432696 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-27 03:11:59.458155 | debian-bookworm | skipping: Conditional result was False 2025-12-27 03:11:59.471018 | 2025-12-27 03:11:59.471192 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-27 03:11:59.953698 | debian-bookworm | ok 2025-12-27 03:11:59.985896 | 2025-12-27 03:11:59.986926 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-27 03:12:00.037677 | debian-bookworm | ok 2025-12-27 03:12:00.045813 | 2025-12-27 03:12:00.045957 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-27 03:12:00.583629 | debian-bookworm -> localhost | ok 2025-12-27 03:12:00.591624 | 2025-12-27 03:12:00.591804 | TASK [validate-host : Collect information about the host] 2025-12-27 03:12:01.810396 | debian-bookworm | ok 2025-12-27 03:12:01.821326 | 2025-12-27 03:12:01.821458 | TASK [validate-host : Sanitize hostname] 2025-12-27 03:12:01.948290 | debian-bookworm | ok 2025-12-27 03:12:02.003608 | 2025-12-27 03:12:02.003762 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-27 03:12:02.652524 | debian-bookworm -> localhost | changed 2025-12-27 03:12:02.658753 | 2025-12-27 03:12:02.659354 | TASK [validate-host : Collect information about zuul worker] 2025-12-27 03:12:03.093371 | debian-bookworm | ok 2025-12-27 03:12:03.098718 | 2025-12-27 03:12:03.098873 | TASK [validate-host : Write out all zuul information for each host] 2025-12-27 03:12:03.727918 | debian-bookworm -> localhost | changed 2025-12-27 03:12:03.739277 | 2025-12-27 03:12:03.739476 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-27 03:12:04.013426 | debian-bookworm | ok 2025-12-27 03:12:04.020924 | 2025-12-27 03:12:04.021136 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-27 03:12:05.398225 | debian-bookworm | changed: 2025-12-27 03:12:05.398517 | debian-bookworm | cd+++++++++ src/ 2025-12-27 03:12:05.398572 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-27 03:12:05.398610 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-27 03:12:05.398642 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2025-12-27 03:12:05.398672 | debian-bookworm | localhost | ok: Runtime: 0:00:00.033279 2025-12-27 03:12:37.010556 | 2025-12-27 03:12:37.010644 | TASK [upload-logs : Upload logs to log server] 2025-12-27 03:12:37.786783 | localhost | Output suppressed because no_log was given 2025-12-27 03:12:37.788883 | 2025-12-27 03:12:37.788979 | LOOP [upload-logs : Compress console log and json output] 2025-12-27 03:12:37.865141 | localhost | skipping: Conditional result was False 2025-12-27 03:12:37.871073 | localhost | skipping: Conditional result was False 2025-12-27 03:12:37.876748 | 2025-12-27 03:12:37.876878 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-27 03:12:37.922275 | localhost | skipping: Conditional result was False 2025-12-27 03:12:37.922540 | 2025-12-27 03:12:37.927361 | localhost | skipping: Conditional result was False 2025-12-27 03:12:37.933026 | 2025-12-27 03:12:37.933184 | LOOP [upload-logs : Upload console log and json output]