2026-06-02 08:07:22.266598 | Job console starting 2026-06-02 08:07:22.281797 | Updating git repos 2026-06-02 08:07:22.323684 | Cloning repos into workspace 2026-06-02 08:07:22.358168 | Restoring repo states 2026-06-02 08:07:22.364669 | Merging changes 2026-06-02 08:07:22.966601 | Checking out repos 2026-06-02 08:07:23.025690 | Preparing playbooks 2026-06-02 08:07:23.815545 | Running Ansible setup 2026-06-02 08:07:28.362383 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-06-02 08:07:29.269552 | 2026-06-02 08:07:29.269722 | PLAY [Base pre] 2026-06-02 08:07:29.288160 | 2026-06-02 08:07:29.288303 | TASK [Setup log path fact] 2026-06-02 08:07:29.307650 | debian-bookworm | ok 2026-06-02 08:07:29.324364 | 2026-06-02 08:07:29.324544 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-02 08:07:29.364056 | debian-bookworm | ok 2026-06-02 08:07:29.374514 | 2026-06-02 08:07:29.374658 | TASK [emit-job-header : Print job information] 2026-06-02 08:07:29.414206 | # Job Information 2026-06-02 08:07:29.414398 | Ansible Version: 2.16.14 2026-06-02 08:07:29.414435 | Job: python-black 2026-06-02 08:07:29.414468 | Pipeline: check 2026-06-02 08:07:29.414492 | Executor: 521e9411259a 2026-06-02 08:07:29.414513 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1207 2026-06-02 08:07:29.414569 | Event ID: a8ebc500-5e59-11f1-8cb9-010cb4614f01 2026-06-02 08:07:29.419889 | 2026-06-02 08:07:29.420003 | LOOP [emit-job-header : Print node information] 2026-06-02 08:07:29.548743 | debian-bookworm | ok: 2026-06-02 08:07:29.551047 | debian-bookworm | # Node Information 2026-06-02 08:07:29.551145 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-06-02 08:07:29.551176 | debian-bookworm | Hostname: debian 2026-06-02 08:07:29.551201 | debian-bookworm | Username: zuul 2026-06-02 08:07:29.551224 | debian-bookworm | Distro: Debian 12.14 2026-06-02 08:07:29.551249 | debian-bookworm | Provider: regiocloud-a 2026-06-02 08:07:29.551270 | debian-bookworm | Region: 2026-06-02 08:07:29.551290 | debian-bookworm | Label: debian-bookworm 2026-06-02 08:07:29.551310 | debian-bookworm | Product Name: OpenStack Nova 2026-06-02 08:07:29.551329 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe30:826d 2026-06-02 08:07:29.577994 | 2026-06-02 08:07:29.578142 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-02 08:07:30.244719 | debian-bookworm -> localhost | changed 2026-06-02 08:07:30.253866 | 2026-06-02 08:07:30.254173 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-02 08:07:31.738077 | debian-bookworm -> localhost | changed 2026-06-02 08:07:31.753375 | 2026-06-02 08:07:31.753631 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-02 08:07:32.170659 | debian-bookworm -> localhost | ok 2026-06-02 08:07:32.178260 | 2026-06-02 08:07:32.178378 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-02 08:07:32.217765 | debian-bookworm | ok 2026-06-02 08:07:32.251144 | debian-bookworm | included: /var/lib/zuul/builds/31f60236f8964510a974a6940c6ffd9b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-02 08:07:32.271952 | 2026-06-02 08:07:32.272134 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-02 08:07:34.687329 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-06-02 08:07:34.687637 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/31f60236f8964510a974a6940c6ffd9b/work/31f60236f8964510a974a6940c6ffd9b_id_rsa 2026-06-02 08:07:34.687677 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/31f60236f8964510a974a6940c6ffd9b/work/31f60236f8964510a974a6940c6ffd9b_id_rsa.pub 2026-06-02 08:07:34.687704 | debian-bookworm -> localhost | The key fingerprint is: 2026-06-02 08:07:34.687727 | debian-bookworm -> localhost | SHA256:GCj2OAtgut5O8IXp66R0q9to3j5N91DUPAsVf2Xpe6s zuul-build-sshkey 2026-06-02 08:07:34.687750 | debian-bookworm -> localhost | The key's randomart image is: 2026-06-02 08:07:34.687782 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-06-02 08:07:34.687803 | debian-bookworm -> localhost | | +o. +| 2026-06-02 08:07:34.687825 | debian-bookworm -> localhost | | . o +. o.| 2026-06-02 08:07:34.687846 | debian-bookworm -> localhost | |..o . . . . o... | 2026-06-02 08:07:34.687866 | debian-bookworm -> localhost | |+. +o o . . .. | 2026-06-02 08:07:34.687885 | debian-bookworm -> localhost | |o.oo... S .| 2026-06-02 08:07:34.687911 | debian-bookworm -> localhost | | o+o.. o ..| 2026-06-02 08:07:34.687932 | debian-bookworm -> localhost | |...*o . o o| 2026-06-02 08:07:34.687952 | debian-bookworm -> localhost | |o.X.o. . . | 2026-06-02 08:07:34.687973 | debian-bookworm -> localhost | |oB*X. E. | 2026-06-02 08:07:34.687993 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-06-02 08:07:34.688044 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.711325 2026-06-02 08:07:34.695558 | 2026-06-02 08:07:34.695681 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-02 08:07:34.758823 | debian-bookworm | ok 2026-06-02 08:07:34.780386 | debian-bookworm | included: /var/lib/zuul/builds/31f60236f8964510a974a6940c6ffd9b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-02 08:07:34.801227 | 2026-06-02 08:07:34.801364 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-02 08:07:34.836553 | debian-bookworm | skipping: Conditional result was False 2026-06-02 08:07:34.844263 | 2026-06-02 08:07:34.844404 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-02 08:07:35.700757 | debian-bookworm | changed 2026-06-02 08:07:35.713723 | 2026-06-02 08:07:35.713849 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-02 08:07:36.036300 | debian-bookworm | ok 2026-06-02 08:07:36.083849 | 2026-06-02 08:07:36.084016 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-02 08:07:36.994797 | debian-bookworm | changed 2026-06-02 08:07:37.002891 | 2026-06-02 08:07:37.003008 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-02 08:07:37.671110 | debian-bookworm | changed 2026-06-02 08:07:37.677472 | 2026-06-02 08:07:37.677606 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-02 08:07:37.702005 | debian-bookworm | skipping: Conditional result was False 2026-06-02 08:07:37.708676 | 2026-06-02 08:07:37.708796 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-02 08:07:38.226215 | debian-bookworm -> localhost | changed 2026-06-02 08:07:38.241598 | 2026-06-02 08:07:38.241728 | TASK [add-build-sshkey : Add back temp key] 2026-06-02 08:07:38.614733 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/31f60236f8964510a974a6940c6ffd9b/work/31f60236f8964510a974a6940c6ffd9b_id_rsa (zuul-build-sshkey) 2026-06-02 08:07:38.615081 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.037504 2026-06-02 08:07:38.623933 | 2026-06-02 08:07:38.624062 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-02 08:07:39.045528 | debian-bookworm | ok 2026-06-02 08:07:39.056251 | 2026-06-02 08:07:39.056441 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-02 08:07:39.082474 | debian-bookworm | skipping: Conditional result was False 2026-06-02 08:07:39.100466 | 2026-06-02 08:07:39.100696 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-06-02 08:07:39.546112 | debian-bookworm | ok 2026-06-02 08:07:39.557590 | 2026-06-02 08:07:39.568052 | TASK [validate-host : Define zuul_info_dir fact] 2026-06-02 08:07:39.619030 | debian-bookworm | ok 2026-06-02 08:07:39.624231 | 2026-06-02 08:07:39.624355 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-06-02 08:07:40.146583 | debian-bookworm -> localhost | ok 2026-06-02 08:07:40.154730 | 2026-06-02 08:07:40.154892 | TASK [validate-host : Collect information about the host] 2026-06-02 08:07:41.338631 | debian-bookworm | ok 2026-06-02 08:07:41.369476 | 2026-06-02 08:07:41.369672 | TASK [validate-host : Sanitize hostname] 2026-06-02 08:07:41.554798 | debian-bookworm | ok 2026-06-02 08:07:41.667486 | 2026-06-02 08:07:41.667692 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-06-02 08:07:42.398216 | debian-bookworm -> localhost | changed 2026-06-02 08:07:42.412050 | 2026-06-02 08:07:42.412670 | TASK [validate-host : Collect information about zuul worker] 2026-06-02 08:07:42.843427 | debian-bookworm | ok 2026-06-02 08:07:42.849091 | 2026-06-02 08:07:42.849245 | TASK [validate-host : Write out all zuul information for each host] 2026-06-02 08:07:43.791189 | debian-bookworm -> localhost | changed 2026-06-02 08:07:43.798756 | 2026-06-02 08:07:43.798855 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-06-02 08:07:44.056581 | debian-bookworm | ok 2026-06-02 08:07:44.060932 | 2026-06-02 08:07:44.061001 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-06-02 08:07:44.925125 | debian-bookworm | changed: 2026-06-02 08:07:44.925303 | debian-bookworm | cd+++++++++ src/ 2026-06-02 08:07:44.925339 | debian-bookworm | cd+++++++++ src/github.com/ 2026-06-02 08:07:44.925365 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-06-02 08:07:44.925387 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-06-02 08:07:44.925408 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/31f60236f8964510a974a6940c6ffd9b/work/logs" 2026-06-02 08:08:12.188459 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/31f60236f8964510a974a6940c6ffd9b/work/artifacts" 2026-06-02 08:08:12.506964 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/31f60236f8964510a974a6940c6ffd9b/work/docs" 2026-06-02 08:08:12.522717 | 2026-06-02 08:08:12.522891 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-02 08:08:13.568823 | debian-bookworm | changed: 2026-06-02 08:08:13.569122 | debian-bookworm | .d..t...... ./ 2026-06-02 08:08:13.569162 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-06-02 08:08:13.569213 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-06-02 08:08:13.569246 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-06-02 08:08:13.569292 | debian-bookworm | changed: All items complete 2026-06-02 08:08:13.569318 | 2026-06-02 08:08:14.215275 | debian-bookworm | changed: .d..t...... ./ 2026-06-02 08:08:14.798295 | debian-bookworm | changed: .d..t...... ./ 2026-06-02 08:08:14.820808 | 2026-06-02 08:08:14.820956 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-02 08:08:15.435243 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.013984 2026-06-02 08:08:15.746101 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.033400 2026-06-02 08:08:15.762675 | 2026-06-02 08:08:15.762793 | PLAY RECAP 2026-06-02 08:08:15.762868 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-06-02 08:08:15.762897 | 2026-06-02 08:08:15.898351 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-06-02 08:08:15.900040 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-02 08:08:16.661478 | 2026-06-02 08:08:16.661692 | PLAY [Base post] 2026-06-02 08:08:16.680663 | 2026-06-02 08:08:16.680910 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-02 08:08:17.299449 | debian-bookworm | changed 2026-06-02 08:08:17.315065 | 2026-06-02 08:08:17.315223 | PLAY RECAP 2026-06-02 08:08:17.316047 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-02 08:08:17.316216 | 2026-06-02 08:08:17.452089 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-02 08:08:17.453443 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-06-02 08:08:18.282729 | 2026-06-02 08:08:18.283026 | PLAY [Base post-logs] 2026-06-02 08:08:18.295870 | 2026-06-02 08:08:18.296061 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-02 08:08:18.845128 | localhost | changed 2026-06-02 08:08:18.856951 | 2026-06-02 08:08:18.857171 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-02 08:08:18.885200 | localhost | ok 2026-06-02 08:08:18.890024 | 2026-06-02 08:08:18.890174 | TASK [Set zuul-log-path fact] 2026-06-02 08:08:18.912875 | localhost | ok 2026-06-02 08:08:18.923258 | 2026-06-02 08:08:18.923395 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-02 08:08:18.949486 | localhost | ok 2026-06-02 08:08:18.953252 | 2026-06-02 08:08:18.953368 | TASK [upload-logs : Create log directories] 2026-06-02 08:08:19.882998 | localhost | changed 2026-06-02 08:08:19.886377 | 2026-06-02 08:08:19.886530 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-02 08:08:20.560155 | localhost -> localhost | ok: Runtime: 0:00:00.006191 2026-06-02 08:08:20.564872 | 2026-06-02 08:08:20.565005 | TASK [upload-logs : Upload logs to log server] 2026-06-02 08:08:21.702008 | localhost | Output suppressed because no_log was given 2026-06-02 08:08:21.703975 | 2026-06-02 08:08:21.704090 | LOOP [upload-logs : Compress console log and json output] 2026-06-02 08:08:21.756300 | localhost | skipping: Conditional result was False 2026-06-02 08:08:21.764502 | localhost | skipping: Conditional result was False 2026-06-02 08:08:21.772817 | 2026-06-02 08:08:21.772955 | LOOP [upload-logs : Upload compressed console log and json output] 2026-06-02 08:08:21.843277 | localhost | skipping: Conditional result was False 2026-06-02 08:08:21.843610 | 2026-06-02 08:08:21.848838 | localhost | skipping: Conditional result was False 2026-06-02 08:08:21.856475 | 2026-06-02 08:08:21.856627 | LOOP [upload-logs : Upload console log and json output]