2026-05-22 11:39:00.731081 | Job console starting 2026-05-22 11:39:00.741881 | Updating git repos 2026-05-22 11:39:00.826548 | Cloning repos into workspace 2026-05-22 11:39:00.875948 | Restoring repo states 2026-05-22 11:39:00.900122 | Merging changes 2026-05-22 11:39:01.488227 | Checking out repos 2026-05-22 11:39:01.532249 | Preparing playbooks 2026-05-22 11:39:03.338678 | Running Ansible setup 2026-05-22 11:39:08.852514 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-22 11:39:10.272195 | 2026-05-22 11:39:10.272381 | PLAY [Base pre] 2026-05-22 11:39:10.309056 | 2026-05-22 11:39:10.309184 | TASK [Setup log path fact] 2026-05-22 11:39:10.338934 | debian-bookworm | ok 2026-05-22 11:39:10.355571 | 2026-05-22 11:39:10.355701 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-22 11:39:10.384086 | debian-bookworm | ok 2026-05-22 11:39:10.393704 | 2026-05-22 11:39:10.393804 | TASK [emit-job-header : Print job information] 2026-05-22 11:39:10.472049 | # Job Information 2026-05-22 11:39:10.472209 | Ansible Version: 2.16.14 2026-05-22 11:39:10.472246 | Job: container-image-kolla-ansible-build-2025.1 2026-05-22 11:39:10.472304 | Pipeline: check 2026-05-22 11:39:10.472332 | Executor: 521e9411259a 2026-05-22 11:39:10.472353 | Triggered by: https://github.com/osism/container-image-kolla-ansible/pull/907 2026-05-22 11:39:10.472375 | Event ID: cdac99d0-55d2-11f1-8d47-c4617e559067 2026-05-22 11:39:10.477663 | 2026-05-22 11:39:10.477754 | LOOP [emit-job-header : Print node information] 2026-05-22 11:39:10.642648 | debian-bookworm | ok: 2026-05-22 11:39:10.642949 | debian-bookworm | # Node Information 2026-05-22 11:39:10.642994 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-22 11:39:10.643019 | debian-bookworm | Hostname: debian 2026-05-22 11:39:10.643042 | debian-bookworm | Username: zuul 2026-05-22 11:39:10.643062 | debian-bookworm | Distro: Debian 12.14 2026-05-22 11:39:10.643086 | debian-bookworm | Provider: regiocloud-a 2026-05-22 11:39:10.643106 | debian-bookworm | Region: 2026-05-22 11:39:10.643127 | debian-bookworm | Label: debian-bookworm 2026-05-22 11:39:10.643146 | debian-bookworm | Product Name: OpenStack Nova 2026-05-22 11:39:10.643165 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fefc:bac2 2026-05-22 11:39:10.663721 | 2026-05-22 11:39:10.663836 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-22 11:39:11.401150 | debian-bookworm -> localhost | changed 2026-05-22 11:39:11.407916 | 2026-05-22 11:39:11.408024 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-22 11:39:12.771541 | debian-bookworm -> localhost | changed 2026-05-22 11:39:12.780075 | 2026-05-22 11:39:12.780172 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-22 11:39:13.228705 | debian-bookworm -> localhost | ok 2026-05-22 11:39:13.234622 | 2026-05-22 11:39:13.234722 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-22 11:39:13.263626 | debian-bookworm | ok 2026-05-22 11:39:13.294861 | debian-bookworm | included: /var/lib/zuul/builds/78d7300cd54742e1ad195c1a2343746d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-22 11:39:13.300630 | 2026-05-22 11:39:13.300709 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-22 11:39:14.704517 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-22 11:39:14.704767 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/78d7300cd54742e1ad195c1a2343746d/work/78d7300cd54742e1ad195c1a2343746d_id_rsa 2026-05-22 11:39:14.704835 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/78d7300cd54742e1ad195c1a2343746d/work/78d7300cd54742e1ad195c1a2343746d_id_rsa.pub 2026-05-22 11:39:14.704874 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-22 11:39:14.704907 | debian-bookworm -> localhost | SHA256:Yfcjp0RzhqKEDDquIxrsDzPNFf0j8HintFdcesiciWc zuul-build-sshkey 2026-05-22 11:39:14.704953 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-22 11:39:14.704985 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-22 11:39:14.705015 | debian-bookworm -> localhost | | . | 2026-05-22 11:39:14.705045 | debian-bookworm -> localhost | | . o .. . | 2026-05-22 11:39:14.705074 | debian-bookworm -> localhost | |o oo..+ = o. | 2026-05-22 11:39:14.705102 | debian-bookworm -> localhost | |.. .=o.===* | 2026-05-22 11:39:14.705130 | debian-bookworm -> localhost | | . o.=S=oE+. | 2026-05-22 11:39:14.705167 | debian-bookworm -> localhost | |o o . o =.=+.. | 2026-05-22 11:39:14.705196 | debian-bookworm -> localhost | |== o o .. | 2026-05-22 11:39:14.705225 | debian-bookworm -> localhost | |+o+ . | 2026-05-22 11:39:14.705255 | debian-bookworm -> localhost | |.... | 2026-05-22 11:39:14.705297 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-22 11:39:14.705368 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.783976 2026-05-22 11:39:14.713339 | 2026-05-22 11:39:14.713430 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-22 11:39:14.749959 | debian-bookworm | ok 2026-05-22 11:39:14.766639 | debian-bookworm | included: /var/lib/zuul/builds/78d7300cd54742e1ad195c1a2343746d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-22 11:39:14.776044 | 2026-05-22 11:39:14.776137 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-22 11:39:14.801406 | debian-bookworm | skipping: Conditional result was False 2026-05-22 11:39:14.814227 | 2026-05-22 11:39:14.814404 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-22 11:39:15.453465 | debian-bookworm | changed 2026-05-22 11:39:15.462648 | 2026-05-22 11:39:15.462775 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-22 11:39:15.716439 | debian-bookworm | ok 2026-05-22 11:39:15.723577 | 2026-05-22 11:39:15.723692 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-22 11:39:16.409402 | debian-bookworm | changed 2026-05-22 11:39:16.419952 | 2026-05-22 11:39:16.420075 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-22 11:39:17.080191 | debian-bookworm | changed 2026-05-22 11:39:17.084717 | 2026-05-22 11:39:17.084799 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-22 11:39:17.131822 | debian-bookworm | skipping: Conditional result was False 2026-05-22 11:39:17.136806 | 2026-05-22 11:39:17.136894 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-22 11:39:17.523693 | debian-bookworm -> localhost | changed 2026-05-22 11:39:17.532330 | 2026-05-22 11:39:17.532454 | TASK [add-build-sshkey : Add back temp key] 2026-05-22 11:39:17.870088 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/78d7300cd54742e1ad195c1a2343746d/work/78d7300cd54742e1ad195c1a2343746d_id_rsa (zuul-build-sshkey) 2026-05-22 11:39:17.870289 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011211 2026-05-22 11:39:17.876853 | 2026-05-22 11:39:17.876942 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-22 11:39:18.223445 | debian-bookworm | ok 2026-05-22 11:39:18.230076 | 2026-05-22 11:39:18.230179 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-22 11:39:18.253030 | debian-bookworm | skipping: Conditional result was False 2026-05-22 11:39:18.261554 | 2026-05-22 11:39:18.261642 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-22 11:39:18.673922 | debian-bookworm | ok 2026-05-22 11:39:18.688658 | 2026-05-22 11:39:18.688788 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-22 11:39:18.715887 | debian-bookworm | ok 2026-05-22 11:39:18.719896 | 2026-05-22 11:39:18.719970 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-22 11:39:18.934187 | debian-bookworm -> localhost | ok 2026-05-22 11:39:18.939662 | 2026-05-22 11:39:18.939754 | TASK [validate-host : Collect information about the host] 2026-05-22 11:39:19.978558 | debian-bookworm | ok 2026-05-22 11:39:20.000252 | 2026-05-22 11:39:20.000384 | TASK [validate-host : Sanitize hostname] 2026-05-22 11:39:20.098687 | debian-bookworm | ok 2026-05-22 11:39:20.126444 | 2026-05-22 11:39:20.126538 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-22 11:39:20.680423 | debian-bookworm -> localhost | changed 2026-05-22 11:39:20.684895 | 2026-05-22 11:39:20.684978 | TASK [validate-host : Collect information about zuul worker] 2026-05-22 11:39:21.070748 | debian-bookworm | ok 2026-05-22 11:39:21.075348 | 2026-05-22 11:39:21.075452 | TASK [validate-host : Write out all zuul information for each host] 2026-05-22 11:39:21.655156 | debian-bookworm -> localhost | changed 2026-05-22 11:39:21.662565 | 2026-05-22 11:39:21.662650 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-22 11:39:21.939574 | debian-bookworm | ok 2026-05-22 11:39:21.947406 | 2026-05-22 11:39:21.947499 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-22 11:39:22.753572 | debian-bookworm | changed: 2026-05-22 11:39:22.753741 | debian-bookworm | cd+++++++++ src/ 2026-05-22 11:39:22.753774 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-22 11:39:22.753798 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-22 11:39:22.753820 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-kolla-ansible/ 2026-05-22 11:39:22.753841 | debian-bookworm | Containerfile 2026-05-22 11:39:22.754086 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/78d7300cd54742e1ad195c1a2343746d/work/logs" 2026-05-22 11:51:55.815891 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/78d7300cd54742e1ad195c1a2343746d/work/artifacts" 2026-05-22 11:51:56.100478 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/78d7300cd54742e1ad195c1a2343746d/work/docs" 2026-05-22 11:51:56.115548 | 2026-05-22 11:51:56.115705 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-22 11:51:56.962889 | debian-bookworm | changed: 2026-05-22 11:51:56.963229 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-22 11:51:56.963285 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-22 11:51:56.963346 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-22 11:51:56.963426 | debian-bookworm | changed: All items complete 2026-05-22 11:51:56.963501 | 2026-05-22 11:51:57.648529 | debian-bookworm | changed: .d..t...... ./ 2026-05-22 11:51:58.283411 | debian-bookworm | changed: .d..t...... ./ 2026-05-22 11:51:58.308670 | 2026-05-22 11:51:58.308821 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-22 11:51:58.835737 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.010594 2026-05-22 11:51:59.139751 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.010135 2026-05-22 11:51:59.167331 | 2026-05-22 11:51:59.167551 | PLAY RECAP 2026-05-22 11:51:59.167642 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-22 11:51:59.167686 | 2026-05-22 11:51:59.307318 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-22 11:51:59.309690 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-22 11:52:00.073706 | 2026-05-22 11:52:00.073887 | PLAY [Base post] 2026-05-22 11:52:00.088281 | 2026-05-22 11:52:00.088428 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-22 11:52:00.917480 | debian-bookworm | changed 2026-05-22 11:52:00.926433 | 2026-05-22 11:52:00.926597 | PLAY RECAP 2026-05-22 11:52:00.926677 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-22 11:52:00.926752 | 2026-05-22 11:52:01.056871 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-22 11:52:01.057899 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-22 11:52:01.862257 | 2026-05-22 11:52:01.862474 | PLAY [Base post-logs] 2026-05-22 11:52:01.873957 | 2026-05-22 11:52:01.874127 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-22 11:52:02.337990 | localhost | changed 2026-05-22 11:52:02.353307 | 2026-05-22 11:52:02.353544 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-22 11:52:02.380506 | localhost | ok 2026-05-22 11:52:02.385327 | 2026-05-22 11:52:02.385490 | TASK [Set zuul-log-path fact] 2026-05-22 11:52:02.414660 | localhost | ok 2026-05-22 11:52:02.430393 | 2026-05-22 11:52:02.430639 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-22 11:52:02.460234 | localhost | ok 2026-05-22 11:52:02.467850 | 2026-05-22 11:52:02.468059 | TASK [upload-logs : Create log directories] 2026-05-22 11:52:02.988526 | localhost | changed 2026-05-22 11:52:02.993426 | 2026-05-22 11:52:02.993650 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-22 11:52:03.500523 | localhost -> localhost | ok: Runtime: 0:00:00.007239 2026-05-22 11:52:03.507727 | 2026-05-22 11:52:03.507889 | TASK [upload-logs : Upload logs to log server] 2026-05-22 11:52:04.092586 | localhost | Output suppressed because no_log was given 2026-05-22 11:52:04.094640 | 2026-05-22 11:52:04.094759 | LOOP [upload-logs : Compress console log and json output] 2026-05-22 11:52:04.149242 | localhost | skipping: Conditional result was False 2026-05-22 11:52:04.154491 | localhost | skipping: Conditional result was False 2026-05-22 11:52:04.165905 | 2026-05-22 11:52:04.166131 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-22 11:52:04.215825 | localhost | skipping: Conditional result was False 2026-05-22 11:52:04.216523 | 2026-05-22 11:52:04.220076 | localhost | skipping: Conditional result was False 2026-05-22 11:52:04.228146 | 2026-05-22 11:52:04.228423 | LOOP [upload-logs : Upload console log and json output]