2025-11-06 03:02:31.139926 | Job console starting 2025-11-06 03:02:31.149518 | Updating git repos 2025-11-06 03:02:31.168532 | Cloning repos into workspace 2025-11-06 03:02:31.245254 | Restoring repo states 2025-11-06 03:02:31.250907 | Merging changes 2025-11-06 03:02:31.250919 | Checking out repos 2025-11-06 03:02:31.310503 | Preparing playbooks 2025-11-06 03:02:32.562090 | Running Ansible setup 2025-11-06 03:02:37.851952 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-06 03:02:38.679773 | 2025-11-06 03:02:38.679894 | PLAY [Base pre] 2025-11-06 03:02:38.704814 | 2025-11-06 03:02:38.704928 | TASK [Setup log path fact] 2025-11-06 03:02:38.745672 | debian-bookworm | ok 2025-11-06 03:02:38.760833 | 2025-11-06 03:02:38.760950 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-06 03:02:38.790066 | debian-bookworm | ok 2025-11-06 03:02:38.799787 | 2025-11-06 03:02:38.799892 | TASK [emit-job-header : Print job information] 2025-11-06 03:02:38.828914 | # Job Information 2025-11-06 03:02:38.829065 | Ansible Version: 2.16.14 2025-11-06 03:02:38.829100 | Job: python-black 2025-11-06 03:02:38.829133 | Pipeline: periodic-daily 2025-11-06 03:02:38.829156 | Executor: 521e9411259a 2025-11-06 03:02:38.829177 | Triggered by: https://github.com/osism/node-image 2025-11-06 03:02:38.829198 | Event ID: 4ecfb8c1f98646589188e289f09f7a7d 2025-11-06 03:02:38.834072 | 2025-11-06 03:02:38.834162 | LOOP [emit-job-header : Print node information] 2025-11-06 03:02:38.937094 | debian-bookworm | ok: 2025-11-06 03:02:38.937282 | debian-bookworm | # Node Information 2025-11-06 03:02:38.937312 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-06 03:02:38.937332 | debian-bookworm | Hostname: debian 2025-11-06 03:02:38.937350 | debian-bookworm | Username: zuul 2025-11-06 03:02:38.937368 | debian-bookworm | Distro: Debian 12.12 2025-11-06 03:02:38.937388 | debian-bookworm | Provider: regiocloud-a 2025-11-06 03:02:38.937406 | debian-bookworm | Region: 2025-11-06 03:02:38.937423 | debian-bookworm | Label: debian-bookworm 2025-11-06 03:02:38.937439 | debian-bookworm | Product Name: OpenStack Nova 2025-11-06 03:02:38.937454 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe1e:25d0 2025-11-06 03:02:38.950353 | 2025-11-06 03:02:38.950456 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-06 03:02:39.561224 | debian-bookworm -> localhost | changed 2025-11-06 03:02:39.566861 | 2025-11-06 03:02:39.566957 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-06 03:02:41.221360 | debian-bookworm -> localhost | changed 2025-11-06 03:02:41.254029 | 2025-11-06 03:02:41.254142 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-06 03:02:41.489086 | debian-bookworm -> localhost | ok 2025-11-06 03:02:41.493888 | 2025-11-06 03:02:41.493973 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-06 03:02:41.520344 | debian-bookworm | ok 2025-11-06 03:02:41.543830 | debian-bookworm | included: /var/lib/zuul/builds/3f072828e2da4ddc99cf03774ecb21af/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-06 03:02:41.556541 | 2025-11-06 03:02:41.556645 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-06 03:02:42.773343 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-06 03:02:42.773502 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/3f072828e2da4ddc99cf03774ecb21af/work/3f072828e2da4ddc99cf03774ecb21af_id_rsa 2025-11-06 03:02:42.773534 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/3f072828e2da4ddc99cf03774ecb21af/work/3f072828e2da4ddc99cf03774ecb21af_id_rsa.pub 2025-11-06 03:02:42.773556 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-06 03:02:42.773577 | debian-bookworm -> localhost | SHA256:FNcXI3+lhYqo8TetYldy43YKqM4wod+C3DlPblt/8x0 zuul-build-sshkey 2025-11-06 03:02:42.773619 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-06 03:02:42.773645 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-06 03:02:42.773663 | debian-bookworm -> localhost | | . ... ooo| 2025-11-06 03:02:42.773680 | debian-bookworm -> localhost | | o .oo+.| 2025-11-06 03:02:42.773697 | debian-bookworm -> localhost | | .. . oo .| 2025-11-06 03:02:42.773713 | debian-bookworm -> localhost | | ... . . . | 2025-11-06 03:02:42.773730 | debian-bookworm -> localhost | | . +S . | 2025-11-06 03:02:42.773747 | debian-bookworm -> localhost | | . .. ..+ = | 2025-11-06 03:02:42.773764 | debian-bookworm -> localhost | | ..oo.. o..B . E | 2025-11-06 03:02:42.773780 | debian-bookworm -> localhost | | o.=B.oo.o.= ...| 2025-11-06 03:02:42.773797 | debian-bookworm -> localhost | | .*Oo o.o.=. .| 2025-11-06 03:02:42.773813 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-06 03:02:42.773856 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.463029 2025-11-06 03:02:42.779143 | 2025-11-06 03:02:42.779218 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-06 03:02:42.796430 | debian-bookworm | ok 2025-11-06 03:02:42.805332 | debian-bookworm | included: /var/lib/zuul/builds/3f072828e2da4ddc99cf03774ecb21af/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-06 03:02:42.812441 | 2025-11-06 03:02:42.812507 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-06 03:02:42.824723 | debian-bookworm | skipping: Conditional result was False 2025-11-06 03:02:42.829079 | 2025-11-06 03:02:42.829146 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-06 03:02:43.402292 | debian-bookworm | changed 2025-11-06 03:02:43.410101 | 2025-11-06 03:02:43.410202 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-06 03:02:43.639155 | debian-bookworm | ok 2025-11-06 03:02:43.643477 | 2025-11-06 03:02:43.643550 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-06 03:02:44.226080 | debian-bookworm | changed 2025-11-06 03:02:44.231494 | 2025-11-06 03:02:44.231576 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-06 03:02:44.806170 | debian-bookworm | changed 2025-11-06 03:02:44.813594 | 2025-11-06 03:02:44.813677 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-06 03:02:44.836516 | debian-bookworm | skipping: Conditional result was False 2025-11-06 03:02:44.841900 | 2025-11-06 03:02:44.841981 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-06 03:02:45.249537 | debian-bookworm -> localhost | changed 2025-11-06 03:02:45.259725 | 2025-11-06 03:02:45.259818 | TASK [add-build-sshkey : Add back temp key] 2025-11-06 03:02:45.647639 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/3f072828e2da4ddc99cf03774ecb21af/work/3f072828e2da4ddc99cf03774ecb21af_id_rsa (zuul-build-sshkey) 2025-11-06 03:02:45.647880 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.012193 2025-11-06 03:02:45.655811 | 2025-11-06 03:02:45.655899 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-06 03:02:46.060818 | debian-bookworm | ok 2025-11-06 03:02:46.068147 | 2025-11-06 03:02:46.068236 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-06 03:02:46.092180 | debian-bookworm | skipping: Conditional result was False 2025-11-06 03:02:46.102696 | 2025-11-06 03:02:46.102782 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-06 03:02:46.507299 | debian-bookworm | ok 2025-11-06 03:02:46.523311 | 2025-11-06 03:02:46.523427 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-06 03:02:46.554144 | debian-bookworm | ok 2025-11-06 03:02:46.561204 | 2025-11-06 03:02:46.561303 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-06 03:02:46.818341 | debian-bookworm -> localhost | ok 2025-11-06 03:02:46.824416 | 2025-11-06 03:02:46.824508 | TASK [validate-host : Collect information about the host] 2025-11-06 03:02:47.837099 | debian-bookworm | ok 2025-11-06 03:02:47.847296 | 2025-11-06 03:02:47.847402 | TASK [validate-host : Sanitize hostname] 2025-11-06 03:02:47.943238 | debian-bookworm | ok 2025-11-06 03:02:47.971999 | 2025-11-06 03:02:47.972098 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-06 03:02:48.408281 | debian-bookworm -> localhost | changed 2025-11-06 03:02:48.413553 | 2025-11-06 03:02:48.413658 | TASK [validate-host : Collect information about zuul worker] 2025-11-06 03:02:48.815564 | debian-bookworm | ok 2025-11-06 03:02:48.822104 | 2025-11-06 03:02:48.822234 | TASK [validate-host : Write out all zuul information for each host] 2025-11-06 03:02:49.312295 | debian-bookworm -> localhost | changed 2025-11-06 03:02:49.321177 | 2025-11-06 03:02:49.321266 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-06 03:02:49.558131 | debian-bookworm | ok 2025-11-06 03:02:49.563547 | 2025-11-06 03:02:49.563663 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-06 03:02:51.427891 | debian-bookworm | changed: 2025-11-06 03:02:51.428055 | debian-bookworm | cd+++++++++ src/ 2025-11-06 03:02:51.428090 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-06 03:02:51.428115 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-06 03:02:51.428137 | debian-bookworm | cd+++++++++ src/github.com/osism/node-image/ 2025-11-06 03:02:51.428157 | debian-bookworm | Containerfile 2025-11-06 03:02:51.428288 | debian-bookworm | localhost | ok: Runtime: 0:00:00.004856 2025-11-06 03:03:17.809071 | 2025-11-06 03:03:17.809186 | TASK [upload-logs : Upload logs to log server] 2025-11-06 03:03:18.397453 | localhost | Output suppressed because no_log was given 2025-11-06 03:03:18.400871 | 2025-11-06 03:03:18.400996 | LOOP [upload-logs : Compress console log and json output] 2025-11-06 03:03:18.459216 | localhost | skipping: Conditional result was False 2025-11-06 03:03:18.466333 | localhost | skipping: Conditional result was False 2025-11-06 03:03:18.470199 | 2025-11-06 03:03:18.470324 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-06 03:03:18.547093 | localhost | skipping: Conditional result was False 2025-11-06 03:03:18.547359 | 2025-11-06 03:03:18.557116 | localhost | skipping: Conditional result was False 2025-11-06 03:03:18.563933 | 2025-11-06 03:03:18.564295 | LOOP [upload-logs : Upload console log and json output]