2025-11-23 12:51:04.349523 | Job console starting 2025-11-23 12:51:04.387276 | Updating git repos 2025-11-23 12:51:04.468211 | Cloning repos into workspace 2025-11-23 12:51:04.564754 | Restoring repo states 2025-11-23 12:51:04.604446 | Merging changes 2025-11-23 12:51:05.226555 | Checking out repos 2025-11-23 12:51:05.285181 | Preparing playbooks 2025-11-23 12:51:06.424498 | Running Ansible setup 2025-11-23 12:51:12.213813 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-23 12:51:13.547972 | 2025-11-23 12:51:13.548192 | PLAY [Base pre] 2025-11-23 12:51:13.581963 | 2025-11-23 12:51:13.582169 | TASK [Setup log path fact] 2025-11-23 12:51:13.631906 | debian-bookworm | ok 2025-11-23 12:51:13.670654 | 2025-11-23 12:51:13.671117 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-23 12:51:13.731968 | debian-bookworm | ok 2025-11-23 12:51:13.767349 | 2025-11-23 12:51:13.767491 | TASK [emit-job-header : Print job information] 2025-11-23 12:51:13.817545 | # Job Information 2025-11-23 12:51:13.817767 | Ansible Version: 2.16.14 2025-11-23 12:51:13.817805 | Job: python-black 2025-11-23 12:51:13.817839 | Pipeline: check 2025-11-23 12:51:13.817863 | Executor: 521e9411259a 2025-11-23 12:51:13.817883 | Triggered by: https://github.com/osism/python-osism/pull/1843 2025-11-23 12:51:13.817905 | Event ID: 0d584570-c86b-11f0-8efe-0513ed03d83c 2025-11-23 12:51:13.823147 | 2025-11-23 12:51:13.823276 | LOOP [emit-job-header : Print node information] 2025-11-23 12:51:14.082742 | debian-bookworm | ok: 2025-11-23 12:51:14.083038 | debian-bookworm | # Node Information 2025-11-23 12:51:14.083093 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-23 12:51:14.083118 | debian-bookworm | Hostname: debian 2025-11-23 12:51:14.083141 | debian-bookworm | Username: zuul 2025-11-23 12:51:14.083161 | debian-bookworm | Distro: Debian 12.12 2025-11-23 12:51:14.083184 | debian-bookworm | Provider: regiocloud-a 2025-11-23 12:51:14.083206 | debian-bookworm | Region: 2025-11-23 12:51:14.083226 | debian-bookworm | Label: debian-bookworm 2025-11-23 12:51:14.083245 | debian-bookworm | Product Name: OpenStack Nova 2025-11-23 12:51:14.083264 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe78:327 2025-11-23 12:51:14.096231 | 2025-11-23 12:51:14.096381 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-23 12:51:14.877761 | debian-bookworm -> localhost | changed 2025-11-23 12:51:14.886582 | 2025-11-23 12:51:14.886732 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-23 12:51:17.089955 | debian-bookworm -> localhost | changed 2025-11-23 12:51:17.107905 | 2025-11-23 12:51:17.108098 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-23 12:51:17.632900 | debian-bookworm -> localhost | ok 2025-11-23 12:51:17.639284 | 2025-11-23 12:51:17.639405 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-23 12:51:17.679671 | debian-bookworm | ok 2025-11-23 12:51:17.714593 | debian-bookworm | included: /var/lib/zuul/builds/d4de7cd7aae8456aa0e32c111f40d280/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-23 12:51:17.721153 | 2025-11-23 12:51:17.721273 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-23 12:51:19.962146 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-23 12:51:19.962448 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/d4de7cd7aae8456aa0e32c111f40d280/work/d4de7cd7aae8456aa0e32c111f40d280_id_rsa 2025-11-23 12:51:19.962493 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/d4de7cd7aae8456aa0e32c111f40d280/work/d4de7cd7aae8456aa0e32c111f40d280_id_rsa.pub 2025-11-23 12:51:19.962521 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-23 12:51:19.962544 | debian-bookworm -> localhost | SHA256:0JjMLkf/ElRvD+n1IFri91sTjnEBdeFG+Hg3N7lvHy8 zuul-build-sshkey 2025-11-23 12:51:19.962567 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-23 12:51:19.962598 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-23 12:51:19.962620 | debian-bookworm -> localhost | | . .o+o| 2025-11-23 12:51:19.962641 | debian-bookworm -> localhost | | o + . . o+ .| 2025-11-23 12:51:19.962660 | debian-bookworm -> localhost | | B o . B =+.| 2025-11-23 12:51:19.962680 | debian-bookworm -> localhost | | o + . * *.O+| 2025-11-23 12:51:19.962700 | debian-bookworm -> localhost | | . o S o o.ooB| 2025-11-23 12:51:19.962724 | debian-bookworm -> localhost | | o o . .=..| 2025-11-23 12:51:19.962744 | debian-bookworm -> localhost | | . . ..+o| 2025-11-23 12:51:19.962764 | debian-bookworm -> localhost | | . Eo*| 2025-11-23 12:51:19.962785 | debian-bookworm -> localhost | | .o+| 2025-11-23 12:51:19.962805 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-23 12:51:19.962897 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.192263 2025-11-23 12:51:19.969811 | 2025-11-23 12:51:19.969922 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-23 12:51:20.009366 | debian-bookworm | ok 2025-11-23 12:51:20.019937 | debian-bookworm | included: /var/lib/zuul/builds/d4de7cd7aae8456aa0e32c111f40d280/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-23 12:51:20.029750 | 2025-11-23 12:51:20.029874 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-23 12:51:20.057273 | debian-bookworm | skipping: Conditional result was False 2025-11-23 12:51:20.063809 | 2025-11-23 12:51:20.063933 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-23 12:51:20.795503 | debian-bookworm | changed 2025-11-23 12:51:20.804408 | 2025-11-23 12:51:20.804566 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-23 12:51:21.130256 | debian-bookworm | ok 2025-11-23 12:51:21.136125 | 2025-11-23 12:51:21.136249 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-23 12:51:21.787839 | debian-bookworm | changed 2025-11-23 12:51:21.798563 | 2025-11-23 12:51:21.798725 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-23 12:51:22.512825 | debian-bookworm | changed 2025-11-23 12:51:22.527250 | 2025-11-23 12:51:22.527384 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-23 12:51:22.569356 | debian-bookworm | skipping: Conditional result was False 2025-11-23 12:51:22.576395 | 2025-11-23 12:51:22.576521 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-23 12:51:23.465859 | debian-bookworm -> localhost | changed 2025-11-23 12:51:23.498796 | 2025-11-23 12:51:23.499059 | TASK [add-build-sshkey : Add back temp key] 2025-11-23 12:51:24.064381 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/d4de7cd7aae8456aa0e32c111f40d280/work/d4de7cd7aae8456aa0e32c111f40d280_id_rsa (zuul-build-sshkey) 2025-11-23 12:51:24.064639 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.016744 2025-11-23 12:51:24.073948 | 2025-11-23 12:51:24.074136 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-23 12:51:24.554458 | debian-bookworm | ok 2025-11-23 12:51:24.559901 | 2025-11-23 12:51:24.560028 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-23 12:51:24.618977 | debian-bookworm | skipping: Conditional result was False 2025-11-23 12:51:24.648409 | 2025-11-23 12:51:24.648551 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-23 12:51:25.292444 | debian-bookworm | ok 2025-11-23 12:51:25.305187 | 2025-11-23 12:51:25.305325 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-23 12:51:25.361806 | debian-bookworm | ok 2025-11-23 12:51:25.368599 | 2025-11-23 12:51:25.368722 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-23 12:51:25.704541 | debian-bookworm -> localhost | ok 2025-11-23 12:51:25.717135 | 2025-11-23 12:51:25.717418 | TASK [validate-host : Collect information about the host] 2025-11-23 12:51:27.023890 | debian-bookworm | ok 2025-11-23 12:51:27.047342 | 2025-11-23 12:51:27.047488 | TASK [validate-host : Sanitize hostname] 2025-11-23 12:51:27.209253 | debian-bookworm | ok 2025-11-23 12:51:27.284304 | 2025-11-23 12:51:27.284451 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-23 12:51:28.029802 | debian-bookworm -> localhost | changed 2025-11-23 12:51:28.036118 | 2025-11-23 12:51:28.036309 | TASK [validate-host : Collect information about zuul worker] 2025-11-23 12:51:28.612507 | debian-bookworm | ok 2025-11-23 12:51:28.617367 | 2025-11-23 12:51:28.617486 | TASK [validate-host : Write out all zuul information for each host] 2025-11-23 12:51:29.494912 | debian-bookworm -> localhost | changed 2025-11-23 12:51:29.517642 | 2025-11-23 12:51:29.517869 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-23 12:51:29.804532 | debian-bookworm | ok 2025-11-23 12:51:29.814395 | 2025-11-23 12:51:29.814532 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-23 12:51:31.018310 | debian-bookworm | changed: 2025-11-23 12:51:31.018533 | debian-bookworm | cd+++++++++ src/ 2025-11-23 12:51:31.018571 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-23 12:51:31.018596 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-23 12:51:31.018619 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-11-23 12:51:31.018640 | debian-bookworm | Containerfile 2025-11-23 12:51:31.018756 | debian-bookworm | Containerfile 2025-11-23 12:51:31.039394 | debian-bookworm | localhost | ok: Runtime: 0:00:00.005105 2025-11-23 12:52:00.305768 | 2025-11-23 12:52:00.305920 | TASK [upload-logs : Upload logs to log server] 2025-11-23 12:52:01.038819 | localhost | Output suppressed because no_log was given 2025-11-23 12:52:01.043448 | 2025-11-23 12:52:01.043568 | LOOP [upload-logs : Compress console log and json output] 2025-11-23 12:52:01.124590 | localhost | skipping: Conditional result was False 2025-11-23 12:52:01.129491 | localhost | skipping: Conditional result was False 2025-11-23 12:52:01.143408 | 2025-11-23 12:52:01.143538 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-23 12:52:01.227760 | localhost | skipping: Conditional result was False 2025-11-23 12:52:01.228273 | 2025-11-23 12:52:01.238686 | localhost | skipping: Conditional result was False 2025-11-23 12:52:01.243653 | 2025-11-23 12:52:01.243780 | LOOP [upload-logs : Upload console log and json output]