2025-10-22 03:18:26.753377 | Job console starting 2025-10-22 03:18:26.761145 | Updating git repos 2025-10-22 03:18:26.781574 | Cloning repos into workspace 2025-10-22 03:18:26.801826 | Restoring repo states 2025-10-22 03:18:26.804507 | Merging changes 2025-10-22 03:18:26.804519 | Checking out repos 2025-10-22 03:18:26.834705 | Preparing playbooks 2025-10-22 03:18:27.666518 | Running Ansible setup 2025-10-22 03:18:31.576180 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-22 03:18:32.281806 | 2025-10-22 03:18:32.281995 | PLAY [Base pre] 2025-10-22 03:18:32.296501 | 2025-10-22 03:18:32.296612 | TASK [Setup log path fact] 2025-10-22 03:18:32.329590 | debian-bookworm | ok 2025-10-22 03:18:32.343681 | 2025-10-22 03:18:32.343798 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-22 03:18:32.372151 | debian-bookworm | ok 2025-10-22 03:18:32.381195 | 2025-10-22 03:18:32.381281 | TASK [emit-job-header : Print job information] 2025-10-22 03:18:32.427222 | # Job Information 2025-10-22 03:18:32.427488 | Ansible Version: 2.16.14 2025-10-22 03:18:32.427606 | Job: python-black 2025-10-22 03:18:32.427678 | Pipeline: periodic-daily 2025-10-22 03:18:32.427726 | Executor: 521e9411259a 2025-10-22 03:18:32.427768 | Triggered by: https://github.com/osism/cinder-driver-dm-clone 2025-10-22 03:18:32.427812 | Event ID: 5943f3e95a3749b9b05a25555777e7f4 2025-10-22 03:18:32.435680 | 2025-10-22 03:18:32.435804 | LOOP [emit-job-header : Print node information] 2025-10-22 03:18:32.535031 | debian-bookworm | ok: 2025-10-22 03:18:32.535201 | debian-bookworm | # Node Information 2025-10-22 03:18:32.535237 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-22 03:18:32.535265 | debian-bookworm | Hostname: debian 2025-10-22 03:18:32.535290 | debian-bookworm | Username: zuul 2025-10-22 03:18:32.535313 | debian-bookworm | Distro: Debian 12.12 2025-10-22 03:18:32.535340 | debian-bookworm | Provider: regiocloud-a 2025-10-22 03:18:32.535364 | debian-bookworm | Region: 2025-10-22 03:18:32.535425 | debian-bookworm | Label: debian-bookworm 2025-10-22 03:18:32.535507 | debian-bookworm | Product Name: OpenStack Nova 2025-10-22 03:18:32.535547 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fef4:5935 2025-10-22 03:18:32.555397 | 2025-10-22 03:18:32.555495 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-22 03:18:32.975591 | debian-bookworm -> localhost | changed 2025-10-22 03:18:32.982576 | 2025-10-22 03:18:32.982676 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-22 03:18:33.785543 | debian-bookworm -> localhost | changed 2025-10-22 03:18:33.801000 | 2025-10-22 03:18:33.801114 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-22 03:18:34.047797 | debian-bookworm -> localhost | ok 2025-10-22 03:18:34.057051 | 2025-10-22 03:18:34.057195 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-22 03:18:34.078337 | debian-bookworm | ok 2025-10-22 03:18:34.100282 | debian-bookworm | included: /var/lib/zuul/builds/dfe40045a5f04437b815aaa2630ac595/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-22 03:18:34.105707 | 2025-10-22 03:18:34.105775 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-22 03:18:35.398746 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-22 03:18:35.398924 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/dfe40045a5f04437b815aaa2630ac595/work/dfe40045a5f04437b815aaa2630ac595_id_rsa 2025-10-22 03:18:35.398955 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/dfe40045a5f04437b815aaa2630ac595/work/dfe40045a5f04437b815aaa2630ac595_id_rsa.pub 2025-10-22 03:18:35.398978 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-22 03:18:35.398998 | debian-bookworm -> localhost | SHA256:/NYDMpUGxUr5kgCv8CqLQMwmQJyfwgYfNRuffYJnn38 zuul-build-sshkey 2025-10-22 03:18:35.399017 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-22 03:18:35.399047 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-22 03:18:35.399065 | debian-bookworm -> localhost | |....=. .+. | 2025-10-22 03:18:35.399083 | debian-bookworm -> localhost | |oo. *.+o... | 2025-10-22 03:18:35.399100 | debian-bookworm -> localhost | |+.o.o =o=+= | 2025-10-22 03:18:35.399117 | debian-bookworm -> localhost | |++.= . ++*.. | 2025-10-22 03:18:35.399134 | debian-bookworm -> localhost | |o=. o S.+ | 2025-10-22 03:18:35.399151 | debian-bookworm -> localhost | |+ . + + | 2025-10-22 03:18:35.399167 | debian-bookworm -> localhost | |o . o + E | 2025-10-22 03:18:35.399188 | debian-bookworm -> localhost | |oo . o | 2025-10-22 03:18:35.399216 | debian-bookworm -> localhost | |o | 2025-10-22 03:18:35.399234 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-22 03:18:35.399279 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.856092 2025-10-22 03:18:35.404381 | 2025-10-22 03:18:35.404452 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-22 03:18:35.430571 | debian-bookworm | ok 2025-10-22 03:18:35.438082 | debian-bookworm | included: /var/lib/zuul/builds/dfe40045a5f04437b815aaa2630ac595/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-22 03:18:35.447799 | 2025-10-22 03:18:35.447868 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-22 03:18:35.469908 | debian-bookworm | skipping: Conditional result was False 2025-10-22 03:18:35.474519 | 2025-10-22 03:18:35.474620 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-22 03:18:36.156862 | debian-bookworm | changed 2025-10-22 03:18:36.165558 | 2025-10-22 03:18:36.165681 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-22 03:18:36.428445 | debian-bookworm | ok 2025-10-22 03:18:36.434358 | 2025-10-22 03:18:36.434447 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-22 03:18:37.049816 | debian-bookworm | changed 2025-10-22 03:18:37.056259 | 2025-10-22 03:18:37.056352 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-22 03:18:37.667942 | debian-bookworm | changed 2025-10-22 03:18:37.680997 | 2025-10-22 03:18:37.681109 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-22 03:18:37.701397 | debian-bookworm | skipping: Conditional result was False 2025-10-22 03:18:37.708589 | 2025-10-22 03:18:37.708691 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-22 03:18:38.199291 | debian-bookworm -> localhost | changed 2025-10-22 03:18:38.219104 | 2025-10-22 03:18:38.219205 | TASK [add-build-sshkey : Add back temp key] 2025-10-22 03:18:38.695521 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/dfe40045a5f04437b815aaa2630ac595/work/dfe40045a5f04437b815aaa2630ac595_id_rsa (zuul-build-sshkey) 2025-10-22 03:18:38.695762 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.012342 2025-10-22 03:18:38.703231 | 2025-10-22 03:18:38.703322 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-22 03:18:39.076199 | debian-bookworm | ok 2025-10-22 03:18:39.081064 | 2025-10-22 03:18:39.081151 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-22 03:18:39.103834 | debian-bookworm | skipping: Conditional result was False 2025-10-22 03:18:39.113743 | 2025-10-22 03:18:39.113834 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-22 03:18:39.530954 | debian-bookworm | ok 2025-10-22 03:18:39.541706 | 2025-10-22 03:18:39.541797 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-22 03:18:39.570599 | debian-bookworm | ok 2025-10-22 03:18:39.576158 | 2025-10-22 03:18:39.576252 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-22 03:18:39.907784 | debian-bookworm -> localhost | ok 2025-10-22 03:18:39.924182 | 2025-10-22 03:18:39.924332 | TASK [validate-host : Collect information about the host] 2025-10-22 03:18:40.995692 | debian-bookworm | ok 2025-10-22 03:18:41.005832 | 2025-10-22 03:18:41.005934 | TASK [validate-host : Sanitize hostname] 2025-10-22 03:18:41.116048 | debian-bookworm | ok 2025-10-22 03:18:41.162021 | 2025-10-22 03:18:41.162150 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-22 03:18:41.816981 | debian-bookworm -> localhost | changed 2025-10-22 03:18:41.825397 | 2025-10-22 03:18:41.825512 | TASK [validate-host : Collect information about zuul worker] 2025-10-22 03:18:42.244179 | debian-bookworm | ok 2025-10-22 03:18:42.252151 | 2025-10-22 03:18:42.252540 | TASK [validate-host : Write out all zuul information for each host] 2025-10-22 03:18:42.774985 | debian-bookworm -> localhost | changed 2025-10-22 03:18:42.785232 | 2025-10-22 03:18:42.785344 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-22 03:18:43.064138 | debian-bookworm | ok 2025-10-22 03:18:43.073553 | 2025-10-22 03:18:43.073681 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-22 03:18:43.828260 | debian-bookworm | changed: 2025-10-22 03:18:43.828455 | debian-bookworm | cd+++++++++ src/ 2025-10-22 03:18:43.828489 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-22 03:18:43.828512 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-22 03:18:43.828550 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/ 2025-10-22 03:18:43.828572 | debian-bookworm | localhost | ok: Runtime: 0:00:00.019742 2025-10-22 03:19:10.942225 | 2025-10-22 03:19:10.942307 | TASK [upload-logs : Upload logs to log server] 2025-10-22 03:19:12.117669 | localhost | Output suppressed because no_log was given 2025-10-22 03:19:12.119182 | 2025-10-22 03:19:12.119260 | LOOP [upload-logs : Compress console log and json output] 2025-10-22 03:19:12.228616 | localhost | skipping: Conditional result was False 2025-10-22 03:19:12.242574 | localhost | skipping: Conditional result was False 2025-10-22 03:19:12.255216 | 2025-10-22 03:19:12.255310 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-22 03:19:12.331651 | localhost | skipping: Conditional result was False 2025-10-22 03:19:12.331871 | 2025-10-22 03:19:12.343681 | localhost | skipping: Conditional result was False 2025-10-22 03:19:12.350404 | 2025-10-22 03:19:12.350494 | LOOP [upload-logs : Upload console log and json output]