2026-09-27 03:02:18.127691 | Job console starting 2026-09-27 03:02:18.136139 | Updating git repos 2026-09-27 03:02:18.182754 | Cloning repos into workspace 2026-09-27 03:02:18.269920 | Restoring repo states 2026-09-27 03:02:18.282568 | Merging changes 2026-09-27 03:02:18.282581 | Checking out repos 2026-09-27 03:02:18.351993 | Preparing playbooks 2026-09-27 03:02:19.560352 | Running Ansible setup 2026-09-27 03:02:24.622656 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-09-27 03:02:25.479944 | 2026-09-27 03:02:25.480067 | PLAY [Base pre] 2026-09-27 03:02:25.496712 | 2026-09-27 03:02:25.496818 | TASK [Setup log path fact] 2026-09-27 03:02:25.515734 | debian-bookworm | ok 2026-09-27 03:02:25.531471 | 2026-09-27 03:02:25.531598 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-27 03:02:25.569681 | debian-bookworm | ok 2026-09-27 03:02:25.582040 | 2026-09-27 03:02:25.582147 | TASK [emit-job-header : Print job information] 2026-09-27 03:02:25.632346 | # Job Information 2026-09-27 03:02:25.632499 | Ansible Version: 2.16.14 2026-09-27 03:02:25.632533 | Job: python-black 2026-09-27 03:02:25.632565 | Pipeline: periodic-daily 2026-09-27 03:02:25.632588 | Executor: 521e9411259a 2026-09-27 03:02:25.632610 | Triggered by: https://github.com/osism/openstack-image-manager 2026-09-27 03:02:25.632633 | Event ID: 1ed6a33f1be147bfb077092151c5b756 2026-09-27 03:02:25.637835 | 2026-09-27 03:02:25.637933 | LOOP [emit-job-header : Print node information] 2026-09-27 03:02:25.743171 | debian-bookworm | ok: 2026-09-27 03:02:25.743429 | debian-bookworm | # Node Information 2026-09-27 03:02:25.743469 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-09-27 03:02:25.743495 | debian-bookworm | Hostname: debian 2026-09-27 03:02:25.743517 | debian-bookworm | Username: zuul 2026-09-27 03:02:25.743538 | debian-bookworm | Distro: Debian 12.15 2026-09-27 03:02:25.743567 | debian-bookworm | Provider: regiocloud-a 2026-09-27 03:02:25.743595 | debian-bookworm | Region: 2026-09-27 03:02:25.743617 | debian-bookworm | Label: debian-bookworm 2026-09-27 03:02:25.743638 | debian-bookworm | Product Name: OpenStack Nova 2026-09-27 03:02:25.743658 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe43:3a8b 2026-09-27 03:02:25.763021 | 2026-09-27 03:02:25.763127 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-27 03:02:26.224281 | debian-bookworm -> localhost | changed 2026-09-27 03:02:26.231060 | 2026-09-27 03:02:26.231163 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-27 03:02:27.399348 | debian-bookworm -> localhost | changed 2026-09-27 03:02:27.408414 | 2026-09-27 03:02:27.408505 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-27 03:02:27.665578 | debian-bookworm -> localhost | ok 2026-09-27 03:02:27.670860 | 2026-09-27 03:02:27.670948 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-27 03:02:27.688687 | debian-bookworm | ok 2026-09-27 03:02:27.708225 | debian-bookworm | included: /var/lib/zuul/builds/15e224a2719b4a11b68a09ebd9d10032/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-27 03:02:27.723545 | 2026-09-27 03:02:27.723628 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-27 03:02:28.952376 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-09-27 03:02:28.952916 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/15e224a2719b4a11b68a09ebd9d10032/work/15e224a2719b4a11b68a09ebd9d10032_id_rsa 2026-09-27 03:02:28.953039 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/15e224a2719b4a11b68a09ebd9d10032/work/15e224a2719b4a11b68a09ebd9d10032_id_rsa.pub 2026-09-27 03:02:28.953429 | debian-bookworm -> localhost | The key fingerprint is: 2026-09-27 03:02:28.953509 | debian-bookworm -> localhost | SHA256:qD8ghq+apdAmK7oS8uHPOkzIOt3GIUrZDaqSqNFGXQc zuul-build-sshkey 2026-09-27 03:02:28.953624 | debian-bookworm -> localhost | The key's randomart image is: 2026-09-27 03:02:28.953714 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-09-27 03:02:28.953782 | debian-bookworm -> localhost | | E | 2026-09-27 03:02:28.953847 | debian-bookworm -> localhost | | . | 2026-09-27 03:02:28.953908 | debian-bookworm -> localhost | | . . | 2026-09-27 03:02:28.953967 | debian-bookworm -> localhost | | o . o | 2026-09-27 03:02:28.954026 | debian-bookworm -> localhost | |.o= + . S | 2026-09-27 03:02:28.954094 | debian-bookworm -> localhost | |=O*.oo | 2026-09-27 03:02:28.954155 | debian-bookworm -> localhost | |X%**.o | 2026-09-27 03:02:28.954214 | debian-bookworm -> localhost | |%XB.+.. | 2026-09-27 03:02:28.954275 | debian-bookworm -> localhost | |^+.=o .. | 2026-09-27 03:02:28.954381 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-09-27 03:02:28.954540 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.712998 2026-09-27 03:02:28.967946 | 2026-09-27 03:02:28.968073 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-27 03:02:28.986670 | debian-bookworm | ok 2026-09-27 03:02:28.997116 | debian-bookworm | included: /var/lib/zuul/builds/15e224a2719b4a11b68a09ebd9d10032/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-27 03:02:29.005475 | 2026-09-27 03:02:29.005585 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-27 03:02:29.018236 | debian-bookworm | skipping: Conditional result was False 2026-09-27 03:02:29.023868 | 2026-09-27 03:02:29.023951 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-27 03:02:29.767877 | debian-bookworm | changed 2026-09-27 03:02:29.772156 | 2026-09-27 03:02:29.772228 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-27 03:02:30.023687 | debian-bookworm | ok 2026-09-27 03:02:30.029406 | 2026-09-27 03:02:30.029493 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-27 03:02:30.643761 | debian-bookworm | changed 2026-09-27 03:02:30.647959 | 2026-09-27 03:02:30.648035 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-27 03:02:31.266066 | debian-bookworm | changed 2026-09-27 03:02:31.282816 | 2026-09-27 03:02:31.283508 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-27 03:02:31.334057 | debian-bookworm | skipping: Conditional result was False 2026-09-27 03:02:31.351607 | 2026-09-27 03:02:31.351722 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-27 03:02:31.952952 | debian-bookworm -> localhost | changed 2026-09-27 03:02:31.982328 | 2026-09-27 03:02:31.982559 | TASK [add-build-sshkey : Add back temp key] 2026-09-27 03:02:32.418093 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/15e224a2719b4a11b68a09ebd9d10032/work/15e224a2719b4a11b68a09ebd9d10032_id_rsa (zuul-build-sshkey) 2026-09-27 03:02:32.418737 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.017526 2026-09-27 03:02:32.426200 | 2026-09-27 03:02:32.426287 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-27 03:02:32.837293 | debian-bookworm | ok 2026-09-27 03:02:32.855855 | 2026-09-27 03:02:32.855971 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-27 03:02:32.879310 | debian-bookworm | skipping: Conditional result was False 2026-09-27 03:02:32.893374 | 2026-09-27 03:02:32.893485 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-09-27 03:02:33.329476 | debian-bookworm | ok 2026-09-27 03:02:33.400447 | 2026-09-27 03:02:33.400606 | TASK [validate-host : Define zuul_info_dir fact] 2026-09-27 03:02:33.435372 | debian-bookworm | ok 2026-09-27 03:02:33.443330 | 2026-09-27 03:02:33.443434 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-09-27 03:02:33.911581 | debian-bookworm -> localhost | ok 2026-09-27 03:02:33.918973 | 2026-09-27 03:02:33.919068 | TASK [validate-host : Collect information about the host] 2026-09-27 03:02:35.173524 | debian-bookworm | ok 2026-09-27 03:02:35.185087 | 2026-09-27 03:02:35.185179 | TASK [validate-host : Sanitize hostname] 2026-09-27 03:02:35.300380 | debian-bookworm | ok 2026-09-27 03:02:35.308030 | 2026-09-27 03:02:35.308148 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-09-27 03:02:36.010996 | debian-bookworm -> localhost | changed 2026-09-27 03:02:36.016571 | 2026-09-27 03:02:36.016658 | TASK [validate-host : Collect information about zuul worker] 2026-09-27 03:02:36.412279 | debian-bookworm | ok 2026-09-27 03:02:36.416908 | 2026-09-27 03:02:36.417006 | TASK [validate-host : Write out all zuul information for each host] 2026-09-27 03:02:36.916972 | debian-bookworm -> localhost | changed 2026-09-27 03:02:36.926236 | 2026-09-27 03:02:36.926331 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-09-27 03:02:37.164975 | debian-bookworm | ok 2026-09-27 03:02:37.170286 | 2026-09-27 03:02:37.170403 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-09-27 03:02:37.992813 | debian-bookworm | changed: 2026-09-27 03:02:37.992996 | debian-bookworm | cd+++++++++ src/ 2026-09-27 03:02:37.993043 | debian-bookworm | cd+++++++++ src/github.com/ 2026-09-27 03:02:37.993081 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-09-27 03:02:37.993106 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-09-27 03:02:37.993127 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/15e224a2719b4a11b68a09ebd9d10032/work/logs" 2026-09-27 03:03:44.555151 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/15e224a2719b4a11b68a09ebd9d10032/work/artifacts" 2026-09-27 03:03:44.781062 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/15e224a2719b4a11b68a09ebd9d10032/work/docs" 2026-09-27 03:03:44.790914 | 2026-09-27 03:03:44.791009 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-27 03:03:45.425764 | debian-bookworm | changed: 2026-09-27 03:03:45.425951 | debian-bookworm | .d..t...... ./ 2026-09-27 03:03:45.425985 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-09-27 03:03:45.426009 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-09-27 03:03:45.426031 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-09-27 03:03:45.426054 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-09-27 03:03:45.426074 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-09-27 03:03:45.426108 | debian-bookworm | changed: All items complete 2026-09-27 03:03:45.426129 | 2026-09-27 03:03:45.932723 | debian-bookworm | changed: .d..t...... ./ 2026-09-27 03:03:46.541173 | debian-bookworm | changed: .d..t...... ./ 2026-09-27 03:03:46.569453 | 2026-09-27 03:03:46.569587 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-27 03:03:46.612410 | debian-bookworm | skipping: Conditional result was False 2026-09-27 03:03:46.630721 | debian-bookworm | skipping: Conditional result was False 2026-09-27 03:03:46.641916 | 2026-09-27 03:03:46.641993 | PLAY RECAP 2026-09-27 03:03:46.642053 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-09-27 03:03:46.642078 | 2026-09-27 03:03:46.796929 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-27 03:03:46.797517 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-27 03:03:47.719700 | 2026-09-27 03:03:47.719827 | PLAY [Base post] 2026-09-27 03:03:47.747965 | 2026-09-27 03:03:47.748086 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-27 03:03:48.329564 | debian-bookworm | changed 2026-09-27 03:03:48.339812 | 2026-09-27 03:03:48.339908 | PLAY RECAP 2026-09-27 03:03:48.339965 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-27 03:03:48.340025 | 2026-09-27 03:03:48.475940 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-27 03:03:48.476714 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-27 03:03:49.236990 | 2026-09-27 03:03:49.237117 | PLAY [Base post-logs] 2026-09-27 03:03:49.246438 | 2026-09-27 03:03:49.246544 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-27 03:03:49.671303 | localhost | changed 2026-09-27 03:03:49.680911 | 2026-09-27 03:03:49.681042 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-27 03:03:49.706339 | localhost | ok 2026-09-27 03:03:49.709139 | 2026-09-27 03:03:49.709223 | TASK [Set zuul-log-path fact] 2026-09-27 03:03:49.726322 | localhost | ok 2026-09-27 03:03:49.734169 | 2026-09-27 03:03:49.734282 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-27 03:03:49.758919 | localhost | ok 2026-09-27 03:03:49.762028 | 2026-09-27 03:03:49.762123 | TASK [upload-logs : Create log directories] 2026-09-27 03:03:50.219915 | localhost | changed 2026-09-27 03:03:50.223353 | 2026-09-27 03:03:50.223457 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-27 03:03:50.644540 | localhost -> localhost | ok: Runtime: 0:00:00.006388 2026-09-27 03:03:50.651067 | 2026-09-27 03:03:50.651242 | TASK [upload-logs : Upload logs to log server] 2026-09-27 03:03:51.159397 | localhost | Output suppressed because no_log was given 2026-09-27 03:03:51.160994 | 2026-09-27 03:03:51.161078 | LOOP [upload-logs : Compress console log and json output] 2026-09-27 03:03:51.200794 | localhost | skipping: Conditional result was False 2026-09-27 03:03:51.207870 | localhost | skipping: Conditional result was False 2026-09-27 03:03:51.216384 | 2026-09-27 03:03:51.216474 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-27 03:03:51.255934 | localhost | skipping: Conditional result was False 2026-09-27 03:03:51.256144 | 2026-09-27 03:03:51.262361 | localhost | skipping: Conditional result was False 2026-09-27 03:03:51.271438 | 2026-09-27 03:03:51.271530 | LOOP [upload-logs : Upload console log and json output]