2025-10-09 03:01:44.781454 | Job console starting 2025-10-09 03:01:44.788937 | Updating git repos 2025-10-09 03:01:44.839640 | Cloning repos into workspace 2025-10-09 03:01:44.910631 | Restoring repo states 2025-10-09 03:01:44.941234 | Merging changes 2025-10-09 03:01:44.941250 | Checking out repos 2025-10-09 03:01:44.970629 | Preparing playbooks 2025-10-09 03:01:46.402735 | Running Ansible setup 2025-10-09 03:01:52.514443 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-09 03:01:53.539575 | 2025-10-09 03:01:53.539692 | PLAY [Base pre] 2025-10-09 03:01:53.577121 | 2025-10-09 03:01:53.577235 | TASK [Setup log path fact] 2025-10-09 03:01:53.631992 | debian-bookworm | ok 2025-10-09 03:01:53.657672 | 2025-10-09 03:01:53.657787 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-09 03:01:53.713533 | debian-bookworm | ok 2025-10-09 03:01:53.723498 | 2025-10-09 03:01:53.723596 | TASK [emit-job-header : Print job information] 2025-10-09 03:01:53.758897 | # Job Information 2025-10-09 03:01:53.759031 | Ansible Version: 2.16.14 2025-10-09 03:01:53.759060 | Job: python-black 2025-10-09 03:01:53.759086 | Pipeline: periodic-daily 2025-10-09 03:01:53.759105 | Executor: 521e9411259a 2025-10-09 03:01:53.759122 | Triggered by: https://github.com/osism/cinder-driver-dm-clone 2025-10-09 03:01:53.759142 | Event ID: 032d6e3a1ace4a4d876fa27cd7e9c08d 2025-10-09 03:01:53.762958 | 2025-10-09 03:01:53.763037 | LOOP [emit-job-header : Print node information] 2025-10-09 03:01:53.935167 | debian-bookworm | ok: 2025-10-09 03:01:53.935302 | debian-bookworm | # Node Information 2025-10-09 03:01:53.935330 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-09 03:01:53.935352 | debian-bookworm | Hostname: debian 2025-10-09 03:01:53.935370 | debian-bookworm | Username: zuul 2025-10-09 03:01:53.935387 | debian-bookworm | Distro: Debian 12.12 2025-10-09 03:01:53.935406 | debian-bookworm | Provider: regiocloud-a 2025-10-09 03:01:53.935423 | debian-bookworm | Region: 2025-10-09 03:01:53.935440 | debian-bookworm | Label: debian-bookworm 2025-10-09 03:01:53.935455 | debian-bookworm | Product Name: OpenStack Nova 2025-10-09 03:01:53.935471 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe88:adbb 2025-10-09 03:01:53.945944 | 2025-10-09 03:01:53.946039 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-09 03:01:54.463376 | debian-bookworm -> localhost | changed 2025-10-09 03:01:54.477316 | 2025-10-09 03:01:54.477413 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-09 03:01:55.901593 | debian-bookworm -> localhost | changed 2025-10-09 03:01:55.914369 | 2025-10-09 03:01:55.914455 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-09 03:01:56.170333 | debian-bookworm -> localhost | ok 2025-10-09 03:01:56.176480 | 2025-10-09 03:01:56.176594 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-09 03:01:56.215534 | debian-bookworm | ok 2025-10-09 03:01:56.229315 | debian-bookworm | included: /var/lib/zuul/builds/c979e63369054deab97ff710d5bff47b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-09 03:01:56.234061 | 2025-10-09 03:01:56.234134 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-09 03:01:57.093629 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-09 03:01:57.093801 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/c979e63369054deab97ff710d5bff47b/work/c979e63369054deab97ff710d5bff47b_id_rsa 2025-10-09 03:01:57.093832 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/c979e63369054deab97ff710d5bff47b/work/c979e63369054deab97ff710d5bff47b_id_rsa.pub 2025-10-09 03:01:57.093854 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-09 03:01:57.093873 | debian-bookworm -> localhost | SHA256:kmXg4G/q1TyTc6FpwKvOHCEWNxGjUjVYpNfQWwau3sk zuul-build-sshkey 2025-10-09 03:01:57.093892 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-09 03:01:57.093917 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-09 03:01:57.093935 | debian-bookworm -> localhost | | .=@oo. | 2025-10-09 03:01:57.093951 | debian-bookworm -> localhost | | ..+ X..o | 2025-10-09 03:01:57.093968 | debian-bookworm -> localhost | |. + = ++o | 2025-10-09 03:01:57.093984 | debian-bookworm -> localhost | | . + =.+ | 2025-10-09 03:01:57.094000 | debian-bookworm -> localhost | | o o B S . | 2025-10-09 03:01:57.094019 | debian-bookworm -> localhost | | . o * B + . | 2025-10-09 03:01:57.094035 | debian-bookworm -> localhost | | + E @ . | 2025-10-09 03:01:57.094052 | debian-bookworm -> localhost | | + + . = | 2025-10-09 03:01:57.094069 | debian-bookworm -> localhost | | .* | 2025-10-09 03:01:57.094085 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-09 03:01:57.094126 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.432094 2025-10-09 03:01:57.099815 | 2025-10-09 03:01:57.099896 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-09 03:01:57.126591 | debian-bookworm | ok 2025-10-09 03:01:57.133810 | debian-bookworm | included: /var/lib/zuul/builds/c979e63369054deab97ff710d5bff47b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-09 03:01:57.153033 | 2025-10-09 03:01:57.153106 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-09 03:01:57.166165 | debian-bookworm | skipping: Conditional result was False 2025-10-09 03:01:57.170738 | 2025-10-09 03:01:57.170810 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-09 03:01:57.718590 | debian-bookworm | changed 2025-10-09 03:01:57.735206 | 2025-10-09 03:01:57.735307 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-09 03:01:57.983291 | debian-bookworm | ok 2025-10-09 03:01:58.006071 | 2025-10-09 03:01:58.006206 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-09 03:01:58.602082 | debian-bookworm | changed 2025-10-09 03:01:58.608724 | 2025-10-09 03:01:58.608805 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-09 03:01:59.184887 | debian-bookworm | changed 2025-10-09 03:01:59.189765 | 2025-10-09 03:01:59.189844 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-09 03:01:59.212305 | debian-bookworm | skipping: Conditional result was False 2025-10-09 03:01:59.218095 | 2025-10-09 03:01:59.218220 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-09 03:01:59.556311 | debian-bookworm -> localhost | changed 2025-10-09 03:01:59.570359 | 2025-10-09 03:01:59.570640 | TASK [add-build-sshkey : Add back temp key] 2025-10-09 03:01:59.914255 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/c979e63369054deab97ff710d5bff47b/work/c979e63369054deab97ff710d5bff47b_id_rsa (zuul-build-sshkey) 2025-10-09 03:01:59.914463 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.022246 2025-10-09 03:01:59.922075 | 2025-10-09 03:01:59.922165 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-09 03:02:00.286613 | debian-bookworm | ok 2025-10-09 03:02:00.292392 | 2025-10-09 03:02:00.292486 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-09 03:02:00.305397 | debian-bookworm | skipping: Conditional result was False 2025-10-09 03:02:00.318633 | 2025-10-09 03:02:00.318730 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-09 03:02:00.705768 | debian-bookworm | ok 2025-10-09 03:02:00.714372 | 2025-10-09 03:02:00.714453 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-09 03:02:00.744426 | debian-bookworm | ok 2025-10-09 03:02:00.749267 | 2025-10-09 03:02:00.749356 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-09 03:02:01.036652 | debian-bookworm -> localhost | ok 2025-10-09 03:02:01.043047 | 2025-10-09 03:02:01.043141 | TASK [validate-host : Collect information about the host] 2025-10-09 03:02:02.064945 | debian-bookworm | ok 2025-10-09 03:02:02.089832 | 2025-10-09 03:02:02.089944 | TASK [validate-host : Sanitize hostname] 2025-10-09 03:02:02.409363 | debian-bookworm | ok 2025-10-09 03:02:02.493892 | 2025-10-09 03:02:02.494003 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-09 03:02:03.859502 | debian-bookworm -> localhost | changed 2025-10-09 03:02:03.867591 | 2025-10-09 03:02:03.867707 | TASK [validate-host : Collect information about zuul worker] 2025-10-09 03:02:04.310858 | debian-bookworm | ok 2025-10-09 03:02:04.319084 | 2025-10-09 03:02:04.319182 | TASK [validate-host : Write out all zuul information for each host] 2025-10-09 03:02:04.905723 | debian-bookworm -> localhost | changed 2025-10-09 03:02:04.917575 | 2025-10-09 03:02:04.917666 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-09 03:02:05.156604 | debian-bookworm | ok 2025-10-09 03:02:05.161794 | 2025-10-09 03:02:05.161875 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-09 03:02:05.905536 | debian-bookworm | changed: 2025-10-09 03:02:05.905697 | debian-bookworm | cd+++++++++ src/ 2025-10-09 03:02:05.905730 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-09 03:02:05.905755 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-09 03:02:05.905776 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/ 2025-10-09 03:02:05.905796 | debian-bookworm | localhost | ok: Runtime: 0:00:00.013791 2025-10-09 03:02:32.729689 | 2025-10-09 03:02:32.729771 | TASK [upload-logs : Upload logs to log server] 2025-10-09 03:02:33.653303 | localhost | Output suppressed because no_log was given 2025-10-09 03:02:33.658772 | 2025-10-09 03:02:33.658899 | LOOP [upload-logs : Compress console log and json output] 2025-10-09 03:02:33.727969 | localhost | skipping: Conditional result was False 2025-10-09 03:02:33.743328 | localhost | skipping: Conditional result was False 2025-10-09 03:02:33.751366 | 2025-10-09 03:02:33.751450 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-09 03:02:33.836474 | localhost | skipping: Conditional result was False 2025-10-09 03:02:33.836720 | 2025-10-09 03:02:33.849975 | localhost | skipping: Conditional result was False 2025-10-09 03:02:33.856558 | 2025-10-09 03:02:33.856636 | LOOP [upload-logs : Upload console log and json output]