2025-08-23 21:48:39.670450 | Job console starting 2025-08-23 21:48:39.683212 | Updating git repos 2025-08-23 21:48:39.718659 | Cloning repos into workspace 2025-08-23 21:48:39.773122 | Restoring repo states 2025-08-23 21:48:39.786916 | Merging changes 2025-08-23 21:48:40.290468 | Checking out repos 2025-08-23 21:48:40.331478 | Preparing playbooks 2025-08-23 21:48:40.898816 | Running Ansible setup 2025-08-23 21:48:45.345297 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-08-23 21:48:46.153369 | 2025-08-23 21:48:46.153531 | PLAY [Base pre] 2025-08-23 21:48:46.170314 | 2025-08-23 21:48:46.170457 | TASK [Setup log path fact] 2025-08-23 21:48:46.199617 | debian-bookworm | ok 2025-08-23 21:48:46.216450 | 2025-08-23 21:48:46.216607 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-23 21:48:46.246230 | debian-bookworm | ok 2025-08-23 21:48:46.263552 | 2025-08-23 21:48:46.263802 | TASK [emit-job-header : Print job information] 2025-08-23 21:48:46.334415 | # Job Information 2025-08-23 21:48:46.334613 | Ansible Version: 2.16.14 2025-08-23 21:48:46.334650 | Job: python-black 2025-08-23 21:48:46.334683 | Pipeline: check 2025-08-23 21:48:46.334705 | Executor: 521e9411259a 2025-08-23 21:48:46.334726 | Triggered by: https://github.com/osism/ansible-collection-services/pull/1961 2025-08-23 21:48:46.334748 | Event ID: 9fdd6220-806a-11f0-8533-9b33fbac3839 2025-08-23 21:48:46.340582 | 2025-08-23 21:48:46.340709 | LOOP [emit-job-header : Print node information] 2025-08-23 21:48:46.467432 | debian-bookworm | ok: 2025-08-23 21:48:46.467708 | debian-bookworm | # Node Information 2025-08-23 21:48:46.467759 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-08-23 21:48:46.467790 | debian-bookworm | Hostname: debian 2025-08-23 21:48:46.467817 | debian-bookworm | Username: zuul 2025-08-23 21:48:46.467842 | debian-bookworm | Distro: Debian 12.11 2025-08-23 21:48:46.467870 | debian-bookworm | Provider: regiocloud-a 2025-08-23 21:48:46.467894 | debian-bookworm | Region: 2025-08-23 21:48:46.467920 | debian-bookworm | Label: debian-bookworm 2025-08-23 21:48:46.467944 | debian-bookworm | Product Name: OpenStack Nova 2025-08-23 21:48:46.467967 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe7a:6ab9 2025-08-23 21:48:46.486494 | 2025-08-23 21:48:46.486618 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-08-23 21:48:46.988520 | debian-bookworm -> localhost | changed 2025-08-23 21:48:47.010726 | 2025-08-23 21:48:47.010900 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-08-23 21:48:48.239103 | debian-bookworm -> localhost | changed 2025-08-23 21:48:48.250346 | 2025-08-23 21:48:48.250485 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-08-23 21:48:48.558166 | debian-bookworm -> localhost | ok 2025-08-23 21:48:48.565081 | 2025-08-23 21:48:48.565206 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-08-23 21:48:48.594376 | debian-bookworm | ok 2025-08-23 21:48:48.611870 | debian-bookworm | included: /var/lib/zuul/builds/bcb8efd0071947c5bf6763732cc84b85/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-08-23 21:48:48.617944 | 2025-08-23 21:48:48.618042 | TASK [add-build-sshkey : Create Temp SSH key] 2025-08-23 21:48:50.713867 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-08-23 21:48:50.714216 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/bcb8efd0071947c5bf6763732cc84b85/work/bcb8efd0071947c5bf6763732cc84b85_id_rsa 2025-08-23 21:48:50.714327 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/bcb8efd0071947c5bf6763732cc84b85/work/bcb8efd0071947c5bf6763732cc84b85_id_rsa.pub 2025-08-23 21:48:50.714376 | debian-bookworm -> localhost | The key fingerprint is: 2025-08-23 21:48:50.714421 | debian-bookworm -> localhost | SHA256:VUzg623EugKm6vcaC5V4ZsywYPgMhx3R3rIups5Idvk zuul-build-sshkey 2025-08-23 21:48:50.714460 | debian-bookworm -> localhost | The key's randomart image is: 2025-08-23 21:48:50.714511 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-08-23 21:48:50.714549 | debian-bookworm -> localhost | | oo .+o | 2025-08-23 21:48:50.714585 | debian-bookworm -> localhost | |.o .. . .. | 2025-08-23 21:48:50.714616 | debian-bookworm -> localhost | |=.+. . o | 2025-08-23 21:48:50.714645 | debian-bookworm -> localhost | |.* *o.. . o | 2025-08-23 21:48:50.714674 | debian-bookworm -> localhost | | = Oo S . o | 2025-08-23 21:48:50.714717 | debian-bookworm -> localhost | | =o o . + | 2025-08-23 21:48:50.714747 | debian-bookworm -> localhost | | o.+.o . o o | 2025-08-23 21:48:50.714776 | debian-bookworm -> localhost | |= +.=o . o | 2025-08-23 21:48:50.714806 | debian-bookworm -> localhost | |+*o+oE. .. | 2025-08-23 21:48:50.714855 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-08-23 21:48:50.715011 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.577423 2025-08-23 21:48:50.727550 | 2025-08-23 21:48:50.727667 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-08-23 21:48:50.765769 | debian-bookworm | ok 2025-08-23 21:48:50.776523 | debian-bookworm | included: /var/lib/zuul/builds/bcb8efd0071947c5bf6763732cc84b85/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-08-23 21:48:50.785802 | 2025-08-23 21:48:50.785905 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-08-23 21:48:50.810423 | debian-bookworm | skipping: Conditional result was False 2025-08-23 21:48:50.816547 | 2025-08-23 21:48:50.816656 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-08-23 21:48:51.526172 | debian-bookworm | changed 2025-08-23 21:48:51.533440 | 2025-08-23 21:48:51.533576 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-08-23 21:48:51.820811 | debian-bookworm | ok 2025-08-23 21:48:51.827460 | 2025-08-23 21:48:51.827599 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-08-23 21:48:52.507668 | debian-bookworm | changed 2025-08-23 21:48:52.514973 | 2025-08-23 21:48:52.515092 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-08-23 21:48:53.172325 | debian-bookworm | changed 2025-08-23 21:48:53.180549 | 2025-08-23 21:48:53.180670 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-08-23 21:48:53.204440 | debian-bookworm | skipping: Conditional result was False 2025-08-23 21:48:53.211520 | 2025-08-23 21:48:53.211629 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-08-23 21:48:53.695644 | debian-bookworm -> localhost | changed 2025-08-23 21:48:53.710209 | 2025-08-23 21:48:53.710350 | TASK [add-build-sshkey : Add back temp key] 2025-08-23 21:48:54.066021 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/bcb8efd0071947c5bf6763732cc84b85/work/bcb8efd0071947c5bf6763732cc84b85_id_rsa (zuul-build-sshkey) 2025-08-23 21:48:54.066609 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.019451 2025-08-23 21:48:54.082778 | 2025-08-23 21:48:54.082960 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-08-23 21:48:54.505105 | debian-bookworm | ok 2025-08-23 21:48:54.513969 | 2025-08-23 21:48:54.514115 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-08-23 21:48:54.538603 | debian-bookworm | skipping: Conditional result was False 2025-08-23 21:48:54.555014 | 2025-08-23 21:48:54.555133 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-08-23 21:48:55.005124 | debian-bookworm | ok 2025-08-23 21:48:55.020079 | 2025-08-23 21:48:55.020200 | TASK [validate-host : Define zuul_info_dir fact] 2025-08-23 21:48:55.063565 | debian-bookworm | ok 2025-08-23 21:48:55.070711 | 2025-08-23 21:48:55.070826 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-08-23 21:48:55.418101 | debian-bookworm -> localhost | ok 2025-08-23 21:48:55.425013 | 2025-08-23 21:48:55.425124 | TASK [validate-host : Collect information about the host] 2025-08-23 21:48:56.526238 | debian-bookworm | ok 2025-08-23 21:48:56.537464 | 2025-08-23 21:48:56.537589 | TASK [validate-host : Sanitize hostname] 2025-08-23 21:48:56.649092 | debian-bookworm | ok 2025-08-23 21:48:56.691406 | 2025-08-23 21:48:56.691536 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-08-23 21:48:57.262313 | debian-bookworm -> localhost | changed 2025-08-23 21:48:57.268390 | 2025-08-23 21:48:57.268508 | TASK [validate-host : Collect information about zuul worker] 2025-08-23 21:48:57.667905 | debian-bookworm | ok 2025-08-23 21:48:57.679597 | 2025-08-23 21:48:57.679826 | TASK [validate-host : Write out all zuul information for each host] 2025-08-23 21:48:58.296693 | debian-bookworm -> localhost | changed 2025-08-23 21:48:58.306652 | 2025-08-23 21:48:58.306775 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-08-23 21:48:58.577582 | debian-bookworm | ok 2025-08-23 21:48:58.586339 | 2025-08-23 21:48:58.586482 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-08-23 21:48:59.666301 | debian-bookworm | changed: 2025-08-23 21:48:59.666522 | debian-bookworm | cd+++++++++ src/ 2025-08-23 21:48:59.666560 | debian-bookworm | cd+++++++++ src/github.com/ 2025-08-23 21:48:59.666587 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-08-23 21:48:59.666611 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2025-08-23 21:48:59.666634 | debian-bookworm | localhost | ok: Runtime: 0:00:00.004679 2025-08-23 21:49:24.639456 | 2025-08-23 21:49:24.639578 | TASK [upload-logs : Upload logs to log server] 2025-08-23 21:49:25.226499 | localhost | Output suppressed because no_log was given 2025-08-23 21:49:25.228751 | 2025-08-23 21:49:25.228867 | LOOP [upload-logs : Compress console log and json output] 2025-08-23 21:49:25.283254 | localhost | skipping: Conditional result was False 2025-08-23 21:49:25.290188 | localhost | skipping: Conditional result was False 2025-08-23 21:49:25.303569 | 2025-08-23 21:49:25.303818 | LOOP [upload-logs : Upload compressed console log and json output] 2025-08-23 21:49:25.351949 | localhost | skipping: Conditional result was False 2025-08-23 21:49:25.352404 | 2025-08-23 21:49:25.357013 | localhost | skipping: Conditional result was False 2025-08-23 21:49:25.364976 | 2025-08-23 21:49:25.365088 | LOOP [upload-logs : Upload console log and json output]