2025-11-22 22:46:57.801467 | Job console starting 2025-11-22 22:46:57.840271 | Updating git repos 2025-11-22 22:46:57.944871 | Cloning repos into workspace 2025-11-22 22:46:58.001938 | Restoring repo states 2025-11-22 22:46:58.024915 | Merging changes 2025-11-22 22:47:00.475079 | Checking out repos 2025-11-22 22:47:00.582804 | Preparing playbooks 2025-11-22 22:47:01.821967 | Running Ansible setup 2025-11-22 22:47:07.538306 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-22 22:47:08.998078 | 2025-11-22 22:47:08.998288 | PLAY [Base pre] 2025-11-22 22:47:09.015869 | 2025-11-22 22:47:09.016038 | TASK [Setup log path fact] 2025-11-22 22:47:09.046149 | debian-bookworm | ok 2025-11-22 22:47:09.078688 | 2025-11-22 22:47:09.078924 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-22 22:47:09.132330 | debian-bookworm | ok 2025-11-22 22:47:09.153829 | 2025-11-22 22:47:09.153988 | TASK [emit-job-header : Print job information] 2025-11-22 22:47:09.231717 | # Job Information 2025-11-22 22:47:09.231927 | Ansible Version: 2.16.14 2025-11-22 22:47:09.231964 | Job: python-black 2025-11-22 22:47:09.231996 | Pipeline: check 2025-11-22 22:47:09.232019 | Executor: 521e9411259a 2025-11-22 22:47:09.232040 | Triggered by: https://github.com/osism/python-osism/pull/1836 2025-11-22 22:47:09.232062 | Event ID: 20da55a0-c7f5-11f0-97ca-46dfe57b33b8 2025-11-22 22:47:09.237182 | 2025-11-22 22:47:09.237333 | LOOP [emit-job-header : Print node information] 2025-11-22 22:47:09.501918 | debian-bookworm | ok: 2025-11-22 22:47:09.502192 | debian-bookworm | # Node Information 2025-11-22 22:47:09.502245 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-22 22:47:09.502272 | debian-bookworm | Hostname: debian 2025-11-22 22:47:09.502294 | debian-bookworm | Username: zuul 2025-11-22 22:47:09.502315 | debian-bookworm | Distro: Debian 12.12 2025-11-22 22:47:09.502346 | debian-bookworm | Provider: regiocloud-a 2025-11-22 22:47:09.502371 | debian-bookworm | Region: 2025-11-22 22:47:09.502392 | debian-bookworm | Label: debian-bookworm 2025-11-22 22:47:09.502411 | debian-bookworm | Product Name: OpenStack Nova 2025-11-22 22:47:09.502431 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe23:336c 2025-11-22 22:47:09.518990 | 2025-11-22 22:47:09.519139 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-22 22:47:10.451418 | debian-bookworm -> localhost | changed 2025-11-22 22:47:10.458519 | 2025-11-22 22:47:10.458631 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-22 22:47:11.835411 | debian-bookworm -> localhost | changed 2025-11-22 22:47:11.844244 | 2025-11-22 22:47:11.844338 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-22 22:47:12.149714 | debian-bookworm -> localhost | ok 2025-11-22 22:47:12.154546 | 2025-11-22 22:47:12.154630 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-22 22:47:12.195765 | debian-bookworm | ok 2025-11-22 22:47:12.229792 | debian-bookworm | included: /var/lib/zuul/builds/3c9f4538153948edad77e730f8124d38/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-22 22:47:12.234673 | 2025-11-22 22:47:12.234754 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-22 22:47:13.843181 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-22 22:47:13.843378 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/3c9f4538153948edad77e730f8124d38/work/3c9f4538153948edad77e730f8124d38_id_rsa 2025-11-22 22:47:13.843411 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/3c9f4538153948edad77e730f8124d38/work/3c9f4538153948edad77e730f8124d38_id_rsa.pub 2025-11-22 22:47:13.843435 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-22 22:47:13.843456 | debian-bookworm -> localhost | SHA256:3/IQyraJx1t3/F/Hl1LbCWunJ6H2lGFkTMLLhZ8lSYw zuul-build-sshkey 2025-11-22 22:47:13.843474 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-22 22:47:13.843500 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-22 22:47:13.843518 | debian-bookworm -> localhost | | ..=o. | 2025-11-22 22:47:13.843535 | debian-bookworm -> localhost | | E+= . | 2025-11-22 22:47:13.843552 | debian-bookworm -> localhost | | . +++ | 2025-11-22 22:47:13.843568 | debian-bookworm -> localhost | | ooo | 2025-11-22 22:47:13.843584 | debian-bookworm -> localhost | | S . + . | 2025-11-22 22:47:13.843604 | debian-bookworm -> localhost | | . o o.o*.=| 2025-11-22 22:47:13.843621 | debian-bookworm -> localhost | | .+ = +*+=*| 2025-11-22 22:47:13.843637 | debian-bookworm -> localhost | | oo+ Boo+o+| 2025-11-22 22:47:13.843653 | debian-bookworm -> localhost | | ..+.. ooo +| 2025-11-22 22:47:13.843669 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-22 22:47:13.843707 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.052632 2025-11-22 22:47:13.848678 | 2025-11-22 22:47:13.848754 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-22 22:47:13.885288 | debian-bookworm | ok 2025-11-22 22:47:13.892761 | debian-bookworm | included: /var/lib/zuul/builds/3c9f4538153948edad77e730f8124d38/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-22 22:47:13.900173 | 2025-11-22 22:47:13.900250 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-22 22:47:13.932739 | debian-bookworm | skipping: Conditional result was False 2025-11-22 22:47:13.937463 | 2025-11-22 22:47:13.937538 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-22 22:47:14.518002 | debian-bookworm | changed 2025-11-22 22:47:14.522484 | 2025-11-22 22:47:14.522567 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-22 22:47:14.762436 | debian-bookworm | ok 2025-11-22 22:47:14.767797 | 2025-11-22 22:47:14.767893 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-22 22:47:15.386070 | debian-bookworm | changed 2025-11-22 22:47:15.392619 | 2025-11-22 22:47:15.392719 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-22 22:47:16.051688 | debian-bookworm | changed 2025-11-22 22:47:16.068074 | 2025-11-22 22:47:16.068311 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-22 22:47:16.094743 | debian-bookworm | skipping: Conditional result was False 2025-11-22 22:47:16.106466 | 2025-11-22 22:47:16.106626 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-22 22:47:16.506128 | debian-bookworm -> localhost | changed 2025-11-22 22:47:16.516627 | 2025-11-22 22:47:16.516738 | TASK [add-build-sshkey : Add back temp key] 2025-11-22 22:47:16.909814 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/3c9f4538153948edad77e730f8124d38/work/3c9f4538153948edad77e730f8124d38_id_rsa (zuul-build-sshkey) 2025-11-22 22:47:16.910019 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.012796 2025-11-22 22:47:16.917700 | 2025-11-22 22:47:16.917820 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-22 22:47:17.313526 | debian-bookworm | ok 2025-11-22 22:47:17.318369 | 2025-11-22 22:47:17.318466 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-22 22:47:17.358485 | debian-bookworm | skipping: Conditional result was False 2025-11-22 22:47:17.371983 | 2025-11-22 22:47:17.372093 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-22 22:47:17.848698 | debian-bookworm | ok 2025-11-22 22:47:17.865026 | 2025-11-22 22:47:17.865142 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-22 22:47:17.925102 | debian-bookworm | ok 2025-11-22 22:47:17.940471 | 2025-11-22 22:47:17.940579 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-22 22:47:18.371994 | debian-bookworm -> localhost | ok 2025-11-22 22:47:18.378620 | 2025-11-22 22:47:18.378714 | TASK [validate-host : Collect information about the host] 2025-11-22 22:47:19.568619 | debian-bookworm | ok 2025-11-22 22:47:19.585129 | 2025-11-22 22:47:19.585311 | TASK [validate-host : Sanitize hostname] 2025-11-22 22:47:19.852460 | debian-bookworm | ok 2025-11-22 22:47:19.988019 | 2025-11-22 22:47:19.988177 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-22 22:47:20.737183 | debian-bookworm -> localhost | changed 2025-11-22 22:47:20.746614 | 2025-11-22 22:47:20.746787 | TASK [validate-host : Collect information about zuul worker] 2025-11-22 22:47:21.192295 | debian-bookworm | ok 2025-11-22 22:47:21.197662 | 2025-11-22 22:47:21.197806 | TASK [validate-host : Write out all zuul information for each host] 2025-11-22 22:47:22.087919 | debian-bookworm -> localhost | changed 2025-11-22 22:47:22.097809 | 2025-11-22 22:47:22.097942 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-22 22:47:22.400762 | debian-bookworm | ok 2025-11-22 22:47:22.406448 | 2025-11-22 22:47:22.406561 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-22 22:47:23.499480 | debian-bookworm | changed: 2025-11-22 22:47:23.499681 | debian-bookworm | cd+++++++++ src/ 2025-11-22 22:47:23.499720 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-22 22:47:23.499744 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-22 22:47:23.499766 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-11-22 22:47:23.499785 | debian-bookworm | Containerfile 2025-11-22 22:47:23.499896 | debian-bookworm | Containerfile 2025-11-22 22:47:23.518806 | debian-bookworm | localhost | ok: Runtime: 0:00:00.010681 2025-11-22 22:47:52.073713 | 2025-11-22 22:47:52.073844 | TASK [upload-logs : Upload logs to log server] 2025-11-22 22:47:52.671839 | localhost | Output suppressed because no_log was given 2025-11-22 22:47:52.674552 | 2025-11-22 22:47:52.674703 | LOOP [upload-logs : Compress console log and json output] 2025-11-22 22:47:52.724693 | localhost | skipping: Conditional result was False 2025-11-22 22:47:52.733046 | localhost | skipping: Conditional result was False 2025-11-22 22:47:52.742347 | 2025-11-22 22:47:52.742461 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-22 22:47:52.804720 | localhost | skipping: Conditional result was False 2025-11-22 22:47:52.805340 | 2025-11-22 22:47:52.808733 | localhost | skipping: Conditional result was False 2025-11-22 22:47:52.816677 | 2025-11-22 22:47:52.816844 | LOOP [upload-logs : Upload console log and json output]