2025-10-12T13:21:04.800: current working dir: /root/qa/mctester.
2025-10-12T13:21:04.845: current logging dir: ../mctester/www.
2025-10-12T13:21:04.845: ---------------------------------------------------------------
2025-10-12T13:21:04.851: mctester entry: 2025-10-12T13:21:04.846072 mode=50
2025-10-12T13:21:04.852: ---------------------------------------------------------------
2025-10-12T13:21:04.923: EXE: 1/git describe --tags.
2025-10-12T13:21:04.934: Row 1: v1.1-493-g334079e.
2025-10-12T13:21:04.936: EXE: 1/git rev-list --count HEAD.
2025-10-12T13:21:04.944: Row 1: 550.
2025-10-12T13:21:04.944: EXE: 1/git rev-parse HEAD.
2025-10-12T13:21:04.947: Row 1: 334079e0023fd6b85febe0f6cd19139cfdea0dc1.
2025-10-12T13:21:04.955: mctester: v1.1.550 (334079e0023fd6b85febe0f6cd19139cfdea0dc1).
2025-10-12T13:21:04.956: Entering into a performance tests mode.
2025-10-12T13:21:04.957: ------ test: start, 2025-10-12T13:21:04.956
2025-10-12T13:21:04.959: ------ test: 2000
2025-10-12T13:21:04.960: CMD: ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "top -b -n 1"
2025-10-12T13:21:04.960: EXE: 1/ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "top -b -n 1".
2025-10-12T13:21:05.248: Row 1: top - 13:21:05 up 133 days, 3:08, 0 users, load average: 0.26, 0.50, 1.22.
2025-10-12T13:21:05.249: Row 2: Tasks: 534 total, 1 running, 533 sleeping, 0 stopped, 0 zombie.
2025-10-12T13:21:05.249: 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-12T13:21:05.249: Row 4: KiB Mem : 13202036+total, 704760 free, 66483220 used, 64832392 buff/cache.
2025-10-12T13:21:05.249: Row 5: KiB Swap: 0 total, 0 free, 0 used. 64538352 avail Mem .
2025-10-12T13:21:05.250: Row 6: .
2025-10-12T13:21:05.250: Row 7: PID USER PR NI VIRT RES SHR S %CPU %MEM TIME+ COMMAND.
2025-10-12T13:21:05.250: Row 8: 89817 root 20 0 22.425g 0.010t 38148 S 487.5 8.5 18094:46 java.
2025-10-12T13:21:05.250: Row 9: 24108 root 20 0 44056 4096 3152 R 6.2 0.0 0:00.01 top.
2025-10-12T13:21:05.251: Row 10: 1 root 20 0 43692 4144 2780 S 0.0 0.0 6:56.20 init.
2025-10-12T13:21:05.251: Row 11: 2 root 20 0 0 0 0 S 0.0 0.0 0:00.91 kthreadd.
2025-10-12T13:21:05.251: Row 12: 3 root 20 0 0 0 0 S 0.0 0.0 0:46.73 ksoftirqd+.
2025-10-12T13:21:05.252: Row 13: 4 root 20 0 0 0 0 S 0.0 0.0 0:00.00 kworker/0+.
2025-10-12T13:21:05.252: Row 14: 5 root 0 -20 0 0 0 S 0.0 0.0 0:00.00 kworker/0+.
2025-10-12T13:21:05.252: Row 15: 7 root 20 0 0 0 0 S 0.0 0.0 57:08.49 rcu_sched.
2025-10-12T13:21:05.252: Row 16: 8 root 20 0 0 0 0 S 0.0 0.0 0:00.00 rcu_bh.
2025-10-12T13:21:05.253: Row 17: 9 root rt 0 0 0 0 S 0.0 0.0 0:02.61 migration+.
2025-10-12T13:21:05.253: Row 18: 10 root rt 0 0 0 0 S 0.0 0.0 0:32.28 watchdog/0.
2025-10-12T13:21:05.253: Row 19: 11 root rt 0 0 0 0 S 0.0 0.0 0:31.34 watchdog/1.
2025-10-12T13:21:05.253: Row 20: 12 root rt 0 0 0 0 S 0.0 0.0 0:10.82 migration+.
2025-10-12T13:21:05.253: Row 21: 13 root 20 0 0 0 0 S 0.0 0.0 0:02.34 ksoftirqd+.
2025-10-12T13:21:05.254: Row 22: 14 root 20 0 0 0 0 S 0.0 0.0 0:00.00 kworker/1+.
2025-10-12T13:21:05.254: Row 23: 15 root 0 -20 0 0 0 S 0.0 0.0 0:00.00 kworker/1+.
2025-10-12T13:21:05.254: Row 24: 16 root rt 0 0 0 0 S 0.0 0.0 0:31.56 watchdog/2.
2025-10-12T13:21:05.321: SUC: 355ms Uptime 133 days, 1min 0.26, 5min 0.50, 15min 1.22, mem:132020360 total / 704760 free / 66483220 used / 64832392 cache / 64538352 avail
2025-10-12T13:21:05.331: ------ test: 2001
2025-10-12T13:21:05.331: CMD: top -b -E k -n 1
2025-10-12T13:21:05.332: EXE: 1/top -b -E k -n 1.
2025-10-12T13:21:05.490: Row 1: top - 13:21:05 up 48 days, 3:34, 0 users, load average: 3.31, 3.82, 3.94.
2025-10-12T13:21:05.490: Row 2: Tasks: 168 total, 1 running, 165 sleeping, 1 stopped, 1 zombie.
2025-10-12T13:21:05.490: Row 3: %Cpu(s): 6.5 us, 0.0 sy, 0.0 ni, 93.5 id, 0.0 wa, 0.0 hi, 0.0 si, 0.0 st.
2025-10-12T13:21:05.490: Row 4: KiB Mem : 16480104 total, 5338316 free, 1242564 used, 9899224 buff/cache.
2025-10-12T13:21:05.491: Row 5: KiB Swap: 0 total, 0 free, 0 used. 14799504 avail Mem .
2025-10-12T13:21:05.491: Row 6: .
2025-10-12T13:21:05.491: Row 7: PID USER PR NI VIRT RES SHR S %CPU %MEM TIME+ COMMAND.
2025-10-12T13:21:05.491: Row 8: 2525370 root 20 0 4977416 78492 27224 S 43.8 0.5 0:01.08 java.
2025-10-12T13:21:05.491: Row 9: 1 root 20 0 167780 13280 8396 S 0.0 0.1 1:20.08 systemd.
2025-10-12T13:21:05.492: Row 10: 2 root 20 0 0 0 0 S 0.0 0.0 0:00.48 kthreadd.
2025-10-12T13:21:05.492: Row 11: 3 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 rcu_gp.
2025-10-12T13:21:05.492: Row 12: 4 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 rcu_par+.
2025-10-12T13:21:05.492: Row 13: 5 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 slub_fl+.
2025-10-12T13:21:05.492: Row 14: 6 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 netns.
2025-10-12T13:21:05.492: Row 15: 8 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 kworker+.
2025-10-12T13:21:05.493: Row 16: 10 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 mm_perc+.
2025-10-12T13:21:05.493: Row 17: 11 root 20 0 0 0 0 S 0.0 0.0 0:00.00 rcu_tas+.
2025-10-12T13:21:05.493: Row 18: 12 root 20 0 0 0 0 S 0.0 0.0 0:00.00 rcu_tas+.
2025-10-12T13:21:05.493: Row 19: 13 root 20 0 0 0 0 S 0.0 0.0 0:00.83 ksoftir+.
2025-10-12T13:21:05.493: Row 20: 14 root 20 0 0 0 0 I 0.0 0.0 2:03.88 rcu_sch+.
2025-10-12T13:21:05.494: Row 21: 15 root rt 0 0 0 0 S 0.0 0.0 0:09.40 migrati+.
2025-10-12T13:21:05.494: Row 22: 16 root -51 0 0 0 0 S 0.0 0.0 0:00.00 idle_in+.
2025-10-12T13:21:05.494: Row 23: 18 root 20 0 0 0 0 S 0.0 0.0 0:00.00 cpuhp/0.
2025-10-12T13:21:05.494: Row 24: 19 root 20 0 0 0 0 S 0.0 0.0 0:00.00 cpuhp/1.
2025-10-12T13:21:05.502: SUC: 171ms Uptime 48 days, 1min 3.31, 5min 3.82, 15min 3.94, mem:16480104 total / 5338316 free / 1242564 used / 9899224 cache / 14799504 avail
2025-10-12T13:21:05.503: ------ test: 2002
2025-10-12T13:21:05.503: CMD: df -h
2025-10-12T13:21:05.503: EXE: 1/df -h.
2025-10-12T13:21:05.505: Row 1: Filesystem Size Used Avail Use% Mounted on.
2025-10-12T13:21:05.505: Row 2: tmpfs 791M 82M 710M 11% /run.
2025-10-12T13:21:05.505: Row 3: /dev/vda2 30G 24G 4.4G 85% /.
2025-10-12T13:21:05.505: Row 4: tmpfs 3.9G 0 3.9G 0% /dev/shm.
2025-10-12T13:21:05.505: Row 5: tmpfs 5.0M 0 5.0M 0% /run/lock.
2025-10-12T13:21:05.507: SUC: 4ms Diskfree qa.headai.com: tmpfs:11%, /dev/vda2:85%, tmpfs:0%, tmpfs:0%.
2025-10-12T13:21:05.508: ------ test: 2003
2025-10-12T13:21:05.508: CMD: ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "df -h"
2025-10-12T13:21:05.508: EXE: 1/ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "df -h".
2025-10-12T13:21:05.610: Row 1: Filesystem Size Used Avail Use% Mounted on.
2025-10-12T13:21:05.610: Row 2: udev 63G 4.0K 63G 1% /dev.
2025-10-12T13:21:05.610: Row 3: tmpfs 13G 5.5M 13G 1% /run.
2025-10-12T13:21:05.610: Row 4: /dev/vda1 757G 305G 421G 42% /.
2025-10-12T13:21:05.610: Row 5: none 4.0K 0 4.0K 0% /sys/fs/cgroup.
2025-10-12T13:21:05.611: Row 6: none 5.0M 0 5.0M 0% /run/lock.
2025-10-12T13:21:05.611: Row 7: none 63G 0 63G 0% /run/shm.
2025-10-12T13:21:05.611: Row 8: none 100M 0 100M 0% /run/user.
2025-10-12T13:21:05.611: Row 9: cgmfs 100K 0 100K 0% /run/cgmanager/fs.
2025-10-12T13:21:05.611: Row 10: /dev/vdb 985G 275G 661G 30% /opt/tomcat/webapps/ROOT/analysis.
2025-10-12T13:21:05.611: Row 11: tmpfs 100K 0 100K 0% /var/lib/lxd/shmounts.
2025-10-12T13:21:05.612: Row 12: tmpfs 100K 0 100K 0% /var/lib/lxd/devlxd.
2025-10-12T13:21:05.612: SUC: 104ms 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-12T13:21:05.613: ------ test: 2004
2025-10-12T13:21:05.613: URL: https://headai.com
2025-10-12T13:21:06.560: SUC: 937ms, 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-12T13:21:06.561: ------ test: 2005
2025-10-12T13:21:06.794: SQL: show global status like 'threads_connected';.
2025-10-12T13:21:06.821: Results: value=3/200.
2025-10-12T13:21:06.827: SQL: value, lines: 1, ret=1, 3.
2025-10-12T13:21:06.827: SUC: 266ms 3
2025-10-12T13:21:06.828: ------ test: 2006
2025-10-12T13:21:06.907: SQL: SHOW PROCESSLIST;.
2025-10-12T13:21:06.912: Row 1: 54047640,root,localhost:56654,analysis,Query,0,Sending data,SELECT SUBSTRING_INDEX(token, '||', 1) as token_clean, count(id) as count FROM analysis.long_queries.
2025-10-12T13:21:06.912: Row 2: 54047641,root,localhost:56656,null,Query,0,starting,SHOW PROCESSLIST.
2025-10-12T13:21:06.912: SQL: COUNTNOTLINES:Command, lines: 2, ret=2, 2.
2025-10-12T13:21:06.912: SUC: 84ms 2
2025-10-12T13:21:06.913: checkJavaStack starting: 2007.
2025-10-12T13:21:07.008: ------ test: 2007
2025-10-12T13:21:07.008: 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-12T13:21:07.270: Row 1: "https-openssl-nio-443-exec-1119" #505815 daemon prio=5 os_prio=0 tid=0x00007f568c5a5000 nid=0x2c5 runnable [0x00007f5637cf9000].
2025-10-12T13:21:07.271: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-12T13:21:07.271: Row 3: at java.lang.String.indexOf(String.java:1769).
2025-10-12T13:21:07.271: Row 4: at java.lang.String.indexOf(String.java:1718).
2025-10-12T13:21:07.271: Row 5: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5362).
2025-10-12T13:21:07.272: Row 6: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5318).
2025-10-12T13:21:07.272: Row 7: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5258).
2025-10-12T13:21:07.272: Row 8: at h2.core2021.semanticSimilarity_v3(core2021.java:1402).
2025-10-12T13:21:07.272: Row 9: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-12T13:21:07.272: Row 10: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:791).
2025-10-12T13:21:07.272: Row 11: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-12T13:21:07.272: Row 12: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-12T13:21:07.272: Row 13: at h1.mc_api.doGet(mc_api.java:39).
2025-10-12T13:21:07.273: SUC: 2007, 265ms, lines: 13.
2025-10-12T13:21:07.275: checkJavaStack end: 2007, pid/ret=13.
2025-10-12T13:21:17.276: checkJavaStack starting: 2007.
2025-10-12T13:21:17.364: ------ test: 2007
2025-10-12T13:21:17.364: 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-12T13:21:17.588: Row 1: "https-openssl-nio-443-exec-1119" #505815 daemon prio=5 os_prio=0 tid=0x00007f568c5a5000 nid=0x2c5 runnable [0x00007f5637cf9000].
2025-10-12T13:21:17.589: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-12T13:21:17.589: Row 3: at h1.body.wordToBody(body.java:286).
2025-10-12T13:21:17.589: Row 4: at h2.core2021.semanticSimilarity_v3(core2021.java:1397).
2025-10-12T13:21:17.589: Row 5: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-12T13:21:17.589: Row 6: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:791).
2025-10-12T13:21:17.589: Row 7: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-12T13:21:17.589: Row 8: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-12T13:21:17.590: Row 9: at h1.mc_api.doGet(mc_api.java:39).
2025-10-12T13:21:17.592: SUC: 2007, 228ms, lines: 9.
2025-10-12T13:21:17.592: checkJavaStack end: 2007, pid/ret=9.
2025-10-12T13:21:27.593: checkJavaStack starting: 2007.
2025-10-12T13:21:27.678: ------ test: 2007
2025-10-12T13:21:27.679: 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-12T13:21:27.896: SUC: 2007, 217ms, lines: 4096.
2025-10-12T13:21:27.897: checkJavaStack end: 2007, pid/ret=4096.
2025-10-12T13:21:37.897: checkJavaStack starting: 2007.
2025-10-12T13:21:37.988: ------ test: 2007
2025-10-12T13:21:37.988: 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-12T13:21:38.213: Row 1: "https-openssl-nio-443-exec-1131" #506713 daemon prio=5 os_prio=0 tid=0x00007f562013d000 nid=0xc3e runnable [0x00007f56379f6000].
2025-10-12T13:21:38.214: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-12T13:21:38.214: Row 3: at h2.core2021.semanticSimilarity_v3(core2021.java:1396).
2025-10-12T13:21:38.214: Row 4: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-12T13:21:38.214: Row 5: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:791).
2025-10-12T13:21:38.214: Row 6: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-12T13:21:38.214: Row 7: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-12T13:21:38.214: Row 8: at h1.mc_api.doGet(mc_api.java:39).
2025-10-12T13:21:38.216: SUC: 2007, 228ms, lines: 8.
2025-10-12T13:21:38.217: checkJavaStack end: 2007, pid/ret=8.
2025-10-12T13:21:48.217: checkJavaStack starting: 2007.
2025-10-12T13:21:48.302: ------ test: 2007
2025-10-12T13:21:48.302: 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-12T13:21:48.577: Row 1: "https-openssl-nio-443-exec-1131" #506713 daemon prio=5 os_prio=0 tid=0x00007f562013d000 nid=0xc3e runnable [0x00007f56379f6000].
2025-10-12T13:21:48.578: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-12T13:21:48.578: Row 3: at h2.core2021.semanticSimilarity_v3(core2021.java:1400).
2025-10-12T13:21:48.578: Row 4: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-12T13:21:48.578: Row 5: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:791).
2025-10-12T13:21:48.578: Row 6: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-12T13:21:48.578: Row 7: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-12T13:21:48.578: Row 8: at h1.mc_api.doGet(mc_api.java:39).
2025-10-12T13:21:48.579: SUC: 2007, 277ms, lines: 8.
2025-10-12T13:21:48.580: checkJavaStack end: 2007, pid/ret=8.
2025-10-12T13:21:58.580: checkJavaStack starting: 2007.
2025-10-12T13:21:58.666: ------ test: 2007
2025-10-12T13:21:58.666: 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-12T13:21:58.867: Row 1: "https-openssl-nio-443-exec-1131" #506713 daemon prio=5 os_prio=0 tid=0x00007f562013d000 nid=0xc3e runnable [0x00007f56379f6000].
2025-10-12T13:21:58.867: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-12T13:21:58.867: Row 3: at h1.body.wordToBody(body.java:303).
2025-10-12T13:21:58.867: Row 4: at h2.core2021.semanticSimilarity_v3(core2021.java:1373).
2025-10-12T13:21:58.867: Row 5: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-12T13:21:58.868: Row 6: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:791).
2025-10-12T13:21:58.868: Row 7: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-12T13:21:58.868: Row 8: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-12T13:21:58.868: Row 9: at h1.mc_api.doGet(mc_api.java:39).
2025-10-12T13:21:58.869: SUC: 2007, 203ms, lines: 9.
2025-10-12T13:21:58.870: checkJavaStack end: 2007, pid/ret=9.
2025-10-12T13:22:08.870: checkJavaStack starting: 2007.
2025-10-12T13:22:08.984: ------ test: 2007
2025-10-12T13:22:08.984: 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-12T13:22:09.227: Row 1: "https-openssl-nio-443-exec-1131" #506713 daemon prio=5 os_prio=0 tid=0x00007f562013d000 nid=0xc3e runnable [0x00007f56379f6000].
2025-10-12T13:22:09.227: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-12T13:22:09.228: Row 3: at h1.body.wordToBody(body.java:318).
2025-10-12T13:22:09.228: Row 4: at h2.core2021.semanticSimilarity_v3(core2021.java:1397).
2025-10-12T13:22:09.228: Row 5: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-12T13:22:09.228: Row 6: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:791).
2025-10-12T13:22:09.228: Row 7: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-12T13:22:09.228: Row 8: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-12T13:22:09.228: Row 9: at h1.mc_api.doGet(mc_api.java:39).
2025-10-12T13:22:09.230: SUC: 2007, 245ms, lines: 9.
2025-10-12T13:22:09.230: checkJavaStack end: 2007, pid/ret=9.
2025-10-12T13:22:19.230: checkJavaStack starting: 2007.
2025-10-12T13:22:19.319: ------ test: 2007
2025-10-12T13:22:19.319: 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-12T13:22:19.510: Row 1: "https-openssl-nio-443-exec-1131" #506713 daemon prio=5 os_prio=0 tid=0x00007f562013d000 nid=0xc3e runnable [0x00007f56379f6000].
2025-10-12T13:22:19.510: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-12T13:22:19.510: Row 3: at h2.core2021.semanticSimilarity_v3(core2021.java:1396).
2025-10-12T13:22:19.510: Row 4: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-12T13:22:19.510: Row 5: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:791).
2025-10-12T13:22:19.511: Row 6: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-12T13:22:19.511: Row 7: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-12T13:22:19.511: Row 8: at h1.mc_api.doGet(mc_api.java:39).
2025-10-12T13:22:19.530: SUC: 2007, 211ms, lines: 8.
2025-10-12T13:22:19.531: checkJavaStack end: 2007, pid/ret=8.
2025-10-12T13:22:29.531: checkJavaStack starting: 2007.
2025-10-12T13:22:29.617: ------ test: 2007
2025-10-12T13:22:29.618: 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-12T13:22:29.822: Row 1: "https-openssl-nio-443-exec-1131" #506713 daemon prio=5 os_prio=0 tid=0x00007f562013d000 nid=0xc3e runnable [0x00007f56379f6000].
2025-10-12T13:22:29.822: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-12T13:22:29.822: Row 3: at h1.body.wordToBody(body.java:286).
2025-10-12T13:22:29.822: Row 4: at h2.core2021.semanticSimilarity_v3(core2021.java:1397).
2025-10-12T13:22:29.823: Row 5: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-12T13:22:29.823: Row 6: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:791).
2025-10-12T13:22:29.823: Row 7: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-12T13:22:29.823: Row 8: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-12T13:22:29.823: Row 9: at h1.mc_api.doGet(mc_api.java:39).
2025-10-12T13:22:29.825: SUC: 2007, 207ms, lines: 9.
2025-10-12T13:22:29.825: checkJavaStack end: 2007, pid/ret=9.
2025-10-12T13:22:39.826: checkJavaStack starting: 2007.
2025-10-12T13:22:39.915: ------ test: 2007
2025-10-12T13:22:39.915: 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-12T13:22:40.148: Row 1: "https-openssl-nio-443-exec-1131" #506713 daemon prio=5 os_prio=0 tid=0x00007f562013d000 nid=0xc3e runnable [0x00007f56379f6000].
2025-10-12T13:22:40.148: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-12T13:22:40.148: Row 3: at java.lang.String.indexOf(String.java:1769).
2025-10-12T13:22:40.148: Row 4: at java.lang.String.indexOf(String.java:1718).
2025-10-12T13:22:40.148: Row 5: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5362).
2025-10-12T13:22:40.148: Row 6: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5318).
2025-10-12T13:22:40.148: Row 7: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5258).
2025-10-12T13:22:40.148: Row 8: at h2.core2021.semanticSimilarity_v3(core2021.java:1413).
2025-10-12T13:22:40.148: Row 9: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-12T13:22:40.149: Row 10: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:791).
2025-10-12T13:22:40.149: Row 11: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-12T13:22:40.149: Row 12: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-12T13:22:40.149: Row 13: at h1.mc_api.doGet(mc_api.java:39).
2025-10-12T13:22:40.152: SUC: 2007, 237ms, lines: 13.
2025-10-12T13:22:40.153: checkJavaStack end: 2007, pid/ret=13.
2025-10-12T13:22:50.153: checkJavaStack starting: 2007.
2025-10-12T13:22:50.238: ------ test: 2007
2025-10-12T13:22:50.238: 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-12T13:22:50.448: Row 1: "https-openssl-nio-443-exec-1131" #506713 daemon prio=5 os_prio=0 tid=0x00007f562013d000 nid=0xc3e runnable [0x00007f56379f6000].
2025-10-12T13:22:50.448: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-12T13:22:50.449: Row 3: at h1.body.wordToBody(body.java:286).
2025-10-12T13:22:50.449: Row 4: at h2.core2021.semanticSimilarity_v3(core2021.java:1397).
2025-10-12T13:22:50.449: Row 5: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-12T13:22:50.449: Row 6: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:791).
2025-10-12T13:22:50.449: Row 7: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-12T13:22:50.449: Row 8: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-12T13:22:50.449: Row 9: at h1.mc_api.doGet(mc_api.java:39).
2025-10-12T13:22:50.452: SUC: 2007, 214ms, lines: 9.
2025-10-12T13:22:50.452: checkJavaStack end: 2007, pid/ret=9.
2025-10-12T13:23:00.452: checkJavaStack starting: 2007.
2025-10-12T13:23:00.539: ------ test: 2007
2025-10-12T13:23:00.539: 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-12T13:23:00.760: Row 1: "https-openssl-nio-443-exec-1131" #506713 daemon prio=5 os_prio=0 tid=0x00007f562013d000 nid=0xc3e runnable [0x00007f56379f6000].
2025-10-12T13:23:00.760: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-12T13:23:00.760: Row 3: at h1.body.wordToBody(body.java:289).
2025-10-12T13:23:00.760: Row 4: at h2.core2021.semanticSimilarity_v3(core2021.java:1397).
2025-10-12T13:23:00.761: Row 5: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-12T13:23:00.761: Row 6: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:791).
2025-10-12T13:23:00.761: Row 7: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-12T13:23:00.761: Row 8: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-12T13:23:00.761: Row 9: at h1.mc_api.doGet(mc_api.java:39).
2025-10-12T13:23:00.764: SUC: 2007, 225ms, lines: 9.
2025-10-12T13:23:00.764: checkJavaStack end: 2007, pid/ret=9.
2025-10-12T13:23:10.764: checkJavaStack starting: 2007.
2025-10-12T13:23:10.879: ------ test: 2007
2025-10-12T13:23:10.879: 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-12T13:23:11.104: Row 1: "https-openssl-nio-443-exec-1131" #506713 daemon prio=5 os_prio=0 tid=0x00007f562013d000 nid=0xc3e runnable [0x00007f56379f6000].
2025-10-12T13:23:11.105: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-12T13:23:11.105: Row 3: at h1.body.wordToBody(body.java:286).
2025-10-12T13:23:11.105: Row 4: at h2.core2021.semanticSimilarity_v3(core2021.java:1397).
2025-10-12T13:23:11.105: Row 5: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-12T13:23:11.105: Row 6: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:791).
2025-10-12T13:23:11.105: Row 7: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-12T13:23:11.105: Row 8: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-12T13:23:11.105: Row 9: at h1.mc_api.doGet(mc_api.java:39).
2025-10-12T13:23:11.108: SUC: 2007, 229ms, lines: 9.
2025-10-12T13:23:11.108: checkJavaStack end: 2007, pid/ret=9.
2025-10-12T13:23:21.109: checkJavaStack starting: 2007.
2025-10-12T13:23:21.194: ------ test: 2007
2025-10-12T13:23:21.194: 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-12T13:23:21.415: Row 1: "https-openssl-nio-443-exec-1134" #521838 daemon prio=5 os_prio=0 tid=0x00007f563805c000 nid=0xaad5 runnable [0x00007f56377f5000].
2025-10-12T13:23:21.415: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-12T13:23:21.415: Row 3: at java.net.SocketInputStream.socketRead0(Native Method).
2025-10-12T13:23:21.416: Row 4: at java.net.SocketInputStream.socketRead(SocketInputStream.java:116).
2025-10-12T13:23:21.416: Row 5: at java.net.SocketInputStream.read(SocketInputStream.java:171).
2025-10-12T13:23:21.416: Row 6: at java.net.SocketInputStream.read(SocketInputStream.java:141).
2025-10-12T13:23:21.416: Row 7: at com.mysql.jdbc.util.ReadAheadInputStream.fill(ReadAheadInputStream.java:100).
2025-10-12T13:23:21.416: Row 8: at com.mysql.jdbc.util.ReadAheadInputStream.readFromUnderlyingStreamIfNecessary(ReadAheadInputStream.java:143).
2025-10-12T13:23:21.416: Row 9: at com.mysql.jdbc.util.ReadAheadInputStream.read(ReadAheadInputStream.java:173).
2025-10-12T13:23:21.416: Row 10: - locked <0x00000006e973e4e0> (a com.mysql.jdbc.util.ReadAheadInputStream).
2025-10-12T13:23:21.416: Row 11: at com.mysql.jdbc.MysqlIO.readFully(MysqlIO.java:2911).
2025-10-12T13:23:21.417: Row 12: at com.mysql.jdbc.MysqlIO.reuseAndReadPacket(MysqlIO.java:3337).
2025-10-12T13:23:21.417: Row 13: at com.mysql.jdbc.MysqlIO.reuseAndReadPacket(MysqlIO.java:3327).
2025-10-12T13:23:21.417: Row 14: at com.mysql.jdbc.MysqlIO.checkErrorPacket(MysqlIO.java:3814).
2025-10-12T13:23:21.417: Row 15: at com.mysql.jdbc.MysqlIO.sendCommand(MysqlIO.java:2435).
2025-10-12T13:23:21.417: Row 16: at com.mysql.jdbc.MysqlIO.sqlQueryDirect(MysqlIO.java:2582).
2025-10-12T13:23:21.417: Row 17: at com.mysql.jdbc.ConnectionImpl.execSQL(ConnectionImpl.java:2530).
2025-10-12T13:23:21.417: Row 18: - locked <0x00000006e95348d0> (a com.mysql.jdbc.JDBC4Connection).
2025-10-12T13:23:21.417: Row 19: at com.mysql.jdbc.PreparedStatement.executeInternal(PreparedStatement.java:1907).
2025-10-12T13:23:21.417: Row 20: - locked <0x00000006e95348d0> (a com.mysql.jdbc.JDBC4Connection).
2025-10-12T13:23:21.417: Row 21: at com.mysql.jdbc.PreparedStatement.executeQuery(PreparedStatement.java:2030).
2025-10-12T13:23:21.417: Row 22: - locked <0x00000006e95348d0> (a com.mysql.jdbc.JDBC4Connection).
2025-10-12T13:23:21.418: Row 23: at h2.helpers.check_pending_works(helpers.java:4945).
2025-10-12T13:23:21.418: Row 24: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-12T13:23:21.438: SUC: 2007, 244ms, lines: 35.
2025-10-12T13:23:21.439: checkJavaStack end: 2007, pid/ret=35.
2025-10-12T13:23:31.439: checkJavaStack starting: 2007.
2025-10-12T13:23:31.527: ------ test: 2007
2025-10-12T13:23:31.527: 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-12T13:23:31.734: Row 1: "https-openssl-nio-443-exec-1131" #506713 daemon prio=5 os_prio=0 tid=0x00007f562013d000 nid=0xc3e runnable [0x00007f56379f6000].
2025-10-12T13:23:31.735: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-12T13:23:31.735: Row 3: at h2.core2021.semanticSimilarity_v3(core2021.java:1396).
2025-10-12T13:23:31.735: Row 4: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-12T13:23:31.735: Row 5: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:791).
2025-10-12T13:23:31.735: Row 6: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-12T13:23:31.735: Row 7: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-12T13:23:31.735: Row 8: at h1.mc_api.doGet(mc_api.java:39).
2025-10-12T13:23:31.737: SUC: 2007, 210ms, lines: 8.
2025-10-12T13:23:31.737: checkJavaStack end: 2007, pid/ret=8.
2025-10-12T13:23:41.738: checkJavaStack starting: 2007.
2025-10-12T13:23:41.827: ------ test: 2007
2025-10-12T13:23:41.827: 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-12T13:23:42.040: Row 1: "https-openssl-nio-443-exec-1131" #506713 daemon prio=5 os_prio=0 tid=0x00007f562013d000 nid=0xc3e runnable [0x00007f56379f6000].
2025-10-12T13:23:42.040: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-12T13:23:42.040: Row 3: at java.lang.String.indexOf(String.java:1769).
2025-10-12T13:23:42.040: Row 4: at java.lang.String.indexOf(String.java:1718).
2025-10-12T13:23:42.041: Row 5: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5362).
2025-10-12T13:23:42.041: Row 6: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5318).
2025-10-12T13:23:42.041: Row 7: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5258).
2025-10-12T13:23:42.041: Row 8: at h2.core2021.semanticSimilarity_v3(core2021.java:1417).
2025-10-12T13:23:42.041: Row 9: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-12T13:23:42.041: Row 10: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:791).
2025-10-12T13:23:42.041: Row 11: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-12T13:23:42.041: Row 12: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-12T13:23:42.041: Row 13: at h1.mc_api.doGet(mc_api.java:39).
2025-10-12T13:23:42.043: SUC: 2007, 215ms, lines: 13.
2025-10-12T13:23:42.043: checkJavaStack end: 2007, pid/ret=13.
2025-10-12T13:23:52.043: checkJavaStack starting: 2007.
2025-10-12T13:23:52.130: ------ test: 2007
2025-10-12T13:23:52.130: 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-12T13:23:52.386: Row 1: "https-openssl-nio-443-exec-1131" #506713 daemon prio=5 os_prio=0 tid=0x00007f562013d000 nid=0xc3e runnable [0x00007f56379f6000].
2025-10-12T13:23:52.386: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-12T13:23:52.386: Row 3: at java.util.AbstractCollection.toArray(AbstractCollection.java:183).
2025-10-12T13:23:52.387: Row 4: at java.lang.String.split(String.java:2378).
2025-10-12T13:23:52.387: Row 5: at java.lang.String.split(String.java:2422).
2025-10-12T13:23:52.387: Row 6: at h2.core2021.networkMatchSuperFast(core2021.java:3159).
2025-10-12T13:23:52.387: Row 7: at h2.core2021.semanticSimilarity_v3(core2021.java:1422).
2025-10-12T13:23:52.387: Row 8: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-12T13:23:52.387: Row 9: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:791).
2025-10-12T13:23:52.387: Row 10: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-12T13:23:52.387: Row 11: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-12T13:23:52.387: Row 12: at h1.mc_api.doGet(mc_api.java:39).
2025-10-12T13:23:52.389: SUC: 2007, 259ms, lines: 12.
2025-10-12T13:23:52.390: checkJavaStack end: 2007, pid/ret=12.
2025-10-12T13:24:02.390: checkJavaStack starting: 2007.
2025-10-12T13:24:02.475: ------ test: 2007
2025-10-12T13:24:02.475: 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-12T13:24:02.737: Row 1: "https-openssl-nio-443-exec-1131" #506713 daemon prio=5 os_prio=0 tid=0x00007f562013d000 nid=0xc3e runnable [0x00007f56379f6000].
2025-10-12T13:24:02.737: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-12T13:24:02.737: Row 3: at h2.core2021.semanticSimilarity_v3(core2021.java:1396).
2025-10-12T13:24:02.737: Row 4: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-12T13:24:02.737: Row 5: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:791).
2025-10-12T13:24:02.737: Row 6: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-12T13:24:02.738: Row 7: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-12T13:24:02.738: Row 8: at h1.mc_api.doGet(mc_api.java:39).
2025-10-12T13:24:02.739: SUC: 2007, 264ms, lines: 8.
2025-10-12T13:24:02.740: checkJavaStack end: 2007, pid/ret=8.
2025-10-12T13:24:12.741: checkJavaStack starting: 2007.
2025-10-12T13:24:12.859: ------ test: 2007
2025-10-12T13:24:12.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-12T13:24:13.094: Row 1: "https-openssl-nio-443-exec-1131" #506713 daemon prio=5 os_prio=0 tid=0x00007f562013d000 nid=0xc3e runnable [0x00007f56379f6000].
2025-10-12T13:24:13.094: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-12T13:24:13.094: Row 3: at h2.core2021.semanticSimilarity_v3(core2021.java:1384).
2025-10-12T13:24:13.094: Row 4: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-12T13:24:13.094: Row 5: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:791).
2025-10-12T13:24:13.095: Row 6: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-12T13:24:13.095: Row 7: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-12T13:24:13.095: Row 8: at h1.mc_api.doGet(mc_api.java:39).
2025-10-12T13:24:13.100: SUC: 2007, 241ms, lines: 8.
2025-10-12T13:24:13.100: checkJavaStack end: 2007, pid/ret=8.
2025-10-12T13:24:23.101: checkJavaStack starting: 2007.
2025-10-12T13:24:23.188: ------ test: 2007
2025-10-12T13:24:23.188: 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-12T13:24:23.395: Row 1: "https-openssl-nio-443-exec-1131" #506713 daemon prio=5 os_prio=0 tid=0x00007f562013d000 nid=0xc3e runnable [0x00007f56379f6000].
2025-10-12T13:24:23.395: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-12T13:24:23.396: Row 3: at java.lang.String.indexOf(String.java:1769).
2025-10-12T13:24:23.396: Row 4: at java.lang.String.indexOf(String.java:1718).
2025-10-12T13:24:23.396: Row 5: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5362).
2025-10-12T13:24:23.396: Row 6: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5318).
2025-10-12T13:24:23.396: Row 7: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5258).
2025-10-12T13:24:23.396: Row 8: at h2.core2021.semanticSimilarity_v3(core2021.java:1404).
2025-10-12T13:24:23.396: Row 9: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-12T13:24:23.396: Row 10: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:791).
2025-10-12T13:24:23.396: Row 11: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-12T13:24:23.396: Row 12: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-12T13:24:23.396: Row 13: at h1.mc_api.doGet(mc_api.java:39).
2025-10-12T13:24:23.398: SUC: 2007, 210ms, lines: 13.
2025-10-12T13:24:23.398: checkJavaStack end: 2007, pid/ret=13.
2025-10-12T13:24:33.398: checkJavaStack starting: 2007.
2025-10-12T13:24:33.483: ------ test: 2007
2025-10-12T13:24:33.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-12T13:24:33.708: SUC: 2007, 224ms, lines: 4096.
2025-10-12T13:24:33.708: checkJavaStack end: 2007, pid/ret=4096.
2025-10-12T13:24:43.708: checkJavaStack starting: 2007.
2025-10-12T13:24:43.795: ------ test: 2007
2025-10-12T13:24:43.796: 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-12T13:24:43.982: SUC: 2007, 186ms, lines: 4096.
2025-10-12T13:24:43.983: checkJavaStack end: 2007, pid/ret=4096.
2025-10-12T13:24:53.983: checkJavaStack starting: 2007.
2025-10-12T13:24:54.068: ------ test: 2007
2025-10-12T13:24:54.068: 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-12T13:24:54.303: Row 1: "https-openssl-nio-443-exec-1123" #505836 daemon prio=5 os_prio=0 tid=0x00007f5654848000 nid=0x2dc runnable [0x00007f56b958d000].
2025-10-12T13:24:54.304: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-12T13:24:54.304: Row 3: at h2.skills_compass.get_suggestion_with_interests(skills_compass.java:1449).
2025-10-12T13:24:54.304: Row 4: at h2.skills_compass.get_suggestion(skills_compass.java:23).
2025-10-12T13:24:54.304: Row 5: at h2.Utils.doPost(Utils.java:794).
2025-10-12T13:24:54.304: Row 6: at h2.Utils.doGet(Utils.java:30).
2025-10-12T13:24:54.306: SUC: 2007, 237ms, lines: 6.
2025-10-12T13:24:54.306: checkJavaStack end: 2007, pid/ret=6.
2025-10-12T13:25:04.306: checkJavaStack starting: 2007.
2025-10-12T13:25:04.394: ------ test: 2007
2025-10-12T13:25:04.394: 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-12T13:25:04.627: SUC: 2007, 233ms, lines: 4096.
2025-10-12T13:25:04.628: checkJavaStack end: 2007, pid/ret=4096.
2025-10-12T13:25:14.628: checkJavaStack starting: 2007.
2025-10-12T13:25:14.746: ------ test: 2007
2025-10-12T13:25:14.746: 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-12T13:25:14.932: SUC: 2007, 186ms, lines: 4096.
2025-10-12T13:25:14.933: checkJavaStack end: 2007, pid/ret=4096.
2025-10-12T13:25:24.933: checkJavaStack starting: 2007.
2025-10-12T13:25:25.022: ------ test: 2007
2025-10-12T13:25:25.022: 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-12T13:25:25.217: SUC: 2007, 195ms, lines: 4096.
2025-10-12T13:25:25.218: checkJavaStack end: 2007, pid/ret=4096.
2025-10-12T13:25:35.218: checkJavaStack starting: 2007.
2025-10-12T13:25:35.308: ------ test: 2007
2025-10-12T13:25:35.308: 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-12T13:25:35.500: SUC: 2007, 192ms, lines: 4096.
2025-10-12T13:25:35.500: checkJavaStack end: 2007, pid/ret=4096.
2025-10-12T13:25:45.500: checkJavaStack starting: 2007.
2025-10-12T13:25:45.586: ------ test: 2007
2025-10-12T13:25:45.586: 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-12T13:25:45.800: SUC: 2007, 214ms, lines: 4096.
2025-10-12T13:25:45.800: checkJavaStack end: 2007, pid/ret=4096.
2025-10-12T13:25:55.800: checkJavaStack starting: 2007.
2025-10-12T13:25:55.886: ------ test: 2007
2025-10-12T13:25:55.886: 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-12T13:25:56.123: SUC: 2007, 236ms, lines: 4096.
2025-10-12T13:25:56.123: checkJavaStack end: 2007, pid/ret=4096.
2025-10-12T13:26:06.123: checkJavaStack starting: 2007.
2025-10-12T13:26:06.207: ------ test: 2007
2025-10-12T13:26:06.207: 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-12T13:26:06.380: Row 1: "https-openssl-nio-443-exec-1137" #528409 daemon prio=5 os_prio=0 tid=0x00007f568ba8f800 nid=0xe764 runnable [0x00007f5637af6000].
2025-10-12T13:26:06.380: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-12T13:26:06.380: Row 3: at java.net.SocketInputStream.socketRead0(Native Method).
2025-10-12T13:26:06.380: Row 4: at java.net.SocketInputStream.socketRead(SocketInputStream.java:116).
2025-10-12T13:26:06.380: Row 5: at java.net.SocketInputStream.read(SocketInputStream.java:171).
2025-10-12T13:26:06.380: Row 6: at java.net.SocketInputStream.read(SocketInputStream.java:141).
2025-10-12T13:26:06.380: Row 7: at sun.security.ssl.SSLSocketInputRecord.read(SSLSocketInputRecord.java:457).
2025-10-12T13:26:06.381: Row 8: at sun.security.ssl.SSLSocketInputRecord.bytesInCompletePacket(SSLSocketInputRecord.java:68).
2025-10-12T13:26:06.381: Row 9: at sun.security.ssl.SSLSocketImpl.readApplicationRecord(SSLSocketImpl.java:1332).
2025-10-12T13:26:06.381: Row 10: at sun.security.ssl.SSLSocketImpl.access$300(SSLSocketImpl.java:73).
2025-10-12T13:26:06.381: Row 11: at sun.security.ssl.SSLSocketImpl$AppInputStream.read(SSLSocketImpl.java:948).
2025-10-12T13:26:06.381: Row 12: at net.snowflake.client.jdbc.internal.apache.http.impl.io.SessionInputBufferImpl.streamRead(SessionInputBufferImpl.java:137).
2025-10-12T13:26:06.381: Row 13: at net.snowflake.client.jdbc.internal.apache.http.impl.io.SessionInputBufferImpl.fillBuffer(SessionInputBufferImpl.java:153).
2025-10-12T13:26:06.381: Row 14: at net.snowflake.client.jdbc.internal.apache.http.impl.io.SessionInputBufferImpl.readLine(SessionInputBufferImpl.java:280).
2025-10-12T13:26:06.381: Row 15: at net.snowflake.client.jdbc.internal.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:138).
2025-10-12T13:26:06.381: Row 16: at net.snowflake.client.jdbc.internal.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:56).
2025-10-12T13:26:06.382: Row 17: at net.snowflake.client.jdbc.internal.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:259).
2025-10-12T13:26:06.382: Row 18: at net.snowflake.client.jdbc.internal.apache.http.impl.DefaultBHttpClientConnection.receiveResponseHeader(DefaultBHttpClientConnection.java:163).
2025-10-12T13:26:06.382: Row 19: at net.snowflake.client.jdbc.internal.apache.http.impl.conn.CPoolProxy.receiveResponseHeader(CPoolProxy.java:157).
2025-10-12T13:26:06.382: Row 20: at net.snowflake.client.jdbc.internal.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:273).
2025-10-12T13:26:06.382: Row 21: at net.snowflake.client.jdbc.internal.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:125).
2025-10-12T13:26:06.382: Row 22: at net.snowflake.client.jdbc.internal.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:272).
2025-10-12T13:26:06.382: Row 23: at net.snowflake.client.jdbc.internal.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:186).
2025-10-12T13:26:06.382: Row 24: at net.snowflake.client.jdbc.internal.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:89).
2025-10-12T13:26:06.400: SUC: 2007, 193ms, lines: 69.
2025-10-12T13:26:06.401: checkJavaStack end: 2007, pid/ret=69.
2025-10-12T13:26:16.401: checkJavaStack starting: 2007.
2025-10-12T13:26:16.516: ------ test: 2007
2025-10-12T13:26:16.516: 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-12T13:26:16.735: SUC: 2007, 219ms, lines: 4096.
2025-10-12T13:26:16.735: checkJavaStack end: 2007, pid/ret=4096.
2025-10-12T13:26:26.736: checkJavaStack starting: 2007.
2025-10-12T13:26:26.822: ------ test: 2007
2025-10-12T13:26:26.822: 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-12T13:26:27.045: SUC: 2007, 223ms, lines: 4096.
2025-10-12T13:26:27.046: checkJavaStack end: 2007, pid/ret=4096.
2025-10-12T13:26:27.049: ------ test: end, 322090ms. Score 39/39.
2025-10-12T13:26:27.051: Test duration: 5m22s.