2026-05-24 15:31:27.480209 | Job console starting 2026-05-24 15:31:27.507748 | Updating git repos 2026-05-24 15:31:27.599997 | Cloning repos into workspace 2026-05-24 15:31:27.715736 | Restoring repo states 2026-05-24 15:31:27.733858 | Merging changes 2026-05-24 15:31:28.333488 | Checking out repos 2026-05-24 15:31:28.389933 | Preparing playbooks 2026-05-24 15:31:29.772967 | Running Ansible setup 2026-05-24 15:31:35.666960 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-24 15:31:36.764788 | 2026-05-24 15:31:36.764964 | PLAY [Base pre] 2026-05-24 15:31:36.783294 | 2026-05-24 15:31:36.783449 | TASK [Setup log path fact] 2026-05-24 15:31:36.823670 | debian-bookworm | ok 2026-05-24 15:31:36.857413 | 2026-05-24 15:31:36.857592 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-24 15:31:36.897126 | debian-bookworm | ok 2026-05-24 15:31:36.917931 | 2026-05-24 15:31:36.918124 | TASK [emit-job-header : Print job information] 2026-05-24 15:31:36.998240 | # Job Information 2026-05-24 15:31:36.998444 | Ansible Version: 2.16.14 2026-05-24 15:31:36.998479 | Job: python-black 2026-05-24 15:31:36.998511 | Pipeline: check 2026-05-24 15:31:36.998534 | Executor: 521e9411259a 2026-05-24 15:31:36.998555 | Triggered by: https://github.com/osism/container-image-kolla-ansible/pull/908 2026-05-24 15:31:36.998577 | Event ID: 9c6556be-5785-11f1-9001-8a2529fcc724 2026-05-24 15:31:37.011170 | 2026-05-24 15:31:37.011341 | LOOP [emit-job-header : Print node information] 2026-05-24 15:31:37.222822 | debian-bookworm | ok: 2026-05-24 15:31:37.223254 | debian-bookworm | # Node Information 2026-05-24 15:31:37.223302 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-24 15:31:37.223328 | debian-bookworm | Hostname: debian 2026-05-24 15:31:37.223351 | debian-bookworm | Username: zuul 2026-05-24 15:31:37.223371 | debian-bookworm | Distro: Debian 12.14 2026-05-24 15:31:37.223395 | debian-bookworm | Provider: regiocloud-a 2026-05-24 15:31:37.223416 | debian-bookworm | Region: 2026-05-24 15:31:37.223438 | debian-bookworm | Label: debian-bookworm 2026-05-24 15:31:37.223459 | debian-bookworm | Product Name: OpenStack Nova 2026-05-24 15:31:37.223479 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fea3:3d1f 2026-05-24 15:31:37.252992 | 2026-05-24 15:31:37.262908 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-24 15:31:38.529922 | debian-bookworm -> localhost | changed 2026-05-24 15:31:38.537617 | 2026-05-24 15:31:38.537765 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-24 15:31:40.464204 | debian-bookworm -> localhost | changed 2026-05-24 15:31:40.475410 | 2026-05-24 15:31:40.475543 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-24 15:31:41.166118 | debian-bookworm -> localhost | ok 2026-05-24 15:31:41.172249 | 2026-05-24 15:31:41.172356 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-24 15:31:41.202425 | debian-bookworm | ok 2026-05-24 15:31:41.236515 | debian-bookworm | included: /var/lib/zuul/builds/cfb6e60d8eec4892962cff8144bd41eb/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-24 15:31:41.246780 | 2026-05-24 15:31:41.246910 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-24 15:31:44.085562 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-24 15:31:44.085762 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/cfb6e60d8eec4892962cff8144bd41eb/work/cfb6e60d8eec4892962cff8144bd41eb_id_rsa 2026-05-24 15:31:44.085802 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/cfb6e60d8eec4892962cff8144bd41eb/work/cfb6e60d8eec4892962cff8144bd41eb_id_rsa.pub 2026-05-24 15:31:44.085829 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-24 15:31:44.085853 | debian-bookworm -> localhost | SHA256:S4oLJpmb5WTBqh8I1a221ZJQCk9AggBueuvtnkbeWtc zuul-build-sshkey 2026-05-24 15:31:44.085884 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-24 15:31:44.085906 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-24 15:31:44.085927 | debian-bookworm -> localhost | |B.+.. . | 2026-05-24 15:31:44.085948 | debian-bookworm -> localhost | |o. = + | 2026-05-24 15:31:44.085968 | debian-bookworm -> localhost | | o. = . | 2026-05-24 15:31:44.085987 | debian-bookworm -> localhost | |oo o o | 2026-05-24 15:31:44.086006 | debian-bookworm -> localhost | |o + o + S | 2026-05-24 15:31:44.086031 | debian-bookworm -> localhost | |.* +.+ + o | 2026-05-24 15:31:44.086052 | debian-bookworm -> localhost | |* Ooo.o o E | 2026-05-24 15:31:44.086085 | debian-bookworm -> localhost | |.@ +o+.. | 2026-05-24 15:31:44.086106 | debian-bookworm -> localhost | |+.++B. | 2026-05-24 15:31:44.086126 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-24 15:31:44.086175 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.235987 2026-05-24 15:31:44.092239 | 2026-05-24 15:31:44.092338 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-24 15:31:44.119587 | debian-bookworm | ok 2026-05-24 15:31:44.128632 | debian-bookworm | included: /var/lib/zuul/builds/cfb6e60d8eec4892962cff8144bd41eb/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-24 15:31:44.138921 | 2026-05-24 15:31:44.139024 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-24 15:31:44.152407 | debian-bookworm | skipping: Conditional result was False 2026-05-24 15:31:44.159075 | 2026-05-24 15:31:44.159185 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-24 15:31:44.795875 | debian-bookworm | changed 2026-05-24 15:31:44.804368 | 2026-05-24 15:31:44.804585 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-24 15:31:45.045386 | debian-bookworm | ok 2026-05-24 15:31:45.051019 | 2026-05-24 15:31:45.051114 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-24 15:31:45.669999 | debian-bookworm | changed 2026-05-24 15:31:45.681549 | 2026-05-24 15:31:45.681654 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-24 15:31:46.335773 | debian-bookworm | changed 2026-05-24 15:31:46.345837 | 2026-05-24 15:31:46.345952 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-24 15:31:46.397875 | debian-bookworm | skipping: Conditional result was False 2026-05-24 15:31:46.403823 | 2026-05-24 15:31:46.403924 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-24 15:31:46.964957 | debian-bookworm -> localhost | changed 2026-05-24 15:31:46.973537 | 2026-05-24 15:31:46.973627 | TASK [add-build-sshkey : Add back temp key] 2026-05-24 15:31:47.351713 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/cfb6e60d8eec4892962cff8144bd41eb/work/cfb6e60d8eec4892962cff8144bd41eb_id_rsa (zuul-build-sshkey) 2026-05-24 15:31:47.351928 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011135 2026-05-24 15:31:47.362485 | 2026-05-24 15:31:47.362590 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-24 15:31:47.789165 | debian-bookworm | ok 2026-05-24 15:31:47.798528 | 2026-05-24 15:31:47.798644 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-24 15:31:47.821571 | debian-bookworm | skipping: Conditional result was False 2026-05-24 15:31:47.832500 | 2026-05-24 15:31:47.832618 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-24 15:31:48.227686 | debian-bookworm | ok 2026-05-24 15:31:48.237999 | 2026-05-24 15:31:48.238111 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-24 15:31:48.272041 | debian-bookworm | ok 2026-05-24 15:31:48.279792 | 2026-05-24 15:31:48.279918 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-24 15:31:48.688693 | debian-bookworm -> localhost | ok 2026-05-24 15:31:48.695540 | 2026-05-24 15:31:48.695667 | TASK [validate-host : Collect information about the host] 2026-05-24 15:31:49.956830 | debian-bookworm | ok 2026-05-24 15:31:49.978050 | 2026-05-24 15:31:49.978218 | TASK [validate-host : Sanitize hostname] 2026-05-24 15:31:50.170663 | debian-bookworm | ok 2026-05-24 15:31:50.266544 | 2026-05-24 15:31:50.266708 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-24 15:31:51.429126 | debian-bookworm -> localhost | changed 2026-05-24 15:31:51.435436 | 2026-05-24 15:31:51.435570 | TASK [validate-host : Collect information about zuul worker] 2026-05-24 15:31:51.852600 | debian-bookworm | ok 2026-05-24 15:31:51.857647 | 2026-05-24 15:31:51.857778 | TASK [validate-host : Write out all zuul information for each host] 2026-05-24 15:31:52.520421 | debian-bookworm -> localhost | changed 2026-05-24 15:31:52.530652 | 2026-05-24 15:31:52.530777 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-24 15:31:52.801619 | debian-bookworm | ok 2026-05-24 15:31:52.807583 | 2026-05-24 15:31:52.807699 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-24 15:31:53.671837 | debian-bookworm | changed: 2026-05-24 15:31:53.672045 | debian-bookworm | cd+++++++++ src/ 2026-05-24 15:31:53.672105 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-24 15:31:53.672138 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-24 15:31:53.672169 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-kolla-ansible/ 2026-05-24 15:31:53.672200 | debian-bookworm | Containerfile 2026-05-24 15:31:53.672429 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/cfb6e60d8eec4892962cff8144bd41eb/work/logs" 2026-05-24 15:32:20.155535 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/cfb6e60d8eec4892962cff8144bd41eb/work/artifacts" 2026-05-24 15:32:20.432463 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/cfb6e60d8eec4892962cff8144bd41eb/work/docs" 2026-05-24 15:32:20.443487 | 2026-05-24 15:32:20.443627 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-24 15:32:21.216396 | debian-bookworm | changed: 2026-05-24 15:32:21.216695 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-24 15:32:21.216741 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-24 15:32:21.216790 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-24 15:32:21.216847 | debian-bookworm | changed: All items complete 2026-05-24 15:32:21.216881 | 2026-05-24 15:32:21.805596 | debian-bookworm | changed: .d..t...... ./ 2026-05-24 15:32:22.420319 | debian-bookworm | changed: .d..t...... ./ 2026-05-24 15:32:22.443495 | 2026-05-24 15:32:22.443667 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-24 15:32:23.170737 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.006841 2026-05-24 15:32:23.451561 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.006350 2026-05-24 15:32:23.469456 | 2026-05-24 15:32:23.469565 | PLAY RECAP 2026-05-24 15:32:23.469615 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-24 15:32:23.469640 | 2026-05-24 15:32:23.604406 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-24 15:32:23.605255 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-24 15:32:24.451850 | 2026-05-24 15:32:24.452030 | PLAY [Base post] 2026-05-24 15:32:24.466228 | 2026-05-24 15:32:24.466394 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-24 15:32:25.032791 | debian-bookworm | changed 2026-05-24 15:32:25.039530 | 2026-05-24 15:32:25.039805 | PLAY RECAP 2026-05-24 15:32:25.039988 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-24 15:32:25.040282 | 2026-05-24 15:32:25.183766 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-24 15:32:25.185219 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-24 15:32:26.072644 | 2026-05-24 15:32:26.072837 | PLAY [Base post-logs] 2026-05-24 15:32:26.084419 | 2026-05-24 15:32:26.084598 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-24 15:32:26.578459 | localhost | changed 2026-05-24 15:32:26.588823 | 2026-05-24 15:32:26.589020 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-24 15:32:26.615947 | localhost | ok 2026-05-24 15:32:26.619811 | 2026-05-24 15:32:26.619960 | TASK [Set zuul-log-path fact] 2026-05-24 15:32:26.638629 | localhost | ok 2026-05-24 15:32:26.648943 | 2026-05-24 15:32:26.649091 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-24 15:32:26.696247 | localhost | ok 2026-05-24 15:32:26.699544 | 2026-05-24 15:32:26.699666 | TASK [upload-logs : Create log directories] 2026-05-24 15:32:27.278012 | localhost | changed 2026-05-24 15:32:27.280870 | 2026-05-24 15:32:27.280977 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-24 15:32:27.829148 | localhost -> localhost | ok: Runtime: 0:00:00.006268 2026-05-24 15:32:27.837342 | 2026-05-24 15:32:27.837525 | TASK [upload-logs : Upload logs to log server] 2026-05-24 15:32:28.932029 | localhost | Output suppressed because no_log was given 2026-05-24 15:32:28.939204 | 2026-05-24 15:32:28.939336 | LOOP [upload-logs : Compress console log and json output] 2026-05-24 15:32:29.001675 | localhost | skipping: Conditional result was False 2026-05-24 15:32:29.009742 | localhost | skipping: Conditional result was False 2026-05-24 15:32:29.021631 | 2026-05-24 15:32:29.021765 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-24 15:32:29.079255 | localhost | skipping: Conditional result was False 2026-05-24 15:32:29.079704 | 2026-05-24 15:32:29.086395 | localhost | skipping: Conditional result was False 2026-05-24 15:32:29.093539 | 2026-05-24 15:32:29.093810 | LOOP [upload-logs : Upload console log and json output]