2026-09-13 03:02:15.392789 | Job console starting 2026-09-13 03:02:15.403825 | Updating git repos 2026-09-13 03:02:15.434722 | Cloning repos into workspace 2026-09-13 03:02:15.504161 | Restoring repo states 2026-09-13 03:02:15.518246 | Merging changes 2026-09-13 03:02:15.518259 | Checking out repos 2026-09-13 03:02:15.571980 | Preparing playbooks 2026-09-13 03:02:16.502295 | Running Ansible setup 2026-09-13 03:02:21.454692 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-09-13 03:02:22.198177 | 2026-09-13 03:02:22.198302 | PLAY [Base pre] 2026-09-13 03:02:22.235467 | 2026-09-13 03:02:22.235583 | TASK [Setup log path fact] 2026-09-13 03:02:22.263279 | debian-bookworm | ok 2026-09-13 03:02:22.280320 | 2026-09-13 03:02:22.280452 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-13 03:02:22.308129 | debian-bookworm | ok 2026-09-13 03:02:22.317595 | 2026-09-13 03:02:22.317690 | TASK [emit-job-header : Print job information] 2026-09-13 03:02:22.365758 | # Job Information 2026-09-13 03:02:22.365936 | Ansible Version: 2.16.14 2026-09-13 03:02:22.365974 | Job: python-black 2026-09-13 03:02:22.366007 | Pipeline: periodic-daily 2026-09-13 03:02:22.366030 | Executor: 521e9411259a 2026-09-13 03:02:22.366051 | Triggered by: https://github.com/osism/openstack-simple-stress 2026-09-13 03:02:22.366073 | Event ID: 45615204fb4e46b2be1f9e74644b3a92 2026-09-13 03:02:22.370953 | 2026-09-13 03:02:22.371045 | LOOP [emit-job-header : Print node information] 2026-09-13 03:02:22.516776 | debian-bookworm | ok: 2026-09-13 03:02:22.516988 | debian-bookworm | # Node Information 2026-09-13 03:02:22.517024 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-09-13 03:02:22.517049 | debian-bookworm | Hostname: debian 2026-09-13 03:02:22.517071 | debian-bookworm | Username: zuul 2026-09-13 03:02:22.517093 | debian-bookworm | Distro: Debian 12.15 2026-09-13 03:02:22.517120 | debian-bookworm | Provider: regiocloud-a 2026-09-13 03:02:22.517142 | debian-bookworm | Region: 2026-09-13 03:02:22.517163 | debian-bookworm | Label: debian-bookworm 2026-09-13 03:02:22.517183 | debian-bookworm | Product Name: OpenStack Nova 2026-09-13 03:02:22.517203 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fed3:453d 2026-09-13 03:02:22.533125 | 2026-09-13 03:02:22.533234 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-13 03:02:23.082630 | debian-bookworm -> localhost | changed 2026-09-13 03:02:23.089412 | 2026-09-13 03:02:23.089509 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-13 03:02:24.037404 | debian-bookworm -> localhost | changed 2026-09-13 03:02:24.045954 | 2026-09-13 03:02:24.046038 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-13 03:02:24.251026 | debian-bookworm -> localhost | ok 2026-09-13 03:02:24.256052 | 2026-09-13 03:02:24.256136 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-13 03:02:24.274945 | debian-bookworm | ok 2026-09-13 03:02:24.289516 | debian-bookworm | included: /var/lib/zuul/builds/5b45d53693ed433e9e16bfca317d160a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-13 03:02:24.295366 | 2026-09-13 03:02:24.295449 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-13 03:02:28.110168 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-09-13 03:02:28.111071 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/5b45d53693ed433e9e16bfca317d160a/work/5b45d53693ed433e9e16bfca317d160a_id_rsa 2026-09-13 03:02:28.111147 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/5b45d53693ed433e9e16bfca317d160a/work/5b45d53693ed433e9e16bfca317d160a_id_rsa.pub 2026-09-13 03:02:28.111184 | debian-bookworm -> localhost | The key fingerprint is: 2026-09-13 03:02:28.111216 | debian-bookworm -> localhost | SHA256:wb9xCrzP966sQUBJD3MLff8izy5flEzgvhepclAnRr4 zuul-build-sshkey 2026-09-13 03:02:28.111368 | debian-bookworm -> localhost | The key's randomart image is: 2026-09-13 03:02:28.111450 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-09-13 03:02:28.111483 | debian-bookworm -> localhost | | .*o. o | 2026-09-13 03:02:28.111515 | debian-bookworm -> localhost | | o.*..= . | 2026-09-13 03:02:28.111542 | debian-bookworm -> localhost | | + o. B o | 2026-09-13 03:02:28.111568 | debian-bookworm -> localhost | | . + + B o| 2026-09-13 03:02:28.111597 | debian-bookworm -> localhost | | S +..E *.| 2026-09-13 03:02:28.111627 | debian-bookworm -> localhost | | + =o +.o| 2026-09-13 03:02:28.111654 | debian-bookworm -> localhost | | . +. B o.| 2026-09-13 03:02:28.111680 | debian-bookworm -> localhost | | o o= +. | 2026-09-13 03:02:28.111708 | debian-bookworm -> localhost | | +ooB= | 2026-09-13 03:02:28.112354 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-09-13 03:02:28.112904 | debian-bookworm -> localhost | ok: Runtime: 0:00:03.259938 2026-09-13 03:02:28.132429 | 2026-09-13 03:02:28.132533 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-13 03:02:28.202654 | debian-bookworm | ok 2026-09-13 03:02:28.225196 | debian-bookworm | included: /var/lib/zuul/builds/5b45d53693ed433e9e16bfca317d160a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-13 03:02:28.238870 | 2026-09-13 03:02:28.238980 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-13 03:02:28.267927 | debian-bookworm | skipping: Conditional result was False 2026-09-13 03:02:28.273868 | 2026-09-13 03:02:28.273976 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-13 03:02:29.066702 | debian-bookworm | changed 2026-09-13 03:02:29.078648 | 2026-09-13 03:02:29.078759 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-13 03:02:29.341985 | debian-bookworm | ok 2026-09-13 03:02:29.350013 | 2026-09-13 03:02:29.353086 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-13 03:02:30.026436 | debian-bookworm | changed 2026-09-13 03:02:30.030712 | 2026-09-13 03:02:30.030789 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-13 03:02:30.729673 | debian-bookworm | changed 2026-09-13 03:02:30.734169 | 2026-09-13 03:02:30.734243 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-13 03:02:30.768833 | debian-bookworm | skipping: Conditional result was False 2026-09-13 03:02:30.773629 | 2026-09-13 03:02:30.773711 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-13 03:02:31.352721 | debian-bookworm -> localhost | changed 2026-09-13 03:02:31.361261 | 2026-09-13 03:02:31.361338 | TASK [add-build-sshkey : Add back temp key] 2026-09-13 03:02:31.837869 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/5b45d53693ed433e9e16bfca317d160a/work/5b45d53693ed433e9e16bfca317d160a_id_rsa (zuul-build-sshkey) 2026-09-13 03:02:31.838059 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.025673 2026-09-13 03:02:31.844032 | 2026-09-13 03:02:31.844117 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-13 03:02:32.275952 | debian-bookworm | ok 2026-09-13 03:02:32.281001 | 2026-09-13 03:02:32.281079 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-13 03:02:32.303985 | debian-bookworm | skipping: Conditional result was False 2026-09-13 03:02:32.316786 | 2026-09-13 03:02:32.316895 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-09-13 03:02:32.811523 | debian-bookworm | ok 2026-09-13 03:02:32.825898 | 2026-09-13 03:02:32.825987 | TASK [validate-host : Define zuul_info_dir fact] 2026-09-13 03:02:32.862995 | debian-bookworm | ok 2026-09-13 03:02:32.867064 | 2026-09-13 03:02:32.867134 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-09-13 03:02:33.655119 | debian-bookworm -> localhost | ok 2026-09-13 03:02:33.660164 | 2026-09-13 03:02:33.660242 | TASK [validate-host : Collect information about the host] 2026-09-13 03:02:35.067263 | debian-bookworm | ok 2026-09-13 03:02:35.090121 | 2026-09-13 03:02:35.090222 | TASK [validate-host : Sanitize hostname] 2026-09-13 03:02:35.483345 | debian-bookworm | ok 2026-09-13 03:02:35.507232 | 2026-09-13 03:02:35.509844 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-09-13 03:02:36.740641 | debian-bookworm -> localhost | changed 2026-09-13 03:02:36.745982 | 2026-09-13 03:02:36.746070 | TASK [validate-host : Collect information about zuul worker] 2026-09-13 03:02:37.212890 | debian-bookworm | ok 2026-09-13 03:02:37.216763 | 2026-09-13 03:02:37.216851 | TASK [validate-host : Write out all zuul information for each host] 2026-09-13 03:02:38.180304 | debian-bookworm -> localhost | changed 2026-09-13 03:02:38.188261 | 2026-09-13 03:02:38.188340 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-09-13 03:02:38.483763 | debian-bookworm | ok 2026-09-13 03:02:38.498647 | 2026-09-13 03:02:38.498733 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-09-13 03:02:39.627051 | debian-bookworm | changed: 2026-09-13 03:02:39.627208 | debian-bookworm | cd+++++++++ src/ 2026-09-13 03:02:39.627236 | debian-bookworm | cd+++++++++ src/github.com/ 2026-09-13 03:02:39.627256 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-09-13 03:02:39.627274 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-simple-stress/ 2026-09-13 03:02:39.627291 | debian-bookworm | localhost | ok: "/var/lib/zuul/builds/5b45d53693ed433e9e16bfca317d160a/work/logs" 2026-09-13 03:03:42.787625 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/5b45d53693ed433e9e16bfca317d160a/work/artifacts" 2026-09-13 03:03:43.037914 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/5b45d53693ed433e9e16bfca317d160a/work/docs" 2026-09-13 03:03:43.051394 | 2026-09-13 03:03:43.051488 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-13 03:03:43.771743 | debian-bookworm | changed: 2026-09-13 03:03:43.772147 | debian-bookworm | .d..t...... ./ 2026-09-13 03:03:43.772211 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-09-13 03:03:43.772255 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-09-13 03:03:43.772294 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-09-13 03:03:43.772331 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-09-13 03:03:43.772368 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-09-13 03:03:43.772428 | debian-bookworm | changed: All items complete 2026-09-13 03:03:43.772466 | 2026-09-13 03:03:44.333968 | debian-bookworm | changed: .d..t...... ./ 2026-09-13 03:03:44.944841 | debian-bookworm | changed: .d..t...... ./ 2026-09-13 03:03:44.967703 | 2026-09-13 03:03:44.967846 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-13 03:03:45.003574 | debian-bookworm | skipping: Conditional result was False 2026-09-13 03:03:45.010342 | debian-bookworm | skipping: Conditional result was False 2026-09-13 03:03:45.021287 | 2026-09-13 03:03:45.021372 | PLAY RECAP 2026-09-13 03:03:45.021423 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-09-13 03:03:45.021448 | 2026-09-13 03:03:45.161750 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-09-13 03:03:45.162612 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-13 03:03:45.888764 | 2026-09-13 03:03:45.888938 | PLAY [Base post] 2026-09-13 03:03:45.902296 | 2026-09-13 03:03:45.902423 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-13 03:03:46.490619 | debian-bookworm | changed 2026-09-13 03:03:46.520891 | 2026-09-13 03:03:46.521045 | PLAY RECAP 2026-09-13 03:03:46.521114 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-13 03:03:46.521189 | 2026-09-13 03:03:46.654978 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-09-13 03:03:46.655868 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-13 03:03:47.448533 | 2026-09-13 03:03:47.448690 | PLAY [Base post-logs] 2026-09-13 03:03:47.459121 | 2026-09-13 03:03:47.459247 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-13 03:03:48.029491 | localhost | changed 2026-09-13 03:03:48.060139 | 2026-09-13 03:03:48.060308 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-13 03:03:48.087520 | localhost | ok 2026-09-13 03:03:48.091330 | 2026-09-13 03:03:48.091435 | TASK [Set zuul-log-path fact] 2026-09-13 03:03:48.128411 | localhost | ok 2026-09-13 03:03:48.142869 | 2026-09-13 03:03:48.143001 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-13 03:03:48.183536 | localhost | ok 2026-09-13 03:03:48.187158 | 2026-09-13 03:03:48.187263 | TASK [upload-logs : Create log directories] 2026-09-13 03:03:49.099299 | localhost | changed 2026-09-13 03:03:49.102841 | 2026-09-13 03:03:49.102957 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-13 03:03:49.741634 | localhost -> localhost | ok: Runtime: 0:00:00.016099 2026-09-13 03:03:49.746117 | 2026-09-13 03:03:49.746236 | TASK [upload-logs : Upload logs to log server] 2026-09-13 03:03:50.572411 | localhost | Output suppressed because no_log was given 2026-09-13 03:03:50.574072 | 2026-09-13 03:03:50.574161 | LOOP [upload-logs : Compress console log and json output] 2026-09-13 03:03:50.619120 | localhost | skipping: Conditional result was False 2026-09-13 03:03:50.626208 | localhost | skipping: Conditional result was False 2026-09-13 03:03:50.630247 | 2026-09-13 03:03:50.630341 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-13 03:03:50.667643 | localhost | skipping: Conditional result was False 2026-09-13 03:03:50.667863 | 2026-09-13 03:03:50.673833 | localhost | skipping: Conditional result was False 2026-09-13 03:03:50.686336 | 2026-09-13 03:03:50.686424 | LOOP [upload-logs : Upload console log and json output]