2026-02-25 01:49:52.825769 | Job console starting 2026-02-25 01:49:52.874408 | Updating git repos 2026-02-25 01:49:52.976223 | Cloning repos into workspace 2026-02-25 01:49:53.033771 | Restoring repo states 2026-02-25 01:49:53.070605 | Merging changes 2026-02-25 01:49:53.736310 | Checking out repos 2026-02-25 01:49:53.862740 | Preparing playbooks 2026-02-25 01:49:54.778821 | Running Ansible setup 2026-02-25 01:50:00.812875 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-02-25 01:50:01.798774 | 2026-02-25 01:50:01.799009 | PLAY [Base pre] 2026-02-25 01:50:01.834112 | 2026-02-25 01:50:01.834281 | TASK [Setup log path fact] 2026-02-25 01:50:01.865977 | debian-bookworm | ok 2026-02-25 01:50:01.898238 | 2026-02-25 01:50:01.898414 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-25 01:50:01.966570 | debian-bookworm | ok 2026-02-25 01:50:01.988670 | 2026-02-25 01:50:01.988829 | TASK [emit-job-header : Print job information] 2026-02-25 01:50:02.111461 | # Job Information 2026-02-25 01:50:02.111665 | Ansible Version: 2.16.14 2026-02-25 01:50:02.111702 | Job: python-black 2026-02-25 01:50:02.111736 | Pipeline: check 2026-02-25 01:50:02.111759 | Executor: 521e9411259a 2026-02-25 01:50:02.111780 | Triggered by: https://github.com/osism/python-osism/pull/2045 2026-02-25 01:50:02.111803 | Event ID: 416c59d0-11ec-11f1-9af3-50811edcc074 2026-02-25 01:50:02.120732 | 2026-02-25 01:50:02.120865 | LOOP [emit-job-header : Print node information] 2026-02-25 01:50:02.376865 | debian-bookworm | ok: 2026-02-25 01:50:02.377069 | debian-bookworm | # Node Information 2026-02-25 01:50:02.377103 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-02-25 01:50:02.377128 | debian-bookworm | Hostname: debian 2026-02-25 01:50:02.377149 | debian-bookworm | Username: zuul 2026-02-25 01:50:02.377170 | debian-bookworm | Distro: Debian 12.13 2026-02-25 01:50:02.377193 | debian-bookworm | Provider: regiocloud-a 2026-02-25 01:50:02.377213 | debian-bookworm | Region: 2026-02-25 01:50:02.377234 | debian-bookworm | Label: debian-bookworm 2026-02-25 01:50:02.377254 | debian-bookworm | Product Name: OpenStack Nova 2026-02-25 01:50:02.377274 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fee6:24f8 2026-02-25 01:50:02.392100 | 2026-02-25 01:50:02.392239 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-02-25 01:50:03.232847 | debian-bookworm -> localhost | changed 2026-02-25 01:50:03.253462 | 2026-02-25 01:50:03.253581 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-02-25 01:50:04.809636 | debian-bookworm -> localhost | changed 2026-02-25 01:50:04.820103 | 2026-02-25 01:50:04.820214 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-25 01:50:05.449256 | debian-bookworm -> localhost | ok 2026-02-25 01:50:05.457609 | 2026-02-25 01:50:05.457748 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-25 01:50:05.506209 | debian-bookworm | ok 2026-02-25 01:50:05.540085 | debian-bookworm | included: /var/lib/zuul/builds/93d0c23be5664d8db88b7413f503d6f2/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-25 01:50:05.553564 | 2026-02-25 01:50:05.553685 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-25 01:50:08.187260 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-02-25 01:50:08.187452 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/93d0c23be5664d8db88b7413f503d6f2/work/93d0c23be5664d8db88b7413f503d6f2_id_rsa 2026-02-25 01:50:08.187490 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/93d0c23be5664d8db88b7413f503d6f2/work/93d0c23be5664d8db88b7413f503d6f2_id_rsa.pub 2026-02-25 01:50:08.187516 | debian-bookworm -> localhost | The key fingerprint is: 2026-02-25 01:50:08.187541 | debian-bookworm -> localhost | SHA256:zJurgb7+6hhn9Jm+scP6uh0pKhXV82QJGjw64yj5tWA zuul-build-sshkey 2026-02-25 01:50:08.187563 | debian-bookworm -> localhost | The key's randomart image is: 2026-02-25 01:50:08.187596 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-02-25 01:50:08.187619 | debian-bookworm -> localhost | | ..... . | 2026-02-25 01:50:08.187642 | debian-bookworm -> localhost | | +oo + | 2026-02-25 01:50:08.187678 | debian-bookworm -> localhost | | o.. = | 2026-02-25 01:50:08.187699 | debian-bookworm -> localhost | | = o. | 2026-02-25 01:50:08.187720 | debian-bookworm -> localhost | | + +. S | 2026-02-25 01:50:08.187746 | debian-bookworm -> localhost | |+ E..o + o | 2026-02-25 01:50:08.187766 | debian-bookworm -> localhost | |.+.o=oO o | 2026-02-25 01:50:08.187786 | debian-bookworm -> localhost | |. .B.+o= . | 2026-02-25 01:50:08.187807 | debian-bookworm -> localhost | | .ooXOO+. | 2026-02-25 01:50:08.187827 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-02-25 01:50:08.187884 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.614199 2026-02-25 01:50:08.195319 | 2026-02-25 01:50:08.195416 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-25 01:50:08.223455 | debian-bookworm | ok 2026-02-25 01:50:08.241976 | debian-bookworm | included: /var/lib/zuul/builds/93d0c23be5664d8db88b7413f503d6f2/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-25 01:50:08.264373 | 2026-02-25 01:50:08.264484 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-25 01:50:08.300620 | debian-bookworm | skipping: Conditional result was False 2026-02-25 01:50:08.306580 | 2026-02-25 01:50:08.306689 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-25 01:50:09.105289 | debian-bookworm | changed 2026-02-25 01:50:09.110502 | 2026-02-25 01:50:09.110608 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-25 01:50:09.439409 | debian-bookworm | ok 2026-02-25 01:50:09.444937 | 2026-02-25 01:50:09.445027 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-25 01:50:10.170104 | debian-bookworm | changed 2026-02-25 01:50:10.176514 | 2026-02-25 01:50:10.176610 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-25 01:50:10.787529 | debian-bookworm | changed 2026-02-25 01:50:10.792974 | 2026-02-25 01:50:10.793972 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-25 01:50:10.817129 | debian-bookworm | skipping: Conditional result was False 2026-02-25 01:50:10.827927 | 2026-02-25 01:50:10.828042 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-25 01:50:11.460808 | debian-bookworm -> localhost | changed 2026-02-25 01:50:11.469780 | 2026-02-25 01:50:11.469868 | TASK [add-build-sshkey : Add back temp key] 2026-02-25 01:50:12.062859 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/93d0c23be5664d8db88b7413f503d6f2/work/93d0c23be5664d8db88b7413f503d6f2_id_rsa (zuul-build-sshkey) 2026-02-25 01:50:12.063393 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.018058 2026-02-25 01:50:12.076791 | 2026-02-25 01:50:12.076944 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-25 01:50:12.445098 | debian-bookworm | ok 2026-02-25 01:50:12.449221 | 2026-02-25 01:50:12.449312 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-25 01:50:12.487253 | debian-bookworm | skipping: Conditional result was False 2026-02-25 01:50:12.495839 | 2026-02-25 01:50:12.495928 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-02-25 01:50:12.969762 | debian-bookworm | ok 2026-02-25 01:50:12.981331 | 2026-02-25 01:50:12.981423 | TASK [validate-host : Define zuul_info_dir fact] 2026-02-25 01:50:13.026953 | debian-bookworm | ok 2026-02-25 01:50:13.031295 | 2026-02-25 01:50:13.031388 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-02-25 01:50:13.633824 | debian-bookworm -> localhost | ok 2026-02-25 01:50:13.638939 | 2026-02-25 01:50:13.639021 | TASK [validate-host : Collect information about the host] 2026-02-25 01:50:14.764932 | debian-bookworm | ok 2026-02-25 01:50:14.821836 | 2026-02-25 01:50:14.822726 | TASK [validate-host : Sanitize hostname] 2026-02-25 01:50:15.157053 | debian-bookworm | ok 2026-02-25 01:50:15.214982 | 2026-02-25 01:50:15.215084 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-02-25 01:50:15.860160 | debian-bookworm -> localhost | changed 2026-02-25 01:50:15.865537 | 2026-02-25 01:50:15.865627 | TASK [validate-host : Collect information about zuul worker] 2026-02-25 01:50:16.321148 | debian-bookworm | ok 2026-02-25 01:50:16.324916 | 2026-02-25 01:50:16.325008 | TASK [validate-host : Write out all zuul information for each host] 2026-02-25 01:50:17.366401 | debian-bookworm -> localhost | changed 2026-02-25 01:50:17.375935 | 2026-02-25 01:50:17.376041 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-02-25 01:50:17.677420 | debian-bookworm | ok 2026-02-25 01:50:17.682747 | 2026-02-25 01:50:17.682859 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-02-25 01:50:18.837813 | debian-bookworm | changed: 2026-02-25 01:50:18.837988 | debian-bookworm | cd+++++++++ src/ 2026-02-25 01:50:18.838021 | debian-bookworm | cd+++++++++ src/github.com/ 2026-02-25 01:50:18.838044 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-02-25 01:50:18.838066 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-02-25 01:50:18.838086 | debian-bookworm | Containerfile 2026-02-25 01:50:18.838223 | debian-bookworm | Containerfile 2026-02-25 01:50:18.843455 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007607 2026-02-25 01:50:46.421314 | 2026-02-25 01:50:46.421440 | TASK [upload-logs : Upload logs to log server] 2026-02-25 01:50:47.040175 | localhost | Output suppressed because no_log was given 2026-02-25 01:50:47.043575 | 2026-02-25 01:50:47.043981 | LOOP [upload-logs : Compress console log and json output] 2026-02-25 01:50:47.113444 | localhost | skipping: Conditional result was False 2026-02-25 01:50:47.119443 | localhost | skipping: Conditional result was False 2026-02-25 01:50:47.126962 | 2026-02-25 01:50:47.127190 | LOOP [upload-logs : Upload compressed console log and json output] 2026-02-25 01:50:47.179164 | localhost | skipping: Conditional result was False 2026-02-25 01:50:47.179989 | 2026-02-25 01:50:47.182597 | localhost | skipping: Conditional result was False 2026-02-25 01:50:47.189168 | 2026-02-25 01:50:47.189329 | LOOP [upload-logs : Upload console log and json output]