2025-09-04 00:00:14.326005 | Job console starting 2025-09-04 00:00:14.333415 | Updating git repos 2025-09-04 00:00:14.602661 | Cloning repos into workspace 2025-09-04 00:00:14.657907 | Restoring repo states 2025-09-04 00:00:14.665943 | Merging changes 2025-09-04 00:00:14.665960 | Checking out repos 2025-09-04 00:00:14.807766 | Preparing playbooks 2025-09-04 00:00:15.681151 | Running Ansible setup 2025-09-04 00:00:21.255437 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-04 00:00:23.054299 | 2025-09-04 00:00:23.054415 | PLAY [Base pre] 2025-09-04 00:00:23.094182 | 2025-09-04 00:00:23.094295 | TASK [Setup log path fact] 2025-09-04 00:00:23.122853 | debian-bookworm | ok 2025-09-04 00:00:23.149651 | 2025-09-04 00:00:23.149768 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-04 00:00:23.232580 | debian-bookworm | ok 2025-09-04 00:00:23.263802 | 2025-09-04 00:00:23.264895 | TASK [emit-job-header : Print job information] 2025-09-04 00:00:23.429346 | # Job Information 2025-09-04 00:00:23.429500 | Ansible Version: 2.16.14 2025-09-04 00:00:23.429531 | Job: container-image-kolla-ansible-push-2024.2 2025-09-04 00:00:23.429559 | Pipeline: periodic-midnight 2025-09-04 00:00:23.429578 | Executor: 521e9411259a 2025-09-04 00:00:23.429595 | Triggered by: https://github.com/osism/container-image-kolla-ansible 2025-09-04 00:00:23.429612 | Event ID: 6c7a8b3c39cb402ea7d879ca88789528 2025-09-04 00:00:23.433547 | 2025-09-04 00:00:23.433629 | LOOP [emit-job-header : Print node information] 2025-09-04 00:00:23.725871 | debian-bookworm | ok: 2025-09-04 00:00:23.726235 | debian-bookworm | # Node Information 2025-09-04 00:00:23.726278 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-04 00:00:23.726300 | debian-bookworm | Hostname: debian 2025-09-04 00:00:23.726319 | debian-bookworm | Username: zuul 2025-09-04 00:00:23.726351 | debian-bookworm | Distro: Debian 12.11 2025-09-04 00:00:23.726695 | debian-bookworm | Provider: regiocloud-a 2025-09-04 00:00:23.726723 | debian-bookworm | Region: 2025-09-04 00:00:23.726743 | debian-bookworm | Label: debian-bookworm 2025-09-04 00:00:23.726761 | debian-bookworm | Product Name: OpenStack Nova 2025-09-04 00:00:23.726778 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe70:5837 2025-09-04 00:00:23.742078 | 2025-09-04 00:00:23.742173 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-04 00:00:25.252547 | debian-bookworm -> localhost | changed 2025-09-04 00:00:25.258373 | 2025-09-04 00:00:25.258498 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-04 00:00:27.270856 | debian-bookworm -> localhost | changed 2025-09-04 00:00:27.279570 | 2025-09-04 00:00:27.279703 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-04 00:00:28.291216 | debian-bookworm -> localhost | ok 2025-09-04 00:00:28.297211 | 2025-09-04 00:00:28.297314 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-04 00:00:28.345048 | debian-bookworm | ok 2025-09-04 00:00:28.380706 | debian-bookworm | included: /var/lib/zuul/builds/149e1b9f248345ddb3ef07dcfd3c0731/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-04 00:00:28.410912 | 2025-09-04 00:00:28.411019 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-04 00:00:30.946231 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-04 00:00:30.946397 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/149e1b9f248345ddb3ef07dcfd3c0731/work/149e1b9f248345ddb3ef07dcfd3c0731_id_rsa 2025-09-04 00:00:30.946454 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/149e1b9f248345ddb3ef07dcfd3c0731/work/149e1b9f248345ddb3ef07dcfd3c0731_id_rsa.pub 2025-09-04 00:00:30.946478 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-04 00:00:30.946497 | debian-bookworm -> localhost | SHA256:9CNaFnhgAHqOt9HwEhkIQzgHvQvxs5hcXyY8yDTk954 zuul-build-sshkey 2025-09-04 00:00:30.946522 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-04 00:00:30.946540 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-04 00:00:30.946557 | debian-bookworm -> localhost | |B=+o..o | 2025-09-04 00:00:30.946575 | debian-bookworm -> localhost | |=o+= . o | 2025-09-04 00:00:30.946591 | debian-bookworm -> localhost | |.=Bo+.. + | 2025-09-04 00:00:30.946606 | debian-bookworm -> localhost | |.++O.+.= o | 2025-09-04 00:00:30.946622 | debian-bookworm -> localhost | |o+*++ =.S o | 2025-09-04 00:00:30.946644 | debian-bookworm -> localhost | |ooo+ ..+.. . | 2025-09-04 00:00:30.946661 | debian-bookworm -> localhost | | . .E | 2025-09-04 00:00:30.946677 | debian-bookworm -> localhost | | | 2025-09-04 00:00:30.946695 | debian-bookworm -> localhost | | | 2025-09-04 00:00:30.946711 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-04 00:00:30.946758 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.253074 2025-09-04 00:00:30.952009 | 2025-09-04 00:00:30.952085 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-04 00:00:30.988801 | debian-bookworm | ok 2025-09-04 00:00:31.000551 | debian-bookworm | included: /var/lib/zuul/builds/149e1b9f248345ddb3ef07dcfd3c0731/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-04 00:00:31.023323 | 2025-09-04 00:00:31.023433 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-04 00:00:31.085433 | debian-bookworm | skipping: Conditional result was False 2025-09-04 00:00:31.091574 | 2025-09-04 00:00:31.091678 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-04 00:00:31.742777 | debian-bookworm | changed 2025-09-04 00:00:31.748202 | 2025-09-04 00:00:31.748282 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-04 00:00:32.049184 | debian-bookworm | ok 2025-09-04 00:00:32.053741 | 2025-09-04 00:00:32.053817 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-04 00:00:32.857287 | debian-bookworm | changed 2025-09-04 00:00:32.862958 | 2025-09-04 00:00:32.863046 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-04 00:00:33.583745 | debian-bookworm | changed 2025-09-04 00:00:33.588255 | 2025-09-04 00:00:33.588332 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-04 00:00:33.632664 | debian-bookworm | skipping: Conditional result was False 2025-09-04 00:00:33.638513 | 2025-09-04 00:00:33.638648 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-04 00:00:34.833698 | debian-bookworm -> localhost | changed 2025-09-04 00:00:34.843243 | 2025-09-04 00:00:34.843327 | TASK [add-build-sshkey : Add back temp key] 2025-09-04 00:00:35.615892 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/149e1b9f248345ddb3ef07dcfd3c0731/work/149e1b9f248345ddb3ef07dcfd3c0731_id_rsa (zuul-build-sshkey) 2025-09-04 00:00:35.616072 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.017599 2025-09-04 00:00:35.622377 | 2025-09-04 00:00:35.622476 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-04 00:00:36.216330 | debian-bookworm | ok 2025-09-04 00:00:36.220544 | 2025-09-04 00:00:36.220622 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-04 00:00:36.269481 | debian-bookworm | skipping: Conditional result was False 2025-09-04 00:00:36.278486 | 2025-09-04 00:00:36.278581 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-04 00:00:36.784302 | debian-bookworm | ok 2025-09-04 00:00:36.792876 | 2025-09-04 00:00:36.802864 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-04 00:00:36.841392 | debian-bookworm | ok 2025-09-04 00:00:36.853831 | 2025-09-04 00:00:36.853933 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-04 00:00:37.845451 | debian-bookworm -> localhost | ok 2025-09-04 00:00:37.850771 | 2025-09-04 00:00:37.850919 | TASK [validate-host : Collect information about the host] 2025-09-04 00:00:39.420167 | debian-bookworm | ok 2025-09-04 00:00:39.430871 | 2025-09-04 00:00:39.430961 | TASK [validate-host : Sanitize hostname] 2025-09-04 00:00:39.595008 | debian-bookworm | ok 2025-09-04 00:00:39.668128 | 2025-09-04 00:00:39.668223 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-04 00:00:40.702350 | debian-bookworm -> localhost | changed 2025-09-04 00:00:40.708072 | 2025-09-04 00:00:40.708157 | TASK [validate-host : Collect information about zuul worker] 2025-09-04 00:00:41.268847 | debian-bookworm | ok 2025-09-04 00:00:41.273406 | 2025-09-04 00:00:41.273502 | TASK [validate-host : Write out all zuul information for each host] 2025-09-04 00:00:42.193538 | debian-bookworm -> localhost | changed 2025-09-04 00:00:42.201638 | 2025-09-04 00:00:42.201725 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-04 00:00:42.516622 | debian-bookworm | ok 2025-09-04 00:00:42.521218 | 2025-09-04 00:00:42.521294 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-04 00:00:43.814214 | debian-bookworm | changed: 2025-09-04 00:00:43.814355 | debian-bookworm | cd+++++++++ src/ 2025-09-04 00:00:43.814383 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-04 00:00:43.814402 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-04 00:00:43.814443 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-kolla-ansible/ 2025-09-04 00:00:43.814462 | debian-bookworm | Containerfile 2025-09-04 00:00:43.814569 | debian-bookworm | 2025-09-04 00:10:14.301683 | debian-bookworm | ERROR 2025-09-04 00:10:14.302139 | debian-bookworm | { 2025-09-04 00:10:14.302248 | debian-bookworm | "delta": "0:00:20.954745", 2025-09-04 00:10:14.302321 | debian-bookworm | "end": "2025-09-04 00:10:14.006817", 2025-09-04 00:10:14.302418 | debian-bookworm | "msg": "non-zero return code", 2025-09-04 00:10:14.302483 | debian-bookworm | "rc": 1, 2025-09-04 00:10:14.302540 | debian-bookworm | "start": "2025-09-04 00:09:53.052072" 2025-09-04 00:10:14.302593 | debian-bookworm | } failure 2025-09-04 00:10:14.306896 | 2025-09-04 00:10:14.307109 | PLAY RECAP 2025-09-04 00:10:14.307303 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2025-09-04 00:10:14.307442 | 2025-09-04 00:10:14.451121 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/container-image-kolla-ansible/playbooks/build.yml@main] 2025-09-04 00:10:14.453480 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-09-04 00:10:15.175482 | 2025-09-04 00:10:15.175640 | PLAY [Base post] 2025-09-04 00:10:15.189564 | 2025-09-04 00:10:15.189695 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-09-04 00:10:17.497454 | debian-bookworm | changed 2025-09-04 00:10:17.506579 | 2025-09-04 00:10:17.506710 | PLAY RECAP 2025-09-04 00:10:17.506788 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-09-04 00:10:17.506889 | 2025-09-04 00:10:17.625069 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-09-04 00:10:17.626141 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-09-04 00:10:18.442018 | 2025-09-04 00:10:18.442195 | PLAY [Base post-logs] 2025-09-04 00:10:18.453380 | 2025-09-04 00:10:18.453552 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-09-04 00:10:18.907820 | localhost | changed 2025-09-04 00:10:18.923941 | 2025-09-04 00:10:18.924122 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-09-04 00:10:18.962268 | localhost | ok 2025-09-04 00:10:18.967219 | 2025-09-04 00:10:18.967359 | TASK [Set zuul-log-path fact] 2025-09-04 00:10:18.994044 | localhost | ok 2025-09-04 00:10:19.009628 | 2025-09-04 00:10:19.009794 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-04 00:10:19.047801 | localhost | ok 2025-09-04 00:10:19.054905 | 2025-09-04 00:10:19.055075 | TASK [upload-logs : Create log directories] 2025-09-04 00:10:19.579267 | localhost | changed 2025-09-04 00:10:19.583759 | 2025-09-04 00:10:19.583894 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-09-04 00:10:20.069223 | localhost -> localhost | ok: Runtime: 0:00:00.007705 2025-09-04 00:10:20.077683 | 2025-09-04 00:10:20.077850 | TASK [upload-logs : Upload logs to log server] 2025-09-04 00:10:20.646575 | localhost | Output suppressed because no_log was given 2025-09-04 00:10:20.650056 | 2025-09-04 00:10:20.650218 | LOOP [upload-logs : Compress console log and json output] 2025-09-04 00:10:20.704899 | localhost | skipping: Conditional result was False 2025-09-04 00:10:20.708644 | localhost | skipping: Conditional result was False 2025-09-04 00:10:20.721713 | 2025-09-04 00:10:20.721930 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-04 00:10:20.768023 | localhost | skipping: Conditional result was False 2025-09-04 00:10:20.768636 | 2025-09-04 00:10:20.772154 | localhost | skipping: Conditional result was False 2025-09-04 00:10:20.785959 | 2025-09-04 00:10:20.786158 | LOOP [upload-logs : Upload console log and json output]