2025-12-06 03:05:55.126458 | Job console starting 2025-12-06 03:05:55.161360 | Updating git repos 2025-12-06 03:05:55.230863 | Cloning repos into workspace 2025-12-06 03:05:55.310162 | Restoring repo states 2025-12-06 03:05:55.322055 | Merging changes 2025-12-06 03:05:55.322077 | Checking out repos 2025-12-06 03:05:55.399117 | Preparing playbooks 2025-12-06 03:05:56.744064 | Running Ansible setup 2025-12-06 03:06:01.746988 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-06 03:06:02.546328 | 2025-12-06 03:06:02.546499 | PLAY [Base pre] 2025-12-06 03:06:02.567390 | 2025-12-06 03:06:02.567555 | TASK [Setup log path fact] 2025-12-06 03:06:02.587771 | debian-bookworm | ok 2025-12-06 03:06:02.611617 | 2025-12-06 03:06:02.611782 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-06 03:06:02.663660 | debian-bookworm | ok 2025-12-06 03:06:02.684103 | 2025-12-06 03:06:02.684249 | TASK [emit-job-header : Print job information] 2025-12-06 03:06:02.734318 | # Job Information 2025-12-06 03:06:02.734524 | Ansible Version: 2.16.14 2025-12-06 03:06:02.734559 | Job: python-black 2025-12-06 03:06:02.734591 | Pipeline: periodic-daily 2025-12-06 03:06:02.734615 | Executor: 521e9411259a 2025-12-06 03:06:02.734635 | Triggered by: https://github.com/osism/rookify 2025-12-06 03:06:02.734658 | Event ID: 4713034c7cd741d58c38102da8a778be 2025-12-06 03:06:02.739819 | 2025-12-06 03:06:02.741470 | LOOP [emit-job-header : Print node information] 2025-12-06 03:06:02.877806 | debian-bookworm | ok: 2025-12-06 03:06:02.878094 | debian-bookworm | # Node Information 2025-12-06 03:06:02.878133 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-06 03:06:02.878158 | debian-bookworm | Hostname: debian 2025-12-06 03:06:02.878180 | debian-bookworm | Username: zuul 2025-12-06 03:06:02.878202 | debian-bookworm | Distro: Debian 12.12 2025-12-06 03:06:02.878225 | debian-bookworm | Provider: regiocloud-a 2025-12-06 03:06:02.878247 | debian-bookworm | Region: 2025-12-06 03:06:02.878268 | debian-bookworm | Label: debian-bookworm 2025-12-06 03:06:02.878288 | debian-bookworm | Product Name: OpenStack Nova 2025-12-06 03:06:02.878307 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe1d:f0e3 2025-12-06 03:06:02.906554 | 2025-12-06 03:06:02.906722 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-06 03:06:03.563982 | debian-bookworm -> localhost | changed 2025-12-06 03:06:03.582579 | 2025-12-06 03:06:03.582756 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-06 03:06:04.837145 | debian-bookworm -> localhost | changed 2025-12-06 03:06:04.857619 | 2025-12-06 03:06:04.857793 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-06 03:06:05.186635 | debian-bookworm -> localhost | ok 2025-12-06 03:06:05.193179 | 2025-12-06 03:06:05.193321 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-06 03:06:05.222981 | debian-bookworm | ok 2025-12-06 03:06:05.243046 | debian-bookworm | included: /var/lib/zuul/builds/2a2a8592ca8647beb339d69519f875f8/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-06 03:06:05.250297 | 2025-12-06 03:06:05.250434 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-06 03:06:07.125051 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-06 03:06:07.125287 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/2a2a8592ca8647beb339d69519f875f8/work/2a2a8592ca8647beb339d69519f875f8_id_rsa 2025-12-06 03:06:07.125328 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/2a2a8592ca8647beb339d69519f875f8/work/2a2a8592ca8647beb339d69519f875f8_id_rsa.pub 2025-12-06 03:06:07.125355 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-06 03:06:07.125379 | debian-bookworm -> localhost | SHA256:P6FRH63DLrfCENxDIjJfOq3qv8gwPhzSSiv1zMuXJLQ zuul-build-sshkey 2025-12-06 03:06:07.125403 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-06 03:06:07.125431 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-06 03:06:07.125453 | debian-bookworm -> localhost | | | 2025-12-06 03:06:07.125475 | debian-bookworm -> localhost | | o . o . . | 2025-12-06 03:06:07.125495 | debian-bookworm -> localhost | | + * +. . . | 2025-12-06 03:06:07.125516 | debian-bookworm -> localhost | | . + +.oo o | 2025-12-06 03:06:07.125536 | debian-bookworm -> localhost | | . . . oS...= | 2025-12-06 03:06:07.125564 | debian-bookworm -> localhost | |..+ E o .+ o . | 2025-12-06 03:06:07.125586 | debian-bookworm -> localhost | |.=+= + ..o+ o | 2025-12-06 03:06:07.125606 | debian-bookworm -> localhost | |ooo==.o o+ . | 2025-12-06 03:06:07.125627 | debian-bookworm -> localhost | |. .o*+o. .. | 2025-12-06 03:06:07.125648 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-06 03:06:07.125705 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.158408 2025-12-06 03:06:07.133214 | 2025-12-06 03:06:07.133354 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-06 03:06:07.174306 | debian-bookworm | ok 2025-12-06 03:06:07.195423 | debian-bookworm | included: /var/lib/zuul/builds/2a2a8592ca8647beb339d69519f875f8/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-06 03:06:07.210424 | 2025-12-06 03:06:07.210572 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-06 03:06:07.258048 | debian-bookworm | skipping: Conditional result was False 2025-12-06 03:06:07.266020 | 2025-12-06 03:06:07.266175 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-06 03:06:08.029449 | debian-bookworm | changed 2025-12-06 03:06:08.046044 | 2025-12-06 03:06:08.046191 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-06 03:06:08.361882 | debian-bookworm | ok 2025-12-06 03:06:08.367819 | 2025-12-06 03:06:08.367980 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-06 03:06:09.015308 | debian-bookworm | changed 2025-12-06 03:06:09.023012 | 2025-12-06 03:06:09.023160 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-06 03:06:09.674146 | debian-bookworm | changed 2025-12-06 03:06:09.686212 | 2025-12-06 03:06:09.686365 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-06 03:06:09.722352 | debian-bookworm | skipping: Conditional result was False 2025-12-06 03:06:09.739226 | 2025-12-06 03:06:09.739576 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-06 03:06:10.305641 | debian-bookworm -> localhost | changed 2025-12-06 03:06:10.325180 | 2025-12-06 03:06:10.325575 | TASK [add-build-sshkey : Add back temp key] 2025-12-06 03:06:10.774063 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/2a2a8592ca8647beb339d69519f875f8/work/2a2a8592ca8647beb339d69519f875f8_id_rsa (zuul-build-sshkey) 2025-12-06 03:06:10.774584 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.027851 2025-12-06 03:06:10.786675 | 2025-12-06 03:06:10.786815 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-06 03:06:11.206127 | debian-bookworm | ok 2025-12-06 03:06:11.215624 | 2025-12-06 03:06:11.215811 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-06 03:06:11.257008 | debian-bookworm | skipping: Conditional result was False 2025-12-06 03:06:11.280237 | 2025-12-06 03:06:11.280389 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-06 03:06:11.735659 | debian-bookworm | ok 2025-12-06 03:06:11.761639 | 2025-12-06 03:06:11.761786 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-06 03:06:11.813135 | debian-bookworm | ok 2025-12-06 03:06:11.821649 | 2025-12-06 03:06:11.821926 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-06 03:06:12.260720 | debian-bookworm -> localhost | ok 2025-12-06 03:06:12.273789 | 2025-12-06 03:06:12.273950 | TASK [validate-host : Collect information about the host] 2025-12-06 03:06:13.621786 | debian-bookworm | ok 2025-12-06 03:06:13.649583 | 2025-12-06 03:06:13.649778 | TASK [validate-host : Sanitize hostname] 2025-12-06 03:06:13.895952 | debian-bookworm | ok 2025-12-06 03:06:13.956571 | 2025-12-06 03:06:13.956733 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-06 03:06:14.737685 | debian-bookworm -> localhost | changed 2025-12-06 03:06:14.743881 | 2025-12-06 03:06:14.744017 | TASK [validate-host : Collect information about zuul worker] 2025-12-06 03:06:15.164677 | debian-bookworm | ok 2025-12-06 03:06:15.169665 | 2025-12-06 03:06:15.169892 | TASK [validate-host : Write out all zuul information for each host] 2025-12-06 03:06:15.832135 | debian-bookworm -> localhost | changed 2025-12-06 03:06:15.843526 | 2025-12-06 03:06:15.843665 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-06 03:06:16.141070 | debian-bookworm | ok 2025-12-06 03:06:16.148395 | 2025-12-06 03:06:16.148532 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-06 03:06:17.179682 | debian-bookworm | changed: 2025-12-06 03:06:17.179927 | debian-bookworm | cd+++++++++ src/ 2025-12-06 03:06:17.179973 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-06 03:06:17.179999 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-06 03:06:17.180022 | debian-bookworm | cd+++++++++ src/github.com/osism/rookify/ 2025-12-06 03:06:17.180050 | debian-bookworm | Containerfile 2025-12-06 03:06:17.180203 | debian-bookworm | localhost | ok: Runtime: 0:00:00.010676 2025-12-06 03:06:43.022011 | 2025-12-06 03:06:43.022230 | TASK [upload-logs : Upload logs to log server] 2025-12-06 03:06:43.731528 | localhost | Output suppressed because no_log was given 2025-12-06 03:06:43.733400 | 2025-12-06 03:06:43.733515 | LOOP [upload-logs : Compress console log and json output] 2025-12-06 03:06:43.802069 | localhost | skipping: Conditional result was False 2025-12-06 03:06:43.810349 | localhost | skipping: Conditional result was False 2025-12-06 03:06:43.816960 | 2025-12-06 03:06:43.817257 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-06 03:06:43.885265 | localhost | skipping: Conditional result was False 2025-12-06 03:06:43.886395 | 2025-12-06 03:06:43.890933 | localhost | skipping: Conditional result was False 2025-12-06 03:06:43.902511 | 2025-12-06 03:06:43.902654 | LOOP [upload-logs : Upload console log and json output]