2026-01-23 18:34:21.118136 | Job console starting 2026-01-23 18:34:21.130483 | Updating git repos 2026-01-23 18:34:21.155760 | Cloning repos into workspace 2026-01-23 18:34:21.229484 | Restoring repo states 2026-01-23 18:34:21.237955 | Merging changes 2026-01-23 18:34:21.882878 | Checking out repos 2026-01-23 18:34:21.967168 | Preparing playbooks 2026-01-23 18:34:22.693628 | Running Ansible setup 2026-01-23 18:34:27.221095 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-01-23 18:34:28.091627 | 2026-01-23 18:34:28.091757 | PLAY [Base pre] 2026-01-23 18:34:28.128478 | 2026-01-23 18:34:28.128612 | TASK [Setup log path fact] 2026-01-23 18:34:28.164501 | debian-bookworm | ok 2026-01-23 18:34:28.186568 | 2026-01-23 18:34:28.186782 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-23 18:34:28.253743 | debian-bookworm | ok 2026-01-23 18:34:28.279499 | 2026-01-23 18:34:28.279613 | TASK [emit-job-header : Print job information] 2026-01-23 18:34:28.347775 | # Job Information 2026-01-23 18:34:28.347925 | Ansible Version: 2.16.14 2026-01-23 18:34:28.347960 | Job: python-black 2026-01-23 18:34:28.347993 | Pipeline: check 2026-01-23 18:34:28.348016 | Executor: 521e9411259a 2026-01-23 18:34:28.348037 | Triggered by: https://github.com/osism/python-osism/pull/1711 2026-01-23 18:34:28.348060 | Event ID: 05dd4d50-f88a-11f0-9222-5cb32a2eb610 2026-01-23 18:34:28.352943 | 2026-01-23 18:34:28.353037 | LOOP [emit-job-header : Print node information] 2026-01-23 18:34:28.495890 | debian-bookworm | ok: 2026-01-23 18:34:28.496056 | debian-bookworm | # Node Information 2026-01-23 18:34:28.496091 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-01-23 18:34:28.496117 | debian-bookworm | Hostname: debian 2026-01-23 18:34:28.496139 | debian-bookworm | Username: zuul 2026-01-23 18:34:28.496161 | debian-bookworm | Distro: Debian 12.13 2026-01-23 18:34:28.496184 | debian-bookworm | Provider: regiocloud-a 2026-01-23 18:34:28.496205 | debian-bookworm | Region: 2026-01-23 18:34:28.496226 | debian-bookworm | Label: debian-bookworm 2026-01-23 18:34:28.496246 | debian-bookworm | Product Name: OpenStack Nova 2026-01-23 18:34:28.496278 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fec2:132c 2026-01-23 18:34:28.506790 | 2026-01-23 18:34:28.506931 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-01-23 18:34:29.059110 | debian-bookworm -> localhost | changed 2026-01-23 18:34:29.066051 | 2026-01-23 18:34:29.066168 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-01-23 18:34:30.236194 | debian-bookworm -> localhost | changed 2026-01-23 18:34:30.247991 | 2026-01-23 18:34:30.248107 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-01-23 18:34:30.897995 | debian-bookworm -> localhost | ok 2026-01-23 18:34:30.905517 | 2026-01-23 18:34:30.905645 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-01-23 18:34:30.979439 | debian-bookworm | ok 2026-01-23 18:34:31.003128 | debian-bookworm | included: /var/lib/zuul/builds/51cb1954777a4e959d6795eb2634639e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-01-23 18:34:31.009866 | 2026-01-23 18:34:31.009972 | TASK [add-build-sshkey : Create Temp SSH key] 2026-01-23 18:34:32.755451 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-01-23 18:34:32.755778 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/51cb1954777a4e959d6795eb2634639e/work/51cb1954777a4e959d6795eb2634639e_id_rsa 2026-01-23 18:34:32.755825 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/51cb1954777a4e959d6795eb2634639e/work/51cb1954777a4e959d6795eb2634639e_id_rsa.pub 2026-01-23 18:34:32.755853 | debian-bookworm -> localhost | The key fingerprint is: 2026-01-23 18:34:32.755881 | debian-bookworm -> localhost | SHA256:4FDpwRRBkojrZFm6btP26+X3mASIVhSVgXBdm7FN+YI zuul-build-sshkey 2026-01-23 18:34:32.755906 | debian-bookworm -> localhost | The key's randomart image is: 2026-01-23 18:34:32.755939 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-01-23 18:34:32.755963 | debian-bookworm -> localhost | | . ooO@*+o .. | 2026-01-23 18:34:32.755988 | debian-bookworm -> localhost | |. ..+++o B. | 2026-01-23 18:34:32.756011 | debian-bookworm -> localhost | | .+ .o.. +... | 2026-01-23 18:34:32.756034 | debian-bookworm -> localhost | |.= ooo. E . . | 2026-01-23 18:34:32.756056 | debian-bookworm -> localhost | |+ .o ...S . | 2026-01-23 18:34:32.756086 | debian-bookworm -> localhost | | o. . | 2026-01-23 18:34:32.756109 | debian-bookworm -> localhost | |. . . . | 2026-01-23 18:34:32.756130 | debian-bookworm -> localhost | | + o o ..o | 2026-01-23 18:34:32.756153 | debian-bookworm -> localhost | |. o o+...o.. | 2026-01-23 18:34:32.756175 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-01-23 18:34:32.756241 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.929099 2026-01-23 18:34:32.769424 | 2026-01-23 18:34:32.769559 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-01-23 18:34:32.830433 | debian-bookworm | ok 2026-01-23 18:34:32.855671 | debian-bookworm | included: /var/lib/zuul/builds/51cb1954777a4e959d6795eb2634639e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-01-23 18:34:32.886289 | 2026-01-23 18:34:32.886439 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-01-23 18:34:32.924725 | debian-bookworm | skipping: Conditional result was False 2026-01-23 18:34:32.931702 | 2026-01-23 18:34:32.931834 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-01-23 18:34:33.669121 | debian-bookworm | changed 2026-01-23 18:34:33.673747 | 2026-01-23 18:34:33.673828 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-01-23 18:34:33.985222 | debian-bookworm | ok 2026-01-23 18:34:33.992023 | 2026-01-23 18:34:33.992500 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-01-23 18:34:34.861744 | debian-bookworm | changed 2026-01-23 18:34:34.870807 | 2026-01-23 18:34:34.870921 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-01-23 18:34:35.701797 | debian-bookworm | changed 2026-01-23 18:34:35.722984 | 2026-01-23 18:34:35.723104 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-01-23 18:34:35.766822 | debian-bookworm | skipping: Conditional result was False 2026-01-23 18:34:35.772931 | 2026-01-23 18:34:35.773086 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-01-23 18:34:36.972568 | debian-bookworm -> localhost | changed 2026-01-23 18:34:36.992974 | 2026-01-23 18:34:36.993076 | TASK [add-build-sshkey : Add back temp key] 2026-01-23 18:34:37.910635 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/51cb1954777a4e959d6795eb2634639e/work/51cb1954777a4e959d6795eb2634639e_id_rsa (zuul-build-sshkey) 2026-01-23 18:34:37.910865 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.050244 2026-01-23 18:34:37.939446 | 2026-01-23 18:34:37.939581 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-01-23 18:34:38.691586 | debian-bookworm | ok 2026-01-23 18:34:38.696667 | 2026-01-23 18:34:38.696761 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-01-23 18:34:38.733471 | debian-bookworm | skipping: Conditional result was False 2026-01-23 18:34:38.743882 | 2026-01-23 18:34:38.743992 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-01-23 18:34:39.257151 | debian-bookworm | ok 2026-01-23 18:34:39.298580 | 2026-01-23 18:34:39.298752 | TASK [validate-host : Define zuul_info_dir fact] 2026-01-23 18:34:39.368235 | debian-bookworm | ok 2026-01-23 18:34:39.378993 | 2026-01-23 18:34:39.379139 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-01-23 18:34:40.078615 | debian-bookworm -> localhost | ok 2026-01-23 18:34:40.086445 | 2026-01-23 18:34:40.086542 | TASK [validate-host : Collect information about the host] 2026-01-23 18:34:41.356444 | debian-bookworm | ok 2026-01-23 18:34:41.372627 | 2026-01-23 18:34:41.372733 | TASK [validate-host : Sanitize hostname] 2026-01-23 18:34:41.466813 | debian-bookworm | ok 2026-01-23 18:34:41.514694 | 2026-01-23 18:34:41.514806 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-01-23 18:34:42.084774 | debian-bookworm -> localhost | changed 2026-01-23 18:34:42.089479 | 2026-01-23 18:34:42.089567 | TASK [validate-host : Collect information about zuul worker] 2026-01-23 18:34:42.552152 | debian-bookworm | ok 2026-01-23 18:34:42.557132 | 2026-01-23 18:34:42.557290 | TASK [validate-host : Write out all zuul information for each host] 2026-01-23 18:34:43.300220 | debian-bookworm -> localhost | changed 2026-01-23 18:34:43.320912 | 2026-01-23 18:34:43.321015 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-01-23 18:34:43.650928 | debian-bookworm | ok 2026-01-23 18:34:43.656035 | 2026-01-23 18:34:43.656122 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-01-23 18:34:44.919134 | debian-bookworm | changed: 2026-01-23 18:34:44.919338 | debian-bookworm | cd+++++++++ src/ 2026-01-23 18:34:44.919376 | debian-bookworm | cd+++++++++ src/github.com/ 2026-01-23 18:34:44.919402 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-01-23 18:34:44.919424 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-01-23 18:34:44.919445 | debian-bookworm | Containerfile 2026-01-23 18:34:44.919589 | debian-bookworm | Containerfile 2026-01-23 18:34:44.941421 | debian-bookworm | localhost | ok: Runtime: 0:00:00.030999 2026-01-23 18:35:14.915940 | 2026-01-23 18:35:14.916021 | TASK [upload-logs : Upload logs to log server] 2026-01-23 18:35:15.581245 | localhost | Output suppressed because no_log was given 2026-01-23 18:35:15.582626 | 2026-01-23 18:35:15.582694 | LOOP [upload-logs : Compress console log and json output] 2026-01-23 18:35:15.627851 | localhost | skipping: Conditional result was False 2026-01-23 18:35:15.634134 | localhost | skipping: Conditional result was False 2026-01-23 18:35:15.637171 | 2026-01-23 18:35:15.637270 | LOOP [upload-logs : Upload compressed console log and json output] 2026-01-23 18:35:15.715947 | localhost | skipping: Conditional result was False 2026-01-23 18:35:15.716148 | 2026-01-23 18:35:15.722298 | localhost | skipping: Conditional result was False 2026-01-23 18:35:15.732065 | 2026-01-23 18:35:15.732144 | LOOP [upload-logs : Upload console log and json output]