2025-08-31 03:01:26.743190 | Job console starting 2025-08-31 03:01:26.754252 | Updating git repos 2025-08-31 03:01:26.890628 | Cloning repos into workspace 2025-08-31 03:01:27.026064 | Restoring repo states 2025-08-31 03:01:27.044820 | Merging changes 2025-08-31 03:01:27.045040 | Checking out repos 2025-08-31 03:01:27.122644 | Preparing playbooks 2025-08-31 03:01:29.004507 | Running Ansible setup 2025-08-31 03:01:36.371437 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-08-31 03:01:38.732433 | 2025-08-31 03:01:38.732549 | PLAY [Base pre] 2025-08-31 03:01:38.792407 | 2025-08-31 03:01:38.792524 | TASK [Setup log path fact] 2025-08-31 03:01:38.859170 | debian-bookworm | ok 2025-08-31 03:01:38.897227 | 2025-08-31 03:01:38.897351 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-31 03:01:38.965497 | debian-bookworm | ok 2025-08-31 03:01:38.988210 | 2025-08-31 03:01:38.988317 | TASK [emit-job-header : Print job information] 2025-08-31 03:01:39.061106 | # Job Information 2025-08-31 03:01:39.061236 | Ansible Version: 2.16.14 2025-08-31 03:01:39.061265 | Job: python-black 2025-08-31 03:01:39.061292 | Pipeline: periodic-daily 2025-08-31 03:01:39.061311 | Executor: 521e9411259a 2025-08-31 03:01:39.061329 | Triggered by: https://github.com/osism/cinder-driver-dm-clone 2025-08-31 03:01:39.061347 | Event ID: d6e5c319fe33412cb2d38701305c5c47 2025-08-31 03:01:39.065211 | 2025-08-31 03:01:39.065291 | LOOP [emit-job-header : Print node information] 2025-08-31 03:01:39.343401 | debian-bookworm | ok: 2025-08-31 03:01:39.343543 | debian-bookworm | # Node Information 2025-08-31 03:01:39.343572 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-08-31 03:01:39.343592 | debian-bookworm | Hostname: debian 2025-08-31 03:01:39.343610 | debian-bookworm | Username: zuul 2025-08-31 03:01:39.343626 | debian-bookworm | Distro: Debian 12.11 2025-08-31 03:01:39.343645 | debian-bookworm | Provider: regiocloud-a 2025-08-31 03:01:39.343662 | debian-bookworm | Region: 2025-08-31 03:01:39.343679 | debian-bookworm | Label: debian-bookworm 2025-08-31 03:01:39.343695 | debian-bookworm | Product Name: OpenStack Nova 2025-08-31 03:01:39.343711 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe7a:8f3 2025-08-31 03:01:39.355737 | 2025-08-31 03:01:39.355858 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-08-31 03:01:40.605553 | debian-bookworm -> localhost | changed 2025-08-31 03:01:40.611370 | 2025-08-31 03:01:40.611462 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-08-31 03:01:42.460530 | debian-bookworm -> localhost | changed 2025-08-31 03:01:42.478781 | 2025-08-31 03:01:42.482915 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-08-31 03:01:42.993909 | debian-bookworm -> localhost | ok 2025-08-31 03:01:42.999737 | 2025-08-31 03:01:42.999870 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-08-31 03:01:43.038178 | debian-bookworm | ok 2025-08-31 03:01:43.067721 | debian-bookworm | included: /var/lib/zuul/builds/d82fcee9f71a488a8372f6156cd13d5c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-08-31 03:01:43.087279 | 2025-08-31 03:01:43.087371 | TASK [add-build-sshkey : Create Temp SSH key] 2025-08-31 03:01:45.633773 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-08-31 03:01:45.633938 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/d82fcee9f71a488a8372f6156cd13d5c/work/d82fcee9f71a488a8372f6156cd13d5c_id_rsa 2025-08-31 03:01:45.633970 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/d82fcee9f71a488a8372f6156cd13d5c/work/d82fcee9f71a488a8372f6156cd13d5c_id_rsa.pub 2025-08-31 03:01:45.633991 | debian-bookworm -> localhost | The key fingerprint is: 2025-08-31 03:01:45.634011 | debian-bookworm -> localhost | SHA256:1zz0/jk2VoSC2J7beFIlslBwn3l15Ui/tIlSUm3U3LE zuul-build-sshkey 2025-08-31 03:01:45.634030 | debian-bookworm -> localhost | The key's randomart image is: 2025-08-31 03:01:45.634055 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-08-31 03:01:45.634074 | debian-bookworm -> localhost | | ... .++O| 2025-08-31 03:01:45.634093 | debian-bookworm -> localhost | | ....+ B*| 2025-08-31 03:01:45.634109 | debian-bookworm -> localhost | | + o=.+Eo| 2025-08-31 03:01:45.634126 | debian-bookworm -> localhost | | o ++=o= =| 2025-08-31 03:01:45.634142 | debian-bookworm -> localhost | | So.=+=.= | 2025-08-31 03:01:45.634163 | debian-bookworm -> localhost | | .+ oo .| 2025-08-31 03:01:45.634180 | debian-bookworm -> localhost | | = . .| 2025-08-31 03:01:45.634196 | debian-bookworm -> localhost | | + o *.| 2025-08-31 03:01:45.634213 | debian-bookworm -> localhost | | o o.+| 2025-08-31 03:01:45.634229 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-08-31 03:01:45.634269 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.737138 2025-08-31 03:01:45.639606 | 2025-08-31 03:01:45.639678 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-08-31 03:01:45.686409 | debian-bookworm | ok 2025-08-31 03:01:45.694200 | debian-bookworm | included: /var/lib/zuul/builds/d82fcee9f71a488a8372f6156cd13d5c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-08-31 03:01:45.711493 | 2025-08-31 03:01:45.711572 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-08-31 03:01:45.734478 | debian-bookworm | skipping: Conditional result was False 2025-08-31 03:01:45.740405 | 2025-08-31 03:01:45.740498 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-08-31 03:01:46.506728 | debian-bookworm | changed 2025-08-31 03:01:46.511509 | 2025-08-31 03:01:46.511586 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-08-31 03:01:46.833473 | debian-bookworm | ok 2025-08-31 03:01:46.838091 | 2025-08-31 03:01:46.838172 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-08-31 03:01:47.527715 | debian-bookworm | changed 2025-08-31 03:01:47.534152 | 2025-08-31 03:01:47.534245 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-08-31 03:01:48.244579 | debian-bookworm | changed 2025-08-31 03:01:48.249919 | 2025-08-31 03:01:48.250015 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-08-31 03:01:48.299282 | debian-bookworm | skipping: Conditional result was False 2025-08-31 03:01:48.306227 | 2025-08-31 03:01:48.306361 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-08-31 03:01:49.376166 | debian-bookworm -> localhost | changed 2025-08-31 03:01:49.386466 | 2025-08-31 03:01:49.386560 | TASK [add-build-sshkey : Add back temp key] 2025-08-31 03:01:50.687133 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/d82fcee9f71a488a8372f6156cd13d5c/work/d82fcee9f71a488a8372f6156cd13d5c_id_rsa (zuul-build-sshkey) 2025-08-31 03:01:50.687750 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.050365 2025-08-31 03:01:50.700129 | 2025-08-31 03:01:50.700215 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-08-31 03:01:51.535504 | debian-bookworm | ok 2025-08-31 03:01:51.539564 | 2025-08-31 03:01:51.539643 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-08-31 03:01:51.587315 | debian-bookworm | skipping: Conditional result was False 2025-08-31 03:01:51.601115 | 2025-08-31 03:01:51.601211 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-08-31 03:01:52.678377 | debian-bookworm | ok 2025-08-31 03:01:52.695162 | 2025-08-31 03:01:52.695264 | TASK [validate-host : Define zuul_info_dir fact] 2025-08-31 03:01:52.754227 | debian-bookworm | ok 2025-08-31 03:01:52.758856 | 2025-08-31 03:01:52.758956 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-08-31 03:01:53.471335 | debian-bookworm -> localhost | ok 2025-08-31 03:01:53.476557 | 2025-08-31 03:01:53.476634 | TASK [validate-host : Collect information about the host] 2025-08-31 03:01:54.864190 | debian-bookworm | ok 2025-08-31 03:01:54.879266 | 2025-08-31 03:01:54.879361 | TASK [validate-host : Sanitize hostname] 2025-08-31 03:01:55.059776 | debian-bookworm | ok 2025-08-31 03:01:55.207695 | 2025-08-31 03:01:55.207804 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-08-31 03:01:56.462886 | debian-bookworm -> localhost | changed 2025-08-31 03:01:56.467613 | 2025-08-31 03:01:56.467696 | TASK [validate-host : Collect information about zuul worker] 2025-08-31 03:01:57.107884 | debian-bookworm | ok 2025-08-31 03:01:57.111813 | 2025-08-31 03:01:57.111922 | TASK [validate-host : Write out all zuul information for each host] 2025-08-31 03:01:58.574701 | debian-bookworm -> localhost | changed 2025-08-31 03:01:58.582625 | 2025-08-31 03:01:58.582709 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-08-31 03:01:58.876937 | debian-bookworm | ok 2025-08-31 03:01:58.881292 | 2025-08-31 03:01:58.881510 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-08-31 03:02:00.430187 | debian-bookworm | changed: 2025-08-31 03:02:00.430325 | debian-bookworm | cd+++++++++ src/ 2025-08-31 03:02:00.430354 | debian-bookworm | cd+++++++++ src/github.com/ 2025-08-31 03:02:00.430373 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-08-31 03:02:00.430391 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/ 2025-08-31 03:02:00.430407 | debian-bookworm | localhost | ok: Runtime: 0:00:00.012282 2025-08-31 03:02:34.867305 | 2025-08-31 03:02:34.867388 | TASK [upload-logs : Upload logs to log server] 2025-08-31 03:02:35.700366 | localhost | Output suppressed because no_log was given 2025-08-31 03:02:35.701708 | 2025-08-31 03:02:35.701782 | LOOP [upload-logs : Compress console log and json output] 2025-08-31 03:02:35.827937 | localhost | skipping: Conditional result was False 2025-08-31 03:02:35.858807 | localhost | skipping: Conditional result was False 2025-08-31 03:02:35.871216 | 2025-08-31 03:02:35.871310 | LOOP [upload-logs : Upload compressed console log and json output] 2025-08-31 03:02:35.932693 | localhost | skipping: Conditional result was False 2025-08-31 03:02:35.932909 | 2025-08-31 03:02:35.938597 | localhost | skipping: Conditional result was False 2025-08-31 03:02:35.946628 | 2025-08-31 03:02:35.946716 | LOOP [upload-logs : Upload console log and json output]