2025-12-24 03:12:18.249231 | Job console starting 2025-12-24 03:12:18.263548 | Updating git repos 2025-12-24 03:12:18.318470 | Cloning repos into workspace 2025-12-24 03:12:18.418654 | Restoring repo states 2025-12-24 03:12:18.467720 | Merging changes 2025-12-24 03:12:18.467756 | Checking out repos 2025-12-24 03:12:18.634170 | Preparing playbooks 2025-12-24 03:12:20.276409 | Running Ansible setup 2025-12-24 03:12:27.964020 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-24 03:12:29.575230 | 2025-12-24 03:12:29.575466 | PLAY [Base pre] 2025-12-24 03:12:29.594774 | 2025-12-24 03:12:29.594975 | TASK [Setup log path fact] 2025-12-24 03:12:29.645085 | debian-bookworm | ok 2025-12-24 03:12:29.663105 | 2025-12-24 03:12:29.663377 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-24 03:12:29.738073 | debian-bookworm | ok 2025-12-24 03:12:29.780772 | 2025-12-24 03:12:29.780953 | TASK [emit-job-header : Print job information] 2025-12-24 03:12:29.824864 | # Job Information 2025-12-24 03:12:29.825144 | Ansible Version: 2.16.14 2025-12-24 03:12:29.825186 | Job: python-black 2025-12-24 03:12:29.825221 | Pipeline: periodic-daily 2025-12-24 03:12:29.825245 | Executor: 521e9411259a 2025-12-24 03:12:29.825317 | Triggered by: https://github.com/osism/testbed 2025-12-24 03:12:29.825340 | Event ID: 4333c56161cf4146ad429521d2f75a23 2025-12-24 03:12:29.831081 | 2025-12-24 03:12:29.831237 | LOOP [emit-job-header : Print node information] 2025-12-24 03:12:29.959542 | debian-bookworm | ok: 2025-12-24 03:12:29.959754 | debian-bookworm | # Node Information 2025-12-24 03:12:29.959789 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-24 03:12:29.959815 | debian-bookworm | Hostname: debian 2025-12-24 03:12:29.959837 | debian-bookworm | Username: zuul 2025-12-24 03:12:29.959858 | debian-bookworm | Distro: Debian 12.12 2025-12-24 03:12:29.959882 | debian-bookworm | Provider: regiocloud-a 2025-12-24 03:12:29.959903 | debian-bookworm | Region: 2025-12-24 03:12:29.959924 | debian-bookworm | Label: debian-bookworm 2025-12-24 03:12:29.959943 | debian-bookworm | Product Name: OpenStack Nova 2025-12-24 03:12:29.959963 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feba:a21d 2025-12-24 03:12:29.993564 | 2025-12-24 03:12:29.993737 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-24 03:12:31.146575 | debian-bookworm -> localhost | changed 2025-12-24 03:12:31.155560 | 2025-12-24 03:12:31.155707 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-24 03:12:33.976865 | debian-bookworm -> localhost | changed 2025-12-24 03:12:34.001900 | 2025-12-24 03:12:34.002060 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-24 03:12:34.810512 | debian-bookworm -> localhost | ok 2025-12-24 03:12:34.818095 | 2025-12-24 03:12:34.818236 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-24 03:12:34.869805 | debian-bookworm | ok 2025-12-24 03:12:34.937081 | debian-bookworm | included: /var/lib/zuul/builds/4317f5a1c3754bfbaeb7dd276f2075c0/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-24 03:12:34.964804 | 2025-12-24 03:12:34.971236 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-24 03:12:38.082660 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-24 03:12:38.083007 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/4317f5a1c3754bfbaeb7dd276f2075c0/work/4317f5a1c3754bfbaeb7dd276f2075c0_id_rsa 2025-12-24 03:12:38.083052 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/4317f5a1c3754bfbaeb7dd276f2075c0/work/4317f5a1c3754bfbaeb7dd276f2075c0_id_rsa.pub 2025-12-24 03:12:38.083079 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-24 03:12:38.083105 | debian-bookworm -> localhost | SHA256:DBF6143Cos/Gt+NTQPuqYaZiyl42gzhEg+1wJYo8i8U zuul-build-sshkey 2025-12-24 03:12:38.083128 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-24 03:12:38.083162 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-24 03:12:38.083184 | debian-bookworm -> localhost | | . . o. | 2025-12-24 03:12:38.083206 | debian-bookworm -> localhost | |++ o . o.. o | 2025-12-24 03:12:38.083226 | debian-bookworm -> localhost | |==E . +.+.o . | 2025-12-24 03:12:38.083246 | debian-bookworm -> localhost | |o=+ o =o. | 2025-12-24 03:12:38.083309 | debian-bookworm -> localhost | |.o. . So | 2025-12-24 03:12:38.083333 | debian-bookworm -> localhost | |o . + o | 2025-12-24 03:12:38.083354 | debian-bookworm -> localhost | |o. = O .o | 2025-12-24 03:12:38.083374 | debian-bookworm -> localhost | |..= o= o+. | 2025-12-24 03:12:38.083395 | debian-bookworm -> localhost | |o= .. .ooo | 2025-12-24 03:12:38.083415 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-24 03:12:38.083472 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.980816 2025-12-24 03:12:38.118624 | 2025-12-24 03:12:38.118784 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-24 03:12:38.203434 | debian-bookworm | ok 2025-12-24 03:12:38.224788 | debian-bookworm | included: /var/lib/zuul/builds/4317f5a1c3754bfbaeb7dd276f2075c0/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-24 03:12:38.241021 | 2025-12-24 03:12:38.241159 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-24 03:12:38.296301 | debian-bookworm | skipping: Conditional result was False 2025-12-24 03:12:38.308196 | 2025-12-24 03:12:38.308589 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-24 03:12:39.289755 | debian-bookworm | changed 2025-12-24 03:12:39.375749 | 2025-12-24 03:12:39.375939 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-24 03:12:39.751736 | debian-bookworm | ok 2025-12-24 03:12:39.764437 | 2025-12-24 03:12:39.764587 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-24 03:12:40.846193 | debian-bookworm | changed 2025-12-24 03:12:40.864348 | 2025-12-24 03:12:40.864515 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-24 03:12:41.763774 | debian-bookworm | changed 2025-12-24 03:12:41.782718 | 2025-12-24 03:12:41.782913 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-24 03:12:41.899549 | debian-bookworm | skipping: Conditional result was False 2025-12-24 03:12:41.909582 | 2025-12-24 03:12:41.909983 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-24 03:12:43.635266 | debian-bookworm -> localhost | changed 2025-12-24 03:12:43.651961 | 2025-12-24 03:12:43.652111 | TASK [add-build-sshkey : Add back temp key] 2025-12-24 03:12:44.342658 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/4317f5a1c3754bfbaeb7dd276f2075c0/work/4317f5a1c3754bfbaeb7dd276f2075c0_id_rsa (zuul-build-sshkey) 2025-12-24 03:12:44.342955 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.015724 2025-12-24 03:12:44.352758 | 2025-12-24 03:12:44.352893 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-24 03:12:44.808048 | debian-bookworm | ok 2025-12-24 03:12:44.815603 | 2025-12-24 03:12:44.815757 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-24 03:12:44.851314 | debian-bookworm | skipping: Conditional result was False 2025-12-24 03:12:44.872977 | 2025-12-24 03:12:44.873141 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-24 03:12:45.390195 | debian-bookworm | ok 2025-12-24 03:12:45.449902 | 2025-12-24 03:12:45.450054 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-24 03:12:45.479954 | debian-bookworm | ok 2025-12-24 03:12:45.487055 | 2025-12-24 03:12:45.487193 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-24 03:12:46.168872 | debian-bookworm -> localhost | ok 2025-12-24 03:12:46.176624 | 2025-12-24 03:12:46.176758 | TASK [validate-host : Collect information about the host] 2025-12-24 03:12:47.928969 | debian-bookworm | ok 2025-12-24 03:12:47.956663 | 2025-12-24 03:12:47.956884 | TASK [validate-host : Sanitize hostname] 2025-12-24 03:12:48.081301 | debian-bookworm | ok 2025-12-24 03:12:48.200966 | 2025-12-24 03:12:48.201129 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-24 03:12:48.921039 | debian-bookworm -> localhost | changed 2025-12-24 03:12:48.928917 | 2025-12-24 03:12:48.929058 | TASK [validate-host : Collect information about zuul worker] 2025-12-24 03:12:49.395593 | debian-bookworm | ok 2025-12-24 03:12:49.401175 | 2025-12-24 03:12:49.401337 | TASK [validate-host : Write out all zuul information for each host] 2025-12-24 03:12:50.990329 | debian-bookworm -> localhost | changed 2025-12-24 03:12:51.001853 | 2025-12-24 03:12:51.001994 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-24 03:12:51.309409 | debian-bookworm | ok 2025-12-24 03:12:51.316815 | 2025-12-24 03:12:51.316942 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-24 03:12:53.310314 | debian-bookworm | changed: 2025-12-24 03:12:53.310546 | debian-bookworm | cd+++++++++ src/ 2025-12-24 03:12:53.310581 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-24 03:12:53.310605 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-24 03:12:53.310627 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2025-12-24 03:12:53.310648 | debian-bookworm | localhost | ok: Runtime: 0:00:00.054039 2025-12-24 03:13:34.548389 | 2025-12-24 03:13:34.549013 | TASK [upload-logs : Upload logs to log server] 2025-12-24 03:13:35.761630 | localhost | Output suppressed because no_log was given 2025-12-24 03:13:35.763862 | 2025-12-24 03:13:35.782425 | LOOP [upload-logs : Compress console log and json output] 2025-12-24 03:13:35.884417 | localhost | skipping: Conditional result was False 2025-12-24 03:13:35.908192 | localhost | skipping: Conditional result was False 2025-12-24 03:13:35.915875 | 2025-12-24 03:13:35.916026 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-24 03:13:36.093783 | localhost | skipping: Conditional result was False 2025-12-24 03:13:36.094076 | 2025-12-24 03:13:36.110155 | localhost | skipping: Conditional result was False 2025-12-24 03:13:36.114532 | 2025-12-24 03:13:36.114689 | LOOP [upload-logs : Upload console log and json output]