2026-05-15 09:10:38.732875 | Job console starting 2026-05-15 09:10:38.751352 | Updating git repos 2026-05-15 09:10:38.823294 | Cloning repos into workspace 2026-05-15 09:10:38.873396 | Restoring repo states 2026-05-15 09:10:38.902456 | Merging changes 2026-05-15 09:10:39.545569 | Checking out repos 2026-05-15 09:10:39.597736 | Preparing playbooks 2026-05-15 09:10:41.040335 | Running Ansible setup 2026-05-15 09:10:48.069487 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-15 09:10:49.255807 | 2026-05-15 09:10:49.255924 | PLAY [Base pre] 2026-05-15 09:10:49.281612 | 2026-05-15 09:10:49.281729 | TASK [Setup log path fact] 2026-05-15 09:10:49.317787 | debian-bookworm | ok 2026-05-15 09:10:49.336002 | 2026-05-15 09:10:49.336130 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-15 09:10:49.393021 | debian-bookworm | ok 2026-05-15 09:10:49.400825 | 2026-05-15 09:10:49.400917 | TASK [emit-job-header : Print job information] 2026-05-15 09:10:49.466377 | # Job Information 2026-05-15 09:10:49.466521 | Ansible Version: 2.16.14 2026-05-15 09:10:49.466549 | Job: python-black 2026-05-15 09:10:49.466577 | Pipeline: check 2026-05-15 09:10:49.466597 | Executor: 521e9411259a 2026-05-15 09:10:49.466614 | Triggered by: https://github.com/osism/container-image-kolla-ansible/pull/903 2026-05-15 09:10:49.466632 | Event ID: ea746600-503d-11f1-9b37-9e37aa2bda22 2026-05-15 09:10:49.470570 | 2026-05-15 09:10:49.470656 | LOOP [emit-job-header : Print node information] 2026-05-15 09:10:49.594451 | debian-bookworm | ok: 2026-05-15 09:10:49.594711 | debian-bookworm | # Node Information 2026-05-15 09:10:49.594755 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-15 09:10:49.594805 | debian-bookworm | Hostname: debian 2026-05-15 09:10:49.594828 | debian-bookworm | Username: zuul 2026-05-15 09:10:49.594863 | debian-bookworm | Distro: Debian 12.13 2026-05-15 09:10:49.594887 | debian-bookworm | Provider: regiocloud-a 2026-05-15 09:10:49.594909 | debian-bookworm | Region: 2026-05-15 09:10:49.594931 | debian-bookworm | Label: debian-bookworm 2026-05-15 09:10:49.594951 | debian-bookworm | Product Name: OpenStack Nova 2026-05-15 09:10:49.594970 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fea4:1321 2026-05-15 09:10:49.613656 | 2026-05-15 09:10:49.613761 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-15 09:10:50.461105 | debian-bookworm -> localhost | changed 2026-05-15 09:10:50.467080 | 2026-05-15 09:10:50.467177 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-15 09:10:52.180006 | debian-bookworm -> localhost | changed 2026-05-15 09:10:52.188944 | 2026-05-15 09:10:52.189040 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-15 09:10:52.723478 | debian-bookworm -> localhost | ok 2026-05-15 09:10:52.731633 | 2026-05-15 09:10:52.731727 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-15 09:10:52.759685 | debian-bookworm | ok 2026-05-15 09:10:52.784064 | debian-bookworm | included: /var/lib/zuul/builds/f903770d442a4ee3a64f87d9d34104f2/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-15 09:10:52.788982 | 2026-05-15 09:10:52.789054 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-15 09:10:55.219537 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-15 09:10:55.219731 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/f903770d442a4ee3a64f87d9d34104f2/work/f903770d442a4ee3a64f87d9d34104f2_id_rsa 2026-05-15 09:10:55.219776 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/f903770d442a4ee3a64f87d9d34104f2/work/f903770d442a4ee3a64f87d9d34104f2_id_rsa.pub 2026-05-15 09:10:55.219804 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-15 09:10:55.219829 | debian-bookworm -> localhost | SHA256:wFzKtC1ZpFJpIadu/iF+7frDVkkn43K51BIb2OwNkPM zuul-build-sshkey 2026-05-15 09:10:55.219862 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-15 09:10:55.219885 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-15 09:10:55.219906 | debian-bookworm -> localhost | | . =++. | 2026-05-15 09:10:55.219927 | debian-bookworm -> localhost | | XoO+ | 2026-05-15 09:10:55.219947 | debian-bookworm -> localhost | | o.@ .B | 2026-05-15 09:10:55.219966 | debian-bookworm -> localhost | | . . o. E . | 2026-05-15 09:10:55.219985 | debian-bookworm -> localhost | | o S+ & | 2026-05-15 09:10:55.220007 | debian-bookworm -> localhost | | o . @ o | 2026-05-15 09:10:55.220028 | debian-bookworm -> localhost | | o .o = o | 2026-05-15 09:10:55.220048 | debian-bookworm -> localhost | | . o..= . | 2026-05-15 09:10:55.220068 | debian-bookworm -> localhost | | ..o=o. | 2026-05-15 09:10:55.220089 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-15 09:10:55.220138 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.574029 2026-05-15 09:10:55.226243 | 2026-05-15 09:10:55.226338 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-15 09:10:55.254164 | debian-bookworm | ok 2026-05-15 09:10:55.269906 | debian-bookworm | included: /var/lib/zuul/builds/f903770d442a4ee3a64f87d9d34104f2/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-15 09:10:55.290334 | 2026-05-15 09:10:55.290439 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-15 09:10:55.315126 | debian-bookworm | skipping: Conditional result was False 2026-05-15 09:10:55.321435 | 2026-05-15 09:10:55.321536 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-15 09:10:56.233107 | debian-bookworm | changed 2026-05-15 09:10:56.240566 | 2026-05-15 09:10:56.240691 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-15 09:10:56.501309 | debian-bookworm | ok 2026-05-15 09:10:56.509913 | 2026-05-15 09:10:56.510134 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-15 09:10:57.223549 | debian-bookworm | changed 2026-05-15 09:10:57.233135 | 2026-05-15 09:10:57.233250 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-15 09:10:57.909862 | debian-bookworm | changed 2026-05-15 09:10:57.915062 | 2026-05-15 09:10:57.915152 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-15 09:10:57.937981 | debian-bookworm | skipping: Conditional result was False 2026-05-15 09:10:57.943726 | 2026-05-15 09:10:57.943841 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-15 09:10:58.421813 | debian-bookworm -> localhost | changed 2026-05-15 09:10:58.432602 | 2026-05-15 09:10:58.432711 | TASK [add-build-sshkey : Add back temp key] 2026-05-15 09:10:59.102823 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/f903770d442a4ee3a64f87d9d34104f2/work/f903770d442a4ee3a64f87d9d34104f2_id_rsa (zuul-build-sshkey) 2026-05-15 09:10:59.103046 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.014738 2026-05-15 09:10:59.111167 | 2026-05-15 09:10:59.111268 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-15 09:10:59.505245 | debian-bookworm | ok 2026-05-15 09:10:59.510056 | 2026-05-15 09:10:59.510142 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-15 09:10:59.539086 | debian-bookworm | skipping: Conditional result was False 2026-05-15 09:10:59.549228 | 2026-05-15 09:10:59.549331 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-15 09:11:00.167560 | debian-bookworm | ok 2026-05-15 09:11:00.178409 | 2026-05-15 09:11:00.178531 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-15 09:11:00.207054 | debian-bookworm | ok 2026-05-15 09:11:00.212058 | 2026-05-15 09:11:00.212163 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-15 09:11:00.650996 | debian-bookworm -> localhost | ok 2026-05-15 09:11:00.657664 | 2026-05-15 09:11:00.657790 | TASK [validate-host : Collect information about the host] 2026-05-15 09:11:02.117021 | debian-bookworm | ok 2026-05-15 09:11:02.128026 | 2026-05-15 09:11:02.128153 | TASK [validate-host : Sanitize hostname] 2026-05-15 09:11:02.239022 | debian-bookworm | ok 2026-05-15 09:11:02.306427 | 2026-05-15 09:11:02.306644 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-15 09:11:03.165424 | debian-bookworm -> localhost | changed 2026-05-15 09:11:03.171648 | 2026-05-15 09:11:03.171784 | TASK [validate-host : Collect information about zuul worker] 2026-05-15 09:11:03.726932 | debian-bookworm | ok 2026-05-15 09:11:03.731020 | 2026-05-15 09:11:03.731096 | TASK [validate-host : Write out all zuul information for each host] 2026-05-15 09:11:04.332165 | debian-bookworm -> localhost | changed 2026-05-15 09:11:04.339811 | 2026-05-15 09:11:04.339899 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-15 09:11:04.609010 | debian-bookworm | ok 2026-05-15 09:11:04.613657 | 2026-05-15 09:11:04.613739 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-15 09:11:05.816297 | debian-bookworm | changed: 2026-05-15 09:11:05.816504 | debian-bookworm | cd+++++++++ src/ 2026-05-15 09:11:05.816548 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-15 09:11:05.816579 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-15 09:11:05.816607 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-kolla-ansible/ 2026-05-15 09:11:05.816633 | debian-bookworm | Containerfile 2026-05-15 09:11:05.816834 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/f903770d442a4ee3a64f87d9d34104f2/work/logs" 2026-05-15 09:11:33.215626 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/f903770d442a4ee3a64f87d9d34104f2/work/artifacts" 2026-05-15 09:11:33.543921 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/f903770d442a4ee3a64f87d9d34104f2/work/docs" 2026-05-15 09:11:33.569210 | 2026-05-15 09:11:33.569359 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-15 09:11:34.417231 | debian-bookworm | changed: 2026-05-15 09:11:34.417478 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-15 09:11:34.417516 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-15 09:11:34.417549 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-15 09:11:34.417597 | debian-bookworm | changed: All items complete 2026-05-15 09:11:34.417620 | 2026-05-15 09:11:35.032243 | debian-bookworm | changed: .d..t...... ./ 2026-05-15 09:11:35.643223 | debian-bookworm | changed: .d..t...... ./ 2026-05-15 09:11:35.658789 | 2026-05-15 09:11:35.658990 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-15 09:11:36.198141 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.006747 2026-05-15 09:11:36.458396 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.004718 2026-05-15 09:11:36.469399 | 2026-05-15 09:11:36.469481 | PLAY RECAP 2026-05-15 09:11:36.469529 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-15 09:11:36.469561 | 2026-05-15 09:11:36.569715 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-15 09:11:36.570448 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-15 09:11:37.256236 | 2026-05-15 09:11:37.256375 | PLAY [Base post] 2026-05-15 09:11:37.272922 | 2026-05-15 09:11:37.273058 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-15 09:11:37.859630 | debian-bookworm | changed 2026-05-15 09:11:37.865301 | 2026-05-15 09:11:37.865387 | PLAY RECAP 2026-05-15 09:11:37.865448 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-15 09:11:37.865509 | 2026-05-15 09:11:37.952238 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-15 09:11:37.954047 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-15 09:11:38.675625 | 2026-05-15 09:11:38.675785 | PLAY [Base post-logs] 2026-05-15 09:11:38.695846 | 2026-05-15 09:11:38.695983 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-15 09:11:39.099745 | localhost | changed 2026-05-15 09:11:39.111314 | 2026-05-15 09:11:39.111447 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-15 09:11:39.148887 | localhost | ok 2026-05-15 09:11:39.156215 | 2026-05-15 09:11:39.156393 | TASK [Set zuul-log-path fact] 2026-05-15 09:11:39.174385 | localhost | ok 2026-05-15 09:11:39.183854 | 2026-05-15 09:11:39.183968 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-15 09:11:39.220322 | localhost | ok 2026-05-15 09:11:39.225502 | 2026-05-15 09:11:39.225648 | TASK [upload-logs : Create log directories] 2026-05-15 09:11:39.682244 | localhost | changed 2026-05-15 09:11:39.686468 | 2026-05-15 09:11:39.686637 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-15 09:11:40.276416 | localhost -> localhost | ok: Runtime: 0:00:00.009028 2026-05-15 09:11:40.282077 | 2026-05-15 09:11:40.282223 | TASK [upload-logs : Upload logs to log server] 2026-05-15 09:11:41.018554 | localhost | Output suppressed because no_log was given 2026-05-15 09:11:41.021455 | 2026-05-15 09:11:41.021580 | LOOP [upload-logs : Compress console log and json output] 2026-05-15 09:11:41.087648 | localhost | skipping: Conditional result was False 2026-05-15 09:11:41.097656 | localhost | skipping: Conditional result was False 2026-05-15 09:11:41.111552 | 2026-05-15 09:11:41.111701 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-15 09:11:41.206062 | localhost | skipping: Conditional result was False 2026-05-15 09:11:41.206379 | 2026-05-15 09:11:41.217288 | localhost | skipping: Conditional result was False 2026-05-15 09:11:41.221436 | 2026-05-15 09:11:41.221564 | LOOP [upload-logs : Upload console log and json output]