2025-11-03 03:14:49.421982 | Job console starting 2025-11-03 03:14:49.430566 | Updating git repos 2025-11-03 03:14:49.449862 | Cloning repos into workspace 2025-11-03 03:14:49.483032 | Restoring repo states 2025-11-03 03:14:49.488996 | Merging changes 2025-11-03 03:14:49.489016 | Checking out repos 2025-11-03 03:14:49.555247 | Preparing playbooks 2025-11-03 03:14:50.235926 | Running Ansible setup 2025-11-03 03:14:54.735466 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-03 03:14:55.488520 | 2025-11-03 03:14:55.488673 | PLAY [Base pre] 2025-11-03 03:14:55.504457 | 2025-11-03 03:14:55.504593 | TASK [Setup log path fact] 2025-11-03 03:14:55.544475 | debian-bookworm | ok 2025-11-03 03:14:55.561848 | 2025-11-03 03:14:55.562000 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-03 03:14:55.593296 | debian-bookworm | ok 2025-11-03 03:14:55.604580 | 2025-11-03 03:14:55.604712 | TASK [emit-job-header : Print job information] 2025-11-03 03:14:55.675186 | # Job Information 2025-11-03 03:14:55.675410 | Ansible Version: 2.16.14 2025-11-03 03:14:55.675453 | Job: python-black 2025-11-03 03:14:55.675487 | Pipeline: periodic-daily 2025-11-03 03:14:55.675510 | Executor: 521e9411259a 2025-11-03 03:14:55.675531 | Triggered by: https://github.com/osism/testbed 2025-11-03 03:14:55.675553 | Event ID: de09a44015ea4ebfa8deaa5dde60c793 2025-11-03 03:14:55.687714 | 2025-11-03 03:14:55.687861 | LOOP [emit-job-header : Print node information] 2025-11-03 03:14:55.840770 | debian-bookworm | ok: 2025-11-03 03:14:55.841045 | debian-bookworm | # Node Information 2025-11-03 03:14:55.841083 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-03 03:14:55.841109 | debian-bookworm | Hostname: debian 2025-11-03 03:14:55.841132 | debian-bookworm | Username: zuul 2025-11-03 03:14:55.841153 | debian-bookworm | Distro: Debian 12.12 2025-11-03 03:14:55.841177 | debian-bookworm | Provider: regiocloud-a 2025-11-03 03:14:55.841197 | debian-bookworm | Region: 2025-11-03 03:14:55.841218 | debian-bookworm | Label: debian-bookworm 2025-11-03 03:14:55.841238 | debian-bookworm | Product Name: OpenStack Nova 2025-11-03 03:14:55.841257 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe8d:b24f 2025-11-03 03:14:55.859744 | 2025-11-03 03:14:55.859952 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-03 03:14:56.540914 | debian-bookworm -> localhost | changed 2025-11-03 03:14:56.549007 | 2025-11-03 03:14:56.549132 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-03 03:14:57.744581 | debian-bookworm -> localhost | changed 2025-11-03 03:14:57.757962 | 2025-11-03 03:14:57.758080 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-03 03:14:58.021859 | debian-bookworm -> localhost | ok 2025-11-03 03:14:58.032910 | 2025-11-03 03:14:58.033085 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-03 03:14:58.065428 | debian-bookworm | ok 2025-11-03 03:14:58.087415 | debian-bookworm | included: /var/lib/zuul/builds/08427a30ed1c4cdb8ea897a28c98942e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-03 03:14:58.095512 | 2025-11-03 03:14:58.095633 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-03 03:15:00.547252 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-03 03:15:00.547518 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/08427a30ed1c4cdb8ea897a28c98942e/work/08427a30ed1c4cdb8ea897a28c98942e_id_rsa 2025-11-03 03:15:00.547560 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/08427a30ed1c4cdb8ea897a28c98942e/work/08427a30ed1c4cdb8ea897a28c98942e_id_rsa.pub 2025-11-03 03:15:00.547588 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-03 03:15:00.547611 | debian-bookworm -> localhost | SHA256:ekoMZwfmihjrf65c8ryinr26RHGbTogmumnPEWPc+84 zuul-build-sshkey 2025-11-03 03:15:00.547633 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-03 03:15:00.547667 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-03 03:15:00.547689 | debian-bookworm -> localhost | | | 2025-11-03 03:15:00.547711 | debian-bookworm -> localhost | | | 2025-11-03 03:15:00.547730 | debian-bookworm -> localhost | | . . o | 2025-11-03 03:15:00.547750 | debian-bookworm -> localhost | |. = +o . | 2025-11-03 03:15:00.547770 | debian-bookworm -> localhost | |++ O..+ S | 2025-11-03 03:15:00.547794 | debian-bookworm -> localhost | |=++.o*.o | 2025-11-03 03:15:00.547814 | debian-bookworm -> localhost | |+..+.o+ . | 2025-11-03 03:15:00.547834 | debian-bookworm -> localhost | |o+=.*ooo | 2025-11-03 03:15:00.547855 | debian-bookworm -> localhost | |=B*O*=+E | 2025-11-03 03:15:00.547875 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-03 03:15:00.547930 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.906964 2025-11-03 03:15:00.553973 | 2025-11-03 03:15:00.554069 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-03 03:15:00.581271 | debian-bookworm | ok 2025-11-03 03:15:00.590071 | debian-bookworm | included: /var/lib/zuul/builds/08427a30ed1c4cdb8ea897a28c98942e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-03 03:15:00.600342 | 2025-11-03 03:15:00.600441 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-03 03:15:00.613445 | debian-bookworm | skipping: Conditional result was False 2025-11-03 03:15:00.619875 | 2025-11-03 03:15:00.619979 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-03 03:15:01.232964 | debian-bookworm | changed 2025-11-03 03:15:01.244967 | 2025-11-03 03:15:01.245078 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-03 03:15:01.548918 | debian-bookworm | ok 2025-11-03 03:15:01.562595 | 2025-11-03 03:15:01.562689 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-03 03:15:02.228067 | debian-bookworm | changed 2025-11-03 03:15:02.235213 | 2025-11-03 03:15:02.235305 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-03 03:15:02.852439 | debian-bookworm | changed 2025-11-03 03:15:02.857632 | 2025-11-03 03:15:02.858293 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-03 03:15:02.881603 | debian-bookworm | skipping: Conditional result was False 2025-11-03 03:15:02.888029 | 2025-11-03 03:15:02.888111 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-03 03:15:03.287277 | debian-bookworm -> localhost | changed 2025-11-03 03:15:03.301604 | 2025-11-03 03:15:03.301717 | TASK [add-build-sshkey : Add back temp key] 2025-11-03 03:15:03.618736 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/08427a30ed1c4cdb8ea897a28c98942e/work/08427a30ed1c4cdb8ea897a28c98942e_id_rsa (zuul-build-sshkey) 2025-11-03 03:15:03.619117 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.010710 2025-11-03 03:15:03.640618 | 2025-11-03 03:15:03.640716 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-03 03:15:04.025726 | debian-bookworm | ok 2025-11-03 03:15:04.032060 | 2025-11-03 03:15:04.032178 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-03 03:15:04.055963 | debian-bookworm | skipping: Conditional result was False 2025-11-03 03:15:04.064602 | 2025-11-03 03:15:04.064698 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-03 03:15:04.475337 | debian-bookworm | ok 2025-11-03 03:15:04.490853 | 2025-11-03 03:15:04.490936 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-03 03:15:04.518328 | debian-bookworm | ok 2025-11-03 03:15:04.522213 | 2025-11-03 03:15:04.522282 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-03 03:15:04.769035 | debian-bookworm -> localhost | ok 2025-11-03 03:15:04.775616 | 2025-11-03 03:15:04.775701 | TASK [validate-host : Collect information about the host] 2025-11-03 03:15:05.917053 | debian-bookworm | ok 2025-11-03 03:15:05.930665 | 2025-11-03 03:15:05.930771 | TASK [validate-host : Sanitize hostname] 2025-11-03 03:15:06.032527 | debian-bookworm | ok 2025-11-03 03:15:06.066935 | 2025-11-03 03:15:06.067033 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-03 03:15:06.534244 | debian-bookworm -> localhost | changed 2025-11-03 03:15:06.539760 | 2025-11-03 03:15:06.539858 | TASK [validate-host : Collect information about zuul worker] 2025-11-03 03:15:06.941734 | debian-bookworm | ok 2025-11-03 03:15:06.947019 | 2025-11-03 03:15:06.947128 | TASK [validate-host : Write out all zuul information for each host] 2025-11-03 03:15:07.498454 | debian-bookworm -> localhost | changed 2025-11-03 03:15:07.518737 | 2025-11-03 03:15:07.518947 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-03 03:15:07.792522 | debian-bookworm | ok 2025-11-03 03:15:07.800214 | 2025-11-03 03:15:07.800329 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-03 03:15:09.197480 | debian-bookworm | changed: 2025-11-03 03:15:09.197702 | debian-bookworm | cd+++++++++ src/ 2025-11-03 03:15:09.197738 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-03 03:15:09.197780 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-03 03:15:09.197804 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2025-11-03 03:15:09.197825 | debian-bookworm | localhost | ok: Runtime: 0:00:00.010537 2025-11-03 03:15:36.803801 | 2025-11-03 03:15:36.803892 | TASK [upload-logs : Upload logs to log server] 2025-11-03 03:15:37.528644 | localhost | Output suppressed because no_log was given 2025-11-03 03:15:37.532104 | 2025-11-03 03:15:37.532194 | LOOP [upload-logs : Compress console log and json output] 2025-11-03 03:15:37.628526 | localhost | skipping: Conditional result was False 2025-11-03 03:15:37.636836 | localhost | skipping: Conditional result was False 2025-11-03 03:15:37.649095 | 2025-11-03 03:15:37.649188 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-03 03:15:37.775150 | localhost | skipping: Conditional result was False 2025-11-03 03:15:37.777437 | 2025-11-03 03:15:37.781776 | localhost | skipping: Conditional result was False 2025-11-03 03:15:37.787568 | 2025-11-03 03:15:37.787663 | LOOP [upload-logs : Upload console log and json output]