2026-06-19 02:56:27.531939 | Job console starting 2026-06-19 02:56:27.567729 | Updating git repos 2026-06-19 02:56:27.640011 | Cloning repos into workspace 2026-06-19 02:56:27.823939 | Restoring repo states 2026-06-19 02:56:27.833389 | Merging changes 2026-06-19 02:56:28.645987 | Checking out repos 2026-06-19 02:56:28.740378 | Preparing playbooks 2026-06-19 02:56:31.476735 | Running Ansible setup 2026-06-19 02:56:38.240858 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-06-19 02:56:39.780271 | 2026-06-19 02:56:39.780423 | PLAY [Base pre] 2026-06-19 02:56:39.819186 | 2026-06-19 02:56:39.819327 | TASK [Setup log path fact] 2026-06-19 02:56:39.863843 | debian-bookworm | ok 2026-06-19 02:56:39.905819 | 2026-06-19 02:56:39.905964 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-19 02:56:39.950161 | debian-bookworm | ok 2026-06-19 02:56:39.966275 | 2026-06-19 02:56:39.966390 | TASK [emit-job-header : Print job information] 2026-06-19 02:56:40.019188 | # Job Information 2026-06-19 02:56:40.019334 | Ansible Version: 2.16.14 2026-06-19 02:56:40.019364 | Job: container-image-cfg-cookiecutter-build 2026-06-19 02:56:40.019391 | Pipeline: check 2026-06-19 02:56:40.019411 | Executor: 521e9411259a 2026-06-19 02:56:40.019428 | Triggered by: https://github.com/osism/cfg-cookiecutter/pull/855 2026-06-19 02:56:40.019445 | Event ID: 701354d0-6b8a-11f1-856a-c68fb2671789 2026-06-19 02:56:40.024050 | 2026-06-19 02:56:40.024153 | LOOP [emit-job-header : Print node information] 2026-06-19 02:56:40.318814 | debian-bookworm | ok: 2026-06-19 02:56:40.319080 | debian-bookworm | # Node Information 2026-06-19 02:56:40.319125 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-06-19 02:56:40.319148 | debian-bookworm | Hostname: debian 2026-06-19 02:56:40.319168 | debian-bookworm | Username: zuul 2026-06-19 02:56:40.319186 | debian-bookworm | Distro: Debian 12.14 2026-06-19 02:56:40.319206 | debian-bookworm | Provider: regiocloud-a 2026-06-19 02:56:40.319224 | debian-bookworm | Region: 2026-06-19 02:56:40.319241 | debian-bookworm | Label: debian-bookworm 2026-06-19 02:56:40.319257 | debian-bookworm | Product Name: OpenStack Nova 2026-06-19 02:56:40.319274 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe60:e4cc 2026-06-19 02:56:40.337032 | 2026-06-19 02:56:40.337153 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-19 02:56:41.288995 | debian-bookworm -> localhost | changed 2026-06-19 02:56:41.295231 | 2026-06-19 02:56:41.295344 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-19 02:56:43.574824 | debian-bookworm -> localhost | changed 2026-06-19 02:56:43.588452 | 2026-06-19 02:56:43.588577 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-19 02:56:44.129865 | debian-bookworm -> localhost | ok 2026-06-19 02:56:44.136374 | 2026-06-19 02:56:44.136520 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-19 02:56:44.192853 | debian-bookworm | ok 2026-06-19 02:56:44.230361 | debian-bookworm | included: /var/lib/zuul/builds/756f2ae0b907496fa658de811741b367/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-19 02:56:44.247589 | 2026-06-19 02:56:44.247717 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-19 02:56:45.868642 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-06-19 02:56:45.868824 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/756f2ae0b907496fa658de811741b367/work/756f2ae0b907496fa658de811741b367_id_rsa 2026-06-19 02:56:45.868857 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/756f2ae0b907496fa658de811741b367/work/756f2ae0b907496fa658de811741b367_id_rsa.pub 2026-06-19 02:56:45.868879 | debian-bookworm -> localhost | The key fingerprint is: 2026-06-19 02:56:45.868900 | debian-bookworm -> localhost | SHA256:IcBv1zyLr8NOCMTMGWQFVx1Op7N02NE3oC17W4PXufs zuul-build-sshkey 2026-06-19 02:56:45.868931 | debian-bookworm -> localhost | The key's randomart image is: 2026-06-19 02:56:45.868951 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-06-19 02:56:45.868969 | debian-bookworm -> localhost | | o*oo...o.oo. | 2026-06-19 02:56:45.868988 | debian-bookworm -> localhost | | =.= o.=o....| 2026-06-19 02:56:45.869005 | debian-bookworm -> localhost | | *.. .o*oo. ..| 2026-06-19 02:56:45.869022 | debian-bookworm -> localhost | | . o..o++o . o| 2026-06-19 02:56:45.869039 | debian-bookworm -> localhost | | .. .S..+ o =.| 2026-06-19 02:56:45.869063 | debian-bookworm -> localhost | | . .. . . + o| 2026-06-19 02:56:45.869081 | debian-bookworm -> localhost | | .... . . | 2026-06-19 02:56:45.869098 | debian-bookworm -> localhost | | .o . .| 2026-06-19 02:56:45.869126 | debian-bookworm -> localhost | | .oo .E| 2026-06-19 02:56:45.869143 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-06-19 02:56:45.869183 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.616681 2026-06-19 02:56:45.874845 | 2026-06-19 02:56:45.874953 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-19 02:56:45.912597 | debian-bookworm | ok 2026-06-19 02:56:45.924503 | debian-bookworm | included: /var/lib/zuul/builds/756f2ae0b907496fa658de811741b367/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-19 02:56:45.943558 | 2026-06-19 02:56:45.943700 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-19 02:56:45.963898 | debian-bookworm | skipping: Conditional result was False 2026-06-19 02:56:45.970045 | 2026-06-19 02:56:45.970162 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-19 02:56:46.666466 | debian-bookworm | changed 2026-06-19 02:56:46.671503 | 2026-06-19 02:56:46.671596 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-19 02:56:46.962425 | debian-bookworm | ok 2026-06-19 02:56:46.968210 | 2026-06-19 02:56:46.968313 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-19 02:56:47.669177 | debian-bookworm | changed 2026-06-19 02:56:47.673910 | 2026-06-19 02:56:47.673991 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-19 02:56:48.434090 | debian-bookworm | changed 2026-06-19 02:56:48.472717 | 2026-06-19 02:56:48.472839 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-19 02:56:48.517679 | debian-bookworm | skipping: Conditional result was False 2026-06-19 02:56:48.532714 | 2026-06-19 02:56:48.532837 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-19 02:56:49.344990 | debian-bookworm -> localhost | changed 2026-06-19 02:56:49.362045 | 2026-06-19 02:56:49.362200 | TASK [add-build-sshkey : Add back temp key] 2026-06-19 02:56:50.069881 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/756f2ae0b907496fa658de811741b367/work/756f2ae0b907496fa658de811741b367_id_rsa (zuul-build-sshkey) 2026-06-19 02:56:50.070099 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.030814 2026-06-19 02:56:50.077491 | 2026-06-19 02:56:50.077596 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-19 02:56:50.585957 | debian-bookworm | ok 2026-06-19 02:56:50.600433 | 2026-06-19 02:56:50.600559 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-19 02:56:50.651837 | debian-bookworm | skipping: Conditional result was False 2026-06-19 02:56:50.666136 | 2026-06-19 02:56:50.666260 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-06-19 02:56:51.225215 | debian-bookworm | ok 2026-06-19 02:56:51.248416 | 2026-06-19 02:56:51.248538 | TASK [validate-host : Define zuul_info_dir fact] 2026-06-19 02:56:51.307897 | debian-bookworm | ok 2026-06-19 02:56:51.313179 | 2026-06-19 02:56:51.313276 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-06-19 02:56:51.661377 | debian-bookworm -> localhost | ok 2026-06-19 02:56:51.668417 | 2026-06-19 02:56:51.668542 | TASK [validate-host : Collect information about the host] 2026-06-19 02:56:53.049314 | debian-bookworm | ok 2026-06-19 02:56:53.073835 | 2026-06-19 02:56:53.074031 | TASK [validate-host : Sanitize hostname] 2026-06-19 02:56:53.243461 | debian-bookworm | ok 2026-06-19 02:56:53.247995 | 2026-06-19 02:56:53.248099 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-06-19 02:56:54.102522 | debian-bookworm -> localhost | changed 2026-06-19 02:56:54.108545 | 2026-06-19 02:56:54.108650 | TASK [validate-host : Collect information about zuul worker] 2026-06-19 02:56:54.643626 | debian-bookworm | ok 2026-06-19 02:56:54.648507 | 2026-06-19 02:56:54.648604 | TASK [validate-host : Write out all zuul information for each host] 2026-06-19 02:56:55.504533 | debian-bookworm -> localhost | changed 2026-06-19 02:56:55.513951 | 2026-06-19 02:56:55.514057 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-06-19 02:56:55.785792 | debian-bookworm | ok 2026-06-19 02:56:55.794504 | 2026-06-19 02:56:55.794614 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-06-19 02:56:56.774182 | debian-bookworm | changed: 2026-06-19 02:56:56.774358 | debian-bookworm | cd+++++++++ src/ 2026-06-19 02:56:56.774392 | debian-bookworm | cd+++++++++ src/github.com/ 2026-06-19 02:56:56.774417 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-06-19 02:56:56.774439 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2026-06-19 02:56:56.774459 | debian-bookworm | Containerfile 2026-06-19 02:56:56.774591 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/756f2ae0b907496fa658de811741b367/work/logs" 2026-06-19 02:59:48.600196 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/756f2ae0b907496fa658de811741b367/work/artifacts" 2026-06-19 02:59:48.878898 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/756f2ae0b907496fa658de811741b367/work/docs" 2026-06-19 02:59:48.900782 | 2026-06-19 02:59:48.901060 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-19 02:59:49.805999 | debian-bookworm | changed: 2026-06-19 02:59:49.806345 | debian-bookworm | .d..t...... ./ 2026-06-19 02:59:49.806394 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-06-19 02:59:49.806426 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-06-19 02:59:49.806455 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-06-19 02:59:49.806481 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-06-19 02:59:49.806506 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-06-19 02:59:49.806560 | debian-bookworm | changed: All items complete 2026-06-19 02:59:49.806593 | 2026-06-19 02:59:50.454620 | debian-bookworm | changed: .d..t...... ./ 2026-06-19 02:59:51.072809 | debian-bookworm | changed: .d..t...... ./ 2026-06-19 02:59:51.099865 | 2026-06-19 02:59:51.100102 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-19 02:59:51.480143 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.008873 2026-06-19 02:59:51.771343 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.009342 2026-06-19 02:59:51.794514 | 2026-06-19 02:59:51.794813 | PLAY RECAP 2026-06-19 02:59:51.795024 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-06-19 02:59:51.795103 | 2026-06-19 02:59:51.967567 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-06-19 02:59:51.968600 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-19 02:59:52.768011 | 2026-06-19 02:59:52.768355 | PLAY [Base post] 2026-06-19 02:59:52.782992 | 2026-06-19 02:59:52.783159 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-19 02:59:53.669313 | debian-bookworm | changed 2026-06-19 02:59:53.681108 | 2026-06-19 02:59:53.681282 | PLAY RECAP 2026-06-19 02:59:53.681373 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-19 02:59:53.681462 | 2026-06-19 02:59:53.827559 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-19 02:59:53.829894 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-06-19 02:59:54.688239 | 2026-06-19 02:59:54.688475 | PLAY [Base post-logs] 2026-06-19 02:59:54.701416 | 2026-06-19 02:59:54.701605 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-19 02:59:55.205814 | localhost | changed 2026-06-19 02:59:55.216874 | 2026-06-19 02:59:55.217066 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-19 02:59:55.253848 | localhost | ok 2026-06-19 02:59:55.258291 | 2026-06-19 02:59:55.258437 | TASK [Set zuul-log-path fact] 2026-06-19 02:59:55.276646 | localhost | ok 2026-06-19 02:59:55.286174 | 2026-06-19 02:59:55.286357 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-19 02:59:55.324134 | localhost | ok 2026-06-19 02:59:55.329315 | 2026-06-19 02:59:55.329471 | TASK [upload-logs : Create log directories] 2026-06-19 02:59:55.877775 | localhost | changed 2026-06-19 02:59:55.883469 | 2026-06-19 02:59:55.883625 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-19 02:59:56.484660 | localhost -> localhost | ok: Runtime: 0:00:00.007868 2026-06-19 02:59:56.496065 | 2026-06-19 02:59:56.496325 | TASK [upload-logs : Upload logs to log server] 2026-06-19 02:59:57.164128 | localhost | Output suppressed because no_log was given 2026-06-19 02:59:57.166354 | 2026-06-19 02:59:57.166469 | LOOP [upload-logs : Compress console log and json output] 2026-06-19 02:59:57.224052 | localhost | skipping: Conditional result was False 2026-06-19 02:59:57.231463 | localhost | skipping: Conditional result was False 2026-06-19 02:59:57.238981 | 2026-06-19 02:59:57.239223 | LOOP [upload-logs : Upload compressed console log and json output] 2026-06-19 02:59:57.305558 | localhost | skipping: Conditional result was False 2026-06-19 02:59:57.306013 | 2026-06-19 02:59:57.310465 | localhost | skipping: Conditional result was False 2026-06-19 02:59:57.321635 | 2026-06-19 02:59:57.321947 | LOOP [upload-logs : Upload console log and json output]