2025-10-06 03:08:27.656081 | Job console starting 2025-10-06 03:08:27.677461 | Updating git repos 2025-10-06 03:08:27.691040 | Cloning repos into workspace 2025-10-06 03:08:27.716646 | Restoring repo states 2025-10-06 03:08:27.724021 | Merging changes 2025-10-06 03:08:27.724039 | Checking out repos 2025-10-06 03:08:27.794696 | Preparing playbooks 2025-10-06 03:08:29.157009 | Running Ansible setup 2025-10-06 03:08:34.646396 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-06 03:08:35.499348 | 2025-10-06 03:08:35.499459 | PLAY [Base pre] 2025-10-06 03:08:35.511424 | 2025-10-06 03:08:35.511537 | TASK [Setup log path fact] 2025-10-06 03:08:35.538158 | debian-bookworm | ok 2025-10-06 03:08:35.549872 | 2025-10-06 03:08:35.549970 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-06 03:08:35.577097 | debian-bookworm | ok 2025-10-06 03:08:35.588745 | 2025-10-06 03:08:35.588830 | TASK [emit-job-header : Print job information] 2025-10-06 03:08:35.635590 | # Job Information 2025-10-06 03:08:35.635731 | Ansible Version: 2.16.14 2025-10-06 03:08:35.635760 | Job: python-black 2025-10-06 03:08:35.635786 | Pipeline: periodic-daily 2025-10-06 03:08:35.635805 | Executor: 521e9411259a 2025-10-06 03:08:35.635822 | Triggered by: https://github.com/osism/rookify 2025-10-06 03:08:35.635841 | Event ID: b6749991fe614715ba5b84a248f64cb4 2025-10-06 03:08:35.639757 | 2025-10-06 03:08:35.639838 | LOOP [emit-job-header : Print node information] 2025-10-06 03:08:35.740693 | debian-bookworm | ok: 2025-10-06 03:08:35.740829 | debian-bookworm | # Node Information 2025-10-06 03:08:35.740857 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-06 03:08:35.740878 | debian-bookworm | Hostname: debian 2025-10-06 03:08:35.740896 | debian-bookworm | Username: zuul 2025-10-06 03:08:35.740913 | debian-bookworm | Distro: Debian 12.12 2025-10-06 03:08:35.740933 | debian-bookworm | Provider: regiocloud-a 2025-10-06 03:08:35.740951 | debian-bookworm | Region: 2025-10-06 03:08:35.740968 | debian-bookworm | Label: debian-bookworm 2025-10-06 03:08:35.740985 | debian-bookworm | Product Name: OpenStack Nova 2025-10-06 03:08:35.741002 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe60:a239 2025-10-06 03:08:35.752335 | 2025-10-06 03:08:35.752425 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-06 03:08:36.539852 | debian-bookworm -> localhost | changed 2025-10-06 03:08:36.554156 | 2025-10-06 03:08:36.554718 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-06 03:08:37.770457 | debian-bookworm -> localhost | changed 2025-10-06 03:08:37.782945 | 2025-10-06 03:08:37.783035 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-06 03:08:38.147327 | debian-bookworm -> localhost | ok 2025-10-06 03:08:38.155087 | 2025-10-06 03:08:38.155183 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-06 03:08:38.185355 | debian-bookworm | ok 2025-10-06 03:08:38.199992 | debian-bookworm | included: /var/lib/zuul/builds/5ccc7ff707094dd898127487b862da4f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-06 03:08:38.204987 | 2025-10-06 03:08:38.205057 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-06 03:08:41.517499 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-06 03:08:41.517668 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/5ccc7ff707094dd898127487b862da4f/work/5ccc7ff707094dd898127487b862da4f_id_rsa 2025-10-06 03:08:41.517701 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/5ccc7ff707094dd898127487b862da4f/work/5ccc7ff707094dd898127487b862da4f_id_rsa.pub 2025-10-06 03:08:41.517725 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-06 03:08:41.517748 | debian-bookworm -> localhost | SHA256:kG9KpXQW+ffIRPw3JGwgZ0lowUetv7gtntQH2cj/xNA zuul-build-sshkey 2025-10-06 03:08:41.517767 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-06 03:08:41.517794 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-06 03:08:41.517814 | debian-bookworm -> localhost | | o+=B= | 2025-10-06 03:08:41.517833 | debian-bookworm -> localhost | | ..=+oo= . | 2025-10-06 03:08:41.517852 | debian-bookworm -> localhost | | + =...o.o | 2025-10-06 03:08:41.517870 | debian-bookworm -> localhost | | . B ..+ =o.| 2025-10-06 03:08:41.517887 | debian-bookworm -> localhost | | o S +.B.oE| 2025-10-06 03:08:41.517910 | debian-bookworm -> localhost | | . o +.+o | 2025-10-06 03:08:41.517928 | debian-bookworm -> localhost | | . ....oo| 2025-10-06 03:08:41.517946 | debian-bookworm -> localhost | | .oo....| 2025-10-06 03:08:41.517964 | debian-bookworm -> localhost | | .+o. .| 2025-10-06 03:08:41.517982 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-06 03:08:41.518023 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.856917 2025-10-06 03:08:41.523023 | 2025-10-06 03:08:41.523100 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-06 03:08:41.549044 | debian-bookworm | ok 2025-10-06 03:08:41.556489 | debian-bookworm | included: /var/lib/zuul/builds/5ccc7ff707094dd898127487b862da4f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-06 03:08:41.565394 | 2025-10-06 03:08:41.565475 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-06 03:08:41.577777 | debian-bookworm | skipping: Conditional result was False 2025-10-06 03:08:41.582289 | 2025-10-06 03:08:41.582371 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-06 03:08:42.182423 | debian-bookworm | changed 2025-10-06 03:08:42.190134 | 2025-10-06 03:08:42.190228 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-06 03:08:42.434081 | debian-bookworm | ok 2025-10-06 03:08:42.441680 | 2025-10-06 03:08:42.441784 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-06 03:08:43.073159 | debian-bookworm | changed 2025-10-06 03:08:43.079675 | 2025-10-06 03:08:43.079767 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-06 03:08:43.644985 | debian-bookworm | changed 2025-10-06 03:08:43.653272 | 2025-10-06 03:08:43.653529 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-06 03:08:43.676617 | debian-bookworm | skipping: Conditional result was False 2025-10-06 03:08:43.685156 | 2025-10-06 03:08:43.685938 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-06 03:08:44.212600 | debian-bookworm -> localhost | changed 2025-10-06 03:08:44.226200 | 2025-10-06 03:08:44.226297 | TASK [add-build-sshkey : Add back temp key] 2025-10-06 03:08:44.536321 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/5ccc7ff707094dd898127487b862da4f/work/5ccc7ff707094dd898127487b862da4f_id_rsa (zuul-build-sshkey) 2025-10-06 03:08:44.536540 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.009472 2025-10-06 03:08:44.543919 | 2025-10-06 03:08:44.544006 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-06 03:08:44.978036 | debian-bookworm | ok 2025-10-06 03:08:44.982790 | 2025-10-06 03:08:44.982895 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-06 03:08:45.006002 | debian-bookworm | skipping: Conditional result was False 2025-10-06 03:08:45.015737 | 2025-10-06 03:08:45.015832 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-06 03:08:45.408689 | debian-bookworm | ok 2025-10-06 03:08:45.420689 | 2025-10-06 03:08:45.420768 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-06 03:08:45.447116 | debian-bookworm | ok 2025-10-06 03:08:45.451106 | 2025-10-06 03:08:45.451178 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-06 03:08:45.745855 | debian-bookworm -> localhost | ok 2025-10-06 03:08:45.750858 | 2025-10-06 03:08:45.750926 | TASK [validate-host : Collect information about the host] 2025-10-06 03:08:46.833592 | debian-bookworm | ok 2025-10-06 03:08:46.854752 | 2025-10-06 03:08:46.854935 | TASK [validate-host : Sanitize hostname] 2025-10-06 03:08:47.004659 | debian-bookworm | ok 2025-10-06 03:08:47.042330 | 2025-10-06 03:08:47.042430 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-06 03:08:47.576649 | debian-bookworm -> localhost | changed 2025-10-06 03:08:47.582051 | 2025-10-06 03:08:47.582143 | TASK [validate-host : Collect information about zuul worker] 2025-10-06 03:08:47.992778 | debian-bookworm | ok 2025-10-06 03:08:47.997360 | 2025-10-06 03:08:47.997447 | TASK [validate-host : Write out all zuul information for each host] 2025-10-06 03:08:48.548935 | debian-bookworm -> localhost | changed 2025-10-06 03:08:48.558658 | 2025-10-06 03:08:48.558744 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-06 03:08:48.831671 | debian-bookworm | ok 2025-10-06 03:08:48.836831 | 2025-10-06 03:08:48.836915 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-06 03:08:49.613150 | debian-bookworm | changed: 2025-10-06 03:08:49.613347 | debian-bookworm | cd+++++++++ src/ 2025-10-06 03:08:49.613382 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-06 03:08:49.613407 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-06 03:08:49.613429 | debian-bookworm | cd+++++++++ src/github.com/osism/rookify/ 2025-10-06 03:08:49.613470 | debian-bookworm | Containerfile 2025-10-06 03:08:49.613626 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007015 2025-10-06 03:09:16.707370 | 2025-10-06 03:09:16.707694 | TASK [upload-logs : Upload logs to log server] 2025-10-06 03:09:17.870527 | localhost | Output suppressed because no_log was given 2025-10-06 03:09:17.872146 | 2025-10-06 03:09:17.872230 | LOOP [upload-logs : Compress console log and json output] 2025-10-06 03:09:17.915107 | localhost | skipping: Conditional result was False 2025-10-06 03:09:17.921217 | localhost | skipping: Conditional result was False 2025-10-06 03:09:17.927635 | 2025-10-06 03:09:17.927740 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-06 03:09:18.014512 | localhost | skipping: Conditional result was False 2025-10-06 03:09:18.014768 | 2025-10-06 03:09:18.029200 | localhost | skipping: Conditional result was False 2025-10-06 03:09:18.033565 | 2025-10-06 03:09:18.033662 | LOOP [upload-logs : Upload console log and json output]