2025-10-10 09:06:13.559777 | Job console starting 2025-10-10 09:06:13.589584 | Updating git repos 2025-10-10 09:06:13.630354 | Cloning repos into workspace 2025-10-10 09:06:13.714115 | Restoring repo states 2025-10-10 09:06:13.725650 | Merging changes 2025-10-10 09:06:14.270613 | Checking out repos 2025-10-10 09:06:14.360950 | Preparing playbooks 2025-10-10 09:06:15.511521 | Running Ansible setup 2025-10-10 09:06:21.191384 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-10 09:06:22.443680 | 2025-10-10 09:06:22.443822 | PLAY [Base pre] 2025-10-10 09:06:22.488517 | 2025-10-10 09:06:22.488656 | TASK [Setup log path fact] 2025-10-10 09:06:22.516511 | debian-bookworm | ok 2025-10-10 09:06:22.544113 | 2025-10-10 09:06:22.544253 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-10 09:06:22.583117 | debian-bookworm | ok 2025-10-10 09:06:22.602518 | 2025-10-10 09:06:22.602650 | TASK [emit-job-header : Print job information] 2025-10-10 09:06:22.651682 | # Job Information 2025-10-10 09:06:22.651893 | Ansible Version: 2.16.14 2025-10-10 09:06:22.651928 | Job: python-black 2025-10-10 09:06:22.651963 | Pipeline: check 2025-10-10 09:06:22.651985 | Executor: 521e9411259a 2025-10-10 09:06:22.652006 | Triggered by: https://github.com/osism/python-osism/pull/1745 2025-10-10 09:06:22.652029 | Event ID: 590e24b0-a5b8-11f0-9d90-be025645d811 2025-10-10 09:06:22.666858 | 2025-10-10 09:06:22.666980 | LOOP [emit-job-header : Print node information] 2025-10-10 09:06:22.799947 | debian-bookworm | ok: 2025-10-10 09:06:22.800106 | debian-bookworm | # Node Information 2025-10-10 09:06:22.800139 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-10 09:06:22.800164 | debian-bookworm | Hostname: debian 2025-10-10 09:06:22.800187 | debian-bookworm | Username: zuul 2025-10-10 09:06:22.800208 | debian-bookworm | Distro: Debian 12.12 2025-10-10 09:06:22.800231 | debian-bookworm | Provider: regiocloud-a 2025-10-10 09:06:22.800252 | debian-bookworm | Region: 2025-10-10 09:06:22.800272 | debian-bookworm | Label: debian-bookworm 2025-10-10 09:06:22.800291 | debian-bookworm | Product Name: OpenStack Nova 2025-10-10 09:06:22.800310 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fea0:2f41 2025-10-10 09:06:22.817917 | 2025-10-10 09:06:22.820073 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-10 09:06:23.504248 | debian-bookworm -> localhost | changed 2025-10-10 09:06:23.509826 | 2025-10-10 09:06:23.509919 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-10 09:06:24.740046 | debian-bookworm -> localhost | changed 2025-10-10 09:06:24.748425 | 2025-10-10 09:06:24.748507 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-10 09:06:25.194469 | debian-bookworm -> localhost | ok 2025-10-10 09:06:25.199468 | 2025-10-10 09:06:25.199558 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-10 09:06:25.226457 | debian-bookworm | ok 2025-10-10 09:06:25.252008 | debian-bookworm | included: /var/lib/zuul/builds/572b9cc315a3471ca8bf2c61f828a104/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-10 09:06:25.272344 | 2025-10-10 09:06:25.272434 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-10 09:06:27.324006 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-10 09:06:27.324173 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/572b9cc315a3471ca8bf2c61f828a104/work/572b9cc315a3471ca8bf2c61f828a104_id_rsa 2025-10-10 09:06:27.324204 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/572b9cc315a3471ca8bf2c61f828a104/work/572b9cc315a3471ca8bf2c61f828a104_id_rsa.pub 2025-10-10 09:06:27.324226 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-10 09:06:27.324246 | debian-bookworm -> localhost | SHA256:xpceAtOoW7QH3XsgW6EUaf4LaBLLCwUpNEowmpAHDdk zuul-build-sshkey 2025-10-10 09:06:27.324264 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-10 09:06:27.324290 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-10 09:06:27.324309 | debian-bookworm -> localhost | |O@ . oo. | 2025-10-10 09:06:27.324326 | debian-bookworm -> localhost | |OoE =oo . | 2025-10-10 09:06:27.324343 | debian-bookworm -> localhost | |+o . *o= + | 2025-10-10 09:06:27.324360 | debian-bookworm -> localhost | | oo *.+ + | 2025-10-10 09:06:27.324376 | debian-bookworm -> localhost | | o.oo.S.= . | 2025-10-10 09:06:27.324398 | debian-bookworm -> localhost | | . +ooo.+.o | 2025-10-10 09:06:27.324415 | debian-bookworm -> localhost | | ..+ ... | 2025-10-10 09:06:27.324432 | debian-bookworm -> localhost | | . . | 2025-10-10 09:06:27.324449 | debian-bookworm -> localhost | | | 2025-10-10 09:06:27.324465 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-10 09:06:27.324506 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.334714 2025-10-10 09:06:27.330092 | 2025-10-10 09:06:27.330178 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-10 09:06:27.356559 | debian-bookworm | ok 2025-10-10 09:06:27.366499 | debian-bookworm | included: /var/lib/zuul/builds/572b9cc315a3471ca8bf2c61f828a104/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-10 09:06:27.383584 | 2025-10-10 09:06:27.383673 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-10 09:06:27.416358 | debian-bookworm | skipping: Conditional result was False 2025-10-10 09:06:27.421675 | 2025-10-10 09:06:27.421745 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-10 09:06:28.054653 | debian-bookworm | changed 2025-10-10 09:06:28.059734 | 2025-10-10 09:06:28.059819 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-10 09:06:28.317874 | debian-bookworm | ok 2025-10-10 09:06:28.322221 | 2025-10-10 09:06:28.322294 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-10 09:06:28.933132 | debian-bookworm | changed 2025-10-10 09:06:28.943602 | 2025-10-10 09:06:28.943737 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-10 09:06:29.572137 | debian-bookworm | changed 2025-10-10 09:06:29.577651 | 2025-10-10 09:06:29.577738 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-10 09:06:29.600735 | debian-bookworm | skipping: Conditional result was False 2025-10-10 09:06:29.611953 | 2025-10-10 09:06:29.612069 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-10 09:06:30.040056 | debian-bookworm -> localhost | changed 2025-10-10 09:06:30.050910 | 2025-10-10 09:06:30.051003 | TASK [add-build-sshkey : Add back temp key] 2025-10-10 09:06:30.317861 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/572b9cc315a3471ca8bf2c61f828a104/work/572b9cc315a3471ca8bf2c61f828a104_id_rsa (zuul-build-sshkey) 2025-10-10 09:06:30.318052 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.008396 2025-10-10 09:06:30.335298 | 2025-10-10 09:06:30.335394 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-10 09:06:30.758426 | debian-bookworm | ok 2025-10-10 09:06:30.762551 | 2025-10-10 09:06:30.762657 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-10 09:06:30.811388 | debian-bookworm | skipping: Conditional result was False 2025-10-10 09:06:30.819698 | 2025-10-10 09:06:30.819792 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-10 09:06:31.399235 | debian-bookworm | ok 2025-10-10 09:06:31.407693 | 2025-10-10 09:06:31.407790 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-10 09:06:31.434087 | debian-bookworm | ok 2025-10-10 09:06:31.438081 | 2025-10-10 09:06:31.438152 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-10 09:06:31.737798 | debian-bookworm -> localhost | ok 2025-10-10 09:06:31.746540 | 2025-10-10 09:06:31.746680 | TASK [validate-host : Collect information about the host] 2025-10-10 09:06:32.785621 | debian-bookworm | ok 2025-10-10 09:06:32.793704 | 2025-10-10 09:06:32.793782 | TASK [validate-host : Sanitize hostname] 2025-10-10 09:06:32.879529 | debian-bookworm | ok 2025-10-10 09:06:32.912524 | 2025-10-10 09:06:32.912626 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-10 09:06:33.416709 | debian-bookworm -> localhost | changed 2025-10-10 09:06:33.422008 | 2025-10-10 09:06:33.422095 | TASK [validate-host : Collect information about zuul worker] 2025-10-10 09:06:33.884684 | debian-bookworm | ok 2025-10-10 09:06:33.889233 | 2025-10-10 09:06:33.889324 | TASK [validate-host : Write out all zuul information for each host] 2025-10-10 09:06:34.508079 | debian-bookworm -> localhost | changed 2025-10-10 09:06:34.520892 | 2025-10-10 09:06:34.520990 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-10 09:06:34.793949 | debian-bookworm | ok 2025-10-10 09:06:34.800616 | 2025-10-10 09:06:34.800751 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-10 09:06:35.846591 | debian-bookworm | changed: 2025-10-10 09:06:35.846937 | debian-bookworm | cd+++++++++ src/ 2025-10-10 09:06:35.847001 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-10 09:06:35.847045 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-10 09:06:35.847084 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-10-10 09:06:35.847120 | debian-bookworm | Containerfile 2025-10-10 09:06:35.847308 | debian-bookworm | Containerfile 2025-10-10 09:06:35.896823 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006427 2025-10-10 09:07:00.800234 | 2025-10-10 09:07:00.800455 | TASK [upload-logs : Upload logs to log server] 2025-10-10 09:07:01.340891 | localhost | Output suppressed because no_log was given 2025-10-10 09:07:01.344635 | 2025-10-10 09:07:01.344848 | LOOP [upload-logs : Compress console log and json output] 2025-10-10 09:07:01.394421 | localhost | skipping: Conditional result was False 2025-10-10 09:07:01.399389 | localhost | skipping: Conditional result was False 2025-10-10 09:07:01.411996 | 2025-10-10 09:07:01.412103 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-10 09:07:01.463432 | localhost | skipping: Conditional result was False 2025-10-10 09:07:01.463991 | 2025-10-10 09:07:01.468487 | localhost | skipping: Conditional result was False 2025-10-10 09:07:01.481487 | 2025-10-10 09:07:01.481733 | LOOP [upload-logs : Upload console log and json output]