2025-06-04 03:18:54.333195 | Job console starting 2025-06-04 03:18:54.360812 | Updating git repos 2025-06-04 03:18:54.396119 | Cloning repos into workspace 2025-06-04 03:18:54.444730 | Restoring repo states 2025-06-04 03:18:54.451617 | Merging changes 2025-06-04 03:18:54.451638 | Checking out repos 2025-06-04 03:18:54.494469 | Preparing playbooks 2025-06-04 03:18:55.293055 | Running Ansible setup 2025-06-04 03:19:00.516456 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-06-04 03:19:01.605840 | 2025-06-04 03:19:01.606038 | PLAY [Base pre] 2025-06-04 03:19:01.623327 | 2025-06-04 03:19:01.623462 | TASK [Setup log path fact] 2025-06-04 03:19:01.654135 | debian-bookworm | ok 2025-06-04 03:19:01.671731 | 2025-06-04 03:19:01.671895 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-06-04 03:19:01.716905 | debian-bookworm | ok 2025-06-04 03:19:01.728088 | 2025-06-04 03:19:01.728228 | TASK [emit-job-header : Print job information] 2025-06-04 03:19:01.788678 | # Job Information 2025-06-04 03:19:01.788878 | Ansible Version: 2.16.14 2025-06-04 03:19:01.788914 | Job: python-black 2025-06-04 03:19:01.788946 | Pipeline: periodic-daily 2025-06-04 03:19:01.788969 | Executor: 521e9411259a 2025-06-04 03:19:01.788990 | Triggered by: https://github.com/osism/cfg-cookiecutter 2025-06-04 03:19:01.789012 | Event ID: 5edb8363042e44949c3a338356fb9536 2025-06-04 03:19:01.794239 | 2025-06-04 03:19:01.794364 | LOOP [emit-job-header : Print node information] 2025-06-04 03:19:02.015480 | debian-bookworm | ok: 2025-06-04 03:19:02.015733 | debian-bookworm | # Node Information 2025-06-04 03:19:02.015770 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-06-04 03:19:02.015796 | debian-bookworm | Hostname: debian 2025-06-04 03:19:02.015818 | debian-bookworm | Username: zuul 2025-06-04 03:19:02.015838 | debian-bookworm | Distro: Debian 12.11 2025-06-04 03:19:02.015861 | debian-bookworm | Provider: regiocloud-a 2025-06-04 03:19:02.015882 | debian-bookworm | Region: 2025-06-04 03:19:02.015903 | debian-bookworm | Label: debian-bookworm 2025-06-04 03:19:02.015923 | debian-bookworm | Product Name: OpenStack Nova 2025-06-04 03:19:02.015941 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe00:c9ae 2025-06-04 03:19:02.028803 | 2025-06-04 03:19:02.028939 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-06-04 03:19:02.735569 | debian-bookworm -> localhost | changed 2025-06-04 03:19:02.745552 | 2025-06-04 03:19:02.745687 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-06-04 03:19:03.873020 | debian-bookworm -> localhost | changed 2025-06-04 03:19:03.885728 | 2025-06-04 03:19:03.885867 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-06-04 03:19:04.172962 | debian-bookworm -> localhost | ok 2025-06-04 03:19:04.179456 | 2025-06-04 03:19:04.179581 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-06-04 03:19:04.225532 | debian-bookworm | ok 2025-06-04 03:19:04.251766 | debian-bookworm | included: /var/lib/zuul/builds/28244588f5fb42b5acd53d8ca2ad0ab5/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-06-04 03:19:04.262518 | 2025-06-04 03:19:04.262657 | TASK [add-build-sshkey : Create Temp SSH key] 2025-06-04 03:19:05.737036 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-06-04 03:19:05.737305 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/28244588f5fb42b5acd53d8ca2ad0ab5/work/28244588f5fb42b5acd53d8ca2ad0ab5_id_rsa 2025-06-04 03:19:05.737349 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/28244588f5fb42b5acd53d8ca2ad0ab5/work/28244588f5fb42b5acd53d8ca2ad0ab5_id_rsa.pub 2025-06-04 03:19:05.737376 | debian-bookworm -> localhost | The key fingerprint is: 2025-06-04 03:19:05.737402 | debian-bookworm -> localhost | SHA256:Y/UfEr52yUpKcrK8S9Mmq6tcEBBbk4w6eiAQIaWTqxE zuul-build-sshkey 2025-06-04 03:19:05.737424 | debian-bookworm -> localhost | The key's randomart image is: 2025-06-04 03:19:05.737458 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-06-04 03:19:05.737479 | debian-bookworm -> localhost | |++++o. | 2025-06-04 03:19:05.737500 | debian-bookworm -> localhost | |oo.+o. | 2025-06-04 03:19:05.737520 | debian-bookworm -> localhost | |E.. . . . | 2025-06-04 03:19:05.737540 | debian-bookworm -> localhost | |=+ . . o . | 2025-06-04 03:19:05.737559 | debian-bookworm -> localhost | |=o . S + . | 2025-06-04 03:19:05.737580 | debian-bookworm -> localhost | |o.. . . o = o | 2025-06-04 03:19:05.737601 | debian-bookworm -> localhost | |.. . * = + = | 2025-06-04 03:19:05.737621 | debian-bookworm -> localhost | | . . o @ + o | 2025-06-04 03:19:05.737641 | debian-bookworm -> localhost | | o.oo*o. . | 2025-06-04 03:19:05.737680 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-06-04 03:19:05.737735 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.957052 2025-06-04 03:19:05.745050 | 2025-06-04 03:19:05.745185 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-06-04 03:19:05.775608 | debian-bookworm | ok 2025-06-04 03:19:05.786283 | debian-bookworm | included: /var/lib/zuul/builds/28244588f5fb42b5acd53d8ca2ad0ab5/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-06-04 03:19:05.796259 | 2025-06-04 03:19:05.796381 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-06-04 03:19:05.824420 | debian-bookworm | skipping: Conditional result was False 2025-06-04 03:19:05.831030 | 2025-06-04 03:19:05.831162 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-06-04 03:19:06.479985 | debian-bookworm | changed 2025-06-04 03:19:06.486026 | 2025-06-04 03:19:06.486189 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-06-04 03:19:06.758855 | debian-bookworm | ok 2025-06-04 03:19:06.768914 | 2025-06-04 03:19:06.769042 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-06-04 03:19:07.529631 | debian-bookworm | changed 2025-06-04 03:19:07.544016 | 2025-06-04 03:19:07.544297 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-06-04 03:19:08.364835 | debian-bookworm | changed 2025-06-04 03:19:08.375921 | 2025-06-04 03:19:08.376265 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-06-04 03:19:08.414333 | debian-bookworm | skipping: Conditional result was False 2025-06-04 03:19:08.424213 | 2025-06-04 03:19:08.424604 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-06-04 03:19:09.375066 | debian-bookworm -> localhost | changed 2025-06-04 03:19:09.386471 | 2025-06-04 03:19:09.386602 | TASK [add-build-sshkey : Add back temp key] 2025-06-04 03:19:09.982681 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/28244588f5fb42b5acd53d8ca2ad0ab5/work/28244588f5fb42b5acd53d8ca2ad0ab5_id_rsa (zuul-build-sshkey) 2025-06-04 03:19:09.983529 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.022066 2025-06-04 03:19:09.996107 | 2025-06-04 03:19:09.996281 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-06-04 03:19:10.929340 | debian-bookworm | ok 2025-06-04 03:19:10.934974 | 2025-06-04 03:19:10.935093 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-06-04 03:19:10.972795 | debian-bookworm | skipping: Conditional result was False 2025-06-04 03:19:10.987008 | 2025-06-04 03:19:10.987183 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-06-04 03:19:11.609075 | debian-bookworm | ok 2025-06-04 03:19:11.636273 | 2025-06-04 03:19:11.636426 | TASK [validate-host : Define zuul_info_dir fact] 2025-06-04 03:19:11.686329 | debian-bookworm | ok 2025-06-04 03:19:11.691709 | 2025-06-04 03:19:11.691852 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-06-04 03:19:12.080370 | debian-bookworm -> localhost | ok 2025-06-04 03:19:12.087648 | 2025-06-04 03:19:12.087774 | TASK [validate-host : Collect information about the host] 2025-06-04 03:19:13.407739 | debian-bookworm | ok 2025-06-04 03:19:13.415933 | 2025-06-04 03:19:13.416014 | TASK [validate-host : Sanitize hostname] 2025-06-04 03:19:13.524990 | debian-bookworm | ok 2025-06-04 03:19:13.569773 | 2025-06-04 03:19:13.569866 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-06-04 03:19:14.316128 | debian-bookworm -> localhost | changed 2025-06-04 03:19:14.322023 | 2025-06-04 03:19:14.322120 | TASK [validate-host : Collect information about zuul worker] 2025-06-04 03:19:14.727781 | debian-bookworm | ok 2025-06-04 03:19:14.733067 | 2025-06-04 03:19:14.733540 | TASK [validate-host : Write out all zuul information for each host] 2025-06-04 03:19:15.240015 | debian-bookworm -> localhost | changed 2025-06-04 03:19:15.249879 | 2025-06-04 03:19:15.249973 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-06-04 03:19:15.574138 | debian-bookworm | ok 2025-06-04 03:19:15.587648 | 2025-06-04 03:19:15.587754 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-06-04 03:19:16.354859 | debian-bookworm | changed: 2025-06-04 03:19:16.355028 | debian-bookworm | cd+++++++++ src/ 2025-06-04 03:19:16.355061 | debian-bookworm | cd+++++++++ src/github.com/ 2025-06-04 03:19:16.355085 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-06-04 03:19:16.355106 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2025-06-04 03:19:16.355126 | debian-bookworm | Containerfile 2025-06-04 03:19:16.355271 | debian-bookworm | localhost | ok: Runtime: 0:00:00.009367 2025-06-04 03:19:42.052977 | 2025-06-04 03:19:42.053200 | TASK [upload-logs : Upload logs to log server] 2025-06-04 03:19:42.643526 | localhost | Output suppressed because no_log was given 2025-06-04 03:19:42.645375 | 2025-06-04 03:19:42.645488 | LOOP [upload-logs : Compress console log and json output] 2025-06-04 03:19:42.693345 | localhost | skipping: Conditional result was False 2025-06-04 03:19:42.698404 | localhost | skipping: Conditional result was False 2025-06-04 03:19:42.704066 | 2025-06-04 03:19:42.704249 | LOOP [upload-logs : Upload compressed console log and json output] 2025-06-04 03:19:42.750059 | localhost | skipping: Conditional result was False 2025-06-04 03:19:42.750446 | 2025-06-04 03:19:42.757236 | localhost | skipping: Conditional result was False 2025-06-04 03:19:42.765441 | 2025-06-04 03:19:42.765738 | LOOP [upload-logs : Upload console log and json output]