2025-06-25 03:01:53.133840 | Job console starting 2025-06-25 03:01:53.161919 | Updating git repos 2025-06-25 03:01:53.193254 | Cloning repos into workspace 2025-06-25 03:01:53.228095 | Restoring repo states 2025-06-25 03:01:53.235616 | Merging changes 2025-06-25 03:01:53.235685 | Checking out repos 2025-06-25 03:01:53.279865 | Preparing playbooks 2025-06-25 03:01:54.154906 | Running Ansible setup 2025-06-25 03:01:59.466614 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-06-25 03:02:00.459696 | 2025-06-25 03:02:00.459862 | PLAY [Base pre] 2025-06-25 03:02:00.476719 | 2025-06-25 03:02:00.476873 | TASK [Setup log path fact] 2025-06-25 03:02:00.497973 | debian-bookworm | ok 2025-06-25 03:02:00.514511 | 2025-06-25 03:02:00.514722 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-06-25 03:02:00.577837 | debian-bookworm | ok 2025-06-25 03:02:00.596739 | 2025-06-25 03:02:00.596885 | TASK [emit-job-header : Print job information] 2025-06-25 03:02:00.648146 | # Job Information 2025-06-25 03:02:00.648363 | Ansible Version: 2.16.14 2025-06-25 03:02:00.648398 | Job: python-black 2025-06-25 03:02:00.648431 | Pipeline: periodic-daily 2025-06-25 03:02:00.648454 | Executor: 521e9411259a 2025-06-25 03:02:00.648475 | Triggered by: https://github.com/osism/cinder-driver-dm-clone 2025-06-25 03:02:00.648498 | Event ID: 173ace9dc5304d66bbce43c72c3e90d5 2025-06-25 03:02:00.653871 | 2025-06-25 03:02:00.653999 | LOOP [emit-job-header : Print node information] 2025-06-25 03:02:00.891533 | debian-bookworm | ok: 2025-06-25 03:02:00.891767 | debian-bookworm | # Node Information 2025-06-25 03:02:00.891803 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-06-25 03:02:00.891828 | debian-bookworm | Hostname: debian 2025-06-25 03:02:00.891850 | debian-bookworm | Username: zuul 2025-06-25 03:02:00.891870 | debian-bookworm | Distro: Debian 12.11 2025-06-25 03:02:00.891893 | debian-bookworm | Provider: regiocloud-a 2025-06-25 03:02:00.891914 | debian-bookworm | Region: 2025-06-25 03:02:00.891935 | debian-bookworm | Label: debian-bookworm 2025-06-25 03:02:00.891955 | debian-bookworm | Product Name: OpenStack Nova 2025-06-25 03:02:00.891975 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fefc:e322 2025-06-25 03:02:00.908638 | 2025-06-25 03:02:00.908811 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-06-25 03:02:01.393496 | debian-bookworm -> localhost | changed 2025-06-25 03:02:01.401384 | 2025-06-25 03:02:01.401511 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-06-25 03:02:02.649576 | debian-bookworm -> localhost | changed 2025-06-25 03:02:02.661082 | 2025-06-25 03:02:02.661220 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-06-25 03:02:02.973506 | debian-bookworm -> localhost | ok 2025-06-25 03:02:02.991907 | 2025-06-25 03:02:02.992074 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-06-25 03:02:03.047545 | debian-bookworm | ok 2025-06-25 03:02:03.074934 | debian-bookworm | included: /var/lib/zuul/builds/eedd7513130c49e38c1257a3a9d6461c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-06-25 03:02:03.084215 | 2025-06-25 03:02:03.084677 | TASK [add-build-sshkey : Create Temp SSH key] 2025-06-25 03:02:04.573176 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-06-25 03:02:04.573757 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/eedd7513130c49e38c1257a3a9d6461c/work/eedd7513130c49e38c1257a3a9d6461c_id_rsa 2025-06-25 03:02:04.573877 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/eedd7513130c49e38c1257a3a9d6461c/work/eedd7513130c49e38c1257a3a9d6461c_id_rsa.pub 2025-06-25 03:02:04.573955 | debian-bookworm -> localhost | The key fingerprint is: 2025-06-25 03:02:04.574021 | debian-bookworm -> localhost | SHA256:ueRmtRJNmGUFeO/YPqE6xfCKvICF/fvqucNjg9Js4j4 zuul-build-sshkey 2025-06-25 03:02:04.574081 | debian-bookworm -> localhost | The key's randomart image is: 2025-06-25 03:02:04.574162 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-06-25 03:02:04.574226 | debian-bookworm -> localhost | | .+o. | 2025-06-25 03:02:04.574289 | debian-bookworm -> localhost | | .=. | 2025-06-25 03:02:04.574347 | debian-bookworm -> localhost | | o... | 2025-06-25 03:02:04.574404 | debian-bookworm -> localhost | | o .+ . | 2025-06-25 03:02:04.574462 | debian-bookworm -> localhost | | . o S+o+ | 2025-06-25 03:02:04.574533 | debian-bookworm -> localhost | | o . o +=.+ | 2025-06-25 03:02:04.574594 | debian-bookworm -> localhost | | .o.+..*o.o . | 2025-06-25 03:02:04.574676 | debian-bookworm -> localhost | | E =.O=o.. o | 2025-06-25 03:02:04.574741 | debian-bookworm -> localhost | | oo= oBOoo . | 2025-06-25 03:02:04.574799 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-06-25 03:02:04.575107 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.945750 2025-06-25 03:02:04.589665 | 2025-06-25 03:02:04.589846 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-06-25 03:02:04.623174 | debian-bookworm | ok 2025-06-25 03:02:04.633803 | debian-bookworm | included: /var/lib/zuul/builds/eedd7513130c49e38c1257a3a9d6461c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-06-25 03:02:04.644242 | 2025-06-25 03:02:04.644353 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-06-25 03:02:04.679190 | debian-bookworm | skipping: Conditional result was False 2025-06-25 03:02:04.689117 | 2025-06-25 03:02:04.689236 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-06-25 03:02:05.437363 | debian-bookworm | changed 2025-06-25 03:02:05.445125 | 2025-06-25 03:02:05.445276 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-06-25 03:02:05.768850 | debian-bookworm | ok 2025-06-25 03:02:05.774774 | 2025-06-25 03:02:05.774906 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-06-25 03:02:06.425796 | debian-bookworm | changed 2025-06-25 03:02:06.433240 | 2025-06-25 03:02:06.433364 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-06-25 03:02:07.123789 | debian-bookworm | changed 2025-06-25 03:02:07.134104 | 2025-06-25 03:02:07.134287 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-06-25 03:02:07.160332 | debian-bookworm | skipping: Conditional result was False 2025-06-25 03:02:07.169804 | 2025-06-25 03:02:07.169955 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-06-25 03:02:07.721822 | debian-bookworm -> localhost | changed 2025-06-25 03:02:07.738067 | 2025-06-25 03:02:07.738310 | TASK [add-build-sshkey : Add back temp key] 2025-06-25 03:02:08.239842 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/eedd7513130c49e38c1257a3a9d6461c/work/eedd7513130c49e38c1257a3a9d6461c_id_rsa (zuul-build-sshkey) 2025-06-25 03:02:08.240339 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.032480 2025-06-25 03:02:08.251273 | 2025-06-25 03:02:08.251402 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-06-25 03:02:08.724695 | debian-bookworm | ok 2025-06-25 03:02:08.730078 | 2025-06-25 03:02:08.730195 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-06-25 03:02:08.769360 | debian-bookworm | skipping: Conditional result was False 2025-06-25 03:02:08.796873 | 2025-06-25 03:02:08.797683 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-06-25 03:02:09.408877 | debian-bookworm | ok 2025-06-25 03:02:09.429944 | 2025-06-25 03:02:09.430079 | TASK [validate-host : Define zuul_info_dir fact] 2025-06-25 03:02:09.470988 | debian-bookworm | ok 2025-06-25 03:02:09.477706 | 2025-06-25 03:02:09.477816 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-06-25 03:02:09.856378 | debian-bookworm -> localhost | ok 2025-06-25 03:02:09.863052 | 2025-06-25 03:02:09.863175 | TASK [validate-host : Collect information about the host] 2025-06-25 03:02:10.995389 | debian-bookworm | ok 2025-06-25 03:02:11.007970 | 2025-06-25 03:02:11.008125 | TASK [validate-host : Sanitize hostname] 2025-06-25 03:02:11.120218 | debian-bookworm | ok 2025-06-25 03:02:11.175554 | 2025-06-25 03:02:11.175721 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-06-25 03:02:11.915439 | debian-bookworm -> localhost | changed 2025-06-25 03:02:11.925149 | 2025-06-25 03:02:11.925350 | TASK [validate-host : Collect information about zuul worker] 2025-06-25 03:02:12.357330 | debian-bookworm | ok 2025-06-25 03:02:12.368965 | 2025-06-25 03:02:12.369087 | TASK [validate-host : Write out all zuul information for each host] 2025-06-25 03:02:13.095848 | debian-bookworm -> localhost | changed 2025-06-25 03:02:13.120539 | 2025-06-25 03:02:13.120767 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-06-25 03:02:13.405426 | debian-bookworm | ok 2025-06-25 03:02:13.413443 | 2025-06-25 03:02:13.413560 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-06-25 03:02:14.233776 | debian-bookworm | changed: 2025-06-25 03:02:14.234037 | debian-bookworm | cd+++++++++ src/ 2025-06-25 03:02:14.234082 | debian-bookworm | cd+++++++++ src/github.com/ 2025-06-25 03:02:14.234114 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-06-25 03:02:14.234141 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/ 2025-06-25 03:02:14.234167 | debian-bookworm | localhost | ok: Runtime: 0:00:00.026596 2025-06-25 03:02:42.595890 | 2025-06-25 03:02:42.595999 | TASK [upload-logs : Upload logs to log server] 2025-06-25 03:02:43.399547 | localhost | Output suppressed because no_log was given 2025-06-25 03:02:43.401189 | 2025-06-25 03:02:43.401274 | LOOP [upload-logs : Compress console log and json output] 2025-06-25 03:02:43.457189 | localhost | skipping: Conditional result was False 2025-06-25 03:02:43.471078 | localhost | skipping: Conditional result was False 2025-06-25 03:02:43.477340 | 2025-06-25 03:02:43.477452 | LOOP [upload-logs : Upload compressed console log and json output] 2025-06-25 03:02:43.548764 | localhost | skipping: Conditional result was False 2025-06-25 03:02:43.549022 | 2025-06-25 03:02:43.554292 | localhost | skipping: Conditional result was False 2025-06-25 03:02:43.562987 | 2025-06-25 03:02:43.563099 | LOOP [upload-logs : Upload console log and json output]