2025-09-12 03:05:00.239864 | Job console starting 2025-09-12 03:05:00.284467 | Updating git repos 2025-09-12 03:05:00.308939 | Cloning repos into workspace 2025-09-12 03:05:00.341471 | Restoring repo states 2025-09-12 03:05:00.346970 | Merging changes 2025-09-12 03:05:00.346988 | Checking out repos 2025-09-12 03:05:00.420056 | Preparing playbooks 2025-09-12 03:05:01.088077 | Running Ansible setup 2025-09-12 03:05:06.040889 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-12 03:05:06.871258 | 2025-09-12 03:05:06.871422 | PLAY [Base pre] 2025-09-12 03:05:06.892698 | 2025-09-12 03:05:06.892855 | TASK [Setup log path fact] 2025-09-12 03:05:06.912473 | debian-bookworm | ok 2025-09-12 03:05:06.929107 | 2025-09-12 03:05:06.929286 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-12 03:05:06.959110 | debian-bookworm | ok 2025-09-12 03:05:06.969566 | 2025-09-12 03:05:06.969686 | TASK [emit-job-header : Print job information] 2025-09-12 03:05:07.019253 | # Job Information 2025-09-12 03:05:07.019447 | Ansible Version: 2.16.14 2025-09-12 03:05:07.019482 | Job: python-black 2025-09-12 03:05:07.019513 | Pipeline: periodic-daily 2025-09-12 03:05:07.019535 | Executor: 521e9411259a 2025-09-12 03:05:07.019554 | Triggered by: https://github.com/osism/rookify 2025-09-12 03:05:07.019576 | Event ID: 213b86d6cb2b4d2c9ddca010b13e4717 2025-09-12 03:05:07.024837 | 2025-09-12 03:05:07.024958 | LOOP [emit-job-header : Print node information] 2025-09-12 03:05:07.146858 | debian-bookworm | ok: 2025-09-12 03:05:07.147062 | debian-bookworm | # Node Information 2025-09-12 03:05:07.147098 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-12 03:05:07.147123 | debian-bookworm | Hostname: debian 2025-09-12 03:05:07.147145 | debian-bookworm | Username: zuul 2025-09-12 03:05:07.147200 | debian-bookworm | Distro: Debian 12.12 2025-09-12 03:05:07.147226 | debian-bookworm | Provider: regiocloud-a 2025-09-12 03:05:07.147247 | debian-bookworm | Region: 2025-09-12 03:05:07.147268 | debian-bookworm | Label: debian-bookworm 2025-09-12 03:05:07.147289 | debian-bookworm | Product Name: OpenStack Nova 2025-09-12 03:05:07.147308 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feb8:11e4 2025-09-12 03:05:07.164776 | 2025-09-12 03:05:07.164914 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-12 03:05:07.654404 | debian-bookworm -> localhost | changed 2025-09-12 03:05:07.662730 | 2025-09-12 03:05:07.662938 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-12 03:05:08.791289 | debian-bookworm -> localhost | changed 2025-09-12 03:05:08.802414 | 2025-09-12 03:05:08.802537 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-12 03:05:09.095427 | debian-bookworm -> localhost | ok 2025-09-12 03:05:09.102105 | 2025-09-12 03:05:09.102256 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-12 03:05:09.125004 | debian-bookworm | ok 2025-09-12 03:05:09.143603 | debian-bookworm | included: /var/lib/zuul/builds/1bf99e7002334ae1acd43d5cbee7df76/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-12 03:05:09.149875 | 2025-09-12 03:05:09.149988 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-12 03:05:10.491515 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-12 03:05:10.492022 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/1bf99e7002334ae1acd43d5cbee7df76/work/1bf99e7002334ae1acd43d5cbee7df76_id_rsa 2025-09-12 03:05:10.492132 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/1bf99e7002334ae1acd43d5cbee7df76/work/1bf99e7002334ae1acd43d5cbee7df76_id_rsa.pub 2025-09-12 03:05:10.492235 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-12 03:05:10.492310 | debian-bookworm -> localhost | SHA256:GphZ2Xm9FkWsVjSLAM/qejImOvy/a/ZmIGx9IYe7yNI zuul-build-sshkey 2025-09-12 03:05:10.492373 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-12 03:05:10.492457 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-12 03:05:10.492520 | debian-bookworm -> localhost | | ... += | 2025-09-12 03:05:10.492581 | debian-bookworm -> localhost | | o + o ooo | 2025-09-12 03:05:10.492636 | debian-bookworm -> localhost | | o.o + +o. | 2025-09-12 03:05:10.492691 | debian-bookworm -> localhost | | =o oo oo | 2025-09-12 03:05:10.492745 | debian-bookworm -> localhost | | .+..+S. .o | 2025-09-12 03:05:10.492813 | debian-bookworm -> localhost | | + ++. . | 2025-09-12 03:05:10.492870 | debian-bookworm -> localhost | | . + o.+. | 2025-09-12 03:05:10.492924 | debian-bookworm -> localhost | | + E B.+ | 2025-09-12 03:05:10.492982 | debian-bookworm -> localhost | | .=.*=X. | 2025-09-12 03:05:10.493040 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-12 03:05:10.493199 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.657294 2025-09-12 03:05:10.505529 | 2025-09-12 03:05:10.505689 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-12 03:05:10.540217 | debian-bookworm | ok 2025-09-12 03:05:10.553535 | debian-bookworm | included: /var/lib/zuul/builds/1bf99e7002334ae1acd43d5cbee7df76/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-12 03:05:10.563427 | 2025-09-12 03:05:10.563571 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-12 03:05:10.588026 | debian-bookworm | skipping: Conditional result was False 2025-09-12 03:05:10.595545 | 2025-09-12 03:05:10.595676 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-12 03:05:11.260093 | debian-bookworm | changed 2025-09-12 03:05:11.276883 | 2025-09-12 03:05:11.277023 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-12 03:05:11.555876 | debian-bookworm | ok 2025-09-12 03:05:11.561566 | 2025-09-12 03:05:11.561692 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-12 03:05:12.256032 | debian-bookworm | changed 2025-09-12 03:05:12.263874 | 2025-09-12 03:05:12.263999 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-12 03:05:13.004396 | debian-bookworm | changed 2025-09-12 03:05:13.012309 | 2025-09-12 03:05:13.012444 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-12 03:05:13.036558 | debian-bookworm | skipping: Conditional result was False 2025-09-12 03:05:13.043257 | 2025-09-12 03:05:13.043386 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-12 03:05:13.559208 | debian-bookworm -> localhost | changed 2025-09-12 03:05:13.573978 | 2025-09-12 03:05:13.574103 | TASK [add-build-sshkey : Add back temp key] 2025-09-12 03:05:13.986589 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/1bf99e7002334ae1acd43d5cbee7df76/work/1bf99e7002334ae1acd43d5cbee7df76_id_rsa (zuul-build-sshkey) 2025-09-12 03:05:13.986857 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.012941 2025-09-12 03:05:14.000024 | 2025-09-12 03:05:14.001988 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-12 03:05:14.482402 | debian-bookworm | ok 2025-09-12 03:05:14.487612 | 2025-09-12 03:05:14.487720 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-12 03:05:14.513760 | debian-bookworm | skipping: Conditional result was False 2025-09-12 03:05:14.524069 | 2025-09-12 03:05:14.524199 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-12 03:05:15.099941 | debian-bookworm | ok 2025-09-12 03:05:15.124565 | 2025-09-12 03:05:15.124856 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-12 03:05:15.156732 | debian-bookworm | ok 2025-09-12 03:05:15.162808 | 2025-09-12 03:05:15.162949 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-12 03:05:16.013458 | debian-bookworm -> localhost | ok 2025-09-12 03:05:16.028314 | 2025-09-12 03:05:16.028461 | TASK [validate-host : Collect information about the host] 2025-09-12 03:05:17.766107 | debian-bookworm | ok 2025-09-12 03:05:17.801870 | 2025-09-12 03:05:17.802352 | TASK [validate-host : Sanitize hostname] 2025-09-12 03:05:17.937693 | debian-bookworm | ok 2025-09-12 03:05:18.011403 | 2025-09-12 03:05:18.011512 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-12 03:05:18.989602 | debian-bookworm -> localhost | changed 2025-09-12 03:05:18.995000 | 2025-09-12 03:05:18.995143 | TASK [validate-host : Collect information about zuul worker] 2025-09-12 03:05:19.408045 | debian-bookworm | ok 2025-09-12 03:05:19.412842 | 2025-09-12 03:05:19.412927 | TASK [validate-host : Write out all zuul information for each host] 2025-09-12 03:05:19.817027 | debian-bookworm -> localhost | changed 2025-09-12 03:05:19.826035 | 2025-09-12 03:05:19.826127 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-12 03:05:20.112708 | debian-bookworm | ok 2025-09-12 03:05:20.121648 | 2025-09-12 03:05:20.121747 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-12 03:05:20.903331 | debian-bookworm | changed: 2025-09-12 03:05:20.903503 | debian-bookworm | cd+++++++++ src/ 2025-09-12 03:05:20.903536 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-12 03:05:20.903559 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-12 03:05:20.903580 | debian-bookworm | cd+++++++++ src/github.com/osism/rookify/ 2025-09-12 03:05:20.903599 | debian-bookworm | Containerfile 2025-09-12 03:05:20.903747 | debian-bookworm | localhost | ok: Runtime: 0:00:00.008842 2025-09-12 03:05:45.657382 | 2025-09-12 03:05:45.657507 | TASK [upload-logs : Upload logs to log server] 2025-09-12 03:05:46.692034 | localhost | Output suppressed because no_log was given 2025-09-12 03:05:46.693934 | 2025-09-12 03:05:46.694035 | LOOP [upload-logs : Compress console log and json output] 2025-09-12 03:05:46.747259 | localhost | skipping: Conditional result was False 2025-09-12 03:05:46.765664 | localhost | skipping: Conditional result was False 2025-09-12 03:05:46.781020 | 2025-09-12 03:05:46.781197 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-12 03:05:46.838772 | localhost | skipping: Conditional result was False 2025-09-12 03:05:46.839135 | 2025-09-12 03:05:46.845961 | localhost | skipping: Conditional result was False 2025-09-12 03:05:46.849712 | 2025-09-12 03:05:46.849834 | LOOP [upload-logs : Upload console log and json output]