2025-12-03 03:14:21.625955 | Job console starting 2025-12-03 03:14:21.637643 | Updating git repos 2025-12-03 03:14:21.699864 | Cloning repos into workspace 2025-12-03 03:14:21.768179 | Restoring repo states 2025-12-03 03:14:21.803203 | Merging changes 2025-12-03 03:14:21.803223 | Checking out repos 2025-12-03 03:14:21.852337 | Preparing playbooks 2025-12-03 03:14:23.205479 | Running Ansible setup 2025-12-03 03:14:30.811308 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-03 03:14:31.675900 | 2025-12-03 03:14:31.676080 | PLAY [Base pre] 2025-12-03 03:14:31.699072 | 2025-12-03 03:14:31.699240 | TASK [Setup log path fact] 2025-12-03 03:14:31.720051 | debian-bookworm | ok 2025-12-03 03:14:31.747860 | 2025-12-03 03:14:31.748027 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-03 03:14:31.822315 | debian-bookworm | ok 2025-12-03 03:14:31.854157 | 2025-12-03 03:14:31.854372 | TASK [emit-job-header : Print job information] 2025-12-03 03:14:31.916308 | # Job Information 2025-12-03 03:14:31.917148 | Ansible Version: 2.16.14 2025-12-03 03:14:31.917196 | Job: python-black 2025-12-03 03:14:31.917230 | Pipeline: periodic-daily 2025-12-03 03:14:31.917252 | Executor: 521e9411259a 2025-12-03 03:14:31.917273 | Triggered by: https://github.com/osism/container-image-osism-ansible 2025-12-03 03:14:31.917296 | Event ID: 6652e61307a2404189c079d7bb541631 2025-12-03 03:14:31.922597 | 2025-12-03 03:14:31.922736 | LOOP [emit-job-header : Print node information] 2025-12-03 03:14:32.135137 | debian-bookworm | ok: 2025-12-03 03:14:32.135348 | debian-bookworm | # Node Information 2025-12-03 03:14:32.135383 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-03 03:14:32.135408 | debian-bookworm | Hostname: debian 2025-12-03 03:14:32.135431 | debian-bookworm | Username: zuul 2025-12-03 03:14:32.135452 | debian-bookworm | Distro: Debian 12.12 2025-12-03 03:14:32.135477 | debian-bookworm | Provider: regiocloud-a 2025-12-03 03:14:32.135514 | debian-bookworm | Region: 2025-12-03 03:14:32.135537 | debian-bookworm | Label: debian-bookworm 2025-12-03 03:14:32.135558 | debian-bookworm | Product Name: OpenStack Nova 2025-12-03 03:14:32.135578 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe5b:558 2025-12-03 03:14:32.150025 | 2025-12-03 03:14:32.150177 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-03 03:14:32.835637 | debian-bookworm -> localhost | changed 2025-12-03 03:14:32.843463 | 2025-12-03 03:14:32.843628 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-03 03:14:34.523242 | debian-bookworm -> localhost | changed 2025-12-03 03:14:34.534435 | 2025-12-03 03:14:34.534603 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-03 03:14:34.850480 | debian-bookworm -> localhost | ok 2025-12-03 03:14:34.857396 | 2025-12-03 03:14:34.857567 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-03 03:14:34.889013 | debian-bookworm | ok 2025-12-03 03:14:34.929109 | debian-bookworm | included: /var/lib/zuul/builds/e46b985bd8ec4e7aa313e7be6e3ef7c3/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-03 03:14:34.940424 | 2025-12-03 03:14:34.940603 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-03 03:14:36.902923 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-03 03:14:36.903196 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/e46b985bd8ec4e7aa313e7be6e3ef7c3/work/e46b985bd8ec4e7aa313e7be6e3ef7c3_id_rsa 2025-12-03 03:14:36.903238 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/e46b985bd8ec4e7aa313e7be6e3ef7c3/work/e46b985bd8ec4e7aa313e7be6e3ef7c3_id_rsa.pub 2025-12-03 03:14:36.903265 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-03 03:14:36.903296 | debian-bookworm -> localhost | SHA256:AYlKiE2hO03TJmzk3tbpmNzzRNdBJawIC1ed7S1byjs zuul-build-sshkey 2025-12-03 03:14:36.903330 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-03 03:14:36.903367 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-03 03:14:36.903390 | debian-bookworm -> localhost | |.++. ..o.. +o.. | 2025-12-03 03:14:36.903412 | debian-bookworm -> localhost | |o=o.o +. o.o. | 2025-12-03 03:14:36.903433 | debian-bookworm -> localhost | |..B.oo o.. o.. | 2025-12-03 03:14:36.903453 | debian-bookworm -> localhost | | *.= .......o.o | 2025-12-03 03:14:36.903474 | debian-bookworm -> localhost | |o o o o S ...= | 2025-12-03 03:14:36.903542 | debian-bookworm -> localhost | | . o = . . + | 2025-12-03 03:14:36.903566 | debian-bookworm -> localhost | | + + . . | 2025-12-03 03:14:36.903586 | debian-bookworm -> localhost | | + E | 2025-12-03 03:14:36.903607 | debian-bookworm -> localhost | | . . | 2025-12-03 03:14:36.903627 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-03 03:14:36.903694 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.953994 2025-12-03 03:14:36.911077 | 2025-12-03 03:14:36.911211 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-03 03:14:36.954923 | debian-bookworm | ok 2025-12-03 03:14:36.988950 | debian-bookworm | included: /var/lib/zuul/builds/e46b985bd8ec4e7aa313e7be6e3ef7c3/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-03 03:14:37.009156 | 2025-12-03 03:14:37.009303 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-03 03:14:37.034346 | debian-bookworm | skipping: Conditional result was False 2025-12-03 03:14:37.041103 | 2025-12-03 03:14:37.041234 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-03 03:14:37.750381 | debian-bookworm | changed 2025-12-03 03:14:37.758560 | 2025-12-03 03:14:37.758691 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-03 03:14:38.038692 | debian-bookworm | ok 2025-12-03 03:14:38.049320 | 2025-12-03 03:14:38.049482 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-03 03:14:38.736798 | debian-bookworm | changed 2025-12-03 03:14:38.744012 | 2025-12-03 03:14:38.744142 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-03 03:14:39.470939 | debian-bookworm | changed 2025-12-03 03:14:39.486004 | 2025-12-03 03:14:39.486146 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-03 03:14:39.511148 | debian-bookworm | skipping: Conditional result was False 2025-12-03 03:14:39.517979 | 2025-12-03 03:14:39.518107 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-03 03:14:40.390462 | debian-bookworm -> localhost | changed 2025-12-03 03:14:40.424700 | 2025-12-03 03:14:40.424847 | TASK [add-build-sshkey : Add back temp key] 2025-12-03 03:14:41.152410 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/e46b985bd8ec4e7aa313e7be6e3ef7c3/work/e46b985bd8ec4e7aa313e7be6e3ef7c3_id_rsa (zuul-build-sshkey) 2025-12-03 03:14:41.152708 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.017701 2025-12-03 03:14:41.177251 | 2025-12-03 03:14:41.177439 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-03 03:14:41.826718 | debian-bookworm | ok 2025-12-03 03:14:41.842251 | 2025-12-03 03:14:41.842398 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-03 03:14:41.939606 | debian-bookworm | skipping: Conditional result was False 2025-12-03 03:14:41.970470 | 2025-12-03 03:14:41.971143 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-03 03:14:42.849692 | debian-bookworm | ok 2025-12-03 03:14:42.868552 | 2025-12-03 03:14:42.868695 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-03 03:14:42.928598 | debian-bookworm | ok 2025-12-03 03:14:42.934621 | 2025-12-03 03:14:42.934761 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-03 03:14:43.519781 | debian-bookworm -> localhost | ok 2025-12-03 03:14:43.526847 | 2025-12-03 03:14:43.526980 | TASK [validate-host : Collect information about the host] 2025-12-03 03:14:44.705936 | debian-bookworm | ok 2025-12-03 03:14:44.743803 | 2025-12-03 03:14:44.743960 | TASK [validate-host : Sanitize hostname] 2025-12-03 03:14:45.029012 | debian-bookworm | ok 2025-12-03 03:14:45.166203 | 2025-12-03 03:14:45.166879 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-03 03:14:46.411324 | debian-bookworm -> localhost | changed 2025-12-03 03:14:46.417381 | 2025-12-03 03:14:46.417522 | TASK [validate-host : Collect information about zuul worker] 2025-12-03 03:14:47.011626 | debian-bookworm | ok 2025-12-03 03:14:47.018938 | 2025-12-03 03:14:47.019073 | TASK [validate-host : Write out all zuul information for each host] 2025-12-03 03:14:47.696016 | debian-bookworm -> localhost | changed 2025-12-03 03:14:47.714689 | 2025-12-03 03:14:47.714852 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-03 03:14:48.039302 | debian-bookworm | ok 2025-12-03 03:14:48.047901 | 2025-12-03 03:14:48.048052 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-03 03:14:49.405268 | debian-bookworm | changed: 2025-12-03 03:14:49.405569 | debian-bookworm | cd+++++++++ src/ 2025-12-03 03:14:49.405613 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-03 03:14:49.405638 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-03 03:14:49.405660 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-osism-ansible/ 2025-12-03 03:14:49.405680 | debian-bookworm | Containerfile 2025-12-03 03:14:49.405812 | debian-bookworm | localhost | ok: Runtime: 0:00:00.029586 2025-12-03 03:15:20.139147 | 2025-12-03 03:15:20.139356 | TASK [upload-logs : Upload logs to log server] 2025-12-03 03:15:20.967313 | localhost | Output suppressed because no_log was given 2025-12-03 03:15:20.968996 | 2025-12-03 03:15:20.969084 | LOOP [upload-logs : Compress console log and json output] 2025-12-03 03:15:21.028428 | localhost | skipping: Conditional result was False 2025-12-03 03:15:21.034776 | localhost | skipping: Conditional result was False 2025-12-03 03:15:21.044995 | 2025-12-03 03:15:21.045100 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-03 03:15:21.136991 | localhost | skipping: Conditional result was False 2025-12-03 03:15:21.137218 | 2025-12-03 03:15:21.149335 | localhost | skipping: Conditional result was False 2025-12-03 03:15:21.161116 | 2025-12-03 03:15:21.161226 | LOOP [upload-logs : Upload console log and json output]