2025-10-26 03:11:18.598226 | Job console starting 2025-10-26 03:11:18.607719 | Updating git repos 2025-10-26 03:11:18.645772 | Cloning repos into workspace 2025-10-26 03:11:18.745216 | Restoring repo states 2025-10-26 03:11:18.765683 | Merging changes 2025-10-26 03:11:18.765704 | Checking out repos 2025-10-26 03:11:18.841671 | Preparing playbooks 2025-10-26 03:11:19.784466 | Running Ansible setup 2025-10-26 03:11:25.047594 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-26 03:11:25.789243 | 2025-10-26 03:11:25.789364 | PLAY [Base pre] 2025-10-26 03:11:25.803701 | 2025-10-26 03:11:25.803802 | TASK [Setup log path fact] 2025-10-26 03:11:25.831501 | debian-bookworm | ok 2025-10-26 03:11:25.846308 | 2025-10-26 03:11:25.846427 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-26 03:11:25.875418 | debian-bookworm | ok 2025-10-26 03:11:25.895409 | 2025-10-26 03:11:25.895541 | TASK [emit-job-header : Print job information] 2025-10-26 03:11:25.924033 | # Job Information 2025-10-26 03:11:25.924271 | Ansible Version: 2.16.14 2025-10-26 03:11:25.924308 | Job: python-black 2025-10-26 03:11:25.924344 | Pipeline: periodic-daily 2025-10-26 03:11:25.924371 | Executor: 521e9411259a 2025-10-26 03:11:25.924391 | Triggered by: https://github.com/osism/cfg-cookiecutter 2025-10-26 03:11:25.924414 | Event ID: ae24ee6854f94f81acc94ef9960ddbb4 2025-10-26 03:11:25.929088 | 2025-10-26 03:11:25.929177 | LOOP [emit-job-header : Print node information] 2025-10-26 03:11:26.026893 | debian-bookworm | ok: 2025-10-26 03:11:26.027060 | debian-bookworm | # Node Information 2025-10-26 03:11:26.027093 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-26 03:11:26.027118 | debian-bookworm | Hostname: debian 2025-10-26 03:11:26.027139 | debian-bookworm | Username: zuul 2025-10-26 03:11:26.027160 | debian-bookworm | Distro: Debian 12.12 2025-10-26 03:11:26.027184 | debian-bookworm | Provider: regiocloud-a 2025-10-26 03:11:26.027204 | debian-bookworm | Region: 2025-10-26 03:11:26.027225 | debian-bookworm | Label: debian-bookworm 2025-10-26 03:11:26.027245 | debian-bookworm | Product Name: OpenStack Nova 2025-10-26 03:11:26.027264 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe25:66d5 2025-10-26 03:11:26.046118 | 2025-10-26 03:11:26.046226 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-26 03:11:26.399683 | debian-bookworm -> localhost | changed 2025-10-26 03:11:26.408718 | 2025-10-26 03:11:26.408831 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-26 03:11:27.343520 | debian-bookworm -> localhost | changed 2025-10-26 03:11:27.363485 | 2025-10-26 03:11:27.363587 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-26 03:11:27.601033 | debian-bookworm -> localhost | ok 2025-10-26 03:11:27.610707 | 2025-10-26 03:11:27.610824 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-26 03:11:27.630329 | debian-bookworm | ok 2025-10-26 03:11:27.646041 | debian-bookworm | included: /var/lib/zuul/builds/92987007d2654e68a10d1bf3074b5d2a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-26 03:11:27.650749 | 2025-10-26 03:11:27.650814 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-26 03:11:29.029750 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-26 03:11:29.030127 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/92987007d2654e68a10d1bf3074b5d2a/work/92987007d2654e68a10d1bf3074b5d2a_id_rsa 2025-10-26 03:11:29.030214 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/92987007d2654e68a10d1bf3074b5d2a/work/92987007d2654e68a10d1bf3074b5d2a_id_rsa.pub 2025-10-26 03:11:29.030274 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-26 03:11:29.030327 | debian-bookworm -> localhost | SHA256:j4RIDIF6b8W8z6rAyDzRDZ2+2uGEFE6kdFbEqAZHmpo zuul-build-sshkey 2025-10-26 03:11:29.030379 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-26 03:11:29.030468 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-26 03:11:29.030524 | debian-bookworm -> localhost | | ++==o | 2025-10-26 03:11:29.030574 | debian-bookworm -> localhost | |+o*+... | 2025-10-26 03:11:29.030621 | debian-bookworm -> localhost | |=o.+o= | 2025-10-26 03:11:29.030666 | debian-bookworm -> localhost | |o+=.=.+. | 2025-10-26 03:11:29.030712 | debian-bookworm -> localhost | |Eo =.+..S | 2025-10-26 03:11:29.030764 | debian-bookworm -> localhost | |ooo + o. o | 2025-10-26 03:11:29.030809 | debian-bookworm -> localhost | |.+oo + o. . | 2025-10-26 03:11:29.030882 | debian-bookworm -> localhost | | ..= . o | 2025-10-26 03:11:29.030931 | debian-bookworm -> localhost | | ..+.. | 2025-10-26 03:11:29.030978 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-26 03:11:29.031084 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.946148 2025-10-26 03:11:29.042405 | 2025-10-26 03:11:29.042584 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-26 03:11:29.074361 | debian-bookworm | ok 2025-10-26 03:11:29.087099 | debian-bookworm | included: /var/lib/zuul/builds/92987007d2654e68a10d1bf3074b5d2a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-26 03:11:29.096404 | 2025-10-26 03:11:29.096493 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-26 03:11:29.119385 | debian-bookworm | skipping: Conditional result was False 2025-10-26 03:11:29.128955 | 2025-10-26 03:11:29.129085 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-26 03:11:29.692704 | debian-bookworm | changed 2025-10-26 03:11:29.698103 | 2025-10-26 03:11:29.698186 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-26 03:11:29.937429 | debian-bookworm | ok 2025-10-26 03:11:29.942660 | 2025-10-26 03:11:29.942748 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-26 03:11:30.628766 | debian-bookworm | changed 2025-10-26 03:11:30.638399 | 2025-10-26 03:11:30.638508 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-26 03:11:31.280973 | debian-bookworm | changed 2025-10-26 03:11:31.289461 | 2025-10-26 03:11:31.289575 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-26 03:11:31.313304 | debian-bookworm | skipping: Conditional result was False 2025-10-26 03:11:31.323043 | 2025-10-26 03:11:31.323167 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-26 03:11:31.729880 | debian-bookworm -> localhost | changed 2025-10-26 03:11:31.748458 | 2025-10-26 03:11:31.748565 | TASK [add-build-sshkey : Add back temp key] 2025-10-26 03:11:32.101660 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/92987007d2654e68a10d1bf3074b5d2a/work/92987007d2654e68a10d1bf3074b5d2a_id_rsa (zuul-build-sshkey) 2025-10-26 03:11:32.101882 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.018026 2025-10-26 03:11:32.109821 | 2025-10-26 03:11:32.109917 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-26 03:11:32.487141 | debian-bookworm | ok 2025-10-26 03:11:32.505645 | 2025-10-26 03:11:32.505886 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-26 03:11:32.532692 | debian-bookworm | skipping: Conditional result was False 2025-10-26 03:11:32.552245 | 2025-10-26 03:11:32.552356 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-26 03:11:32.941236 | debian-bookworm | ok 2025-10-26 03:11:32.953517 | 2025-10-26 03:11:32.953629 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-26 03:11:32.995859 | debian-bookworm | ok 2025-10-26 03:11:33.001652 | 2025-10-26 03:11:33.001761 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-26 03:11:33.435810 | debian-bookworm -> localhost | ok 2025-10-26 03:11:33.444026 | 2025-10-26 03:11:33.444146 | TASK [validate-host : Collect information about the host] 2025-10-26 03:11:34.979300 | debian-bookworm | ok 2025-10-26 03:11:34.993175 | 2025-10-26 03:11:34.993422 | TASK [validate-host : Sanitize hostname] 2025-10-26 03:11:35.129990 | debian-bookworm | ok 2025-10-26 03:11:35.203666 | 2025-10-26 03:11:35.203813 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-26 03:11:36.208359 | debian-bookworm -> localhost | changed 2025-10-26 03:11:36.213160 | 2025-10-26 03:11:36.213239 | TASK [validate-host : Collect information about zuul worker] 2025-10-26 03:11:36.631076 | debian-bookworm | ok 2025-10-26 03:11:36.638328 | 2025-10-26 03:11:36.638478 | TASK [validate-host : Write out all zuul information for each host] 2025-10-26 03:11:37.209845 | debian-bookworm -> localhost | changed 2025-10-26 03:11:37.219226 | 2025-10-26 03:11:37.219319 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-26 03:11:37.538819 | debian-bookworm | ok 2025-10-26 03:11:37.544025 | 2025-10-26 03:11:37.544108 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-26 03:11:38.532224 | debian-bookworm | changed: 2025-10-26 03:11:38.532396 | debian-bookworm | cd+++++++++ src/ 2025-10-26 03:11:38.532431 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-26 03:11:38.532469 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-26 03:11:38.532491 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2025-10-26 03:11:38.532511 | debian-bookworm | Containerfile 2025-10-26 03:11:38.532641 | debian-bookworm | localhost | ok: Runtime: 0:00:00.010246 2025-10-26 03:12:05.340729 | 2025-10-26 03:12:05.340824 | TASK [upload-logs : Upload logs to log server] 2025-10-26 03:12:06.123992 | localhost | Output suppressed because no_log was given 2025-10-26 03:12:06.125309 | 2025-10-26 03:12:06.125389 | LOOP [upload-logs : Compress console log and json output] 2025-10-26 03:12:06.159585 | localhost | skipping: Conditional result was False 2025-10-26 03:12:06.164118 | localhost | skipping: Conditional result was False 2025-10-26 03:12:06.169695 | 2025-10-26 03:12:06.169774 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-26 03:12:06.204815 | localhost | skipping: Conditional result was False 2025-10-26 03:12:06.205025 | 2025-10-26 03:12:06.210163 | localhost | skipping: Conditional result was False 2025-10-26 03:12:06.214045 | 2025-10-26 03:12:06.214128 | LOOP [upload-logs : Upload console log and json output]