2026-05-04 03:06:47.628387 | Job console starting 2026-05-04 03:06:47.647220 | Updating git repos 2026-05-04 03:06:47.707690 | Cloning repos into workspace 2026-05-04 03:06:47.744577 | Restoring repo states 2026-05-04 03:06:47.763028 | Merging changes 2026-05-04 03:06:47.763045 | Checking out repos 2026-05-04 03:06:47.843259 | Preparing playbooks 2026-05-04 03:06:48.793359 | Running Ansible setup 2026-05-04 03:06:54.086311 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-04 03:06:54.982236 | 2026-05-04 03:06:54.982412 | PLAY [Base pre] 2026-05-04 03:06:55.000915 | 2026-05-04 03:06:55.001072 | TASK [Setup log path fact] 2026-05-04 03:06:55.034165 | debian-bookworm | ok 2026-05-04 03:06:55.063169 | 2026-05-04 03:06:55.066912 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-04 03:06:55.099210 | debian-bookworm | ok 2026-05-04 03:06:55.119139 | 2026-05-04 03:06:55.119295 | TASK [emit-job-header : Print job information] 2026-05-04 03:06:55.169237 | # Job Information 2026-05-04 03:06:55.169444 | Ansible Version: 2.16.14 2026-05-04 03:06:55.169480 | Job: openstack-octavia-amphora-image-cleanup 2026-05-04 03:06:55.169513 | Pipeline: periodic-daily 2026-05-04 03:06:55.169536 | Executor: 521e9411259a 2026-05-04 03:06:55.169557 | Triggered by: https://github.com/osism/openstack-octavia-amphora-image 2026-05-04 03:06:55.169581 | Event ID: 8f5d5aaa78e247f994555b308bcc4eab 2026-05-04 03:06:55.174788 | 2026-05-04 03:06:55.178535 | LOOP [emit-job-header : Print node information] 2026-05-04 03:06:55.312896 | debian-bookworm | ok: 2026-05-04 03:06:55.313123 | debian-bookworm | # Node Information 2026-05-04 03:06:55.313159 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-04 03:06:55.313186 | debian-bookworm | Hostname: debian 2026-05-04 03:06:55.313209 | debian-bookworm | Username: zuul 2026-05-04 03:06:55.313230 | debian-bookworm | Distro: Debian 12.13 2026-05-04 03:06:55.313255 | debian-bookworm | Provider: regiocloud-a 2026-05-04 03:06:55.313276 | debian-bookworm | Region: 2026-05-04 03:06:55.313298 | debian-bookworm | Label: debian-bookworm 2026-05-04 03:06:55.313318 | debian-bookworm | Product Name: OpenStack Nova 2026-05-04 03:06:55.313338 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe51:aaef 2026-05-04 03:06:55.332739 | 2026-05-04 03:06:55.332910 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-04 03:06:55.886026 | debian-bookworm -> localhost | changed 2026-05-04 03:06:55.901019 | 2026-05-04 03:06:55.901174 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-04 03:06:57.296318 | debian-bookworm -> localhost | changed 2026-05-04 03:06:57.313051 | 2026-05-04 03:06:57.313212 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-04 03:06:57.683029 | debian-bookworm -> localhost | ok 2026-05-04 03:06:57.689516 | 2026-05-04 03:06:57.689637 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-04 03:06:57.737255 | debian-bookworm | ok 2026-05-04 03:06:57.757573 | debian-bookworm | included: /var/lib/zuul/builds/563fb6466db2404285522f50ceeabfed/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-04 03:06:57.764943 | 2026-05-04 03:06:57.765069 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-04 03:06:59.287089 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-04 03:06:59.287533 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/563fb6466db2404285522f50ceeabfed/work/563fb6466db2404285522f50ceeabfed_id_rsa 2026-05-04 03:06:59.287626 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/563fb6466db2404285522f50ceeabfed/work/563fb6466db2404285522f50ceeabfed_id_rsa.pub 2026-05-04 03:06:59.287694 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-04 03:06:59.287780 | debian-bookworm -> localhost | SHA256:JoSiutLWXMTgTRfKBT9KZeaJpOTtN9rmvwonI1Ulq8I zuul-build-sshkey 2026-05-04 03:06:59.287861 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-04 03:06:59.287921 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-04 03:06:59.287975 | debian-bookworm -> localhost | | . o.B.. | 2026-05-04 03:06:59.288030 | debian-bookworm -> localhost | | o.*.X.= | 2026-05-04 03:06:59.288083 | debian-bookworm -> localhost | | ..+=B.B | 2026-05-04 03:06:59.288134 | debian-bookworm -> localhost | | . o.+++ . | 2026-05-04 03:06:59.288186 | debian-bookworm -> localhost | |. E.* S | 2026-05-04 03:06:59.288256 | debian-bookworm -> localhost | |. o.* . | 2026-05-04 03:06:59.288309 | debian-bookworm -> localhost | |.. o..= + | 2026-05-04 03:06:59.288362 | debian-bookworm -> localhost | |..o o. B | 2026-05-04 03:06:59.288415 | debian-bookworm -> localhost | |o. ooo. | 2026-05-04 03:06:59.288469 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-04 03:06:59.288596 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.983435 2026-05-04 03:06:59.300761 | 2026-05-04 03:06:59.300898 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-04 03:06:59.339208 | debian-bookworm | ok 2026-05-04 03:06:59.353769 | debian-bookworm | included: /var/lib/zuul/builds/563fb6466db2404285522f50ceeabfed/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-04 03:06:59.364330 | 2026-05-04 03:06:59.364449 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-04 03:06:59.393426 | debian-bookworm | skipping: Conditional result was False 2026-05-04 03:06:59.410025 | 2026-05-04 03:06:59.410237 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-04 03:07:00.077501 | debian-bookworm | changed 2026-05-04 03:07:00.085237 | 2026-05-04 03:07:00.085367 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-04 03:07:00.360092 | debian-bookworm | ok 2026-05-04 03:07:00.370486 | 2026-05-04 03:07:00.370651 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-04 03:07:01.035365 | debian-bookworm | changed 2026-05-04 03:07:01.046175 | 2026-05-04 03:07:01.046326 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-04 03:07:01.690498 | debian-bookworm | changed 2026-05-04 03:07:01.698899 | 2026-05-04 03:07:01.699053 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-04 03:07:01.723836 | debian-bookworm | skipping: Conditional result was False 2026-05-04 03:07:01.731319 | 2026-05-04 03:07:01.731479 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-04 03:07:02.263373 | debian-bookworm -> localhost | changed 2026-05-04 03:07:02.288038 | 2026-05-04 03:07:02.288270 | TASK [add-build-sshkey : Add back temp key] 2026-05-04 03:07:02.631515 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/563fb6466db2404285522f50ceeabfed/work/563fb6466db2404285522f50ceeabfed_id_rsa (zuul-build-sshkey) 2026-05-04 03:07:02.631921 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.012775 2026-05-04 03:07:02.644728 | 2026-05-04 03:07:02.644894 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-04 03:07:03.065345 | debian-bookworm | ok 2026-05-04 03:07:03.071027 | 2026-05-04 03:07:03.071153 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-04 03:07:03.096274 | debian-bookworm | skipping: Conditional result was False 2026-05-04 03:07:03.122324 | 2026-05-04 03:07:03.122500 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-04 03:07:03.598827 | debian-bookworm | ok 2026-05-04 03:07:03.629049 | 2026-05-04 03:07:03.629208 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-04 03:07:03.691681 | debian-bookworm | ok 2026-05-04 03:07:03.697045 | 2026-05-04 03:07:03.697170 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-04 03:07:04.086172 | debian-bookworm -> localhost | ok 2026-05-04 03:07:04.093430 | 2026-05-04 03:07:04.093580 | TASK [validate-host : Collect information about the host] 2026-05-04 03:07:05.318586 | debian-bookworm | ok 2026-05-04 03:07:05.334592 | 2026-05-04 03:07:05.334803 | TASK [validate-host : Sanitize hostname] 2026-05-04 03:07:05.467510 | debian-bookworm | ok 2026-05-04 03:07:05.515431 | 2026-05-04 03:07:05.515566 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-04 03:07:06.224539 | debian-bookworm -> localhost | changed 2026-05-04 03:07:06.239437 | 2026-05-04 03:07:06.239628 | TASK [validate-host : Collect information about zuul worker] 2026-05-04 03:07:06.696772 | debian-bookworm | ok 2026-05-04 03:07:06.703420 | 2026-05-04 03:07:06.703581 | TASK [validate-host : Write out all zuul information for each host] 2026-05-04 03:07:07.310626 | debian-bookworm -> localhost | changed 2026-05-04 03:07:07.325779 | 2026-05-04 03:07:07.326379 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-04 03:07:07.591406 | debian-bookworm | ok 2026-05-04 03:07:07.598913 | 2026-05-04 03:07:07.599049 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-04 03:07:08.673204 | debian-bookworm | changed: 2026-05-04 03:07:08.673422 | debian-bookworm | cd+++++++++ src/ 2026-05-04 03:07:08.673457 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-04 03:07:08.673482 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-04 03:07:08.673503 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-octavia-amphora-image/ 2026-05-04 03:07:08.673523 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/563fb6466db2404285522f50ceeabfed/work/logs" 2026-05-04 03:08:11.975631 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/563fb6466db2404285522f50ceeabfed/work/artifacts" 2026-05-04 03:08:12.277817 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/563fb6466db2404285522f50ceeabfed/work/docs" 2026-05-04 03:08:12.293088 | 2026-05-04 03:08:12.293245 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-04 03:08:13.270659 | debian-bookworm | changed: 2026-05-04 03:08:13.270920 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-04 03:08:13.270958 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-04 03:08:13.270989 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-04 03:08:13.271038 | debian-bookworm | changed: All items complete 2026-05-04 03:08:13.271064 | 2026-05-04 03:08:14.256463 | debian-bookworm | changed: .d..t...... ./ 2026-05-04 03:08:15.111184 | debian-bookworm | changed: .d..t...... ./ 2026-05-04 03:08:15.136298 | 2026-05-04 03:08:15.136447 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-04 03:08:15.196568 | debian-bookworm | skipping: Conditional result was False 2026-05-04 03:08:15.205431 | debian-bookworm | skipping: Conditional result was False 2026-05-04 03:08:15.220391 | 2026-05-04 03:08:15.220505 | PLAY RECAP 2026-05-04 03:08:15.220601 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-04 03:08:15.220628 | 2026-05-04 03:08:15.481618 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-04 03:08:15.482473 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-04 03:08:16.581514 | 2026-05-04 03:08:16.581734 | PLAY [Base post] 2026-05-04 03:08:16.614289 | 2026-05-04 03:08:16.614465 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-04 03:08:17.267168 | debian-bookworm | changed 2026-05-04 03:08:17.282273 | 2026-05-04 03:08:17.282410 | PLAY RECAP 2026-05-04 03:08:17.282474 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-04 03:08:17.282557 | 2026-05-04 03:08:17.599695 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-04 03:08:17.600573 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-04 03:08:18.617996 | 2026-05-04 03:08:18.618208 | PLAY [Base post-logs] 2026-05-04 03:08:18.642798 | 2026-05-04 03:08:18.643007 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-04 03:08:19.642511 | localhost | changed 2026-05-04 03:08:19.664075 | 2026-05-04 03:08:19.664274 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-04 03:08:19.721733 | localhost | ok 2026-05-04 03:08:19.725194 | 2026-05-04 03:08:19.725310 | TASK [Set zuul-log-path fact] 2026-05-04 03:08:19.751571 | localhost | ok 2026-05-04 03:08:19.763572 | 2026-05-04 03:08:19.763728 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-04 03:08:19.840788 | localhost | ok 2026-05-04 03:08:19.844620 | 2026-05-04 03:08:19.844750 | TASK [upload-logs : Create log directories] 2026-05-04 03:08:21.081354 | localhost | changed 2026-05-04 03:08:21.084041 | 2026-05-04 03:08:21.084139 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-04 03:08:21.896307 | localhost -> localhost | ok: Runtime: 0:00:00.010260 2026-05-04 03:08:21.899902 | 2026-05-04 03:08:21.900165 | TASK [upload-logs : Upload logs to log server] 2026-05-04 03:08:22.724425 | localhost | Output suppressed because no_log was given 2026-05-04 03:08:22.726314 | 2026-05-04 03:08:22.726402 | LOOP [upload-logs : Compress console log and json output] 2026-05-04 03:08:22.839896 | localhost | skipping: Conditional result was False 2026-05-04 03:08:22.846654 | localhost | skipping: Conditional result was False 2026-05-04 03:08:22.852795 | 2026-05-04 03:08:22.852888 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-04 03:08:22.902312 | localhost | skipping: Conditional result was False 2026-05-04 03:08:22.902553 | 2026-05-04 03:08:22.914896 | localhost | skipping: Conditional result was False 2026-05-04 03:08:22.917653 | 2026-05-04 03:08:22.917731 | LOOP [upload-logs : Upload console log and json output]