2025-10-26 03:02:19.310931 | Job console starting 2025-10-26 03:02:19.320067 | Updating git repos 2025-10-26 03:02:19.345240 | Cloning repos into workspace 2025-10-26 03:02:19.400619 | Restoring repo states 2025-10-26 03:02:19.427122 | Merging changes 2025-10-26 03:02:19.427136 | Checking out repos 2025-10-26 03:02:19.534200 | Preparing playbooks 2025-10-26 03:02:20.579001 | Running Ansible setup 2025-10-26 03:02:25.279197 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-26 03:02:27.433588 | 2025-10-26 03:02:27.433701 | PLAY [Base pre] 2025-10-26 03:02:27.492803 | 2025-10-26 03:02:27.492925 | TASK [Setup log path fact] 2025-10-26 03:02:27.526096 | debian-bookworm | ok 2025-10-26 03:02:27.547624 | 2025-10-26 03:02:27.547810 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-26 03:02:27.589698 | debian-bookworm | ok 2025-10-26 03:02:27.607929 | 2025-10-26 03:02:27.608089 | TASK [emit-job-header : Print job information] 2025-10-26 03:02:27.687411 | # Job Information 2025-10-26 03:02:27.687554 | Ansible Version: 2.16.14 2025-10-26 03:02:27.687584 | Job: python-black 2025-10-26 03:02:27.687613 | Pipeline: periodic-daily 2025-10-26 03:02:27.687633 | Executor: 521e9411259a 2025-10-26 03:02:27.687652 | Triggered by: https://github.com/osism/node-image 2025-10-26 03:02:27.687672 | Event ID: 01c484e37298416f94ae08668466efa6 2025-10-26 03:02:27.692314 | 2025-10-26 03:02:27.692394 | LOOP [emit-job-header : Print node information] 2025-10-26 03:02:27.873457 | debian-bookworm | ok: 2025-10-26 03:02:27.873706 | debian-bookworm | # Node Information 2025-10-26 03:02:27.873740 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-26 03:02:27.873762 | debian-bookworm | Hostname: debian 2025-10-26 03:02:27.873780 | debian-bookworm | Username: zuul 2025-10-26 03:02:27.873797 | debian-bookworm | Distro: Debian 12.12 2025-10-26 03:02:27.873817 | debian-bookworm | Provider: regiocloud-a 2025-10-26 03:02:27.873835 | debian-bookworm | Region: 2025-10-26 03:02:27.873852 | debian-bookworm | Label: debian-bookworm 2025-10-26 03:02:27.873868 | debian-bookworm | Product Name: OpenStack Nova 2025-10-26 03:02:27.873885 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe9d:e4dd 2025-10-26 03:02:27.887934 | 2025-10-26 03:02:27.888041 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-26 03:02:29.260831 | debian-bookworm -> localhost | changed 2025-10-26 03:02:29.266441 | 2025-10-26 03:02:29.266529 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-26 03:02:31.090432 | debian-bookworm -> localhost | changed 2025-10-26 03:02:31.099085 | 2025-10-26 03:02:31.099175 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-26 03:02:31.546309 | debian-bookworm -> localhost | ok 2025-10-26 03:02:31.551239 | 2025-10-26 03:02:31.551356 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-26 03:02:31.588705 | debian-bookworm | ok 2025-10-26 03:02:31.618037 | debian-bookworm | included: /var/lib/zuul/builds/6f70bf1e8c7c4b02a0bb119fcf6d419c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-26 03:02:31.640422 | 2025-10-26 03:02:31.640515 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-26 03:02:34.579524 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-26 03:02:34.579717 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/6f70bf1e8c7c4b02a0bb119fcf6d419c/work/6f70bf1e8c7c4b02a0bb119fcf6d419c_id_rsa 2025-10-26 03:02:34.579751 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/6f70bf1e8c7c4b02a0bb119fcf6d419c/work/6f70bf1e8c7c4b02a0bb119fcf6d419c_id_rsa.pub 2025-10-26 03:02:34.579773 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-26 03:02:34.579794 | debian-bookworm -> localhost | SHA256:t8ASG+U1zXWQGDjGDl/U2OjpuA+v0w6bNV17/zWDC7Q zuul-build-sshkey 2025-10-26 03:02:34.579813 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-26 03:02:34.581385 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-26 03:02:34.581418 | debian-bookworm -> localhost | | ..o=oOoo.| 2025-10-26 03:02:34.581440 | debian-bookworm -> localhost | | o..=.B +. | 2025-10-26 03:02:34.581459 | debian-bookworm -> localhost | | o .= + . | 2025-10-26 03:02:34.581477 | debian-bookworm -> localhost | | = o o | 2025-10-26 03:02:34.581494 | debian-bookworm -> localhost | | o S .+ .| 2025-10-26 03:02:34.581517 | debian-bookworm -> localhost | | . oo.o....| 2025-10-26 03:02:34.581534 | debian-bookworm -> localhost | | +Eo..+o| 2025-10-26 03:02:34.581551 | debian-bookworm -> localhost | | oBo.. *| 2025-10-26 03:02:34.581568 | debian-bookworm -> localhost | | +=+. +| 2025-10-26 03:02:34.581585 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-26 03:02:34.581631 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.549916 2025-10-26 03:02:34.586672 | 2025-10-26 03:02:34.586747 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-26 03:02:34.606603 | debian-bookworm | ok 2025-10-26 03:02:34.640449 | debian-bookworm | included: /var/lib/zuul/builds/6f70bf1e8c7c4b02a0bb119fcf6d419c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-26 03:02:34.680033 | 2025-10-26 03:02:34.680139 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-26 03:02:34.723449 | debian-bookworm | skipping: Conditional result was False 2025-10-26 03:02:34.728265 | 2025-10-26 03:02:34.728359 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-26 03:02:35.529178 | debian-bookworm | changed 2025-10-26 03:02:35.533529 | 2025-10-26 03:02:35.533602 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-26 03:02:35.803135 | debian-bookworm | ok 2025-10-26 03:02:35.807670 | 2025-10-26 03:02:35.807752 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-26 03:02:36.509127 | debian-bookworm | changed 2025-10-26 03:02:36.514515 | 2025-10-26 03:02:36.514594 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-26 03:02:37.242515 | debian-bookworm | changed 2025-10-26 03:02:37.246879 | 2025-10-26 03:02:37.246955 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-26 03:02:37.280616 | debian-bookworm | skipping: Conditional result was False 2025-10-26 03:02:37.285398 | 2025-10-26 03:02:37.285476 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-26 03:02:38.121823 | debian-bookworm -> localhost | changed 2025-10-26 03:02:38.130290 | 2025-10-26 03:02:38.130368 | TASK [add-build-sshkey : Add back temp key] 2025-10-26 03:02:38.822382 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/6f70bf1e8c7c4b02a0bb119fcf6d419c/work/6f70bf1e8c7c4b02a0bb119fcf6d419c_id_rsa (zuul-build-sshkey) 2025-10-26 03:02:38.822562 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.022633 2025-10-26 03:02:38.828925 | 2025-10-26 03:02:38.829005 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-26 03:02:39.324932 | debian-bookworm | ok 2025-10-26 03:02:39.328954 | 2025-10-26 03:02:39.329031 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-26 03:02:39.364880 | debian-bookworm | skipping: Conditional result was False 2025-10-26 03:02:39.373474 | 2025-10-26 03:02:39.373553 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-26 03:02:39.907590 | debian-bookworm | ok 2025-10-26 03:02:39.929131 | 2025-10-26 03:02:39.929221 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-26 03:02:39.964868 | debian-bookworm | ok 2025-10-26 03:02:39.968766 | 2025-10-26 03:02:39.968837 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-26 03:02:40.421369 | debian-bookworm -> localhost | ok 2025-10-26 03:02:40.426434 | 2025-10-26 03:02:40.426507 | TASK [validate-host : Collect information about the host] 2025-10-26 03:02:41.390575 | debian-bookworm | ok 2025-10-26 03:02:41.404194 | 2025-10-26 03:02:41.404329 | TASK [validate-host : Sanitize hostname] 2025-10-26 03:02:41.472215 | debian-bookworm | ok 2025-10-26 03:02:41.499700 | 2025-10-26 03:02:41.499783 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-26 03:02:42.070145 | debian-bookworm -> localhost | changed 2025-10-26 03:02:42.075118 | 2025-10-26 03:02:42.075196 | TASK [validate-host : Collect information about zuul worker] 2025-10-26 03:02:42.491960 | debian-bookworm | ok 2025-10-26 03:02:42.500026 | 2025-10-26 03:02:42.500126 | TASK [validate-host : Write out all zuul information for each host] 2025-10-26 03:02:43.107879 | debian-bookworm -> localhost | changed 2025-10-26 03:02:43.126285 | 2025-10-26 03:02:43.126379 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-26 03:02:43.366203 | debian-bookworm | ok 2025-10-26 03:02:43.371452 | 2025-10-26 03:02:43.371539 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-26 03:02:45.029231 | debian-bookworm | changed: 2025-10-26 03:02:45.029414 | debian-bookworm | cd+++++++++ src/ 2025-10-26 03:02:45.029443 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-26 03:02:45.029463 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-26 03:02:45.029481 | debian-bookworm | cd+++++++++ src/github.com/osism/node-image/ 2025-10-26 03:02:45.029498 | debian-bookworm | Containerfile 2025-10-26 03:02:45.029605 | debian-bookworm | localhost | ok: Runtime: 0:00:00.031534 2025-10-26 03:03:10.969365 | 2025-10-26 03:03:10.969483 | TASK [upload-logs : Upload logs to log server] 2025-10-26 03:03:11.518692 | localhost | Output suppressed because no_log was given 2025-10-26 03:03:11.522428 | 2025-10-26 03:03:11.522600 | LOOP [upload-logs : Compress console log and json output] 2025-10-26 03:03:11.572418 | localhost | skipping: Conditional result was False 2025-10-26 03:03:11.581012 | localhost | skipping: Conditional result was False 2025-10-26 03:03:11.590695 | 2025-10-26 03:03:11.590884 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-26 03:03:11.645668 | localhost | skipping: Conditional result was False 2025-10-26 03:03:11.646080 | 2025-10-26 03:03:11.650280 | localhost | skipping: Conditional result was False 2025-10-26 03:03:11.658554 | 2025-10-26 03:03:11.658666 | LOOP [upload-logs : Upload console log and json output]