2026-05-08 13:01:28.816423 | Job console starting 2026-05-08 13:01:28.859261 | Updating git repos 2026-05-08 13:01:28.909137 | Cloning repos into workspace 2026-05-08 13:01:28.964454 | Restoring repo states 2026-05-08 13:01:28.994347 | Merging changes 2026-05-08 13:01:29.665221 | Checking out repos 2026-05-08 13:01:29.747956 | Preparing playbooks 2026-05-08 13:01:31.530722 | Running Ansible setup 2026-05-08 13:01:37.790279 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-08 13:01:39.104046 | 2026-05-08 13:01:39.104224 | PLAY [Base pre] 2026-05-08 13:01:39.146347 | 2026-05-08 13:01:39.146527 | TASK [Setup log path fact] 2026-05-08 13:01:39.196780 | debian-bookworm | ok 2026-05-08 13:01:39.213358 | 2026-05-08 13:01:39.213515 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-08 13:01:39.284208 | debian-bookworm | ok 2026-05-08 13:01:39.306047 | 2026-05-08 13:01:39.306193 | TASK [emit-job-header : Print job information] 2026-05-08 13:01:39.416775 | # Job Information 2026-05-08 13:01:39.417089 | Ansible Version: 2.16.14 2026-05-08 13:01:39.417127 | Job: python-black 2026-05-08 13:01:39.417162 | Pipeline: check 2026-05-08 13:01:39.417186 | Executor: 521e9411259a 2026-05-08 13:01:39.417208 | Triggered by: https://github.com/osism/container-image-kolla-ansible/pull/897 2026-05-08 13:01:39.417230 | Event ID: 00f8b350-4ade-11f1-8cee-bc68f5ba7d08 2026-05-08 13:01:39.422364 | 2026-05-08 13:01:39.422482 | LOOP [emit-job-header : Print node information] 2026-05-08 13:01:39.602611 | debian-bookworm | ok: 2026-05-08 13:01:39.606921 | debian-bookworm | # Node Information 2026-05-08 13:01:39.607055 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-08 13:01:39.607086 | debian-bookworm | Hostname: debian 2026-05-08 13:01:39.607110 | debian-bookworm | Username: zuul 2026-05-08 13:01:39.607131 | debian-bookworm | Distro: Debian 12.13 2026-05-08 13:01:39.607158 | debian-bookworm | Provider: regiocloud-a 2026-05-08 13:01:39.607180 | debian-bookworm | Region: 2026-05-08 13:01:39.607201 | debian-bookworm | Label: debian-bookworm 2026-05-08 13:01:39.607221 | debian-bookworm | Product Name: OpenStack Nova 2026-05-08 13:01:39.607241 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe7a:9fd9 2026-05-08 13:01:39.624212 | 2026-05-08 13:01:39.624349 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-08 13:01:40.809803 | debian-bookworm -> localhost | changed 2026-05-08 13:01:40.817948 | 2026-05-08 13:01:40.818064 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-08 13:01:42.732399 | debian-bookworm -> localhost | changed 2026-05-08 13:01:42.743034 | 2026-05-08 13:01:42.743145 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-08 13:01:43.312370 | debian-bookworm -> localhost | ok 2026-05-08 13:01:43.328666 | 2026-05-08 13:01:43.328784 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-08 13:01:43.361338 | debian-bookworm | ok 2026-05-08 13:01:43.386353 | debian-bookworm | included: /var/lib/zuul/builds/57bc6a07c4a24accbeba245f2acdb327/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-08 13:01:43.399633 | 2026-05-08 13:01:43.399744 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-08 13:01:44.643990 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-08 13:01:44.644163 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/57bc6a07c4a24accbeba245f2acdb327/work/57bc6a07c4a24accbeba245f2acdb327_id_rsa 2026-05-08 13:01:44.644195 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/57bc6a07c4a24accbeba245f2acdb327/work/57bc6a07c4a24accbeba245f2acdb327_id_rsa.pub 2026-05-08 13:01:44.644218 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-08 13:01:44.644238 | debian-bookworm -> localhost | SHA256:aW6JODg7mdAxi+3IVCyn6y0vvHC5BLjUG+0L958juZY zuul-build-sshkey 2026-05-08 13:01:44.644266 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-08 13:01:44.644284 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-08 13:01:44.644302 | debian-bookworm -> localhost | | | 2026-05-08 13:01:44.644320 | debian-bookworm -> localhost | | | 2026-05-08 13:01:44.644338 | debian-bookworm -> localhost | | . | 2026-05-08 13:01:44.644355 | debian-bookworm -> localhost | |..++. . | 2026-05-08 13:01:44.644372 | debian-bookworm -> localhost | |o==* . S | 2026-05-08 13:01:44.644391 | debian-bookworm -> localhost | |+=+o+. + . | 2026-05-08 13:01:44.644408 | debian-bookworm -> localhost | |*+B=oo. * | 2026-05-08 13:01:44.644425 | debian-bookworm -> localhost | |oO*+o.oE .. | 2026-05-08 13:01:44.644442 | debian-bookworm -> localhost | |.oB+ ..o+o. | 2026-05-08 13:01:44.644458 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-08 13:01:44.644500 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.412486 2026-05-08 13:01:44.649589 | 2026-05-08 13:01:44.649680 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-08 13:01:44.686303 | debian-bookworm | ok 2026-05-08 13:01:44.693562 | debian-bookworm | included: /var/lib/zuul/builds/57bc6a07c4a24accbeba245f2acdb327/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-08 13:01:44.719134 | 2026-05-08 13:01:44.719236 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-08 13:01:44.742526 | debian-bookworm | skipping: Conditional result was False 2026-05-08 13:01:44.748387 | 2026-05-08 13:01:44.748490 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-08 13:01:45.501011 | debian-bookworm | changed 2026-05-08 13:01:45.505265 | 2026-05-08 13:01:45.505333 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-08 13:01:45.790617 | debian-bookworm | ok 2026-05-08 13:01:45.795279 | 2026-05-08 13:01:45.795359 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-08 13:01:46.533599 | debian-bookworm | changed 2026-05-08 13:01:46.539244 | 2026-05-08 13:01:46.539325 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-08 13:01:47.207854 | debian-bookworm | changed 2026-05-08 13:01:47.213710 | 2026-05-08 13:01:47.213799 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-08 13:01:47.237247 | debian-bookworm | skipping: Conditional result was False 2026-05-08 13:01:47.245586 | 2026-05-08 13:01:47.245726 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-08 13:01:47.666367 | debian-bookworm -> localhost | changed 2026-05-08 13:01:47.683468 | 2026-05-08 13:01:47.683592 | TASK [add-build-sshkey : Add back temp key] 2026-05-08 13:01:48.010357 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/57bc6a07c4a24accbeba245f2acdb327/work/57bc6a07c4a24accbeba245f2acdb327_id_rsa (zuul-build-sshkey) 2026-05-08 13:01:48.010610 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.009074 2026-05-08 13:01:48.019037 | 2026-05-08 13:01:48.019137 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-08 13:01:48.404841 | debian-bookworm | ok 2026-05-08 13:01:48.409760 | 2026-05-08 13:01:48.409849 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-08 13:01:48.446707 | debian-bookworm | skipping: Conditional result was False 2026-05-08 13:01:48.457615 | 2026-05-08 13:01:48.457717 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-08 13:01:48.858849 | debian-bookworm | ok 2026-05-08 13:01:48.869050 | 2026-05-08 13:01:48.869154 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-08 13:01:48.917932 | debian-bookworm | ok 2026-05-08 13:01:48.923116 | 2026-05-08 13:01:48.923209 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-08 13:01:49.371766 | debian-bookworm -> localhost | ok 2026-05-08 13:01:49.378029 | 2026-05-08 13:01:49.378118 | TASK [validate-host : Collect information about the host] 2026-05-08 13:01:50.455800 | debian-bookworm | ok 2026-05-08 13:01:50.475822 | 2026-05-08 13:01:50.475937 | TASK [validate-host : Sanitize hostname] 2026-05-08 13:01:50.582795 | debian-bookworm | ok 2026-05-08 13:01:50.615607 | 2026-05-08 13:01:50.615709 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-08 13:01:51.436576 | debian-bookworm -> localhost | changed 2026-05-08 13:01:51.442302 | 2026-05-08 13:01:51.442410 | TASK [validate-host : Collect information about zuul worker] 2026-05-08 13:01:51.939524 | debian-bookworm | ok 2026-05-08 13:01:51.944429 | 2026-05-08 13:01:51.944532 | TASK [validate-host : Write out all zuul information for each host] 2026-05-08 13:01:52.561441 | debian-bookworm -> localhost | changed 2026-05-08 13:01:52.577772 | 2026-05-08 13:01:52.577904 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-08 13:01:52.858865 | debian-bookworm | ok 2026-05-08 13:01:52.866705 | 2026-05-08 13:01:52.866807 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-08 13:01:54.091140 | debian-bookworm | changed: 2026-05-08 13:01:54.091318 | debian-bookworm | cd+++++++++ src/ 2026-05-08 13:01:54.091353 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-08 13:01:54.091377 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-08 13:01:54.091400 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-kolla-ansible/ 2026-05-08 13:01:54.091421 | debian-bookworm | Containerfile 2026-05-08 13:01:54.091575 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/57bc6a07c4a24accbeba245f2acdb327/work/logs" 2026-05-08 13:02:20.681202 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/57bc6a07c4a24accbeba245f2acdb327/work/artifacts" 2026-05-08 13:02:20.996907 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/57bc6a07c4a24accbeba245f2acdb327/work/docs" 2026-05-08 13:02:21.016954 | 2026-05-08 13:02:21.017201 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-08 13:02:21.880303 | debian-bookworm | changed: 2026-05-08 13:02:21.880763 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-08 13:02:21.880840 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-08 13:02:21.880894 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-08 13:02:21.880973 | debian-bookworm | changed: All items complete 2026-05-08 13:02:21.881079 | 2026-05-08 13:02:22.472858 | debian-bookworm | changed: .d..t...... ./ 2026-05-08 13:02:23.073151 | debian-bookworm | changed: .d..t...... ./ 2026-05-08 13:02:23.098250 | 2026-05-08 13:02:23.098422 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-08 13:02:23.681172 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.011602 2026-05-08 13:02:23.985571 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.009388 2026-05-08 13:02:23.999380 | 2026-05-08 13:02:23.999510 | PLAY RECAP 2026-05-08 13:02:23.999583 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-08 13:02:23.999617 | 2026-05-08 13:02:24.155472 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-08 13:02:24.156466 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-08 13:02:24.946511 | 2026-05-08 13:02:24.946676 | PLAY [Base post] 2026-05-08 13:02:24.962389 | 2026-05-08 13:02:24.962542 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-08 13:02:25.605907 | debian-bookworm | changed 2026-05-08 13:02:25.613865 | 2026-05-08 13:02:25.614062 | PLAY RECAP 2026-05-08 13:02:25.614137 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-08 13:02:25.614205 | 2026-05-08 13:02:25.769322 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-08 13:02:25.770310 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-08 13:02:26.673704 | 2026-05-08 13:02:26.673932 | PLAY [Base post-logs] 2026-05-08 13:02:26.685900 | 2026-05-08 13:02:26.686117 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-08 13:02:27.213539 | localhost | changed 2026-05-08 13:02:27.232366 | 2026-05-08 13:02:27.232575 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-08 13:02:27.260495 | localhost | ok 2026-05-08 13:02:27.266207 | 2026-05-08 13:02:27.266382 | TASK [Set zuul-log-path fact] 2026-05-08 13:02:27.285440 | localhost | ok 2026-05-08 13:02:27.302057 | 2026-05-08 13:02:27.302236 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-08 13:02:27.339637 | localhost | ok 2026-05-08 13:02:27.344744 | 2026-05-08 13:02:27.344886 | TASK [upload-logs : Create log directories] 2026-05-08 13:02:27.898769 | localhost | changed 2026-05-08 13:02:27.902424 | 2026-05-08 13:02:27.902550 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-08 13:02:28.407886 | localhost -> localhost | ok: Runtime: 0:00:00.005659 2026-05-08 13:02:28.416129 | 2026-05-08 13:02:28.416296 | TASK [upload-logs : Upload logs to log server] 2026-05-08 13:02:29.021781 | localhost | Output suppressed because no_log was given 2026-05-08 13:02:29.023714 | 2026-05-08 13:02:29.023819 | LOOP [upload-logs : Compress console log and json output] 2026-05-08 13:02:29.091120 | localhost | skipping: Conditional result was False 2026-05-08 13:02:29.108033 | localhost | skipping: Conditional result was False 2026-05-08 13:02:29.121950 | 2026-05-08 13:02:29.122167 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-08 13:02:29.173229 | localhost | skipping: Conditional result was False 2026-05-08 13:02:29.173550 | 2026-05-08 13:02:29.178481 | localhost | skipping: Conditional result was False 2026-05-08 13:02:29.188294 | 2026-05-08 13:02:29.188413 | LOOP [upload-logs : Upload console log and json output]