2025-10-18 03:11:48.729068 | Job console starting 2025-10-18 03:11:48.739606 | Updating git repos 2025-10-18 03:11:48.770304 | Cloning repos into workspace 2025-10-18 03:11:48.836968 | Restoring repo states 2025-10-18 03:11:48.847095 | Merging changes 2025-10-18 03:11:48.847132 | Checking out repos 2025-10-18 03:11:48.940722 | Preparing playbooks 2025-10-18 03:11:49.492177 | Running Ansible setup 2025-10-18 03:11:53.731617 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-18 03:11:54.460709 | 2025-10-18 03:11:54.460911 | PLAY [Base pre] 2025-10-18 03:11:54.477137 | 2025-10-18 03:11:54.477256 | TASK [Setup log path fact] 2025-10-18 03:11:54.495849 | debian-bookworm | ok 2025-10-18 03:11:54.510577 | 2025-10-18 03:11:54.510695 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-18 03:11:54.553754 | debian-bookworm | ok 2025-10-18 03:11:54.572515 | 2025-10-18 03:11:54.572649 | TASK [emit-job-header : Print job information] 2025-10-18 03:11:54.620291 | # Job Information 2025-10-18 03:11:54.620639 | Ansible Version: 2.16.14 2025-10-18 03:11:54.620715 | Job: python-black 2025-10-18 03:11:54.620785 | Pipeline: periodic-daily 2025-10-18 03:11:54.620857 | Executor: 521e9411259a 2025-10-18 03:11:54.620902 | Triggered by: https://github.com/osism/testbed 2025-10-18 03:11:54.620947 | Event ID: 0697864dff144e5da9b7e60096a5b379 2025-10-18 03:11:54.630720 | 2025-10-18 03:11:54.630997 | LOOP [emit-job-header : Print node information] 2025-10-18 03:11:54.760506 | debian-bookworm | ok: 2025-10-18 03:11:54.760706 | debian-bookworm | # Node Information 2025-10-18 03:11:54.760742 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-18 03:11:54.760768 | debian-bookworm | Hostname: debian 2025-10-18 03:11:54.760791 | debian-bookworm | Username: zuul 2025-10-18 03:11:54.760812 | debian-bookworm | Distro: Debian 12.12 2025-10-18 03:11:54.760853 | debian-bookworm | Provider: regiocloud-a 2025-10-18 03:11:54.760874 | debian-bookworm | Region: 2025-10-18 03:11:54.760895 | debian-bookworm | Label: debian-bookworm 2025-10-18 03:11:54.760914 | debian-bookworm | Product Name: OpenStack Nova 2025-10-18 03:11:54.760933 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fee3:b47f 2025-10-18 03:11:54.779779 | 2025-10-18 03:11:54.780480 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-18 03:11:55.248650 | debian-bookworm -> localhost | changed 2025-10-18 03:11:55.263719 | 2025-10-18 03:11:55.263896 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-18 03:11:56.329285 | debian-bookworm -> localhost | changed 2025-10-18 03:11:56.342223 | 2025-10-18 03:11:56.342342 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-18 03:11:56.632447 | debian-bookworm -> localhost | ok 2025-10-18 03:11:56.645731 | 2025-10-18 03:11:56.645950 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-18 03:11:56.678018 | debian-bookworm | ok 2025-10-18 03:11:56.698228 | debian-bookworm | included: /var/lib/zuul/builds/cb2b2fe4bbf64f8494ca96bb34598761/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-18 03:11:56.704237 | 2025-10-18 03:11:56.704333 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-18 03:11:57.936775 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-18 03:11:57.937111 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/cb2b2fe4bbf64f8494ca96bb34598761/work/cb2b2fe4bbf64f8494ca96bb34598761_id_rsa 2025-10-18 03:11:57.937166 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/cb2b2fe4bbf64f8494ca96bb34598761/work/cb2b2fe4bbf64f8494ca96bb34598761_id_rsa.pub 2025-10-18 03:11:57.937203 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-18 03:11:57.937237 | debian-bookworm -> localhost | SHA256:IYtbXz8pP/DhtvmMkd1UYo3Cxu+ElL27wtsK2dJJ/vI zuul-build-sshkey 2025-10-18 03:11:57.937269 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-18 03:11:57.937315 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-18 03:11:57.937347 | debian-bookworm -> localhost | | | 2025-10-18 03:11:57.937379 | debian-bookworm -> localhost | | o o o | 2025-10-18 03:11:57.937408 | debian-bookworm -> localhost | | . . B = o| 2025-10-18 03:11:57.937437 | debian-bookworm -> localhost | | . o . o = o.| 2025-10-18 03:11:57.937466 | debian-bookworm -> localhost | | . o S . o + .| 2025-10-18 03:11:57.937498 | debian-bookworm -> localhost | | o . ..B.B + | 2025-10-18 03:11:57.937527 | debian-bookworm -> localhost | | . . ==@.+ .| 2025-10-18 03:11:57.937557 | debian-bookworm -> localhost | | =OO . | 2025-10-18 03:11:57.937587 | debian-bookworm -> localhost | | .BXE | 2025-10-18 03:11:57.937616 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-18 03:11:57.937690 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.750494 2025-10-18 03:11:57.946759 | 2025-10-18 03:11:57.946973 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-18 03:11:57.992955 | debian-bookworm | ok 2025-10-18 03:11:58.006465 | debian-bookworm | included: /var/lib/zuul/builds/cb2b2fe4bbf64f8494ca96bb34598761/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-18 03:11:58.016110 | 2025-10-18 03:11:58.016209 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-18 03:11:58.039987 | debian-bookworm | skipping: Conditional result was False 2025-10-18 03:11:58.047511 | 2025-10-18 03:11:58.047625 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-18 03:11:58.720968 | debian-bookworm | changed 2025-10-18 03:11:58.730388 | 2025-10-18 03:11:58.730527 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-18 03:11:58.991142 | debian-bookworm | ok 2025-10-18 03:11:59.005433 | 2025-10-18 03:11:59.005616 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-18 03:11:59.727483 | debian-bookworm | changed 2025-10-18 03:11:59.741661 | 2025-10-18 03:11:59.741968 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-18 03:12:00.420030 | debian-bookworm | changed 2025-10-18 03:12:00.429016 | 2025-10-18 03:12:00.429151 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-18 03:12:00.454717 | debian-bookworm | skipping: Conditional result was False 2025-10-18 03:12:00.469505 | 2025-10-18 03:12:00.469660 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-18 03:12:00.948266 | debian-bookworm -> localhost | changed 2025-10-18 03:12:00.966943 | 2025-10-18 03:12:00.967092 | TASK [add-build-sshkey : Add back temp key] 2025-10-18 03:12:01.316404 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/cb2b2fe4bbf64f8494ca96bb34598761/work/cb2b2fe4bbf64f8494ca96bb34598761_id_rsa (zuul-build-sshkey) 2025-10-18 03:12:01.316919 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.019890 2025-10-18 03:12:01.332548 | 2025-10-18 03:12:01.332688 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-18 03:12:01.767650 | debian-bookworm | ok 2025-10-18 03:12:01.776154 | 2025-10-18 03:12:01.776293 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-18 03:12:01.811613 | debian-bookworm | skipping: Conditional result was False 2025-10-18 03:12:01.834603 | 2025-10-18 03:12:01.834732 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-18 03:12:02.279022 | debian-bookworm | ok 2025-10-18 03:12:02.296404 | 2025-10-18 03:12:02.296528 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-18 03:12:02.343350 | debian-bookworm | ok 2025-10-18 03:12:02.353717 | 2025-10-18 03:12:02.354193 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-18 03:12:02.662614 | debian-bookworm -> localhost | ok 2025-10-18 03:12:02.669447 | 2025-10-18 03:12:02.669555 | TASK [validate-host : Collect information about the host] 2025-10-18 03:12:03.841006 | debian-bookworm | ok 2025-10-18 03:12:03.862427 | 2025-10-18 03:12:03.862570 | TASK [validate-host : Sanitize hostname] 2025-10-18 03:12:03.987012 | debian-bookworm | ok 2025-10-18 03:12:04.067440 | 2025-10-18 03:12:04.067630 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-18 03:12:04.888644 | debian-bookworm -> localhost | changed 2025-10-18 03:12:04.896171 | 2025-10-18 03:12:04.896293 | TASK [validate-host : Collect information about zuul worker] 2025-10-18 03:12:05.332856 | debian-bookworm | ok 2025-10-18 03:12:05.338001 | 2025-10-18 03:12:05.338567 | TASK [validate-host : Write out all zuul information for each host] 2025-10-18 03:12:05.922654 | debian-bookworm -> localhost | changed 2025-10-18 03:12:05.940542 | 2025-10-18 03:12:05.940673 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-18 03:12:06.232088 | debian-bookworm | ok 2025-10-18 03:12:06.241984 | 2025-10-18 03:12:06.242123 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-18 03:12:07.482719 | debian-bookworm | changed: 2025-10-18 03:12:07.482995 | debian-bookworm | cd+++++++++ src/ 2025-10-18 03:12:07.483033 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-18 03:12:07.483057 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-18 03:12:07.483079 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2025-10-18 03:12:07.483099 | debian-bookworm | localhost | ok: Runtime: 0:00:00.021714 2025-10-18 03:12:34.319040 | 2025-10-18 03:12:34.319132 | TASK [upload-logs : Upload logs to log server] 2025-10-18 03:12:35.177303 | localhost | Output suppressed because no_log was given 2025-10-18 03:12:35.180420 | 2025-10-18 03:12:35.180651 | LOOP [upload-logs : Compress console log and json output] 2025-10-18 03:12:35.231924 | localhost | skipping: Conditional result was False 2025-10-18 03:12:35.237427 | localhost | skipping: Conditional result was False 2025-10-18 03:12:35.249153 | 2025-10-18 03:12:35.249273 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-18 03:12:35.296043 | localhost | skipping: Conditional result was False 2025-10-18 03:12:35.296295 | 2025-10-18 03:12:35.300649 | localhost | skipping: Conditional result was False 2025-10-18 03:12:35.312348 | 2025-10-18 03:12:35.312436 | LOOP [upload-logs : Upload console log and json output]