2025-05-31 03:18:49.638862 | Job console starting 2025-05-31 03:18:49.658286 | Updating git repos 2025-05-31 03:18:49.690728 | Cloning repos into workspace 2025-05-31 03:18:49.737176 | Restoring repo states 2025-05-31 03:18:49.743905 | Merging changes 2025-05-31 03:18:49.743925 | Checking out repos 2025-05-31 03:18:49.815155 | Preparing playbooks 2025-05-31 03:18:50.567340 | Running Ansible setup 2025-05-31 03:18:54.969598 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-05-31 03:18:55.751394 | 2025-05-31 03:18:55.751589 | PLAY [Base pre] 2025-05-31 03:18:55.768366 | 2025-05-31 03:18:55.768523 | TASK [Setup log path fact] 2025-05-31 03:18:55.790337 | debian-bookworm | ok 2025-05-31 03:18:55.810413 | 2025-05-31 03:18:55.810633 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-05-31 03:18:55.842494 | debian-bookworm | ok 2025-05-31 03:18:55.858073 | 2025-05-31 03:18:55.858231 | TASK [emit-job-header : Print job information] 2025-05-31 03:18:55.909885 | # Job Information 2025-05-31 03:18:55.910160 | Ansible Version: 2.16.14 2025-05-31 03:18:55.910211 | Job: python-black 2025-05-31 03:18:55.910256 | Pipeline: periodic-daily 2025-05-31 03:18:55.910288 | Executor: 521e9411259a 2025-05-31 03:18:55.910317 | Triggered by: https://github.com/osism/cfg-cookiecutter 2025-05-31 03:18:55.910349 | Event ID: bd6bf0c1dd11477a846ab38ff24a0933 2025-05-31 03:18:55.917245 | 2025-05-31 03:18:55.917375 | LOOP [emit-job-header : Print node information] 2025-05-31 03:18:56.045853 | debian-bookworm | ok: 2025-05-31 03:18:56.046213 | debian-bookworm | # Node Information 2025-05-31 03:18:56.046269 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-05-31 03:18:56.046310 | debian-bookworm | Hostname: debian 2025-05-31 03:18:56.046347 | debian-bookworm | Username: zuul 2025-05-31 03:18:56.046382 | debian-bookworm | Distro: Debian 12.11 2025-05-31 03:18:56.046421 | debian-bookworm | Provider: regiocloud-a 2025-05-31 03:18:56.046455 | debian-bookworm | Region: 2025-05-31 03:18:56.046488 | debian-bookworm | Label: debian-bookworm 2025-05-31 03:18:56.046520 | debian-bookworm | Product Name: OpenStack Nova 2025-05-31 03:18:56.046553 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe03:3398 2025-05-31 03:18:56.064008 | 2025-05-31 03:18:56.064183 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-05-31 03:18:56.586032 | debian-bookworm -> localhost | changed 2025-05-31 03:18:56.602593 | 2025-05-31 03:18:56.602767 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-05-31 03:18:57.707289 | debian-bookworm -> localhost | changed 2025-05-31 03:18:57.724507 | 2025-05-31 03:18:57.724764 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-05-31 03:18:58.004313 | debian-bookworm -> localhost | ok 2025-05-31 03:18:58.011227 | 2025-05-31 03:18:58.011362 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-05-31 03:18:58.040921 | debian-bookworm | ok 2025-05-31 03:18:58.059344 | debian-bookworm | included: /var/lib/zuul/builds/cfe713d87f114ee7bfd2a017118b617b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-05-31 03:18:58.065563 | 2025-05-31 03:18:58.065663 | TASK [add-build-sshkey : Create Temp SSH key] 2025-05-31 03:18:59.769580 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-05-31 03:18:59.769938 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/cfe713d87f114ee7bfd2a017118b617b/work/cfe713d87f114ee7bfd2a017118b617b_id_rsa 2025-05-31 03:18:59.770012 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/cfe713d87f114ee7bfd2a017118b617b/work/cfe713d87f114ee7bfd2a017118b617b_id_rsa.pub 2025-05-31 03:18:59.770050 | debian-bookworm -> localhost | The key fingerprint is: 2025-05-31 03:18:59.770084 | debian-bookworm -> localhost | SHA256:wbqxFBh+EQrC0v8MBZcOsTz5SfK/13/ckfWUm5mBVEw zuul-build-sshkey 2025-05-31 03:18:59.770117 | debian-bookworm -> localhost | The key's randomart image is: 2025-05-31 03:18:59.770168 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-05-31 03:18:59.770199 | debian-bookworm -> localhost | |o.. +o+o +E | 2025-05-31 03:18:59.770230 | debian-bookworm -> localhost | |.o.+.Boo . . | 2025-05-31 03:18:59.770258 | debian-bookworm -> localhost | |. .X++ o . . .| 2025-05-31 03:18:59.770286 | debian-bookworm -> localhost | | oB.+ . . oo| 2025-05-31 03:18:59.770314 | debian-bookworm -> localhost | | +B S .X| 2025-05-31 03:18:59.770354 | debian-bookworm -> localhost | | .o= B.| 2025-05-31 03:18:59.770384 | debian-bookworm -> localhost | | o . . .o| 2025-05-31 03:18:59.770412 | debian-bookworm -> localhost | | .. . +| 2025-05-31 03:18:59.770441 | debian-bookworm -> localhost | | .. ... | 2025-05-31 03:18:59.770470 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-05-31 03:18:59.770548 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.160454 2025-05-31 03:18:59.781212 | 2025-05-31 03:18:59.781376 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-05-31 03:18:59.832439 | debian-bookworm | ok 2025-05-31 03:18:59.843357 | debian-bookworm | included: /var/lib/zuul/builds/cfe713d87f114ee7bfd2a017118b617b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-05-31 03:18:59.853313 | 2025-05-31 03:18:59.853448 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-05-31 03:18:59.888391 | debian-bookworm | skipping: Conditional result was False 2025-05-31 03:18:59.895928 | 2025-05-31 03:18:59.896105 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-05-31 03:19:00.616950 | debian-bookworm | changed 2025-05-31 03:19:00.625864 | 2025-05-31 03:19:00.626032 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-05-31 03:19:00.894176 | debian-bookworm | ok 2025-05-31 03:19:00.901833 | 2025-05-31 03:19:00.902007 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-05-31 03:19:01.678699 | debian-bookworm | changed 2025-05-31 03:19:01.688189 | 2025-05-31 03:19:01.688333 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-05-31 03:19:02.369318 | debian-bookworm | changed 2025-05-31 03:19:02.375587 | 2025-05-31 03:19:02.375714 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-05-31 03:19:02.411045 | debian-bookworm | skipping: Conditional result was False 2025-05-31 03:19:02.429572 | 2025-05-31 03:19:02.429805 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-05-31 03:19:02.964195 | debian-bookworm -> localhost | changed 2025-05-31 03:19:02.985621 | 2025-05-31 03:19:02.985876 | TASK [add-build-sshkey : Add back temp key] 2025-05-31 03:19:03.426528 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/cfe713d87f114ee7bfd2a017118b617b/work/cfe713d87f114ee7bfd2a017118b617b_id_rsa (zuul-build-sshkey) 2025-05-31 03:19:03.426875 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.029213 2025-05-31 03:19:03.436231 | 2025-05-31 03:19:03.436369 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-05-31 03:19:03.934184 | debian-bookworm | ok 2025-05-31 03:19:03.949066 | 2025-05-31 03:19:03.949245 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-05-31 03:19:04.039712 | debian-bookworm | skipping: Conditional result was False 2025-05-31 03:19:04.065847 | 2025-05-31 03:19:04.066036 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-05-31 03:19:04.546115 | debian-bookworm | ok 2025-05-31 03:19:04.591598 | 2025-05-31 03:19:04.591765 | TASK [validate-host : Define zuul_info_dir fact] 2025-05-31 03:19:04.622310 | debian-bookworm | ok 2025-05-31 03:19:04.627536 | 2025-05-31 03:19:04.627646 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-05-31 03:19:04.945495 | debian-bookworm -> localhost | ok 2025-05-31 03:19:04.953123 | 2025-05-31 03:19:04.953241 | TASK [validate-host : Collect information about the host] 2025-05-31 03:19:06.113275 | debian-bookworm | ok 2025-05-31 03:19:06.123930 | 2025-05-31 03:19:06.124114 | TASK [validate-host : Sanitize hostname] 2025-05-31 03:19:06.256584 | debian-bookworm | ok 2025-05-31 03:19:06.303678 | 2025-05-31 03:19:06.303830 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-05-31 03:19:06.993464 | debian-bookworm -> localhost | changed 2025-05-31 03:19:07.000946 | 2025-05-31 03:19:07.001145 | TASK [validate-host : Collect information about zuul worker] 2025-05-31 03:19:07.460105 | debian-bookworm | ok 2025-05-31 03:19:07.465141 | 2025-05-31 03:19:07.465461 | TASK [validate-host : Write out all zuul information for each host] 2025-05-31 03:19:08.087991 | debian-bookworm -> localhost | changed 2025-05-31 03:19:08.101195 | 2025-05-31 03:19:08.101656 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-05-31 03:19:08.378976 | debian-bookworm | ok 2025-05-31 03:19:08.387881 | 2025-05-31 03:19:08.388030 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-05-31 03:19:09.476082 | debian-bookworm | changed: 2025-05-31 03:19:09.476338 | debian-bookworm | cd+++++++++ src/ 2025-05-31 03:19:09.476372 | debian-bookworm | cd+++++++++ src/github.com/ 2025-05-31 03:19:09.476395 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-05-31 03:19:09.476416 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2025-05-31 03:19:09.476436 | debian-bookworm | Containerfile 2025-05-31 03:19:09.476564 | debian-bookworm | localhost | ok: Runtime: 0:00:00.015031 2025-05-31 03:19:35.050020 | 2025-05-31 03:19:35.050142 | TASK [upload-logs : Upload logs to log server] 2025-05-31 03:19:35.907512 | localhost | Output suppressed because no_log was given 2025-05-31 03:19:35.909559 | 2025-05-31 03:19:35.909684 | LOOP [upload-logs : Compress console log and json output] 2025-05-31 03:19:36.006312 | localhost | skipping: Conditional result was False 2025-05-31 03:19:36.023369 | localhost | skipping: Conditional result was False 2025-05-31 03:19:36.031114 | 2025-05-31 03:19:36.031255 | LOOP [upload-logs : Upload compressed console log and json output] 2025-05-31 03:19:36.139883 | localhost | skipping: Conditional result was False 2025-05-31 03:19:36.140257 | 2025-05-31 03:19:36.153789 | localhost | skipping: Conditional result was False 2025-05-31 03:19:36.176186 | 2025-05-31 03:19:36.176341 | LOOP [upload-logs : Upload console log and json output]