2025-10-21 16:09:50.306036 | Job console starting 2025-10-21 16:09:50.318119 | Updating git repos 2025-10-21 16:09:50.347082 | Cloning repos into workspace 2025-10-21 16:09:50.397392 | Restoring repo states 2025-10-21 16:09:50.418681 | Merging changes 2025-10-21 16:09:51.015481 | Checking out repos 2025-10-21 16:09:51.063778 | Preparing playbooks 2025-10-21 16:09:51.576039 | Running Ansible setup 2025-10-21 16:09:55.819976 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-21 16:09:56.570922 | 2025-10-21 16:09:56.571083 | PLAY [Base pre] 2025-10-21 16:09:56.588029 | 2025-10-21 16:09:56.588155 | TASK [Setup log path fact] 2025-10-21 16:09:56.622488 | debian-bookworm | ok 2025-10-21 16:09:56.640468 | 2025-10-21 16:09:56.640597 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-21 16:09:56.687730 | debian-bookworm | ok 2025-10-21 16:09:56.701856 | 2025-10-21 16:09:56.701982 | TASK [emit-job-header : Print job information] 2025-10-21 16:09:56.759037 | # Job Information 2025-10-21 16:09:56.759394 | Ansible Version: 2.16.14 2025-10-21 16:09:56.759468 | Job: python-black 2025-10-21 16:09:56.759537 | Pipeline: check 2025-10-21 16:09:56.759584 | Executor: 521e9411259a 2025-10-21 16:09:56.759622 | Triggered by: https://github.com/osism/python-osism/pull/1682 2025-10-21 16:09:56.759662 | Event ID: 9cbfac60-ae96-11f0-9a90-d92e18dda28a 2025-10-21 16:09:56.767901 | 2025-10-21 16:09:56.768056 | LOOP [emit-job-header : Print node information] 2025-10-21 16:09:56.875863 | debian-bookworm | ok: 2025-10-21 16:09:56.876124 | debian-bookworm | # Node Information 2025-10-21 16:09:56.876265 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-21 16:09:56.876316 | debian-bookworm | Hostname: debian 2025-10-21 16:09:56.876353 | debian-bookworm | Username: zuul 2025-10-21 16:09:56.876387 | debian-bookworm | Distro: Debian 12.12 2025-10-21 16:09:56.876424 | debian-bookworm | Provider: regiocloud-a 2025-10-21 16:09:56.876455 | debian-bookworm | Region: 2025-10-21 16:09:56.876485 | debian-bookworm | Label: debian-bookworm 2025-10-21 16:09:56.876513 | debian-bookworm | Product Name: OpenStack Nova 2025-10-21 16:09:56.876542 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fed0:ef88 2025-10-21 16:09:56.905371 | 2025-10-21 16:09:56.905530 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-21 16:09:57.386677 | debian-bookworm -> localhost | changed 2025-10-21 16:09:57.402327 | 2025-10-21 16:09:57.402491 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-21 16:09:58.494702 | debian-bookworm -> localhost | changed 2025-10-21 16:09:58.515041 | 2025-10-21 16:09:58.515202 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-21 16:09:58.807740 | debian-bookworm -> localhost | ok 2025-10-21 16:09:58.821494 | 2025-10-21 16:09:58.821664 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-21 16:09:58.858892 | debian-bookworm | ok 2025-10-21 16:09:58.881893 | debian-bookworm | included: /var/lib/zuul/builds/c28a38031a7f46eabd46aae70e647e62/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-21 16:09:58.888156 | 2025-10-21 16:09:58.888286 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-21 16:09:59.854045 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-21 16:09:59.854539 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/c28a38031a7f46eabd46aae70e647e62/work/c28a38031a7f46eabd46aae70e647e62_id_rsa 2025-10-21 16:09:59.854645 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/c28a38031a7f46eabd46aae70e647e62/work/c28a38031a7f46eabd46aae70e647e62_id_rsa.pub 2025-10-21 16:09:59.854721 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-21 16:09:59.854788 | debian-bookworm -> localhost | SHA256:yA7Xn5n0q/Edv0s2Fyhb7gCbS0JN/yJHaLnLnePbEtk zuul-build-sshkey 2025-10-21 16:09:59.854983 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-21 16:09:59.855078 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-21 16:09:59.855142 | debian-bookworm -> localhost | | | 2025-10-21 16:09:59.855226 | debian-bookworm -> localhost | | | 2025-10-21 16:09:59.855288 | debian-bookworm -> localhost | | . | 2025-10-21 16:09:59.855344 | debian-bookworm -> localhost | | . oo + . | 2025-10-21 16:09:59.855400 | debian-bookworm -> localhost | | . +.S*.+oo . | 2025-10-21 16:09:59.855466 | debian-bookworm -> localhost | | +. .o*B*E .| 2025-10-21 16:09:59.855524 | debian-bookworm -> localhost | | .. **=oo.+.| 2025-10-21 16:09:59.855580 | debian-bookworm -> localhost | | + *=*oooo| 2025-10-21 16:09:59.855637 | debian-bookworm -> localhost | | +o**o.o+| 2025-10-21 16:09:59.855693 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-21 16:09:59.855815 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.448241 2025-10-21 16:09:59.868681 | 2025-10-21 16:09:59.868827 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-21 16:09:59.904763 | debian-bookworm | ok 2025-10-21 16:09:59.917548 | debian-bookworm | included: /var/lib/zuul/builds/c28a38031a7f46eabd46aae70e647e62/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-21 16:09:59.927299 | 2025-10-21 16:09:59.927400 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-21 16:09:59.950609 | debian-bookworm | skipping: Conditional result was False 2025-10-21 16:09:59.957085 | 2025-10-21 16:09:59.957207 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-21 16:10:00.655706 | debian-bookworm | changed 2025-10-21 16:10:00.662127 | 2025-10-21 16:10:00.662248 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-21 16:10:00.949447 | debian-bookworm | ok 2025-10-21 16:10:00.956626 | 2025-10-21 16:10:00.956759 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-21 16:10:01.696532 | debian-bookworm | changed 2025-10-21 16:10:01.711680 | 2025-10-21 16:10:01.711854 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-21 16:10:02.426922 | debian-bookworm | changed 2025-10-21 16:10:02.435116 | 2025-10-21 16:10:02.435261 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-21 16:10:02.459967 | debian-bookworm | skipping: Conditional result was False 2025-10-21 16:10:02.471918 | 2025-10-21 16:10:02.472082 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-21 16:10:02.954783 | debian-bookworm -> localhost | changed 2025-10-21 16:10:02.970813 | 2025-10-21 16:10:02.971020 | TASK [add-build-sshkey : Add back temp key] 2025-10-21 16:10:03.340565 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/c28a38031a7f46eabd46aae70e647e62/work/c28a38031a7f46eabd46aae70e647e62_id_rsa (zuul-build-sshkey) 2025-10-21 16:10:03.340829 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.019275 2025-10-21 16:10:03.349611 | 2025-10-21 16:10:03.349738 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-21 16:10:03.794776 | debian-bookworm | ok 2025-10-21 16:10:03.805156 | 2025-10-21 16:10:03.805326 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-21 16:10:03.832773 | debian-bookworm | skipping: Conditional result was False 2025-10-21 16:10:03.843811 | 2025-10-21 16:10:03.843913 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-21 16:10:04.315458 | debian-bookworm | ok 2025-10-21 16:10:04.331537 | 2025-10-21 16:10:04.331675 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-21 16:10:04.378033 | debian-bookworm | ok 2025-10-21 16:10:04.386691 | 2025-10-21 16:10:04.386868 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-21 16:10:04.688677 | debian-bookworm -> localhost | ok 2025-10-21 16:10:04.702086 | 2025-10-21 16:10:04.702317 | TASK [validate-host : Collect information about the host] 2025-10-21 16:10:05.910619 | debian-bookworm | ok 2025-10-21 16:10:05.925208 | 2025-10-21 16:10:05.925335 | TASK [validate-host : Sanitize hostname] 2025-10-21 16:10:06.050265 | debian-bookworm | ok 2025-10-21 16:10:06.108917 | 2025-10-21 16:10:06.109055 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-21 16:10:06.660378 | debian-bookworm -> localhost | changed 2025-10-21 16:10:06.666626 | 2025-10-21 16:10:06.666744 | TASK [validate-host : Collect information about zuul worker] 2025-10-21 16:10:07.117372 | debian-bookworm | ok 2025-10-21 16:10:07.123588 | 2025-10-21 16:10:07.123713 | TASK [validate-host : Write out all zuul information for each host] 2025-10-21 16:10:07.686660 | debian-bookworm -> localhost | changed 2025-10-21 16:10:07.696578 | 2025-10-21 16:10:07.697229 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-21 16:10:07.991503 | debian-bookworm | ok 2025-10-21 16:10:07.998068 | 2025-10-21 16:10:07.998179 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-21 16:10:09.016397 | debian-bookworm | changed: 2025-10-21 16:10:09.016615 | debian-bookworm | cd+++++++++ src/ 2025-10-21 16:10:09.016655 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-21 16:10:09.016682 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-21 16:10:09.016706 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-10-21 16:10:09.016729 | debian-bookworm | Containerfile 2025-10-21 16:10:09.016852 | debian-bookworm | Containerfile 2025-10-21 16:10:09.023700 | debian-bookworm | localhost | ok: Runtime: 0:00:00.008336 2025-10-21 16:10:36.987985 | 2025-10-21 16:10:36.988113 | TASK [upload-logs : Upload logs to log server] 2025-10-21 16:10:37.715191 | localhost | Output suppressed because no_log was given 2025-10-21 16:10:37.717521 | 2025-10-21 16:10:37.717649 | LOOP [upload-logs : Compress console log and json output] 2025-10-21 16:10:37.792009 | localhost | skipping: Conditional result was False 2025-10-21 16:10:37.803573 | localhost | skipping: Conditional result was False 2025-10-21 16:10:37.816540 | 2025-10-21 16:10:37.816664 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-21 16:10:37.869591 | localhost | skipping: Conditional result was False 2025-10-21 16:10:37.869892 | 2025-10-21 16:10:37.875979 | localhost | skipping: Conditional result was False 2025-10-21 16:10:37.883675 | 2025-10-21 16:10:37.883793 | LOOP [upload-logs : Upload console log and json output]