2025-07-06 03:27:46.754920 | Job console starting 2025-07-06 03:27:46.764174 | Updating git repos 2025-07-06 03:27:46.787706 | Cloning repos into workspace 2025-07-06 03:27:46.832021 | Restoring repo states 2025-07-06 03:27:46.839883 | Merging changes 2025-07-06 03:27:46.839902 | Checking out repos 2025-07-06 03:27:46.920404 | Preparing playbooks 2025-07-06 03:27:47.549433 | Running Ansible setup 2025-07-06 03:27:51.804514 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-07-06 03:27:52.590749 | 2025-07-06 03:27:52.590939 | PLAY [Base pre] 2025-07-06 03:27:52.607277 | 2025-07-06 03:27:52.607424 | TASK [Setup log path fact] 2025-07-06 03:27:52.636647 | debian-bookworm | ok 2025-07-06 03:27:52.652104 | 2025-07-06 03:27:52.652259 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-07-06 03:27:52.695522 | debian-bookworm | ok 2025-07-06 03:27:52.707063 | 2025-07-06 03:27:52.707196 | TASK [emit-job-header : Print job information] 2025-07-06 03:27:52.760766 | # Job Information 2025-07-06 03:27:52.761002 | Ansible Version: 2.16.14 2025-07-06 03:27:52.761046 | Job: python-black 2025-07-06 03:27:52.761110 | Pipeline: periodic-daily 2025-07-06 03:27:52.761142 | Executor: 521e9411259a 2025-07-06 03:27:52.761168 | Triggered by: https://github.com/osism/testbed 2025-07-06 03:27:52.761196 | Event ID: 0c4bc19286bc4ac890904ffad6a69070 2025-07-06 03:27:52.767040 | 2025-07-06 03:27:52.767255 | LOOP [emit-job-header : Print node information] 2025-07-06 03:27:52.873276 | debian-bookworm | ok: 2025-07-06 03:27:52.873545 | debian-bookworm | # Node Information 2025-07-06 03:27:52.873586 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-07-06 03:27:52.873612 | debian-bookworm | Hostname: debian 2025-07-06 03:27:52.873634 | debian-bookworm | Username: zuul 2025-07-06 03:27:52.873655 | debian-bookworm | Distro: Debian 12.11 2025-07-06 03:27:52.873679 | debian-bookworm | Provider: regiocloud-a 2025-07-06 03:27:52.873700 | debian-bookworm | Region: 2025-07-06 03:27:52.873721 | debian-bookworm | Label: debian-bookworm 2025-07-06 03:27:52.873740 | debian-bookworm | Product Name: OpenStack Nova 2025-07-06 03:27:52.873759 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fefb:39d0 2025-07-06 03:27:52.900424 | 2025-07-06 03:27:52.900605 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-07-06 03:27:53.391493 | debian-bookworm -> localhost | changed 2025-07-06 03:27:53.399207 | 2025-07-06 03:27:53.399340 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-07-06 03:27:54.497555 | debian-bookworm -> localhost | changed 2025-07-06 03:27:54.523370 | 2025-07-06 03:27:54.523543 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-07-06 03:27:54.855830 | debian-bookworm -> localhost | ok 2025-07-06 03:27:54.870879 | 2025-07-06 03:27:54.871103 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-07-06 03:27:54.908318 | debian-bookworm | ok 2025-07-06 03:27:54.944613 | debian-bookworm | included: /var/lib/zuul/builds/efa93c3e09e34c57b8f5f23cd2a9a8f4/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-07-06 03:27:54.952809 | 2025-07-06 03:27:54.952930 | TASK [add-build-sshkey : Create Temp SSH key] 2025-07-06 03:27:57.045730 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-07-06 03:27:57.045983 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/efa93c3e09e34c57b8f5f23cd2a9a8f4/work/efa93c3e09e34c57b8f5f23cd2a9a8f4_id_rsa 2025-07-06 03:27:57.046024 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/efa93c3e09e34c57b8f5f23cd2a9a8f4/work/efa93c3e09e34c57b8f5f23cd2a9a8f4_id_rsa.pub 2025-07-06 03:27:57.046051 | debian-bookworm -> localhost | The key fingerprint is: 2025-07-06 03:27:57.046095 | debian-bookworm -> localhost | SHA256:K6nG/yrueRNt98fuY1f0KX2E/EizTjYVkQNfD/Zy0HQ zuul-build-sshkey 2025-07-06 03:27:57.046120 | debian-bookworm -> localhost | The key's randomart image is: 2025-07-06 03:27:57.046157 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-07-06 03:27:57.046180 | debian-bookworm -> localhost | | .=+E| 2025-07-06 03:27:57.046202 | debian-bookworm -> localhost | | ..B=| 2025-07-06 03:27:57.046221 | debian-bookworm -> localhost | | ..o*| 2025-07-06 03:27:57.046241 | debian-bookworm -> localhost | | =o+| 2025-07-06 03:27:57.046260 | debian-bookworm -> localhost | | .S ..Oo| 2025-07-06 03:27:57.046286 | debian-bookworm -> localhost | | ..o.. .*o=| 2025-07-06 03:27:57.046306 | debian-bookworm -> localhost | | . oo.. . =..o| 2025-07-06 03:27:57.046327 | debian-bookworm -> localhost | | +oo. . * .| 2025-07-06 03:27:57.046347 | debian-bookworm -> localhost | | +=+o+. =oo | 2025-07-06 03:27:57.046368 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-07-06 03:27:57.046424 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.554329 2025-07-06 03:27:57.055521 | 2025-07-06 03:27:57.055663 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-07-06 03:27:57.103632 | debian-bookworm | ok 2025-07-06 03:27:57.123329 | debian-bookworm | included: /var/lib/zuul/builds/efa93c3e09e34c57b8f5f23cd2a9a8f4/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-07-06 03:27:57.141019 | 2025-07-06 03:27:57.141388 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-07-06 03:27:57.169102 | debian-bookworm | skipping: Conditional result was False 2025-07-06 03:27:57.179358 | 2025-07-06 03:27:57.179499 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-07-06 03:27:57.966259 | debian-bookworm | changed 2025-07-06 03:27:57.976098 | 2025-07-06 03:27:57.976232 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-07-06 03:27:58.255333 | debian-bookworm | ok 2025-07-06 03:27:58.268583 | 2025-07-06 03:27:58.268739 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-07-06 03:27:59.026058 | debian-bookworm | changed 2025-07-06 03:27:59.033563 | 2025-07-06 03:27:59.033699 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-07-06 03:27:59.729939 | debian-bookworm | changed 2025-07-06 03:27:59.740024 | 2025-07-06 03:27:59.740226 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-07-06 03:27:59.764690 | debian-bookworm | skipping: Conditional result was False 2025-07-06 03:27:59.772440 | 2025-07-06 03:27:59.772583 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-07-06 03:28:00.257180 | debian-bookworm -> localhost | changed 2025-07-06 03:28:00.281353 | 2025-07-06 03:28:00.281524 | TASK [add-build-sshkey : Add back temp key] 2025-07-06 03:28:00.646039 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/efa93c3e09e34c57b8f5f23cd2a9a8f4/work/efa93c3e09e34c57b8f5f23cd2a9a8f4_id_rsa (zuul-build-sshkey) 2025-07-06 03:28:00.646340 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.012385 2025-07-06 03:28:00.655222 | 2025-07-06 03:28:00.655362 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-07-06 03:28:01.069237 | debian-bookworm | ok 2025-07-06 03:28:01.079588 | 2025-07-06 03:28:01.079742 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-07-06 03:28:01.124189 | debian-bookworm | skipping: Conditional result was False 2025-07-06 03:28:01.145006 | 2025-07-06 03:28:01.145191 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-07-06 03:28:01.665970 | debian-bookworm | ok 2025-07-06 03:28:01.686589 | 2025-07-06 03:28:01.686726 | TASK [validate-host : Define zuul_info_dir fact] 2025-07-06 03:28:01.715685 | debian-bookworm | ok 2025-07-06 03:28:01.720992 | 2025-07-06 03:28:01.721150 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-07-06 03:28:02.130323 | debian-bookworm -> localhost | ok 2025-07-06 03:28:02.137686 | 2025-07-06 03:28:02.137822 | TASK [validate-host : Collect information about the host] 2025-07-06 03:28:03.388471 | debian-bookworm | ok 2025-07-06 03:28:03.398732 | 2025-07-06 03:28:03.398873 | TASK [validate-host : Sanitize hostname] 2025-07-06 03:28:03.499328 | debian-bookworm | ok 2025-07-06 03:28:03.585956 | 2025-07-06 03:28:03.586159 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-07-06 03:28:04.368554 | debian-bookworm -> localhost | changed 2025-07-06 03:28:04.375374 | 2025-07-06 03:28:04.375505 | TASK [validate-host : Collect information about zuul worker] 2025-07-06 03:28:04.803148 | debian-bookworm | ok 2025-07-06 03:28:04.808021 | 2025-07-06 03:28:04.808203 | TASK [validate-host : Write out all zuul information for each host] 2025-07-06 03:28:05.405991 | debian-bookworm -> localhost | changed 2025-07-06 03:28:05.416239 | 2025-07-06 03:28:05.416368 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-07-06 03:28:05.700879 | debian-bookworm | ok 2025-07-06 03:28:05.712147 | 2025-07-06 03:28:05.712379 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-07-06 03:28:07.508736 | debian-bookworm | changed: 2025-07-06 03:28:07.509048 | debian-bookworm | cd+++++++++ src/ 2025-07-06 03:28:07.509113 | debian-bookworm | cd+++++++++ src/github.com/ 2025-07-06 03:28:07.509139 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-07-06 03:28:07.509162 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2025-07-06 03:28:07.509183 | debian-bookworm | localhost | ok: Runtime: 0:00:00.028448 2025-07-06 03:28:35.184291 | 2025-07-06 03:28:35.184435 | TASK [upload-logs : Upload logs to log server] 2025-07-06 03:28:35.822535 | localhost | Output suppressed because no_log was given 2025-07-06 03:28:35.824608 | 2025-07-06 03:28:35.824724 | LOOP [upload-logs : Compress console log and json output] 2025-07-06 03:28:35.874593 | localhost | skipping: Conditional result was False 2025-07-06 03:28:35.881183 | localhost | skipping: Conditional result was False 2025-07-06 03:28:35.892083 | 2025-07-06 03:28:35.892223 | LOOP [upload-logs : Upload compressed console log and json output] 2025-07-06 03:28:35.986431 | localhost | skipping: Conditional result was False 2025-07-06 03:28:35.986736 | 2025-07-06 03:28:36.002597 | localhost | skipping: Conditional result was False 2025-07-06 03:28:36.010152 | 2025-07-06 03:28:36.010305 | LOOP [upload-logs : Upload console log and json output]