2025-09-08 18:36:34.426883 | Job console starting 2025-09-08 18:36:34.455808 | Updating git repos 2025-09-08 18:36:34.555279 | Cloning repos into workspace 2025-09-08 18:36:34.650568 | Restoring repo states 2025-09-08 18:36:34.684168 | Merging changes 2025-09-08 18:36:35.541394 | Checking out repos 2025-09-08 18:36:35.619170 | Preparing playbooks 2025-09-08 18:36:36.997610 | Running Ansible setup 2025-09-08 18:36:42.760057 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-08 18:36:43.699133 | 2025-09-08 18:36:43.699308 | PLAY [Base pre] 2025-09-08 18:36:43.740670 | 2025-09-08 18:36:43.740839 | TASK [Setup log path fact] 2025-09-08 18:36:43.768351 | debian-bookworm | ok 2025-09-08 18:36:43.804100 | 2025-09-08 18:36:43.804265 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-08 18:36:43.895717 | debian-bookworm | ok 2025-09-08 18:36:43.926662 | 2025-09-08 18:36:43.926811 | TASK [emit-job-header : Print job information] 2025-09-08 18:36:44.007618 | # Job Information 2025-09-08 18:36:44.007815 | Ansible Version: 2.16.14 2025-09-08 18:36:44.007853 | Job: python-black 2025-09-08 18:36:44.007887 | Pipeline: check 2025-09-08 18:36:44.007910 | Executor: 521e9411259a 2025-09-08 18:36:44.007930 | Triggered by: https://github.com/osism/python-osism/pull/1713 2025-09-08 18:36:44.007952 | Event ID: b88fba50-8ce2-11f0-94b1-50dd46b1fbac 2025-09-08 18:36:44.012998 | 2025-09-08 18:36:44.013120 | LOOP [emit-job-header : Print node information] 2025-09-08 18:36:44.256725 | debian-bookworm | ok: 2025-09-08 18:36:44.256927 | debian-bookworm | # Node Information 2025-09-08 18:36:44.256963 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-08 18:36:44.256989 | debian-bookworm | Hostname: debian 2025-09-08 18:36:44.257011 | debian-bookworm | Username: zuul 2025-09-08 18:36:44.257032 | debian-bookworm | Distro: Debian 12.12 2025-09-08 18:36:44.257057 | debian-bookworm | Provider: regiocloud-a 2025-09-08 18:36:44.257079 | debian-bookworm | Region: 2025-09-08 18:36:44.257100 | debian-bookworm | Label: debian-bookworm 2025-09-08 18:36:44.257120 | debian-bookworm | Product Name: OpenStack Nova 2025-09-08 18:36:44.257140 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fef0:9489 2025-09-08 18:36:44.272801 | 2025-09-08 18:36:44.272944 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-08 18:36:45.277292 | debian-bookworm -> localhost | changed 2025-09-08 18:36:45.284087 | 2025-09-08 18:36:45.284192 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-08 18:36:46.980213 | debian-bookworm -> localhost | changed 2025-09-08 18:36:46.992172 | 2025-09-08 18:36:46.992284 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-08 18:36:47.462878 | debian-bookworm -> localhost | ok 2025-09-08 18:36:47.467781 | 2025-09-08 18:36:47.467878 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-08 18:36:47.494384 | debian-bookworm | ok 2025-09-08 18:36:47.516304 | debian-bookworm | included: /var/lib/zuul/builds/6b789c67842147daacca47838b6d0f82/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-08 18:36:47.525831 | 2025-09-08 18:36:47.525917 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-08 18:36:49.359872 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-08 18:36:49.360026 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/6b789c67842147daacca47838b6d0f82/work/6b789c67842147daacca47838b6d0f82_id_rsa 2025-09-08 18:36:49.360058 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/6b789c67842147daacca47838b6d0f82/work/6b789c67842147daacca47838b6d0f82_id_rsa.pub 2025-09-08 18:36:49.360079 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-08 18:36:49.360099 | debian-bookworm -> localhost | SHA256:NcAmSMU7qm4v6vyiCtEbM+o4Q9JK2C2Dyxj235VY3PQ zuul-build-sshkey 2025-09-08 18:36:49.360117 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-08 18:36:49.360142 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-08 18:36:49.360160 | debian-bookworm -> localhost | | ..+... | 2025-09-08 18:36:49.360178 | debian-bookworm -> localhost | | . o o. | 2025-09-08 18:36:49.360195 | debian-bookworm -> localhost | | + o. | 2025-09-08 18:36:49.360212 | debian-bookworm -> localhost | | . o ..o.. | 2025-09-08 18:36:49.360228 | debian-bookworm -> localhost | |o+=. . .So . E | 2025-09-08 18:36:49.360248 | debian-bookworm -> localhost | |=*==o o . | 2025-09-08 18:36:49.360265 | debian-bookworm -> localhost | |X+o+ . o | 2025-09-08 18:36:49.360281 | debian-bookworm -> localhost | |@o+. . . | 2025-09-08 18:36:49.360298 | debian-bookworm -> localhost | |OX++o. . | 2025-09-08 18:36:49.360314 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-08 18:36:49.360354 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.188268 2025-09-08 18:36:49.365633 | 2025-09-08 18:36:49.365706 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-08 18:36:49.407224 | debian-bookworm | ok 2025-09-08 18:36:49.414485 | debian-bookworm | included: /var/lib/zuul/builds/6b789c67842147daacca47838b6d0f82/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-08 18:36:49.421506 | 2025-09-08 18:36:49.421575 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-08 18:36:49.437903 | debian-bookworm | skipping: Conditional result was False 2025-09-08 18:36:49.442428 | 2025-09-08 18:36:49.442510 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-08 18:36:50.152894 | debian-bookworm | changed 2025-09-08 18:36:50.157281 | 2025-09-08 18:36:50.157350 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-08 18:36:50.419289 | debian-bookworm | ok 2025-09-08 18:36:50.424649 | 2025-09-08 18:36:50.424742 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-08 18:36:51.141201 | debian-bookworm | changed 2025-09-08 18:36:51.147622 | 2025-09-08 18:36:51.147719 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-08 18:36:51.815869 | debian-bookworm | changed 2025-09-08 18:36:51.821508 | 2025-09-08 18:36:51.821611 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-08 18:36:51.858995 | debian-bookworm | skipping: Conditional result was False 2025-09-08 18:36:51.864744 | 2025-09-08 18:36:51.864848 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-08 18:36:52.353545 | debian-bookworm -> localhost | changed 2025-09-08 18:36:52.363685 | 2025-09-08 18:36:52.363783 | TASK [add-build-sshkey : Add back temp key] 2025-09-08 18:36:52.801552 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/6b789c67842147daacca47838b6d0f82/work/6b789c67842147daacca47838b6d0f82_id_rsa (zuul-build-sshkey) 2025-09-08 18:36:52.801773 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.009594 2025-09-08 18:36:52.809208 | 2025-09-08 18:36:52.809302 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-08 18:36:53.180628 | debian-bookworm | ok 2025-09-08 18:36:53.193139 | 2025-09-08 18:36:53.193243 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-08 18:36:53.219394 | debian-bookworm | skipping: Conditional result was False 2025-09-08 18:36:53.229516 | 2025-09-08 18:36:53.229625 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-08 18:36:53.745810 | debian-bookworm | ok 2025-09-08 18:36:53.763554 | 2025-09-08 18:36:53.763655 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-08 18:36:53.804543 | debian-bookworm | ok 2025-09-08 18:36:53.811894 | 2025-09-08 18:36:53.812004 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-08 18:36:54.258366 | debian-bookworm -> localhost | ok 2025-09-08 18:36:54.264701 | 2025-09-08 18:36:54.264799 | TASK [validate-host : Collect information about the host] 2025-09-08 18:36:55.393356 | debian-bookworm | ok 2025-09-08 18:36:55.413575 | 2025-09-08 18:36:55.413693 | TASK [validate-host : Sanitize hostname] 2025-09-08 18:36:55.567978 | debian-bookworm | ok 2025-09-08 18:36:55.616542 | 2025-09-08 18:36:55.616682 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-08 18:36:56.466590 | debian-bookworm -> localhost | changed 2025-09-08 18:36:56.475570 | 2025-09-08 18:36:56.475708 | TASK [validate-host : Collect information about zuul worker] 2025-09-08 18:36:56.939865 | debian-bookworm | ok 2025-09-08 18:36:56.944756 | 2025-09-08 18:36:56.944880 | TASK [validate-host : Write out all zuul information for each host] 2025-09-08 18:36:57.626531 | debian-bookworm -> localhost | changed 2025-09-08 18:36:57.636305 | 2025-09-08 18:36:57.636423 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-08 18:36:57.963160 | debian-bookworm | ok 2025-09-08 18:36:57.969132 | 2025-09-08 18:36:57.969251 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-08 18:36:59.182585 | debian-bookworm | changed: 2025-09-08 18:36:59.182806 | debian-bookworm | cd+++++++++ src/ 2025-09-08 18:36:59.182879 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-08 18:36:59.182905 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-08 18:36:59.182926 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-09-08 18:36:59.182946 | debian-bookworm | Containerfile 2025-09-08 18:36:59.183058 | debian-bookworm | Containerfile 2025-09-08 18:36:59.216238 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006021 2025-09-08 18:37:26.820323 | 2025-09-08 18:37:26.820566 | TASK [upload-logs : Upload logs to log server] 2025-09-08 18:37:27.387986 | localhost | Output suppressed because no_log was given 2025-09-08 18:37:27.391893 | 2025-09-08 18:37:27.392079 | LOOP [upload-logs : Compress console log and json output] 2025-09-08 18:37:27.441897 | localhost | skipping: Conditional result was False 2025-09-08 18:37:27.447764 | localhost | skipping: Conditional result was False 2025-09-08 18:37:27.455068 | 2025-09-08 18:37:27.455295 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-08 18:37:27.502532 | localhost | skipping: Conditional result was False 2025-09-08 18:37:27.502930 | 2025-09-08 18:37:27.507344 | localhost | skipping: Conditional result was False 2025-09-08 18:37:27.519652 | 2025-09-08 18:37:27.519862 | LOOP [upload-logs : Upload console log and json output]