2026-05-28 03:02:27.541458 | Job console starting 2026-05-28 03:02:27.567305 | Updating git repos 2026-05-28 03:02:27.601552 | Cloning repos into workspace 2026-05-28 03:02:27.662414 | Restoring repo states 2026-05-28 03:02:27.671908 | Merging changes 2026-05-28 03:02:27.671924 | Checking out repos 2026-05-28 03:02:27.705559 | Preparing playbooks 2026-05-28 03:02:28.416741 | Running Ansible setup 2026-05-28 03:02:32.409694 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-28 03:02:33.474285 | 2026-05-28 03:02:33.474462 | PLAY [Base pre] 2026-05-28 03:02:33.506020 | 2026-05-28 03:02:33.506179 | TASK [Setup log path fact] 2026-05-28 03:02:33.550703 | debian-bookworm | ok 2026-05-28 03:02:33.600448 | 2026-05-28 03:02:33.600635 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-28 03:02:33.636209 | debian-bookworm | ok 2026-05-28 03:02:33.647734 | 2026-05-28 03:02:33.647864 | TASK [emit-job-header : Print job information] 2026-05-28 03:02:33.688210 | # Job Information 2026-05-28 03:02:33.688408 | Ansible Version: 2.16.14 2026-05-28 03:02:33.688442 | Job: python-black 2026-05-28 03:02:33.688475 | Pipeline: periodic-daily 2026-05-28 03:02:33.688498 | Executor: 521e9411259a 2026-05-28 03:02:33.688520 | Triggered by: https://github.com/osism/openstack-image-manager 2026-05-28 03:02:33.688542 | Event ID: 2e6ab29f0470417084c80d9a36bada5e 2026-05-28 03:02:33.693851 | 2026-05-28 03:02:33.693977 | LOOP [emit-job-header : Print node information] 2026-05-28 03:02:33.938798 | debian-bookworm | ok: 2026-05-28 03:02:33.939105 | debian-bookworm | # Node Information 2026-05-28 03:02:33.939145 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-28 03:02:33.939171 | debian-bookworm | Hostname: debian 2026-05-28 03:02:33.939194 | debian-bookworm | Username: zuul 2026-05-28 03:02:33.939215 | debian-bookworm | Distro: Debian 12.14 2026-05-28 03:02:33.939239 | debian-bookworm | Provider: regiocloud-a 2026-05-28 03:02:33.939260 | debian-bookworm | Region: 2026-05-28 03:02:33.939282 | debian-bookworm | Label: debian-bookworm 2026-05-28 03:02:33.939301 | debian-bookworm | Product Name: OpenStack Nova 2026-05-28 03:02:33.939320 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fed1:7567 2026-05-28 03:02:33.953546 | 2026-05-28 03:02:33.953717 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-28 03:02:34.884433 | debian-bookworm -> localhost | changed 2026-05-28 03:02:34.894229 | 2026-05-28 03:02:34.894393 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-28 03:02:36.431976 | debian-bookworm -> localhost | changed 2026-05-28 03:02:36.443953 | 2026-05-28 03:02:36.444059 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-28 03:02:36.779107 | debian-bookworm -> localhost | ok 2026-05-28 03:02:36.785006 | 2026-05-28 03:02:36.785104 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-28 03:02:36.804866 | debian-bookworm | ok 2026-05-28 03:02:36.821432 | debian-bookworm | included: /var/lib/zuul/builds/567f3d9fd1d6434c881a5534e01b0de0/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-28 03:02:36.827864 | 2026-05-28 03:02:36.827951 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-28 03:02:40.667241 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-28 03:02:40.667429 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/567f3d9fd1d6434c881a5534e01b0de0/work/567f3d9fd1d6434c881a5534e01b0de0_id_rsa 2026-05-28 03:02:40.667462 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/567f3d9fd1d6434c881a5534e01b0de0/work/567f3d9fd1d6434c881a5534e01b0de0_id_rsa.pub 2026-05-28 03:02:40.667484 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-28 03:02:40.667504 | debian-bookworm -> localhost | SHA256:zDwh+QIKRdnM7OF63ylOyxxb+VoI9zyeaRTWVKKp4SY zuul-build-sshkey 2026-05-28 03:02:40.667522 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-28 03:02:40.667547 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-28 03:02:40.667566 | debian-bookworm -> localhost | | .o* ... | 2026-05-28 03:02:40.667584 | debian-bookworm -> localhost | | .. * . o.. | 2026-05-28 03:02:40.667601 | debian-bookworm -> localhost | |. o..o o oo | 2026-05-28 03:02:40.667617 | debian-bookworm -> localhost | | . .o. B +o . | 2026-05-28 03:02:40.667634 | debian-bookworm -> localhost | | .. E S. . | 2026-05-28 03:02:40.667656 | debian-bookworm -> localhost | | . . * *. | 2026-05-28 03:02:40.667674 | debian-bookworm -> localhost | | . .o.+o= | 2026-05-28 03:02:40.667704 | debian-bookworm -> localhost | | +o=o+.+ | 2026-05-28 03:02:40.667722 | debian-bookworm -> localhost | | .*..o= | 2026-05-28 03:02:40.667739 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-28 03:02:40.667782 | debian-bookworm -> localhost | ok: Runtime: 0:00:03.303899 2026-05-28 03:02:40.672807 | 2026-05-28 03:02:40.672884 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-28 03:02:40.699036 | debian-bookworm | ok 2026-05-28 03:02:40.706167 | debian-bookworm | included: /var/lib/zuul/builds/567f3d9fd1d6434c881a5534e01b0de0/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-28 03:02:40.730968 | 2026-05-28 03:02:40.731082 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-28 03:02:40.763895 | debian-bookworm | skipping: Conditional result was False 2026-05-28 03:02:40.768701 | 2026-05-28 03:02:40.768786 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-28 03:02:41.435717 | debian-bookworm | changed 2026-05-28 03:02:41.440002 | 2026-05-28 03:02:41.440080 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-28 03:02:41.770448 | debian-bookworm | ok 2026-05-28 03:02:41.774818 | 2026-05-28 03:02:41.775085 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-28 03:02:42.561408 | debian-bookworm | changed 2026-05-28 03:02:42.566937 | 2026-05-28 03:02:42.567018 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-28 03:02:43.352261 | debian-bookworm | changed 2026-05-28 03:02:43.357183 | 2026-05-28 03:02:43.357264 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-28 03:02:43.381432 | debian-bookworm | skipping: Conditional result was False 2026-05-28 03:02:43.391032 | 2026-05-28 03:02:43.391190 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-28 03:02:44.405503 | debian-bookworm -> localhost | changed 2026-05-28 03:02:44.414922 | 2026-05-28 03:02:44.415008 | TASK [add-build-sshkey : Add back temp key] 2026-05-28 03:02:45.361016 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/567f3d9fd1d6434c881a5534e01b0de0/work/567f3d9fd1d6434c881a5534e01b0de0_id_rsa (zuul-build-sshkey) 2026-05-28 03:02:45.361236 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.027022 2026-05-28 03:02:45.369964 | 2026-05-28 03:02:45.370053 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-28 03:02:46.099157 | debian-bookworm | ok 2026-05-28 03:02:46.105995 | 2026-05-28 03:02:46.106182 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-28 03:02:46.151061 | debian-bookworm | skipping: Conditional result was False 2026-05-28 03:02:46.163106 | 2026-05-28 03:02:46.163408 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-28 03:02:46.828763 | debian-bookworm | ok 2026-05-28 03:02:46.844174 | 2026-05-28 03:02:46.844272 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-28 03:02:46.888330 | debian-bookworm | ok 2026-05-28 03:02:46.914289 | 2026-05-28 03:02:46.915082 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-28 03:02:47.333664 | debian-bookworm -> localhost | ok 2026-05-28 03:02:47.339103 | 2026-05-28 03:02:47.339188 | TASK [validate-host : Collect information about the host] 2026-05-28 03:02:48.430411 | debian-bookworm | ok 2026-05-28 03:02:48.458669 | 2026-05-28 03:02:48.458942 | TASK [validate-host : Sanitize hostname] 2026-05-28 03:02:48.670239 | debian-bookworm | ok 2026-05-28 03:02:48.758063 | 2026-05-28 03:02:48.758484 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-28 03:02:49.705933 | debian-bookworm -> localhost | changed 2026-05-28 03:02:49.717134 | 2026-05-28 03:02:49.717261 | TASK [validate-host : Collect information about zuul worker] 2026-05-28 03:02:50.127755 | debian-bookworm | ok 2026-05-28 03:02:50.135455 | 2026-05-28 03:02:50.135579 | TASK [validate-host : Write out all zuul information for each host] 2026-05-28 03:02:50.644667 | debian-bookworm -> localhost | changed 2026-05-28 03:02:50.653854 | 2026-05-28 03:02:50.653956 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-28 03:02:50.946736 | debian-bookworm | ok 2026-05-28 03:02:50.951847 | 2026-05-28 03:02:50.951933 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-28 03:02:52.154374 | debian-bookworm | changed: 2026-05-28 03:02:52.154567 | debian-bookworm | cd+++++++++ src/ 2026-05-28 03:02:52.154600 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-28 03:02:52.154624 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-28 03:02:52.154646 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-05-28 03:02:52.154666 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/567f3d9fd1d6434c881a5534e01b0de0/work/logs" 2026-05-28 03:03:21.175221 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/567f3d9fd1d6434c881a5534e01b0de0/work/artifacts" 2026-05-28 03:03:21.661938 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/567f3d9fd1d6434c881a5534e01b0de0/work/docs" 2026-05-28 03:03:21.675477 | 2026-05-28 03:03:21.675618 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-28 03:03:22.991180 | debian-bookworm | changed: 2026-05-28 03:03:22.991359 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-28 03:03:22.991393 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-28 03:03:22.991422 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-28 03:03:22.991463 | debian-bookworm | changed: All items complete 2026-05-28 03:03:22.991485 | 2026-05-28 03:03:23.612230 | debian-bookworm | changed: .d..t...... ./ 2026-05-28 03:03:24.295403 | debian-bookworm | changed: .d..t...... ./ 2026-05-28 03:03:24.310458 | 2026-05-28 03:03:24.310568 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-28 03:03:24.357822 | debian-bookworm | skipping: Conditional result was False 2026-05-28 03:03:24.361340 | debian-bookworm | skipping: Conditional result was False 2026-05-28 03:03:24.371249 | 2026-05-28 03:03:24.371319 | PLAY RECAP 2026-05-28 03:03:24.371358 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-05-28 03:03:24.371378 | 2026-05-28 03:03:24.583666 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-28 03:03:24.584355 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-28 03:03:25.433290 | 2026-05-28 03:03:25.433401 | PLAY [Base post] 2026-05-28 03:03:25.443570 | 2026-05-28 03:03:25.443677 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-28 03:03:26.000117 | debian-bookworm | changed 2026-05-28 03:03:26.005001 | 2026-05-28 03:03:26.005075 | PLAY RECAP 2026-05-28 03:03:26.005124 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-28 03:03:26.005175 | 2026-05-28 03:03:26.219343 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-28 03:03:26.219962 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-28 03:03:27.191322 | 2026-05-28 03:03:27.191435 | PLAY [Base post-logs] 2026-05-28 03:03:27.199474 | 2026-05-28 03:03:27.199574 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-28 03:03:27.547991 | localhost | changed 2026-05-28 03:03:27.557197 | 2026-05-28 03:03:27.557320 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-28 03:03:27.581805 | localhost | ok 2026-05-28 03:03:27.584559 | 2026-05-28 03:03:27.584640 | TASK [Set zuul-log-path fact] 2026-05-28 03:03:27.599129 | localhost | ok 2026-05-28 03:03:27.606587 | 2026-05-28 03:03:27.606685 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-28 03:03:27.632742 | localhost | ok 2026-05-28 03:03:27.649093 | 2026-05-28 03:03:27.649216 | TASK [upload-logs : Create log directories] 2026-05-28 03:03:28.165492 | localhost | changed 2026-05-28 03:03:28.167737 | 2026-05-28 03:03:28.167811 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-28 03:03:28.771530 | localhost -> localhost | ok: Runtime: 0:00:00.011172 2026-05-28 03:03:28.775230 | 2026-05-28 03:03:28.775326 | TASK [upload-logs : Upload logs to log server] 2026-05-28 03:03:29.758234 | localhost | Output suppressed because no_log was given 2026-05-28 03:03:29.760164 | 2026-05-28 03:03:29.760255 | LOOP [upload-logs : Compress console log and json output] 2026-05-28 03:03:29.827950 | localhost | skipping: Conditional result was False 2026-05-28 03:03:29.834958 | localhost | skipping: Conditional result was False 2026-05-28 03:03:29.846408 | 2026-05-28 03:03:29.846520 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-28 03:03:29.892441 | localhost | skipping: Conditional result was False 2026-05-28 03:03:29.892712 | 2026-05-28 03:03:29.899312 | localhost | skipping: Conditional result was False 2026-05-28 03:03:29.902744 | 2026-05-28 03:03:29.903098 | LOOP [upload-logs : Upload console log and json output]