2025-10-26 03:12:03.598655 | Job console starting 2025-10-26 03:12:03.613285 | Updating git repos 2025-10-26 03:12:03.649955 | Cloning repos into workspace 2025-10-26 03:12:03.751516 | Restoring repo states 2025-10-26 03:12:03.768605 | Merging changes 2025-10-26 03:12:03.768619 | Checking out repos 2025-10-26 03:12:03.859678 | Preparing playbooks 2025-10-26 03:12:04.875448 | Running Ansible setup 2025-10-26 03:12:10.103938 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-26 03:12:11.216771 | 2025-10-26 03:12:11.216943 | PLAY [Base pre] 2025-10-26 03:12:11.242623 | 2025-10-26 03:12:11.242740 | TASK [Setup log path fact] 2025-10-26 03:12:11.269608 | debian-bookworm | ok 2025-10-26 03:12:11.301073 | 2025-10-26 03:12:11.301196 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-26 03:12:11.331625 | debian-bookworm | ok 2025-10-26 03:12:11.340153 | 2025-10-26 03:12:11.340249 | TASK [emit-job-header : Print job information] 2025-10-26 03:12:11.429049 | # Job Information 2025-10-26 03:12:11.429244 | Ansible Version: 2.16.14 2025-10-26 03:12:11.429275 | Job: python-black 2025-10-26 03:12:11.429302 | Pipeline: periodic-daily 2025-10-26 03:12:11.429321 | Executor: 521e9411259a 2025-10-26 03:12:11.429338 | Triggered by: https://github.com/osism/testbed 2025-10-26 03:12:11.429356 | Event ID: d6451bb832754394b3b9d1e1fad69b49 2025-10-26 03:12:11.433295 | 2025-10-26 03:12:11.433384 | LOOP [emit-job-header : Print node information] 2025-10-26 03:12:11.610157 | debian-bookworm | ok: 2025-10-26 03:12:11.610352 | debian-bookworm | # Node Information 2025-10-26 03:12:11.610381 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-26 03:12:11.610401 | debian-bookworm | Hostname: debian 2025-10-26 03:12:11.610419 | debian-bookworm | Username: zuul 2025-10-26 03:12:11.610457 | debian-bookworm | Distro: Debian 12.12 2025-10-26 03:12:11.610480 | debian-bookworm | Provider: regiocloud-a 2025-10-26 03:12:11.610497 | debian-bookworm | Region: 2025-10-26 03:12:11.610514 | debian-bookworm | Label: debian-bookworm 2025-10-26 03:12:11.610530 | debian-bookworm | Product Name: OpenStack Nova 2025-10-26 03:12:11.610546 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feaa:9866 2025-10-26 03:12:11.622445 | 2025-10-26 03:12:11.622541 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-26 03:12:12.597119 | debian-bookworm -> localhost | changed 2025-10-26 03:12:12.604876 | 2025-10-26 03:12:12.604982 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-26 03:12:14.130683 | debian-bookworm -> localhost | changed 2025-10-26 03:12:14.140122 | 2025-10-26 03:12:14.140219 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-26 03:12:14.836139 | debian-bookworm -> localhost | ok 2025-10-26 03:12:14.851946 | 2025-10-26 03:12:14.852040 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-26 03:12:14.884121 | debian-bookworm | ok 2025-10-26 03:12:14.897486 | debian-bookworm | included: /var/lib/zuul/builds/78e3b262647b4565a724b397ce52bda3/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-26 03:12:14.902173 | 2025-10-26 03:12:14.902243 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-26 03:12:16.323462 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-26 03:12:16.323623 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/78e3b262647b4565a724b397ce52bda3/work/78e3b262647b4565a724b397ce52bda3_id_rsa 2025-10-26 03:12:16.323653 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/78e3b262647b4565a724b397ce52bda3/work/78e3b262647b4565a724b397ce52bda3_id_rsa.pub 2025-10-26 03:12:16.323674 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-26 03:12:16.323693 | debian-bookworm -> localhost | SHA256:2NFaKlURgPUXRU/DRXFp2W6bqQRQi7x0Bp5ColUJHWE zuul-build-sshkey 2025-10-26 03:12:16.323711 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-26 03:12:16.323736 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-26 03:12:16.323754 | debian-bookworm -> localhost | | ++E*o=+.o++@| 2025-10-26 03:12:16.323771 | debian-bookworm -> localhost | | o =oo=+ .. B+| 2025-10-26 03:12:16.323788 | debian-bookworm -> localhost | | . .o*=+. ...| 2025-10-26 03:12:16.323804 | debian-bookworm -> localhost | | +o=+o o| 2025-10-26 03:12:16.323820 | debian-bookworm -> localhost | | o S. . .+| 2025-10-26 03:12:16.323842 | debian-bookworm -> localhost | | . . + | 2025-10-26 03:12:16.323860 | debian-bookworm -> localhost | | . . | 2025-10-26 03:12:16.323876 | debian-bookworm -> localhost | | . | 2025-10-26 03:12:16.323893 | debian-bookworm -> localhost | | | 2025-10-26 03:12:16.323909 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-26 03:12:16.323950 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.961918 2025-10-26 03:12:16.328964 | 2025-10-26 03:12:16.329052 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-26 03:12:16.351320 | debian-bookworm | ok 2025-10-26 03:12:16.360155 | debian-bookworm | included: /var/lib/zuul/builds/78e3b262647b4565a724b397ce52bda3/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-26 03:12:16.371828 | 2025-10-26 03:12:16.379335 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-26 03:12:16.392159 | debian-bookworm | skipping: Conditional result was False 2025-10-26 03:12:16.401248 | 2025-10-26 03:12:16.401342 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-26 03:12:16.979888 | debian-bookworm | changed 2025-10-26 03:12:16.986209 | 2025-10-26 03:12:16.986299 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-26 03:12:17.202332 | debian-bookworm | ok 2025-10-26 03:12:17.207182 | 2025-10-26 03:12:17.207261 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-26 03:12:17.828612 | debian-bookworm | changed 2025-10-26 03:12:17.839785 | 2025-10-26 03:12:17.839876 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-26 03:12:18.471698 | debian-bookworm | changed 2025-10-26 03:12:18.483367 | 2025-10-26 03:12:18.483480 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-26 03:12:18.523156 | debian-bookworm | skipping: Conditional result was False 2025-10-26 03:12:18.539396 | 2025-10-26 03:12:18.539883 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-26 03:12:19.426183 | debian-bookworm -> localhost | changed 2025-10-26 03:12:19.438512 | 2025-10-26 03:12:19.438601 | TASK [add-build-sshkey : Add back temp key] 2025-10-26 03:12:19.949152 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/78e3b262647b4565a724b397ce52bda3/work/78e3b262647b4565a724b397ce52bda3_id_rsa (zuul-build-sshkey) 2025-10-26 03:12:19.949331 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.027280 2025-10-26 03:12:19.956536 | 2025-10-26 03:12:19.956623 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-26 03:12:20.476502 | debian-bookworm | ok 2025-10-26 03:12:20.480482 | 2025-10-26 03:12:20.480556 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-26 03:12:20.513125 | debian-bookworm | skipping: Conditional result was False 2025-10-26 03:12:20.521609 | 2025-10-26 03:12:20.521693 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-26 03:12:20.984285 | debian-bookworm | ok 2025-10-26 03:12:21.004625 | 2025-10-26 03:12:21.004718 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-26 03:12:21.051831 | debian-bookworm | ok 2025-10-26 03:12:21.056143 | 2025-10-26 03:12:21.056279 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-26 03:12:21.365960 | debian-bookworm -> localhost | ok 2025-10-26 03:12:21.383497 | 2025-10-26 03:12:21.383584 | TASK [validate-host : Collect information about the host] 2025-10-26 03:12:22.374869 | debian-bookworm | ok 2025-10-26 03:12:22.392613 | 2025-10-26 03:12:22.392717 | TASK [validate-host : Sanitize hostname] 2025-10-26 03:12:22.522410 | debian-bookworm | ok 2025-10-26 03:12:22.593136 | 2025-10-26 03:12:22.593244 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-26 03:12:23.315747 | debian-bookworm -> localhost | changed 2025-10-26 03:12:23.321140 | 2025-10-26 03:12:23.321241 | TASK [validate-host : Collect information about zuul worker] 2025-10-26 03:12:23.731476 | debian-bookworm | ok 2025-10-26 03:12:23.735948 | 2025-10-26 03:12:23.736041 | TASK [validate-host : Write out all zuul information for each host] 2025-10-26 03:12:24.221292 | debian-bookworm -> localhost | changed 2025-10-26 03:12:24.230385 | 2025-10-26 03:12:24.230487 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-26 03:12:24.492508 | debian-bookworm | ok 2025-10-26 03:12:24.497678 | 2025-10-26 03:12:24.497755 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-26 03:12:25.730245 | debian-bookworm | changed: 2025-10-26 03:12:25.730404 | debian-bookworm | cd+++++++++ src/ 2025-10-26 03:12:25.730463 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-26 03:12:25.730489 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-26 03:12:25.730510 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2025-10-26 03:12:25.730530 | debian-bookworm | localhost | ok: Runtime: 0:00:00.012651 2025-10-26 03:12:51.191271 | 2025-10-26 03:12:51.191387 | TASK [upload-logs : Upload logs to log server] 2025-10-26 03:12:51.894100 | localhost | Output suppressed because no_log was given 2025-10-26 03:12:51.907733 | 2025-10-26 03:12:51.909659 | LOOP [upload-logs : Compress console log and json output] 2025-10-26 03:12:52.017357 | localhost | skipping: Conditional result was False 2025-10-26 03:12:52.025824 | localhost | skipping: Conditional result was False 2025-10-26 03:12:52.040641 | 2025-10-26 03:12:52.040768 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-26 03:12:52.110663 | localhost | skipping: Conditional result was False 2025-10-26 03:12:52.110954 | 2025-10-26 03:12:52.118374 | localhost | skipping: Conditional result was False 2025-10-26 03:12:52.124005 | 2025-10-26 03:12:52.124119 | LOOP [upload-logs : Upload console log and json output]