2025-08-24 17:55:52.466723 | Job console starting 2025-08-24 17:55:52.511927 | Updating git repos 2025-08-24 17:55:52.594357 | Cloning repos into workspace 2025-08-24 17:55:52.684907 | Restoring repo states 2025-08-24 17:55:52.704631 | Merging changes 2025-08-24 17:55:53.287651 | Checking out repos 2025-08-24 17:55:53.345584 | Preparing playbooks 2025-08-24 17:55:54.429620 | Running Ansible setup 2025-08-24 17:55:59.815862 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-08-24 17:56:00.782007 | 2025-08-24 17:56:00.782181 | PLAY [Base pre] 2025-08-24 17:56:00.798410 | 2025-08-24 17:56:00.798547 | TASK [Setup log path fact] 2025-08-24 17:56:00.832041 | debian-bookworm | ok 2025-08-24 17:56:00.847832 | 2025-08-24 17:56:00.847982 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-24 17:56:00.878750 | debian-bookworm | ok 2025-08-24 17:56:00.906669 | 2025-08-24 17:56:00.906822 | TASK [emit-job-header : Print job information] 2025-08-24 17:56:00.947502 | # Job Information 2025-08-24 17:56:00.947686 | Ansible Version: 2.16.14 2025-08-24 17:56:00.947721 | Job: python-black 2025-08-24 17:56:00.947770 | Pipeline: check 2025-08-24 17:56:00.947793 | Executor: 521e9411259a 2025-08-24 17:56:00.947814 | Triggered by: https://github.com/osism/container-image-osism-ansible/pull/683 2025-08-24 17:56:00.947837 | Event ID: 8e7ddba0-8113-11f0-8fd4-b66b84d5da51 2025-08-24 17:56:00.952818 | 2025-08-24 17:56:00.952940 | LOOP [emit-job-header : Print node information] 2025-08-24 17:56:01.112054 | debian-bookworm | ok: 2025-08-24 17:56:01.112344 | debian-bookworm | # Node Information 2025-08-24 17:56:01.112383 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-08-24 17:56:01.112408 | debian-bookworm | Hostname: debian 2025-08-24 17:56:01.112428 | debian-bookworm | Username: zuul 2025-08-24 17:56:01.112448 | debian-bookworm | Distro: Debian 12.11 2025-08-24 17:56:01.112471 | debian-bookworm | Provider: regiocloud-a 2025-08-24 17:56:01.112491 | debian-bookworm | Region: 2025-08-24 17:56:01.112512 | debian-bookworm | Label: debian-bookworm 2025-08-24 17:56:01.112532 | debian-bookworm | Product Name: OpenStack Nova 2025-08-24 17:56:01.112551 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feee:1276 2025-08-24 17:56:01.131125 | 2025-08-24 17:56:01.131266 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-08-24 17:56:01.895456 | debian-bookworm -> localhost | changed 2025-08-24 17:56:01.904197 | 2025-08-24 17:56:01.904341 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-08-24 17:56:03.403015 | debian-bookworm -> localhost | changed 2025-08-24 17:56:03.424920 | 2025-08-24 17:56:03.425065 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-08-24 17:56:03.844995 | debian-bookworm -> localhost | ok 2025-08-24 17:56:03.851391 | 2025-08-24 17:56:03.851519 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-08-24 17:56:03.880755 | debian-bookworm | ok 2025-08-24 17:56:03.900231 | debian-bookworm | included: /var/lib/zuul/builds/f9ee6098ef3d4c0b8b7beb35eaac07f0/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-08-24 17:56:03.906434 | 2025-08-24 17:56:03.906546 | TASK [add-build-sshkey : Create Temp SSH key] 2025-08-24 17:56:05.975716 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-08-24 17:56:05.975881 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/f9ee6098ef3d4c0b8b7beb35eaac07f0/work/f9ee6098ef3d4c0b8b7beb35eaac07f0_id_rsa 2025-08-24 17:56:05.975913 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/f9ee6098ef3d4c0b8b7beb35eaac07f0/work/f9ee6098ef3d4c0b8b7beb35eaac07f0_id_rsa.pub 2025-08-24 17:56:05.975935 | debian-bookworm -> localhost | The key fingerprint is: 2025-08-24 17:56:05.975955 | debian-bookworm -> localhost | SHA256:jntiveFM6nNRJsw+sm4qExDU3onfhWCbxoAeZO39Df8 zuul-build-sshkey 2025-08-24 17:56:05.975984 | debian-bookworm -> localhost | The key's randomart image is: 2025-08-24 17:56:05.976003 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-08-24 17:56:05.976020 | debian-bookworm -> localhost | |o++ | 2025-08-24 17:56:05.976038 | debian-bookworm -> localhost | |oo + o | 2025-08-24 17:56:05.976054 | debian-bookworm -> localhost | |..+ B =o. | 2025-08-24 17:56:05.976071 | debian-bookworm -> localhost | |.. + O o+.o | 2025-08-24 17:56:05.976088 | debian-bookworm -> localhost | | . o o.S+ | 2025-08-24 17:56:05.976109 | debian-bookworm -> localhost | | . ..=+o | 2025-08-24 17:56:05.976127 | debian-bookworm -> localhost | | . .++o. | 2025-08-24 17:56:05.976143 | debian-bookworm -> localhost | | o **+. E | 2025-08-24 17:56:05.976160 | debian-bookworm -> localhost | | o.*==+. | 2025-08-24 17:56:05.976176 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-08-24 17:56:05.976215 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.286874 2025-08-24 17:56:05.981182 | 2025-08-24 17:56:05.981252 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-08-24 17:56:05.997788 | debian-bookworm | ok 2025-08-24 17:56:06.005692 | debian-bookworm | included: /var/lib/zuul/builds/f9ee6098ef3d4c0b8b7beb35eaac07f0/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-08-24 17:56:06.013381 | 2025-08-24 17:56:06.013447 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-08-24 17:56:06.035955 | debian-bookworm | skipping: Conditional result was False 2025-08-24 17:56:06.041831 | 2025-08-24 17:56:06.041912 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-08-24 17:56:06.687869 | debian-bookworm | changed 2025-08-24 17:56:06.694020 | 2025-08-24 17:56:06.694131 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-08-24 17:56:06.963352 | debian-bookworm | ok 2025-08-24 17:56:06.972110 | 2025-08-24 17:56:06.972231 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-08-24 17:56:07.664461 | debian-bookworm | changed 2025-08-24 17:56:07.674312 | 2025-08-24 17:56:07.674430 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-08-24 17:56:08.297663 | debian-bookworm | changed 2025-08-24 17:56:08.311085 | 2025-08-24 17:56:08.311203 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-08-24 17:56:08.333906 | debian-bookworm | skipping: Conditional result was False 2025-08-24 17:56:08.339629 | 2025-08-24 17:56:08.339714 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-08-24 17:56:08.838529 | debian-bookworm -> localhost | changed 2025-08-24 17:56:08.849202 | 2025-08-24 17:56:08.849301 | TASK [add-build-sshkey : Add back temp key] 2025-08-24 17:56:09.178070 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/f9ee6098ef3d4c0b8b7beb35eaac07f0/work/f9ee6098ef3d4c0b8b7beb35eaac07f0_id_rsa (zuul-build-sshkey) 2025-08-24 17:56:09.178308 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.009922 2025-08-24 17:56:09.186258 | 2025-08-24 17:56:09.186359 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-08-24 17:56:09.587754 | debian-bookworm | ok 2025-08-24 17:56:09.593017 | 2025-08-24 17:56:09.593107 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-08-24 17:56:09.638394 | debian-bookworm | skipping: Conditional result was False 2025-08-24 17:56:09.648638 | 2025-08-24 17:56:09.648725 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-08-24 17:56:10.100397 | debian-bookworm | ok 2025-08-24 17:56:10.110687 | 2025-08-24 17:56:10.110789 | TASK [validate-host : Define zuul_info_dir fact] 2025-08-24 17:56:10.138483 | debian-bookworm | ok 2025-08-24 17:56:10.143174 | 2025-08-24 17:56:10.143253 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-08-24 17:56:10.428678 | debian-bookworm -> localhost | ok 2025-08-24 17:56:10.435061 | 2025-08-24 17:56:10.435153 | TASK [validate-host : Collect information about the host] 2025-08-24 17:56:11.511141 | debian-bookworm | ok 2025-08-24 17:56:11.522412 | 2025-08-24 17:56:11.522556 | TASK [validate-host : Sanitize hostname] 2025-08-24 17:56:11.643882 | debian-bookworm | ok 2025-08-24 17:56:11.682528 | 2025-08-24 17:56:11.682654 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-08-24 17:56:12.341037 | debian-bookworm -> localhost | changed 2025-08-24 17:56:12.347212 | 2025-08-24 17:56:12.347326 | TASK [validate-host : Collect information about zuul worker] 2025-08-24 17:56:12.765715 | debian-bookworm | ok 2025-08-24 17:56:12.771314 | 2025-08-24 17:56:12.772060 | TASK [validate-host : Write out all zuul information for each host] 2025-08-24 17:56:13.531577 | debian-bookworm -> localhost | changed 2025-08-24 17:56:13.541626 | 2025-08-24 17:56:13.541776 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-08-24 17:56:13.853611 | debian-bookworm | ok 2025-08-24 17:56:13.859563 | 2025-08-24 17:56:13.859666 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-08-24 17:56:14.768874 | debian-bookworm | changed: 2025-08-24 17:56:14.769143 | debian-bookworm | cd+++++++++ src/ 2025-08-24 17:56:14.769180 | debian-bookworm | cd+++++++++ src/github.com/ 2025-08-24 17:56:14.769203 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-08-24 17:56:14.769225 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-osism-ansible/ 2025-08-24 17:56:14.769246 | debian-bookworm | Containerfile 2025-08-24 17:56:14.769376 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006775 2025-08-24 17:56:42.317557 | 2025-08-24 17:56:42.317710 | TASK [upload-logs : Upload logs to log server] 2025-08-24 17:56:42.877335 | localhost | Output suppressed because no_log was given 2025-08-24 17:56:42.881500 | 2025-08-24 17:56:42.881679 | LOOP [upload-logs : Compress console log and json output] 2025-08-24 17:56:42.941636 | localhost | skipping: Conditional result was False 2025-08-24 17:56:42.947812 | localhost | skipping: Conditional result was False 2025-08-24 17:56:42.964054 | 2025-08-24 17:56:42.964290 | LOOP [upload-logs : Upload compressed console log and json output] 2025-08-24 17:56:43.012830 | localhost | skipping: Conditional result was False 2025-08-24 17:56:43.013421 | 2025-08-24 17:56:43.016864 | localhost | skipping: Conditional result was False 2025-08-24 17:56:43.029944 | 2025-08-24 17:56:43.030181 | LOOP [upload-logs : Upload console log and json output]