2025-11-19 03:15:29.289030 | Job console starting 2025-11-19 03:15:29.306564 | Updating git repos 2025-11-19 03:15:29.336401 | Cloning repos into workspace 2025-11-19 03:15:29.424379 | Restoring repo states 2025-11-19 03:15:29.431921 | Merging changes 2025-11-19 03:15:29.431938 | Checking out repos 2025-11-19 03:15:29.488517 | Preparing playbooks 2025-11-19 03:15:30.316654 | Running Ansible setup 2025-11-19 03:15:34.958289 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-19 03:15:35.872868 | 2025-11-19 03:15:35.873037 | PLAY [Base pre] 2025-11-19 03:15:35.890242 | 2025-11-19 03:15:35.890471 | TASK [Setup log path fact] 2025-11-19 03:15:35.922686 | debian-bookworm | ok 2025-11-19 03:15:35.938699 | 2025-11-19 03:15:35.938888 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-19 03:15:35.969814 | debian-bookworm | ok 2025-11-19 03:15:35.979816 | 2025-11-19 03:15:35.979952 | TASK [emit-job-header : Print job information] 2025-11-19 03:15:36.020186 | # Job Information 2025-11-19 03:15:36.020501 | Ansible Version: 2.16.14 2025-11-19 03:15:36.020545 | Job: python-black 2025-11-19 03:15:36.020578 | Pipeline: periodic-daily 2025-11-19 03:15:36.020601 | Executor: 521e9411259a 2025-11-19 03:15:36.020622 | Triggered by: https://github.com/osism/cfg-cookiecutter 2025-11-19 03:15:36.020645 | Event ID: 0269acf2ff35434b9bf224d72b633400 2025-11-19 03:15:36.026002 | 2025-11-19 03:15:36.026121 | LOOP [emit-job-header : Print node information] 2025-11-19 03:15:36.141332 | debian-bookworm | ok: 2025-11-19 03:15:36.141533 | debian-bookworm | # Node Information 2025-11-19 03:15:36.141568 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-19 03:15:36.141593 | debian-bookworm | Hostname: debian 2025-11-19 03:15:36.141615 | debian-bookworm | Username: zuul 2025-11-19 03:15:36.141637 | debian-bookworm | Distro: Debian 12.12 2025-11-19 03:15:36.141660 | debian-bookworm | Provider: regiocloud-a 2025-11-19 03:15:36.141680 | debian-bookworm | Region: 2025-11-19 03:15:36.141701 | debian-bookworm | Label: debian-bookworm 2025-11-19 03:15:36.141720 | debian-bookworm | Product Name: OpenStack Nova 2025-11-19 03:15:36.141739 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe0e:db0c 2025-11-19 03:15:36.156629 | 2025-11-19 03:15:36.156771 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-19 03:15:36.724679 | debian-bookworm -> localhost | changed 2025-11-19 03:15:36.735794 | 2025-11-19 03:15:36.735982 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-19 03:15:37.887328 | debian-bookworm -> localhost | changed 2025-11-19 03:15:37.908479 | 2025-11-19 03:15:37.908628 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-19 03:15:38.221545 | debian-bookworm -> localhost | ok 2025-11-19 03:15:38.228075 | 2025-11-19 03:15:38.228226 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-19 03:15:38.257607 | debian-bookworm | ok 2025-11-19 03:15:38.275571 | debian-bookworm | included: /var/lib/zuul/builds/7240e5b286644f1db297fb73db33be60/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-19 03:15:38.281815 | 2025-11-19 03:15:38.281924 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-19 03:15:39.902502 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-19 03:15:39.902969 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/7240e5b286644f1db297fb73db33be60/work/7240e5b286644f1db297fb73db33be60_id_rsa 2025-11-19 03:15:39.903061 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/7240e5b286644f1db297fb73db33be60/work/7240e5b286644f1db297fb73db33be60_id_rsa.pub 2025-11-19 03:15:39.903143 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-19 03:15:39.903235 | debian-bookworm -> localhost | SHA256:x2YCtUQE/Aq28x73Q5ohcvMAEcFM1MRrSyb7/CcoMBQ zuul-build-sshkey 2025-11-19 03:15:39.903287 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-19 03:15:39.903362 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-19 03:15:39.903414 | debian-bookworm -> localhost | | ==Bo+= | 2025-11-19 03:15:39.903461 | debian-bookworm -> localhost | | E + +o . | 2025-11-19 03:15:39.903505 | debian-bookworm -> localhost | | . ..o. | 2025-11-19 03:15:39.903559 | debian-bookworm -> localhost | | . = =... | 2025-11-19 03:15:39.903601 | debian-bookworm -> localhost | | . . X oS = | 2025-11-19 03:15:39.903656 | debian-bookworm -> localhost | | o = B .=. | 2025-11-19 03:15:39.903704 | debian-bookworm -> localhost | | o B.*.= | 2025-11-19 03:15:39.903757 | debian-bookworm -> localhost | | . =o=.o | 2025-11-19 03:15:39.903803 | debian-bookworm -> localhost | | o...o.. | 2025-11-19 03:15:39.903866 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-19 03:15:39.903989 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.021141 2025-11-19 03:15:39.916148 | 2025-11-19 03:15:39.916322 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-19 03:15:39.947315 | debian-bookworm | ok 2025-11-19 03:15:39.956970 | debian-bookworm | included: /var/lib/zuul/builds/7240e5b286644f1db297fb73db33be60/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-19 03:15:39.966320 | 2025-11-19 03:15:39.966425 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-19 03:15:40.001106 | debian-bookworm | skipping: Conditional result was False 2025-11-19 03:15:40.012586 | 2025-11-19 03:15:40.012742 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-19 03:15:40.676063 | debian-bookworm | changed 2025-11-19 03:15:40.688503 | 2025-11-19 03:15:40.688645 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-19 03:15:40.991749 | debian-bookworm | ok 2025-11-19 03:15:41.005228 | 2025-11-19 03:15:41.005602 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-19 03:15:41.736252 | debian-bookworm | changed 2025-11-19 03:15:41.743871 | 2025-11-19 03:15:41.743999 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-19 03:15:42.468077 | debian-bookworm | changed 2025-11-19 03:15:42.475028 | 2025-11-19 03:15:42.475154 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-19 03:15:42.528317 | debian-bookworm | skipping: Conditional result was False 2025-11-19 03:15:42.536668 | 2025-11-19 03:15:42.536800 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-19 03:15:43.673043 | debian-bookworm -> localhost | changed 2025-11-19 03:15:43.685651 | 2025-11-19 03:15:43.685800 | TASK [add-build-sshkey : Add back temp key] 2025-11-19 03:15:44.425705 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/7240e5b286644f1db297fb73db33be60/work/7240e5b286644f1db297fb73db33be60_id_rsa (zuul-build-sshkey) 2025-11-19 03:15:44.426240 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011522 2025-11-19 03:15:44.435230 | 2025-11-19 03:15:44.435358 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-19 03:15:44.850199 | debian-bookworm | ok 2025-11-19 03:15:44.858729 | 2025-11-19 03:15:44.858907 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-19 03:15:44.893921 | debian-bookworm | skipping: Conditional result was False 2025-11-19 03:15:44.912928 | 2025-11-19 03:15:44.913086 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-19 03:15:45.370697 | debian-bookworm | ok 2025-11-19 03:15:45.397051 | 2025-11-19 03:15:45.397244 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-19 03:15:45.458297 | debian-bookworm | ok 2025-11-19 03:15:45.473325 | 2025-11-19 03:15:45.473497 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-19 03:15:46.033284 | debian-bookworm -> localhost | ok 2025-11-19 03:15:46.040034 | 2025-11-19 03:15:46.040158 | TASK [validate-host : Collect information about the host] 2025-11-19 03:15:47.407158 | debian-bookworm | ok 2025-11-19 03:15:47.426434 | 2025-11-19 03:15:47.426582 | TASK [validate-host : Sanitize hostname] 2025-11-19 03:15:47.555744 | debian-bookworm | ok 2025-11-19 03:15:47.605005 | 2025-11-19 03:15:47.605149 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-19 03:15:48.307527 | debian-bookworm -> localhost | changed 2025-11-19 03:15:48.314736 | 2025-11-19 03:15:48.314935 | TASK [validate-host : Collect information about zuul worker] 2025-11-19 03:15:49.075246 | debian-bookworm | ok 2025-11-19 03:15:49.085364 | 2025-11-19 03:15:49.085583 | TASK [validate-host : Write out all zuul information for each host] 2025-11-19 03:15:50.524854 | debian-bookworm -> localhost | changed 2025-11-19 03:15:50.541387 | 2025-11-19 03:15:50.541528 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-19 03:15:50.814349 | debian-bookworm | ok 2025-11-19 03:15:50.825116 | 2025-11-19 03:15:50.825284 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-19 03:15:52.129915 | debian-bookworm | changed: 2025-11-19 03:15:52.130130 | debian-bookworm | cd+++++++++ src/ 2025-11-19 03:15:52.130166 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-19 03:15:52.130210 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-19 03:15:52.130234 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2025-11-19 03:15:52.130255 | debian-bookworm | Containerfile 2025-11-19 03:15:52.130388 | debian-bookworm | localhost | ok: Runtime: 0:00:00.037402 2025-11-19 03:16:22.918267 | 2025-11-19 03:16:22.919578 | TASK [upload-logs : Upload logs to log server] 2025-11-19 03:16:23.953052 | localhost | Output suppressed because no_log was given 2025-11-19 03:16:23.955142 | 2025-11-19 03:16:23.955269 | LOOP [upload-logs : Compress console log and json output] 2025-11-19 03:16:24.103973 | localhost | skipping: Conditional result was False 2025-11-19 03:16:24.140081 | localhost | skipping: Conditional result was False 2025-11-19 03:16:24.146821 | 2025-11-19 03:16:24.146983 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-19 03:16:24.252361 | localhost | skipping: Conditional result was False 2025-11-19 03:16:24.252753 | 2025-11-19 03:16:24.264328 | localhost | skipping: Conditional result was False 2025-11-19 03:16:24.276488 | 2025-11-19 03:16:24.276646 | LOOP [upload-logs : Upload console log and json output]