2026-09-10 07:23:38.320482 | Job console starting 2026-09-10 07:23:38.351821 | Updating git repos 2026-09-10 07:23:38.422056 | Cloning repos into workspace 2026-09-10 07:23:38.490598 | Restoring repo states 2026-09-10 07:23:38.501055 | Merging changes 2026-09-10 07:23:39.305697 | Checking out repos 2026-09-10 07:23:39.374461 | Preparing playbooks 2026-09-10 07:23:40.534029 | Running Ansible setup 2026-09-10 07:23:46.507878 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-09-10 07:23:47.569494 | 2026-09-10 07:23:47.582284 | PLAY [Base pre] 2026-09-10 07:23:47.631426 | 2026-09-10 07:23:47.631574 | TASK [Setup log path fact] 2026-09-10 07:23:47.684157 | debian-bookworm | ok 2026-09-10 07:23:47.746200 | 2026-09-10 07:23:47.746333 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-10 07:23:47.817428 | debian-bookworm | ok 2026-09-10 07:23:47.842867 | 2026-09-10 07:23:47.842976 | TASK [emit-job-header : Print job information] 2026-09-10 07:23:47.893952 | # Job Information 2026-09-10 07:23:47.894105 | Ansible Version: 2.16.14 2026-09-10 07:23:47.894139 | Job: python-black 2026-09-10 07:23:47.894169 | Pipeline: check 2026-09-10 07:23:47.894192 | Executor: 521e9411259a 2026-09-10 07:23:47.894213 | Triggered by: https://github.com/osism/python-osism/pull/2687 2026-09-10 07:23:47.894235 | Event ID: 842d0890-ace8-11f1-9131-556e176f2fcc 2026-09-10 07:23:47.898921 | 2026-09-10 07:23:47.899012 | LOOP [emit-job-header : Print node information] 2026-09-10 07:23:48.091685 | debian-bookworm | ok: 2026-09-10 07:23:48.091845 | debian-bookworm | # Node Information 2026-09-10 07:23:48.091880 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-09-10 07:23:48.091905 | debian-bookworm | Hostname: debian 2026-09-10 07:23:48.091926 | debian-bookworm | Username: zuul 2026-09-10 07:23:48.091946 | debian-bookworm | Distro: Debian 12.15 2026-09-10 07:23:48.091970 | debian-bookworm | Provider: regiocloud-a 2026-09-10 07:23:48.091991 | debian-bookworm | Region: 2026-09-10 07:23:48.092013 | debian-bookworm | Label: debian-bookworm 2026-09-10 07:23:48.092033 | debian-bookworm | Product Name: OpenStack Nova 2026-09-10 07:23:48.092053 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe3c:e2dd 2026-09-10 07:23:48.108155 | 2026-09-10 07:23:48.108256 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-10 07:23:49.094585 | debian-bookworm -> localhost | changed 2026-09-10 07:23:49.100199 | 2026-09-10 07:23:49.100289 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-10 07:23:51.871792 | debian-bookworm -> localhost | changed 2026-09-10 07:23:51.881961 | 2026-09-10 07:23:51.882130 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-10 07:23:52.434594 | debian-bookworm -> localhost | ok 2026-09-10 07:23:52.439492 | 2026-09-10 07:23:52.439591 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-10 07:23:52.457230 | debian-bookworm | ok 2026-09-10 07:23:52.488927 | debian-bookworm | included: /var/lib/zuul/builds/11124a4813a2434daa51df6ff4a0df3a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-10 07:23:52.498715 | 2026-09-10 07:23:52.498797 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-10 07:23:56.125929 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-09-10 07:23:56.126852 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/11124a4813a2434daa51df6ff4a0df3a/work/11124a4813a2434daa51df6ff4a0df3a_id_rsa 2026-09-10 07:23:56.126910 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/11124a4813a2434daa51df6ff4a0df3a/work/11124a4813a2434daa51df6ff4a0df3a_id_rsa.pub 2026-09-10 07:23:56.126935 | debian-bookworm -> localhost | The key fingerprint is: 2026-09-10 07:23:56.126957 | debian-bookworm -> localhost | SHA256:fX8ox83ccMDUcc9r0iNDGjxkLiCSygMidgzLYGvKu5k zuul-build-sshkey 2026-09-10 07:23:56.126977 | debian-bookworm -> localhost | The key's randomart image is: 2026-09-10 07:23:56.127004 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-09-10 07:23:56.127022 | debian-bookworm -> localhost | |.oo... . o .oo| 2026-09-10 07:23:56.127040 | debian-bookworm -> localhost | |B.o+. . . = o .+| 2026-09-10 07:23:56.127057 | debian-bookworm -> localhost | |*=o . = .o o| 2026-09-10 07:23:56.127073 | debian-bookworm -> localhost | |++ .. = ...| 2026-09-10 07:23:56.127090 | debian-bookworm -> localhost | |... S ...+.=.| 2026-09-10 07:23:56.127109 | debian-bookworm -> localhost | | . . o=Bo| 2026-09-10 07:23:56.127126 | debian-bookworm -> localhost | | . . = *| 2026-09-10 07:23:56.127142 | debian-bookworm -> localhost | | + o . | 2026-09-10 07:23:56.127160 | debian-bookworm -> localhost | | E | 2026-09-10 07:23:56.127177 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-09-10 07:23:56.127239 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.988758 2026-09-10 07:23:56.132322 | 2026-09-10 07:23:56.132395 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-10 07:23:56.155628 | debian-bookworm | ok 2026-09-10 07:23:56.164785 | debian-bookworm | included: /var/lib/zuul/builds/11124a4813a2434daa51df6ff4a0df3a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-10 07:23:56.175147 | 2026-09-10 07:23:56.175234 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-10 07:23:56.198416 | debian-bookworm | skipping: Conditional result was False 2026-09-10 07:23:56.203386 | 2026-09-10 07:23:56.203466 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-10 07:23:56.889518 | debian-bookworm | changed 2026-09-10 07:23:56.896073 | 2026-09-10 07:23:56.896244 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-10 07:23:57.141762 | debian-bookworm | ok 2026-09-10 07:23:57.148257 | 2026-09-10 07:23:57.148353 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-10 07:23:57.823002 | debian-bookworm | changed 2026-09-10 07:23:57.830959 | 2026-09-10 07:23:57.831061 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-10 07:23:58.532088 | debian-bookworm | changed 2026-09-10 07:23:58.544330 | 2026-09-10 07:23:58.544451 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-10 07:23:58.587714 | debian-bookworm | skipping: Conditional result was False 2026-09-10 07:23:58.594453 | 2026-09-10 07:23:58.594563 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-10 07:23:59.625194 | debian-bookworm -> localhost | changed 2026-09-10 07:23:59.636606 | 2026-09-10 07:23:59.636705 | TASK [add-build-sshkey : Add back temp key] 2026-09-10 07:23:59.982805 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/11124a4813a2434daa51df6ff4a0df3a/work/11124a4813a2434daa51df6ff4a0df3a_id_rsa (zuul-build-sshkey) 2026-09-10 07:23:59.982990 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.015878 2026-09-10 07:23:59.989077 | 2026-09-10 07:23:59.989165 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-10 07:24:00.559309 | debian-bookworm | ok 2026-09-10 07:24:00.564155 | 2026-09-10 07:24:00.564240 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-10 07:24:00.610984 | debian-bookworm | skipping: Conditional result was False 2026-09-10 07:24:00.622898 | 2026-09-10 07:24:00.623298 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-09-10 07:24:01.176645 | debian-bookworm | ok 2026-09-10 07:24:01.200020 | 2026-09-10 07:24:01.200119 | TASK [validate-host : Define zuul_info_dir fact] 2026-09-10 07:24:01.230914 | debian-bookworm | ok 2026-09-10 07:24:01.236130 | 2026-09-10 07:24:01.236223 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-09-10 07:24:01.829154 | debian-bookworm -> localhost | ok 2026-09-10 07:24:01.835521 | 2026-09-10 07:24:01.835650 | TASK [validate-host : Collect information about the host] 2026-09-10 07:24:03.123951 | debian-bookworm | ok 2026-09-10 07:24:03.145386 | 2026-09-10 07:24:03.145487 | TASK [validate-host : Sanitize hostname] 2026-09-10 07:24:03.298319 | debian-bookworm | ok 2026-09-10 07:24:03.304478 | 2026-09-10 07:24:03.304597 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-09-10 07:24:03.929043 | debian-bookworm -> localhost | changed 2026-09-10 07:24:03.933523 | 2026-09-10 07:24:03.933626 | TASK [validate-host : Collect information about zuul worker] 2026-09-10 07:24:04.378448 | debian-bookworm | ok 2026-09-10 07:24:04.383140 | 2026-09-10 07:24:04.383234 | TASK [validate-host : Write out all zuul information for each host] 2026-09-10 07:24:05.421793 | debian-bookworm -> localhost | changed 2026-09-10 07:24:05.441972 | 2026-09-10 07:24:05.442254 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-09-10 07:24:05.719794 | debian-bookworm | ok 2026-09-10 07:24:05.731364 | 2026-09-10 07:24:05.731601 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-09-10 07:24:08.262319 | debian-bookworm | changed: 2026-09-10 07:24:08.265705 | debian-bookworm | cd+++++++++ src/ 2026-09-10 07:24:08.265771 | debian-bookworm | cd+++++++++ src/github.com/ 2026-09-10 07:24:08.265796 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-09-10 07:24:08.265817 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-09-10 07:24:08.265837 | debian-bookworm | Containerfile 2026-09-10 07:24:08.265956 | debian-bookworm | Containerfile 2026-09-10 07:24:08.282326 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/11124a4813a2434daa51df6ff4a0df3a/work/logs" 2026-09-10 07:25:24.408887 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/11124a4813a2434daa51df6ff4a0df3a/work/artifacts" 2026-09-10 07:25:24.679839 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/11124a4813a2434daa51df6ff4a0df3a/work/docs" 2026-09-10 07:25:24.698542 | 2026-09-10 07:25:24.698754 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-10 07:25:25.600974 | debian-bookworm | changed: 2026-09-10 07:25:25.601226 | debian-bookworm | .d..t...... ./ 2026-09-10 07:25:25.601266 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-09-10 07:25:25.601291 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-09-10 07:25:25.601313 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-09-10 07:25:25.601334 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-09-10 07:25:25.601355 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-09-10 07:25:25.601397 | debian-bookworm | changed: All items complete 2026-09-10 07:25:25.601424 | 2026-09-10 07:25:26.223865 | debian-bookworm | changed: .d..t...... ./ 2026-09-10 07:25:26.832268 | debian-bookworm | changed: .d..t...... ./ 2026-09-10 07:25:26.858125 | 2026-09-10 07:25:26.858265 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-10 07:25:27.239833 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.005727 2026-09-10 07:25:27.530354 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.023543 2026-09-10 07:25:27.543979 | 2026-09-10 07:25:27.544076 | PLAY RECAP 2026-09-10 07:25:27.544124 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-09-10 07:25:27.544148 | 2026-09-10 07:25:27.684185 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-10 07:25:27.685091 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-10 07:25:28.563009 | 2026-09-10 07:25:28.563166 | PLAY [Base post] 2026-09-10 07:25:28.577389 | 2026-09-10 07:25:28.577526 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-10 07:25:29.171380 | debian-bookworm | changed 2026-09-10 07:25:29.182551 | 2026-09-10 07:25:29.182702 | PLAY RECAP 2026-09-10 07:25:29.182789 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-10 07:25:29.182877 | 2026-09-10 07:25:29.317973 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-10 07:25:29.321773 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-10 07:25:30.170376 | 2026-09-10 07:25:30.170550 | PLAY [Base post-logs] 2026-09-10 07:25:30.181918 | 2026-09-10 07:25:30.182062 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-10 07:25:30.669338 | localhost | changed 2026-09-10 07:25:30.683254 | 2026-09-10 07:25:30.683509 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-10 07:25:30.709642 | localhost | ok 2026-09-10 07:25:30.712794 | 2026-09-10 07:25:30.712899 | TASK [Set zuul-log-path fact] 2026-09-10 07:25:30.729336 | localhost | ok 2026-09-10 07:25:30.737440 | 2026-09-10 07:25:30.737632 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-10 07:25:30.766669 | localhost | ok 2026-09-10 07:25:30.771423 | 2026-09-10 07:25:30.771617 | TASK [upload-logs : Create log directories] 2026-09-10 07:25:31.291706 | localhost | changed 2026-09-10 07:25:31.298235 | 2026-09-10 07:25:31.298389 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-10 07:25:31.855391 | localhost -> localhost | ok: Runtime: 0:00:00.006988 2026-09-10 07:25:31.865261 | 2026-09-10 07:25:31.865444 | TASK [upload-logs : Upload logs to log server] 2026-09-10 07:25:32.480806 | localhost | Output suppressed because no_log was given 2026-09-10 07:25:32.482852 | 2026-09-10 07:25:32.482965 | LOOP [upload-logs : Compress console log and json output] 2026-09-10 07:25:32.537788 | localhost | skipping: Conditional result was False 2026-09-10 07:25:32.543812 | localhost | skipping: Conditional result was False 2026-09-10 07:25:32.555121 | 2026-09-10 07:25:32.555328 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-10 07:25:32.602590 | localhost | skipping: Conditional result was False 2026-09-10 07:25:32.603314 | 2026-09-10 07:25:32.607705 | localhost | skipping: Conditional result was False 2026-09-10 07:25:32.620287 | 2026-09-10 07:25:32.620504 | LOOP [upload-logs : Upload console log and json output]