2026-09-16 03:02:58.530077 | Job console starting 2026-09-16 03:02:58.552471 | Updating git repos 2026-09-16 03:02:58.601819 | Cloning repos into workspace 2026-09-16 03:02:58.680945 | Restoring repo states 2026-09-16 03:02:58.686705 | Merging changes 2026-09-16 03:02:58.686719 | Checking out repos 2026-09-16 03:02:58.770840 | Preparing playbooks 2026-09-16 03:02:59.747874 | Running Ansible setup 2026-09-16 03:03:04.041838 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-09-16 03:03:04.786160 | 2026-09-16 03:03:04.786278 | PLAY [Base pre] 2026-09-16 03:03:04.802658 | 2026-09-16 03:03:04.802759 | TASK [Setup log path fact] 2026-09-16 03:03:04.830814 | debian-bookworm | ok 2026-09-16 03:03:04.845824 | 2026-09-16 03:03:04.845935 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-16 03:03:04.874651 | debian-bookworm | ok 2026-09-16 03:03:04.883964 | 2026-09-16 03:03:04.884054 | TASK [emit-job-header : Print job information] 2026-09-16 03:03:04.922606 | # Job Information 2026-09-16 03:03:04.922755 | Ansible Version: 2.16.14 2026-09-16 03:03:04.922789 | Job: python-black 2026-09-16 03:03:04.922822 | Pipeline: periodic-daily 2026-09-16 03:03:04.922844 | Executor: 521e9411259a 2026-09-16 03:03:04.922865 | Triggered by: https://github.com/osism/openstack-image-manager 2026-09-16 03:03:04.922887 | Event ID: f830e8d4a3914a41bb9dcb8cc435370f 2026-09-16 03:03:04.929183 | 2026-09-16 03:03:04.929281 | LOOP [emit-job-header : Print node information] 2026-09-16 03:03:05.032864 | debian-bookworm | ok: 2026-09-16 03:03:05.033113 | debian-bookworm | # Node Information 2026-09-16 03:03:05.033172 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-09-16 03:03:05.033219 | debian-bookworm | Hostname: debian 2026-09-16 03:03:05.033258 | debian-bookworm | Username: zuul 2026-09-16 03:03:05.033294 | debian-bookworm | Distro: Debian 12.15 2026-09-16 03:03:05.033337 | debian-bookworm | Provider: regiocloud-a 2026-09-16 03:03:05.033373 | debian-bookworm | Region: 2026-09-16 03:03:05.033411 | debian-bookworm | Label: debian-bookworm 2026-09-16 03:03:05.033446 | debian-bookworm | Product Name: OpenStack Nova 2026-09-16 03:03:05.033480 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fec0:9874 2026-09-16 03:03:05.048989 | 2026-09-16 03:03:05.049094 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-16 03:03:05.452889 | debian-bookworm -> localhost | changed 2026-09-16 03:03:05.463286 | 2026-09-16 03:03:05.463410 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-16 03:03:07.160128 | debian-bookworm -> localhost | changed 2026-09-16 03:03:07.171198 | 2026-09-16 03:03:07.171318 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-16 03:03:07.728816 | debian-bookworm -> localhost | ok 2026-09-16 03:03:07.735487 | 2026-09-16 03:03:07.735596 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-16 03:03:07.806877 | debian-bookworm | ok 2026-09-16 03:03:07.846357 | debian-bookworm | included: /var/lib/zuul/builds/398473172c7d4d45b48867fa09bca5ad/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-16 03:03:07.860545 | 2026-09-16 03:03:07.861883 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-16 03:03:11.483174 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-09-16 03:03:11.483386 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/398473172c7d4d45b48867fa09bca5ad/work/398473172c7d4d45b48867fa09bca5ad_id_rsa 2026-09-16 03:03:11.483426 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/398473172c7d4d45b48867fa09bca5ad/work/398473172c7d4d45b48867fa09bca5ad_id_rsa.pub 2026-09-16 03:03:11.483454 | debian-bookworm -> localhost | The key fingerprint is: 2026-09-16 03:03:11.483479 | debian-bookworm -> localhost | SHA256:llTefzTEgHesFnEADgG3lxBDyjFhA/AkC/I8dl90FyQ zuul-build-sshkey 2026-09-16 03:03:11.483504 | debian-bookworm -> localhost | The key's randomart image is: 2026-09-16 03:03:11.483536 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-09-16 03:03:11.483559 | debian-bookworm -> localhost | |.. o.o.B=OEo*=*o | 2026-09-16 03:03:11.483595 | debian-bookworm -> localhost | |.o. = o.*+*=.oo+ | 2026-09-16 03:03:11.483618 | debian-bookworm -> localhost | | =... oo..+o +..| 2026-09-16 03:03:11.483639 | debian-bookworm -> localhost | | . o . o .. + ..| 2026-09-16 03:03:11.483661 | debian-bookworm -> localhost | | . S . . .| 2026-09-16 03:03:11.483699 | debian-bookworm -> localhost | | . . | 2026-09-16 03:03:11.483721 | debian-bookworm -> localhost | | | 2026-09-16 03:03:11.483742 | debian-bookworm -> localhost | | | 2026-09-16 03:03:11.483764 | debian-bookworm -> localhost | | | 2026-09-16 03:03:11.483784 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-09-16 03:03:11.483841 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.717979 2026-09-16 03:03:11.490202 | 2026-09-16 03:03:11.490291 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-16 03:03:11.518678 | debian-bookworm | ok 2026-09-16 03:03:11.528722 | debian-bookworm | included: /var/lib/zuul/builds/398473172c7d4d45b48867fa09bca5ad/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-16 03:03:11.536733 | 2026-09-16 03:03:11.536821 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-16 03:03:11.550423 | debian-bookworm | skipping: Conditional result was False 2026-09-16 03:03:11.556164 | 2026-09-16 03:03:11.556279 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-16 03:03:12.378158 | debian-bookworm | changed 2026-09-16 03:03:12.387820 | 2026-09-16 03:03:12.387913 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-16 03:03:12.692486 | debian-bookworm | ok 2026-09-16 03:03:12.698786 | 2026-09-16 03:03:12.698876 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-16 03:03:13.479410 | debian-bookworm | changed 2026-09-16 03:03:13.484729 | 2026-09-16 03:03:13.484816 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-16 03:03:14.219800 | debian-bookworm | changed 2026-09-16 03:03:14.225365 | 2026-09-16 03:03:14.225455 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-16 03:03:14.250950 | debian-bookworm | skipping: Conditional result was False 2026-09-16 03:03:14.256704 | 2026-09-16 03:03:14.256800 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-16 03:03:14.825724 | debian-bookworm -> localhost | changed 2026-09-16 03:03:14.836335 | 2026-09-16 03:03:14.836434 | TASK [add-build-sshkey : Add back temp key] 2026-09-16 03:03:15.298504 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/398473172c7d4d45b48867fa09bca5ad/work/398473172c7d4d45b48867fa09bca5ad_id_rsa (zuul-build-sshkey) 2026-09-16 03:03:15.298719 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011507 2026-09-16 03:03:15.305901 | 2026-09-16 03:03:15.305989 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-16 03:03:15.719031 | debian-bookworm | ok 2026-09-16 03:03:15.725239 | 2026-09-16 03:03:15.725341 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-16 03:03:15.748389 | debian-bookworm | skipping: Conditional result was False 2026-09-16 03:03:15.758273 | 2026-09-16 03:03:15.758362 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-09-16 03:03:16.200642 | debian-bookworm | ok 2026-09-16 03:03:16.221819 | 2026-09-16 03:03:16.227034 | TASK [validate-host : Define zuul_info_dir fact] 2026-09-16 03:03:16.288070 | debian-bookworm | ok 2026-09-16 03:03:16.295732 | 2026-09-16 03:03:16.295824 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-09-16 03:03:16.960149 | debian-bookworm -> localhost | ok 2026-09-16 03:03:16.967054 | 2026-09-16 03:03:16.967148 | TASK [validate-host : Collect information about the host] 2026-09-16 03:03:18.496280 | debian-bookworm | ok 2026-09-16 03:03:18.517434 | 2026-09-16 03:03:18.517626 | TASK [validate-host : Sanitize hostname] 2026-09-16 03:03:18.654497 | debian-bookworm | ok 2026-09-16 03:03:18.659205 | 2026-09-16 03:03:18.659298 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-09-16 03:03:19.152838 | debian-bookworm -> localhost | changed 2026-09-16 03:03:19.161665 | 2026-09-16 03:03:19.161800 | TASK [validate-host : Collect information about zuul worker] 2026-09-16 03:03:19.621710 | debian-bookworm | ok 2026-09-16 03:03:19.629004 | 2026-09-16 03:03:19.629094 | TASK [validate-host : Write out all zuul information for each host] 2026-09-16 03:03:20.067691 | debian-bookworm -> localhost | changed 2026-09-16 03:03:20.075307 | 2026-09-16 03:03:20.075419 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-09-16 03:03:20.380372 | debian-bookworm | ok 2026-09-16 03:03:20.385434 | 2026-09-16 03:03:20.385520 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-09-16 03:03:21.330132 | debian-bookworm | changed: 2026-09-16 03:03:21.330299 | debian-bookworm | cd+++++++++ src/ 2026-09-16 03:03:21.330361 | debian-bookworm | cd+++++++++ src/github.com/ 2026-09-16 03:03:21.330387 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-09-16 03:03:21.330409 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-09-16 03:03:21.330432 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/398473172c7d4d45b48867fa09bca5ad/work/logs" 2026-09-16 03:04:29.869270 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/398473172c7d4d45b48867fa09bca5ad/work/artifacts" 2026-09-16 03:04:30.144670 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/398473172c7d4d45b48867fa09bca5ad/work/docs" 2026-09-16 03:04:30.161793 | 2026-09-16 03:04:30.162079 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-16 03:04:31.023554 | debian-bookworm | changed: 2026-09-16 03:04:31.023816 | debian-bookworm | .d..t...... ./ 2026-09-16 03:04:31.023856 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-09-16 03:04:31.023881 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-09-16 03:04:31.023903 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-09-16 03:04:31.023924 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-09-16 03:04:31.023944 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-09-16 03:04:31.023981 | debian-bookworm | changed: All items complete 2026-09-16 03:04:31.024005 | 2026-09-16 03:04:31.648458 | debian-bookworm | changed: .d..t...... ./ 2026-09-16 03:04:32.213905 | debian-bookworm | changed: .d..t...... ./ 2026-09-16 03:04:32.234378 | 2026-09-16 03:04:32.234514 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-16 03:04:32.266524 | debian-bookworm | skipping: Conditional result was False 2026-09-16 03:04:32.270112 | debian-bookworm | skipping: Conditional result was False 2026-09-16 03:04:32.286821 | 2026-09-16 03:04:32.286916 | PLAY RECAP 2026-09-16 03:04:32.286970 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-09-16 03:04:32.286994 | 2026-09-16 03:04:32.439333 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-16 03:04:32.440188 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-16 03:04:33.359161 | 2026-09-16 03:04:33.359328 | PLAY [Base post] 2026-09-16 03:04:33.380817 | 2026-09-16 03:04:33.380977 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-16 03:04:34.194768 | debian-bookworm | changed 2026-09-16 03:04:34.204579 | 2026-09-16 03:04:34.204695 | PLAY RECAP 2026-09-16 03:04:34.204751 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-16 03:04:34.204810 | 2026-09-16 03:04:34.381034 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-16 03:04:34.381966 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-16 03:04:35.256705 | 2026-09-16 03:04:35.256821 | PLAY [Base post-logs] 2026-09-16 03:04:35.282990 | 2026-09-16 03:04:35.283095 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-16 03:04:36.139302 | localhost | changed 2026-09-16 03:04:36.159177 | 2026-09-16 03:04:36.159359 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-16 03:04:36.195290 | localhost | ok 2026-09-16 03:04:36.198115 | 2026-09-16 03:04:36.198192 | TASK [Set zuul-log-path fact] 2026-09-16 03:04:36.233477 | localhost | ok 2026-09-16 03:04:36.241696 | 2026-09-16 03:04:36.241792 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-16 03:04:36.289210 | localhost | ok 2026-09-16 03:04:36.292305 | 2026-09-16 03:04:36.292386 | TASK [upload-logs : Create log directories] 2026-09-16 03:04:37.256894 | localhost | changed 2026-09-16 03:04:37.259189 | 2026-09-16 03:04:37.259267 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-16 03:04:37.906373 | localhost -> localhost | ok: Runtime: 0:00:00.026209 2026-09-16 03:04:37.910116 | 2026-09-16 03:04:37.910203 | TASK [upload-logs : Upload logs to log server] 2026-09-16 03:04:38.694374 | localhost | Output suppressed because no_log was given 2026-09-16 03:04:38.695762 | 2026-09-16 03:04:38.695838 | LOOP [upload-logs : Compress console log and json output] 2026-09-16 03:04:38.742603 | localhost | skipping: Conditional result was False 2026-09-16 03:04:38.755349 | localhost | skipping: Conditional result was False 2026-09-16 03:04:38.763580 | 2026-09-16 03:04:38.763698 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-16 03:04:38.812330 | localhost | skipping: Conditional result was False 2026-09-16 03:04:38.812589 | 2026-09-16 03:04:38.818528 | localhost | skipping: Conditional result was False 2026-09-16 03:04:38.827343 | 2026-09-16 03:04:38.827427 | LOOP [upload-logs : Upload console log and json output]