2026-04-07 18:31:50.363956 | Job console starting 2026-04-07 18:31:50.372944 | Updating git repos 2026-04-07 18:31:50.431406 | Cloning repos into workspace 2026-04-07 18:31:50.528563 | Restoring repo states 2026-04-07 18:31:50.564915 | Merging changes 2026-04-07 18:31:51.235349 | Checking out repos 2026-04-07 18:31:51.272168 | Preparing playbooks 2026-04-07 18:31:51.847056 | Running Ansible setup 2026-04-07 18:31:56.770192 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-04-07 18:31:57.923448 | 2026-04-07 18:31:57.923618 | PLAY [Base pre] 2026-04-07 18:31:57.955095 | 2026-04-07 18:31:57.955261 | TASK [Setup log path fact] 2026-04-07 18:31:57.975267 | debian-bookworm | ok 2026-04-07 18:31:57.990863 | 2026-04-07 18:31:57.991016 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-07 18:31:58.022051 | debian-bookworm | ok 2026-04-07 18:31:58.052980 | 2026-04-07 18:31:58.053114 | TASK [emit-job-header : Print job information] 2026-04-07 18:31:58.092619 | # Job Information 2026-04-07 18:31:58.092816 | Ansible Version: 2.16.14 2026-04-07 18:31:58.092853 | Job: python-black 2026-04-07 18:31:58.092886 | Pipeline: check 2026-04-07 18:31:58.092908 | Executor: 521e9411259a 2026-04-07 18:31:58.092929 | Triggered by: https://github.com/osism/python-osism/pull/2171 2026-04-07 18:31:58.092951 | Event ID: fa056840-32af-11f1-8d44-a340073d1a9b 2026-04-07 18:31:58.098015 | 2026-04-07 18:31:58.098134 | LOOP [emit-job-header : Print node information] 2026-04-07 18:31:58.208130 | debian-bookworm | ok: 2026-04-07 18:31:58.208375 | debian-bookworm | # Node Information 2026-04-07 18:31:58.208415 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-04-07 18:31:58.208442 | debian-bookworm | Hostname: debian 2026-04-07 18:31:58.208464 | debian-bookworm | Username: zuul 2026-04-07 18:31:58.208485 | debian-bookworm | Distro: Debian 12.13 2026-04-07 18:31:58.208509 | debian-bookworm | Provider: regiocloud-a 2026-04-07 18:31:58.208530 | debian-bookworm | Region: 2026-04-07 18:31:58.208552 | debian-bookworm | Label: debian-bookworm 2026-04-07 18:31:58.208572 | debian-bookworm | Product Name: OpenStack Nova 2026-04-07 18:31:58.208592 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feb4:c6cc 2026-04-07 18:31:58.231722 | 2026-04-07 18:31:58.232001 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-07 18:31:59.166478 | debian-bookworm -> localhost | changed 2026-04-07 18:31:59.173990 | 2026-04-07 18:31:59.174121 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-07 18:32:01.004154 | debian-bookworm -> localhost | changed 2026-04-07 18:32:01.020105 | 2026-04-07 18:32:01.020261 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-07 18:32:01.693688 | debian-bookworm -> localhost | ok 2026-04-07 18:32:01.700198 | 2026-04-07 18:32:01.700379 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-07 18:32:01.750711 | debian-bookworm | ok 2026-04-07 18:32:01.797828 | debian-bookworm | included: /var/lib/zuul/builds/38dc947474e64911b1560f44f8debd9f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-07 18:32:01.809553 | 2026-04-07 18:32:01.815935 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-07 18:32:05.099173 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-04-07 18:32:05.099366 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/38dc947474e64911b1560f44f8debd9f/work/38dc947474e64911b1560f44f8debd9f_id_rsa 2026-04-07 18:32:05.099399 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/38dc947474e64911b1560f44f8debd9f/work/38dc947474e64911b1560f44f8debd9f_id_rsa.pub 2026-04-07 18:32:05.099421 | debian-bookworm -> localhost | The key fingerprint is: 2026-04-07 18:32:05.099442 | debian-bookworm -> localhost | SHA256:0pI+vz9D2EXxCaNqsNv8XpdFPl6dqHydMI0KhBKtVnY zuul-build-sshkey 2026-04-07 18:32:05.099461 | debian-bookworm -> localhost | The key's randomart image is: 2026-04-07 18:32:05.099488 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-04-07 18:32:05.099507 | debian-bookworm -> localhost | | .. +. | 2026-04-07 18:32:05.099525 | debian-bookworm -> localhost | | .+.E ..+ . | 2026-04-07 18:32:05.099542 | debian-bookworm -> localhost | | .=..... o .| 2026-04-07 18:32:05.099559 | debian-bookworm -> localhost | | o.=.. . +oo| 2026-04-07 18:32:05.099575 | debian-bookworm -> localhost | | . = S+ . = +=| 2026-04-07 18:32:05.099595 | debian-bookworm -> localhost | | . B. = o =o+| 2026-04-07 18:32:05.099612 | debian-bookworm -> localhost | | + o. +..o+ | 2026-04-07 18:32:05.099629 | debian-bookworm -> localhost | | o .o... | 2026-04-07 18:32:05.099645 | debian-bookworm -> localhost | | o++o | 2026-04-07 18:32:05.099662 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-04-07 18:32:05.099701 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.908915 2026-04-07 18:32:05.105824 | 2026-04-07 18:32:05.105911 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-07 18:32:05.134594 | debian-bookworm | ok 2026-04-07 18:32:05.146726 | debian-bookworm | included: /var/lib/zuul/builds/38dc947474e64911b1560f44f8debd9f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-07 18:32:05.176008 | 2026-04-07 18:32:05.176101 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-07 18:32:05.229339 | debian-bookworm | skipping: Conditional result was False 2026-04-07 18:32:05.234137 | 2026-04-07 18:32:05.234226 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-07 18:32:05.952885 | debian-bookworm | changed 2026-04-07 18:32:05.957448 | 2026-04-07 18:32:05.957523 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-07 18:32:06.270529 | debian-bookworm | ok 2026-04-07 18:32:06.275156 | 2026-04-07 18:32:06.275239 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-07 18:32:07.046862 | debian-bookworm | changed 2026-04-07 18:32:07.062236 | 2026-04-07 18:32:07.062419 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-07 18:32:07.822740 | debian-bookworm | changed 2026-04-07 18:32:07.827988 | 2026-04-07 18:32:07.828081 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-07 18:32:07.861247 | debian-bookworm | skipping: Conditional result was False 2026-04-07 18:32:07.867379 | 2026-04-07 18:32:07.867476 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-07 18:32:08.559796 | debian-bookworm -> localhost | changed 2026-04-07 18:32:08.576809 | 2026-04-07 18:32:08.576918 | TASK [add-build-sshkey : Add back temp key] 2026-04-07 18:32:09.247200 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/38dc947474e64911b1560f44f8debd9f/work/38dc947474e64911b1560f44f8debd9f_id_rsa (zuul-build-sshkey) 2026-04-07 18:32:09.247399 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.016605 2026-04-07 18:32:09.255828 | 2026-04-07 18:32:09.255912 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-07 18:32:09.809579 | debian-bookworm | ok 2026-04-07 18:32:09.813876 | 2026-04-07 18:32:09.813959 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-07 18:32:09.846867 | debian-bookworm | skipping: Conditional result was False 2026-04-07 18:32:09.855897 | 2026-04-07 18:32:09.855986 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-04-07 18:32:10.294707 | debian-bookworm | ok 2026-04-07 18:32:10.312915 | 2026-04-07 18:32:10.313079 | TASK [validate-host : Define zuul_info_dir fact] 2026-04-07 18:32:10.361871 | debian-bookworm | ok 2026-04-07 18:32:10.375364 | 2026-04-07 18:32:10.375472 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-04-07 18:32:11.214137 | debian-bookworm -> localhost | ok 2026-04-07 18:32:11.225158 | 2026-04-07 18:32:11.225260 | TASK [validate-host : Collect information about the host] 2026-04-07 18:32:13.048474 | debian-bookworm | ok 2026-04-07 18:32:13.084397 | 2026-04-07 18:32:13.084495 | TASK [validate-host : Sanitize hostname] 2026-04-07 18:32:13.379272 | debian-bookworm | ok 2026-04-07 18:32:13.507890 | 2026-04-07 18:32:13.507992 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-04-07 18:32:14.657899 | debian-bookworm -> localhost | changed 2026-04-07 18:32:14.662865 | 2026-04-07 18:32:14.662955 | TASK [validate-host : Collect information about zuul worker] 2026-04-07 18:32:15.097588 | debian-bookworm | ok 2026-04-07 18:32:15.103217 | 2026-04-07 18:32:15.103327 | TASK [validate-host : Write out all zuul information for each host] 2026-04-07 18:32:15.698382 | debian-bookworm -> localhost | changed 2026-04-07 18:32:15.709147 | 2026-04-07 18:32:15.709374 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-04-07 18:32:15.983916 | debian-bookworm | ok 2026-04-07 18:32:15.994459 | 2026-04-07 18:32:15.994562 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-04-07 18:32:17.482538 | debian-bookworm | changed: 2026-04-07 18:32:17.482724 | debian-bookworm | cd+++++++++ src/ 2026-04-07 18:32:17.482759 | debian-bookworm | cd+++++++++ src/github.com/ 2026-04-07 18:32:17.482784 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-04-07 18:32:17.482806 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-04-07 18:32:17.482827 | debian-bookworm | Containerfile 2026-04-07 18:32:17.482986 | debian-bookworm | Containerfile 2026-04-07 18:32:17.495916 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007991 2026-04-07 18:32:46.139079 | 2026-04-07 18:32:46.139215 | TASK [upload-logs : Upload logs to log server] 2026-04-07 18:32:46.833283 | localhost | Output suppressed because no_log was given 2026-04-07 18:32:46.837049 | 2026-04-07 18:32:46.837256 | LOOP [upload-logs : Compress console log and json output] 2026-04-07 18:32:46.926576 | localhost | skipping: Conditional result was False 2026-04-07 18:32:46.944077 | localhost | skipping: Conditional result was False 2026-04-07 18:32:46.958287 | 2026-04-07 18:32:46.958488 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-07 18:32:47.049450 | localhost | skipping: Conditional result was False 2026-04-07 18:32:47.049763 | 2026-04-07 18:32:47.054736 | localhost | skipping: Conditional result was False 2026-04-07 18:32:47.060798 | 2026-04-07 18:32:47.060934 | LOOP [upload-logs : Upload console log and json output]