2026-09-15 05:39:21.297814 | Job console starting 2026-09-15 05:39:21.305802 | Updating git repos 2026-09-15 05:39:21.327619 | Cloning repos into workspace 2026-09-15 05:39:21.385403 | Restoring repo states 2026-09-15 05:39:21.406471 | Merging changes 2026-09-15 05:39:21.901851 | Checking out repos 2026-09-15 05:39:21.938457 | Preparing playbooks 2026-09-15 05:39:22.599367 | Running Ansible setup 2026-09-15 05:39:26.983707 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-09-15 05:39:28.082477 | 2026-09-15 05:39:28.082661 | PLAY [Base pre] 2026-09-15 05:39:28.109426 | 2026-09-15 05:39:28.109666 | TASK [Setup log path fact] 2026-09-15 05:39:28.131633 | debian-bookworm | ok 2026-09-15 05:39:28.149808 | 2026-09-15 05:39:28.149963 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-15 05:39:28.180166 | debian-bookworm | ok 2026-09-15 05:39:28.194635 | 2026-09-15 05:39:28.194772 | TASK [emit-job-header : Print job information] 2026-09-15 05:39:28.237083 | # Job Information 2026-09-15 05:39:28.237292 | Ansible Version: 2.16.14 2026-09-15 05:39:28.237340 | Job: container-image-cfg-cookiecutter-build 2026-09-15 05:39:28.237374 | Pipeline: check 2026-09-15 05:39:28.237398 | Executor: 521e9411259a 2026-09-15 05:39:28.237418 | Triggered by: https://github.com/osism/cfg-cookiecutter/pull/874 2026-09-15 05:39:28.237440 | Event ID: b3add350-b0c7-11f1-994f-bdec3def8884 2026-09-15 05:39:28.244998 | 2026-09-15 05:39:28.245134 | LOOP [emit-job-header : Print node information] 2026-09-15 05:39:28.412071 | debian-bookworm | ok: 2026-09-15 05:39:28.412339 | debian-bookworm | # Node Information 2026-09-15 05:39:28.412381 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-09-15 05:39:28.412408 | debian-bookworm | Hostname: debian 2026-09-15 05:39:28.412431 | debian-bookworm | Username: zuul 2026-09-15 05:39:28.412453 | debian-bookworm | Distro: Debian 12.15 2026-09-15 05:39:28.412485 | debian-bookworm | Provider: regiocloud-a 2026-09-15 05:39:28.412530 | debian-bookworm | Region: 2026-09-15 05:39:28.412552 | debian-bookworm | Label: debian-bookworm 2026-09-15 05:39:28.412573 | debian-bookworm | Product Name: OpenStack Nova 2026-09-15 05:39:28.412594 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe0a:ed6a 2026-09-15 05:39:28.434620 | 2026-09-15 05:39:28.434759 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-15 05:39:29.634393 | debian-bookworm -> localhost | changed 2026-09-15 05:39:29.644891 | 2026-09-15 05:39:29.645024 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-15 05:39:32.023006 | debian-bookworm -> localhost | changed 2026-09-15 05:39:32.031445 | 2026-09-15 05:39:32.031549 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-15 05:39:32.748526 | debian-bookworm -> localhost | ok 2026-09-15 05:39:32.753920 | 2026-09-15 05:39:32.754008 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-15 05:39:32.792610 | debian-bookworm | ok 2026-09-15 05:39:32.812786 | debian-bookworm | included: /var/lib/zuul/builds/3a95445f0cf94f03acdf5489a8064700/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-15 05:39:32.829927 | 2026-09-15 05:39:32.830014 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-15 05:39:34.157610 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-09-15 05:39:34.158086 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/3a95445f0cf94f03acdf5489a8064700/work/3a95445f0cf94f03acdf5489a8064700_id_rsa 2026-09-15 05:39:34.158200 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/3a95445f0cf94f03acdf5489a8064700/work/3a95445f0cf94f03acdf5489a8064700_id_rsa.pub 2026-09-15 05:39:34.158282 | debian-bookworm -> localhost | The key fingerprint is: 2026-09-15 05:39:34.158357 | debian-bookworm -> localhost | SHA256:R3ZP/tA/Kwa9tj8GGxDBkWZOdUpnEh809vEEChf6Ozo zuul-build-sshkey 2026-09-15 05:39:34.158448 | debian-bookworm -> localhost | The key's randomart image is: 2026-09-15 05:39:34.158536 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-09-15 05:39:34.158598 | debian-bookworm -> localhost | | ooB*+@.| 2026-09-15 05:39:34.158661 | debian-bookworm -> localhost | | @..O.*| 2026-09-15 05:39:34.158718 | debian-bookworm -> localhost | | O +...o| 2026-09-15 05:39:34.158775 | debian-bookworm -> localhost | | o = + . | 2026-09-15 05:39:34.158833 | debian-bookworm -> localhost | | S . + + .| 2026-09-15 05:39:34.158896 | debian-bookworm -> localhost | | . . = o.| 2026-09-15 05:39:34.158956 | debian-bookworm -> localhost | | + =.o| 2026-09-15 05:39:34.159013 | debian-bookworm -> localhost | | E. B oo| 2026-09-15 05:39:34.159073 | debian-bookworm -> localhost | | ..o.=o.| 2026-09-15 05:39:34.159132 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-09-15 05:39:34.159273 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.706207 2026-09-15 05:39:34.185404 | 2026-09-15 05:39:34.186362 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-15 05:39:34.251822 | debian-bookworm | ok 2026-09-15 05:39:34.268834 | debian-bookworm | included: /var/lib/zuul/builds/3a95445f0cf94f03acdf5489a8064700/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-15 05:39:34.276974 | 2026-09-15 05:39:34.277068 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-15 05:39:34.300989 | debian-bookworm | skipping: Conditional result was False 2026-09-15 05:39:34.306838 | 2026-09-15 05:39:34.306936 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-15 05:39:34.974728 | debian-bookworm | changed 2026-09-15 05:39:34.981229 | 2026-09-15 05:39:34.981318 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-15 05:39:35.276511 | debian-bookworm | ok 2026-09-15 05:39:35.284783 | 2026-09-15 05:39:35.284880 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-15 05:39:36.006253 | debian-bookworm | changed 2026-09-15 05:39:36.011702 | 2026-09-15 05:39:36.011793 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-15 05:39:36.707094 | debian-bookworm | changed 2026-09-15 05:39:36.712561 | 2026-09-15 05:39:36.712643 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-15 05:39:36.725487 | debian-bookworm | skipping: Conditional result was False 2026-09-15 05:39:36.731169 | 2026-09-15 05:39:36.731249 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-15 05:39:37.121504 | debian-bookworm -> localhost | changed 2026-09-15 05:39:37.131711 | 2026-09-15 05:39:37.131807 | TASK [add-build-sshkey : Add back temp key] 2026-09-15 05:39:37.397268 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/3a95445f0cf94f03acdf5489a8064700/work/3a95445f0cf94f03acdf5489a8064700_id_rsa (zuul-build-sshkey) 2026-09-15 05:39:37.397491 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.016338 2026-09-15 05:39:37.404921 | 2026-09-15 05:39:37.405008 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-15 05:39:37.802007 | debian-bookworm | ok 2026-09-15 05:39:37.808606 | 2026-09-15 05:39:37.808705 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-15 05:39:37.841866 | debian-bookworm | skipping: Conditional result was False 2026-09-15 05:39:37.851571 | 2026-09-15 05:39:37.851652 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-09-15 05:39:38.283961 | debian-bookworm | ok 2026-09-15 05:39:38.293963 | 2026-09-15 05:39:38.294054 | TASK [validate-host : Define zuul_info_dir fact] 2026-09-15 05:39:38.348841 | debian-bookworm | ok 2026-09-15 05:39:38.369692 | 2026-09-15 05:39:38.369870 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-09-15 05:39:38.626765 | debian-bookworm -> localhost | ok 2026-09-15 05:39:38.632816 | 2026-09-15 05:39:38.632899 | TASK [validate-host : Collect information about the host] 2026-09-15 05:39:39.705436 | debian-bookworm | ok 2026-09-15 05:39:39.722340 | 2026-09-15 05:39:39.722444 | TASK [validate-host : Sanitize hostname] 2026-09-15 05:39:39.857008 | debian-bookworm | ok 2026-09-15 05:39:39.861363 | 2026-09-15 05:39:39.861448 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-09-15 05:39:40.341929 | debian-bookworm -> localhost | changed 2026-09-15 05:39:40.356368 | 2026-09-15 05:39:40.356519 | TASK [validate-host : Collect information about zuul worker] 2026-09-15 05:39:40.775749 | debian-bookworm | ok 2026-09-15 05:39:40.784600 | 2026-09-15 05:39:40.784726 | TASK [validate-host : Write out all zuul information for each host] 2026-09-15 05:39:41.534165 | debian-bookworm -> localhost | changed 2026-09-15 05:39:41.561773 | 2026-09-15 05:39:41.561948 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-09-15 05:39:41.851562 | debian-bookworm | ok 2026-09-15 05:39:41.864857 | 2026-09-15 05:39:41.865471 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-09-15 05:39:43.123882 | debian-bookworm | changed: 2026-09-15 05:39:43.124078 | debian-bookworm | cd+++++++++ src/ 2026-09-15 05:39:43.124112 | debian-bookworm | cd+++++++++ src/github.com/ 2026-09-15 05:39:43.124136 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-09-15 05:39:43.124157 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2026-09-15 05:39:43.124178 | debian-bookworm | Containerfile 2026-09-15 05:39:43.124309 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/3a95445f0cf94f03acdf5489a8064700/work/logs" 2026-09-15 05:42:12.705011 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/3a95445f0cf94f03acdf5489a8064700/work/artifacts" 2026-09-15 05:42:12.964456 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/3a95445f0cf94f03acdf5489a8064700/work/docs" 2026-09-15 05:42:12.978634 | 2026-09-15 05:42:12.978739 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-15 05:42:13.878697 | debian-bookworm | changed: 2026-09-15 05:42:13.878850 | debian-bookworm | .d..t...... ./ 2026-09-15 05:42:13.878878 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-09-15 05:42:13.878899 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-09-15 05:42:13.878916 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-09-15 05:42:13.878933 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-09-15 05:42:13.878950 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-09-15 05:42:13.878979 | debian-bookworm | changed: All items complete 2026-09-15 05:42:13.878999 | 2026-09-15 05:42:14.384511 | debian-bookworm | changed: .d..t...... ./ 2026-09-15 05:42:14.973201 | debian-bookworm | changed: .d..t...... ./ 2026-09-15 05:42:14.985749 | 2026-09-15 05:42:14.985830 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-15 05:42:15.271034 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.014815 2026-09-15 05:42:15.554833 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.004064 2026-09-15 05:42:15.569158 | 2026-09-15 05:42:15.569230 | PLAY RECAP 2026-09-15 05:42:15.569278 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-09-15 05:42:15.569302 | 2026-09-15 05:42:15.659354 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-15 05:42:15.661393 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-15 05:42:16.379808 | 2026-09-15 05:42:16.379922 | PLAY [Base post] 2026-09-15 05:42:16.391873 | 2026-09-15 05:42:16.391975 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-15 05:42:17.177614 | debian-bookworm | changed 2026-09-15 05:42:17.185076 | 2026-09-15 05:42:17.185166 | PLAY RECAP 2026-09-15 05:42:17.185234 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-15 05:42:17.185300 | 2026-09-15 05:42:17.272097 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-15 05:42:17.272942 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-15 05:42:18.040585 | 2026-09-15 05:42:18.040695 | PLAY [Base post-logs] 2026-09-15 05:42:18.049047 | 2026-09-15 05:42:18.049137 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-15 05:42:18.500929 | localhost | changed 2026-09-15 05:42:18.509770 | 2026-09-15 05:42:18.509885 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-15 05:42:18.535253 | localhost | ok 2026-09-15 05:42:18.539853 | 2026-09-15 05:42:18.539986 | TASK [Set zuul-log-path fact] 2026-09-15 05:42:18.556500 | localhost | ok 2026-09-15 05:42:18.566000 | 2026-09-15 05:42:18.566113 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-15 05:42:18.590582 | localhost | ok 2026-09-15 05:42:18.593369 | 2026-09-15 05:42:18.593453 | TASK [upload-logs : Create log directories] 2026-09-15 05:42:19.052863 | localhost | changed 2026-09-15 05:42:19.056150 | 2026-09-15 05:42:19.056238 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-15 05:42:19.695419 | localhost -> localhost | ok: Runtime: 0:00:00.006537 2026-09-15 05:42:19.698919 | 2026-09-15 05:42:19.699011 | TASK [upload-logs : Upload logs to log server] 2026-09-15 05:42:20.437433 | localhost | Output suppressed because no_log was given 2026-09-15 05:42:20.438822 | 2026-09-15 05:42:20.438888 | LOOP [upload-logs : Compress console log and json output] 2026-09-15 05:42:20.487194 | localhost | skipping: Conditional result was False 2026-09-15 05:42:20.497630 | localhost | skipping: Conditional result was False 2026-09-15 05:42:20.499989 | 2026-09-15 05:42:20.500067 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-15 05:42:20.556614 | localhost | skipping: Conditional result was False 2026-09-15 05:42:20.556809 | 2026-09-15 05:42:20.562131 | localhost | skipping: Conditional result was False 2026-09-15 05:42:20.582104 | 2026-09-15 05:42:20.582207 | LOOP [upload-logs : Upload console log and json output]