2025-09-17 22:05:50.629433 | Job console starting 2025-09-17 22:05:50.653733 | Updating git repos 2025-09-17 22:05:50.733172 | Cloning repos into workspace 2025-09-17 22:05:50.812603 | Restoring repo states 2025-09-17 22:05:50.831183 | Merging changes 2025-09-17 22:05:51.404515 | Checking out repos 2025-09-17 22:05:51.463821 | Preparing playbooks 2025-09-17 22:05:52.558559 | Running Ansible setup 2025-09-17 22:05:57.784727 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-17 22:05:58.516919 | 2025-09-17 22:05:58.517050 | PLAY [Base pre] 2025-09-17 22:05:58.546759 | 2025-09-17 22:05:58.546892 | TASK [Setup log path fact] 2025-09-17 22:05:58.564256 | debian-bookworm | ok 2025-09-17 22:05:58.583414 | 2025-09-17 22:05:58.583544 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-17 22:05:58.632127 | debian-bookworm | ok 2025-09-17 22:05:58.642101 | 2025-09-17 22:05:58.642203 | TASK [emit-job-header : Print job information] 2025-09-17 22:05:58.733999 | # Job Information 2025-09-17 22:05:58.734152 | Ansible Version: 2.16.14 2025-09-17 22:05:58.734186 | Job: python-black 2025-09-17 22:05:58.734219 | Pipeline: check 2025-09-17 22:05:58.734242 | Executor: 521e9411259a 2025-09-17 22:05:58.734263 | Triggered by: https://github.com/osism/python-osism/pull/1722 2025-09-17 22:05:58.734286 | Event ID: 72a9acd0-9412-11f0-92eb-1a62f92f61b9 2025-09-17 22:05:58.739338 | 2025-09-17 22:05:58.739437 | LOOP [emit-job-header : Print node information] 2025-09-17 22:05:58.878314 | debian-bookworm | ok: 2025-09-17 22:05:58.878514 | debian-bookworm | # Node Information 2025-09-17 22:05:58.878581 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-17 22:05:58.878612 | debian-bookworm | Hostname: debian 2025-09-17 22:05:58.878635 | debian-bookworm | Username: zuul 2025-09-17 22:05:58.878657 | debian-bookworm | Distro: Debian 12.12 2025-09-17 22:05:58.878680 | debian-bookworm | Provider: regiocloud-a 2025-09-17 22:05:58.878701 | debian-bookworm | Region: 2025-09-17 22:05:58.878722 | debian-bookworm | Label: debian-bookworm 2025-09-17 22:05:58.878742 | debian-bookworm | Product Name: OpenStack Nova 2025-09-17 22:05:58.878762 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe34:adff 2025-09-17 22:05:58.901656 | 2025-09-17 22:05:58.901750 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-17 22:05:59.572392 | debian-bookworm -> localhost | changed 2025-09-17 22:05:59.578129 | 2025-09-17 22:05:59.578215 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-17 22:06:00.849373 | debian-bookworm -> localhost | changed 2025-09-17 22:06:00.868162 | 2025-09-17 22:06:00.868269 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-17 22:06:01.427186 | debian-bookworm -> localhost | ok 2025-09-17 22:06:01.432898 | 2025-09-17 22:06:01.433003 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-17 22:06:01.472355 | debian-bookworm | ok 2025-09-17 22:06:01.505086 | debian-bookworm | included: /var/lib/zuul/builds/a17a5ef0508e40a38c601ba82f3849ec/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-17 22:06:01.510923 | 2025-09-17 22:06:01.511011 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-17 22:06:03.764843 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-17 22:06:03.765018 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/a17a5ef0508e40a38c601ba82f3849ec/work/a17a5ef0508e40a38c601ba82f3849ec_id_rsa 2025-09-17 22:06:03.765050 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/a17a5ef0508e40a38c601ba82f3849ec/work/a17a5ef0508e40a38c601ba82f3849ec_id_rsa.pub 2025-09-17 22:06:03.765071 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-17 22:06:03.765091 | debian-bookworm -> localhost | SHA256:Qp1TxQINVLntHQli7O2DGEuezZ+H2hALQ/B4fxSrHb4 zuul-build-sshkey 2025-09-17 22:06:03.765109 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-17 22:06:03.765134 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-17 22:06:03.765152 | debian-bookworm -> localhost | | ..+*o+o | 2025-09-17 22:06:03.765170 | debian-bookworm -> localhost | | = oB oo | 2025-09-17 22:06:03.765187 | debian-bookworm -> localhost | | o Bo *+. . | 2025-09-17 22:06:03.765203 | debian-bookworm -> localhost | | . oooo=o.o | 2025-09-17 22:06:03.765219 | debian-bookworm -> localhost | | .oSB+++. . | 2025-09-17 22:06:03.765240 | debian-bookworm -> localhost | | .=o+++.. | 2025-09-17 22:06:03.765256 | debian-bookworm -> localhost | | o.E+ | 2025-09-17 22:06:03.765273 | debian-bookworm -> localhost | | o+ . | 2025-09-17 22:06:03.765290 | debian-bookworm -> localhost | | .... | 2025-09-17 22:06:03.765307 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-17 22:06:03.765378 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.682785 2025-09-17 22:06:03.770301 | 2025-09-17 22:06:03.770384 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-17 22:06:03.817420 | debian-bookworm | ok 2025-09-17 22:06:03.824711 | debian-bookworm | included: /var/lib/zuul/builds/a17a5ef0508e40a38c601ba82f3849ec/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-17 22:06:03.842076 | 2025-09-17 22:06:03.842165 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-17 22:06:03.875239 | debian-bookworm | skipping: Conditional result was False 2025-09-17 22:06:03.882033 | 2025-09-17 22:06:03.882119 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-17 22:06:04.614134 | debian-bookworm | changed 2025-09-17 22:06:04.618642 | 2025-09-17 22:06:04.618720 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-17 22:06:04.869466 | debian-bookworm | ok 2025-09-17 22:06:04.873817 | 2025-09-17 22:06:04.873897 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-17 22:06:05.499223 | debian-bookworm | changed 2025-09-17 22:06:05.505125 | 2025-09-17 22:06:05.505212 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-17 22:06:06.112875 | debian-bookworm | changed 2025-09-17 22:06:06.118485 | 2025-09-17 22:06:06.118587 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-17 22:06:06.141650 | debian-bookworm | skipping: Conditional result was False 2025-09-17 22:06:06.147558 | 2025-09-17 22:06:06.147653 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-17 22:06:06.574267 | debian-bookworm -> localhost | changed 2025-09-17 22:06:06.584977 | 2025-09-17 22:06:06.585077 | TASK [add-build-sshkey : Add back temp key] 2025-09-17 22:06:06.962509 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/a17a5ef0508e40a38c601ba82f3849ec/work/a17a5ef0508e40a38c601ba82f3849ec_id_rsa (zuul-build-sshkey) 2025-09-17 22:06:06.962724 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.013927 2025-09-17 22:06:06.970174 | 2025-09-17 22:06:06.970282 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-17 22:06:07.386925 | debian-bookworm | ok 2025-09-17 22:06:07.392298 | 2025-09-17 22:06:07.392422 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-17 22:06:07.415289 | debian-bookworm | skipping: Conditional result was False 2025-09-17 22:06:07.427577 | 2025-09-17 22:06:07.427687 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-17 22:06:07.805751 | debian-bookworm | ok 2025-09-17 22:06:07.819283 | 2025-09-17 22:06:07.819401 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-17 22:06:07.857066 | debian-bookworm | ok 2025-09-17 22:06:07.862011 | 2025-09-17 22:06:07.862112 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-17 22:06:08.511533 | debian-bookworm -> localhost | ok 2025-09-17 22:06:08.518597 | 2025-09-17 22:06:08.518704 | TASK [validate-host : Collect information about the host] 2025-09-17 22:06:09.624643 | debian-bookworm | ok 2025-09-17 22:06:09.647000 | 2025-09-17 22:06:09.647112 | TASK [validate-host : Sanitize hostname] 2025-09-17 22:06:09.752648 | debian-bookworm | ok 2025-09-17 22:06:09.805548 | 2025-09-17 22:06:09.805653 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-17 22:06:10.634409 | debian-bookworm -> localhost | changed 2025-09-17 22:06:10.639742 | 2025-09-17 22:06:10.639838 | TASK [validate-host : Collect information about zuul worker] 2025-09-17 22:06:11.039664 | debian-bookworm | ok 2025-09-17 22:06:11.044064 | 2025-09-17 22:06:11.044157 | TASK [validate-host : Write out all zuul information for each host] 2025-09-17 22:06:11.626789 | debian-bookworm -> localhost | changed 2025-09-17 22:06:11.636992 | 2025-09-17 22:06:11.637089 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-17 22:06:11.903326 | debian-bookworm | ok 2025-09-17 22:06:11.908532 | 2025-09-17 22:06:11.908620 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-17 22:06:13.095140 | debian-bookworm | changed: 2025-09-17 22:06:13.095322 | debian-bookworm | cd+++++++++ src/ 2025-09-17 22:06:13.095360 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-17 22:06:13.095384 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-17 22:06:13.095406 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-09-17 22:06:13.095427 | debian-bookworm | Containerfile 2025-09-17 22:06:13.095539 | debian-bookworm | Containerfile 2025-09-17 22:06:13.116147 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007340 2025-09-17 22:06:39.260908 | 2025-09-17 22:06:39.261079 | TASK [upload-logs : Upload logs to log server] 2025-09-17 22:06:39.820051 | localhost | Output suppressed because no_log was given 2025-09-17 22:06:39.823021 | 2025-09-17 22:06:39.823169 | LOOP [upload-logs : Compress console log and json output] 2025-09-17 22:06:39.896291 | localhost | skipping: Conditional result was False 2025-09-17 22:06:39.901741 | localhost | skipping: Conditional result was False 2025-09-17 22:06:39.912655 | 2025-09-17 22:06:39.912820 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-17 22:06:39.967647 | localhost | skipping: Conditional result was False 2025-09-17 22:06:39.968387 | 2025-09-17 22:06:39.971798 | localhost | skipping: Conditional result was False 2025-09-17 22:06:39.985134 | 2025-09-17 22:06:39.985380 | LOOP [upload-logs : Upload console log and json output]