2025-10-05 03:09:53.669762 | Job console starting 2025-10-05 03:09:53.683327 | Updating git repos 2025-10-05 03:09:53.716822 | Cloning repos into workspace 2025-10-05 03:09:53.856130 | Restoring repo states 2025-10-05 03:09:53.879404 | Merging changes 2025-10-05 03:09:53.879418 | Checking out repos 2025-10-05 03:09:54.059649 | Preparing playbooks 2025-10-05 03:09:55.727798 | Running Ansible setup 2025-10-05 03:10:03.158963 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-05 03:10:04.947381 | 2025-10-05 03:10:04.947502 | PLAY [Base pre] 2025-10-05 03:10:04.977802 | 2025-10-05 03:10:04.977937 | TASK [Setup log path fact] 2025-10-05 03:10:05.005534 | debian-bookworm | ok 2025-10-05 03:10:05.037194 | 2025-10-05 03:10:05.037322 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-05 03:10:05.085628 | debian-bookworm | ok 2025-10-05 03:10:05.103396 | 2025-10-05 03:10:05.103495 | TASK [emit-job-header : Print job information] 2025-10-05 03:10:05.188668 | # Job Information 2025-10-05 03:10:05.188819 | Ansible Version: 2.16.14 2025-10-05 03:10:05.188871 | Job: python-black 2025-10-05 03:10:05.188899 | Pipeline: periodic-daily 2025-10-05 03:10:05.188919 | Executor: 521e9411259a 2025-10-05 03:10:05.188936 | Triggered by: https://github.com/osism/python-osism 2025-10-05 03:10:05.188954 | Event ID: 43306ca8ffe04b17a09168bba42c981d 2025-10-05 03:10:05.192834 | 2025-10-05 03:10:05.192918 | LOOP [emit-job-header : Print node information] 2025-10-05 03:10:05.472613 | debian-bookworm | ok: 2025-10-05 03:10:05.472796 | debian-bookworm | # Node Information 2025-10-05 03:10:05.472826 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-05 03:10:05.472856 | debian-bookworm | Hostname: debian 2025-10-05 03:10:05.472875 | debian-bookworm | Username: zuul 2025-10-05 03:10:05.472892 | debian-bookworm | Distro: Debian 12.12 2025-10-05 03:10:05.472912 | debian-bookworm | Provider: regiocloud-a 2025-10-05 03:10:05.472930 | debian-bookworm | Region: 2025-10-05 03:10:05.472948 | debian-bookworm | Label: debian-bookworm 2025-10-05 03:10:05.472965 | debian-bookworm | Product Name: OpenStack Nova 2025-10-05 03:10:05.472981 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe00:1ca0 2025-10-05 03:10:05.486301 | 2025-10-05 03:10:05.486404 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-05 03:10:06.906723 | debian-bookworm -> localhost | changed 2025-10-05 03:10:06.913103 | 2025-10-05 03:10:06.913205 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-05 03:10:09.660262 | debian-bookworm -> localhost | changed 2025-10-05 03:10:09.673321 | 2025-10-05 03:10:09.673411 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-05 03:10:10.723800 | debian-bookworm -> localhost | ok 2025-10-05 03:10:10.753196 | 2025-10-05 03:10:10.754518 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-05 03:10:10.844435 | debian-bookworm | ok 2025-10-05 03:10:10.941566 | debian-bookworm | included: /var/lib/zuul/builds/60d913f0452a40a4936a694e85dc4efb/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-05 03:10:10.946500 | 2025-10-05 03:10:10.946575 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-05 03:10:14.832095 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-05 03:10:14.832269 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/60d913f0452a40a4936a694e85dc4efb/work/60d913f0452a40a4936a694e85dc4efb_id_rsa 2025-10-05 03:10:14.832303 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/60d913f0452a40a4936a694e85dc4efb/work/60d913f0452a40a4936a694e85dc4efb_id_rsa.pub 2025-10-05 03:10:14.832325 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-05 03:10:14.832347 | debian-bookworm -> localhost | SHA256:AKol/Solmdh2yeBFGCVux7nr9z9xhf77ZYojCAg3gEg zuul-build-sshkey 2025-10-05 03:10:14.832366 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-05 03:10:14.832391 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-05 03:10:14.832408 | debian-bookworm -> localhost | |oEo++ | 2025-10-05 03:10:14.832426 | debian-bookworm -> localhost | |ooo= o | 2025-10-05 03:10:14.832443 | debian-bookworm -> localhost | |. B.= . . | 2025-10-05 03:10:14.832459 | debian-bookworm -> localhost | |.X.*oo . . . | 2025-10-05 03:10:14.832476 | debian-bookworm -> localhost | |* =o*o S . . | 2025-10-05 03:10:14.832496 | debian-bookworm -> localhost | | + o... . o | 2025-10-05 03:10:14.832513 | debian-bookworm -> localhost | |. . . . . o . o| 2025-10-05 03:10:14.832529 | debian-bookworm -> localhost | | . . . . o ...o.| 2025-10-05 03:10:14.832546 | debian-bookworm -> localhost | | .. ....o..oo.| 2025-10-05 03:10:14.832563 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-05 03:10:14.832607 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.685788 2025-10-05 03:10:14.837713 | 2025-10-05 03:10:14.837783 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-05 03:10:14.874730 | debian-bookworm | ok 2025-10-05 03:10:14.895724 | debian-bookworm | included: /var/lib/zuul/builds/60d913f0452a40a4936a694e85dc4efb/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-05 03:10:14.916499 | 2025-10-05 03:10:14.918891 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-05 03:10:14.952866 | debian-bookworm | skipping: Conditional result was False 2025-10-05 03:10:14.958660 | 2025-10-05 03:10:14.958754 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-05 03:10:15.592709 | debian-bookworm | changed 2025-10-05 03:10:15.602505 | 2025-10-05 03:10:15.602593 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-05 03:10:15.895201 | debian-bookworm | ok 2025-10-05 03:10:15.913772 | 2025-10-05 03:10:15.913933 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-05 03:10:16.514878 | debian-bookworm | changed 2025-10-05 03:10:16.522122 | 2025-10-05 03:10:16.522220 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-05 03:10:17.155583 | debian-bookworm | changed 2025-10-05 03:10:17.166801 | 2025-10-05 03:10:17.167096 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-05 03:10:17.192465 | debian-bookworm | skipping: Conditional result was False 2025-10-05 03:10:17.203651 | 2025-10-05 03:10:17.203782 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-05 03:10:17.685379 | debian-bookworm -> localhost | changed 2025-10-05 03:10:17.699527 | 2025-10-05 03:10:17.699627 | TASK [add-build-sshkey : Add back temp key] 2025-10-05 03:10:18.327857 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/60d913f0452a40a4936a694e85dc4efb/work/60d913f0452a40a4936a694e85dc4efb_id_rsa (zuul-build-sshkey) 2025-10-05 03:10:18.328071 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.025222 2025-10-05 03:10:18.335777 | 2025-10-05 03:10:18.335881 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-05 03:10:18.873936 | debian-bookworm | ok 2025-10-05 03:10:18.883202 | 2025-10-05 03:10:18.883303 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-05 03:10:18.906737 | debian-bookworm | skipping: Conditional result was False 2025-10-05 03:10:18.923507 | 2025-10-05 03:10:18.923601 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-05 03:10:19.345130 | debian-bookworm | ok 2025-10-05 03:10:19.358578 | 2025-10-05 03:10:19.358672 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-05 03:10:19.386415 | debian-bookworm | ok 2025-10-05 03:10:19.391155 | 2025-10-05 03:10:19.391240 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-05 03:10:19.656389 | debian-bookworm -> localhost | ok 2025-10-05 03:10:19.662916 | 2025-10-05 03:10:19.663013 | TASK [validate-host : Collect information about the host] 2025-10-05 03:10:20.844850 | debian-bookworm | ok 2025-10-05 03:10:20.854657 | 2025-10-05 03:10:20.854748 | TASK [validate-host : Sanitize hostname] 2025-10-05 03:10:20.945260 | debian-bookworm | ok 2025-10-05 03:10:20.975931 | 2025-10-05 03:10:20.976031 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-05 03:10:21.680772 | debian-bookworm -> localhost | changed 2025-10-05 03:10:21.688265 | 2025-10-05 03:10:21.688414 | TASK [validate-host : Collect information about zuul worker] 2025-10-05 03:10:22.235723 | debian-bookworm | ok 2025-10-05 03:10:22.243274 | 2025-10-05 03:10:22.243419 | TASK [validate-host : Write out all zuul information for each host] 2025-10-05 03:10:23.594046 | debian-bookworm -> localhost | changed 2025-10-05 03:10:23.604032 | 2025-10-05 03:10:23.604137 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-05 03:10:23.908122 | debian-bookworm | ok 2025-10-05 03:10:23.913410 | 2025-10-05 03:10:23.913494 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-05 03:10:25.182653 | debian-bookworm | changed: 2025-10-05 03:10:25.182852 | debian-bookworm | cd+++++++++ src/ 2025-10-05 03:10:25.182890 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-05 03:10:25.182916 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-05 03:10:25.182937 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-10-05 03:10:25.182958 | debian-bookworm | Containerfile 2025-10-05 03:10:25.183067 | debian-bookworm | Containerfile 2025-10-05 03:10:25.233874 | debian-bookworm | localhost | ok: Runtime: 0:00:00.005502 2025-10-05 03:10:53.308153 | 2025-10-05 03:10:53.308239 | TASK [upload-logs : Upload logs to log server] 2025-10-05 03:10:54.321006 | localhost | Output suppressed because no_log was given 2025-10-05 03:10:54.322591 | 2025-10-05 03:10:54.322671 | LOOP [upload-logs : Compress console log and json output] 2025-10-05 03:10:54.386983 | localhost | skipping: Conditional result was False 2025-10-05 03:10:54.393127 | localhost | skipping: Conditional result was False 2025-10-05 03:10:54.401816 | 2025-10-05 03:10:54.401904 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-05 03:10:54.469348 | localhost | skipping: Conditional result was False 2025-10-05 03:10:54.469567 | 2025-10-05 03:10:54.480183 | localhost | skipping: Conditional result was False 2025-10-05 03:10:54.488552 | 2025-10-05 03:10:54.488641 | LOOP [upload-logs : Upload console log and json output]