2025-09-23 00:00:08.390008 | Job console starting 2025-09-23 00:00:08.400393 | Updating git repos 2025-09-23 00:00:08.625017 | Cloning repos into workspace 2025-09-23 00:00:08.675137 | Restoring repo states 2025-09-23 00:00:08.692552 | Merging changes 2025-09-23 00:00:08.692576 | Checking out repos 2025-09-23 00:00:08.750640 | Preparing playbooks 2025-09-23 00:00:09.305336 | Running Ansible setup 2025-09-23 00:00:13.691002 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-23 00:00:14.621520 | 2025-09-23 00:00:14.621652 | PLAY [Base pre] 2025-09-23 00:00:14.641508 | 2025-09-23 00:00:14.641781 | TASK [Setup log path fact] 2025-09-23 00:00:14.672893 | debian-bookworm | ok 2025-09-23 00:00:14.694001 | 2025-09-23 00:00:14.694242 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-23 00:00:14.747435 | debian-bookworm | ok 2025-09-23 00:00:14.764212 | 2025-09-23 00:00:14.764328 | TASK [emit-job-header : Print job information] 2025-09-23 00:00:14.828819 | # Job Information 2025-09-23 00:00:14.828990 | Ansible Version: 2.16.14 2025-09-23 00:00:14.829025 | Job: container-image-kolla-ansible-push-2024.2 2025-09-23 00:00:14.829058 | Pipeline: periodic-midnight 2025-09-23 00:00:14.829080 | Executor: 521e9411259a 2025-09-23 00:00:14.829100 | Triggered by: https://github.com/osism/container-image-kolla-ansible 2025-09-23 00:00:14.829122 | Event ID: 9307d15195034256902635008fb018ba 2025-09-23 00:00:14.834336 | 2025-09-23 00:00:14.834438 | LOOP [emit-job-header : Print node information] 2025-09-23 00:00:14.963971 | debian-bookworm | ok: 2025-09-23 00:00:14.964181 | debian-bookworm | # Node Information 2025-09-23 00:00:14.964217 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-23 00:00:14.964243 | debian-bookworm | Hostname: debian 2025-09-23 00:00:14.964266 | debian-bookworm | Username: zuul 2025-09-23 00:00:14.964287 | debian-bookworm | Distro: Debian 12.12 2025-09-23 00:00:14.964310 | debian-bookworm | Provider: regiocloud-a 2025-09-23 00:00:14.964332 | debian-bookworm | Region: 2025-09-23 00:00:14.964353 | debian-bookworm | Label: debian-bookworm 2025-09-23 00:00:14.964374 | debian-bookworm | Product Name: OpenStack Nova 2025-09-23 00:00:14.964394 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe8c:e208 2025-09-23 00:00:14.988622 | 2025-09-23 00:00:14.988740 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-23 00:00:15.711186 | debian-bookworm -> localhost | changed 2025-09-23 00:00:15.718076 | 2025-09-23 00:00:15.718179 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-23 00:00:17.818607 | debian-bookworm -> localhost | changed 2025-09-23 00:00:17.830368 | 2025-09-23 00:00:17.830470 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-23 00:00:18.202851 | debian-bookworm -> localhost | ok 2025-09-23 00:00:18.208023 | 2025-09-23 00:00:18.208108 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-23 00:00:18.244634 | debian-bookworm | ok 2025-09-23 00:00:18.292423 | debian-bookworm | included: /var/lib/zuul/builds/bd8d287601fa47d7aa50829bdbcef684/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-23 00:00:18.305654 | 2025-09-23 00:00:18.305751 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-23 00:00:24.680840 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-23 00:00:24.681031 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/bd8d287601fa47d7aa50829bdbcef684/work/bd8d287601fa47d7aa50829bdbcef684_id_rsa 2025-09-23 00:00:24.681064 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/bd8d287601fa47d7aa50829bdbcef684/work/bd8d287601fa47d7aa50829bdbcef684_id_rsa.pub 2025-09-23 00:00:24.681087 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-23 00:00:24.681107 | debian-bookworm -> localhost | SHA256:eS4ohpZBS9SeOpxHcltZHVc5t7K6jzTYugcuzcQaB5o zuul-build-sshkey 2025-09-23 00:00:24.681136 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-23 00:00:24.681156 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-23 00:00:24.681174 | debian-bookworm -> localhost | | .. ....... | 2025-09-23 00:00:24.681192 | debian-bookworm -> localhost | | . . . .. o .| 2025-09-23 00:00:24.681209 | debian-bookworm -> localhost | | o. . o o.| 2025-09-23 00:00:24.681226 | debian-bookworm -> localhost | | o..= o. . . . | 2025-09-23 00:00:24.681242 | debian-bookworm -> localhost | | .o* oo S . o | 2025-09-23 00:00:24.681263 | debian-bookworm -> localhost | | =+oE o Bo . | 2025-09-23 00:00:24.681279 | debian-bookworm -> localhost | | +oo . X.o+. | 2025-09-23 00:00:24.681296 | debian-bookworm -> localhost | | . . . o =ooo | 2025-09-23 00:00:24.681313 | debian-bookworm -> localhost | | .oooo. | 2025-09-23 00:00:24.681330 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-23 00:00:24.681373 | debian-bookworm -> localhost | ok: Runtime: 0:00:04.745609 2025-09-23 00:00:24.686484 | 2025-09-23 00:00:24.686565 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-23 00:00:24.723377 | debian-bookworm | ok 2025-09-23 00:00:24.734363 | debian-bookworm | included: /var/lib/zuul/builds/bd8d287601fa47d7aa50829bdbcef684/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-23 00:00:24.754074 | 2025-09-23 00:00:24.754164 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-23 00:00:24.803278 | debian-bookworm | skipping: Conditional result was False 2025-09-23 00:00:24.808168 | 2025-09-23 00:00:24.808254 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-23 00:00:25.748101 | debian-bookworm | changed 2025-09-23 00:00:25.753094 | 2025-09-23 00:00:25.753172 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-23 00:00:26.059356 | debian-bookworm | ok 2025-09-23 00:00:26.063803 | 2025-09-23 00:00:26.063881 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-23 00:00:26.907772 | debian-bookworm | changed 2025-09-23 00:00:26.913162 | 2025-09-23 00:00:26.913245 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-23 00:00:27.770202 | debian-bookworm | changed 2025-09-23 00:00:27.774712 | 2025-09-23 00:00:27.774790 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-23 00:00:27.821094 | debian-bookworm | skipping: Conditional result was False 2025-09-23 00:00:27.826724 | 2025-09-23 00:00:27.826810 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-23 00:00:28.983424 | debian-bookworm -> localhost | changed 2025-09-23 00:00:28.992325 | 2025-09-23 00:00:28.992408 | TASK [add-build-sshkey : Add back temp key] 2025-09-23 00:00:29.632988 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/bd8d287601fa47d7aa50829bdbcef684/work/bd8d287601fa47d7aa50829bdbcef684_id_rsa (zuul-build-sshkey) 2025-09-23 00:00:29.633181 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.019048 2025-09-23 00:00:29.639953 | 2025-09-23 00:00:29.640035 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-23 00:00:30.234062 | debian-bookworm | ok 2025-09-23 00:00:30.238108 | 2025-09-23 00:00:30.238190 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-23 00:00:30.288618 | debian-bookworm | skipping: Conditional result was False 2025-09-23 00:00:30.297031 | 2025-09-23 00:00:30.297118 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-23 00:00:31.004184 | debian-bookworm | ok 2025-09-23 00:00:31.017413 | 2025-09-23 00:00:31.017501 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-23 00:00:31.061912 | debian-bookworm | ok 2025-09-23 00:00:31.066552 | 2025-09-23 00:00:31.066629 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-23 00:00:31.796642 | debian-bookworm -> localhost | ok 2025-09-23 00:00:31.801956 | 2025-09-23 00:00:31.802047 | TASK [validate-host : Collect information about the host] 2025-09-23 00:00:33.374981 | debian-bookworm | ok 2025-09-23 00:00:33.407748 | 2025-09-23 00:00:33.407861 | TASK [validate-host : Sanitize hostname] 2025-09-23 00:00:33.628071 | debian-bookworm | ok 2025-09-23 00:00:33.679050 | 2025-09-23 00:00:33.679157 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-23 00:00:34.633245 | debian-bookworm -> localhost | changed 2025-09-23 00:00:34.638712 | 2025-09-23 00:00:34.638807 | TASK [validate-host : Collect information about zuul worker] 2025-09-23 00:00:35.111468 | debian-bookworm | ok 2025-09-23 00:00:35.115957 | 2025-09-23 00:00:35.116052 | TASK [validate-host : Write out all zuul information for each host] 2025-09-23 00:00:36.147095 | debian-bookworm -> localhost | changed 2025-09-23 00:00:36.156311 | 2025-09-23 00:00:36.156405 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-23 00:00:36.468739 | debian-bookworm | ok 2025-09-23 00:00:36.481874 | 2025-09-23 00:00:36.481989 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-23 00:00:38.363382 | debian-bookworm | changed: 2025-09-23 00:00:38.363557 | debian-bookworm | cd+++++++++ src/ 2025-09-23 00:00:38.363592 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-23 00:00:38.363616 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-23 00:00:38.363638 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-kolla-ansible/ 2025-09-23 00:00:38.363658 | debian-bookworm | Containerfile 2025-09-23 00:00:38.363789 | debian-bookworm | 2025-09-23 00:13:57.392148 | debian-bookworm | ERROR 2025-09-23 00:13:57.392526 | debian-bookworm | { 2025-09-23 00:13:57.392618 | debian-bookworm | "delta": "0:00:19.655069", 2025-09-23 00:13:57.392683 | debian-bookworm | "end": "2025-09-23 00:13:57.297230", 2025-09-23 00:13:57.392750 | debian-bookworm | "msg": "non-zero return code", 2025-09-23 00:13:57.392832 | debian-bookworm | "rc": 1, 2025-09-23 00:13:57.392884 | debian-bookworm | "start": "2025-09-23 00:13:37.642161" 2025-09-23 00:13:57.392935 | debian-bookworm | } failure 2025-09-23 00:13:57.397083 | 2025-09-23 00:13:57.397225 | PLAY RECAP 2025-09-23 00:13:57.397329 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2025-09-23 00:13:57.397427 | 2025-09-23 00:13:57.560302 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/container-image-kolla-ansible/playbooks/build.yml@main] 2025-09-23 00:13:57.561588 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-09-23 00:13:58.311328 | 2025-09-23 00:13:58.311490 | PLAY [Base post] 2025-09-23 00:13:58.327079 | 2025-09-23 00:13:58.327211 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-09-23 00:13:59.156994 | debian-bookworm | changed 2025-09-23 00:13:59.167643 | 2025-09-23 00:13:59.167814 | PLAY RECAP 2025-09-23 00:13:59.167898 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-09-23 00:13:59.167981 | 2025-09-23 00:13:59.304121 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-09-23 00:13:59.305387 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-09-23 00:14:00.120166 | 2025-09-23 00:14:00.120324 | PLAY [Base post-logs] 2025-09-23 00:14:00.131114 | 2025-09-23 00:14:00.131247 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-09-23 00:14:00.587344 | localhost | changed 2025-09-23 00:14:00.605743 | 2025-09-23 00:14:00.605962 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-09-23 00:14:00.644008 | localhost | ok 2025-09-23 00:14:00.651330 | 2025-09-23 00:14:00.651483 | TASK [Set zuul-log-path fact] 2025-09-23 00:14:00.679746 | localhost | ok 2025-09-23 00:14:00.695752 | 2025-09-23 00:14:00.695962 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-23 00:14:00.722886 | localhost | ok 2025-09-23 00:14:00.725941 | 2025-09-23 00:14:00.726040 | TASK [upload-logs : Create log directories] 2025-09-23 00:14:01.231352 | localhost | changed 2025-09-23 00:14:01.234199 | 2025-09-23 00:14:01.234303 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-09-23 00:14:01.738410 | localhost -> localhost | ok: Runtime: 0:00:00.007717 2025-09-23 00:14:01.747455 | 2025-09-23 00:14:01.747636 | TASK [upload-logs : Upload logs to log server] 2025-09-23 00:14:02.308903 | localhost | Output suppressed because no_log was given 2025-09-23 00:14:02.313273 | 2025-09-23 00:14:02.313458 | LOOP [upload-logs : Compress console log and json output] 2025-09-23 00:14:02.373716 | localhost | skipping: Conditional result was False 2025-09-23 00:14:02.378962 | localhost | skipping: Conditional result was False 2025-09-23 00:14:02.386538 | 2025-09-23 00:14:02.386906 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-23 00:14:02.432613 | localhost | skipping: Conditional result was False 2025-09-23 00:14:02.433242 | 2025-09-23 00:14:02.437069 | localhost | skipping: Conditional result was False 2025-09-23 00:14:02.450269 | 2025-09-23 00:14:02.450480 | LOOP [upload-logs : Upload console log and json output]