2025-12-29 03:19:40.286599 | Job console starting 2025-12-29 03:19:40.305518 | Updating git repos 2025-12-29 03:19:40.344952 | Cloning repos into workspace 2025-12-29 03:19:40.431813 | Restoring repo states 2025-12-29 03:19:40.448166 | Merging changes 2025-12-29 03:19:40.448187 | Checking out repos 2025-12-29 03:19:40.530151 | Preparing playbooks 2025-12-29 03:19:42.380557 | Running Ansible setup 2025-12-29 03:19:49.569019 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-29 03:19:51.625303 | 2025-12-29 03:19:51.625478 | PLAY [Base pre] 2025-12-29 03:19:51.671733 | 2025-12-29 03:19:51.671893 | TASK [Setup log path fact] 2025-12-29 03:19:51.693007 | debian-bookworm | ok 2025-12-29 03:19:51.733000 | 2025-12-29 03:19:51.733183 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-29 03:19:51.785738 | debian-bookworm | ok 2025-12-29 03:19:51.798800 | 2025-12-29 03:19:51.799092 | TASK [emit-job-header : Print job information] 2025-12-29 03:19:51.894586 | # Job Information 2025-12-29 03:19:51.894884 | Ansible Version: 2.16.14 2025-12-29 03:19:51.894931 | Job: python-black 2025-12-29 03:19:51.894970 | Pipeline: periodic-daily 2025-12-29 03:19:51.895004 | Executor: 521e9411259a 2025-12-29 03:19:51.895035 | Triggered by: https://github.com/osism/cinder-driver-dm-clone 2025-12-29 03:19:51.895059 | Event ID: 898f70d8def34937aca1986d33360ef3 2025-12-29 03:19:51.900542 | 2025-12-29 03:19:51.900671 | LOOP [emit-job-header : Print node information] 2025-12-29 03:19:52.285210 | debian-bookworm | ok: 2025-12-29 03:19:52.285484 | debian-bookworm | # Node Information 2025-12-29 03:19:52.285549 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-29 03:19:52.285576 | debian-bookworm | Hostname: debian 2025-12-29 03:19:52.285599 | debian-bookworm | Username: zuul 2025-12-29 03:19:52.285619 | debian-bookworm | Distro: Debian 12.12 2025-12-29 03:19:52.285643 | debian-bookworm | Provider: regiocloud-a 2025-12-29 03:19:52.285664 | debian-bookworm | Region: 2025-12-29 03:19:52.285685 | debian-bookworm | Label: debian-bookworm 2025-12-29 03:19:52.285705 | debian-bookworm | Product Name: OpenStack Nova 2025-12-29 03:19:52.285725 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feee:33da 2025-12-29 03:19:52.309060 | 2025-12-29 03:19:52.309205 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-29 03:19:53.616156 | debian-bookworm -> localhost | changed 2025-12-29 03:19:53.624122 | 2025-12-29 03:19:53.624255 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-29 03:19:57.180030 | debian-bookworm -> localhost | changed 2025-12-29 03:19:57.196691 | 2025-12-29 03:19:57.196854 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-29 03:19:57.981272 | debian-bookworm -> localhost | ok 2025-12-29 03:19:57.987837 | 2025-12-29 03:19:57.987979 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-29 03:19:58.041663 | debian-bookworm | ok 2025-12-29 03:19:58.085259 | debian-bookworm | included: /var/lib/zuul/builds/ff6d960ad4114631962baea83c9e9dad/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-29 03:19:58.102431 | 2025-12-29 03:19:58.102590 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-29 03:20:00.923016 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-29 03:20:00.923294 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/ff6d960ad4114631962baea83c9e9dad/work/ff6d960ad4114631962baea83c9e9dad_id_rsa 2025-12-29 03:20:00.923339 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/ff6d960ad4114631962baea83c9e9dad/work/ff6d960ad4114631962baea83c9e9dad_id_rsa.pub 2025-12-29 03:20:00.923366 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-29 03:20:00.923390 | debian-bookworm -> localhost | SHA256:Bad9IWsiERvbN9JrBKdcKT2DZNmnD7IIDuBQuKeDVEc zuul-build-sshkey 2025-12-29 03:20:00.923412 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-29 03:20:00.923447 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-29 03:20:00.923469 | debian-bookworm -> localhost | | o. .E+o===.. | 2025-12-29 03:20:00.923490 | debian-bookworm -> localhost | |+ . . O+@*o.. | 2025-12-29 03:20:00.923559 | debian-bookworm -> localhost | |oo. . + B.X=. | 2025-12-29 03:20:00.923581 | debian-bookworm -> localhost | |.oo . ..Bo+ | 2025-12-29 03:20:00.923636 | debian-bookworm -> localhost | |oo o . .Sooo | 2025-12-29 03:20:00.923663 | debian-bookworm -> localhost | |+ . . .. . | 2025-12-29 03:20:00.923685 | debian-bookworm -> localhost | | . | 2025-12-29 03:20:00.923705 | debian-bookworm -> localhost | | | 2025-12-29 03:20:00.923726 | debian-bookworm -> localhost | | | 2025-12-29 03:20:00.923747 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-29 03:20:00.923812 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.344681 2025-12-29 03:20:00.931720 | 2025-12-29 03:20:00.931885 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-29 03:20:00.962630 | debian-bookworm | ok 2025-12-29 03:20:00.975067 | debian-bookworm | included: /var/lib/zuul/builds/ff6d960ad4114631962baea83c9e9dad/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-29 03:20:00.988001 | 2025-12-29 03:20:00.988137 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-29 03:20:01.012718 | debian-bookworm | skipping: Conditional result was False 2025-12-29 03:20:01.023039 | 2025-12-29 03:20:01.023175 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-29 03:20:01.856815 | debian-bookworm | changed 2025-12-29 03:20:01.873690 | 2025-12-29 03:20:01.873834 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-29 03:20:02.247868 | debian-bookworm | ok 2025-12-29 03:20:02.278095 | 2025-12-29 03:20:02.278709 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-29 03:20:03.126656 | debian-bookworm | changed 2025-12-29 03:20:03.152429 | 2025-12-29 03:20:03.152564 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-29 03:20:03.985435 | debian-bookworm | changed 2025-12-29 03:20:03.996889 | 2025-12-29 03:20:03.997032 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-29 03:20:04.046796 | debian-bookworm | skipping: Conditional result was False 2025-12-29 03:20:04.065240 | 2025-12-29 03:20:04.065367 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-29 03:20:04.923353 | debian-bookworm -> localhost | changed 2025-12-29 03:20:04.938702 | 2025-12-29 03:20:04.939251 | TASK [add-build-sshkey : Add back temp key] 2025-12-29 03:20:05.299009 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/ff6d960ad4114631962baea83c9e9dad/work/ff6d960ad4114631962baea83c9e9dad_id_rsa (zuul-build-sshkey) 2025-12-29 03:20:05.299223 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.015867 2025-12-29 03:20:05.308100 | 2025-12-29 03:20:05.308201 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-29 03:20:05.794880 | debian-bookworm | ok 2025-12-29 03:20:05.801115 | 2025-12-29 03:20:05.801251 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-29 03:20:05.825872 | debian-bookworm | skipping: Conditional result was False 2025-12-29 03:20:05.839890 | 2025-12-29 03:20:05.840039 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-29 03:20:06.599408 | debian-bookworm | ok 2025-12-29 03:20:06.629977 | 2025-12-29 03:20:06.630143 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-29 03:20:06.714359 | debian-bookworm | ok 2025-12-29 03:20:06.719960 | 2025-12-29 03:20:06.720081 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-29 03:20:07.440315 | debian-bookworm -> localhost | ok 2025-12-29 03:20:07.446975 | 2025-12-29 03:20:07.447096 | TASK [validate-host : Collect information about the host] 2025-12-29 03:20:08.645727 | debian-bookworm | ok 2025-12-29 03:20:08.683758 | 2025-12-29 03:20:08.683911 | TASK [validate-host : Sanitize hostname] 2025-12-29 03:20:09.066193 | debian-bookworm | ok 2025-12-29 03:20:09.172783 | 2025-12-29 03:20:09.172925 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-29 03:20:11.570195 | debian-bookworm -> localhost | changed 2025-12-29 03:20:11.577207 | 2025-12-29 03:20:11.577334 | TASK [validate-host : Collect information about zuul worker] 2025-12-29 03:20:12.221321 | debian-bookworm | ok 2025-12-29 03:20:12.227750 | 2025-12-29 03:20:12.227886 | TASK [validate-host : Write out all zuul information for each host] 2025-12-29 03:20:13.991421 | debian-bookworm -> localhost | changed 2025-12-29 03:20:14.003194 | 2025-12-29 03:20:14.003339 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-29 03:20:14.345207 | debian-bookworm | ok 2025-12-29 03:20:14.354584 | 2025-12-29 03:20:14.354808 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-29 03:20:16.204377 | debian-bookworm | changed: 2025-12-29 03:20:16.204633 | debian-bookworm | cd+++++++++ src/ 2025-12-29 03:20:16.204678 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-29 03:20:16.204708 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-29 03:20:16.204735 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/ 2025-12-29 03:20:16.204761 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007450 2025-12-29 03:20:50.187076 | 2025-12-29 03:20:50.187276 | TASK [upload-logs : Upload logs to log server] 2025-12-29 03:20:51.070777 | localhost | Output suppressed because no_log was given 2025-12-29 03:20:51.073714 | 2025-12-29 03:20:51.073838 | LOOP [upload-logs : Compress console log and json output] 2025-12-29 03:20:51.140316 | localhost | skipping: Conditional result was False 2025-12-29 03:20:51.168055 | localhost | skipping: Conditional result was False 2025-12-29 03:20:51.175959 | 2025-12-29 03:20:51.176127 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-29 03:20:51.293577 | localhost | skipping: Conditional result was False 2025-12-29 03:20:51.293935 | 2025-12-29 03:20:51.302271 | localhost | skipping: Conditional result was False 2025-12-29 03:20:51.309841 | 2025-12-29 03:20:51.309988 | LOOP [upload-logs : Upload console log and json output]