2026-07-29 12:07:59.402557 | Job console starting 2026-07-29 12:07:59.436993 | Updating git repos 2026-07-29 12:07:59.571787 | Cloning repos into workspace 2026-07-29 12:07:59.692450 | Restoring repo states 2026-07-29 12:07:59.710637 | Merging changes 2026-07-29 12:08:00.526580 | Checking out repos 2026-07-29 12:08:00.617644 | Preparing playbooks 2026-07-29 12:08:02.665810 | Running Ansible setup 2026-07-29 12:08:09.379408 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-07-29 12:08:10.344977 | 2026-07-29 12:08:10.345128 | PLAY [Base pre] 2026-07-29 12:08:10.403011 | 2026-07-29 12:08:10.403142 | TASK [Setup log path fact] 2026-07-29 12:08:10.452515 | debian-bookworm | ok 2026-07-29 12:08:10.497886 | 2026-07-29 12:08:10.498035 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-29 12:08:10.546906 | debian-bookworm | ok 2026-07-29 12:08:10.573917 | 2026-07-29 12:08:10.574044 | TASK [emit-job-header : Print job information] 2026-07-29 12:08:10.647853 | # Job Information 2026-07-29 12:08:10.648035 | Ansible Version: 2.16.14 2026-07-29 12:08:10.648070 | Job: python-black 2026-07-29 12:08:10.648102 | Pipeline: check 2026-07-29 12:08:10.648125 | Executor: 521e9411259a 2026-07-29 12:08:10.648147 | Triggered by: https://github.com/osism/python-osism/pull/2530 2026-07-29 12:08:10.648169 | Event ID: 1e037270-8b46-11f1-9a44-74724cb39d81 2026-07-29 12:08:10.652964 | 2026-07-29 12:08:10.653058 | LOOP [emit-job-header : Print node information] 2026-07-29 12:08:11.003645 | debian-bookworm | ok: 2026-07-29 12:08:11.003879 | debian-bookworm | # Node Information 2026-07-29 12:08:11.003910 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-07-29 12:08:11.003931 | debian-bookworm | Hostname: debian 2026-07-29 12:08:11.003950 | debian-bookworm | Username: zuul 2026-07-29 12:08:11.003967 | debian-bookworm | Distro: Debian 12.15 2026-07-29 12:08:11.003992 | debian-bookworm | Provider: regiocloud-a 2026-07-29 12:08:11.004013 | debian-bookworm | Region: 2026-07-29 12:08:11.004030 | debian-bookworm | Label: debian-bookworm 2026-07-29 12:08:11.004046 | debian-bookworm | Product Name: OpenStack Nova 2026-07-29 12:08:11.004062 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe84:f3bb 2026-07-29 12:08:11.020768 | 2026-07-29 12:08:11.020899 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-07-29 12:08:12.311596 | debian-bookworm -> localhost | changed 2026-07-29 12:08:12.318758 | 2026-07-29 12:08:12.318881 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-07-29 12:08:15.198597 | debian-bookworm -> localhost | changed 2026-07-29 12:08:15.207553 | 2026-07-29 12:08:15.207648 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-07-29 12:08:15.752050 | debian-bookworm -> localhost | ok 2026-07-29 12:08:15.757291 | 2026-07-29 12:08:15.757375 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-07-29 12:08:15.787267 | debian-bookworm | ok 2026-07-29 12:08:15.816928 | debian-bookworm | included: /var/lib/zuul/builds/9233d0c919cc42ef9a678f998b804b8d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-07-29 12:08:15.825634 | 2026-07-29 12:08:15.825741 | TASK [add-build-sshkey : Create Temp SSH key] 2026-07-29 12:08:17.722223 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-07-29 12:08:17.722411 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/9233d0c919cc42ef9a678f998b804b8d/work/9233d0c919cc42ef9a678f998b804b8d_id_rsa 2026-07-29 12:08:17.722443 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/9233d0c919cc42ef9a678f998b804b8d/work/9233d0c919cc42ef9a678f998b804b8d_id_rsa.pub 2026-07-29 12:08:17.722465 | debian-bookworm -> localhost | The key fingerprint is: 2026-07-29 12:08:17.722486 | debian-bookworm -> localhost | SHA256:Nj1wuLmIzwiiEwZ2OcnRWeSJs3lqhI6D5+KQgzQmi8c zuul-build-sshkey 2026-07-29 12:08:17.722505 | debian-bookworm -> localhost | The key's randomart image is: 2026-07-29 12:08:17.722534 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-07-29 12:08:17.722552 | debian-bookworm -> localhost | | . +o | 2026-07-29 12:08:17.722570 | debian-bookworm -> localhost | | . oo .. | 2026-07-29 12:08:17.722586 | debian-bookworm -> localhost | | . +o oo . | 2026-07-29 12:08:17.722602 | debian-bookworm -> localhost | |.. *. + * | 2026-07-29 12:08:17.722618 | debian-bookworm -> localhost | |++...+ .S o | 2026-07-29 12:08:17.722639 | debian-bookworm -> localhost | |O=+ ..oo o . | 2026-07-29 12:08:17.722656 | debian-bookworm -> localhost | |@+E..o. . | 2026-07-29 12:08:17.722672 | debian-bookworm -> localhost | |=*...+ | 2026-07-29 12:08:17.722696 | debian-bookworm -> localhost | |o+. . o | 2026-07-29 12:08:17.722715 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-07-29 12:08:17.722760 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.832212 2026-07-29 12:08:17.728118 | 2026-07-29 12:08:17.728205 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-07-29 12:08:17.775988 | debian-bookworm | ok 2026-07-29 12:08:17.798618 | debian-bookworm | included: /var/lib/zuul/builds/9233d0c919cc42ef9a678f998b804b8d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-07-29 12:08:17.808546 | 2026-07-29 12:08:17.808640 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-07-29 12:08:17.838132 | debian-bookworm | skipping: Conditional result was False 2026-07-29 12:08:17.844058 | 2026-07-29 12:08:17.844158 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-07-29 12:08:18.755443 | debian-bookworm | changed 2026-07-29 12:08:18.759919 | 2026-07-29 12:08:18.759999 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-07-29 12:08:19.059437 | debian-bookworm | ok 2026-07-29 12:08:19.063985 | 2026-07-29 12:08:19.064068 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-07-29 12:08:19.881800 | debian-bookworm | changed 2026-07-29 12:08:19.886328 | 2026-07-29 12:08:19.886415 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-07-29 12:08:20.603241 | debian-bookworm | changed 2026-07-29 12:08:20.608371 | 2026-07-29 12:08:20.608457 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-07-29 12:08:20.647379 | debian-bookworm | skipping: Conditional result was False 2026-07-29 12:08:20.654192 | 2026-07-29 12:08:20.654334 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-07-29 12:08:21.402612 | debian-bookworm -> localhost | changed 2026-07-29 12:08:21.415887 | 2026-07-29 12:08:21.416044 | TASK [add-build-sshkey : Add back temp key] 2026-07-29 12:08:21.746614 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/9233d0c919cc42ef9a678f998b804b8d/work/9233d0c919cc42ef9a678f998b804b8d_id_rsa (zuul-build-sshkey) 2026-07-29 12:08:21.746947 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.009736 2026-07-29 12:08:21.755315 | 2026-07-29 12:08:21.755450 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-07-29 12:08:22.186145 | debian-bookworm | ok 2026-07-29 12:08:22.193486 | 2026-07-29 12:08:22.193590 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-07-29 12:08:22.250036 | debian-bookworm | skipping: Conditional result was False 2026-07-29 12:08:22.260662 | 2026-07-29 12:08:22.260793 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-07-29 12:08:22.891773 | debian-bookworm | ok 2026-07-29 12:08:22.905874 | 2026-07-29 12:08:22.906002 | TASK [validate-host : Define zuul_info_dir fact] 2026-07-29 12:08:22.956799 | debian-bookworm | ok 2026-07-29 12:08:22.966769 | 2026-07-29 12:08:22.966904 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-07-29 12:08:23.331398 | debian-bookworm -> localhost | ok 2026-07-29 12:08:23.337841 | 2026-07-29 12:08:23.337941 | TASK [validate-host : Collect information about the host] 2026-07-29 12:08:24.584420 | debian-bookworm | ok 2026-07-29 12:08:24.605100 | 2026-07-29 12:08:24.605219 | TASK [validate-host : Sanitize hostname] 2026-07-29 12:08:24.834759 | debian-bookworm | ok 2026-07-29 12:08:24.850373 | 2026-07-29 12:08:24.850477 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-07-29 12:08:25.871529 | debian-bookworm -> localhost | changed 2026-07-29 12:08:25.877653 | 2026-07-29 12:08:25.877800 | TASK [validate-host : Collect information about zuul worker] 2026-07-29 12:08:26.342578 | debian-bookworm | ok 2026-07-29 12:08:26.348168 | 2026-07-29 12:08:26.348298 | TASK [validate-host : Write out all zuul information for each host] 2026-07-29 12:08:27.238060 | debian-bookworm -> localhost | changed 2026-07-29 12:08:27.260390 | 2026-07-29 12:08:27.260636 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-07-29 12:08:27.576289 | debian-bookworm | ok 2026-07-29 12:08:27.581498 | 2026-07-29 12:08:27.581580 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-07-29 12:08:28.723753 | debian-bookworm | changed: 2026-07-29 12:08:28.723944 | debian-bookworm | cd+++++++++ src/ 2026-07-29 12:08:28.723979 | debian-bookworm | cd+++++++++ src/github.com/ 2026-07-29 12:08:28.724003 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-07-29 12:08:28.724025 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-07-29 12:08:28.724045 | debian-bookworm | Containerfile 2026-07-29 12:08:28.724175 | debian-bookworm | Containerfile 2026-07-29 12:08:28.730327 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/9233d0c919cc42ef9a678f998b804b8d/work/logs" 2026-07-29 12:09:39.348304 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/9233d0c919cc42ef9a678f998b804b8d/work/artifacts" 2026-07-29 12:09:39.643752 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/9233d0c919cc42ef9a678f998b804b8d/work/docs" 2026-07-29 12:09:39.665373 | 2026-07-29 12:09:39.665564 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-07-29 12:09:40.511910 | debian-bookworm | changed: 2026-07-29 12:09:40.512194 | debian-bookworm | .d..t...... ./ 2026-07-29 12:09:40.512232 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-07-29 12:09:40.512256 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-07-29 12:09:40.512277 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-07-29 12:09:40.512299 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-07-29 12:09:40.512319 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-07-29 12:09:40.512363 | debian-bookworm | changed: All items complete 2026-07-29 12:09:40.512390 | 2026-07-29 12:09:41.110226 | debian-bookworm | changed: .d..t...... ./ 2026-07-29 12:09:41.697802 | debian-bookworm | changed: .d..t...... ./ 2026-07-29 12:09:41.721462 | 2026-07-29 12:09:41.721652 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-07-29 12:09:42.112821 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.011825 2026-07-29 12:09:42.426540 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.011968 2026-07-29 12:09:42.438659 | 2026-07-29 12:09:42.438786 | PLAY RECAP 2026-07-29 12:09:42.439170 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-07-29 12:09:42.439206 | 2026-07-29 12:09:42.595774 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-29 12:09:42.600985 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-29 12:09:43.404641 | 2026-07-29 12:09:43.404849 | PLAY [Base post] 2026-07-29 12:09:43.420226 | 2026-07-29 12:09:43.420402 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-07-29 12:09:44.088482 | debian-bookworm | changed 2026-07-29 12:09:44.099696 | 2026-07-29 12:09:44.099835 | PLAY RECAP 2026-07-29 12:09:44.099915 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-29 12:09:44.099999 | 2026-07-29 12:09:44.278423 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-29 12:09:44.280655 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-07-29 12:09:45.140791 | 2026-07-29 12:09:45.140997 | PLAY [Base post-logs] 2026-07-29 12:09:45.153208 | 2026-07-29 12:09:45.153363 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-07-29 12:09:45.659498 | localhost | changed 2026-07-29 12:09:45.671036 | 2026-07-29 12:09:45.671208 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-07-29 12:09:45.712106 | localhost | ok 2026-07-29 12:09:45.718018 | 2026-07-29 12:09:45.718175 | TASK [Set zuul-log-path fact] 2026-07-29 12:09:45.746350 | localhost | ok 2026-07-29 12:09:45.759080 | 2026-07-29 12:09:45.759221 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-29 12:09:45.797202 | localhost | ok 2026-07-29 12:09:45.803368 | 2026-07-29 12:09:45.803534 | TASK [upload-logs : Create log directories] 2026-07-29 12:09:46.380994 | localhost | changed 2026-07-29 12:09:46.384073 | 2026-07-29 12:09:46.384190 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-07-29 12:09:46.974904 | localhost -> localhost | ok: Runtime: 0:00:00.008264 2026-07-29 12:09:46.979878 | 2026-07-29 12:09:46.980000 | TASK [upload-logs : Upload logs to log server] 2026-07-29 12:09:47.629680 | localhost | Output suppressed because no_log was given 2026-07-29 12:09:47.634740 | 2026-07-29 12:09:47.635043 | LOOP [upload-logs : Compress console log and json output] 2026-07-29 12:09:47.692842 | localhost | skipping: Conditional result was False 2026-07-29 12:09:47.701067 | localhost | skipping: Conditional result was False 2026-07-29 12:09:47.720275 | 2026-07-29 12:09:47.720524 | LOOP [upload-logs : Upload compressed console log and json output] 2026-07-29 12:09:47.772379 | localhost | skipping: Conditional result was False 2026-07-29 12:09:47.772720 | 2026-07-29 12:09:47.779266 | localhost | skipping: Conditional result was False 2026-07-29 12:09:47.790651 | 2026-07-29 12:09:47.790825 | LOOP [upload-logs : Upload console log and json output]