2026-05-19 10:50:21.076232 | Job console starting 2026-05-19 10:50:21.087969 | Updating git repos 2026-05-19 10:50:21.170048 | Cloning repos into workspace 2026-05-19 10:50:21.292050 | Restoring repo states 2026-05-19 10:50:21.325929 | Merging changes 2026-05-19 10:50:21.928363 | Checking out repos 2026-05-19 10:50:21.992892 | Preparing playbooks 2026-05-19 10:50:23.422829 | Running Ansible setup 2026-05-19 10:50:28.540166 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-19 10:50:29.844964 | 2026-05-19 10:50:29.845149 | PLAY [Base pre] 2026-05-19 10:50:29.893696 | 2026-05-19 10:50:29.893865 | TASK [Setup log path fact] 2026-05-19 10:50:29.923017 | debian-bookworm | ok 2026-05-19 10:50:29.955189 | 2026-05-19 10:50:29.955365 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-19 10:50:30.016774 | debian-bookworm | ok 2026-05-19 10:50:30.030810 | 2026-05-19 10:50:30.030977 | TASK [emit-job-header : Print job information] 2026-05-19 10:50:30.105982 | # Job Information 2026-05-19 10:50:30.106176 | Ansible Version: 2.16.14 2026-05-19 10:50:30.106210 | Job: python-black 2026-05-19 10:50:30.106240 | Pipeline: check 2026-05-19 10:50:30.106262 | Executor: 521e9411259a 2026-05-19 10:50:30.106282 | Triggered by: https://github.com/osism/container-image-osism-ansible/pull/746 2026-05-19 10:50:30.106304 | Event ID: 8166da40-5370-11f1-83e2-48db0474f909 2026-05-19 10:50:30.111552 | 2026-05-19 10:50:30.111677 | LOOP [emit-job-header : Print node information] 2026-05-19 10:50:30.332189 | debian-bookworm | ok: 2026-05-19 10:50:30.332508 | debian-bookworm | # Node Information 2026-05-19 10:50:30.332569 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-19 10:50:30.332596 | debian-bookworm | Hostname: debian 2026-05-19 10:50:30.332618 | debian-bookworm | Username: zuul 2026-05-19 10:50:30.332638 | debian-bookworm | Distro: Debian 12.14 2026-05-19 10:50:30.332662 | debian-bookworm | Provider: regiocloud-a 2026-05-19 10:50:30.332682 | debian-bookworm | Region: 2026-05-19 10:50:30.332703 | debian-bookworm | Label: debian-bookworm 2026-05-19 10:50:30.332722 | debian-bookworm | Product Name: OpenStack Nova 2026-05-19 10:50:30.332741 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fea8:df6c 2026-05-19 10:50:30.358674 | 2026-05-19 10:50:30.358850 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-19 10:50:31.078319 | debian-bookworm -> localhost | changed 2026-05-19 10:50:31.088651 | 2026-05-19 10:50:31.088817 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-19 10:50:32.845653 | debian-bookworm -> localhost | changed 2026-05-19 10:50:32.861785 | 2026-05-19 10:50:32.861926 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-19 10:50:33.263918 | debian-bookworm -> localhost | ok 2026-05-19 10:50:33.270773 | 2026-05-19 10:50:33.271102 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-19 10:50:33.301127 | debian-bookworm | ok 2026-05-19 10:50:33.348819 | debian-bookworm | included: /var/lib/zuul/builds/0b572c54322e4c0cace5e439c26004c6/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-19 10:50:33.368322 | 2026-05-19 10:50:33.368501 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-19 10:50:35.978677 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-19 10:50:35.978941 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/0b572c54322e4c0cace5e439c26004c6/work/0b572c54322e4c0cace5e439c26004c6_id_rsa 2026-05-19 10:50:35.978983 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/0b572c54322e4c0cace5e439c26004c6/work/0b572c54322e4c0cace5e439c26004c6_id_rsa.pub 2026-05-19 10:50:35.979009 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-19 10:50:35.979033 | debian-bookworm -> localhost | SHA256:QaPYdIngjLHynlmz+/W7Cr0A7kRmvhUaQWlBJmG72GU zuul-build-sshkey 2026-05-19 10:50:35.979068 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-19 10:50:35.979091 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-19 10:50:35.979112 | debian-bookworm -> localhost | | =o*+..+. | 2026-05-19 10:50:35.979134 | debian-bookworm -> localhost | | . @o+.+.. | 2026-05-19 10:50:35.979154 | debian-bookworm -> localhost | |. +.E o . | 2026-05-19 10:50:35.979174 | debian-bookworm -> localhost | | = + . . | 2026-05-19 10:50:35.979194 | debian-bookworm -> localhost | |. + O . S | 2026-05-19 10:50:35.979219 | debian-bookworm -> localhost | | . X * o | 2026-05-19 10:50:35.979240 | debian-bookworm -> localhost | | + * + o | 2026-05-19 10:50:35.979261 | debian-bookworm -> localhost | | o + + o | 2026-05-19 10:50:35.979282 | debian-bookworm -> localhost | | +.. o.+o | 2026-05-19 10:50:35.979302 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-19 10:50:35.979356 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.512203 2026-05-19 10:50:35.986333 | 2026-05-19 10:50:35.986484 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-19 10:50:36.015467 | debian-bookworm | ok 2026-05-19 10:50:36.025025 | debian-bookworm | included: /var/lib/zuul/builds/0b572c54322e4c0cace5e439c26004c6/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-19 10:50:36.034875 | 2026-05-19 10:50:36.035034 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-19 10:50:36.060706 | debian-bookworm | skipping: Conditional result was False 2026-05-19 10:50:36.067100 | 2026-05-19 10:50:36.067243 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-19 10:50:36.733832 | debian-bookworm | changed 2026-05-19 10:50:36.740491 | 2026-05-19 10:50:36.740605 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-19 10:50:37.005939 | debian-bookworm | ok 2026-05-19 10:50:37.014859 | 2026-05-19 10:50:37.015011 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-19 10:50:37.696703 | debian-bookworm | changed 2026-05-19 10:50:37.704079 | 2026-05-19 10:50:37.704225 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-19 10:50:38.337796 | debian-bookworm | changed 2026-05-19 10:50:38.349047 | 2026-05-19 10:50:38.349182 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-19 10:50:38.373141 | debian-bookworm | skipping: Conditional result was False 2026-05-19 10:50:38.379821 | 2026-05-19 10:50:38.379951 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-19 10:50:38.955633 | debian-bookworm -> localhost | changed 2026-05-19 10:50:38.969045 | 2026-05-19 10:50:38.969187 | TASK [add-build-sshkey : Add back temp key] 2026-05-19 10:50:39.308433 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/0b572c54322e4c0cace5e439c26004c6/work/0b572c54322e4c0cace5e439c26004c6_id_rsa (zuul-build-sshkey) 2026-05-19 10:50:39.308729 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.010748 2026-05-19 10:50:39.317420 | 2026-05-19 10:50:39.317580 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-19 10:50:39.790332 | debian-bookworm | ok 2026-05-19 10:50:39.795925 | 2026-05-19 10:50:39.796050 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-19 10:50:39.831147 | debian-bookworm | skipping: Conditional result was False 2026-05-19 10:50:39.842610 | 2026-05-19 10:50:39.842756 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-19 10:50:40.410393 | debian-bookworm | ok 2026-05-19 10:50:40.429518 | 2026-05-19 10:50:40.429695 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-19 10:50:40.467265 | debian-bookworm | ok 2026-05-19 10:50:40.484994 | 2026-05-19 10:50:40.485134 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-19 10:50:40.827663 | debian-bookworm -> localhost | ok 2026-05-19 10:50:40.834848 | 2026-05-19 10:50:40.834986 | TASK [validate-host : Collect information about the host] 2026-05-19 10:50:42.037983 | debian-bookworm | ok 2026-05-19 10:50:42.049090 | 2026-05-19 10:50:42.049231 | TASK [validate-host : Sanitize hostname] 2026-05-19 10:50:42.171464 | debian-bookworm | ok 2026-05-19 10:50:42.216407 | 2026-05-19 10:50:42.216580 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-19 10:50:42.851245 | debian-bookworm -> localhost | changed 2026-05-19 10:50:42.857679 | 2026-05-19 10:50:42.857807 | TASK [validate-host : Collect information about zuul worker] 2026-05-19 10:50:43.324675 | debian-bookworm | ok 2026-05-19 10:50:43.336744 | 2026-05-19 10:50:43.336919 | TASK [validate-host : Write out all zuul information for each host] 2026-05-19 10:50:43.945817 | debian-bookworm -> localhost | changed 2026-05-19 10:50:43.956821 | 2026-05-19 10:50:43.956943 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-19 10:50:44.236345 | debian-bookworm | ok 2026-05-19 10:50:44.242338 | 2026-05-19 10:50:44.242510 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-19 10:50:45.264768 | debian-bookworm | changed: 2026-05-19 10:50:45.265096 | debian-bookworm | cd+++++++++ src/ 2026-05-19 10:50:45.265150 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-19 10:50:45.265176 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-19 10:50:45.265198 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-osism-ansible/ 2026-05-19 10:50:45.265220 | debian-bookworm | Containerfile 2026-05-19 10:50:45.265384 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/0b572c54322e4c0cace5e439c26004c6/work/logs" 2026-05-19 10:51:12.411567 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/0b572c54322e4c0cace5e439c26004c6/work/artifacts" 2026-05-19 10:51:12.685747 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/0b572c54322e4c0cace5e439c26004c6/work/docs" 2026-05-19 10:51:12.711464 | 2026-05-19 10:51:12.711694 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-19 10:51:13.533663 | debian-bookworm | changed: 2026-05-19 10:51:13.533895 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-19 10:51:13.533929 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-19 10:51:13.533958 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-19 10:51:13.534000 | debian-bookworm | changed: All items complete 2026-05-19 10:51:13.534023 | 2026-05-19 10:51:14.104771 | debian-bookworm | changed: .d..t...... ./ 2026-05-19 10:51:14.751032 | debian-bookworm | changed: .d..t...... ./ 2026-05-19 10:51:14.800699 | 2026-05-19 10:51:14.803130 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-19 10:51:16.082457 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.019368 2026-05-19 10:51:17.155843 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.043057 2026-05-19 10:51:17.177597 | 2026-05-19 10:51:17.177759 | PLAY RECAP 2026-05-19 10:51:17.177821 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-19 10:51:17.177851 | 2026-05-19 10:51:17.993764 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-19 10:51:17.995700 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-19 10:51:21.178065 | 2026-05-19 10:51:21.178201 | PLAY [Base post] 2026-05-19 10:51:21.285372 | 2026-05-19 10:51:21.285546 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-19 10:51:22.212691 | debian-bookworm | changed 2026-05-19 10:51:22.227536 | 2026-05-19 10:51:22.227640 | PLAY RECAP 2026-05-19 10:51:22.228203 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-19 10:51:22.228678 | 2026-05-19 10:51:22.549479 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-19 10:51:22.550098 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-19 10:51:23.419242 | 2026-05-19 10:51:23.419365 | PLAY [Base post-logs] 2026-05-19 10:51:23.433894 | 2026-05-19 10:51:23.434014 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-19 10:51:24.739361 | localhost | changed 2026-05-19 10:51:24.748249 | 2026-05-19 10:51:24.748372 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-19 10:51:24.811094 | localhost | ok 2026-05-19 10:51:24.814364 | 2026-05-19 10:51:24.814477 | TASK [Set zuul-log-path fact] 2026-05-19 10:51:24.840556 | localhost | ok 2026-05-19 10:51:24.861551 | 2026-05-19 10:51:24.861677 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-19 10:51:24.906302 | localhost | ok 2026-05-19 10:51:24.908872 | 2026-05-19 10:51:24.908947 | TASK [upload-logs : Create log directories] 2026-05-19 10:51:26.278539 | localhost | changed 2026-05-19 10:51:26.280715 | 2026-05-19 10:51:26.280785 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-19 10:51:26.975032 | localhost -> localhost | ok: Runtime: 0:00:00.019325 2026-05-19 10:51:26.978009 | 2026-05-19 10:51:26.978086 | TASK [upload-logs : Upload logs to log server] 2026-05-19 10:51:28.571728 | localhost | Output suppressed because no_log was given 2026-05-19 10:51:28.573087 | 2026-05-19 10:51:28.573157 | LOOP [upload-logs : Compress console log and json output] 2026-05-19 10:51:28.759677 | localhost | skipping: Conditional result was False 2026-05-19 10:51:28.783465 | localhost | skipping: Conditional result was False 2026-05-19 10:51:28.785951 | 2026-05-19 10:51:28.786029 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-19 10:51:28.896510 | localhost | skipping: Conditional result was False 2026-05-19 10:51:28.896721 | 2026-05-19 10:51:28.910983 | localhost | skipping: Conditional result was False 2026-05-19 10:51:28.919732 | 2026-05-19 10:51:28.919822 | LOOP [upload-logs : Upload console log and json output]