2025-10-13T05:21:04.870: current working dir: /root/qa/mctester.
2025-10-13T05:21:04.915: current logging dir: ../mctester/www.
2025-10-13T05:21:04.915: ---------------------------------------------------------------
2025-10-13T05:21:04.921: mctester entry: 2025-10-13T05:21:04.915911 mode=50
2025-10-13T05:21:04.921: ---------------------------------------------------------------
2025-10-13T05:21:04.991: EXE: 1/git describe --tags.
2025-10-13T05:21:05.009: Row 1: v1.1-493-g334079e.
2025-10-13T05:21:05.012: EXE: 1/git rev-list --count HEAD.
2025-10-13T05:21:05.020: Row 1: 550.
2025-10-13T05:21:05.023: EXE: 1/git rev-parse HEAD.
2025-10-13T05:21:05.025: Row 1: 334079e0023fd6b85febe0f6cd19139cfdea0dc1.
2025-10-13T05:21:05.035: mctester: v1.1.550 (334079e0023fd6b85febe0f6cd19139cfdea0dc1).
2025-10-13T05:21:05.036: Entering into a performance tests mode.
2025-10-13T05:21:05.037: ------ test: start, 2025-10-13T05:21:05.036
2025-10-13T05:21:05.039: ------ test: 2000
2025-10-13T05:21:05.040: CMD: ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "top -b -n 1"
2025-10-13T05:21:05.040: EXE: 1/ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "top -b -n 1".
2025-10-13T05:21:05.305: Row 1: top - 05:21:05 up 133 days, 19:08, 0 users, load average: 0.30, 0.31, 0.74.
2025-10-13T05:21:05.305: Row 2: Tasks: 536 total, 1 running, 535 sleeping, 0 stopped, 0 zombie.
2025-10-13T05:21:05.306: Row 3: %Cpu(s): 1.4 us, 0.2 sy, 0.0 ni, 98.4 id, 0.0 wa, 0.0 hi, 0.0 si, 0.0 st.
2025-10-13T05:21:05.306: Row 4: KiB Mem : 13202036+total, 727684 free, 66537436 used, 64755252 buff/cache.
2025-10-13T05:21:05.306: Row 5: KiB Swap: 0 total, 0 free, 0 used. 64483604 avail Mem .
2025-10-13T05:21:05.306: Row 6: .
2025-10-13T05:21:05.307: Row 7: PID USER PR NI VIRT RES SHR S %CPU %MEM TIME+ COMMAND.
2025-10-13T05:21:05.307: Row 8: 89817 root 20 0 22.425g 0.011t 38148 S 100.0 8.6 18642:10 java.
2025-10-13T05:21:05.307: Row 9: 1 root 20 0 43692 4144 2780 S 0.0 0.0 6:58.53 init.
2025-10-13T05:21:05.307: Row 10: 2 root 20 0 0 0 0 S 0.0 0.0 0:00.91 kthreadd.
2025-10-13T05:21:05.307: Row 11: 3 root 20 0 0 0 0 S 0.0 0.0 0:46.87 ksoftirqd+.
2025-10-13T05:21:05.308: Row 12: 4 root 20 0 0 0 0 S 0.0 0.0 0:00.00 kworker/0+.
2025-10-13T05:21:05.308: Row 13: 5 root 0 -20 0 0 0 S 0.0 0.0 0:00.00 kworker/0+.
2025-10-13T05:21:05.308: Row 14: 7 root 20 0 0 0 0 S 0.0 0.0 57:24.43 rcu_sched.
2025-10-13T05:21:05.308: Row 15: 8 root 20 0 0 0 0 S 0.0 0.0 0:00.00 rcu_bh.
2025-10-13T05:21:05.308: Row 16: 9 root rt 0 0 0 0 S 0.0 0.0 0:02.62 migration+.
2025-10-13T05:21:05.309: Row 17: 10 root rt 0 0 0 0 S 0.0 0.0 0:32.43 watchdog/0.
2025-10-13T05:21:05.309: Row 18: 11 root rt 0 0 0 0 S 0.0 0.0 0:31.49 watchdog/1.
2025-10-13T05:21:05.309: Row 19: 12 root rt 0 0 0 0 S 0.0 0.0 0:10.86 migration+.
2025-10-13T05:21:05.310: Row 20: 13 root 20 0 0 0 0 S 0.0 0.0 0:02.35 ksoftirqd+.
2025-10-13T05:21:05.310: Row 21: 14 root 20 0 0 0 0 S 0.0 0.0 0:00.00 kworker/1+.
2025-10-13T05:21:05.310: Row 22: 15 root 0 -20 0 0 0 S 0.0 0.0 0:00.00 kworker/1+.
2025-10-13T05:21:05.310: Row 23: 16 root rt 0 0 0 0 S 0.0 0.0 0:31.72 watchdog/2.
2025-10-13T05:21:05.311: Row 24: 17 root rt 0 0 0 0 S 0.0 0.0 0:03.84 migration+.
2025-10-13T05:21:05.380: SUC: 335ms Uptime 133 days, 1min 0.30, 5min 0.31, 15min 0.74, mem:132020360 total / 727684 free / 66537436 used / 64755252 cache / 64483604 avail
2025-10-13T05:21:05.390: ------ test: 2001
2025-10-13T05:21:05.390: CMD: top -b -E k -n 1
2025-10-13T05:21:05.390: EXE: 1/top -b -E k -n 1.
2025-10-13T05:21:05.548: Row 1: top - 05:21:05 up 48 days, 19:34, 0 users, load average: 3.60, 3.89, 3.96.
2025-10-13T05:21:05.548: Row 2: Tasks: 167 total, 1 running, 164 sleeping, 1 stopped, 1 zombie.
2025-10-13T05:21:05.549: Row 3: %Cpu(s): 12.1 us, 0.0 sy, 0.0 ni, 87.9 id, 0.0 wa, 0.0 hi, 0.0 si, 0.0 st.
2025-10-13T05:21:05.549: Row 4: KiB Mem : 16480104 total, 5335356 free, 1231812 used, 9912936 buff/cache.
2025-10-13T05:21:05.549: Row 5: KiB Swap: 0 total, 0 free, 0 used. 14810256 avail Mem .
2025-10-13T05:21:05.549: Row 6: .
2025-10-13T05:21:05.550: Row 7: PID USER PR NI VIRT RES SHR S %CPU %MEM TIME+ COMMAND.
2025-10-13T05:21:05.550: Row 8: 2561882 root 20 0 4977416 81152 27324 S 93.3 0.5 0:01.15 java.
2025-10-13T05:21:05.550: Row 9: 1 root 20 0 167780 13280 8396 S 0.0 0.1 1:21.34 systemd.
2025-10-13T05:21:05.550: Row 10: 2 root 20 0 0 0 0 S 0.0 0.0 0:00.49 kthreadd.
2025-10-13T05:21:05.550: Row 11: 3 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 rcu_gp.
2025-10-13T05:21:05.551: Row 12: 4 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 rcu_par+.
2025-10-13T05:21:05.551: Row 13: 5 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 slub_fl+.
2025-10-13T05:21:05.551: Row 14: 6 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 netns.
2025-10-13T05:21:05.551: Row 15: 8 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 kworker+.
2025-10-13T05:21:05.551: Row 16: 10 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 mm_perc+.
2025-10-13T05:21:05.551: Row 17: 11 root 20 0 0 0 0 S 0.0 0.0 0:00.00 rcu_tas+.
2025-10-13T05:21:05.552: Row 18: 12 root 20 0 0 0 0 S 0.0 0.0 0:00.00 rcu_tas+.
2025-10-13T05:21:05.552: Row 19: 13 root 20 0 0 0 0 S 0.0 0.0 0:00.83 ksoftir+.
2025-10-13T05:21:05.552: Row 20: 14 root 20 0 0 0 0 I 0.0 0.0 2:06.77 rcu_sch+.
2025-10-13T05:21:05.552: Row 21: 15 root rt 0 0 0 0 S 0.0 0.0 0:09.49 migrati+.
2025-10-13T05:21:05.552: Row 22: 16 root -51 0 0 0 0 S 0.0 0.0 0:00.00 idle_in+.
2025-10-13T05:21:05.553: Row 23: 18 root 20 0 0 0 0 S 0.0 0.0 0:00.00 cpuhp/0.
2025-10-13T05:21:05.553: Row 24: 19 root 20 0 0 0 0 S 0.0 0.0 0:00.00 cpuhp/1.
2025-10-13T05:21:05.569: SUC: 179ms Uptime 48 days, 1min 3.60, 5min 3.89, 15min 3.96, mem:16480104 total / 5335356 free / 1231812 used / 9912936 cache / 14810256 avail
2025-10-13T05:21:05.570: ------ test: 2002
2025-10-13T05:21:05.570: CMD: df -h
2025-10-13T05:21:05.570: EXE: 1/df -h.
2025-10-13T05:21:05.572: Row 1: Filesystem Size Used Avail Use% Mounted on.
2025-10-13T05:21:05.573: Row 2: tmpfs 791M 82M 710M 11% /run.
2025-10-13T05:21:05.573: Row 3: /dev/vda2 30G 24G 4.4G 85% /.
2025-10-13T05:21:05.573: Row 4: tmpfs 3.9G 0 3.9G 0% /dev/shm.
2025-10-13T05:21:05.573: Row 5: tmpfs 5.0M 0 5.0M 0% /run/lock.
2025-10-13T05:21:05.575: SUC: 5ms Diskfree qa.headai.com: tmpfs:11%, /dev/vda2:85%, tmpfs:0%, tmpfs:0%.
2025-10-13T05:21:05.575: ------ test: 2003
2025-10-13T05:21:05.576: CMD: ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "df -h"
2025-10-13T05:21:05.576: EXE: 1/ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "df -h".
2025-10-13T05:21:05.643: Row 1: Filesystem Size Used Avail Use% Mounted on.
2025-10-13T05:21:05.644: Row 2: udev 63G 4.0K 63G 1% /dev.
2025-10-13T05:21:05.644: Row 3: tmpfs 13G 5.5M 13G 1% /run.
2025-10-13T05:21:05.644: Row 4: /dev/vda1 757G 305G 421G 42% /.
2025-10-13T05:21:05.644: Row 5: none 4.0K 0 4.0K 0% /sys/fs/cgroup.
2025-10-13T05:21:05.645: Row 6: none 5.0M 0 5.0M 0% /run/lock.
2025-10-13T05:21:05.645: Row 7: none 63G 0 63G 0% /run/shm.
2025-10-13T05:21:05.645: Row 8: none 100M 0 100M 0% /run/user.
2025-10-13T05:21:05.645: Row 9: cgmfs 100K 0 100K 0% /run/cgmanager/fs.
2025-10-13T05:21:05.645: Row 10: /dev/vdb 985G 275G 661G 30% /opt/tomcat/webapps/ROOT/analysis.
2025-10-13T05:21:05.645: Row 11: tmpfs 100K 0 100K 0% /var/lib/lxd/shmounts.
2025-10-13T05:21:05.645: Row 12: tmpfs 100K 0 100K 0% /var/lib/lxd/devlxd.
2025-10-13T05:21:05.646: SUC: 70ms Diskfree megatron.headai.com: udev:1%, tmpfs:1%, /dev/vda1:42%, none:0%, none:0%, none:0%, none:0%, cgmfs:0%, /dev/vdb:30%, tmpfs:0%, tmpfs:0%.
2025-10-13T05:21:05.647: ------ test: 2004
2025-10-13T05:21:05.647: URL: https://headai.com
2025-10-13T05:21:06.178: SUC: 522ms, 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-13T05:21:06.179: ------ test: 2005
2025-10-13T05:21:06.414: SQL: show global status like 'threads_connected';.
2025-10-13T05:21:06.440: Results: value=2/200.
2025-10-13T05:21:06.445: SQL: value, lines: 1, ret=1, 2.
2025-10-13T05:21:06.446: SUC: 267ms 2
2025-10-13T05:21:06.447: ------ test: 2006
2025-10-13T05:21:06.530: SQL: SHOW PROCESSLIST;.
2025-10-13T05:21:06.534: Row 1: 54224462,root,localhost:36938,null,Query,0,starting,SHOW PROCESSLIST.
2025-10-13T05:21:06.534: SQL: COUNTNOTLINES:Command, lines: 1, ret=1, 1.
2025-10-13T05:21:06.534: SUC: 87ms 1
2025-10-13T05:21:06.535: checkJavaStack starting: 2007.
2025-10-13T05:21:06.636: ------ test: 2007
2025-10-13T05:21:06.636: 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-13T05:21:06.901: Row 1: "https-openssl-nio-443-exec-1136" #528013 daemon prio=5 os_prio=0 tid=0x00007f56841a9800 nid=0xe4d8 runnable [0x00007f564f2fb000].
2025-10-13T05:21:06.901: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-13T05:21:06.901: Row 3: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5318).
2025-10-13T05:21:06.901: Row 4: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5258).
2025-10-13T05:21:06.901: Row 5: at h2.core2021.semanticSimilarity_v3(core2021.java:1418).
2025-10-13T05:21:06.901: Row 6: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-13T05:21:06.901: Row 7: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:791).
2025-10-13T05:21:06.902: Row 8: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-13T05:21:06.902: Row 9: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-13T05:21:06.902: Row 10: at h1.mc_api.doGet(mc_api.java:39).
2025-10-13T05:21:06.902: Row 11: "https-openssl-nio-443-exec-1125" #505842 daemon prio=5 os_prio=0 tid=0x00007f561001d000 nid=0x2e3 runnable [0x00007f5637bf9000].
2025-10-13T05:21:06.902: Row 12: java.lang.Thread.State: RUNNABLE.
2025-10-13T05:21:06.902: Row 13: at java.net.SocketInputStream.socketRead0(Native Method).
2025-10-13T05:21:06.902: Row 14: at java.net.SocketInputStream.socketRead(SocketInputStream.java:116).
2025-10-13T05:21:06.903: Row 15: at java.net.SocketInputStream.read(SocketInputStream.java:171).
2025-10-13T05:21:06.903: Row 16: at java.net.SocketInputStream.read(SocketInputStream.java:141).
2025-10-13T05:21:06.903: Row 17: at com.mysql.jdbc.util.ReadAheadInputStream.fill(ReadAheadInputStream.java:100).
2025-10-13T05:21:06.903: Row 18: at com.mysql.jdbc.util.ReadAheadInputStream.readFromUnderlyingStreamIfNecessary(ReadAheadInputStream.java:143).
2025-10-13T05:21:06.904: Row 19: at com.mysql.jdbc.util.ReadAheadInputStream.read(ReadAheadInputStream.java:173).
2025-10-13T05:21:06.904: Row 20: - locked <0x000000068d1577a0> (a com.mysql.jdbc.util.ReadAheadInputStream).
2025-10-13T05:21:06.904: Row 21: at com.mysql.jdbc.MysqlIO.readFully(MysqlIO.java:2911).
2025-10-13T05:21:06.904: Row 22: at com.mysql.jdbc.MysqlIO.reuseAndReadPacket(MysqlIO.java:3337).
2025-10-13T05:21:06.904: Row 23: at com.mysql.jdbc.MysqlIO.reuseAndReadPacket(MysqlIO.java:3327).
2025-10-13T05:21:06.904: Row 24: at com.mysql.jdbc.MysqlIO.checkErrorPacket(MysqlIO.java:3814).
2025-10-13T05:21:06.905: SUC: 2007, 269ms, lines: 35.
2025-10-13T05:21:06.907: checkJavaStack end: 2007, pid/ret=35.
2025-10-13T05:21:16.907: checkJavaStack starting: 2007.
2025-10-13T05:21:16.994: ------ test: 2007
2025-10-13T05:21:16.994: 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-13T05:21:17.249: Row 1: "https-openssl-nio-443-exec-1136" #528013 daemon prio=5 os_prio=0 tid=0x00007f56841a9800 nid=0xe4d8 runnable [0x00007f564f2fb000].
2025-10-13T05:21:17.249: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-13T05:21:17.249: Row 3: at java.util.AbstractCollection.toArray(AbstractCollection.java:196).
2025-10-13T05:21:17.249: Row 4: at java.lang.String.split(String.java:2378).
2025-10-13T05:21:17.249: Row 5: at java.lang.String.split(String.java:2422).
2025-10-13T05:21:17.250: Row 6: at h2.core2021.networkMatchSuperFast(core2021.java:3164).
2025-10-13T05:21:17.250: Row 7: at h2.core2021.semanticSimilarity_v3(core2021.java:1422).
2025-10-13T05:21:17.250: Row 8: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-13T05:21:17.250: Row 9: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:791).
2025-10-13T05:21:17.250: Row 10: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-13T05:21:17.250: Row 11: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-13T05:21:17.250: Row 12: at h1.mc_api.doGet(mc_api.java:39).
2025-10-13T05:21:17.250: SUC: 2007, 256ms, lines: 12.
2025-10-13T05:21:17.251: checkJavaStack end: 2007, pid/ret=12.
2025-10-13T05:21:27.252: checkJavaStack starting: 2007.
2025-10-13T05:21:27.338: ------ test: 2007
2025-10-13T05:21:27.339: 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-13T05:21:27.540: SUC: 2007, 201ms, lines: 4096.
2025-10-13T05:21:27.541: checkJavaStack end: 2007, pid/ret=4096.
2025-10-13T05:21:37.541: checkJavaStack starting: 2007.
2025-10-13T05:21:37.627: ------ test: 2007
2025-10-13T05:21:37.627: 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-13T05:21:37.847: Row 1: "https-openssl-nio-443-exec-1121" #505830 daemon prio=5 os_prio=0 tid=0x00007f569c0f7000 nid=0x2d6 runnable [0x00007f5637ffc000].
2025-10-13T05:21:37.847: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-13T05:21:37.847: Row 3: at h2.core2021.semanticSimilarity_v3(core2021.java:1396).
2025-10-13T05:21:37.847: Row 4: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-13T05:21:37.848: Row 5: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:791).
2025-10-13T05:21:37.848: Row 6: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-13T05:21:37.848: Row 7: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-13T05:21:37.848: Row 8: at h1.mc_api.doGet(mc_api.java:39).
2025-10-13T05:21:37.849: SUC: 2007, 222ms, lines: 8.
2025-10-13T05:21:37.850: checkJavaStack end: 2007, pid/ret=8.
2025-10-13T05:21:47.850: checkJavaStack starting: 2007.
2025-10-13T05:21:47.939: ------ test: 2007
2025-10-13T05:21:47.939: 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-13T05:21:48.121: Row 1: "https-openssl-nio-443-exec-1121" #505830 daemon prio=5 os_prio=0 tid=0x00007f569c0f7000 nid=0x2d6 runnable [0x00007f5637ffc000].
2025-10-13T05:21:48.121: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-13T05:21:48.121: Row 3: at h1.body.wordToBody(body.java:286).
2025-10-13T05:21:48.122: Row 4: at h2.core2021.semanticSimilarity_v3(core2021.java:1397).
2025-10-13T05:21:48.122: Row 5: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-13T05:21:48.122: Row 6: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:791).
2025-10-13T05:21:48.122: Row 7: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-13T05:21:48.122: Row 8: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-13T05:21:48.122: Row 9: at h1.mc_api.doGet(mc_api.java:39).
2025-10-13T05:21:48.124: SUC: 2007, 185ms, lines: 9.
2025-10-13T05:21:48.125: checkJavaStack end: 2007, pid/ret=9.
2025-10-13T05:21:58.125: checkJavaStack starting: 2007.
2025-10-13T05:21:58.211: ------ test: 2007
2025-10-13T05:21:58.211: 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-13T05:21:58.430: Row 1: "https-openssl-nio-443-exec-1121" #505830 daemon prio=5 os_prio=0 tid=0x00007f569c0f7000 nid=0x2d6 runnable [0x00007f5637ffc000].
2025-10-13T05:21:58.430: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-13T05:21:58.430: Row 3: at java.lang.String.indexOf(String.java:1769).
2025-10-13T05:21:58.430: Row 4: at java.lang.String.indexOf(String.java:1718).
2025-10-13T05:21:58.430: Row 5: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5362).
2025-10-13T05:21:58.430: Row 6: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5318).
2025-10-13T05:21:58.430: Row 7: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5258).
2025-10-13T05:21:58.431: Row 8: at h2.core2021.semanticSimilarity_v3(core2021.java:1405).
2025-10-13T05:21:58.431: Row 9: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-13T05:21:58.431: Row 10: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:791).
2025-10-13T05:21:58.431: Row 11: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-13T05:21:58.431: Row 12: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-13T05:21:58.431: Row 13: at h1.mc_api.doGet(mc_api.java:39).
2025-10-13T05:21:58.431: SUC: 2007, 220ms, lines: 13.
2025-10-13T05:21:58.432: checkJavaStack end: 2007, pid/ret=13.
2025-10-13T05:22:08.432: checkJavaStack starting: 2007.
2025-10-13T05:22:08.549: ------ test: 2007
2025-10-13T05:22:08.550: 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-13T05:22:08.783: Row 1: "https-openssl-nio-443-exec-1121" #505830 daemon prio=5 os_prio=0 tid=0x00007f569c0f7000 nid=0x2d6 runnable [0x00007f5637ffc000].
2025-10-13T05:22:08.783: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-13T05:22:08.783: Row 3: at java.util.AbstractCollection.toArray(AbstractCollection.java:196).
2025-10-13T05:22:08.784: Row 4: at java.lang.String.split(String.java:2378).
2025-10-13T05:22:08.784: Row 5: at java.lang.String.split(String.java:2422).
2025-10-13T05:22:08.784: Row 6: at h2.core2021.networkMatchSuperFast(core2021.java:3164).
2025-10-13T05:22:08.784: Row 7: at h2.core2021.semanticSimilarity_v3(core2021.java:1422).
2025-10-13T05:22:08.784: Row 8: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-13T05:22:08.784: Row 9: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:791).
2025-10-13T05:22:08.784: Row 10: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-13T05:22:08.784: Row 11: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-13T05:22:08.784: Row 12: at h1.mc_api.doGet(mc_api.java:39).
2025-10-13T05:22:08.800: SUC: 2007, 249ms, lines: 12.
2025-10-13T05:22:08.801: checkJavaStack end: 2007, pid/ret=12.
2025-10-13T05:22:18.801: checkJavaStack starting: 2007.
2025-10-13T05:22:18.888: ------ test: 2007
2025-10-13T05:22:18.888: 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-13T05:22:19.100: Row 1: "https-openssl-nio-443-exec-1121" #505830 daemon prio=5 os_prio=0 tid=0x00007f569c0f7000 nid=0x2d6 runnable [0x00007f5637ffd000].
2025-10-13T05:22:19.100: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-13T05:22:19.100: Row 3: at java.util.Arrays.copyOf(Arrays.java:3181).
2025-10-13T05:22:19.100: Row 4: at java.util.ArrayList.grow(ArrayList.java:267).
2025-10-13T05:22:19.100: Row 5: at java.util.ArrayList.ensureExplicitCapacity(ArrayList.java:241).
2025-10-13T05:22:19.100: Row 6: at java.util.ArrayList.ensureCapacityInternal(ArrayList.java:233).
2025-10-13T05:22:19.100: Row 7: at java.util.ArrayList.add(ArrayList.java:464).
2025-10-13T05:22:19.100: Row 8: at java.lang.String.split(String.java:2353).
2025-10-13T05:22:19.100: Row 9: at java.lang.String.split(String.java:2422).
2025-10-13T05:22:19.100: Row 10: at h2.core2021.networkMatchSuperFast(core2021.java:3159).
2025-10-13T05:22:19.101: Row 11: at h2.core2021.semanticSimilarity_v3(core2021.java:1422).
2025-10-13T05:22:19.101: Row 12: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-13T05:22:19.101: Row 13: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:791).
2025-10-13T05:22:19.101: Row 14: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-13T05:22:19.101: Row 15: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-13T05:22:19.101: Row 16: at h1.mc_api.doGet(mc_api.java:39).
2025-10-13T05:22:19.103: SUC: 2007, 215ms, lines: 16.
2025-10-13T05:22:19.104: checkJavaStack end: 2007, pid/ret=16.
2025-10-13T05:22:29.104: checkJavaStack starting: 2007.
2025-10-13T05:22:29.192: ------ test: 2007
2025-10-13T05:22:29.192: 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-13T05:22:29.397: Row 1: "https-openssl-nio-443-exec-1121" #505830 daemon prio=5 os_prio=0 tid=0x00007f569c0f7000 nid=0x2d6 runnable [0x00007f5637ffc000].
2025-10-13T05:22:29.397: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-13T05:22:29.397: Row 3: at h1.body.wordToBody(body.java:286).
2025-10-13T05:22:29.398: Row 4: at h2.core2021.semanticSimilarity_v3(core2021.java:1397).
2025-10-13T05:22:29.398: Row 5: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-13T05:22:29.398: Row 6: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:791).
2025-10-13T05:22:29.398: Row 7: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-13T05:22:29.398: Row 8: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-13T05:22:29.398: Row 9: at h1.mc_api.doGet(mc_api.java:39).
2025-10-13T05:22:29.399: SUC: 2007, 207ms, lines: 9.
2025-10-13T05:22:29.400: checkJavaStack end: 2007, pid/ret=9.
2025-10-13T05:22:39.400: checkJavaStack starting: 2007.
2025-10-13T05:22:39.489: ------ test: 2007
2025-10-13T05:22:39.489: 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-13T05:22:39.732: Row 1: "https-openssl-nio-443-exec-1121" #505830 daemon prio=5 os_prio=0 tid=0x00007f569c0f7000 nid=0x2d6 runnable [0x00007f5637ffc000].
2025-10-13T05:22:39.732: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-13T05:22:39.733: Row 3: at java.lang.String.indexOf(String.java:1769).
2025-10-13T05:22:39.733: Row 4: at java.lang.String.indexOf(String.java:1718).
2025-10-13T05:22:39.733: Row 5: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5362).
2025-10-13T05:22:39.733: Row 6: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5318).
2025-10-13T05:22:39.733: Row 7: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5258).
2025-10-13T05:22:39.733: Row 8: at h2.core2021.semanticSimilarity_v3(core2021.java:1404).
2025-10-13T05:22:39.733: Row 9: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-13T05:22:39.733: Row 10: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:791).
2025-10-13T05:22:39.733: Row 11: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-13T05:22:39.733: Row 12: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-13T05:22:39.733: Row 13: at h1.mc_api.doGet(mc_api.java:39).
2025-10-13T05:22:39.735: SUC: 2007, 246ms, lines: 13.
2025-10-13T05:22:39.736: checkJavaStack end: 2007, pid/ret=13.
2025-10-13T05:22:49.736: checkJavaStack starting: 2007.
2025-10-13T05:22:49.820: ------ test: 2007
2025-10-13T05:22:49.820: 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-13T05:22:50.041: Row 1: "https-openssl-nio-443-exec-1121" #505830 daemon prio=5 os_prio=0 tid=0x00007f569c0f7000 nid=0x2d6 runnable [0x00007f5637ffc000].
2025-10-13T05:22:50.042: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-13T05:22:50.042: Row 3: at java.lang.String.indexOf(String.java:1769).
2025-10-13T05:22:50.042: Row 4: at java.lang.String.indexOf(String.java:1718).
2025-10-13T05:22:50.042: Row 5: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5362).
2025-10-13T05:22:50.042: Row 6: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5318).
2025-10-13T05:22:50.042: Row 7: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5258).
2025-10-13T05:22:50.042: Row 8: at h2.core2021.semanticSimilarity_v3(core2021.java:1412).
2025-10-13T05:22:50.043: Row 9: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-13T05:22:50.043: Row 10: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:791).
2025-10-13T05:22:50.043: Row 11: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-13T05:22:50.043: Row 12: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-13T05:22:50.043: Row 13: at h1.mc_api.doGet(mc_api.java:39).
2025-10-13T05:22:50.044: SUC: 2007, 223ms, lines: 13.
2025-10-13T05:22:50.044: checkJavaStack end: 2007, pid/ret=13.
2025-10-13T05:23:00.044: checkJavaStack starting: 2007.
2025-10-13T05:23:00.128: ------ test: 2007
2025-10-13T05:23:00.128: 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-13T05:23:00.366: Row 1: "https-openssl-nio-443-exec-1121" #505830 daemon prio=5 os_prio=0 tid=0x00007f569c0f7000 nid=0x2d6 runnable [0x00007f5637ffc000].
2025-10-13T05:23:00.366: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-13T05:23:00.366: Row 3: at h2.core2021.semanticSimilarity_v3(core2021.java:1396).
2025-10-13T05:23:00.366: Row 4: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-13T05:23:00.366: Row 5: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:791).
2025-10-13T05:23:00.367: Row 6: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-13T05:23:00.367: Row 7: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-13T05:23:00.367: Row 8: at h1.mc_api.doGet(mc_api.java:39).
2025-10-13T05:23:00.370: SUC: 2007, 241ms, lines: 8.
2025-10-13T05:23:00.370: checkJavaStack end: 2007, pid/ret=8.
2025-10-13T05:23:10.370: checkJavaStack starting: 2007.
2025-10-13T05:23:10.486: ------ test: 2007
2025-10-13T05:23:10.486: 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-13T05:23:10.731: Row 1: "https-openssl-nio-443-exec-1121" #505830 daemon prio=5 os_prio=0 tid=0x00007f569c0f7000 nid=0x2d6 runnable [0x00007f5637ffc000].
2025-10-13T05:23:10.731: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-13T05:23:10.731: Row 3: at h1.body.wordToBody(body.java:294).
2025-10-13T05:23:10.731: Row 4: at h2.core2021.semanticSimilarity_v3(core2021.java:1373).
2025-10-13T05:23:10.731: Row 5: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-13T05:23:10.731: Row 6: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:791).
2025-10-13T05:23:10.731: Row 7: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-13T05:23:10.732: Row 8: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-13T05:23:10.732: Row 9: at h1.mc_api.doGet(mc_api.java:39).
2025-10-13T05:23:10.733: SUC: 2007, 247ms, lines: 9.
2025-10-13T05:23:10.734: checkJavaStack end: 2007, pid/ret=9.
2025-10-13T05:23:20.734: checkJavaStack starting: 2007.
2025-10-13T05:23:20.821: ------ test: 2007
2025-10-13T05:23:20.821: 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-13T05:23:21.078: Row 1: "https-openssl-nio-443-exec-1121" #505830 daemon prio=5 os_prio=0 tid=0x00007f569c0f7000 nid=0x2d6 runnable [0x00007f5637ffc000].
2025-10-13T05:23:21.079: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-13T05:23:21.079: Row 3: at java.lang.String.split(String.java:2354).
2025-10-13T05:23:21.079: Row 4: at java.lang.String.split(String.java:2422).
2025-10-13T05:23:21.079: Row 5: at h2.core2021.networkMatchSuperFast(core2021.java:3159).
2025-10-13T05:23:21.079: Row 6: at h2.core2021.semanticSimilarity_v3(core2021.java:1422).
2025-10-13T05:23:21.079: Row 7: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-13T05:23:21.079: Row 8: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:791).
2025-10-13T05:23:21.079: Row 9: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-13T05:23:21.079: Row 10: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-13T05:23:21.079: Row 11: at h1.mc_api.doGet(mc_api.java:39).
2025-10-13T05:23:21.080: SUC: 2007, 259ms, lines: 11.
2025-10-13T05:23:21.081: checkJavaStack end: 2007, pid/ret=11.
2025-10-13T05:23:31.081: checkJavaStack starting: 2007.
2025-10-13T05:23:31.170: ------ test: 2007
2025-10-13T05:23:31.170: 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-13T05:23:31.478: Row 1: "https-openssl-nio-443-exec-1130" #505888 daemon prio=5 os_prio=0 tid=0x00007f565c1ea800 nid=0x35f runnable [0x00007f564c2f0000].
2025-10-13T05:23:31.478: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-13T05:23:31.478: Row 3: at java.net.SocketInputStream.socketRead0(Native Method).
2025-10-13T05:23:31.478: Row 4: at java.net.SocketInputStream.socketRead(SocketInputStream.java:116).
2025-10-13T05:23:31.478: Row 5: at java.net.SocketInputStream.read(SocketInputStream.java:171).
2025-10-13T05:23:31.478: Row 6: at java.net.SocketInputStream.read(SocketInputStream.java:141).
2025-10-13T05:23:31.478: Row 7: at com.mysql.jdbc.util.ReadAheadInputStream.fill(ReadAheadInputStream.java:100).
2025-10-13T05:23:31.478: Row 8: at com.mysql.jdbc.util.ReadAheadInputStream.readFromUnderlyingStreamIfNecessary(ReadAheadInputStream.java:143).
2025-10-13T05:23:31.479: Row 9: at com.mysql.jdbc.util.ReadAheadInputStream.read(ReadAheadInputStream.java:173).
2025-10-13T05:23:31.479: Row 10: - locked <0x00000006a141a428> (a com.mysql.jdbc.util.ReadAheadInputStream).
2025-10-13T05:23:31.479: Row 11: at com.mysql.jdbc.MysqlIO.readFully(MysqlIO.java:2911).
2025-10-13T05:23:31.479: Row 12: at com.mysql.jdbc.MysqlIO.reuseAndReadPacket(MysqlIO.java:3337).
2025-10-13T05:23:31.479: Row 13: at com.mysql.jdbc.MysqlIO.reuseAndReadPacket(MysqlIO.java:3327).
2025-10-13T05:23:31.479: Row 14: at com.mysql.jdbc.MysqlIO.checkErrorPacket(MysqlIO.java:3814).
2025-10-13T05:23:31.479: Row 15: at com.mysql.jdbc.MysqlIO.sendCommand(MysqlIO.java:2435).
2025-10-13T05:23:31.479: Row 16: at com.mysql.jdbc.MysqlIO.sqlQueryDirect(MysqlIO.java:2582).
2025-10-13T05:23:31.479: Row 17: at com.mysql.jdbc.ConnectionImpl.execSQL(ConnectionImpl.java:2530).
2025-10-13T05:23:31.480: Row 18: - locked <0x00000006a1410a08> (a com.mysql.jdbc.JDBC4Connection).
2025-10-13T05:23:31.480: Row 19: at com.mysql.jdbc.PreparedStatement.executeInternal(PreparedStatement.java:1907).
2025-10-13T05:23:31.480: Row 20: - locked <0x00000006a1410a08> (a com.mysql.jdbc.JDBC4Connection).
2025-10-13T05:23:31.480: Row 21: at com.mysql.jdbc.PreparedStatement.executeQuery(PreparedStatement.java:2030).
2025-10-13T05:23:31.480: Row 22: - locked <0x00000006a1410a08> (a com.mysql.jdbc.JDBC4Connection).
2025-10-13T05:23:31.480: Row 23: at h2.helpers.check_pending_works(helpers.java:4945).
2025-10-13T05:23:31.481: Row 24: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-13T05:23:31.481: SUC: 2007, 311ms, lines: 36.
2025-10-13T05:23:31.481: checkJavaStack end: 2007, pid/ret=36.
2025-10-13T05:23:41.482: checkJavaStack starting: 2007.
2025-10-13T05:23:41.570: ------ test: 2007
2025-10-13T05:23:41.570: 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-13T05:23:41.815: Row 1: "https-openssl-nio-443-exec-1121" #505830 daemon prio=5 os_prio=0 tid=0x00007f569c0f7000 nid=0x2d6 runnable [0x00007f5637ffc000].
2025-10-13T05:23:41.815: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-13T05:23:41.815: Row 3: at java.lang.String.split(String.java:2354).
2025-10-13T05:23:41.815: Row 4: at java.lang.String.split(String.java:2422).
2025-10-13T05:23:41.815: Row 5: at h2.core2021.networkMatchSuperFast(core2021.java:3159).
2025-10-13T05:23:41.815: Row 6: at h2.core2021.semanticSimilarity_v3(core2021.java:1422).
2025-10-13T05:23:41.815: Row 7: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-13T05:23:41.816: Row 8: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:791).
2025-10-13T05:23:41.816: Row 9: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-13T05:23:41.816: Row 10: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-13T05:23:41.816: Row 11: at h1.mc_api.doGet(mc_api.java:39).
2025-10-13T05:23:41.818: SUC: 2007, 247ms, lines: 11.
2025-10-13T05:23:41.818: checkJavaStack end: 2007, pid/ret=11.
2025-10-13T05:23:51.818: checkJavaStack starting: 2007.
2025-10-13T05:23:51.906: ------ test: 2007
2025-10-13T05:23:51.906: 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-13T05:23:52.132: Row 1: "https-openssl-nio-443-exec-1121" #505830 daemon prio=5 os_prio=0 tid=0x00007f569c0f7000 nid=0x2d6 runnable [0x00007f5637ffc000].
2025-10-13T05:23:52.132: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-13T05:23:52.132: Row 3: at java.util.AbstractCollection.toArray(AbstractCollection.java:199).
2025-10-13T05:23:52.132: Row 4: at java.lang.String.split(String.java:2378).
2025-10-13T05:23:52.132: Row 5: at java.lang.String.split(String.java:2422).
2025-10-13T05:23:52.132: Row 6: at h2.core2021.semanticSimilarity_v3(core2021.java:1269).
2025-10-13T05:23:52.133: Row 7: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-13T05:23:52.133: Row 8: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:791).
2025-10-13T05:23:52.133: Row 9: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-13T05:23:52.133: Row 10: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-13T05:23:52.133: Row 11: at h1.mc_api.doGet(mc_api.java:39).
2025-10-13T05:23:52.134: SUC: 2007, 228ms, lines: 11.
2025-10-13T05:23:52.135: checkJavaStack end: 2007, pid/ret=11.
2025-10-13T05:24:02.135: checkJavaStack starting: 2007.
2025-10-13T05:24:02.223: ------ test: 2007
2025-10-13T05:24:02.223: 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-13T05:24:02.457: Row 1: "https-openssl-nio-443-exec-1121" #505830 daemon prio=5 os_prio=0 tid=0x00007f569c0f7000 nid=0x2d6 runnable [0x00007f5637ffc000].
2025-10-13T05:24:02.458: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-13T05:24:02.458: Row 3: at h2.core2021.semanticSimilarity_v3(core2021.java:1396).
2025-10-13T05:24:02.458: Row 4: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-13T05:24:02.458: Row 5: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:791).
2025-10-13T05:24:02.458: Row 6: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-13T05:24:02.458: Row 7: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-13T05:24:02.458: Row 8: at h1.mc_api.doGet(mc_api.java:39).
2025-10-13T05:24:02.461: SUC: 2007, 238ms, lines: 8.
2025-10-13T05:24:02.461: checkJavaStack end: 2007, pid/ret=8.
2025-10-13T05:24:12.462: checkJavaStack starting: 2007.
2025-10-13T05:24:12.575: ------ test: 2007
2025-10-13T05:24:12.575: 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-13T05:24:12.767: Row 1: "https-openssl-nio-443-exec-1121" #505830 daemon prio=5 os_prio=0 tid=0x00007f569c0f7000 nid=0x2d6 runnable [0x00007f5637ffc000].
2025-10-13T05:24:12.767: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-13T05:24:12.767: Row 3: at h1.body.wordToBody(body.java:288).
2025-10-13T05:24:12.767: Row 4: at h2.core2021.semanticSimilarity_v3(core2021.java:1397).
2025-10-13T05:24:12.767: Row 5: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-13T05:24:12.767: Row 6: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:791).
2025-10-13T05:24:12.768: Row 7: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-13T05:24:12.768: Row 8: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-13T05:24:12.768: Row 9: at h1.mc_api.doGet(mc_api.java:39).
2025-10-13T05:24:12.771: SUC: 2007, 196ms, lines: 9.
2025-10-13T05:24:12.771: checkJavaStack end: 2007, pid/ret=9.
2025-10-13T05:24:22.772: checkJavaStack starting: 2007.
2025-10-13T05:24:22.859: ------ test: 2007
2025-10-13T05:24:22.859: 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-13T05:24:23.079: Row 1: "https-openssl-nio-443-exec-1121" #505830 daemon prio=5 os_prio=0 tid=0x00007f569c0f7000 nid=0x2d6 runnable [0x00007f5637ffc000].
2025-10-13T05:24:23.079: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-13T05:24:23.079: Row 3: at java.lang.String.split(String.java:2354).
2025-10-13T05:24:23.079: Row 4: at java.lang.String.split(String.java:2422).
2025-10-13T05:24:23.079: Row 5: at h2.core2021.networkMatchSuperFast(core2021.java:3159).
2025-10-13T05:24:23.079: Row 6: at h2.core2021.semanticSimilarity_v3(core2021.java:1422).
2025-10-13T05:24:23.079: Row 7: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-13T05:24:23.079: Row 8: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:791).
2025-10-13T05:24:23.079: Row 9: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-13T05:24:23.079: Row 10: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-13T05:24:23.080: Row 11: at h1.mc_api.doGet(mc_api.java:39).
2025-10-13T05:24:23.081: SUC: 2007, 222ms, lines: 11.
2025-10-13T05:24:23.082: checkJavaStack end: 2007, pid/ret=11.
2025-10-13T05:24:33.082: checkJavaStack starting: 2007.
2025-10-13T05:24:33.171: ------ test: 2007
2025-10-13T05:24:33.171: 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-13T05:24:33.394: SUC: 2007, 223ms, lines: 4096.
2025-10-13T05:24:33.395: checkJavaStack end: 2007, pid/ret=4096.
2025-10-13T05:24:43.395: checkJavaStack starting: 2007.
2025-10-13T05:24:43.483: ------ test: 2007
2025-10-13T05:24:43.483: 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-13T05:24:43.738: SUC: 2007, 255ms, lines: 4096.
2025-10-13T05:24:43.739: checkJavaStack end: 2007, pid/ret=4096.
2025-10-13T05:24:53.739: checkJavaStack starting: 2007.
2025-10-13T05:24:53.828: ------ test: 2007
2025-10-13T05:24:53.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-13T05:24:54.079: Row 1: "https-openssl-nio-443-exec-1129" #505867 daemon prio=5 os_prio=0 tid=0x00007f5614530000 nid=0x30a runnable [0x00007f564c6f2000].
2025-10-13T05:24:54.080: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-13T05:24:54.080: Row 3: at h2.skills_compass.get_suggestion_with_interests(skills_compass.java:1449).
2025-10-13T05:24:54.080: Row 4: at h2.skills_compass.get_suggestion(skills_compass.java:23).
2025-10-13T05:24:54.080: Row 5: at h2.Utils.doPost(Utils.java:794).
2025-10-13T05:24:54.080: Row 6: at h2.Utils.doGet(Utils.java:30).
2025-10-13T05:24:54.082: SUC: 2007, 254ms, lines: 6.
2025-10-13T05:24:54.083: checkJavaStack end: 2007, pid/ret=6.
2025-10-13T05:25:04.083: checkJavaStack starting: 2007.
2025-10-13T05:25:04.172: ------ test: 2007
2025-10-13T05:25:04.172: 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-13T05:25:04.394: SUC: 2007, 222ms, lines: 4096.
2025-10-13T05:25:04.395: checkJavaStack end: 2007, pid/ret=4096.
2025-10-13T05:25:14.395: checkJavaStack starting: 2007.
2025-10-13T05:25:14.510: ------ test: 2007
2025-10-13T05:25:14.510: 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-13T05:25:14.743: SUC: 2007, 232ms, lines: 4096.
2025-10-13T05:25:14.743: checkJavaStack end: 2007, pid/ret=4096.
2025-10-13T05:25:24.743: checkJavaStack starting: 2007.
2025-10-13T05:25:24.833: ------ test: 2007
2025-10-13T05:25:24.833: 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-13T05:25:25.028: SUC: 2007, 195ms, lines: 4096.
2025-10-13T05:25:25.028: checkJavaStack end: 2007, pid/ret=4096.
2025-10-13T05:25:35.029: checkJavaStack starting: 2007.
2025-10-13T05:25:35.116: ------ test: 2007
2025-10-13T05:25:35.117: 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-13T05:25:35.369: SUC: 2007, 253ms, lines: 4096.
2025-10-13T05:25:35.369: checkJavaStack end: 2007, pid/ret=4096.
2025-10-13T05:25:45.370: checkJavaStack starting: 2007.
2025-10-13T05:25:45.455: ------ test: 2007
2025-10-13T05:25:45.455: 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-13T05:25:45.655: SUC: 2007, 200ms, lines: 4096.
2025-10-13T05:25:45.655: checkJavaStack end: 2007, pid/ret=4096.
2025-10-13T05:25:55.655: checkJavaStack starting: 2007.
2025-10-13T05:25:55.739: ------ test: 2007
2025-10-13T05:25:55.739: 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-13T05:25:55.932: SUC: 2007, 193ms, lines: 4096.
2025-10-13T05:25:55.932: checkJavaStack end: 2007, pid/ret=4096.
2025-10-13T05:26:05.933: checkJavaStack starting: 2007.
2025-10-13T05:26:06.017: ------ test: 2007
2025-10-13T05:26:06.017: 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-13T05:26:06.227: Row 1: "https-openssl-nio-443-exec-1129" #505867 daemon prio=5 os_prio=0 tid=0x00007f5614530000 nid=0x30a runnable [0x00007f564c6f2000].
2025-10-13T05:26:06.227: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-13T05:26:06.227: Row 3: at java.net.SocketInputStream.socketRead0(Native Method).
2025-10-13T05:26:06.227: Row 4: at java.net.SocketInputStream.socketRead(SocketInputStream.java:116).
2025-10-13T05:26:06.227: Row 5: at java.net.SocketInputStream.read(SocketInputStream.java:171).
2025-10-13T05:26:06.227: Row 6: at java.net.SocketInputStream.read(SocketInputStream.java:141).
2025-10-13T05:26:06.227: Row 7: at com.mysql.jdbc.util.ReadAheadInputStream.fill(ReadAheadInputStream.java:100).
2025-10-13T05:26:06.227: Row 8: at com.mysql.jdbc.util.ReadAheadInputStream.readFromUnderlyingStreamIfNecessary(ReadAheadInputStream.java:143).
2025-10-13T05:26:06.227: Row 9: at com.mysql.jdbc.util.ReadAheadInputStream.read(ReadAheadInputStream.java:173).
2025-10-13T05:26:06.228: Row 10: - locked <0x0000000756752c00> (a com.mysql.jdbc.util.ReadAheadInputStream).
2025-10-13T05:26:06.228: Row 11: at com.mysql.jdbc.MysqlIO.readFully(MysqlIO.java:2911).
2025-10-13T05:26:06.228: Row 12: at com.mysql.jdbc.MysqlIO.reuseAndReadPacket(MysqlIO.java:3337).
2025-10-13T05:26:06.228: Row 13: at com.mysql.jdbc.MysqlIO.reuseAndReadPacket(MysqlIO.java:3327).
2025-10-13T05:26:06.228: Row 14: at com.mysql.jdbc.MysqlIO.checkErrorPacket(MysqlIO.java:3814).
2025-10-13T05:26:06.228: Row 15: at com.mysql.jdbc.MysqlIO.sendCommand(MysqlIO.java:2435).
2025-10-13T05:26:06.228: Row 16: at com.mysql.jdbc.MysqlIO.sqlQueryDirect(MysqlIO.java:2582).
2025-10-13T05:26:06.228: Row 17: at com.mysql.jdbc.ConnectionImpl.execSQL(ConnectionImpl.java:2530).
2025-10-13T05:26:06.228: Row 18: - locked <0x0000000756749218> (a com.mysql.jdbc.JDBC4Connection).
2025-10-13T05:26:06.228: Row 19: at com.mysql.jdbc.PreparedStatement.executeInternal(PreparedStatement.java:1907).
2025-10-13T05:26:06.228: Row 20: - locked <0x0000000756749218> (a com.mysql.jdbc.JDBC4Connection).
2025-10-13T05:26:06.228: Row 21: at com.mysql.jdbc.PreparedStatement.executeQuery(PreparedStatement.java:2030).
2025-10-13T05:26:06.228: Row 22: - locked <0x0000000756749218> (a com.mysql.jdbc.JDBC4Connection).
2025-10-13T05:26:06.228: Row 23: at h2.helpers.check_pending_works(helpers.java:4945).
2025-10-13T05:26:06.229: Row 24: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-13T05:26:06.248: SUC: 2007, 231ms, lines: 69.
2025-10-13T05:26:06.248: checkJavaStack end: 2007, pid/ret=69.
2025-10-13T05:26:16.248: checkJavaStack starting: 2007.
2025-10-13T05:26:16.376: ------ test: 2007
2025-10-13T05:26:16.376: 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-13T05:26:16.591: SUC: 2007, 215ms, lines: 4096.
2025-10-13T05:26:16.592: checkJavaStack end: 2007, pid/ret=4096.
2025-10-13T05:26:26.592: checkJavaStack starting: 2007.
2025-10-13T05:26:26.680: ------ test: 2007
2025-10-13T05:26:26.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-13T05:26:26.887: SUC: 2007, 207ms, lines: 4096.
2025-10-13T05:26:26.888: checkJavaStack end: 2007, pid/ret=4096.
2025-10-13T05:26:26.890: ------ test: end, 321852ms. Score 39/39.
2025-10-13T05:26:26.892: Test duration: 5m21s.