2026-04-14 03:16:22.836357 | Job console starting 2026-04-14 03:16:22.846715 | Updating git repos 2026-04-14 03:16:22.880872 | Cloning repos into workspace 2026-04-14 03:16:22.962619 | Restoring repo states 2026-04-14 03:16:22.979286 | Merging changes 2026-04-14 03:16:22.979308 | Checking out repos 2026-04-14 03:16:23.178934 | Preparing playbooks 2026-04-14 03:16:24.639710 | Running Ansible setup 2026-04-14 03:16:30.559415 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-04-14 03:16:31.853764 | 2026-04-14 03:16:31.853992 | PLAY [Base pre] 2026-04-14 03:16:31.903365 | 2026-04-14 03:16:31.903633 | TASK [Setup log path fact] 2026-04-14 03:16:31.958399 | debian-bookworm | ok 2026-04-14 03:16:32.000179 | 2026-04-14 03:16:32.003236 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-14 03:16:32.081816 | debian-bookworm | ok 2026-04-14 03:16:32.104237 | 2026-04-14 03:16:32.104406 | TASK [emit-job-header : Print job information] 2026-04-14 03:16:32.176516 | # Job Information 2026-04-14 03:16:32.176755 | Ansible Version: 2.16.14 2026-04-14 03:16:32.176794 | Job: python-black 2026-04-14 03:16:32.176827 | Pipeline: periodic-daily 2026-04-14 03:16:32.176850 | Executor: 521e9411259a 2026-04-14 03:16:32.176871 | Triggered by: https://github.com/osism/testbed 2026-04-14 03:16:32.176893 | Event ID: 984f0cba41664f118927eceb369d0101 2026-04-14 03:16:32.200385 | 2026-04-14 03:16:32.202273 | LOOP [emit-job-header : Print node information] 2026-04-14 03:16:32.454959 | debian-bookworm | ok: 2026-04-14 03:16:32.455599 | debian-bookworm | # Node Information 2026-04-14 03:16:32.455684 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-04-14 03:16:32.455713 | debian-bookworm | Hostname: debian 2026-04-14 03:16:32.455738 | debian-bookworm | Username: zuul 2026-04-14 03:16:32.455759 | debian-bookworm | Distro: Debian 12.13 2026-04-14 03:16:32.455783 | debian-bookworm | Provider: regiocloud-a 2026-04-14 03:16:32.455805 | debian-bookworm | Region: 2026-04-14 03:16:32.455826 | debian-bookworm | Label: debian-bookworm 2026-04-14 03:16:32.455846 | debian-bookworm | Product Name: OpenStack Nova 2026-04-14 03:16:32.456056 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe41:b24f 2026-04-14 03:16:32.475995 | 2026-04-14 03:16:32.476165 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-14 03:16:34.295799 | debian-bookworm -> localhost | changed 2026-04-14 03:16:34.308402 | 2026-04-14 03:16:34.308539 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-14 03:16:37.014280 | debian-bookworm -> localhost | changed 2026-04-14 03:16:37.026281 | 2026-04-14 03:16:37.026388 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-14 03:16:37.472065 | debian-bookworm -> localhost | ok 2026-04-14 03:16:37.478181 | 2026-04-14 03:16:37.478298 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-14 03:16:37.517179 | debian-bookworm | ok 2026-04-14 03:16:37.542399 | debian-bookworm | included: /var/lib/zuul/builds/d0cfdafd4e5242f485e473ae9feb0769/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-14 03:16:37.554455 | 2026-04-14 03:16:37.554588 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-14 03:16:38.487964 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-04-14 03:16:38.491054 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/d0cfdafd4e5242f485e473ae9feb0769/work/d0cfdafd4e5242f485e473ae9feb0769_id_rsa 2026-04-14 03:16:38.491131 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/d0cfdafd4e5242f485e473ae9feb0769/work/d0cfdafd4e5242f485e473ae9feb0769_id_rsa.pub 2026-04-14 03:16:38.491162 | debian-bookworm -> localhost | The key fingerprint is: 2026-04-14 03:16:38.491188 | debian-bookworm -> localhost | SHA256:diEBjKQ/rN2OGN/pkop1p7MR6qU0ZKv9HDdEQtE7OLg zuul-build-sshkey 2026-04-14 03:16:38.491211 | debian-bookworm -> localhost | The key's randomart image is: 2026-04-14 03:16:38.491245 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-04-14 03:16:38.491267 | debian-bookworm -> localhost | | .+=... | 2026-04-14 03:16:38.491288 | debian-bookworm -> localhost | | o. o . | 2026-04-14 03:16:38.491308 | debian-bookworm -> localhost | | ....... . | 2026-04-14 03:16:38.491329 | debian-bookworm -> localhost | | .oooo . . | 2026-04-14 03:16:38.491348 | debian-bookworm -> localhost | | o.=...S . | 2026-04-14 03:16:38.491374 | debian-bookworm -> localhost | | oE= = . . | 2026-04-14 03:16:38.491395 | debian-bookworm -> localhost | | O *.= | 2026-04-14 03:16:38.491415 | debian-bookworm -> localhost | | B X+X o | 2026-04-14 03:16:38.491437 | debian-bookworm -> localhost | |o *oB== | 2026-04-14 03:16:38.491456 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-04-14 03:16:38.491546 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.334861 2026-04-14 03:16:38.508097 | 2026-04-14 03:16:38.508272 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-14 03:16:38.536320 | debian-bookworm | ok 2026-04-14 03:16:38.563417 | debian-bookworm | included: /var/lib/zuul/builds/d0cfdafd4e5242f485e473ae9feb0769/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-14 03:16:38.599614 | 2026-04-14 03:16:38.599718 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-14 03:16:38.667623 | debian-bookworm | skipping: Conditional result was False 2026-04-14 03:16:38.678776 | 2026-04-14 03:16:38.679349 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-14 03:16:39.742315 | debian-bookworm | changed 2026-04-14 03:16:39.747656 | 2026-04-14 03:16:39.747744 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-14 03:16:40.018759 | debian-bookworm | ok 2026-04-14 03:16:40.025902 | 2026-04-14 03:16:40.026012 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-14 03:16:40.694002 | debian-bookworm | changed 2026-04-14 03:16:40.700720 | 2026-04-14 03:16:40.700812 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-14 03:16:41.436990 | debian-bookworm | changed 2026-04-14 03:16:41.442290 | 2026-04-14 03:16:41.442386 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-14 03:16:41.475853 | debian-bookworm | skipping: Conditional result was False 2026-04-14 03:16:41.481529 | 2026-04-14 03:16:41.481674 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-14 03:16:42.689274 | debian-bookworm -> localhost | changed 2026-04-14 03:16:42.704917 | 2026-04-14 03:16:42.705033 | TASK [add-build-sshkey : Add back temp key] 2026-04-14 03:16:43.812291 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/d0cfdafd4e5242f485e473ae9feb0769/work/d0cfdafd4e5242f485e473ae9feb0769_id_rsa (zuul-build-sshkey) 2026-04-14 03:16:43.812521 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.026631 2026-04-14 03:16:43.820405 | 2026-04-14 03:16:43.820520 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-14 03:16:44.570550 | debian-bookworm | ok 2026-04-14 03:16:44.587057 | 2026-04-14 03:16:44.590181 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-14 03:16:44.647095 | debian-bookworm | skipping: Conditional result was False 2026-04-14 03:16:44.656071 | 2026-04-14 03:16:44.656167 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-04-14 03:16:45.267873 | debian-bookworm | ok 2026-04-14 03:16:45.295493 | 2026-04-14 03:16:45.295613 | TASK [validate-host : Define zuul_info_dir fact] 2026-04-14 03:16:45.347470 | debian-bookworm | ok 2026-04-14 03:16:45.353033 | 2026-04-14 03:16:45.353133 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-04-14 03:16:45.895623 | debian-bookworm -> localhost | ok 2026-04-14 03:16:45.903453 | 2026-04-14 03:16:45.903555 | TASK [validate-host : Collect information about the host] 2026-04-14 03:16:47.399745 | debian-bookworm | ok 2026-04-14 03:16:47.425345 | 2026-04-14 03:16:47.432563 | TASK [validate-host : Sanitize hostname] 2026-04-14 03:16:47.554655 | debian-bookworm | ok 2026-04-14 03:16:47.642385 | 2026-04-14 03:16:47.642518 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-04-14 03:16:48.837985 | debian-bookworm -> localhost | changed 2026-04-14 03:16:48.843816 | 2026-04-14 03:16:48.843910 | TASK [validate-host : Collect information about zuul worker] 2026-04-14 03:16:49.305235 | debian-bookworm | ok 2026-04-14 03:16:49.309785 | 2026-04-14 03:16:49.309881 | TASK [validate-host : Write out all zuul information for each host] 2026-04-14 03:16:50.263914 | debian-bookworm -> localhost | changed 2026-04-14 03:16:50.271727 | 2026-04-14 03:16:50.271813 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-04-14 03:16:50.576249 | debian-bookworm | ok 2026-04-14 03:16:50.581074 | 2026-04-14 03:16:50.581153 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-04-14 03:16:52.211709 | debian-bookworm | changed: 2026-04-14 03:16:52.211875 | debian-bookworm | cd+++++++++ src/ 2026-04-14 03:16:52.211903 | debian-bookworm | cd+++++++++ src/github.com/ 2026-04-14 03:16:52.211923 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-04-14 03:16:52.211942 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2026-04-14 03:16:52.211959 | debian-bookworm | localhost | ok: Runtime: 0:00:00.021938 2026-04-14 03:17:20.517995 | 2026-04-14 03:17:20.518157 | TASK [upload-logs : Upload logs to log server] 2026-04-14 03:17:21.366052 | localhost | Output suppressed because no_log was given 2026-04-14 03:17:21.368411 | 2026-04-14 03:17:21.368659 | LOOP [upload-logs : Compress console log and json output] 2026-04-14 03:17:21.478827 | localhost | skipping: Conditional result was False 2026-04-14 03:17:21.489400 | localhost | skipping: Conditional result was False 2026-04-14 03:17:21.502802 | 2026-04-14 03:17:21.502981 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-14 03:17:21.604385 | localhost | skipping: Conditional result was False 2026-04-14 03:17:21.604800 | 2026-04-14 03:17:21.618522 | localhost | skipping: Conditional result was False 2026-04-14 03:17:21.623557 | 2026-04-14 03:17:21.623698 | LOOP [upload-logs : Upload console log and json output]