2025-12-18 13:48:16.001044 | Job console starting 2025-12-18 13:48:16.040241 | Updating git repos 2025-12-18 13:48:16.151657 | Cloning repos into workspace 2025-12-18 13:48:16.269343 | Restoring repo states 2025-12-18 13:48:16.293481 | Merging changes 2025-12-18 13:48:17.003886 | Checking out repos 2025-12-18 13:48:17.134654 | Preparing playbooks 2025-12-18 13:48:18.571476 | Running Ansible setup 2025-12-18 13:48:25.174075 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-18 13:48:26.781478 | 2025-12-18 13:48:26.781696 | PLAY [Base pre] 2025-12-18 13:48:26.820573 | 2025-12-18 13:48:26.820793 | TASK [Setup log path fact] 2025-12-18 13:48:26.852751 | debian-bookworm | ok 2025-12-18 13:48:26.888687 | 2025-12-18 13:48:26.888884 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-18 13:48:26.972859 | debian-bookworm | ok 2025-12-18 13:48:26.986583 | 2025-12-18 13:48:26.986783 | TASK [emit-job-header : Print job information] 2025-12-18 13:48:27.031884 | # Job Information 2025-12-18 13:48:27.032081 | Ansible Version: 2.16.14 2025-12-18 13:48:27.032118 | Job: python-black 2025-12-18 13:48:27.032152 | Pipeline: check 2025-12-18 13:48:27.032175 | Executor: 521e9411259a 2025-12-18 13:48:27.032196 | Triggered by: https://github.com/osism/python-osism/pull/1714 2025-12-18 13:48:27.032220 | Event ID: 2dfda9d0-dc18-11f0-914b-90a333f1b853 2025-12-18 13:48:27.037756 | 2025-12-18 13:48:27.037894 | LOOP [emit-job-header : Print node information] 2025-12-18 13:48:27.187093 | debian-bookworm | ok: 2025-12-18 13:48:27.187326 | debian-bookworm | # Node Information 2025-12-18 13:48:27.187364 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-18 13:48:27.187390 | debian-bookworm | Hostname: debian 2025-12-18 13:48:27.187412 | debian-bookworm | Username: zuul 2025-12-18 13:48:27.187433 | debian-bookworm | Distro: Debian 12.12 2025-12-18 13:48:27.187456 | debian-bookworm | Provider: regiocloud-a 2025-12-18 13:48:27.187478 | debian-bookworm | Region: 2025-12-18 13:48:27.187499 | debian-bookworm | Label: debian-bookworm 2025-12-18 13:48:27.187519 | debian-bookworm | Product Name: OpenStack Nova 2025-12-18 13:48:27.187538 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feb3:8fc 2025-12-18 13:48:27.205987 | 2025-12-18 13:48:27.206143 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-18 13:48:28.413939 | debian-bookworm -> localhost | changed 2025-12-18 13:48:28.422694 | 2025-12-18 13:48:28.422902 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-18 13:48:30.573467 | debian-bookworm -> localhost | changed 2025-12-18 13:48:30.587713 | 2025-12-18 13:48:30.587917 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-18 13:48:31.183844 | debian-bookworm -> localhost | ok 2025-12-18 13:48:31.189680 | 2025-12-18 13:48:31.189787 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-18 13:48:31.247556 | debian-bookworm | ok 2025-12-18 13:48:31.286226 | debian-bookworm | included: /var/lib/zuul/builds/64182ce42f354214a5295bef684ab415/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-18 13:48:31.305498 | 2025-12-18 13:48:31.305632 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-18 13:48:33.486844 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-18 13:48:33.487113 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/64182ce42f354214a5295bef684ab415/work/64182ce42f354214a5295bef684ab415_id_rsa 2025-12-18 13:48:33.487173 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/64182ce42f354214a5295bef684ab415/work/64182ce42f354214a5295bef684ab415_id_rsa.pub 2025-12-18 13:48:33.487208 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-18 13:48:33.487253 | debian-bookworm -> localhost | SHA256:3pm5FhgVOItTNh1CBW7TBLDBXd4UvfwVREr22I1hcqs zuul-build-sshkey 2025-12-18 13:48:33.487282 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-18 13:48:33.487320 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-18 13:48:33.487347 | debian-bookworm -> localhost | | .o+=B*o+=*o | 2025-12-18 13:48:33.487375 | debian-bookworm -> localhost | | .+B=ooo+*=.| 2025-12-18 13:48:33.487400 | debian-bookworm -> localhost | | .++=o .+o+o| 2025-12-18 13:48:33.487425 | debian-bookworm -> localhost | | o.o. .o .| 2025-12-18 13:48:33.487450 | debian-bookworm -> localhost | | .So E ..| 2025-12-18 13:48:33.487479 | debian-bookworm -> localhost | | ....+ .| 2025-12-18 13:48:33.487505 | debian-bookworm -> localhost | | . =. | 2025-12-18 13:48:33.487530 | debian-bookworm -> localhost | | .. | 2025-12-18 13:48:33.487556 | debian-bookworm -> localhost | | .. | 2025-12-18 13:48:33.487581 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-18 13:48:33.487672 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.374438 2025-12-18 13:48:33.496026 | 2025-12-18 13:48:33.496132 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-18 13:48:33.514482 | debian-bookworm | ok 2025-12-18 13:48:33.525573 | debian-bookworm | included: /var/lib/zuul/builds/64182ce42f354214a5295bef684ab415/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-18 13:48:33.534748 | 2025-12-18 13:48:33.534861 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-18 13:48:33.557793 | debian-bookworm | skipping: Conditional result was False 2025-12-18 13:48:33.563756 | 2025-12-18 13:48:33.563860 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-18 13:48:34.235399 | debian-bookworm | changed 2025-12-18 13:48:34.243729 | 2025-12-18 13:48:34.243843 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-18 13:48:34.506153 | debian-bookworm | ok 2025-12-18 13:48:34.516563 | 2025-12-18 13:48:34.516787 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-18 13:48:35.190347 | debian-bookworm | changed 2025-12-18 13:48:35.197650 | 2025-12-18 13:48:35.197800 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-18 13:48:35.859900 | debian-bookworm | changed 2025-12-18 13:48:35.865719 | 2025-12-18 13:48:35.865836 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-18 13:48:35.889851 | debian-bookworm | skipping: Conditional result was False 2025-12-18 13:48:35.896971 | 2025-12-18 13:48:35.897105 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-18 13:48:36.906158 | debian-bookworm -> localhost | changed 2025-12-18 13:48:36.920487 | 2025-12-18 13:48:36.920650 | TASK [add-build-sshkey : Add back temp key] 2025-12-18 13:48:37.412372 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/64182ce42f354214a5295bef684ab415/work/64182ce42f354214a5295bef684ab415_id_rsa (zuul-build-sshkey) 2025-12-18 13:48:37.412660 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.014086 2025-12-18 13:48:37.421025 | 2025-12-18 13:48:37.421151 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-18 13:48:37.912958 | debian-bookworm | ok 2025-12-18 13:48:37.919887 | 2025-12-18 13:48:37.920027 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-18 13:48:37.964585 | debian-bookworm | skipping: Conditional result was False 2025-12-18 13:48:37.976288 | 2025-12-18 13:48:37.976421 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-18 13:48:38.604567 | debian-bookworm | ok 2025-12-18 13:48:38.637252 | 2025-12-18 13:48:38.637409 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-18 13:48:38.694625 | debian-bookworm | ok 2025-12-18 13:48:38.700156 | 2025-12-18 13:48:38.700315 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-18 13:48:39.197991 | debian-bookworm -> localhost | ok 2025-12-18 13:48:39.204970 | 2025-12-18 13:48:39.205113 | TASK [validate-host : Collect information about the host] 2025-12-18 13:48:40.605407 | debian-bookworm | ok 2025-12-18 13:48:40.629209 | 2025-12-18 13:48:40.629349 | TASK [validate-host : Sanitize hostname] 2025-12-18 13:48:40.811653 | debian-bookworm | ok 2025-12-18 13:48:40.908166 | 2025-12-18 13:48:40.908310 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-18 13:48:41.830884 | debian-bookworm -> localhost | changed 2025-12-18 13:48:41.856081 | 2025-12-18 13:48:41.856226 | TASK [validate-host : Collect information about zuul worker] 2025-12-18 13:48:42.443173 | debian-bookworm | ok 2025-12-18 13:48:42.448289 | 2025-12-18 13:48:42.448411 | TASK [validate-host : Write out all zuul information for each host] 2025-12-18 13:48:43.475669 | debian-bookworm -> localhost | changed 2025-12-18 13:48:43.485893 | 2025-12-18 13:48:43.486034 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-18 13:48:43.783258 | debian-bookworm | ok 2025-12-18 13:48:43.789470 | 2025-12-18 13:48:43.789623 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-18 13:48:45.015168 | debian-bookworm | changed: 2025-12-18 13:48:45.015383 | debian-bookworm | cd+++++++++ src/ 2025-12-18 13:48:45.015418 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-18 13:48:45.015443 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-18 13:48:45.015464 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-12-18 13:48:45.015484 | debian-bookworm | Containerfile 2025-12-18 13:48:45.015655 | debian-bookworm | Containerfile 2025-12-18 13:48:45.022506 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006931 2025-12-18 13:49:14.262991 | 2025-12-18 13:49:14.263192 | TASK [upload-logs : Upload logs to log server] 2025-12-18 13:49:14.908950 | localhost | Output suppressed because no_log was given 2025-12-18 13:49:14.911083 | 2025-12-18 13:49:14.911200 | LOOP [upload-logs : Compress console log and json output] 2025-12-18 13:49:14.962754 | localhost | skipping: Conditional result was False 2025-12-18 13:49:14.969717 | localhost | skipping: Conditional result was False 2025-12-18 13:49:14.982088 | 2025-12-18 13:49:14.982275 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-18 13:49:15.034523 | localhost | skipping: Conditional result was False 2025-12-18 13:49:15.035072 | 2025-12-18 13:49:15.038213 | localhost | skipping: Conditional result was False 2025-12-18 13:49:15.049637 | 2025-12-18 13:49:15.049909 | LOOP [upload-logs : Upload console log and json output]