2026-06-02 03:14:32.003452 | Job console starting 2026-06-02 03:14:32.025408 | Updating git repos 2026-06-02 03:14:32.068620 | Cloning repos into workspace 2026-06-02 03:14:32.123109 | Restoring repo states 2026-06-02 03:14:32.138345 | Merging changes 2026-06-02 03:14:32.138367 | Checking out repos 2026-06-02 03:14:32.171604 | Preparing playbooks 2026-06-02 03:14:33.073729 | Running Ansible setup 2026-06-02 03:14:39.222786 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-06-02 03:14:39.952874 | 2026-06-02 03:14:39.953004 | PLAY [Base pre] 2026-06-02 03:14:39.969075 | 2026-06-02 03:14:39.969209 | TASK [Setup log path fact] 2026-06-02 03:14:39.987208 | debian-bookworm | ok 2026-06-02 03:14:40.016541 | 2026-06-02 03:14:40.016705 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-02 03:14:40.059191 | debian-bookworm | ok 2026-06-02 03:14:40.071814 | 2026-06-02 03:14:40.071944 | TASK [emit-job-header : Print job information] 2026-06-02 03:14:40.111666 | # Job Information 2026-06-02 03:14:40.111853 | Ansible Version: 2.16.14 2026-06-02 03:14:40.111886 | Job: python-black 2026-06-02 03:14:40.111919 | Pipeline: periodic-daily 2026-06-02 03:14:40.111942 | Executor: 521e9411259a 2026-06-02 03:14:40.111962 | Triggered by: https://github.com/osism/openstack-simple-stress 2026-06-02 03:14:40.111985 | Event ID: cb0cb0d2e0f24b3680005c6634b31c98 2026-06-02 03:14:40.117069 | 2026-06-02 03:14:40.117190 | LOOP [emit-job-header : Print node information] 2026-06-02 03:14:40.240376 | debian-bookworm | ok: 2026-06-02 03:14:40.240545 | debian-bookworm | # Node Information 2026-06-02 03:14:40.240579 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-06-02 03:14:40.240605 | debian-bookworm | Hostname: debian 2026-06-02 03:14:40.240627 | debian-bookworm | Username: zuul 2026-06-02 03:14:40.240648 | debian-bookworm | Distro: Debian 12.14 2026-06-02 03:14:40.240673 | debian-bookworm | Provider: regiocloud-a 2026-06-02 03:14:40.240694 | debian-bookworm | Region: 2026-06-02 03:14:40.240715 | debian-bookworm | Label: debian-bookworm 2026-06-02 03:14:40.240735 | debian-bookworm | Product Name: OpenStack Nova 2026-06-02 03:14:40.240755 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe66:45d3 2026-06-02 03:14:40.253857 | 2026-06-02 03:14:40.253962 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-02 03:14:40.750270 | debian-bookworm -> localhost | changed 2026-06-02 03:14:40.757123 | 2026-06-02 03:14:40.757257 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-02 03:14:41.935812 | debian-bookworm -> localhost | changed 2026-06-02 03:14:41.951280 | 2026-06-02 03:14:41.951429 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-02 03:14:42.313309 | debian-bookworm -> localhost | ok 2026-06-02 03:14:42.319595 | 2026-06-02 03:14:42.319708 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-02 03:14:42.339879 | debian-bookworm | ok 2026-06-02 03:14:42.356881 | debian-bookworm | included: /var/lib/zuul/builds/d922bd53e9864270b7c51847f7c589ef/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-02 03:14:42.363177 | 2026-06-02 03:14:42.363275 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-02 03:14:45.874299 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-06-02 03:14:45.874488 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/d922bd53e9864270b7c51847f7c589ef/work/d922bd53e9864270b7c51847f7c589ef_id_rsa 2026-06-02 03:14:45.874527 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/d922bd53e9864270b7c51847f7c589ef/work/d922bd53e9864270b7c51847f7c589ef_id_rsa.pub 2026-06-02 03:14:45.874556 | debian-bookworm -> localhost | The key fingerprint is: 2026-06-02 03:14:45.874582 | debian-bookworm -> localhost | SHA256:fgpn0aobmiV48qr7UDW/Bf2a9n3r8etegG7shY9SV44 zuul-build-sshkey 2026-06-02 03:14:45.874605 | debian-bookworm -> localhost | The key's randomart image is: 2026-06-02 03:14:45.874637 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-06-02 03:14:45.874660 | debian-bookworm -> localhost | | | 2026-06-02 03:14:45.874683 | debian-bookworm -> localhost | | . | 2026-06-02 03:14:45.874703 | debian-bookworm -> localhost | | o . . | 2026-06-02 03:14:45.874724 | debian-bookworm -> localhost | | . o . o . .| 2026-06-02 03:14:45.874744 | debian-bookworm -> localhost | | . . S o . .+ | 2026-06-02 03:14:45.874784 | debian-bookworm -> localhost | | . . + = o..E..| 2026-06-02 03:14:45.874807 | debian-bookworm -> localhost | |. o o = O ..=.o .| 2026-06-02 03:14:45.874828 | debian-bookworm -> localhost | | . + = B +.+ +.o.| 2026-06-02 03:14:45.874865 | debian-bookworm -> localhost | |o+o.+ o.. ..+o*=o| 2026-06-02 03:14:45.874886 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-06-02 03:14:45.874952 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.720657 2026-06-02 03:14:45.883426 | 2026-06-02 03:14:45.883528 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-02 03:14:45.911358 | debian-bookworm | ok 2026-06-02 03:14:45.931187 | debian-bookworm | included: /var/lib/zuul/builds/d922bd53e9864270b7c51847f7c589ef/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-02 03:14:45.950813 | 2026-06-02 03:14:45.950984 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-02 03:14:45.974167 | debian-bookworm | skipping: Conditional result was False 2026-06-02 03:14:45.980439 | 2026-06-02 03:14:45.980536 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-02 03:14:46.657722 | debian-bookworm | changed 2026-06-02 03:14:46.669028 | 2026-06-02 03:14:46.669166 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-02 03:14:46.964483 | debian-bookworm | ok 2026-06-02 03:14:46.978021 | 2026-06-02 03:14:46.978164 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-02 03:14:47.702855 | debian-bookworm | changed 2026-06-02 03:14:47.710045 | 2026-06-02 03:14:47.710140 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-02 03:14:48.407007 | debian-bookworm | changed 2026-06-02 03:14:48.425579 | 2026-06-02 03:14:48.425684 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-02 03:14:48.460618 | debian-bookworm | skipping: Conditional result was False 2026-06-02 03:14:48.478052 | 2026-06-02 03:14:48.478235 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-02 03:14:48.980229 | debian-bookworm -> localhost | changed 2026-06-02 03:14:48.990607 | 2026-06-02 03:14:48.990700 | TASK [add-build-sshkey : Add back temp key] 2026-06-02 03:14:49.514567 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/d922bd53e9864270b7c51847f7c589ef/work/d922bd53e9864270b7c51847f7c589ef_id_rsa (zuul-build-sshkey) 2026-06-02 03:14:49.514789 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.021799 2026-06-02 03:14:49.522589 | 2026-06-02 03:14:49.522677 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-02 03:14:49.905246 | debian-bookworm | ok 2026-06-02 03:14:49.911583 | 2026-06-02 03:14:49.911668 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-02 03:14:49.934717 | debian-bookworm | skipping: Conditional result was False 2026-06-02 03:14:49.945241 | 2026-06-02 03:14:49.945349 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-06-02 03:14:50.382267 | debian-bookworm | ok 2026-06-02 03:14:50.393908 | 2026-06-02 03:14:50.394018 | TASK [validate-host : Define zuul_info_dir fact] 2026-06-02 03:14:50.461069 | debian-bookworm | ok 2026-06-02 03:14:50.468296 | 2026-06-02 03:14:50.469582 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-06-02 03:14:50.788747 | debian-bookworm -> localhost | ok 2026-06-02 03:14:50.795211 | 2026-06-02 03:14:50.795319 | TASK [validate-host : Collect information about the host] 2026-06-02 03:14:51.966569 | debian-bookworm | ok 2026-06-02 03:14:51.989152 | 2026-06-02 03:14:51.989331 | TASK [validate-host : Sanitize hostname] 2026-06-02 03:14:52.113683 | debian-bookworm | ok 2026-06-02 03:14:52.156087 | 2026-06-02 03:14:52.156242 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-06-02 03:14:52.743302 | debian-bookworm -> localhost | changed 2026-06-02 03:14:52.758809 | 2026-06-02 03:14:52.759016 | TASK [validate-host : Collect information about zuul worker] 2026-06-02 03:14:53.225552 | debian-bookworm | ok 2026-06-02 03:14:53.237840 | 2026-06-02 03:14:53.237987 | TASK [validate-host : Write out all zuul information for each host] 2026-06-02 03:14:53.803817 | debian-bookworm -> localhost | changed 2026-06-02 03:14:53.820636 | 2026-06-02 03:14:53.820771 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-06-02 03:14:54.118770 | debian-bookworm | ok 2026-06-02 03:14:54.124843 | 2026-06-02 03:14:54.124974 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-06-02 03:14:54.961263 | debian-bookworm | changed: 2026-06-02 03:14:54.961472 | debian-bookworm | cd+++++++++ src/ 2026-06-02 03:14:54.961508 | debian-bookworm | cd+++++++++ src/github.com/ 2026-06-02 03:14:54.961533 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-06-02 03:14:54.961555 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-simple-stress/ 2026-06-02 03:14:54.961576 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/d922bd53e9864270b7c51847f7c589ef/work/logs" 2026-06-02 03:15:25.306356 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/d922bd53e9864270b7c51847f7c589ef/work/artifacts" 2026-06-02 03:15:25.726660 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/d922bd53e9864270b7c51847f7c589ef/work/docs" 2026-06-02 03:15:25.806520 | 2026-06-02 03:15:25.806788 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-02 03:15:27.574789 | debian-bookworm | changed: 2026-06-02 03:15:27.575227 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-06-02 03:15:27.575266 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-06-02 03:15:27.575296 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-06-02 03:15:27.575340 | debian-bookworm | changed: All items complete 2026-06-02 03:15:27.575367 | 2026-06-02 03:15:28.300317 | debian-bookworm | changed: .d..t...... ./ 2026-06-02 03:15:29.025915 | debian-bookworm | changed: .d..t...... ./ 2026-06-02 03:15:29.042672 | 2026-06-02 03:15:29.042787 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-02 03:15:29.090376 | debian-bookworm | skipping: Conditional result was False 2026-06-02 03:15:29.100658 | debian-bookworm | skipping: Conditional result was False 2026-06-02 03:15:29.118715 | 2026-06-02 03:15:29.118808 | PLAY RECAP 2026-06-02 03:15:29.118874 | debian-bookworm | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-06-02 03:15:29.118900 | 2026-06-02 03:15:29.297796 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-06-02 03:15:29.298573 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-02 03:15:30.347506 | 2026-06-02 03:15:30.347638 | PLAY [Base post] 2026-06-02 03:15:30.359945 | 2026-06-02 03:15:30.360407 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-02 03:15:30.886542 | debian-bookworm | changed 2026-06-02 03:15:30.896987 | 2026-06-02 03:15:30.897272 | PLAY RECAP 2026-06-02 03:15:30.897361 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-02 03:15:30.897442 | 2026-06-02 03:15:31.002363 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-02 03:15:31.003127 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-06-02 03:15:31.908952 | 2026-06-02 03:15:31.909098 | PLAY [Base post-logs] 2026-06-02 03:15:31.918801 | 2026-06-02 03:15:31.918933 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-02 03:15:32.417984 | localhost | changed 2026-06-02 03:15:32.430417 | 2026-06-02 03:15:32.430551 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-02 03:15:32.465274 | localhost | ok 2026-06-02 03:15:32.468372 | 2026-06-02 03:15:32.468469 | TASK [Set zuul-log-path fact] 2026-06-02 03:15:32.498058 | localhost | ok 2026-06-02 03:15:32.505627 | 2026-06-02 03:15:32.505734 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-02 03:15:32.540262 | localhost | ok 2026-06-02 03:15:32.543247 | 2026-06-02 03:15:32.543339 | TASK [upload-logs : Create log directories] 2026-06-02 03:15:33.104298 | localhost | changed 2026-06-02 03:15:33.106786 | 2026-06-02 03:15:33.106908 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-02 03:15:34.025242 | localhost -> localhost | ok: Runtime: 0:00:00.018344 2026-06-02 03:15:34.029423 | 2026-06-02 03:15:34.029549 | TASK [upload-logs : Upload logs to log server] 2026-06-02 03:15:35.026742 | localhost | Output suppressed because no_log was given 2026-06-02 03:15:35.028406 | 2026-06-02 03:15:35.028489 | LOOP [upload-logs : Compress console log and json output] 2026-06-02 03:15:35.072788 | localhost | skipping: Conditional result was False 2026-06-02 03:15:35.081320 | localhost | skipping: Conditional result was False 2026-06-02 03:15:35.094222 | 2026-06-02 03:15:35.094329 | LOOP [upload-logs : Upload compressed console log and json output] 2026-06-02 03:15:35.134625 | localhost | skipping: Conditional result was False 2026-06-02 03:15:35.134875 | 2026-06-02 03:15:35.138431 | localhost | skipping: Conditional result was False 2026-06-02 03:15:35.151033 | 2026-06-02 03:15:35.151139 | LOOP [upload-logs : Upload console log and json output]