2025-12-25 03:12:07.285984 | Job console starting 2025-12-25 03:12:07.326674 | Updating git repos 2025-12-25 03:12:07.395758 | Cloning repos into workspace 2025-12-25 03:12:07.542436 | Restoring repo states 2025-12-25 03:12:07.559059 | Merging changes 2025-12-25 03:12:07.559080 | Checking out repos 2025-12-25 03:12:07.827052 | Preparing playbooks 2025-12-25 03:12:09.429518 | Running Ansible setup 2025-12-25 03:12:19.550106 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-25 03:12:21.758297 | 2025-12-25 03:12:21.758470 | PLAY [Base pre] 2025-12-25 03:12:21.785427 | 2025-12-25 03:12:21.785651 | TASK [Setup log path fact] 2025-12-25 03:12:21.817930 | debian-bookworm | ok 2025-12-25 03:12:21.835686 | 2025-12-25 03:12:21.835858 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-25 03:12:21.887037 | debian-bookworm | ok 2025-12-25 03:12:21.906945 | 2025-12-25 03:12:21.907095 | TASK [emit-job-header : Print job information] 2025-12-25 03:12:22.020477 | # Job Information 2025-12-25 03:12:22.020761 | Ansible Version: 2.16.14 2025-12-25 03:12:22.020803 | Job: python-black 2025-12-25 03:12:22.020841 | Pipeline: periodic-daily 2025-12-25 03:12:22.020869 | Executor: 521e9411259a 2025-12-25 03:12:22.020890 | Triggered by: https://github.com/osism/testbed 2025-12-25 03:12:22.020912 | Event ID: d870d23596a2462ba67dd516257d5e98 2025-12-25 03:12:22.026526 | 2025-12-25 03:12:22.026681 | LOOP [emit-job-header : Print node information] 2025-12-25 03:12:22.407481 | debian-bookworm | ok: 2025-12-25 03:12:22.407808 | debian-bookworm | # Node Information 2025-12-25 03:12:22.407851 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-25 03:12:22.407878 | debian-bookworm | Hostname: debian 2025-12-25 03:12:22.407901 | debian-bookworm | Username: zuul 2025-12-25 03:12:22.407922 | debian-bookworm | Distro: Debian 12.12 2025-12-25 03:12:22.407945 | debian-bookworm | Provider: regiocloud-a 2025-12-25 03:12:22.407966 | debian-bookworm | Region: 2025-12-25 03:12:22.407987 | debian-bookworm | Label: debian-bookworm 2025-12-25 03:12:22.408006 | debian-bookworm | Product Name: OpenStack Nova 2025-12-25 03:12:22.408026 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fec7:e538 2025-12-25 03:12:22.429320 | 2025-12-25 03:12:22.429489 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-25 03:12:23.969751 | debian-bookworm -> localhost | changed 2025-12-25 03:12:23.988785 | 2025-12-25 03:12:23.989024 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-25 03:12:26.221386 | debian-bookworm -> localhost | changed 2025-12-25 03:12:26.235325 | 2025-12-25 03:12:26.235472 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-25 03:12:26.720249 | debian-bookworm -> localhost | ok 2025-12-25 03:12:26.727644 | 2025-12-25 03:12:26.727776 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-25 03:12:26.772038 | debian-bookworm | ok 2025-12-25 03:12:26.821170 | debian-bookworm | included: /var/lib/zuul/builds/627d6dadb6bb428bb06dd5aa541edaad/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-25 03:12:26.828552 | 2025-12-25 03:12:26.828675 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-25 03:12:28.811053 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-25 03:12:28.811333 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/627d6dadb6bb428bb06dd5aa541edaad/work/627d6dadb6bb428bb06dd5aa541edaad_id_rsa 2025-12-25 03:12:28.811377 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/627d6dadb6bb428bb06dd5aa541edaad/work/627d6dadb6bb428bb06dd5aa541edaad_id_rsa.pub 2025-12-25 03:12:28.811404 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-25 03:12:28.811432 | debian-bookworm -> localhost | SHA256:kOTUUmV5vvfSYq9rYWBLr3XOA1Rycf/3GWzG+kT1u7E zuul-build-sshkey 2025-12-25 03:12:28.811455 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-25 03:12:28.811488 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-25 03:12:28.811511 | debian-bookworm -> localhost | | oo..o. .o| 2025-12-25 03:12:28.811533 | debian-bookworm -> localhost | | +..... .. oo| 2025-12-25 03:12:28.811553 | debian-bookworm -> localhost | | +. o + o| 2025-12-25 03:12:28.811573 | debian-bookworm -> localhost | | . =.o +| 2025-12-25 03:12:28.811593 | debian-bookworm -> localhost | | S o.= B+| 2025-12-25 03:12:28.811619 | debian-bookworm -> localhost | | o.@ B| 2025-12-25 03:12:28.811673 | debian-bookworm -> localhost | | *.%.| 2025-12-25 03:12:28.811696 | debian-bookworm -> localhost | | . B.O| 2025-12-25 03:12:28.811717 | debian-bookworm -> localhost | | ooEo| 2025-12-25 03:12:28.811739 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-25 03:12:28.811795 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.175854 2025-12-25 03:12:28.819263 | 2025-12-25 03:12:28.819390 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-25 03:12:28.848384 | debian-bookworm | ok 2025-12-25 03:12:28.859775 | debian-bookworm | included: /var/lib/zuul/builds/627d6dadb6bb428bb06dd5aa541edaad/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-25 03:12:28.870753 | 2025-12-25 03:12:28.870898 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-25 03:12:28.895599 | debian-bookworm | skipping: Conditional result was False 2025-12-25 03:12:28.902457 | 2025-12-25 03:12:28.902583 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-25 03:12:29.672150 | debian-bookworm | changed 2025-12-25 03:12:29.688517 | 2025-12-25 03:12:29.688964 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-25 03:12:30.052974 | debian-bookworm | ok 2025-12-25 03:12:30.063616 | 2025-12-25 03:12:30.063760 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-25 03:12:30.824952 | debian-bookworm | changed 2025-12-25 03:12:30.842562 | 2025-12-25 03:12:30.842708 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-25 03:12:31.505137 | debian-bookworm | changed 2025-12-25 03:12:31.512428 | 2025-12-25 03:12:31.512564 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-25 03:12:31.550018 | debian-bookworm | skipping: Conditional result was False 2025-12-25 03:12:31.557428 | 2025-12-25 03:12:31.557582 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-25 03:12:32.120267 | debian-bookworm -> localhost | changed 2025-12-25 03:12:32.133974 | 2025-12-25 03:12:32.134178 | TASK [add-build-sshkey : Add back temp key] 2025-12-25 03:12:32.574042 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/627d6dadb6bb428bb06dd5aa541edaad/work/627d6dadb6bb428bb06dd5aa541edaad_id_rsa (zuul-build-sshkey) 2025-12-25 03:12:32.574331 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.015047 2025-12-25 03:12:32.586781 | 2025-12-25 03:12:32.586952 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-25 03:12:33.025378 | debian-bookworm | ok 2025-12-25 03:12:33.034559 | 2025-12-25 03:12:33.034709 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-25 03:12:33.112577 | debian-bookworm | skipping: Conditional result was False 2025-12-25 03:12:33.124678 | 2025-12-25 03:12:33.124813 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-25 03:12:33.678525 | debian-bookworm | ok 2025-12-25 03:12:33.696421 | 2025-12-25 03:12:33.696560 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-25 03:12:33.777760 | debian-bookworm | ok 2025-12-25 03:12:33.784596 | 2025-12-25 03:12:33.784794 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-25 03:12:34.435661 | debian-bookworm -> localhost | ok 2025-12-25 03:12:34.442925 | 2025-12-25 03:12:34.443053 | TASK [validate-host : Collect information about the host] 2025-12-25 03:12:35.685789 | debian-bookworm | ok 2025-12-25 03:12:35.696856 | 2025-12-25 03:12:35.697005 | TASK [validate-host : Sanitize hostname] 2025-12-25 03:12:35.818873 | debian-bookworm | ok 2025-12-25 03:12:35.862687 | 2025-12-25 03:12:35.862829 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-25 03:12:36.515891 | debian-bookworm -> localhost | changed 2025-12-25 03:12:36.527552 | 2025-12-25 03:12:36.527682 | TASK [validate-host : Collect information about zuul worker] 2025-12-25 03:12:37.028058 | debian-bookworm | ok 2025-12-25 03:12:37.038168 | 2025-12-25 03:12:37.038344 | TASK [validate-host : Write out all zuul information for each host] 2025-12-25 03:12:38.200908 | debian-bookworm -> localhost | changed 2025-12-25 03:12:38.220166 | 2025-12-25 03:12:38.220350 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-25 03:12:38.549556 | debian-bookworm | ok 2025-12-25 03:12:38.567428 | 2025-12-25 03:12:38.567580 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-25 03:12:40.185856 | debian-bookworm | changed: 2025-12-25 03:12:40.186089 | debian-bookworm | cd+++++++++ src/ 2025-12-25 03:12:40.186125 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-25 03:12:40.186149 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-25 03:12:40.186170 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2025-12-25 03:12:40.186190 | debian-bookworm | localhost | ok: Runtime: 0:00:00.020066 2025-12-25 03:13:14.077910 | 2025-12-25 03:13:14.078041 | TASK [upload-logs : Upload logs to log server] 2025-12-25 03:13:15.128204 | localhost | Output suppressed because no_log was given 2025-12-25 03:13:15.130255 | 2025-12-25 03:13:15.130371 | LOOP [upload-logs : Compress console log and json output] 2025-12-25 03:13:15.234514 | localhost | skipping: Conditional result was False 2025-12-25 03:13:15.245889 | localhost | skipping: Conditional result was False 2025-12-25 03:13:15.249865 | 2025-12-25 03:13:15.249993 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-25 03:13:15.357502 | localhost | skipping: Conditional result was False 2025-12-25 03:13:15.357814 | 2025-12-25 03:13:15.373937 | localhost | skipping: Conditional result was False 2025-12-25 03:13:15.381182 | 2025-12-25 03:13:15.381343 | LOOP [upload-logs : Upload console log and json output]