2026-08-27 03:09:41.811337 | Job console starting 2026-08-27 03:09:41.822644 | Updating git repos 2026-08-27 03:09:41.845955 | Cloning repos into workspace 2026-08-27 03:09:41.933550 | Restoring repo states 2026-08-27 03:09:41.939633 | Merging changes 2026-08-27 03:09:41.939668 | Checking out repos 2026-08-27 03:09:42.027416 | Preparing playbooks 2026-08-27 03:09:42.978452 | Running Ansible setup 2026-08-27 03:09:48.422606 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-08-27 03:09:49.318201 | 2026-08-27 03:09:49.318383 | PLAY [Base pre] 2026-08-27 03:09:49.338058 | 2026-08-27 03:09:49.338211 | TASK [Setup log path fact] 2026-08-27 03:09:49.369110 | debian-bookworm | ok 2026-08-27 03:09:49.389379 | 2026-08-27 03:09:49.389552 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-27 03:09:49.431520 | debian-bookworm | ok 2026-08-27 03:09:49.446414 | 2026-08-27 03:09:49.446565 | TASK [emit-job-header : Print job information] 2026-08-27 03:09:49.494866 | # Job Information 2026-08-27 03:09:49.495389 | Ansible Version: 2.16.14 2026-08-27 03:09:49.495539 | Job: python-black 2026-08-27 03:09:49.495603 | Pipeline: periodic-daily 2026-08-27 03:09:49.495663 | Executor: 521e9411259a 2026-08-27 03:09:49.495702 | Triggered by: https://github.com/osism/testbed 2026-08-27 03:09:49.495741 | Event ID: a78d54189b1842bd872821f0352c0067 2026-08-27 03:09:49.504332 | 2026-08-27 03:09:49.504485 | LOOP [emit-job-header : Print node information] 2026-08-27 03:09:49.635869 | debian-bookworm | ok: 2026-08-27 03:09:49.636145 | debian-bookworm | # Node Information 2026-08-27 03:09:49.636186 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-08-27 03:09:49.636214 | debian-bookworm | Hostname: debian 2026-08-27 03:09:49.636236 | debian-bookworm | Username: zuul 2026-08-27 03:09:49.636257 | debian-bookworm | Distro: Debian 12.15 2026-08-27 03:09:49.636281 | debian-bookworm | Provider: regiocloud-a 2026-08-27 03:09:49.636302 | debian-bookworm | Region: 2026-08-27 03:09:49.636324 | debian-bookworm | Label: debian-bookworm 2026-08-27 03:09:49.636344 | debian-bookworm | Product Name: OpenStack Nova 2026-08-27 03:09:49.636363 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe5b:7585 2026-08-27 03:09:49.656599 | 2026-08-27 03:09:49.656774 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-27 03:09:50.178528 | debian-bookworm -> localhost | changed 2026-08-27 03:09:50.187790 | 2026-08-27 03:09:50.187947 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-27 03:09:51.668481 | debian-bookworm -> localhost | changed 2026-08-27 03:09:51.683348 | 2026-08-27 03:09:51.683673 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-27 03:09:52.042487 | debian-bookworm -> localhost | ok 2026-08-27 03:09:52.050159 | 2026-08-27 03:09:52.050293 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-27 03:09:52.084856 | debian-bookworm | ok 2026-08-27 03:09:52.102442 | debian-bookworm | included: /var/lib/zuul/builds/9793ff65ac334d94b101542057d912ad/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-27 03:09:52.113454 | 2026-08-27 03:09:52.113567 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-27 03:09:55.749791 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-08-27 03:09:55.750122 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/9793ff65ac334d94b101542057d912ad/work/9793ff65ac334d94b101542057d912ad_id_rsa 2026-08-27 03:09:55.750178 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/9793ff65ac334d94b101542057d912ad/work/9793ff65ac334d94b101542057d912ad_id_rsa.pub 2026-08-27 03:09:55.750212 | debian-bookworm -> localhost | The key fingerprint is: 2026-08-27 03:09:55.750246 | debian-bookworm -> localhost | SHA256:q1yjyOeJJSL6qInUjl/f5QXZuf/Z5L1Z6C3h1JYq7Bs zuul-build-sshkey 2026-08-27 03:09:55.750279 | debian-bookworm -> localhost | The key's randomart image is: 2026-08-27 03:09:55.750331 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-08-27 03:09:55.750365 | debian-bookworm -> localhost | | | 2026-08-27 03:09:55.750397 | debian-bookworm -> localhost | | | 2026-08-27 03:09:55.750427 | debian-bookworm -> localhost | | | 2026-08-27 03:09:55.750457 | debian-bookworm -> localhost | | o . | 2026-08-27 03:09:55.750486 | debian-bookworm -> localhost | | S o o ..| 2026-08-27 03:09:55.750523 | debian-bookworm -> localhost | | . . . +oo| 2026-08-27 03:09:55.750556 | debian-bookworm -> localhost | |....... + .E =ooo| 2026-08-27 03:09:55.750588 | debian-bookworm -> localhost | |++oo.*o=..oooo++*| 2026-08-27 03:09:55.750622 | debian-bookworm -> localhost | |Booo+o*. ..+o .*O| 2026-08-27 03:09:55.750675 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-08-27 03:09:55.750773 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.898603 2026-08-27 03:09:55.761921 | 2026-08-27 03:09:55.762103 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-27 03:09:55.809922 | debian-bookworm | ok 2026-08-27 03:09:55.856611 | debian-bookworm | included: /var/lib/zuul/builds/9793ff65ac334d94b101542057d912ad/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-27 03:09:55.889526 | 2026-08-27 03:09:55.889822 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-27 03:09:55.924810 | debian-bookworm | skipping: Conditional result was False 2026-08-27 03:09:55.933121 | 2026-08-27 03:09:55.933252 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-27 03:09:57.164080 | debian-bookworm | changed 2026-08-27 03:09:57.176281 | 2026-08-27 03:09:57.176423 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-27 03:09:57.528824 | debian-bookworm | ok 2026-08-27 03:09:57.535666 | 2026-08-27 03:09:57.535805 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-27 03:09:58.262108 | debian-bookworm | changed 2026-08-27 03:09:58.266816 | 2026-08-27 03:09:58.270010 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-27 03:09:58.947758 | debian-bookworm | changed 2026-08-27 03:09:58.953819 | 2026-08-27 03:09:58.953911 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-27 03:09:58.980858 | debian-bookworm | skipping: Conditional result was False 2026-08-27 03:09:58.987011 | 2026-08-27 03:09:58.987146 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-27 03:09:59.473606 | debian-bookworm -> localhost | changed 2026-08-27 03:09:59.491520 | 2026-08-27 03:09:59.491686 | TASK [add-build-sshkey : Add back temp key] 2026-08-27 03:09:59.798925 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/9793ff65ac334d94b101542057d912ad/work/9793ff65ac334d94b101542057d912ad_id_rsa (zuul-build-sshkey) 2026-08-27 03:09:59.799145 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.015325 2026-08-27 03:09:59.806606 | 2026-08-27 03:09:59.806720 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-27 03:10:00.227320 | debian-bookworm | ok 2026-08-27 03:10:00.235457 | 2026-08-27 03:10:00.235573 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-27 03:10:00.258849 | debian-bookworm | skipping: Conditional result was False 2026-08-27 03:10:00.269971 | 2026-08-27 03:10:00.270081 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-08-27 03:10:00.703192 | debian-bookworm | ok 2026-08-27 03:10:00.725112 | 2026-08-27 03:10:00.725256 | TASK [validate-host : Define zuul_info_dir fact] 2026-08-27 03:10:00.755429 | debian-bookworm | ok 2026-08-27 03:10:00.761237 | 2026-08-27 03:10:00.761404 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-08-27 03:10:01.037196 | debian-bookworm -> localhost | ok 2026-08-27 03:10:01.043722 | 2026-08-27 03:10:01.043975 | TASK [validate-host : Collect information about the host] 2026-08-27 03:10:02.221393 | debian-bookworm | ok 2026-08-27 03:10:02.242157 | 2026-08-27 03:10:02.242471 | TASK [validate-host : Sanitize hostname] 2026-08-27 03:10:02.615974 | debian-bookworm | ok 2026-08-27 03:10:02.623600 | 2026-08-27 03:10:02.623816 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-08-27 03:10:03.561497 | debian-bookworm -> localhost | changed 2026-08-27 03:10:03.569407 | 2026-08-27 03:10:03.569528 | TASK [validate-host : Collect information about zuul worker] 2026-08-27 03:10:03.984939 | debian-bookworm | ok 2026-08-27 03:10:03.990285 | 2026-08-27 03:10:03.990418 | TASK [validate-host : Write out all zuul information for each host] 2026-08-27 03:10:04.624784 | debian-bookworm -> localhost | changed 2026-08-27 03:10:04.635781 | 2026-08-27 03:10:04.636012 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-08-27 03:10:04.878227 | debian-bookworm | ok 2026-08-27 03:10:04.889547 | 2026-08-27 03:10:04.889717 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-08-27 03:10:06.109793 | debian-bookworm | changed: 2026-08-27 03:10:06.110039 | debian-bookworm | cd+++++++++ src/ 2026-08-27 03:10:06.110074 | debian-bookworm | cd+++++++++ src/github.com/ 2026-08-27 03:10:06.110098 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-08-27 03:10:06.110121 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2026-08-27 03:10:06.110142 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/9793ff65ac334d94b101542057d912ad/work/logs" 2026-08-27 03:11:07.797414 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/9793ff65ac334d94b101542057d912ad/work/artifacts" 2026-08-27 03:11:08.544470 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/9793ff65ac334d94b101542057d912ad/work/docs" 2026-08-27 03:11:08.556136 | 2026-08-27 03:11:08.556296 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-27 03:11:09.676683 | debian-bookworm | changed: 2026-08-27 03:11:09.676997 | debian-bookworm | .d..t...... ./ 2026-08-27 03:11:09.677047 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-08-27 03:11:09.677082 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-08-27 03:11:09.677114 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-08-27 03:11:09.677144 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-08-27 03:11:09.677173 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-08-27 03:11:09.677231 | debian-bookworm | changed: All items complete 2026-08-27 03:11:09.677263 | 2026-08-27 03:11:10.300693 | debian-bookworm | changed: .d..t...... ./ 2026-08-27 03:11:11.140074 | debian-bookworm | changed: .d..t...... ./ 2026-08-27 03:11:11.167921 | 2026-08-27 03:11:11.168213 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-27 03:11:11.216878 | debian-bookworm | skipping: Conditional result was False 2026-08-27 03:11:11.226820 | debian-bookworm | skipping: Conditional result was False 2026-08-27 03:11:11.237667 | 2026-08-27 03:11:11.237776 | PLAY RECAP 2026-08-27 03:11:11.237831 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-08-27 03:11:11.237856 | 2026-08-27 03:11:11.597447 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-08-27 03:11:11.598370 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-27 03:11:12.855332 | 2026-08-27 03:11:12.855802 | PLAY [Base post] 2026-08-27 03:11:12.897863 | 2026-08-27 03:11:12.898196 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-27 03:11:13.846613 | debian-bookworm | changed 2026-08-27 03:11:13.863075 | 2026-08-27 03:11:13.863246 | PLAY RECAP 2026-08-27 03:11:13.863316 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-27 03:11:13.863378 | 2026-08-27 03:11:14.069508 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-08-27 03:11:14.070437 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-27 03:11:15.835436 | 2026-08-27 03:11:15.835675 | PLAY [Base post-logs] 2026-08-27 03:11:15.874427 | 2026-08-27 03:11:15.874653 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-27 03:11:16.841082 | localhost | changed 2026-08-27 03:11:16.864648 | 2026-08-27 03:11:16.864809 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-27 03:11:16.954689 | localhost | ok 2026-08-27 03:11:16.957979 | 2026-08-27 03:11:16.958066 | TASK [Set zuul-log-path fact] 2026-08-27 03:11:16.972549 | localhost | ok 2026-08-27 03:11:16.980698 | 2026-08-27 03:11:16.980797 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-27 03:11:17.029119 | localhost | ok 2026-08-27 03:11:17.032357 | 2026-08-27 03:11:17.032451 | TASK [upload-logs : Create log directories] 2026-08-27 03:11:17.922906 | localhost | changed 2026-08-27 03:11:17.926541 | 2026-08-27 03:11:17.926790 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-27 03:11:18.419879 | localhost -> localhost | ok: Runtime: 0:00:00.009416 2026-08-27 03:11:18.424528 | 2026-08-27 03:11:18.424641 | TASK [upload-logs : Upload logs to log server] 2026-08-27 03:11:18.992855 | localhost | Output suppressed because no_log was given 2026-08-27 03:11:18.994320 | 2026-08-27 03:11:18.994398 | LOOP [upload-logs : Compress console log and json output] 2026-08-27 03:11:19.052138 | localhost | skipping: Conditional result was False 2026-08-27 03:11:19.063969 | localhost | skipping: Conditional result was False 2026-08-27 03:11:19.070059 | 2026-08-27 03:11:19.070149 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-27 03:11:19.112298 | localhost | skipping: Conditional result was False 2026-08-27 03:11:19.112520 | 2026-08-27 03:11:19.117429 | localhost | skipping: Conditional result was False 2026-08-27 03:11:19.125197 | 2026-08-27 03:11:19.125273 | LOOP [upload-logs : Upload console log and json output]