2025-09-26 22:34:56.405585 | Job console starting 2025-09-26 22:34:56.425844 | Updating git repos 2025-09-26 22:34:56.492283 | Cloning repos into workspace 2025-09-26 22:34:56.561961 | Restoring repo states 2025-09-26 22:34:56.576074 | Merging changes 2025-09-26 22:34:57.367336 | Checking out repos 2025-09-26 22:34:57.408586 | Preparing playbooks 2025-09-26 22:34:58.381982 | Running Ansible setup 2025-09-26 22:35:03.540768 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-26 22:35:04.717898 | 2025-09-26 22:35:04.718055 | PLAY [Base pre] 2025-09-26 22:35:04.745704 | 2025-09-26 22:35:04.745856 | TASK [Setup log path fact] 2025-09-26 22:35:04.765787 | debian-bookworm | ok 2025-09-26 22:35:04.783620 | 2025-09-26 22:35:04.783785 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-26 22:35:04.813250 | debian-bookworm | ok 2025-09-26 22:35:04.823473 | 2025-09-26 22:35:04.823605 | TASK [emit-job-header : Print job information] 2025-09-26 22:35:04.863072 | # Job Information 2025-09-26 22:35:04.863275 | Ansible Version: 2.16.14 2025-09-26 22:35:04.863314 | Job: python-black 2025-09-26 22:35:04.863347 | Pipeline: check 2025-09-26 22:35:04.863385 | Executor: 521e9411259a 2025-09-26 22:35:04.863407 | Triggered by: https://github.com/osism/openstack-image-manager/pull/959 2025-09-26 22:35:04.863430 | Event ID: 00f92de0-9b29-11f0-98b8-5e6ea00cfba3 2025-09-26 22:35:04.868531 | 2025-09-26 22:35:04.868643 | LOOP [emit-job-header : Print node information] 2025-09-26 22:35:04.978480 | debian-bookworm | ok: 2025-09-26 22:35:04.978747 | debian-bookworm | # Node Information 2025-09-26 22:35:04.978786 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-26 22:35:04.978812 | debian-bookworm | Hostname: debian 2025-09-26 22:35:04.978858 | debian-bookworm | Username: zuul 2025-09-26 22:35:04.978880 | debian-bookworm | Distro: Debian 12.12 2025-09-26 22:35:04.978903 | debian-bookworm | Provider: regiocloud-a 2025-09-26 22:35:04.978925 | debian-bookworm | Region: 2025-09-26 22:35:04.978946 | debian-bookworm | Label: debian-bookworm 2025-09-26 22:35:04.978966 | debian-bookworm | Product Name: OpenStack Nova 2025-09-26 22:35:04.978986 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:febd:8af1 2025-09-26 22:35:04.997183 | 2025-09-26 22:35:04.997318 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-26 22:35:05.837357 | debian-bookworm -> localhost | changed 2025-09-26 22:35:05.844808 | 2025-09-26 22:35:05.844935 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-26 22:35:07.087894 | debian-bookworm -> localhost | changed 2025-09-26 22:35:07.096545 | 2025-09-26 22:35:07.096631 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-26 22:35:07.623540 | debian-bookworm -> localhost | ok 2025-09-26 22:35:07.628403 | 2025-09-26 22:35:07.628489 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-26 22:35:07.654918 | debian-bookworm | ok 2025-09-26 22:35:07.679240 | debian-bookworm | included: /var/lib/zuul/builds/f6eef652dc2b43bfbe5319c124bc0ab1/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-26 22:35:07.685223 | 2025-09-26 22:35:07.685309 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-26 22:35:08.742586 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-26 22:35:08.742771 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/f6eef652dc2b43bfbe5319c124bc0ab1/work/f6eef652dc2b43bfbe5319c124bc0ab1_id_rsa 2025-09-26 22:35:08.742812 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/f6eef652dc2b43bfbe5319c124bc0ab1/work/f6eef652dc2b43bfbe5319c124bc0ab1_id_rsa.pub 2025-09-26 22:35:08.746376 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-26 22:35:08.746445 | debian-bookworm -> localhost | SHA256:rOIOkRVJDrZ6JN+9qtZklPo7u3UFuDs8xqZb6I194Vs zuul-build-sshkey 2025-09-26 22:35:08.746474 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-26 22:35:08.746508 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-26 22:35:08.746531 | debian-bookworm -> localhost | | o.o. | 2025-09-26 22:35:08.746554 | debian-bookworm -> localhost | | . +.. . | 2025-09-26 22:35:08.746575 | debian-bookworm -> localhost | |. o o.. . | 2025-09-26 22:35:08.746596 | debian-bookworm -> localhost | | = +o. o . | 2025-09-26 22:35:08.746616 | debian-bookworm -> localhost | |. =o. o S . | 2025-09-26 22:35:08.746645 | debian-bookworm -> localhost | | ...o+ +.. | 2025-09-26 22:35:08.746666 | debian-bookworm -> localhost | | .=o &...E | 2025-09-26 22:35:08.746687 | debian-bookworm -> localhost | | .++% +o. | 2025-09-26 22:35:08.746708 | debian-bookworm -> localhost | | ..o%*o... | 2025-09-26 22:35:08.746728 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-26 22:35:08.746783 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.557970 2025-09-26 22:35:08.764485 | 2025-09-26 22:35:08.764583 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-26 22:35:08.781670 | debian-bookworm | ok 2025-09-26 22:35:08.800881 | debian-bookworm | included: /var/lib/zuul/builds/f6eef652dc2b43bfbe5319c124bc0ab1/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-26 22:35:08.819537 | 2025-09-26 22:35:08.819622 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-26 22:35:08.832530 | debian-bookworm | skipping: Conditional result was False 2025-09-26 22:35:08.838126 | 2025-09-26 22:35:08.838210 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-26 22:35:09.485391 | debian-bookworm | changed 2025-09-26 22:35:09.489651 | 2025-09-26 22:35:09.489722 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-26 22:35:09.743847 | debian-bookworm | ok 2025-09-26 22:35:09.751465 | 2025-09-26 22:35:09.751580 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-26 22:35:10.388878 | debian-bookworm | changed 2025-09-26 22:35:10.400821 | 2025-09-26 22:35:10.400921 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-26 22:35:11.061493 | debian-bookworm | changed 2025-09-26 22:35:11.067166 | 2025-09-26 22:35:11.067261 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-26 22:35:11.090795 | debian-bookworm | skipping: Conditional result was False 2025-09-26 22:35:11.096548 | 2025-09-26 22:35:11.096643 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-26 22:35:11.536985 | debian-bookworm -> localhost | changed 2025-09-26 22:35:11.559664 | 2025-09-26 22:35:11.559772 | TASK [add-build-sshkey : Add back temp key] 2025-09-26 22:35:11.880240 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/f6eef652dc2b43bfbe5319c124bc0ab1/work/f6eef652dc2b43bfbe5319c124bc0ab1_id_rsa (zuul-build-sshkey) 2025-09-26 22:35:11.880792 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.009314 2025-09-26 22:35:11.901460 | 2025-09-26 22:35:11.901666 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-26 22:35:12.315442 | debian-bookworm | ok 2025-09-26 22:35:12.319396 | 2025-09-26 22:35:12.319473 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-26 22:35:12.349102 | debian-bookworm | skipping: Conditional result was False 2025-09-26 22:35:12.357463 | 2025-09-26 22:35:12.357549 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-26 22:35:12.798679 | debian-bookworm | ok 2025-09-26 22:35:12.807106 | 2025-09-26 22:35:12.807192 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-26 22:35:12.833468 | debian-bookworm | ok 2025-09-26 22:35:12.837489 | 2025-09-26 22:35:12.837560 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-26 22:35:13.144274 | debian-bookworm -> localhost | ok 2025-09-26 22:35:13.149462 | 2025-09-26 22:35:13.149541 | TASK [validate-host : Collect information about the host] 2025-09-26 22:35:14.213269 | debian-bookworm | ok 2025-09-26 22:35:14.226867 | 2025-09-26 22:35:14.226976 | TASK [validate-host : Sanitize hostname] 2025-09-26 22:35:14.337125 | debian-bookworm | ok 2025-09-26 22:35:14.385642 | 2025-09-26 22:35:14.385784 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-26 22:35:14.951736 | debian-bookworm -> localhost | changed 2025-09-26 22:35:14.957013 | 2025-09-26 22:35:14.957099 | TASK [validate-host : Collect information about zuul worker] 2025-09-26 22:35:15.492235 | debian-bookworm | ok 2025-09-26 22:35:15.496570 | 2025-09-26 22:35:15.496654 | TASK [validate-host : Write out all zuul information for each host] 2025-09-26 22:35:16.007775 | debian-bookworm -> localhost | changed 2025-09-26 22:35:16.016786 | 2025-09-26 22:35:16.016894 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-26 22:35:16.306662 | debian-bookworm | ok 2025-09-26 22:35:16.311841 | 2025-09-26 22:35:16.311936 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-26 22:35:17.314009 | debian-bookworm | changed: 2025-09-26 22:35:17.314178 | debian-bookworm | cd+++++++++ src/ 2025-09-26 22:35:17.314211 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-26 22:35:17.314236 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-26 22:35:17.314258 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-09-26 22:35:17.314279 | debian-bookworm | localhost | ok: Runtime: 0:00:00.022487 2025-09-26 22:35:42.884292 | 2025-09-26 22:35:42.884440 | TASK [upload-logs : Upload logs to log server] 2025-09-26 22:35:43.613535 | localhost | Output suppressed because no_log was given 2025-09-26 22:35:43.615905 | 2025-09-26 22:35:43.616044 | LOOP [upload-logs : Compress console log and json output] 2025-09-26 22:35:43.672771 | localhost | skipping: Conditional result was False 2025-09-26 22:35:43.679336 | localhost | skipping: Conditional result was False 2025-09-26 22:35:43.683288 | 2025-09-26 22:35:43.683434 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-26 22:35:43.735876 | localhost | skipping: Conditional result was False 2025-09-26 22:35:43.736321 | 2025-09-26 22:35:43.740310 | localhost | skipping: Conditional result was False 2025-09-26 22:35:43.753556 | 2025-09-26 22:35:43.753746 | LOOP [upload-logs : Upload console log and json output]