2025-10-31 03:01:05.151235 | Job console starting 2025-10-31 03:01:05.177045 | Updating git repos 2025-10-31 03:01:05.209819 | Cloning repos into workspace 2025-10-31 03:01:05.303760 | Restoring repo states 2025-10-31 03:01:05.323811 | Merging changes 2025-10-31 03:01:05.323825 | Checking out repos 2025-10-31 03:01:05.385030 | Preparing playbooks 2025-10-31 03:01:06.780044 | Running Ansible setup 2025-10-31 03:01:13.975659 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-31 03:01:15.492788 | 2025-10-31 03:01:15.492906 | PLAY [Base pre] 2025-10-31 03:01:15.506295 | 2025-10-31 03:01:15.506395 | TASK [Setup log path fact] 2025-10-31 03:01:15.563774 | debian-bookworm | ok 2025-10-31 03:01:15.581173 | 2025-10-31 03:01:15.581283 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-31 03:01:15.696804 | debian-bookworm | ok 2025-10-31 03:01:15.718612 | 2025-10-31 03:01:15.719515 | TASK [emit-job-header : Print job information] 2025-10-31 03:01:15.837465 | # Job Information 2025-10-31 03:01:15.837618 | Ansible Version: 2.16.14 2025-10-31 03:01:15.837648 | Job: python-black 2025-10-31 03:01:15.837685 | Pipeline: periodic-daily 2025-10-31 03:01:15.837704 | Executor: 521e9411259a 2025-10-31 03:01:15.837721 | Triggered by: https://github.com/osism/cinder-driver-dm-clone 2025-10-31 03:01:15.837739 | Event ID: 0c446ff7ccbb4d858a6a7361eb4606fd 2025-10-31 03:01:15.841591 | 2025-10-31 03:01:15.841667 | LOOP [emit-job-header : Print node information] 2025-10-31 03:01:16.095844 | debian-bookworm | ok: 2025-10-31 03:01:16.095982 | debian-bookworm | # Node Information 2025-10-31 03:01:16.096010 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-31 03:01:16.096031 | debian-bookworm | Hostname: debian 2025-10-31 03:01:16.096049 | debian-bookworm | Username: zuul 2025-10-31 03:01:16.096066 | debian-bookworm | Distro: Debian 12.12 2025-10-31 03:01:16.096086 | debian-bookworm | Provider: regiocloud-a 2025-10-31 03:01:16.096103 | debian-bookworm | Region: 2025-10-31 03:01:16.096120 | debian-bookworm | Label: debian-bookworm 2025-10-31 03:01:16.096137 | debian-bookworm | Product Name: OpenStack Nova 2025-10-31 03:01:16.096152 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe7a:e545 2025-10-31 03:01:16.147644 | 2025-10-31 03:01:16.147744 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-31 03:01:16.826396 | debian-bookworm -> localhost | changed 2025-10-31 03:01:16.840898 | 2025-10-31 03:01:16.841000 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-31 03:01:18.473484 | debian-bookworm -> localhost | changed 2025-10-31 03:01:18.482070 | 2025-10-31 03:01:18.482153 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-31 03:01:19.159300 | debian-bookworm -> localhost | ok 2025-10-31 03:01:19.164184 | 2025-10-31 03:01:19.164275 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-31 03:01:19.201040 | debian-bookworm | ok 2025-10-31 03:01:19.223268 | debian-bookworm | included: /var/lib/zuul/builds/1749f176d7064b14a3a938f68195cd62/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-31 03:01:19.240879 | 2025-10-31 03:01:19.240969 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-31 03:01:21.154430 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-31 03:01:21.154611 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/1749f176d7064b14a3a938f68195cd62/work/1749f176d7064b14a3a938f68195cd62_id_rsa 2025-10-31 03:01:21.154643 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/1749f176d7064b14a3a938f68195cd62/work/1749f176d7064b14a3a938f68195cd62_id_rsa.pub 2025-10-31 03:01:21.154665 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-31 03:01:21.154685 | debian-bookworm -> localhost | SHA256:ihKwBQFBJlv/NEYue1uk4NEQGb87UHDOLjh6XwExrH0 zuul-build-sshkey 2025-10-31 03:01:21.154704 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-31 03:01:21.154730 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-31 03:01:21.154748 | debian-bookworm -> localhost | |O=..B+o | 2025-10-31 03:01:21.154765 | debian-bookworm -> localhost | |o+ .o& | 2025-10-31 03:01:21.154781 | debian-bookworm -> localhost | |o .o* @ . | 2025-10-31 03:01:21.154798 | debian-bookworm -> localhost | | +.o.%E= | 2025-10-31 03:01:21.154813 | debian-bookworm -> localhost | |. + =.B S | 2025-10-31 03:01:21.155026 | debian-bookworm -> localhost | | . o = * | 2025-10-31 03:01:21.155060 | debian-bookworm -> localhost | |. o . * | 2025-10-31 03:01:21.155085 | debian-bookworm -> localhost | | . o . . | 2025-10-31 03:01:21.155104 | debian-bookworm -> localhost | | . | 2025-10-31 03:01:21.155122 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-31 03:01:21.155166 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.173828 2025-10-31 03:01:21.160670 | 2025-10-31 03:01:21.160757 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-31 03:01:21.210120 | debian-bookworm | ok 2025-10-31 03:01:21.229109 | debian-bookworm | included: /var/lib/zuul/builds/1749f176d7064b14a3a938f68195cd62/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-31 03:01:21.276027 | 2025-10-31 03:01:21.276126 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-31 03:01:21.348239 | debian-bookworm | skipping: Conditional result was False 2025-10-31 03:01:21.356364 | 2025-10-31 03:01:21.356456 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-31 03:01:22.024297 | debian-bookworm | changed 2025-10-31 03:01:22.028646 | 2025-10-31 03:01:22.028720 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-31 03:01:22.300154 | debian-bookworm | ok 2025-10-31 03:01:22.304769 | 2025-10-31 03:01:22.304852 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-31 03:01:23.229309 | debian-bookworm | changed 2025-10-31 03:01:23.234652 | 2025-10-31 03:01:23.234730 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-31 03:01:24.032133 | debian-bookworm | changed 2025-10-31 03:01:24.043897 | 2025-10-31 03:01:24.044271 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-31 03:01:24.076990 | debian-bookworm | skipping: Conditional result was False 2025-10-31 03:01:24.084276 | 2025-10-31 03:01:24.084366 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-31 03:01:24.568357 | debian-bookworm -> localhost | changed 2025-10-31 03:01:24.577118 | 2025-10-31 03:01:24.577199 | TASK [add-build-sshkey : Add back temp key] 2025-10-31 03:01:25.109152 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/1749f176d7064b14a3a938f68195cd62/work/1749f176d7064b14a3a938f68195cd62_id_rsa (zuul-build-sshkey) 2025-10-31 03:01:25.109416 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011173 2025-10-31 03:01:25.116221 | 2025-10-31 03:01:25.116318 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-31 03:01:25.570080 | debian-bookworm | ok 2025-10-31 03:01:25.574183 | 2025-10-31 03:01:25.574262 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-31 03:01:25.609777 | debian-bookworm | skipping: Conditional result was False 2025-10-31 03:01:25.624939 | 2025-10-31 03:01:25.625031 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-31 03:01:26.200328 | debian-bookworm | ok 2025-10-31 03:01:26.224252 | 2025-10-31 03:01:26.224417 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-31 03:01:26.290684 | debian-bookworm | ok 2025-10-31 03:01:26.303040 | 2025-10-31 03:01:26.303474 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-31 03:01:27.313986 | debian-bookworm -> localhost | ok 2025-10-31 03:01:27.319271 | 2025-10-31 03:01:27.319353 | TASK [validate-host : Collect information about the host] 2025-10-31 03:01:28.675448 | debian-bookworm | ok 2025-10-31 03:01:28.684352 | 2025-10-31 03:01:28.684463 | TASK [validate-host : Sanitize hostname] 2025-10-31 03:01:28.916651 | debian-bookworm | ok 2025-10-31 03:01:29.027337 | 2025-10-31 03:01:29.027448 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-31 03:01:30.474115 | debian-bookworm -> localhost | changed 2025-10-31 03:01:30.478778 | 2025-10-31 03:01:30.478901 | TASK [validate-host : Collect information about zuul worker] 2025-10-31 03:01:31.401539 | debian-bookworm | ok 2025-10-31 03:01:31.405302 | 2025-10-31 03:01:31.405384 | TASK [validate-host : Write out all zuul information for each host] 2025-10-31 03:01:32.901671 | debian-bookworm -> localhost | changed 2025-10-31 03:01:32.909390 | 2025-10-31 03:01:32.909476 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-31 03:01:33.211434 | debian-bookworm | ok 2025-10-31 03:01:33.215894 | 2025-10-31 03:01:33.215976 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-31 03:01:34.924045 | debian-bookworm | changed: 2025-10-31 03:01:34.924184 | debian-bookworm | cd+++++++++ src/ 2025-10-31 03:01:34.924212 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-31 03:01:34.924232 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-31 03:01:34.924249 | debian-bookworm | cd+++++++++ src/github.com/osism/cinder-driver-dm-clone/ 2025-10-31 03:01:34.924266 | debian-bookworm | localhost | ok: Runtime: 0:00:00.009833 2025-10-31 03:02:01.389705 | 2025-10-31 03:02:01.389782 | TASK [upload-logs : Upload logs to log server] 2025-10-31 03:02:01.913170 | localhost | Output suppressed because no_log was given 2025-10-31 03:02:01.914750 | 2025-10-31 03:02:01.914851 | LOOP [upload-logs : Compress console log and json output] 2025-10-31 03:02:01.950044 | localhost | skipping: Conditional result was False 2025-10-31 03:02:01.954941 | localhost | skipping: Conditional result was False 2025-10-31 03:02:01.969960 | 2025-10-31 03:02:01.970142 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-31 03:02:02.005033 | localhost | skipping: Conditional result was False 2025-10-31 03:02:02.005246 | 2025-10-31 03:02:02.008811 | localhost | skipping: Conditional result was False 2025-10-31 03:02:02.020659 | 2025-10-31 03:02:02.020812 | LOOP [upload-logs : Upload console log and json output]