2025-10-14T08:21:04.885: current working dir: /root/qa/mctester.
2025-10-14T08:21:04.930: current logging dir: ../mctester/www.
2025-10-14T08:21:04.930: ---------------------------------------------------------------
2025-10-14T08:21:04.936: mctester entry: 2025-10-14T08:21:04.930783 mode=50
2025-10-14T08:21:04.936: ---------------------------------------------------------------
2025-10-14T08:21:05.007: EXE: 1/git describe --tags.
2025-10-14T08:21:05.017: Row 1: v1.1-493-g334079e.
2025-10-14T08:21:05.018: EXE: 1/git rev-list --count HEAD.
2025-10-14T08:21:05.027: Row 1: 550.
2025-10-14T08:21:05.028: EXE: 1/git rev-parse HEAD.
2025-10-14T08:21:05.029: Row 1: 334079e0023fd6b85febe0f6cd19139cfdea0dc1.
2025-10-14T08:21:05.038: mctester: v1.1.550 (334079e0023fd6b85febe0f6cd19139cfdea0dc1).
2025-10-14T08:21:05.039: Entering into a performance tests mode.
2025-10-14T08:21:05.040: ------ test: start, 2025-10-14T08:21:05.039
2025-10-14T08:21:05.042: ------ test: 2000
2025-10-14T08:21:05.043: CMD: ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "top -b -n 1"
2025-10-14T08:21:05.043: EXE: 1/ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "top -b -n 1".
2025-10-14T08:21:05.275: Row 1: top - 08:21:05 up 134 days, 22:08, 0 users, load average: 0.45, 0.12, 0.10.
2025-10-14T08:21:05.275: Row 2: Tasks: 530 total, 1 running, 529 sleeping, 0 stopped, 0 zombie.
2025-10-14T08:21:05.276: Row 3: %Cpu(s): 1.5 us, 0.2 sy, 0.0 ni, 98.4 id, 0.0 wa, 0.0 hi, 0.0 si, 0.0 st.
2025-10-14T08:21:05.276: Row 4: KiB Mem : 13202036+total, 737224 free, 66592524 used, 64690624 buff/cache.
2025-10-14T08:21:05.276: Row 5: KiB Swap: 0 total, 0 free, 0 used. 64429968 avail Mem .
2025-10-14T08:21:05.276: Row 6: .
2025-10-14T08:21:05.277: Row 7: PID USER PR NI VIRT RES SHR S %CPU %MEM TIME+ COMMAND.
2025-10-14T08:21:05.277: Row 8: 89817 root 20 0 22.431g 0.011t 38148 S 100.0 8.6 19950:33 java.
2025-10-14T08:21:05.277: Row 9: 25220 root 20 0 44056 4060 3152 R 6.2 0.0 0:00.01 top.
2025-10-14T08:21:05.277: Row 10: 1 root 20 0 43692 4152 2780 S 0.0 0.0 7:01.77 init.
2025-10-14T08:21:05.277: Row 11: 2 root 20 0 0 0 0 S 0.0 0.0 0:00.92 kthreadd.
2025-10-14T08:21:05.278: Row 12: 3 root 20 0 0 0 0 S 0.0 0.0 0:47.14 ksoftirqd+.
2025-10-14T08:21:05.278: Row 13: 4 root 20 0 0 0 0 S 0.0 0.0 0:00.00 kworker/0+.
2025-10-14T08:21:05.278: Row 14: 5 root 0 -20 0 0 0 S 0.0 0.0 0:00.00 kworker/0+.
2025-10-14T08:21:05.278: Row 15: 7 root 20 0 0 0 0 S 0.0 0.0 57:52.58 rcu_sched.
2025-10-14T08:21:05.279: Row 16: 8 root 20 0 0 0 0 S 0.0 0.0 0:00.00 rcu_bh.
2025-10-14T08:21:05.279: Row 17: 9 root rt 0 0 0 0 S 0.0 0.0 0:02.64 migration+.
2025-10-14T08:21:05.279: Row 18: 10 root rt 0 0 0 0 S 0.0 0.0 0:32.70 watchdog/0.
2025-10-14T08:21:05.280: Row 19: 11 root rt 0 0 0 0 S 0.0 0.0 0:31.76 watchdog/1.
2025-10-14T08:21:05.280: Row 20: 12 root rt 0 0 0 0 S 0.0 0.0 0:10.98 migration+.
2025-10-14T08:21:05.280: Row 21: 13 root 20 0 0 0 0 S 0.0 0.0 0:02.37 ksoftirqd+.
2025-10-14T08:21:05.280: Row 22: 14 root 20 0 0 0 0 S 0.0 0.0 0:00.00 kworker/1+.
2025-10-14T08:21:05.280: Row 23: 15 root 0 -20 0 0 0 S 0.0 0.0 0:00.00 kworker/1+.
2025-10-14T08:21:05.281: Row 24: 16 root rt 0 0 0 0 S 0.0 0.0 0:31.99 watchdog/2.
2025-10-14T08:21:05.349: SUC: 300ms Uptime 134 days, 1min 0.45, 5min 0.12, 15min 0.10, mem:132020360 total / 737224 free / 66592524 used / 64690624 cache / 64429968 avail
2025-10-14T08:21:05.359: ------ test: 2001
2025-10-14T08:21:05.359: CMD: top -b -E k -n 1
2025-10-14T08:21:05.359: EXE: 1/top -b -E k -n 1.
2025-10-14T08:21:05.517: Row 1: top - 08:21:05 up 49 days, 22:34, 0 users, load average: 3.69, 3.91, 3.97.
2025-10-14T08:21:05.518: Row 2: Tasks: 168 total, 1 running, 165 sleeping, 1 stopped, 1 zombie.
2025-10-14T08:21:05.518: Row 3: %Cpu(s): 10.5 us, 0.0 sy, 0.0 ni, 89.5 id, 0.0 wa, 0.0 hi, 0.0 si, 0.0 st.
2025-10-14T08:21:05.518: Row 4: KiB Mem : 16480104 total, 5322524 free, 1223068 used, 9934512 buff/cache.
2025-10-14T08:21:05.518: Row 5: KiB Swap: 0 total, 0 free, 0 used. 14819000 avail Mem .
2025-10-14T08:21:05.519: Row 6: .
2025-10-14T08:21:05.519: Row 7: PID USER PR NI VIRT RES SHR S %CPU %MEM TIME+ COMMAND.
2025-10-14T08:21:05.519: Row 8: 2617642 root 20 0 4910856 80104 27648 S 86.7 0.5 0:01.07 java.
2025-10-14T08:21:05.519: Row 9: 1 root 20 0 167780 13280 8396 S 0.0 0.1 1:22.95 systemd.
2025-10-14T08:21:05.519: Row 10: 2 root 20 0 0 0 0 S 0.0 0.0 0:00.50 kthreadd.
2025-10-14T08:21:05.520: Row 11: 3 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 rcu_gp.
2025-10-14T08:21:05.520: Row 12: 4 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 rcu_par+.
2025-10-14T08:21:05.520: Row 13: 5 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 slub_fl+.
2025-10-14T08:21:05.520: Row 14: 6 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 netns.
2025-10-14T08:21:05.520: Row 15: 8 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 kworker+.
2025-10-14T08:21:05.520: Row 16: 10 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 mm_perc+.
2025-10-14T08:21:05.521: Row 17: 11 root 20 0 0 0 0 S 0.0 0.0 0:00.00 rcu_tas+.
2025-10-14T08:21:05.521: Row 18: 12 root 20 0 0 0 0 S 0.0 0.0 0:00.00 rcu_tas+.
2025-10-14T08:21:05.521: Row 19: 13 root 20 0 0 0 0 S 0.0 0.0 0:00.83 ksoftir+.
2025-10-14T08:21:05.521: Row 20: 14 root 20 0 0 0 0 I 0.0 0.0 2:11.25 rcu_sch+.
2025-10-14T08:21:05.521: Row 21: 15 root rt 0 0 0 0 S 0.0 0.0 0:09.64 migrati+.
2025-10-14T08:21:05.522: Row 22: 16 root -51 0 0 0 0 S 0.0 0.0 0:00.00 idle_in+.
2025-10-14T08:21:05.522: Row 23: 18 root 20 0 0 0 0 S 0.0 0.0 0:00.00 cpuhp/0.
2025-10-14T08:21:05.522: Row 24: 19 root 20 0 0 0 0 S 0.0 0.0 0:00.00 cpuhp/1.
2025-10-14T08:21:05.538: SUC: 179ms Uptime 49 days, 1min 3.69, 5min 3.91, 15min 3.97, mem:16480104 total / 5322524 free / 1223068 used / 9934512 cache / 14819000 avail
2025-10-14T08:21:05.539: ------ test: 2002
2025-10-14T08:21:05.539: CMD: df -h
2025-10-14T08:21:05.539: EXE: 1/df -h.
2025-10-14T08:21:05.541: Row 1: Filesystem Size Used Avail Use% Mounted on.
2025-10-14T08:21:05.542: Row 2: tmpfs 791M 82M 710M 11% /run.
2025-10-14T08:21:05.542: Row 3: /dev/vda2 30G 24G 4.4G 85% /.
2025-10-14T08:21:05.542: Row 4: tmpfs 3.9G 0 3.9G 0% /dev/shm.
2025-10-14T08:21:05.542: Row 5: tmpfs 5.0M 0 5.0M 0% /run/lock.
2025-10-14T08:21:05.544: SUC: 5ms Diskfree qa.headai.com: tmpfs:11%, /dev/vda2:85%, tmpfs:0%, tmpfs:0%.
2025-10-14T08:21:05.544: ------ test: 2003
2025-10-14T08:21:05.545: CMD: ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "df -h"
2025-10-14T08:21:05.545: EXE: 1/ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "df -h".
2025-10-14T08:21:05.615: Row 1: Filesystem Size Used Avail Use% Mounted on.
2025-10-14T08:21:05.615: Row 2: udev 63G 4.0K 63G 1% /dev.
2025-10-14T08:21:05.615: Row 3: tmpfs 13G 5.5M 13G 1% /run.
2025-10-14T08:21:05.615: Row 4: /dev/vda1 757G 305G 421G 43% /.
2025-10-14T08:21:05.615: Row 5: none 4.0K 0 4.0K 0% /sys/fs/cgroup.
2025-10-14T08:21:05.616: Row 6: none 5.0M 0 5.0M 0% /run/lock.
2025-10-14T08:21:05.616: Row 7: none 63G 0 63G 0% /run/shm.
2025-10-14T08:21:05.616: Row 8: none 100M 0 100M 0% /run/user.
2025-10-14T08:21:05.616: Row 9: cgmfs 100K 0 100K 0% /run/cgmanager/fs.
2025-10-14T08:21:05.616: Row 10: /dev/vdb 985G 275G 660G 30% /opt/tomcat/webapps/ROOT/analysis.
2025-10-14T08:21:05.616: Row 11: tmpfs 100K 0 100K 0% /var/lib/lxd/shmounts.
2025-10-14T08:21:05.617: Row 12: tmpfs 100K 0 100K 0% /var/lib/lxd/devlxd.
2025-10-14T08:21:05.617: SUC: 72ms Diskfree megatron.headai.com: udev:1%, tmpfs:1%, /dev/vda1:43%, none:0%, none:0%, none:0%, none:0%, cgmfs:0%, /dev/vdb:30%, tmpfs:0%, tmpfs:0%.
2025-10-14T08:21:05.618: ------ test: 2004
2025-10-14T08:21:05.618: URL: https://headai.com
2025-10-14T08:21:06.031: SUC: 393ms, meets direction. Headai is a deep tech company enabling Decision Intelligence for future-focused organizations through automated analysis of unstructured text data. Unlock Hidden Insights Optimize Workforce Strategies Enable Decision Intelligence Improve Operational Efficiency Metis Training tool for creating machine-readable data Learn how to create high-quality, machine-readable data for better job recommendations and labor market […]" />, length 201734.
2025-10-14T08:21:06.032: ------ test: 2005
2025-10-14T08:21:06.257: SQL: show global status like 'threads_connected';.
2025-10-14T08:21:06.285: Results: value=3/200.
2025-10-14T08:21:06.290: SQL: value, lines: 1, ret=1, 3.
2025-10-14T08:21:06.291: SUC: 259ms 3
2025-10-14T08:21:06.292: ------ test: 2006
2025-10-14T08:21:06.373: SQL: SHOW PROCESSLIST;.
2025-10-14T08:21:06.378: Row 1: 54504568,root,localhost:54362,null,Query,0,starting,SHOW PROCESSLIST.
2025-10-14T08:21:06.378: SQL: COUNTNOTLINES:Command, lines: 1, ret=1, 1.
2025-10-14T08:21:06.378: SUC: 86ms 1
2025-10-14T08:21:06.379: checkJavaStack starting: 2007.
2025-10-14T08:21:06.470: ------ test: 2007
2025-10-14T08:21:06.470: EXE: 5/"jstack 89817 | awk '/nid=/ {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]} start_line = NR; last_h1_h2 = 0; has_h1_h2 = 0; in_block = 1} /h1|h2/ {has_h1_h2 = 1; last_h1_h2 = NR} {lines[NR] = $0} END {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]}}' || true".
2025-10-14T08:21:06.777: Row 1: "https-openssl-nio-443-exec-1147" #571360 daemon prio=5 os_prio=0 tid=0x00007f55f0200000 nid=0x3843 runnable [0x00007f56b8c83000].
2025-10-14T08:21:06.777: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-14T08:21:06.779: Row 3: at java.lang.String.split(String.java:2354).
2025-10-14T08:21:06.779: Row 4: at java.lang.String.split(String.java:2422).
2025-10-14T08:21:06.779: Row 5: at h2.core2021.networkMatchSuperFast(core2021.java:3159).
2025-10-14T08:21:06.780: Row 6: at h2.core2021.semanticSimilarity_v3(core2021.java:1422).
2025-10-14T08:21:06.780: Row 7: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-14T08:21:06.780: Row 8: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:799).
2025-10-14T08:21:06.780: Row 9: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-14T08:21:06.780: Row 10: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-14T08:21:06.780: Row 11: at h1.mc_api.doGet(mc_api.java:39).
2025-10-14T08:21:06.781: SUC: 2007, 311ms, lines: 11.
2025-10-14T08:21:06.783: checkJavaStack end: 2007, pid/ret=11.
2025-10-14T08:21:16.783: checkJavaStack starting: 2007.
2025-10-14T08:21:16.873: ------ test: 2007
2025-10-14T08:21:16.873: EXE: 5/"jstack 89817 | awk '/nid=/ {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]} start_line = NR; last_h1_h2 = 0; has_h1_h2 = 0; in_block = 1} /h1|h2/ {has_h1_h2 = 1; last_h1_h2 = NR} {lines[NR] = $0} END {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]}}' || true".
2025-10-14T08:21:17.087: Row 1: "https-openssl-nio-443-exec-1147" #571360 daemon prio=5 os_prio=0 tid=0x00007f55f0200000 nid=0x3843 runnable [0x00007f56b8c83000].
2025-10-14T08:21:17.087: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-14T08:21:17.087: Row 3: at h1.body.wordToBody(body.java:302).
2025-10-14T08:21:17.087: Row 4: at h2.core2021.semanticSimilarity_v3(core2021.java:1397).
2025-10-14T08:21:17.087: Row 5: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-14T08:21:17.088: Row 6: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:799).
2025-10-14T08:21:17.088: Row 7: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-14T08:21:17.088: Row 8: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-14T08:21:17.088: Row 9: at h1.mc_api.doGet(mc_api.java:39).
2025-10-14T08:21:17.090: SUC: 2007, 217ms, lines: 9.
2025-10-14T08:21:17.090: checkJavaStack end: 2007, pid/ret=9.
2025-10-14T08:21:27.091: checkJavaStack starting: 2007.
2025-10-14T08:21:27.176: ------ test: 2007
2025-10-14T08:21:27.176: EXE: 5/"jstack 89817 | awk '/nid=/ {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]} start_line = NR; last_h1_h2 = 0; has_h1_h2 = 0; in_block = 1} /h1|h2/ {has_h1_h2 = 1; last_h1_h2 = NR} {lines[NR] = $0} END {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]}}' || true".
2025-10-14T08:21:27.395: SUC: 2007, 219ms, lines: 4096.
2025-10-14T08:21:27.396: checkJavaStack end: 2007, pid/ret=4096.
2025-10-14T08:21:37.396: checkJavaStack starting: 2007.
2025-10-14T08:21:37.485: ------ test: 2007
2025-10-14T08:21:37.485: EXE: 5/"jstack 89817 | awk '/nid=/ {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]} start_line = NR; last_h1_h2 = 0; has_h1_h2 = 0; in_block = 1} /h1|h2/ {has_h1_h2 = 1; last_h1_h2 = NR} {lines[NR] = $0} END {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]}}' || true".
2025-10-14T08:21:37.755: Row 1: "https-openssl-nio-443-exec-1148" #571361 daemon prio=5 os_prio=0 tid=0x00007f5604047800 nid=0x3844 runnable [0x00007f56377f4000].
2025-10-14T08:21:37.755: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-14T08:21:37.755: Row 3: at h1.body.wordToBody(body.java:286).
2025-10-14T08:21:37.755: Row 4: at h2.core2021.semanticSimilarity_v3(core2021.java:1397).
2025-10-14T08:21:37.755: Row 5: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-14T08:21:37.755: Row 6: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:799).
2025-10-14T08:21:37.755: Row 7: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-14T08:21:37.755: Row 8: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-14T08:21:37.756: Row 9: at h1.mc_api.doGet(mc_api.java:39).
2025-10-14T08:21:37.757: SUC: 2007, 272ms, lines: 9.
2025-10-14T08:21:37.757: checkJavaStack end: 2007, pid/ret=9.
2025-10-14T08:21:47.758: checkJavaStack starting: 2007.
2025-10-14T08:21:47.844: ------ test: 2007
2025-10-14T08:21:47.844: EXE: 5/"jstack 89817 | awk '/nid=/ {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]} start_line = NR; last_h1_h2 = 0; has_h1_h2 = 0; in_block = 1} /h1|h2/ {has_h1_h2 = 1; last_h1_h2 = NR} {lines[NR] = $0} END {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]}}' || true".
2025-10-14T08:21:48.055: Row 1: "https-openssl-nio-443-exec-1148" #571361 daemon prio=5 os_prio=0 tid=0x00007f5604047800 nid=0x3844 runnable [0x00007f56377f4000].
2025-10-14T08:21:48.056: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-14T08:21:48.056: Row 3: at h1.body.wordToBody(body.java:286).
2025-10-14T08:21:48.056: Row 4: at h2.core2021.semanticSimilarity_v3(core2021.java:1397).
2025-10-14T08:21:48.056: Row 5: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-14T08:21:48.056: Row 6: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:799).
2025-10-14T08:21:48.056: Row 7: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-14T08:21:48.056: Row 8: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-14T08:21:48.056: Row 9: at h1.mc_api.doGet(mc_api.java:39).
2025-10-14T08:21:48.063: SUC: 2007, 219ms, lines: 9.
2025-10-14T08:21:48.063: checkJavaStack end: 2007, pid/ret=9.
2025-10-14T08:21:58.064: checkJavaStack starting: 2007.
2025-10-14T08:21:58.147: ------ test: 2007
2025-10-14T08:21:58.148: EXE: 5/"jstack 89817 | awk '/nid=/ {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]} start_line = NR; last_h1_h2 = 0; has_h1_h2 = 0; in_block = 1} /h1|h2/ {has_h1_h2 = 1; last_h1_h2 = NR} {lines[NR] = $0} END {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]}}' || true".
2025-10-14T08:21:58.367: Row 1: "https-openssl-nio-443-exec-1148" #571361 daemon prio=5 os_prio=0 tid=0x00007f5604047800 nid=0x3844 runnable [0x00007f56377f4000].
2025-10-14T08:21:58.367: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-14T08:21:58.368: Row 3: at java.lang.String.indexOf(String.java:1769).
2025-10-14T08:21:58.368: Row 4: at java.lang.String.indexOf(String.java:1718).
2025-10-14T08:21:58.368: Row 5: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5362).
2025-10-14T08:21:58.368: Row 6: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5318).
2025-10-14T08:21:58.368: Row 7: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5258).
2025-10-14T08:21:58.368: Row 8: at h2.core2021.semanticSimilarity_v3(core2021.java:1404).
2025-10-14T08:21:58.368: Row 9: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-14T08:21:58.368: Row 10: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:799).
2025-10-14T08:21:58.368: Row 11: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-14T08:21:58.369: Row 12: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-14T08:21:58.369: Row 13: at h1.mc_api.doGet(mc_api.java:39).
2025-10-14T08:21:58.370: SUC: 2007, 222ms, lines: 13.
2025-10-14T08:21:58.371: checkJavaStack end: 2007, pid/ret=13.
2025-10-14T08:22:08.371: checkJavaStack starting: 2007.
2025-10-14T08:22:08.457: ------ test: 2007
2025-10-14T08:22:08.458: EXE: 5/"jstack 89817 | awk '/nid=/ {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]} start_line = NR; last_h1_h2 = 0; has_h1_h2 = 0; in_block = 1} /h1|h2/ {has_h1_h2 = 1; last_h1_h2 = NR} {lines[NR] = $0} END {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]}}' || true".
2025-10-14T08:22:08.646: Row 1: "https-openssl-nio-443-exec-1148" #571361 daemon prio=5 os_prio=0 tid=0x00007f5604047800 nid=0x3844 runnable [0x00007f56377f4000].
2025-10-14T08:22:08.646: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-14T08:22:08.646: Row 3: at h1.body.wordToBody(body.java:296).
2025-10-14T08:22:08.647: Row 4: at h2.core2021.semanticSimilarity_v3(core2021.java:1397).
2025-10-14T08:22:08.647: Row 5: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-14T08:22:08.647: Row 6: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:799).
2025-10-14T08:22:08.647: Row 7: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-14T08:22:08.647: Row 8: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-14T08:22:08.647: Row 9: at h1.mc_api.doGet(mc_api.java:39).
2025-10-14T08:22:08.649: SUC: 2007, 191ms, lines: 9.
2025-10-14T08:22:08.650: checkJavaStack end: 2007, pid/ret=9.
2025-10-14T08:22:18.650: checkJavaStack starting: 2007.
2025-10-14T08:22:18.738: ------ test: 2007
2025-10-14T08:22:18.738: EXE: 5/"jstack 89817 | awk '/nid=/ {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]} start_line = NR; last_h1_h2 = 0; has_h1_h2 = 0; in_block = 1} /h1|h2/ {has_h1_h2 = 1; last_h1_h2 = NR} {lines[NR] = $0} END {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]}}' || true".
2025-10-14T08:22:18.981: Row 1: "https-openssl-nio-443-exec-1148" #571361 daemon prio=5 os_prio=0 tid=0x00007f5604047800 nid=0x3844 runnable [0x00007f56377f4000].
2025-10-14T08:22:18.981: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-14T08:22:18.981: Row 3: at java.lang.String.indexOf(String.java:1769).
2025-10-14T08:22:18.981: Row 4: at java.lang.String.indexOf(String.java:1718).
2025-10-14T08:22:18.981: Row 5: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5362).
2025-10-14T08:22:18.981: Row 6: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5318).
2025-10-14T08:22:18.981: Row 7: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5258).
2025-10-14T08:22:18.981: Row 8: at h2.core2021.semanticSimilarity_v3(core2021.java:1403).
2025-10-14T08:22:18.981: Row 9: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-14T08:22:18.982: Row 10: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:799).
2025-10-14T08:22:18.982: Row 11: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-14T08:22:18.982: Row 12: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-14T08:22:18.982: Row 13: at h1.mc_api.doGet(mc_api.java:39).
2025-10-14T08:22:18.997: SUC: 2007, 259ms, lines: 13.
2025-10-14T08:22:18.998: checkJavaStack end: 2007, pid/ret=13.
2025-10-14T08:22:28.999: checkJavaStack starting: 2007.
2025-10-14T08:22:29.103: ------ test: 2007
2025-10-14T08:22:29.103: EXE: 5/"jstack 89817 | awk '/nid=/ {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]} start_line = NR; last_h1_h2 = 0; has_h1_h2 = 0; in_block = 1} /h1|h2/ {has_h1_h2 = 1; last_h1_h2 = NR} {lines[NR] = $0} END {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]}}' || true".
2025-10-14T08:22:29.315: Row 1: "https-openssl-nio-443-exec-1148" #571361 daemon prio=5 os_prio=0 tid=0x00007f5604047800 nid=0x3844 runnable [0x00007f56377f4000].
2025-10-14T08:22:29.315: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-14T08:22:29.315: Row 3: at java.lang.String.split(String.java:2354).
2025-10-14T08:22:29.315: Row 4: at java.lang.String.split(String.java:2422).
2025-10-14T08:22:29.315: Row 5: at h2.core2021.networkMatchSuperFast(core2021.java:3164).
2025-10-14T08:22:29.315: Row 6: at h2.core2021.semanticSimilarity_v3(core2021.java:1422).
2025-10-14T08:22:29.316: Row 7: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-14T08:22:29.316: Row 8: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:799).
2025-10-14T08:22:29.316: Row 9: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-14T08:22:29.316: Row 10: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-14T08:22:29.316: Row 11: at h1.mc_api.doGet(mc_api.java:39).
2025-10-14T08:22:29.318: SUC: 2007, 215ms, lines: 11.
2025-10-14T08:22:29.319: checkJavaStack end: 2007, pid/ret=11.
2025-10-14T08:22:39.319: checkJavaStack starting: 2007.
2025-10-14T08:22:39.404: ------ test: 2007
2025-10-14T08:22:39.404: EXE: 5/"jstack 89817 | awk '/nid=/ {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]} start_line = NR; last_h1_h2 = 0; has_h1_h2 = 0; in_block = 1} /h1|h2/ {has_h1_h2 = 1; last_h1_h2 = NR} {lines[NR] = $0} END {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]}}' || true".
2025-10-14T08:22:39.587: Row 1: "https-openssl-nio-443-exec-1148" #571361 daemon prio=5 os_prio=0 tid=0x00007f5604047800 nid=0x3844 runnable [0x00007f56377f4000].
2025-10-14T08:22:39.587: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-14T08:22:39.588: Row 3: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5318).
2025-10-14T08:22:39.588: Row 4: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5258).
2025-10-14T08:22:39.588: Row 5: at h2.core2021.semanticSimilarity_v3(core2021.java:1420).
2025-10-14T08:22:39.588: Row 6: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-14T08:22:39.588: Row 7: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:799).
2025-10-14T08:22:39.588: Row 8: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-14T08:22:39.588: Row 9: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-14T08:22:39.588: Row 10: at h1.mc_api.doGet(mc_api.java:39).
2025-10-14T08:22:39.591: SUC: 2007, 186ms, lines: 10.
2025-10-14T08:22:39.591: checkJavaStack end: 2007, pid/ret=10.
2025-10-14T08:22:49.591: checkJavaStack starting: 2007.
2025-10-14T08:22:49.680: ------ test: 2007
2025-10-14T08:22:49.680: EXE: 5/"jstack 89817 | awk '/nid=/ {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]} start_line = NR; last_h1_h2 = 0; has_h1_h2 = 0; in_block = 1} /h1|h2/ {has_h1_h2 = 1; last_h1_h2 = NR} {lines[NR] = $0} END {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]}}' || true".
2025-10-14T08:22:49.888: Row 1: "https-openssl-nio-443-exec-1148" #571361 daemon prio=5 os_prio=0 tid=0x00007f5604047800 nid=0x3844 runnable [0x00007f56377f4000].
2025-10-14T08:22:49.888: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-14T08:22:49.889: Row 3: at java.lang.String.split(String.java:2354).
2025-10-14T08:22:49.889: Row 4: at java.lang.String.split(String.java:2422).
2025-10-14T08:22:49.889: Row 5: at h2.core2021.semanticSimilarity_v3(core2021.java:1269).
2025-10-14T08:22:49.889: Row 6: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-14T08:22:49.889: Row 7: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:799).
2025-10-14T08:22:49.889: Row 8: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-14T08:22:49.889: Row 9: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-14T08:22:49.889: Row 10: at h1.mc_api.doGet(mc_api.java:39).
2025-10-14T08:22:49.891: SUC: 2007, 211ms, lines: 10.
2025-10-14T08:22:49.892: checkJavaStack end: 2007, pid/ret=10.
2025-10-14T08:22:59.892: checkJavaStack starting: 2007.
2025-10-14T08:22:59.976: ------ test: 2007
2025-10-14T08:22:59.976: EXE: 5/"jstack 89817 | awk '/nid=/ {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]} start_line = NR; last_h1_h2 = 0; has_h1_h2 = 0; in_block = 1} /h1|h2/ {has_h1_h2 = 1; last_h1_h2 = NR} {lines[NR] = $0} END {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]}}' || true".
2025-10-14T08:23:00.216: Row 1: "https-openssl-nio-443-exec-1148" #571361 daemon prio=5 os_prio=0 tid=0x00007f5604047800 nid=0x3844 runnable [0x00007f56377f4000].
2025-10-14T08:23:00.216: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-14T08:23:00.216: Row 3: at java.util.AbstractCollection.toArray(AbstractCollection.java:196).
2025-10-14T08:23:00.216: Row 4: at java.lang.String.split(String.java:2378).
2025-10-14T08:23:00.216: Row 5: at java.lang.String.split(String.java:2422).
2025-10-14T08:23:00.216: Row 6: at h2.core2021.networkMatchSuperFast(core2021.java:3159).
2025-10-14T08:23:00.216: Row 7: at h2.core2021.semanticSimilarity_v3(core2021.java:1422).
2025-10-14T08:23:00.216: Row 8: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-14T08:23:00.217: Row 9: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:799).
2025-10-14T08:23:00.217: Row 10: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-14T08:23:00.217: Row 11: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-14T08:23:00.217: Row 12: at h1.mc_api.doGet(mc_api.java:39).
2025-10-14T08:23:00.217: SUC: 2007, 241ms, lines: 12.
2025-10-14T08:23:00.218: checkJavaStack end: 2007, pid/ret=12.
2025-10-14T08:23:10.218: checkJavaStack starting: 2007.
2025-10-14T08:23:10.305: ------ test: 2007
2025-10-14T08:23:10.305: EXE: 5/"jstack 89817 | awk '/nid=/ {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]} start_line = NR; last_h1_h2 = 0; has_h1_h2 = 0; in_block = 1} /h1|h2/ {has_h1_h2 = 1; last_h1_h2 = NR} {lines[NR] = $0} END {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]}}' || true".
2025-10-14T08:23:10.555: Row 1: "https-openssl-nio-443-exec-1148" #571361 daemon prio=5 os_prio=0 tid=0x00007f5604047800 nid=0x3844 runnable [0x00007f56377f4000].
2025-10-14T08:23:10.555: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-14T08:23:10.555: Row 3: at h1.body.wordToBody(body.java:286).
2025-10-14T08:23:10.555: Row 4: at h2.core2021.semanticSimilarity_v3(core2021.java:1373).
2025-10-14T08:23:10.555: Row 5: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-14T08:23:10.555: Row 6: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:799).
2025-10-14T08:23:10.555: Row 7: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-14T08:23:10.555: Row 8: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-14T08:23:10.555: Row 9: at h1.mc_api.doGet(mc_api.java:39).
2025-10-14T08:23:10.558: SUC: 2007, 253ms, lines: 9.
2025-10-14T08:23:10.559: checkJavaStack end: 2007, pid/ret=9.
2025-10-14T08:23:20.559: checkJavaStack starting: 2007.
2025-10-14T08:23:20.649: ------ test: 2007
2025-10-14T08:23:20.649: EXE: 5/"jstack 89817 | awk '/nid=/ {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]} start_line = NR; last_h1_h2 = 0; has_h1_h2 = 0; in_block = 1} /h1|h2/ {has_h1_h2 = 1; last_h1_h2 = NR} {lines[NR] = $0} END {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]}}' || true".
2025-10-14T08:23:20.847: Row 1: "https-openssl-nio-443-exec-1148" #571361 daemon prio=5 os_prio=0 tid=0x00007f5604047800 nid=0x3844 runnable [0x00007f56377f4000].
2025-10-14T08:23:20.848: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-14T08:23:20.848: Row 3: at h1.body.wordToBody(body.java:318).
2025-10-14T08:23:20.848: Row 4: at h2.core2021.semanticSimilarity_v3(core2021.java:1397).
2025-10-14T08:23:20.848: Row 5: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-14T08:23:20.848: Row 6: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:799).
2025-10-14T08:23:20.848: Row 7: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-14T08:23:20.848: Row 8: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-14T08:23:20.848: Row 9: at h1.mc_api.doGet(mc_api.java:39).
2025-10-14T08:23:20.849: SUC: 2007, 200ms, lines: 9.
2025-10-14T08:23:20.850: checkJavaStack end: 2007, pid/ret=9.
2025-10-14T08:23:30.850: checkJavaStack starting: 2007.
2025-10-14T08:23:30.937: ------ test: 2007
2025-10-14T08:23:30.937: EXE: 5/"jstack 89817 | awk '/nid=/ {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]} start_line = NR; last_h1_h2 = 0; has_h1_h2 = 0; in_block = 1} /h1|h2/ {has_h1_h2 = 1; last_h1_h2 = NR} {lines[NR] = $0} END {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]}}' || true".
2025-10-14T08:23:31.133: Row 1: "https-openssl-nio-443-exec-1148" #571361 daemon prio=5 os_prio=0 tid=0x00007f5604047800 nid=0x3844 runnable [0x00007f56377f4000].
2025-10-14T08:23:31.133: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-14T08:23:31.133: Row 3: at h1.body.wordToBody(body.java:286).
2025-10-14T08:23:31.133: Row 4: at h2.core2021.semanticSimilarity_v3(core2021.java:1373).
2025-10-14T08:23:31.133: Row 5: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-14T08:23:31.133: Row 6: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:799).
2025-10-14T08:23:31.134: Row 7: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-14T08:23:31.134: Row 8: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-14T08:23:31.134: Row 9: at h1.mc_api.doGet(mc_api.java:39).
2025-10-14T08:23:31.135: SUC: 2007, 198ms, lines: 9.
2025-10-14T08:23:31.135: checkJavaStack end: 2007, pid/ret=9.
2025-10-14T08:23:41.136: checkJavaStack starting: 2007.
2025-10-14T08:23:41.225: ------ test: 2007
2025-10-14T08:23:41.225: EXE: 5/"jstack 89817 | awk '/nid=/ {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]} start_line = NR; last_h1_h2 = 0; has_h1_h2 = 0; in_block = 1} /h1|h2/ {has_h1_h2 = 1; last_h1_h2 = NR} {lines[NR] = $0} END {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]}}' || true".
2025-10-14T08:23:41.514: Row 1: "https-openssl-nio-443-exec-1148" #571361 daemon prio=5 os_prio=0 tid=0x00007f5604047800 nid=0x3844 runnable [0x00007f56377f4000].
2025-10-14T08:23:41.515: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-14T08:23:41.515: Row 3: at java.lang.String.split(String.java:2354).
2025-10-14T08:23:41.515: Row 4: at java.lang.String.split(String.java:2422).
2025-10-14T08:23:41.515: Row 5: at h2.core2021.semanticSimilarity_v3(core2021.java:1269).
2025-10-14T08:23:41.515: Row 6: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-14T08:23:41.515: Row 7: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:799).
2025-10-14T08:23:41.515: Row 8: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-14T08:23:41.515: Row 9: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-14T08:23:41.515: Row 10: at h1.mc_api.doGet(mc_api.java:39).
2025-10-14T08:23:41.520: SUC: 2007, 295ms, lines: 10.
2025-10-14T08:23:41.521: checkJavaStack end: 2007, pid/ret=10.
2025-10-14T08:23:51.521: checkJavaStack starting: 2007.
2025-10-14T08:23:51.608: ------ test: 2007
2025-10-14T08:23:51.608: EXE: 5/"jstack 89817 | awk '/nid=/ {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]} start_line = NR; last_h1_h2 = 0; has_h1_h2 = 0; in_block = 1} /h1|h2/ {has_h1_h2 = 1; last_h1_h2 = NR} {lines[NR] = $0} END {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]}}' || true".
2025-10-14T08:23:51.820: Row 1: "https-openssl-nio-443-exec-1154" #571367 daemon prio=5 os_prio=0 tid=0x00007f5620138000 nid=0x3857 runnable [0x00007f56b958d000].
2025-10-14T08:23:51.820: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-14T08:23:51.820: Row 3: at java.net.SocketInputStream.socketRead0(Native Method).
2025-10-14T08:23:51.820: Row 4: at java.net.SocketInputStream.socketRead(SocketInputStream.java:116).
2025-10-14T08:23:51.820: Row 5: at java.net.SocketInputStream.read(SocketInputStream.java:171).
2025-10-14T08:23:51.820: Row 6: at java.net.SocketInputStream.read(SocketInputStream.java:141).
2025-10-14T08:23:51.820: Row 7: at com.mysql.jdbc.util.ReadAheadInputStream.fill(ReadAheadInputStream.java:100).
2025-10-14T08:23:51.821: Row 8: at com.mysql.jdbc.util.ReadAheadInputStream.readFromUnderlyingStreamIfNecessary(ReadAheadInputStream.java:143).
2025-10-14T08:23:51.821: Row 9: at com.mysql.jdbc.util.ReadAheadInputStream.read(ReadAheadInputStream.java:173).
2025-10-14T08:23:51.821: Row 10: - locked <0x00000007bee1d4f8> (a com.mysql.jdbc.util.ReadAheadInputStream).
2025-10-14T08:23:51.821: Row 11: at com.mysql.jdbc.MysqlIO.readFully(MysqlIO.java:2911).
2025-10-14T08:23:51.821: Row 12: at com.mysql.jdbc.MysqlIO.reuseAndReadPacket(MysqlIO.java:3337).
2025-10-14T08:23:51.821: Row 13: at com.mysql.jdbc.MysqlIO.reuseAndReadPacket(MysqlIO.java:3327).
2025-10-14T08:23:51.821: Row 14: at com.mysql.jdbc.MysqlIO.checkErrorPacket(MysqlIO.java:3814).
2025-10-14T08:23:51.821: Row 15: at com.mysql.jdbc.MysqlIO.sendCommand(MysqlIO.java:2435).
2025-10-14T08:23:51.821: Row 16: at com.mysql.jdbc.MysqlIO.sqlQueryDirect(MysqlIO.java:2582).
2025-10-14T08:23:51.821: Row 17: at com.mysql.jdbc.ConnectionImpl.execSQL(ConnectionImpl.java:2530).
2025-10-14T08:23:51.821: Row 18: - locked <0x00000007bee13780> (a com.mysql.jdbc.JDBC4Connection).
2025-10-14T08:23:51.822: Row 19: at com.mysql.jdbc.PreparedStatement.executeInternal(PreparedStatement.java:1907).
2025-10-14T08:23:51.822: Row 20: - locked <0x00000007bee13780> (a com.mysql.jdbc.JDBC4Connection).
2025-10-14T08:23:51.822: Row 21: at com.mysql.jdbc.PreparedStatement.executeQuery(PreparedStatement.java:2030).
2025-10-14T08:23:51.822: Row 22: - locked <0x00000007bee13780> (a com.mysql.jdbc.JDBC4Connection).
2025-10-14T08:23:51.822: Row 23: at h2.helpers.check_pending_works(helpers.java:4945).
2025-10-14T08:23:51.822: Row 24: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-14T08:23:51.823: SUC: 2007, 215ms, lines: 37.
2025-10-14T08:23:51.824: checkJavaStack end: 2007, pid/ret=37.
2025-10-14T08:24:01.824: checkJavaStack starting: 2007.
2025-10-14T08:24:01.940: ------ test: 2007
2025-10-14T08:24:01.941: EXE: 5/"jstack 89817 | awk '/nid=/ {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]} start_line = NR; last_h1_h2 = 0; has_h1_h2 = 0; in_block = 1} /h1|h2/ {has_h1_h2 = 1; last_h1_h2 = NR} {lines[NR] = $0} END {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]}}' || true".
2025-10-14T08:24:02.236: Row 1: "https-openssl-nio-443-exec-1158" #571371 daemon prio=5 os_prio=0 tid=0x00007f55fc084800 nid=0x38cc runnable [0x00007f564c1ef000].
2025-10-14T08:24:02.237: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-14T08:24:02.237: Row 3: at java.net.SocketInputStream.socketRead0(Native Method).
2025-10-14T08:24:02.237: Row 4: at java.net.SocketInputStream.socketRead(SocketInputStream.java:116).
2025-10-14T08:24:02.237: Row 5: at java.net.SocketInputStream.read(SocketInputStream.java:171).
2025-10-14T08:24:02.237: Row 6: at java.net.SocketInputStream.read(SocketInputStream.java:141).
2025-10-14T08:24:02.237: Row 7: at com.mysql.jdbc.util.ReadAheadInputStream.fill(ReadAheadInputStream.java:100).
2025-10-14T08:24:02.237: Row 8: at com.mysql.jdbc.util.ReadAheadInputStream.readFromUnderlyingStreamIfNecessary(ReadAheadInputStream.java:143).
2025-10-14T08:24:02.237: Row 9: at com.mysql.jdbc.util.ReadAheadInputStream.read(ReadAheadInputStream.java:173).
2025-10-14T08:24:02.237: Row 10: - locked <0x000000077d43aa58> (a com.mysql.jdbc.util.ReadAheadInputStream).
2025-10-14T08:24:02.237: Row 11: at com.mysql.jdbc.MysqlIO.readFully(MysqlIO.java:2911).
2025-10-14T08:24:02.237: Row 12: at com.mysql.jdbc.MysqlIO.reuseAndReadPacket(MysqlIO.java:3337).
2025-10-14T08:24:02.238: Row 13: at com.mysql.jdbc.MysqlIO.reuseAndReadPacket(MysqlIO.java:3327).
2025-10-14T08:24:02.238: Row 14: at com.mysql.jdbc.MysqlIO.checkErrorPacket(MysqlIO.java:3814).
2025-10-14T08:24:02.238: Row 15: at com.mysql.jdbc.MysqlIO.sendCommand(MysqlIO.java:2435).
2025-10-14T08:24:02.238: Row 16: at com.mysql.jdbc.MysqlIO.sqlQueryDirect(MysqlIO.java:2582).
2025-10-14T08:24:02.238: Row 17: at com.mysql.jdbc.ConnectionImpl.execSQL(ConnectionImpl.java:2530).
2025-10-14T08:24:02.238: Row 18: - locked <0x000000077d4251e8> (a com.mysql.jdbc.JDBC4Connection).
2025-10-14T08:24:02.238: Row 19: at com.mysql.jdbc.PreparedStatement.executeInternal(PreparedStatement.java:1907).
2025-10-14T08:24:02.238: Row 20: - locked <0x000000077d4251e8> (a com.mysql.jdbc.JDBC4Connection).
2025-10-14T08:24:02.238: Row 21: at com.mysql.jdbc.PreparedStatement.executeQuery(PreparedStatement.java:2030).
2025-10-14T08:24:02.238: Row 22: - locked <0x000000077d4251e8> (a com.mysql.jdbc.JDBC4Connection).
2025-10-14T08:24:02.238: Row 23: at h2.helpers.check_pending_works(helpers.java:4945).
2025-10-14T08:24:02.239: Row 24: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-14T08:24:02.239: SUC: 2007, 298ms, lines: 35.
2025-10-14T08:24:02.239: checkJavaStack end: 2007, pid/ret=35.
2025-10-14T08:24:12.240: checkJavaStack starting: 2007.
2025-10-14T08:24:12.334: ------ test: 2007
2025-10-14T08:24:12.334: EXE: 5/"jstack 89817 | awk '/nid=/ {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]} start_line = NR; last_h1_h2 = 0; has_h1_h2 = 0; in_block = 1} /h1|h2/ {has_h1_h2 = 1; last_h1_h2 = NR} {lines[NR] = $0} END {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]}}' || true".
2025-10-14T08:24:12.529: SUC: 2007, 195ms, lines: 4096.
2025-10-14T08:24:12.530: checkJavaStack end: 2007, pid/ret=4096.
2025-10-14T08:24:22.530: checkJavaStack starting: 2007.
2025-10-14T08:24:22.617: ------ test: 2007
2025-10-14T08:24:22.617: EXE: 5/"jstack 89817 | awk '/nid=/ {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]} start_line = NR; last_h1_h2 = 0; has_h1_h2 = 0; in_block = 1} /h1|h2/ {has_h1_h2 = 1; last_h1_h2 = NR} {lines[NR] = $0} END {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]}}' || true".
2025-10-14T08:24:22.814: SUC: 2007, 197ms, lines: 4096.
2025-10-14T08:24:22.814: checkJavaStack end: 2007, pid/ret=4096.
2025-10-14T08:24:32.814: checkJavaStack starting: 2007.
2025-10-14T08:24:32.901: ------ test: 2007
2025-10-14T08:24:32.902: EXE: 5/"jstack 89817 | awk '/nid=/ {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]} start_line = NR; last_h1_h2 = 0; has_h1_h2 = 0; in_block = 1} /h1|h2/ {has_h1_h2 = 1; last_h1_h2 = NR} {lines[NR] = $0} END {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]}}' || true".
2025-10-14T08:24:33.091: Row 1: "https-openssl-nio-443-exec-1150" #571363 daemon prio=5 os_prio=0 tid=0x00007f5680004800 nid=0x3849 runnable [0x00007f56ba396000].
2025-10-14T08:24:33.091: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-14T08:24:33.091: Row 3: at java.net.SocketInputStream.socketRead0(Native Method).
2025-10-14T08:24:33.091: Row 4: at java.net.SocketInputStream.socketRead(SocketInputStream.java:116).
2025-10-14T08:24:33.091: Row 5: at java.net.SocketInputStream.read(SocketInputStream.java:171).
2025-10-14T08:24:33.091: Row 6: at java.net.SocketInputStream.read(SocketInputStream.java:141).
2025-10-14T08:24:33.092: Row 7: at com.mysql.jdbc.util.ReadAheadInputStream.fill(ReadAheadInputStream.java:100).
2025-10-14T08:24:33.092: Row 8: at com.mysql.jdbc.util.ReadAheadInputStream.readFromUnderlyingStreamIfNecessary(ReadAheadInputStream.java:143).
2025-10-14T08:24:33.092: Row 9: at com.mysql.jdbc.util.ReadAheadInputStream.read(ReadAheadInputStream.java:173).
2025-10-14T08:24:33.092: Row 10: - locked <0x0000000758e76650> (a com.mysql.jdbc.util.ReadAheadInputStream).
2025-10-14T08:24:33.092: Row 11: at com.mysql.jdbc.MysqlIO.readFully(MysqlIO.java:2911).
2025-10-14T08:24:33.092: Row 12: at com.mysql.jdbc.MysqlIO.reuseAndReadPacket(MysqlIO.java:3337).
2025-10-14T08:24:33.092: Row 13: at com.mysql.jdbc.MysqlIO.reuseAndReadPacket(MysqlIO.java:3327).
2025-10-14T08:24:33.092: Row 14: at com.mysql.jdbc.MysqlIO.checkErrorPacket(MysqlIO.java:3814).
2025-10-14T08:24:33.092: Row 15: at com.mysql.jdbc.MysqlIO.sendCommand(MysqlIO.java:2435).
2025-10-14T08:24:33.092: Row 16: at com.mysql.jdbc.MysqlIO.sqlQueryDirect(MysqlIO.java:2582).
2025-10-14T08:24:33.092: Row 17: at com.mysql.jdbc.ConnectionImpl.execSQL(ConnectionImpl.java:2530).
2025-10-14T08:24:33.093: Row 18: - locked <0x0000000758e6cad8> (a com.mysql.jdbc.JDBC4Connection).
2025-10-14T08:24:33.093: Row 19: at com.mysql.jdbc.PreparedStatement.executeInternal(PreparedStatement.java:1907).
2025-10-14T08:24:33.093: Row 20: - locked <0x0000000758e6cad8> (a com.mysql.jdbc.JDBC4Connection).
2025-10-14T08:24:33.093: Row 21: at com.mysql.jdbc.PreparedStatement.executeQuery(PreparedStatement.java:2030).
2025-10-14T08:24:33.093: Row 22: - locked <0x0000000758e6cad8> (a com.mysql.jdbc.JDBC4Connection).
2025-10-14T08:24:33.093: Row 23: at h2.helpers.check_pending_works(helpers.java:5216).
2025-10-14T08:24:33.093: Row 24: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-14T08:24:33.093: SUC: 2007, 191ms, lines: 25.
2025-10-14T08:24:33.093: checkJavaStack end: 2007, pid/ret=25.
2025-10-14T08:24:43.094: checkJavaStack starting: 2007.
2025-10-14T08:24:43.184: ------ test: 2007
2025-10-14T08:24:43.184: EXE: 5/"jstack 89817 | awk '/nid=/ {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]} start_line = NR; last_h1_h2 = 0; has_h1_h2 = 0; in_block = 1} /h1|h2/ {has_h1_h2 = 1; last_h1_h2 = NR} {lines[NR] = $0} END {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]}}' || true".
2025-10-14T08:24:43.531: Row 1: "https-openssl-nio-443-exec-1144" #571357 daemon prio=5 os_prio=0 tid=0x00007f56709bc000 nid=0x3828 runnable [0x00007f5637ffd000].
2025-10-14T08:24:43.531: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-14T08:24:43.531: Row 3: at h2.skills_compass.get_suggestion_with_interests(skills_compass.java:1449).
2025-10-14T08:24:43.531: Row 4: at h2.skills_compass.get_suggestion(skills_compass.java:23).
2025-10-14T08:24:43.531: Row 5: at h2.Utils.doPost(Utils.java:794).
2025-10-14T08:24:43.532: Row 6: at h2.Utils.doGet(Utils.java:30).
2025-10-14T08:24:43.534: SUC: 2007, 350ms, lines: 6.
2025-10-14T08:24:43.534: checkJavaStack end: 2007, pid/ret=6.
2025-10-14T08:24:53.534: checkJavaStack starting: 2007.
2025-10-14T08:24:53.620: ------ test: 2007
2025-10-14T08:24:53.620: EXE: 5/"jstack 89817 | awk '/nid=/ {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]} start_line = NR; last_h1_h2 = 0; has_h1_h2 = 0; in_block = 1} /h1|h2/ {has_h1_h2 = 1; last_h1_h2 = NR} {lines[NR] = $0} END {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]}}' || true".
2025-10-14T08:24:53.857: SUC: 2007, 237ms, lines: 4096.
2025-10-14T08:24:53.858: checkJavaStack end: 2007, pid/ret=4096.
2025-10-14T08:25:03.858: checkJavaStack starting: 2007.
2025-10-14T08:25:03.943: ------ test: 2007
2025-10-14T08:25:03.943: EXE: 5/"jstack 89817 | awk '/nid=/ {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]} start_line = NR; last_h1_h2 = 0; has_h1_h2 = 0; in_block = 1} /h1|h2/ {has_h1_h2 = 1; last_h1_h2 = NR} {lines[NR] = $0} END {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]}}' || true".
2025-10-14T08:25:04.138: SUC: 2007, 195ms, lines: 4096.
2025-10-14T08:25:04.138: checkJavaStack end: 2007, pid/ret=4096.
2025-10-14T08:25:14.139: checkJavaStack starting: 2007.
2025-10-14T08:25:14.224: ------ test: 2007
2025-10-14T08:25:14.224: EXE: 5/"jstack 89817 | awk '/nid=/ {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]} start_line = NR; last_h1_h2 = 0; has_h1_h2 = 0; in_block = 1} /h1|h2/ {has_h1_h2 = 1; last_h1_h2 = NR} {lines[NR] = $0} END {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]}}' || true".
2025-10-14T08:25:14.417: SUC: 2007, 193ms, lines: 4096.
2025-10-14T08:25:14.417: checkJavaStack end: 2007, pid/ret=4096.
2025-10-14T08:25:24.418: checkJavaStack starting: 2007.
2025-10-14T08:25:24.504: ------ test: 2007
2025-10-14T08:25:24.504: EXE: 5/"jstack 89817 | awk '/nid=/ {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]} start_line = NR; last_h1_h2 = 0; has_h1_h2 = 0; in_block = 1} /h1|h2/ {has_h1_h2 = 1; last_h1_h2 = NR} {lines[NR] = $0} END {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]}}' || true".
2025-10-14T08:25:24.741: SUC: 2007, 237ms, lines: 4096.
2025-10-14T08:25:24.741: checkJavaStack end: 2007, pid/ret=4096.
2025-10-14T08:25:34.742: checkJavaStack starting: 2007.
2025-10-14T08:25:34.828: ------ test: 2007
2025-10-14T08:25:34.828: EXE: 5/"jstack 89817 | awk '/nid=/ {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]} start_line = NR; last_h1_h2 = 0; has_h1_h2 = 0; in_block = 1} /h1|h2/ {has_h1_h2 = 1; last_h1_h2 = NR} {lines[NR] = $0} END {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]}}' || true".
2025-10-14T08:25:35.064: SUC: 2007, 236ms, lines: 4096.
2025-10-14T08:25:35.064: checkJavaStack end: 2007, pid/ret=4096.
2025-10-14T08:25:45.065: checkJavaStack starting: 2007.
2025-10-14T08:25:45.152: ------ test: 2007
2025-10-14T08:25:45.152: EXE: 5/"jstack 89817 | awk '/nid=/ {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]} start_line = NR; last_h1_h2 = 0; has_h1_h2 = 0; in_block = 1} /h1|h2/ {has_h1_h2 = 1; last_h1_h2 = NR} {lines[NR] = $0} END {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]}}' || true".
2025-10-14T08:25:45.338: SUC: 2007, 186ms, lines: 4096.
2025-10-14T08:25:45.338: checkJavaStack end: 2007, pid/ret=4096.
2025-10-14T08:25:55.339: checkJavaStack starting: 2007.
2025-10-14T08:25:55.423: ------ test: 2007
2025-10-14T08:25:55.423: EXE: 5/"jstack 89817 | awk '/nid=/ {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]} start_line = NR; last_h1_h2 = 0; has_h1_h2 = 0; in_block = 1} /h1|h2/ {has_h1_h2 = 1; last_h1_h2 = NR} {lines[NR] = $0} END {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]}}' || true".
2025-10-14T08:25:55.685: Row 1: "https-openssl-nio-443-exec-1140" #571353 daemon prio=5 os_prio=0 tid=0x00007f561405e000 nid=0x3770 runnable [0x00007f56b8179000].
2025-10-14T08:25:55.685: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-14T08:25:55.685: Row 3: at java.net.SocketInputStream.socketRead0(Native Method).
2025-10-14T08:25:55.686: Row 4: at java.net.SocketInputStream.socketRead(SocketInputStream.java:116).
2025-10-14T08:25:55.686: Row 5: at java.net.SocketInputStream.read(SocketInputStream.java:171).
2025-10-14T08:25:55.686: Row 6: at java.net.SocketInputStream.read(SocketInputStream.java:141).
2025-10-14T08:25:55.686: Row 7: at sun.security.ssl.SSLSocketInputRecord.read(SSLSocketInputRecord.java:457).
2025-10-14T08:25:55.686: Row 8: at sun.security.ssl.SSLSocketInputRecord.decode(SSLSocketInputRecord.java:165).
2025-10-14T08:25:55.686: Row 9: at sun.security.ssl.SSLTransport.decode(SSLTransport.java:109).
2025-10-14T08:25:55.686: Row 10: at sun.security.ssl.SSLSocketImpl.decode(SSLSocketImpl.java:1383).
2025-10-14T08:25:55.686: Row 11: at sun.security.ssl.SSLSocketImpl.readHandshakeRecord(SSLSocketImpl.java:1291).
2025-10-14T08:25:55.686: Row 12: at sun.security.ssl.SSLSocketImpl.startHandshake(SSLSocketImpl.java:435).
2025-10-14T08:25:55.686: Row 13: at net.snowflake.client.jdbc.internal.apache.http.conn.ssl.SSLConnectionSocketFactory.createLayeredSocket(SSLConnectionSocketFactory.java:436).
2025-10-14T08:25:55.686: Row 14: at net.snowflake.client.jdbc.internal.apache.http.conn.ssl.SSLConnectionSocketFactory.connectSocket(SSLConnectionSocketFactory.java:384).
2025-10-14T08:25:55.686: Row 15: at net.snowflake.client.jdbc.internal.apache.http.impl.conn.DefaultHttpClientConnectionOperator.connect(DefaultHttpClientConnectionOperator.java:142).
2025-10-14T08:25:55.687: Row 16: at net.snowflake.client.jdbc.internal.apache.http.impl.conn.PoolingHttpClientConnectionManager.connect(PoolingHttpClientConnectionManager.java:376).
2025-10-14T08:25:55.687: Row 17: at net.snowflake.client.jdbc.internal.apache.http.impl.execchain.MainClientExec.establishRoute(MainClientExec.java:393).
2025-10-14T08:25:55.687: Row 18: at net.snowflake.client.jdbc.internal.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:236).
2025-10-14T08:25:55.687: Row 19: at net.snowflake.client.jdbc.internal.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:186).
2025-10-14T08:25:55.687: Row 20: at net.snowflake.client.jdbc.internal.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:89).
2025-10-14T08:25:55.687: Row 21: at net.snowflake.client.jdbc.internal.apache.http.impl.execchain.RedirectExec.execute(RedirectExec.java:110).
2025-10-14T08:25:55.687: Row 22: at net.snowflake.client.jdbc.internal.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:185).
2025-10-14T08:25:55.687: Row 23: at net.snowflake.client.jdbc.internal.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:83).
2025-10-14T08:25:55.687: Row 24: at net.snowflake.client.jdbc.internal.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:108).
2025-10-14T08:25:55.693: SUC: 2007, 270ms, lines: 45.
2025-10-14T08:25:55.694: checkJavaStack end: 2007, pid/ret=45.
2025-10-14T08:26:05.694: checkJavaStack starting: 2007.
2025-10-14T08:26:05.784: ------ test: 2007
2025-10-14T08:26:05.784: EXE: 5/"jstack 89817 | awk '/nid=/ {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]} start_line = NR; last_h1_h2 = 0; has_h1_h2 = 0; in_block = 1} /h1|h2/ {has_h1_h2 = 1; last_h1_h2 = NR} {lines[NR] = $0} END {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]}}' || true".
2025-10-14T08:26:06.012: SUC: 2007, 228ms, lines: 4096.
2025-10-14T08:26:06.013: checkJavaStack end: 2007, pid/ret=4096.
2025-10-14T08:26:16.013: checkJavaStack starting: 2007.
2025-10-14T08:26:16.100: ------ test: 2007
2025-10-14T08:26:16.100: EXE: 5/"jstack 89817 | awk '/nid=/ {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]} start_line = NR; last_h1_h2 = 0; has_h1_h2 = 0; in_block = 1} /h1|h2/ {has_h1_h2 = 1; last_h1_h2 = NR} {lines[NR] = $0} END {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]}}' || true".
2025-10-14T08:26:16.318: SUC: 2007, 218ms, lines: 4096.
2025-10-14T08:26:16.318: checkJavaStack end: 2007, pid/ret=4096.
2025-10-14T08:26:26.318: checkJavaStack starting: 2007.
2025-10-14T08:26:26.404: ------ test: 2007
2025-10-14T08:26:26.404: EXE: 5/"jstack 89817 | awk '/nid=/ {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]} start_line = NR; last_h1_h2 = 0; has_h1_h2 = 0; in_block = 1} /h1|h2/ {has_h1_h2 = 1; last_h1_h2 = NR} {lines[NR] = $0} END {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]}}' || true".
2025-10-14T08:26:26.629: SUC: 2007, 225ms, lines: 4096.
2025-10-14T08:26:26.630: checkJavaStack end: 2007, pid/ret=4096.
2025-10-14T08:26:26.634: ------ test: end, 321591ms. Score 39/39.
2025-10-14T08:26:26.636: Test duration: 5m21s.