2026-05-31 03:13:19.782637 | Job console starting 2026-05-31 03:13:19.792905 | Updating git repos 2026-05-31 03:13:19.823349 | Cloning repos into workspace 2026-05-31 03:13:19.943372 | Restoring repo states 2026-05-31 03:13:19.959683 | Merging changes 2026-05-31 03:13:19.959699 | Checking out repos 2026-05-31 03:13:20.015504 | Preparing playbooks 2026-05-31 03:13:21.399137 | Running Ansible setup 2026-05-31 03:13:27.948346 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-31 03:13:29.302392 | 2026-05-31 03:13:29.302523 | PLAY [Base pre] 2026-05-31 03:13:29.320418 | 2026-05-31 03:13:29.320542 | TASK [Setup log path fact] 2026-05-31 03:13:29.348604 | debian-bookworm | ok 2026-05-31 03:13:29.369514 | 2026-05-31 03:13:29.369647 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-31 03:13:29.398936 | debian-bookworm | ok 2026-05-31 03:13:29.419188 | 2026-05-31 03:13:29.419318 | TASK [emit-job-header : Print job information] 2026-05-31 03:13:29.487995 | # Job Information 2026-05-31 03:13:29.488168 | Ansible Version: 2.16.14 2026-05-31 03:13:29.488202 | Job: container-image-cfg-cookiecutter-push 2026-05-31 03:13:29.488247 | Pipeline: periodic-daily 2026-05-31 03:13:29.488270 | Executor: 521e9411259a 2026-05-31 03:13:29.488290 | Triggered by: https://github.com/osism/cfg-cookiecutter 2026-05-31 03:13:29.488311 | Event ID: 322cd975f57642ae81dadbccf4866e88 2026-05-31 03:13:29.495249 | 2026-05-31 03:13:29.495366 | LOOP [emit-job-header : Print node information] 2026-05-31 03:13:29.639609 | debian-bookworm | ok: 2026-05-31 03:13:29.639833 | debian-bookworm | # Node Information 2026-05-31 03:13:29.639869 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-31 03:13:29.639896 | debian-bookworm | Hostname: debian 2026-05-31 03:13:29.639918 | debian-bookworm | Username: zuul 2026-05-31 03:13:29.639940 | debian-bookworm | Distro: Debian 12.14 2026-05-31 03:13:29.639963 | debian-bookworm | Provider: regiocloud-a 2026-05-31 03:13:29.639984 | debian-bookworm | Region: 2026-05-31 03:13:29.640004 | debian-bookworm | Label: debian-bookworm 2026-05-31 03:13:29.640024 | debian-bookworm | Product Name: OpenStack Nova 2026-05-31 03:13:29.640043 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fec8:6e88 2026-05-31 03:13:29.658490 | 2026-05-31 03:13:29.658607 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-31 03:13:30.325354 | debian-bookworm -> localhost | changed 2026-05-31 03:13:30.332314 | 2026-05-31 03:13:30.332426 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-31 03:13:32.046514 | debian-bookworm -> localhost | changed 2026-05-31 03:13:32.058241 | 2026-05-31 03:13:32.058370 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-31 03:13:32.265186 | debian-bookworm -> localhost | ok 2026-05-31 03:13:32.270093 | 2026-05-31 03:13:32.270176 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-31 03:13:32.288394 | debian-bookworm | ok 2026-05-31 03:13:32.301522 | debian-bookworm | included: /var/lib/zuul/builds/f8f7d15de96d4b0c9fa227ddbe231e64/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-31 03:13:32.311456 | 2026-05-31 03:13:32.311541 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-31 03:13:34.511439 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-31 03:13:34.511630 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/f8f7d15de96d4b0c9fa227ddbe231e64/work/f8f7d15de96d4b0c9fa227ddbe231e64_id_rsa 2026-05-31 03:13:34.511660 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/f8f7d15de96d4b0c9fa227ddbe231e64/work/f8f7d15de96d4b0c9fa227ddbe231e64_id_rsa.pub 2026-05-31 03:13:34.511682 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-31 03:13:34.511701 | debian-bookworm -> localhost | SHA256:DdAK8GoUz1/AizwOzRgn8CZccJVQVOoD6u/lXyVe2p4 zuul-build-sshkey 2026-05-31 03:13:34.511725 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-31 03:13:34.511744 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-31 03:13:34.511761 | debian-bookworm -> localhost | |.o+====o | 2026-05-31 03:13:34.511777 | debian-bookworm -> localhost | |..==o.oo. | 2026-05-31 03:13:34.511793 | debian-bookworm -> localhost | |..+X++ oo | 2026-05-31 03:13:34.511809 | debian-bookworm -> localhost | | ++.O.o. o | 2026-05-31 03:13:34.511825 | debian-bookworm -> localhost | | .oo +. S..o | 2026-05-31 03:13:34.511846 | debian-bookworm -> localhost | |.. . . . * | 2026-05-31 03:13:34.514177 | debian-bookworm -> localhost | | . . + . | 2026-05-31 03:13:34.514275 | debian-bookworm -> localhost | | . o . . . | 2026-05-31 03:13:34.514300 | debian-bookworm -> localhost | | .o ... E | 2026-05-31 03:13:34.514320 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-31 03:13:34.514377 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.382414 2026-05-31 03:13:34.524370 | 2026-05-31 03:13:34.524480 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-31 03:13:34.542779 | debian-bookworm | ok 2026-05-31 03:13:34.554528 | debian-bookworm | included: /var/lib/zuul/builds/f8f7d15de96d4b0c9fa227ddbe231e64/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-31 03:13:34.565966 | 2026-05-31 03:13:34.566050 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-31 03:13:34.611199 | debian-bookworm | skipping: Conditional result was False 2026-05-31 03:13:34.618095 | 2026-05-31 03:13:34.618196 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-31 03:13:35.448751 | debian-bookworm | changed 2026-05-31 03:13:35.461773 | 2026-05-31 03:13:35.461883 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-31 03:13:35.812957 | debian-bookworm | ok 2026-05-31 03:13:35.820265 | 2026-05-31 03:13:35.820366 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-31 03:13:36.568078 | debian-bookworm | changed 2026-05-31 03:13:36.575237 | 2026-05-31 03:13:36.575344 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-31 03:13:37.283115 | debian-bookworm | changed 2026-05-31 03:13:37.287860 | 2026-05-31 03:13:37.287935 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-31 03:13:37.328686 | debian-bookworm | skipping: Conditional result was False 2026-05-31 03:13:37.333707 | 2026-05-31 03:13:37.333793 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-31 03:13:37.875758 | debian-bookworm -> localhost | changed 2026-05-31 03:13:37.884416 | 2026-05-31 03:13:37.884500 | TASK [add-build-sshkey : Add back temp key] 2026-05-31 03:13:38.306168 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/f8f7d15de96d4b0c9fa227ddbe231e64/work/f8f7d15de96d4b0c9fa227ddbe231e64_id_rsa (zuul-build-sshkey) 2026-05-31 03:13:38.306366 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.008543 2026-05-31 03:13:38.314433 | 2026-05-31 03:13:38.314524 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-31 03:13:38.792348 | debian-bookworm | ok 2026-05-31 03:13:38.798159 | 2026-05-31 03:13:38.798288 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-31 03:13:38.821698 | debian-bookworm | skipping: Conditional result was False 2026-05-31 03:13:38.832678 | 2026-05-31 03:13:38.832775 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-31 03:13:39.296084 | debian-bookworm | ok 2026-05-31 03:13:39.314735 | 2026-05-31 03:13:39.314907 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-31 03:13:39.353080 | debian-bookworm | ok 2026-05-31 03:13:39.357841 | 2026-05-31 03:13:39.357923 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-31 03:13:39.744378 | debian-bookworm -> localhost | ok 2026-05-31 03:13:39.750483 | 2026-05-31 03:13:39.750585 | TASK [validate-host : Collect information about the host] 2026-05-31 03:13:40.821599 | debian-bookworm | ok 2026-05-31 03:13:40.839358 | 2026-05-31 03:13:40.839467 | TASK [validate-host : Sanitize hostname] 2026-05-31 03:13:40.932259 | debian-bookworm | ok 2026-05-31 03:13:40.994155 | 2026-05-31 03:13:40.994289 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-31 03:13:41.939726 | debian-bookworm -> localhost | changed 2026-05-31 03:13:41.945167 | 2026-05-31 03:13:41.945281 | TASK [validate-host : Collect information about zuul worker] 2026-05-31 03:13:42.405248 | debian-bookworm | ok 2026-05-31 03:13:42.409688 | 2026-05-31 03:13:42.409782 | TASK [validate-host : Write out all zuul information for each host] 2026-05-31 03:13:43.103469 | debian-bookworm -> localhost | changed 2026-05-31 03:13:43.112606 | 2026-05-31 03:13:43.112708 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-31 03:13:43.366463 | debian-bookworm | ok 2026-05-31 03:13:43.371591 | 2026-05-31 03:13:43.371685 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-31 03:13:44.193162 | debian-bookworm | changed: 2026-05-31 03:13:44.193364 | debian-bookworm | cd+++++++++ src/ 2026-05-31 03:13:44.193399 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-31 03:13:44.193422 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-31 03:13:44.193443 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2026-05-31 03:13:44.193462 | debian-bookworm | Containerfile 2026-05-31 03:13:44.193681 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/f8f7d15de96d4b0c9fa227ddbe231e64/work/logs" 2026-05-31 03:15:44.521013 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/f8f7d15de96d4b0c9fa227ddbe231e64/work/artifacts" 2026-05-31 03:15:45.216612 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/f8f7d15de96d4b0c9fa227ddbe231e64/work/docs" 2026-05-31 03:15:45.225042 | 2026-05-31 03:15:45.225131 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-31 03:15:46.153798 | debian-bookworm | changed: 2026-05-31 03:15:46.154006 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-31 03:15:46.154039 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-31 03:15:46.154070 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-31 03:15:46.154108 | debian-bookworm | changed: All items complete 2026-05-31 03:15:46.154127 | 2026-05-31 03:15:47.033645 | debian-bookworm | changed: .d..t...... ./ 2026-05-31 03:15:48.388660 | debian-bookworm | changed: .d..t...... ./ 2026-05-31 03:15:48.422033 | 2026-05-31 03:15:48.422146 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-31 03:15:48.455134 | debian-bookworm | skipping: Conditional result was False 2026-05-31 03:15:48.463582 | debian-bookworm | skipping: Conditional result was False 2026-05-31 03:15:48.490274 | 2026-05-31 03:15:48.490355 | PLAY RECAP 2026-05-31 03:15:48.490408 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-31 03:15:48.490433 | 2026-05-31 03:15:48.781360 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-31 03:15:48.782105 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-31 03:15:50.197528 | 2026-05-31 03:15:50.197654 | PLAY [Base post] 2026-05-31 03:15:50.224553 | 2026-05-31 03:15:50.224667 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-31 03:15:51.163925 | debian-bookworm | changed 2026-05-31 03:15:51.190800 | 2026-05-31 03:15:51.190920 | PLAY RECAP 2026-05-31 03:15:51.191009 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-31 03:15:51.191074 | 2026-05-31 03:15:51.517626 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-31 03:15:51.519190 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-31 03:15:52.788245 | 2026-05-31 03:15:52.788380 | PLAY [Base post-logs] 2026-05-31 03:15:52.830612 | 2026-05-31 03:15:52.830763 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-31 03:15:53.396281 | localhost | changed 2026-05-31 03:15:53.410744 | 2026-05-31 03:15:53.420206 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-31 03:15:53.508355 | localhost | ok 2026-05-31 03:15:53.514023 | 2026-05-31 03:15:53.514426 | TASK [Set zuul-log-path fact] 2026-05-31 03:15:53.584466 | localhost | ok 2026-05-31 03:15:53.610660 | 2026-05-31 03:15:53.610961 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-31 03:15:53.671675 | localhost | ok 2026-05-31 03:15:53.681207 | 2026-05-31 03:15:53.681314 | TASK [upload-logs : Create log directories] 2026-05-31 03:15:54.431177 | localhost | changed 2026-05-31 03:15:54.433897 | 2026-05-31 03:15:54.434004 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-31 03:15:54.918379 | localhost -> localhost | ok: Runtime: 0:00:00.010366 2026-05-31 03:15:54.921891 | 2026-05-31 03:15:54.921994 | TASK [upload-logs : Upload logs to log server] 2026-05-31 03:15:55.693211 | localhost | Output suppressed because no_log was given 2026-05-31 03:15:55.694564 | 2026-05-31 03:15:55.694632 | LOOP [upload-logs : Compress console log and json output] 2026-05-31 03:15:55.774990 | localhost | skipping: Conditional result was False 2026-05-31 03:15:55.781031 | localhost | skipping: Conditional result was False 2026-05-31 03:15:55.790261 | 2026-05-31 03:15:55.790344 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-31 03:15:55.839411 | localhost | skipping: Conditional result was False 2026-05-31 03:15:55.839625 | 2026-05-31 03:15:55.843289 | localhost | skipping: Conditional result was False 2026-05-31 03:15:55.845882 | 2026-05-31 03:15:55.845964 | LOOP [upload-logs : Upload console log and json output]