2026-07-15 03:25:02.579854 | Job console starting 2026-07-15 03:25:02.599079 | Updating git repos 2026-07-15 03:25:02.641189 | Cloning repos into workspace 2026-07-15 03:25:02.767979 | Restoring repo states 2026-07-15 03:25:02.784957 | Merging changes 2026-07-15 03:25:02.784978 | Checking out repos 2026-07-15 03:25:02.856192 | Preparing playbooks 2026-07-15 03:25:03.790793 | Running Ansible setup 2026-07-15 03:25:09.199750 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-07-15 03:25:10.641866 | 2026-07-15 03:25:10.642216 | PLAY [Base pre] 2026-07-15 03:25:10.663735 | 2026-07-15 03:25:10.663915 | TASK [Setup log path fact] 2026-07-15 03:25:10.704907 | debian-bookworm | ok 2026-07-15 03:25:10.729144 | 2026-07-15 03:25:10.729369 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-15 03:25:10.761433 | debian-bookworm | ok 2026-07-15 03:25:10.775054 | 2026-07-15 03:25:10.775226 | TASK [emit-job-header : Print job information] 2026-07-15 03:25:10.862345 | # Job Information 2026-07-15 03:25:10.862585 | Ansible Version: 2.16.14 2026-07-15 03:25:10.862621 | Job: python-black 2026-07-15 03:25:10.862654 | Pipeline: periodic-daily 2026-07-15 03:25:10.862676 | Executor: 521e9411259a 2026-07-15 03:25:10.862697 | Triggered by: https://github.com/osism/testbed 2026-07-15 03:25:10.862718 | Event ID: 735c06c23714473bae8571e0b770ec12 2026-07-15 03:25:10.868321 | 2026-07-15 03:25:10.868460 | LOOP [emit-job-header : Print node information] 2026-07-15 03:25:11.096757 | debian-bookworm | ok: 2026-07-15 03:25:11.097435 | debian-bookworm | # Node Information 2026-07-15 03:25:11.097511 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-07-15 03:25:11.097540 | debian-bookworm | Hostname: debian 2026-07-15 03:25:11.097564 | debian-bookworm | Username: zuul 2026-07-15 03:25:11.097586 | debian-bookworm | Distro: Debian 12.15 2026-07-15 03:25:11.097611 | debian-bookworm | Provider: regiocloud-a 2026-07-15 03:25:11.097633 | debian-bookworm | Region: 2026-07-15 03:25:11.097654 | debian-bookworm | Label: debian-bookworm 2026-07-15 03:25:11.097675 | debian-bookworm | Product Name: OpenStack Nova 2026-07-15 03:25:11.099778 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe51:f84e 2026-07-15 03:25:11.129395 | 2026-07-15 03:25:11.129740 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-07-15 03:25:12.204410 | debian-bookworm -> localhost | changed 2026-07-15 03:25:12.241736 | 2026-07-15 03:25:12.242347 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-07-15 03:25:13.901922 | debian-bookworm -> localhost | changed 2026-07-15 03:25:13.922509 | 2026-07-15 03:25:13.922678 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-07-15 03:25:14.315660 | debian-bookworm -> localhost | ok 2026-07-15 03:25:14.323003 | 2026-07-15 03:25:14.323161 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-07-15 03:25:14.348670 | debian-bookworm | ok 2026-07-15 03:25:14.365671 | debian-bookworm | included: /var/lib/zuul/builds/2826a7961ac0432584e3d817c371ffa5/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-07-15 03:25:14.372422 | 2026-07-15 03:25:14.372547 | TASK [add-build-sshkey : Create Temp SSH key] 2026-07-15 03:25:16.147585 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-07-15 03:25:16.147862 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/2826a7961ac0432584e3d817c371ffa5/work/2826a7961ac0432584e3d817c371ffa5_id_rsa 2026-07-15 03:25:16.147903 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/2826a7961ac0432584e3d817c371ffa5/work/2826a7961ac0432584e3d817c371ffa5_id_rsa.pub 2026-07-15 03:25:16.147930 | debian-bookworm -> localhost | The key fingerprint is: 2026-07-15 03:25:16.147954 | debian-bookworm -> localhost | SHA256:UrF9+QbeX4sYzaqSE2K3g9dPwZMttsnW+flwkFybilU zuul-build-sshkey 2026-07-15 03:25:16.147977 | debian-bookworm -> localhost | The key's randomart image is: 2026-07-15 03:25:16.148015 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-07-15 03:25:16.148037 | debian-bookworm -> localhost | | . | 2026-07-15 03:25:16.148060 | debian-bookworm -> localhost | | + . | 2026-07-15 03:25:16.148081 | debian-bookworm -> localhost | | o . + E.| 2026-07-15 03:25:16.148101 | debian-bookworm -> localhost | | . .o==.oo| 2026-07-15 03:25:16.148121 | debian-bookworm -> localhost | | . S O.=Bo.| 2026-07-15 03:25:16.148151 | debian-bookworm -> localhost | | o + o &.+oo| 2026-07-15 03:25:16.148173 | debian-bookworm -> localhost | | . + = X =..o| 2026-07-15 03:25:16.148193 | debian-bookworm -> localhost | | . B .+ .o.| 2026-07-15 03:25:16.148214 | debian-bookworm -> localhost | | . +... oo| 2026-07-15 03:25:16.148233 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-07-15 03:25:16.148290 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.792357 2026-07-15 03:25:16.155581 | 2026-07-15 03:25:16.155716 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-07-15 03:25:16.186338 | debian-bookworm | ok 2026-07-15 03:25:16.198402 | debian-bookworm | included: /var/lib/zuul/builds/2826a7961ac0432584e3d817c371ffa5/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-07-15 03:25:16.207043 | 2026-07-15 03:25:16.207166 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-07-15 03:25:16.232475 | debian-bookworm | skipping: Conditional result was False 2026-07-15 03:25:16.239373 | 2026-07-15 03:25:16.239510 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-07-15 03:25:16.945905 | debian-bookworm | changed 2026-07-15 03:25:16.957970 | 2026-07-15 03:25:16.959142 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-07-15 03:25:17.273105 | debian-bookworm | ok 2026-07-15 03:25:17.297023 | 2026-07-15 03:25:17.297177 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-07-15 03:25:18.043702 | debian-bookworm | changed 2026-07-15 03:25:18.052280 | 2026-07-15 03:25:18.052449 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-07-15 03:25:18.749392 | debian-bookworm | changed 2026-07-15 03:25:18.755618 | 2026-07-15 03:25:18.755750 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-07-15 03:25:18.781800 | debian-bookworm | skipping: Conditional result was False 2026-07-15 03:25:18.789246 | 2026-07-15 03:25:18.789400 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-07-15 03:25:19.482095 | debian-bookworm -> localhost | changed 2026-07-15 03:25:19.503730 | 2026-07-15 03:25:19.503885 | TASK [add-build-sshkey : Add back temp key] 2026-07-15 03:25:20.064152 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/2826a7961ac0432584e3d817c371ffa5/work/2826a7961ac0432584e3d817c371ffa5_id_rsa (zuul-build-sshkey) 2026-07-15 03:25:20.064452 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.012698 2026-07-15 03:25:20.072708 | 2026-07-15 03:25:20.072849 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-07-15 03:25:20.707806 | debian-bookworm | ok 2026-07-15 03:25:20.724249 | 2026-07-15 03:25:20.724431 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-07-15 03:25:20.759583 | debian-bookworm | skipping: Conditional result was False 2026-07-15 03:25:20.773777 | 2026-07-15 03:25:20.773996 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-07-15 03:25:21.297365 | debian-bookworm | ok 2026-07-15 03:25:21.311168 | 2026-07-15 03:25:21.311357 | TASK [validate-host : Define zuul_info_dir fact] 2026-07-15 03:25:21.341330 | debian-bookworm | ok 2026-07-15 03:25:21.348496 | 2026-07-15 03:25:21.349024 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-07-15 03:25:21.965221 | debian-bookworm -> localhost | ok 2026-07-15 03:25:21.971422 | 2026-07-15 03:25:21.971509 | TASK [validate-host : Collect information about the host] 2026-07-15 03:25:23.441405 | debian-bookworm | ok 2026-07-15 03:25:23.463163 | 2026-07-15 03:25:23.463274 | TASK [validate-host : Sanitize hostname] 2026-07-15 03:25:23.667827 | debian-bookworm | ok 2026-07-15 03:25:23.677625 | 2026-07-15 03:25:23.677729 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-07-15 03:25:24.354049 | debian-bookworm -> localhost | changed 2026-07-15 03:25:24.360044 | 2026-07-15 03:25:24.360137 | TASK [validate-host : Collect information about zuul worker] 2026-07-15 03:25:24.820329 | debian-bookworm | ok 2026-07-15 03:25:24.827681 | 2026-07-15 03:25:24.827783 | TASK [validate-host : Write out all zuul information for each host] 2026-07-15 03:25:25.610389 | debian-bookworm -> localhost | changed 2026-07-15 03:25:25.638147 | 2026-07-15 03:25:25.639590 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-07-15 03:25:25.956409 | debian-bookworm | ok 2026-07-15 03:25:25.961890 | 2026-07-15 03:25:25.961981 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-07-15 03:25:27.116103 | debian-bookworm | changed: 2026-07-15 03:25:27.116271 | debian-bookworm | cd+++++++++ src/ 2026-07-15 03:25:27.116335 | debian-bookworm | cd+++++++++ src/github.com/ 2026-07-15 03:25:27.116360 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-07-15 03:25:27.116381 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2026-07-15 03:25:27.116401 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/2826a7961ac0432584e3d817c371ffa5/work/logs" 2026-07-15 03:26:28.658290 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/2826a7961ac0432584e3d817c371ffa5/work/artifacts" 2026-07-15 03:26:28.958491 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/2826a7961ac0432584e3d817c371ffa5/work/docs" 2026-07-15 03:26:28.975934 | 2026-07-15 03:26:28.976075 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-07-15 03:26:29.843810 | debian-bookworm | changed: 2026-07-15 03:26:29.844142 | debian-bookworm | .d..t...... ./ 2026-07-15 03:26:29.844198 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-07-15 03:26:29.844262 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-07-15 03:26:29.844299 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-07-15 03:26:29.844334 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-07-15 03:26:29.844368 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-07-15 03:26:29.844432 | debian-bookworm | changed: All items complete 2026-07-15 03:26:29.844468 | 2026-07-15 03:26:30.463529 | debian-bookworm | changed: .d..t...... ./ 2026-07-15 03:26:31.069331 | debian-bookworm | changed: .d..t...... ./ 2026-07-15 03:26:31.093292 | 2026-07-15 03:26:31.093480 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-07-15 03:26:31.124051 | debian-bookworm | skipping: Conditional result was False 2026-07-15 03:26:31.128183 | debian-bookworm | skipping: Conditional result was False 2026-07-15 03:26:31.139639 | 2026-07-15 03:26:31.139746 | PLAY RECAP 2026-07-15 03:26:31.139811 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-07-15 03:26:31.139837 | 2026-07-15 03:26:31.294897 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-15 03:26:31.296730 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-15 03:26:32.074571 | 2026-07-15 03:26:32.074740 | PLAY [Base post] 2026-07-15 03:26:32.088642 | 2026-07-15 03:26:32.088772 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-07-15 03:26:32.691524 | debian-bookworm | changed 2026-07-15 03:26:32.704663 | 2026-07-15 03:26:32.704827 | PLAY RECAP 2026-07-15 03:26:32.704915 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-15 03:26:32.705004 | 2026-07-15 03:26:32.839371 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-15 03:26:32.840351 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-07-15 03:26:33.720377 | 2026-07-15 03:26:33.720555 | PLAY [Base post-logs] 2026-07-15 03:26:33.731751 | 2026-07-15 03:26:33.731896 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-07-15 03:26:34.265405 | localhost | changed 2026-07-15 03:26:34.276373 | 2026-07-15 03:26:34.276542 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-07-15 03:26:34.313539 | localhost | ok 2026-07-15 03:26:34.317478 | 2026-07-15 03:26:34.317601 | TASK [Set zuul-log-path fact] 2026-07-15 03:26:34.355959 | localhost | ok 2026-07-15 03:26:34.371386 | 2026-07-15 03:26:34.371551 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-15 03:26:34.397773 | localhost | ok 2026-07-15 03:26:34.400915 | 2026-07-15 03:26:34.401026 | TASK [upload-logs : Create log directories] 2026-07-15 03:26:35.012577 | localhost | changed 2026-07-15 03:26:35.018133 | 2026-07-15 03:26:35.018381 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-07-15 03:26:35.615165 | localhost -> localhost | ok: Runtime: 0:00:00.009481 2026-07-15 03:26:35.623626 | 2026-07-15 03:26:35.623794 | TASK [upload-logs : Upload logs to log server] 2026-07-15 03:26:36.240718 | localhost | Output suppressed because no_log was given 2026-07-15 03:26:36.245332 | 2026-07-15 03:26:36.245559 | LOOP [upload-logs : Compress console log and json output] 2026-07-15 03:26:36.307399 | localhost | skipping: Conditional result was False 2026-07-15 03:26:36.313146 | localhost | skipping: Conditional result was False 2026-07-15 03:26:36.328355 | 2026-07-15 03:26:36.328581 | LOOP [upload-logs : Upload compressed console log and json output] 2026-07-15 03:26:36.383404 | localhost | skipping: Conditional result was False 2026-07-15 03:26:36.384071 | 2026-07-15 03:26:36.387483 | localhost | skipping: Conditional result was False 2026-07-15 03:26:36.400716 | 2026-07-15 03:26:36.400935 | LOOP [upload-logs : Upload console log and json output]