2025-06-30 03:00:11.585844 | Job console starting 2025-06-30 03:00:11.619794 | Updating git repos 2025-06-30 03:00:11.956866 | Cloning repos into workspace 2025-06-30 03:00:12.061694 | Restoring repo states 2025-06-30 03:00:12.083584 | Merging changes 2025-06-30 03:00:12.083606 | Checking out repos 2025-06-30 03:00:12.260190 | Preparing playbooks 2025-06-30 03:00:14.723525 | Running Ansible setup 2025-06-30 03:00:25.097601 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-06-30 03:00:26.715169 | 2025-06-30 03:00:26.715306 | PLAY [Base pre] 2025-06-30 03:00:26.743813 | 2025-06-30 03:00:26.743930 | TASK [Setup log path fact] 2025-06-30 03:00:26.774951 | debian-bookworm | ok 2025-06-30 03:00:26.801771 | 2025-06-30 03:00:26.801889 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-06-30 03:00:26.851992 | debian-bookworm | ok 2025-06-30 03:00:26.859775 | 2025-06-30 03:00:26.859862 | TASK [emit-job-header : Print job information] 2025-06-30 03:00:26.964827 | # Job Information 2025-06-30 03:00:26.965068 | Ansible Version: 2.16.14 2025-06-30 03:00:26.965109 | Job: python-black 2025-06-30 03:00:26.965140 | Pipeline: periodic-daily 2025-06-30 03:00:26.965163 | Executor: 521e9411259a 2025-06-30 03:00:26.965264 | Triggered by: https://github.com/osism/cinder-driver-dm-clone 2025-06-30 03:00:26.965288 | Event ID: 0fdca903c35a49918ffd3bec67bc613e 2025-06-30 03:00:26.969510 | 2025-06-30 03:00:26.969602 | LOOP [emit-job-header : Print node information] 2025-06-30 03:00:27.174558 | debian-bookworm | ok: 2025-06-30 03:00:27.174784 | debian-bookworm | # Node Information 2025-06-30 03:00:27.174815 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-06-30 03:00:27.174849 | debian-bookworm | Hostname: debian 2025-06-30 03:00:27.174868 | debian-bookworm | Username: zuul 2025-06-30 03:00:27.174885 | debian-bookworm | Distro: Debian 12.11 2025-06-30 03:00:27.174905 | debian-bookworm | Provider: regiocloud-a 2025-06-30 03:00:27.174923 | debian-bookworm | Region: 2025-06-30 03:00:27.174940 | debian-bookworm | Label: debian-bookworm 2025-06-30 03:00:27.174956 | debian-bookworm | Product Name: OpenStack Nova 2025-06-30 03:00:27.174973 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe19:d273 2025-06-30 03:00:27.189583 | 2025-06-30 03:00:27.189686 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-06-30 03:00:28.248916 | debian-bookworm -> localhost | changed 2025-06-30 03:00:28.254594 | 2025-06-30 03:00:28.254674 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-06-30 03:00:30.331096 | debian-bookworm -> localhost | changed 2025-06-30 03:00:30.341734 | 2025-06-30 03:00:30.341831 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-06-30 03:00:30.996009 | debian-bookworm -> localhost | ok 2025-06-30 03:00:31.009311 | 2025-06-30 03:00:31.009462 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-06-30 03:00:31.050373 | debian-bookworm | ok 2025-06-30 03:00:31.083143 | debian-bookworm | included: /var/lib/zuul/builds/c2225e769f694e6dbb0778b08366249e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-06-30 03:00:31.094747 | 2025-06-30 03:00:31.095516 | TASK [add-build-sshkey : Create Temp SSH key] 2025-06-30 03:00:32.693246 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-06-30 03:00:32.693430 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/c2225e769f694e6dbb0778b08366249e/work/c2225e769f694e6dbb0778b08366249e_id_rsa 2025-06-30 03:00:32.693463 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/c2225e769f694e6dbb0778b08366249e/work/c2225e769f694e6dbb0778b08366249e_id_rsa.pub 2025-06-30 03:00:32.693485 | debian-bookworm -> localhost | The key fingerprint is: 2025-06-30 03:00:32.693505 | debian-bookworm -> localhost | SHA256:x9X25BlkGylqYrhEQnUwGG9hXaxjH8+rAJ2sXeEz4E0 zuul-build-sshkey 2025-06-30 03:00:32.693524 | debian-bookworm -> localhost | The key's randomart image is: 2025-06-30 03:00:32.693551 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-06-30 03:00:32.693569 | debian-bookworm -> localhost | | .o+*o.o. +.| 2025-06-30 03:00:32.693587 | debian-bookworm -> localhost | | oo.+. . oo.o| 2025-06-30 03:00:32.693604 | debian-bookworm -> localhost | | oo...Eo +o.| 2025-06-30 03:00:32.693621 | debian-bookworm -> localhost | | .o+B*=.. +o| 2025-06-30 03:00:32.693637 | debian-bookworm -> localhost | | ..S=B*+ .o| 2025-06-30 03:00:32.693661 | debian-bookworm -> localhost | | .+...oo | 2025-06-30 03:00:32.693679 | debian-bookworm -> localhost | | . o . | 2025-06-30 03:00:32.693696 | debian-bookworm -> localhost | | . . | 2025-06-30 03:00:32.693715 | debian-bookworm -> localhost | | .. | 2025-06-30 03:00:32.693732 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-06-30 03:00:32.693776 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.606158 2025-06-30 03:00:32.699016 | 2025-06-30 03:00:32.699117 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-06-30 03:00:32.737008 | debian-bookworm | ok 2025-06-30 03:00:32.759490 | debian-bookworm | included: /var/lib/zuul/builds/c2225e769f694e6dbb0778b08366249e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-06-30 03:00:32.800037 | 2025-06-30 03:00:32.800150 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-06-30 03:00:32.834026 | debian-bookworm | skipping: Conditional result was False 2025-06-30 03:00:32.840442 | 2025-06-30 03:00:32.840551 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-06-30 03:00:33.789066 | debian-bookworm | changed 2025-06-30 03:00:33.793374 | 2025-06-30 03:00:33.793449 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-06-30 03:00:34.096262 | debian-bookworm | ok 2025-06-30 03:00:34.101714 | 2025-06-30 03:00:34.101815 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-06-30 03:00:34.754125 | debian-bookworm | changed 2025-06-30 03:00:34.764217 | 2025-06-30 03:00:34.764316 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-06-30 03:00:35.436157 | debian-bookworm | changed 2025-06-30 03:00:35.442921 | 2025-06-30 03:00:35.443023 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-06-30 03:00:35.466207 | debian-bookworm | skipping: Conditional result was False 2025-06-30 03:00:35.473250 | 2025-06-30 03:00:35.473352 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-06-30 03:00:36.002871 | debian-bookworm -> localhost | changed 2025-06-30 03:00:36.013709 | 2025-06-30 03:00:36.013826 | TASK [add-build-sshkey : Add back temp key] 2025-06-30 03:00:36.430633 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/c2225e769f694e6dbb0778b08366249e/work/c2225e769f694e6dbb0778b08366249e_id_rsa (zuul-build-sshkey) 2025-06-30 03:00:36.430855 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.014754 2025-06-30 03:00:36.438434 | 2025-06-30 03:00:36.438529 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-06-30 03:00:36.907448 | debian-bookworm | ok 2025-06-30 03:00:36.920490 | 2025-06-30 03:00:36.920615 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-06-30 03:00:36.961987 | debian-bookworm | skipping: Conditional result was False 2025-06-30 03:00:36.990013 | 2025-06-30 03:00:36.990214 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-06-30 03:00:37.654505 | debian-bookworm | ok 2025-06-30 03:00:37.676942 | 2025-06-30 03:00:37.677086 | TASK [validate-host : Define zuul_info_dir fact] 2025-06-30 03:00:37.726267 | debian-bookworm | ok 2025-06-30 03:00:37.732141 | 2025-06-30 03:00:37.732250 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-06-30 03:00:38.645950 | debian-bookworm -> localhost | ok 2025-06-30 03:00:38.652374 | 2025-06-30 03:00:38.652484 | TASK [validate-host : Collect information about the host] 2025-06-30 03:00:40.213633 | debian-bookworm | ok 2025-06-30 03:00:40.229693 | 2025-06-30 03:00:40.229798 | TASK [validate-host : Sanitize hostname] 2025-06-30 03:00:40.431805 | debian-bookworm | ok 2025-06-30 03:00:40.552472 | 2025-06-30 03:00:40.552597 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-06-30 03:00:41.417453 | debian-bookworm -> localhost | changed 2025-06-30 03:00:41.423373 | 2025-06-30 03:00:41.423472 | TASK [validate-host : Collect information about zuul worker] 2025-06-30 03:00:41.987547 | debian-bookworm | ok 2025-06-30 03:00:41.992061 | 2025-06-30 03:00:41.992154 | TASK [validate-host : Write out all zuul information for each host] 2025-06-30 03:00:43.029753 | debian-bookworm -> localhost | changed 2025-06-30 03:00:43.047245 | 2025-06-30 03:00:43.047813 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-06-30 03:00:43.374915 | debian-bookworm | ok 2025-06-30 03:00:43.416221 | 2025-06-30 03:00:43.417969 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-06-30 03:00:44.726988 | debian-bookworm | changed: 2025-06-30 03:00:44.727230 | debian-bookworm | cd+++++++++ src/ 2025-06-30 03:00:44.727274 | debian-bookworm | cd+++++++++ src/github.com/ 2025-06-30 03:00:44.727304 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-06-30 03:00:44.727330 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/ 2025-06-30 03:00:44.727354 | debian-bookworm | localhost | ok: Runtime: 0:00:00.020202 2025-06-30 03:01:14.419792 | 2025-06-30 03:01:14.419893 | TASK [upload-logs : Upload logs to log server] 2025-06-30 03:01:15.517919 | localhost | Output suppressed because no_log was given 2025-06-30 03:01:15.519340 | 2025-06-30 03:01:15.519413 | LOOP [upload-logs : Compress console log and json output] 2025-06-30 03:01:15.562527 | localhost | skipping: Conditional result was False 2025-06-30 03:01:15.567338 | localhost | skipping: Conditional result was False 2025-06-30 03:01:15.585158 | 2025-06-30 03:01:15.585243 | LOOP [upload-logs : Upload compressed console log and json output] 2025-06-30 03:01:15.631192 | localhost | skipping: Conditional result was False 2025-06-30 03:01:15.631393 | 2025-06-30 03:01:15.636352 | localhost | skipping: Conditional result was False 2025-06-30 03:01:15.640394 | 2025-06-30 03:01:15.640479 | LOOP [upload-logs : Upload console log and json output]