2025-10-23T15:21:04.730: current working dir: /root/qa/mctester.
2025-10-23T15:21:04.775: current logging dir: ../mctester/www.
2025-10-23T15:21:04.775: ---------------------------------------------------------------
2025-10-23T15:21:04.781: mctester entry: 2025-10-23T15:21:04.775913 mode=50
2025-10-23T15:21:04.781: ---------------------------------------------------------------
2025-10-23T15:21:04.852: EXE: 1/git describe --tags.
2025-10-23T15:21:04.864: Row 1: v1.1-499-g9566a2a.
2025-10-23T15:21:04.864: EXE: 1/git rev-list --count HEAD.
2025-10-23T15:21:04.873: Row 1: 556.
2025-10-23T15:21:04.874: EXE: 1/git rev-parse HEAD.
2025-10-23T15:21:04.875: Row 1: 9566a2a9418c04b507c618890106e642fb4f2697.
2025-10-23T15:21:04.885: mctester: v1.1.556 (9566a2a9418c04b507c618890106e642fb4f2697).
2025-10-23T15:21:04.885: Entering into a performance tests mode.
2025-10-23T15:21:04.887: ------ test: start, 2025-10-23T15:21:04.886
2025-10-23T15:21:04.889: ------ test: 2000
2025-10-23T15:21:04.889: CMD: ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "top -b -n 1"
2025-10-23T15:21:04.890: EXE: 1/ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "top -b -n 1".
2025-10-23T15:21:05.124: Row 1: top - 15:21:05 up 144 days, 5:08, 1 user, load average: 0.26, 0.42, 1.14.
2025-10-23T15:21:05.124: Row 2: Tasks: 537 total, 1 running, 536 sleeping, 0 stopped, 0 zombie.
2025-10-23T15:21:05.125: 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-23T15:21:05.125: Row 4: KiB Mem : 13202036+total, 700880 free, 67379472 used, 63940020 buff/cache.
2025-10-23T15:21:05.125: Row 5: KiB Swap: 0 total, 0 free, 0 used. 63653572 avail Mem .
2025-10-23T15:21:05.125: Row 6: .
2025-10-23T15:21:05.126: Row 7: PID USER PR NI VIRT RES SHR S %CPU %MEM TIME+ COMMAND.
2025-10-23T15:21:05.126: Row 8: 89817 root 20 0 22.651g 0.011t 33888 S 93.8 8.9 31172:52 java.
2025-10-23T15:21:05.126: Row 9: 1 root 20 0 43692 3724 2352 S 0.0 0.0 7:32.41 init.
2025-10-23T15:21:05.126: Row 10: 2 root 20 0 0 0 0 S 0.0 0.0 0:00.94 kthreadd.
2025-10-23T15:21:05.127: Row 11: 3 root 20 0 0 0 0 S 0.0 0.0 0:49.65 ksoftirqd+.
2025-10-23T15:21:05.127: Row 12: 4 root 20 0 0 0 0 S 0.0 0.0 0:00.00 kworker/0+.
2025-10-23T15:21:05.127: Row 13: 5 root 0 -20 0 0 0 S 0.0 0.0 0:00.00 kworker/0+.
2025-10-23T15:21:05.127: Row 14: 7 root 20 0 0 0 0 S 0.0 0.0 61:34.89 rcu_sched.
2025-10-23T15:21:05.128: Row 15: 8 root 20 0 0 0 0 S 0.0 0.0 0:00.00 rcu_bh.
2025-10-23T15:21:05.128: Row 16: 9 root rt 0 0 0 0 S 0.0 0.0 0:02.82 migration+.
2025-10-23T15:21:05.128: Row 17: 10 root rt 0 0 0 0 S 0.0 0.0 0:34.91 watchdog/0.
2025-10-23T15:21:05.128: Row 18: 11 root rt 0 0 0 0 S 0.0 0.0 0:33.92 watchdog/1.
2025-10-23T15:21:05.129: Row 19: 12 root rt 0 0 0 0 S 0.0 0.0 0:11.80 migration+.
2025-10-23T15:21:05.129: Row 20: 13 root 20 0 0 0 0 S 0.0 0.0 0:02.50 ksoftirqd+.
2025-10-23T15:21:05.129: Row 21: 14 root 20 0 0 0 0 S 0.0 0.0 0:00.00 kworker/1+.
2025-10-23T15:21:05.129: Row 22: 15 root 0 -20 0 0 0 S 0.0 0.0 0:00.00 kworker/1+.
2025-10-23T15:21:05.130: Row 23: 16 root rt 0 0 0 0 S 0.0 0.0 0:34.16 watchdog/2.
2025-10-23T15:21:05.130: Row 24: 17 root rt 0 0 0 0 S 0.0 0.0 0:04.15 migration+.
2025-10-23T15:21:05.198: SUC: 302ms Uptime 144 days, 1min 0.26, 5min 0.42, 15min 1.14, mem:132020360 total / 700880 free / 67379472 used / 63940020 cache / 63653572 avail
2025-10-23T15:21:05.208: ------ test: 2001
2025-10-23T15:21:05.208: CMD: top -b -E k -n 1
2025-10-23T15:21:05.208: EXE: 1/top -b -E k -n 1.
2025-10-23T15:21:05.367: Row 1: top - 15:21:05 up 59 days, 5:34, 0 users, load average: 3.60, 3.88, 3.96.
2025-10-23T15:21:05.367: Row 2: Tasks: 169 total, 1 running, 166 sleeping, 1 stopped, 1 zombie.
2025-10-23T15:21:05.367: Row 3: %Cpu(s): 8.8 us, 0.8 sy, 0.0 ni, 90.4 id, 0.0 wa, 0.0 hi, 0.0 si, 0.0 st.
2025-10-23T15:21:05.367: Row 4: KiB Mem : 16480104 total, 3121912 free, 1283996 used, 12074196 buff/cache.
2025-10-23T15:21:05.368: Row 5: KiB Swap: 0 total, 0 free, 0 used. 14757656 avail Mem .
2025-10-23T15:21:05.368: Row 6: .
2025-10-23T15:21:05.368: Row 7: PID USER PR NI VIRT RES SHR S %CPU %MEM TIME+ COMMAND.
2025-10-23T15:21:05.368: Row 8: 3092731 root 20 0 4977416 81500 27408 S 66.7 0.5 0:01.10 java.
2025-10-23T15:21:05.369: Row 9: 1 root 20 0 167800 13288 8396 S 0.0 0.1 1:36.95 systemd.
2025-10-23T15:21:05.369: Row 10: 2 root 20 0 0 0 0 S 0.0 0.0 0:00.59 kthreadd.
2025-10-23T15:21:05.369: Row 11: 3 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 rcu_gp.
2025-10-23T15:21:05.369: Row 12: 4 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 rcu_par+.
2025-10-23T15:21:05.369: Row 13: 5 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 slub_fl+.
2025-10-23T15:21:05.370: Row 14: 6 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 netns.
2025-10-23T15:21:05.370: Row 15: 8 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 kworker+.
2025-10-23T15:21:05.370: Row 16: 10 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 mm_perc+.
2025-10-23T15:21:05.370: Row 17: 11 root 20 0 0 0 0 S 0.0 0.0 0:00.00 rcu_tas+.
2025-10-23T15:21:05.370: Row 18: 12 root 20 0 0 0 0 S 0.0 0.0 0:00.00 rcu_tas+.
2025-10-23T15:21:05.370: Row 19: 13 root 20 0 0 0 0 S 0.0 0.0 0:00.88 ksoftir+.
2025-10-23T15:21:05.371: Row 20: 14 root 20 0 0 0 0 I 0.0 0.0 2:48.59 rcu_sch+.
2025-10-23T15:21:05.371: Row 21: 15 root rt 0 0 0 0 S 0.0 0.0 0:10.88 migrati+.
2025-10-23T15:21:05.371: Row 22: 16 root -51 0 0 0 0 S 0.0 0.0 0:00.00 idle_in+.
2025-10-23T15:21:05.371: Row 23: 18 root 20 0 0 0 0 S 0.0 0.0 0:00.00 cpuhp/0.
2025-10-23T15:21:05.371: Row 24: 19 root 20 0 0 0 0 S 0.0 0.0 0:00.00 cpuhp/1.
2025-10-23T15:21:05.379: SUC: 171ms Uptime 59 days, 1min 3.60, 5min 3.88, 15min 3.96, mem:16480104 total / 3121912 free / 1283996 used / 12074196 cache / 14757656 avail
2025-10-23T15:21:05.380: ------ test: 2002
2025-10-23T15:21:05.380: CMD: df -h
2025-10-23T15:21:05.381: EXE: 1/df -h.
2025-10-23T15:21:05.382: Row 1: Filesystem Size Used Avail Use% Mounted on.
2025-10-23T15:21:05.383: Row 2: tmpfs 791M 82M 710M 11% /run.
2025-10-23T15:21:05.383: Row 3: /dev/vda2 30G 26G 3.0G 90% /.
2025-10-23T15:21:05.383: Row 4: tmpfs 3.9G 0 3.9G 0% /dev/shm.
2025-10-23T15:21:05.383: Row 5: tmpfs 5.0M 0 5.0M 0% /run/lock.
2025-10-23T15:21:05.385: SUC: 5ms Diskfree qa.headai.com: tmpfs:11%, /dev/vda2:90%, tmpfs:0%, tmpfs:0%.
2025-10-23T15:21:05.385: ------ test: 2003
2025-10-23T15:21:05.386: CMD: ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "df -h"
2025-10-23T15:21:05.386: EXE: 1/ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "df -h".
2025-10-23T15:21:05.483: Row 1: Filesystem Size Used Avail Use% Mounted on.
2025-10-23T15:21:05.484: Row 2: udev 63G 4.0K 63G 1% /dev.
2025-10-23T15:21:05.484: Row 3: tmpfs 13G 5.5M 13G 1% /run.
2025-10-23T15:21:05.484: Row 4: /dev/vda1 757G 306G 420G 43% /.
2025-10-23T15:21:05.484: Row 5: none 4.0K 0 4.0K 0% /sys/fs/cgroup.
2025-10-23T15:21:05.485: Row 6: none 5.0M 0 5.0M 0% /run/lock.
2025-10-23T15:21:05.485: Row 7: none 63G 0 63G 0% /run/shm.
2025-10-23T15:21:05.485: Row 8: none 100M 0 100M 0% /run/user.
2025-10-23T15:21:05.485: Row 9: cgmfs 100K 0 100K 0% /run/cgmanager/fs.
2025-10-23T15:21:05.485: Row 10: /dev/vdb 985G 275G 660G 30% /opt/tomcat/webapps/ROOT/analysis.
2025-10-23T15:21:05.485: Row 11: tmpfs 100K 0 100K 0% /var/lib/lxd/shmounts.
2025-10-23T15:21:05.485: Row 12: tmpfs 100K 0 100K 0% /var/lib/lxd/devlxd.
2025-10-23T15:21:05.486: SUC: 100ms Diskfree megatron.headai.com: udev:1%, tmpfs:1%, /dev/vda1:43%, none:0%, none:0%, none:0%, none:0%, cgmfs:0%, /dev/vdb:30%, tmpfs:0%, tmpfs:0%.
2025-10-23T15:21:05.487: ------ test: 2004
2025-10-23T15:21:05.487: URL: https://headai.com
2025-10-23T15:21:05.932: SUC: 436ms, 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 190448.
2025-10-23T15:21:05.933: ------ test: 2005
2025-10-23T15:21:06.175: SQL: show global status like 'threads_connected';.
2025-10-23T15:21:06.202: Results: value=4/200.
2025-10-23T15:21:06.207: SQL: value, lines: 1, ret=1, 4.
2025-10-23T15:21:06.208: SUC: 274ms 4
2025-10-23T15:21:06.208: ------ test: 2006
2025-10-23T15:21:06.286: SQL: SHOW PROCESSLIST;.
2025-10-23T15:21:06.290: Row 1: 57023952,root,localhost:43736,null,Query,0,starting,SHOW PROCESSLIST.
2025-10-23T15:21:06.291: SQL: COUNTNOTLINES:Command, lines: 1, ret=1, 1.
2025-10-23T15:21:06.291: SUC: 82ms 1
2025-10-23T15:21:06.292: checkJavaStack starting: 2007.
2025-10-23T15:21:06.383: ------ test: 2007
2025-10-23T15:21:06.383: 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-23T15:21:06.615: Row 1: "https-openssl-nio-443-exec-1297" #997929 daemon prio=5 os_prio=0 tid=0x00007f561461f800 nid=0xd81d runnable [0x00007f56ba094000].
2025-10-23T15:21:06.615: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-23T15:21:06.616: Row 3: at java.lang.String.toLowerCase(String.java:2604).
2025-10-23T15:21:06.616: Row 4: at java.lang.String.toLowerCase(String.java:2670).
2025-10-23T15:21:06.616: Row 5: at h2.core2021.semanticSimilarity_v3(core2021.java:1211).
2025-10-23T15:21:06.616: Row 6: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-23T15:21:06.616: Row 7: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:799).
2025-10-23T15:21:06.616: Row 8: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-23T15:21:06.617: Row 9: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-23T15:21:06.617: Row 10: at h1.mc_api.doGet(mc_api.java:39).
2025-10-23T15:21:06.617: SUC: 2007, 234ms, lines: 10.
2025-10-23T15:21:06.620: checkJavaStack end: 2007, pid/ret=10.
2025-10-23T15:21:16.620: checkJavaStack starting: 2007.
2025-10-23T15:21:16.710: ------ test: 2007
2025-10-23T15:21:16.710: 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-23T15:21:16.931: Row 1: "https-openssl-nio-443-exec-1297" #997929 daemon prio=5 os_prio=0 tid=0x00007f561461f800 nid=0xd81d runnable [0x00007f56ba094000].
2025-10-23T15:21:16.931: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-23T15:21:16.932: Row 3: at h1.body.wordToBody(body.java:288).
2025-10-23T15:21:16.932: Row 4: at h2.core2021.semanticSimilarity_v3(core2021.java:1397).
2025-10-23T15:21:16.932: Row 5: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-23T15:21:16.932: Row 6: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:799).
2025-10-23T15:21:16.932: Row 7: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-23T15:21:16.932: Row 8: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-23T15:21:16.932: Row 9: at h1.mc_api.doGet(mc_api.java:39).
2025-10-23T15:21:16.935: SUC: 2007, 225ms, lines: 9.
2025-10-23T15:21:16.936: checkJavaStack end: 2007, pid/ret=9.
2025-10-23T15:21:26.936: checkJavaStack starting: 2007.
2025-10-23T15:21:27.026: ------ test: 2007
2025-10-23T15:21:27.026: 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-23T15:21:27.220: SUC: 2007, 193ms, lines: 4096.
2025-10-23T15:21:27.220: checkJavaStack end: 2007, pid/ret=4096.
2025-10-23T15:21:37.220: checkJavaStack starting: 2007.
2025-10-23T15:21:37.309: ------ test: 2007
2025-10-23T15:21:37.309: 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-23T15:21:37.564: Row 1: "https-openssl-nio-443-exec-1278" #997656 daemon prio=5 os_prio=0 tid=0x00007f560c2ac000 nid=0xc713 runnable [0x00007f564c1ee000].
2025-10-23T15:21:37.565: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-23T15:21:37.565: Row 3: at java.util.AbstractCollection.toArray(AbstractCollection.java:183).
2025-10-23T15:21:37.565: Row 4: at java.lang.String.split(String.java:2378).
2025-10-23T15:21:37.565: Row 5: at java.lang.String.split(String.java:2422).
2025-10-23T15:21:37.565: Row 6: at h2.core2021.networkMatchSuperFast(core2021.java:3159).
2025-10-23T15:21:37.565: Row 7: at h2.core2021.semanticSimilarity_v3(core2021.java:1422).
2025-10-23T15:21:37.565: Row 8: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-23T15:21:37.565: Row 9: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:799).
2025-10-23T15:21:37.566: Row 10: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-23T15:21:37.566: Row 11: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-23T15:21:37.566: Row 12: at h1.mc_api.doGet(mc_api.java:39).
2025-10-23T15:21:37.568: SUC: 2007, 259ms, lines: 12.
2025-10-23T15:21:37.568: checkJavaStack end: 2007, pid/ret=12.
2025-10-23T15:21:47.569: checkJavaStack starting: 2007.
2025-10-23T15:21:47.656: ------ test: 2007
2025-10-23T15:21:47.656: 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-23T15:21:47.876: Row 1: "https-openssl-nio-443-exec-1278" #997656 daemon prio=5 os_prio=0 tid=0x00007f560c2ac000 nid=0xc713 runnable [0x00007f564c1ee000].
2025-10-23T15:21:47.876: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-23T15:21:47.876: Row 3: at h1.body.wordToBody(body.java:287).
2025-10-23T15:21:47.876: Row 4: at h2.core2021.semanticSimilarity_v3(core2021.java:1373).
2025-10-23T15:21:47.876: Row 5: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-23T15:21:47.876: Row 6: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:799).
2025-10-23T15:21:47.877: Row 7: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-23T15:21:47.877: Row 8: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-23T15:21:47.877: Row 9: at h1.mc_api.doGet(mc_api.java:39).
2025-10-23T15:21:47.879: SUC: 2007, 223ms, lines: 9.
2025-10-23T15:21:47.879: checkJavaStack end: 2007, pid/ret=9.
2025-10-23T15:21:57.880: checkJavaStack starting: 2007.
2025-10-23T15:21:57.969: ------ test: 2007
2025-10-23T15:21:57.969: 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-23T15:21:58.162: Row 1: "https-openssl-nio-443-exec-1278" #997656 daemon prio=5 os_prio=0 tid=0x00007f560c2ac000 nid=0xc713 runnable [0x00007f564c1ee000].
2025-10-23T15:21:58.162: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-23T15:21:58.162: Row 3: at java.util.AbstractCollection.toArray(AbstractCollection.java:183).
2025-10-23T15:21:58.162: Row 4: at java.lang.String.split(String.java:2378).
2025-10-23T15:21:58.162: Row 5: at java.lang.String.split(String.java:2422).
2025-10-23T15:21:58.162: Row 6: at h2.core2021.networkMatchSuperFast(core2021.java:3164).
2025-10-23T15:21:58.162: Row 7: at h2.core2021.semanticSimilarity_v3(core2021.java:1422).
2025-10-23T15:21:58.163: Row 8: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-23T15:21:58.163: Row 9: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:799).
2025-10-23T15:21:58.163: Row 10: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-23T15:21:58.163: Row 11: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-23T15:21:58.163: Row 12: at h1.mc_api.doGet(mc_api.java:39).
2025-10-23T15:21:58.165: SUC: 2007, 196ms, lines: 12.
2025-10-23T15:21:58.166: checkJavaStack end: 2007, pid/ret=12.
2025-10-23T15:22:08.166: checkJavaStack starting: 2007.
2025-10-23T15:22:08.282: ------ test: 2007
2025-10-23T15:22:08.283: 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-23T15:22:08.507: Row 1: "https-openssl-nio-443-exec-1278" #997656 daemon prio=5 os_prio=0 tid=0x00007f560c2ac000 nid=0xc713 runnable [0x00007f564c1ee000].
2025-10-23T15:22:08.508: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-23T15:22:08.508: Row 3: at h1.body.wordToBody(body.java:288).
2025-10-23T15:22:08.508: Row 4: at h2.core2021.semanticSimilarity_v3(core2021.java:1397).
2025-10-23T15:22:08.508: Row 5: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-23T15:22:08.508: Row 6: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:799).
2025-10-23T15:22:08.508: Row 7: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-23T15:22:08.508: Row 8: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-23T15:22:08.508: Row 9: at h1.mc_api.doGet(mc_api.java:39).
2025-10-23T15:22:08.510: SUC: 2007, 227ms, lines: 9.
2025-10-23T15:22:08.510: checkJavaStack end: 2007, pid/ret=9.
2025-10-23T15:22:18.511: checkJavaStack starting: 2007.
2025-10-23T15:22:18.596: ------ test: 2007
2025-10-23T15:22:18.596: 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-23T15:22:18.788: Row 1: "https-openssl-nio-443-exec-1278" #997656 daemon prio=5 os_prio=0 tid=0x00007f560c2ac000 nid=0xc713 runnable [0x00007f564c1ee000].
2025-10-23T15:22:18.789: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-23T15:22:18.789: Row 3: at h1.body.wordToBody(body.java:286).
2025-10-23T15:22:18.789: Row 4: at h2.core2021.semanticSimilarity_v3(core2021.java:1373).
2025-10-23T15:22:18.789: Row 5: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-23T15:22:18.789: Row 6: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:799).
2025-10-23T15:22:18.789: Row 7: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-23T15:22:18.789: Row 8: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-23T15:22:18.789: Row 9: at h1.mc_api.doGet(mc_api.java:39).
2025-10-23T15:22:18.791: SUC: 2007, 195ms, lines: 9.
2025-10-23T15:22:18.791: checkJavaStack end: 2007, pid/ret=9.
2025-10-23T15:22:28.792: checkJavaStack starting: 2007.
2025-10-23T15:22:28.875: ------ test: 2007
2025-10-23T15:22:28.875: 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-23T15:22:29.133: Row 1: "https-openssl-nio-443-exec-1278" #997656 daemon prio=5 os_prio=0 tid=0x00007f560c2ac000 nid=0xc713 runnable [0x00007f564c1ee000].
2025-10-23T15:22:29.133: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-23T15:22:29.133: Row 3: at h1.body.wordToBody(body.java:286).
2025-10-23T15:22:29.133: Row 4: at h2.core2021.semanticSimilarity_v3(core2021.java:1397).
2025-10-23T15:22:29.133: Row 5: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-23T15:22:29.133: Row 6: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:799).
2025-10-23T15:22:29.133: Row 7: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-23T15:22:29.133: Row 8: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-23T15:22:29.133: Row 9: at h1.mc_api.doGet(mc_api.java:39).
2025-10-23T15:22:29.135: SUC: 2007, 260ms, lines: 9.
2025-10-23T15:22:29.136: checkJavaStack end: 2007, pid/ret=9.
2025-10-23T15:22:39.136: checkJavaStack starting: 2007.
2025-10-23T15:22:39.219: ------ test: 2007
2025-10-23T15:22:39.220: 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-23T15:22:39.460: Row 1: "https-openssl-nio-443-exec-1278" #997656 daemon prio=5 os_prio=0 tid=0x00007f560c2ac000 nid=0xc713 runnable [0x00007f564c1ee000].
2025-10-23T15:22:39.460: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-23T15:22:39.460: Row 3: at java.lang.String.split(String.java:2354).
2025-10-23T15:22:39.460: Row 4: at java.lang.String.split(String.java:2422).
2025-10-23T15:22:39.460: Row 5: at h2.core2021.semanticSimilarity_v3(core2021.java:1269).
2025-10-23T15:22:39.460: Row 6: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-23T15:22:39.461: Row 7: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:799).
2025-10-23T15:22:39.461: Row 8: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-23T15:22:39.461: Row 9: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-23T15:22:39.461: Row 10: at h1.mc_api.doGet(mc_api.java:39).
2025-10-23T15:22:39.462: SUC: 2007, 242ms, lines: 10.
2025-10-23T15:22:39.462: checkJavaStack end: 2007, pid/ret=10.
2025-10-23T15:22:49.463: checkJavaStack starting: 2007.
2025-10-23T15:22:49.547: ------ test: 2007
2025-10-23T15:22:49.547: 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-23T15:22:49.782: Row 1: "https-openssl-nio-443-exec-1278" #997656 daemon prio=5 os_prio=0 tid=0x00007f560c2ac000 nid=0xc713 runnable [0x00007f564c1ee000].
2025-10-23T15:22:49.783: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-23T15:22:49.783: Row 3: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5318).
2025-10-23T15:22:49.783: Row 4: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5258).
2025-10-23T15:22:49.783: Row 5: at h2.core2021.semanticSimilarity_v3(core2021.java:1407).
2025-10-23T15:22:49.783: Row 6: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-23T15:22:49.783: Row 7: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:799).
2025-10-23T15:22:49.783: Row 8: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-23T15:22:49.783: Row 9: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-23T15:22:49.784: Row 10: at h1.mc_api.doGet(mc_api.java:39).
2025-10-23T15:22:49.785: SUC: 2007, 238ms, lines: 10.
2025-10-23T15:22:49.786: checkJavaStack end: 2007, pid/ret=10.
2025-10-23T15:22:59.786: checkJavaStack starting: 2007.
2025-10-23T15:22:59.872: ------ test: 2007
2025-10-23T15:22:59.872: 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-23T15:23:00.077: Row 1: "https-openssl-nio-443-exec-1278" #997656 daemon prio=5 os_prio=0 tid=0x00007f560c2ac000 nid=0xc713 runnable [0x00007f564c1ee000].
2025-10-23T15:23:00.077: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-23T15:23:00.077: Row 3: at java.lang.String.indexOf(String.java:1769).
2025-10-23T15:23:00.077: Row 4: at java.lang.String.indexOf(String.java:1718).
2025-10-23T15:23:00.078: Row 5: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5362).
2025-10-23T15:23:00.078: Row 6: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5318).
2025-10-23T15:23:00.078: Row 7: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5258).
2025-10-23T15:23:00.078: Row 8: at h2.core2021.semanticSimilarity_v3(core2021.java:1406).
2025-10-23T15:23:00.078: Row 9: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-23T15:23:00.078: Row 10: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:799).
2025-10-23T15:23:00.078: Row 11: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-23T15:23:00.078: Row 12: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-23T15:23:00.078: Row 13: at h1.mc_api.doGet(mc_api.java:39).
2025-10-23T15:23:00.080: SUC: 2007, 208ms, lines: 13.
2025-10-23T15:23:00.080: checkJavaStack end: 2007, pid/ret=13.
2025-10-23T15:23:10.080: checkJavaStack starting: 2007.
2025-10-23T15:23:10.195: ------ test: 2007
2025-10-23T15:23:10.195: 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-23T15:23:10.435: Row 1: "https-openssl-nio-443-exec-1278" #997656 daemon prio=5 os_prio=0 tid=0x00007f560c2ac000 nid=0xc713 runnable [0x00007f564c1ee000].
2025-10-23T15:23:10.435: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-23T15:23:10.435: Row 3: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5318).
2025-10-23T15:23:10.436: Row 4: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5258).
2025-10-23T15:23:10.436: Row 5: at h2.core2021.semanticSimilarity_v3(core2021.java:1412).
2025-10-23T15:23:10.436: Row 6: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-23T15:23:10.436: Row 7: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:799).
2025-10-23T15:23:10.436: Row 8: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-23T15:23:10.436: Row 9: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-23T15:23:10.436: Row 10: at h1.mc_api.doGet(mc_api.java:39).
2025-10-23T15:23:10.438: SUC: 2007, 243ms, lines: 10.
2025-10-23T15:23:10.438: checkJavaStack end: 2007, pid/ret=10.
2025-10-23T15:23:20.438: checkJavaStack starting: 2007.
2025-10-23T15:23:20.523: ------ test: 2007
2025-10-23T15:23:20.524: 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-23T15:23:20.763: Row 1: "https-openssl-nio-443-exec-1278" #997656 daemon prio=5 os_prio=0 tid=0x00007f560c2ac000 nid=0xc713 runnable [0x00007f564c1ee000].
2025-10-23T15:23:20.764: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-23T15:23:20.764: Row 3: at java.lang.String.indexOf(String.java:1769).
2025-10-23T15:23:20.764: Row 4: at java.lang.String.indexOf(String.java:1718).
2025-10-23T15:23:20.764: Row 5: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5362).
2025-10-23T15:23:20.764: Row 6: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5318).
2025-10-23T15:23:20.764: Row 7: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5258).
2025-10-23T15:23:20.764: Row 8: at h2.core2021.semanticSimilarity_v3(core2021.java:1414).
2025-10-23T15:23:20.764: Row 9: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-23T15:23:20.764: Row 10: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:799).
2025-10-23T15:23:20.764: Row 11: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-23T15:23:20.765: Row 12: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-23T15:23:20.765: Row 13: at h1.mc_api.doGet(mc_api.java:39).
2025-10-23T15:23:20.766: SUC: 2007, 242ms, lines: 13.
2025-10-23T15:23:20.766: checkJavaStack end: 2007, pid/ret=13.
2025-10-23T15:23:30.767: checkJavaStack starting: 2007.
2025-10-23T15:23:30.851: ------ test: 2007
2025-10-23T15:23:30.851: 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-23T15:23:31.133: Row 1: "https-openssl-nio-443-exec-1278" #997656 daemon prio=5 os_prio=0 tid=0x00007f560c2ac000 nid=0xc713 runnable [0x00007f564c1ee000].
2025-10-23T15:23:31.133: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-23T15:23:31.134: Row 3: at h2.core2021.semanticSimilarity_v3(core2021.java:1397).
2025-10-23T15:23:31.134: Row 4: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-23T15:23:31.134: Row 5: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:799).
2025-10-23T15:23:31.134: Row 6: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-23T15:23:31.134: Row 7: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-23T15:23:31.134: Row 8: at h1.mc_api.doGet(mc_api.java:39).
2025-10-23T15:23:31.136: SUC: 2007, 285ms, lines: 8.
2025-10-23T15:23:31.136: checkJavaStack end: 2007, pid/ret=8.
2025-10-23T15:23:41.136: checkJavaStack starting: 2007.
2025-10-23T15:23:41.223: ------ test: 2007
2025-10-23T15:23:41.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-23T15:23:41.422: Row 1: "https-openssl-nio-443-exec-1278" #997656 daemon prio=5 os_prio=0 tid=0x00007f560c2ac000 nid=0xc713 runnable [0x00007f564c1ee000].
2025-10-23T15:23:41.422: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-23T15:23:41.422: Row 3: at h1.body.wordToBody(body.java:286).
2025-10-23T15:23:41.422: Row 4: at h2.core2021.semanticSimilarity_v3(core2021.java:1397).
2025-10-23T15:23:41.422: Row 5: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-23T15:23:41.423: Row 6: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:799).
2025-10-23T15:23:41.423: Row 7: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-23T15:23:41.423: Row 8: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-23T15:23:41.423: Row 9: at h1.mc_api.doGet(mc_api.java:39).
2025-10-23T15:23:41.450: SUC: 2007, 227ms, lines: 9.
2025-10-23T15:23:41.451: checkJavaStack end: 2007, pid/ret=9.
2025-10-23T15:23:51.451: checkJavaStack starting: 2007.
2025-10-23T15:23:51.536: ------ test: 2007
2025-10-23T15:23:51.536: 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-23T15:23:51.766: Row 1: "https-openssl-nio-443-exec-1278" #997656 daemon prio=5 os_prio=0 tid=0x00007f560c2ac000 nid=0xc713 runnable [0x00007f564c1ee000].
2025-10-23T15:23:51.767: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-23T15:23:51.767: Row 3: at h1.body.wordToBody(body.java:288).
2025-10-23T15:23:51.767: Row 4: at h2.core2021.semanticSimilarity_v3(core2021.java:1373).
2025-10-23T15:23:51.767: Row 5: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-23T15:23:51.767: Row 6: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:799).
2025-10-23T15:23:51.767: Row 7: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-23T15:23:51.768: Row 8: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-23T15:23:51.768: Row 9: at h1.mc_api.doGet(mc_api.java:39).
2025-10-23T15:23:51.771: SUC: 2007, 235ms, lines: 9.
2025-10-23T15:23:51.772: checkJavaStack end: 2007, pid/ret=9.
2025-10-23T15:24:01.772: checkJavaStack starting: 2007.
2025-10-23T15:24:01.862: ------ test: 2007
2025-10-23T15:24:01.863: 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-23T15:24:02.070: Row 1: "https-openssl-nio-443-exec-1292" #997672 daemon prio=5 os_prio=0 tid=0x00007f564804d000 nid=0xc739 runnable [0x00007f56b938b000].
2025-10-23T15:24:02.071: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-23T15:24:02.071: Row 3: at java.net.SocketInputStream.socketRead0(Native Method).
2025-10-23T15:24:02.071: Row 4: at java.net.SocketInputStream.socketRead(SocketInputStream.java:116).
2025-10-23T15:24:02.071: Row 5: at java.net.SocketInputStream.read(SocketInputStream.java:171).
2025-10-23T15:24:02.071: Row 6: at java.net.SocketInputStream.read(SocketInputStream.java:141).
2025-10-23T15:24:02.071: Row 7: at com.mysql.jdbc.util.ReadAheadInputStream.fill(ReadAheadInputStream.java:100).
2025-10-23T15:24:02.071: Row 8: at com.mysql.jdbc.util.ReadAheadInputStream.readFromUnderlyingStreamIfNecessary(ReadAheadInputStream.java:143).
2025-10-23T15:24:02.071: Row 9: at com.mysql.jdbc.util.ReadAheadInputStream.read(ReadAheadInputStream.java:173).
2025-10-23T15:24:02.071: Row 10: - locked <0x0000000671ae7b40> (a com.mysql.jdbc.util.ReadAheadInputStream).
2025-10-23T15:24:02.071: Row 11: at com.mysql.jdbc.MysqlIO.readFully(MysqlIO.java:2911).
2025-10-23T15:24:02.072: Row 12: at com.mysql.jdbc.MysqlIO.reuseAndReadPacket(MysqlIO.java:3337).
2025-10-23T15:24:02.072: Row 13: at com.mysql.jdbc.MysqlIO.reuseAndReadPacket(MysqlIO.java:3327).
2025-10-23T15:24:02.072: Row 14: at com.mysql.jdbc.MysqlIO.checkErrorPacket(MysqlIO.java:3814).
2025-10-23T15:24:02.072: Row 15: at com.mysql.jdbc.MysqlIO.sendCommand(MysqlIO.java:2435).
2025-10-23T15:24:02.072: Row 16: at com.mysql.jdbc.MysqlIO.sqlQueryDirect(MysqlIO.java:2582).
2025-10-23T15:24:02.072: Row 17: at com.mysql.jdbc.ConnectionImpl.execSQL(ConnectionImpl.java:2530).
2025-10-23T15:24:02.072: Row 18: - locked <0x0000000671ade0a0> (a com.mysql.jdbc.JDBC4Connection).
2025-10-23T15:24:02.072: Row 19: at com.mysql.jdbc.PreparedStatement.executeInternal(PreparedStatement.java:1907).
2025-10-23T15:24:02.072: Row 20: - locked <0x0000000671ade0a0> (a com.mysql.jdbc.JDBC4Connection).
2025-10-23T15:24:02.072: Row 21: at com.mysql.jdbc.PreparedStatement.executeQuery(PreparedStatement.java:2030).
2025-10-23T15:24:02.072: Row 22: - locked <0x0000000671ade0a0> (a com.mysql.jdbc.JDBC4Connection).
2025-10-23T15:24:02.072: Row 23: at h2.helpers.store_query(helpers.java:4257).
2025-10-23T15:24:02.073: Row 24: at h2.ModifyKnowledgeGraph.doPost(ModifyKnowledgeGraph.java:151).
2025-10-23T15:24:02.073: SUC: 2007, 210ms, lines: 35.
2025-10-23T15:24:02.073: checkJavaStack end: 2007, pid/ret=35.
2025-10-23T15:24:12.073: checkJavaStack starting: 2007.
2025-10-23T15:24:12.189: ------ test: 2007
2025-10-23T15:24:12.189: 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-23T15:24:12.454: Row 1: "https-openssl-nio-443-exec-1280" #997660 daemon prio=5 os_prio=0 tid=0x00007f5674a7b000 nid=0xc71d runnable [0x00007f56b8f87000].
2025-10-23T15:24:12.454: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-23T15:24:12.454: Row 3: at h2.MapToSubmap.getNeighborsIds(MapToSubmap.java:494).
2025-10-23T15:24:12.454: Row 4: at h2.MapToSubmap.getSubmap(MapToSubmap.java:224).
2025-10-23T15:24:12.454: Row 5: at h2.MapToSubmap.Map_To_Submap(MapToSubmap.java:61).
2025-10-23T15:24:12.454: Row 6: at h2.helpers.check_pending_works(helpers.java:5875).
2025-10-23T15:24:12.454: Row 7: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-23T15:24:12.454: Row 8: at h1.mc_api.doGet(mc_api.java:39).
2025-10-23T15:24:12.457: SUC: 2007, 268ms, lines: 8.
2025-10-23T15:24:12.457: checkJavaStack end: 2007, pid/ret=8.
2025-10-23T15:24:22.457: checkJavaStack starting: 2007.
2025-10-23T15:24:22.545: ------ test: 2007
2025-10-23T15:24:22.545: 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-23T15:24:22.761: SUC: 2007, 216ms, lines: 4096.
2025-10-23T15:24:22.762: checkJavaStack end: 2007, pid/ret=4096.
2025-10-23T15:24:32.762: checkJavaStack starting: 2007.
2025-10-23T15:24:32.849: ------ test: 2007
2025-10-23T15:24:32.849: 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-23T15:24:33.155: SUC: 2007, 306ms, lines: 4096.
2025-10-23T15:24:33.156: checkJavaStack end: 2007, pid/ret=4096.
2025-10-23T15:24:43.156: checkJavaStack starting: 2007.
2025-10-23T15:24:43.243: ------ test: 2007
2025-10-23T15:24:43.243: 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-23T15:24:43.443: Row 1: "https-openssl-nio-443-exec-1277" #997655 daemon prio=5 os_prio=0 tid=0x00007f568c048000 nid=0xc70e runnable [0x00007f5637dfb000].
2025-10-23T15:24:43.443: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-23T15:24:43.444: Row 3: at h2.skills_compass.get_suggestion_with_interests(skills_compass.java:1449).
2025-10-23T15:24:43.444: Row 4: at h2.skills_compass.get_suggestion(skills_compass.java:23).
2025-10-23T15:24:43.444: Row 5: at h2.Utils.doPost(Utils.java:794).
2025-10-23T15:24:43.444: Row 6: at h2.Utils.doGet(Utils.java:30).
2025-10-23T15:24:43.446: SUC: 2007, 203ms, lines: 6.
2025-10-23T15:24:43.446: checkJavaStack end: 2007, pid/ret=6.
2025-10-23T15:24:53.447: checkJavaStack starting: 2007.
2025-10-23T15:24:53.531: ------ test: 2007
2025-10-23T15:24:53.531: 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-23T15:24:53.812: SUC: 2007, 281ms, lines: 4096.
2025-10-23T15:24:53.812: checkJavaStack end: 2007, pid/ret=4096.
2025-10-23T15:25:03.813: checkJavaStack starting: 2007.
2025-10-23T15:25:03.900: ------ test: 2007
2025-10-23T15:25:03.901: 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-23T15:25:04.131: SUC: 2007, 230ms, lines: 4096.
2025-10-23T15:25:04.132: checkJavaStack end: 2007, pid/ret=4096.
2025-10-23T15:25:14.132: checkJavaStack starting: 2007.
2025-10-23T15:25:14.247: ------ test: 2007
2025-10-23T15:25:14.247: 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-23T15:25:14.475: SUC: 2007, 228ms, lines: 4096.
2025-10-23T15:25:14.475: checkJavaStack end: 2007, pid/ret=4096.
2025-10-23T15:25:24.475: checkJavaStack starting: 2007.
2025-10-23T15:25:24.562: ------ test: 2007
2025-10-23T15:25:24.562: 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-23T15:25:24.748: Row 1: "Thread-1489" #999271 daemon prio=5 os_prio=0 tid=0x00007f568bc13800 nid=0x14470 runnable [0x00007f56b817b000].
2025-10-23T15:25:24.749: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-23T15:25:24.749: Row 3: at java.util.AbstractCollection.toArray(AbstractCollection.java:183).
2025-10-23T15:25:24.749: Row 4: at java.lang.String.split(String.java:2378).
2025-10-23T15:25:24.749: Row 5: at java.lang.String.split(String.java:2422).
2025-10-23T15:25:24.749: Row 6: at h2.core2021.networkMatchSuperFast(core2021.java:3164).
2025-10-23T15:25:24.749: Row 7: at h2.core2021.semanticSimilarity_v3(core2021.java:1422).
2025-10-23T15:25:24.749: Row 8: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-23T15:25:24.749: Row 9: at h2.SkillsForecast_methods.build_a_map_on_fly_builder(SkillsForecast_methods.java:8288).
2025-10-23T15:25:24.749: Row 10: at h2.SkillsForecast_methods.build_a_map_on_fly_prepare(SkillsForecast_methods.java:8203).
2025-10-23T15:25:24.749: Row 11: at h2.helpers.lambda$22(helpers.java:5589).
2025-10-23T15:25:24.749: Row 12: at h2.helpers$$Lambda$468/1608356081.run(Unknown Source).
2025-10-23T15:25:24.751: SUC: 2007, 189ms, lines: 12.
2025-10-23T15:25:24.751: checkJavaStack end: 2007, pid/ret=12.
2025-10-23T15:25:34.751: checkJavaStack starting: 2007.
2025-10-23T15:25:34.963: ------ test: 2007
2025-10-23T15:25:34.963: 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-23T15:25:35.162: SUC: 2007, 199ms, lines: 4096.
2025-10-23T15:25:35.162: checkJavaStack end: 2007, pid/ret=4096.
2025-10-23T15:25:45.162: checkJavaStack starting: 2007.
2025-10-23T15:25:45.331: ------ test: 2007
2025-10-23T15:25:45.331: 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-23T15:25:45.595: SUC: 2007, 264ms, lines: 4096.
2025-10-23T15:25:45.596: checkJavaStack end: 2007, pid/ret=4096.
2025-10-23T15:25:55.596: checkJavaStack starting: 2007.
2025-10-23T15:25:55.678: ------ test: 2007
2025-10-23T15:25:55.678: 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-23T15:25:55.924: Row 1: "https-openssl-nio-443-exec-1284" #997664 daemon prio=5 os_prio=0 tid=0x00007f568baa8000 nid=0xc724 runnable [0x00007f564db9b000].
2025-10-23T15:25:55.924: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-23T15:25:55.924: Row 3: at java.net.SocketInputStream.socketRead0(Native Method).
2025-10-23T15:25:55.924: Row 4: at java.net.SocketInputStream.socketRead(SocketInputStream.java:116).
2025-10-23T15:25:55.924: Row 5: at java.net.SocketInputStream.read(SocketInputStream.java:171).
2025-10-23T15:25:55.924: Row 6: at java.net.SocketInputStream.read(SocketInputStream.java:141).
2025-10-23T15:25:55.924: Row 7: at sun.security.ssl.SSLSocketInputRecord.read(SSLSocketInputRecord.java:457).
2025-10-23T15:25:55.924: Row 8: at sun.security.ssl.SSLSocketInputRecord.bytesInCompletePacket(SSLSocketInputRecord.java:68).
2025-10-23T15:25:55.924: Row 9: at sun.security.ssl.SSLSocketImpl.readApplicationRecord(SSLSocketImpl.java:1332).
2025-10-23T15:25:55.925: Row 10: at sun.security.ssl.SSLSocketImpl.access$300(SSLSocketImpl.java:73).
2025-10-23T15:25:55.925: Row 11: at sun.security.ssl.SSLSocketImpl$AppInputStream.read(SSLSocketImpl.java:948).
2025-10-23T15:25:55.925: Row 12: at net.snowflake.client.jdbc.internal.apache.http.impl.io.SessionInputBufferImpl.streamRead(SessionInputBufferImpl.java:137).
2025-10-23T15:25:55.925: Row 13: at net.snowflake.client.jdbc.internal.apache.http.impl.io.SessionInputBufferImpl.fillBuffer(SessionInputBufferImpl.java:153).
2025-10-23T15:25:55.925: Row 14: at net.snowflake.client.jdbc.internal.apache.http.impl.io.SessionInputBufferImpl.readLine(SessionInputBufferImpl.java:280).
2025-10-23T15:25:55.925: Row 15: at net.snowflake.client.jdbc.internal.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:138).
2025-10-23T15:25:55.925: Row 16: at net.snowflake.client.jdbc.internal.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:56).
2025-10-23T15:25:55.925: Row 17: at net.snowflake.client.jdbc.internal.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:259).
2025-10-23T15:25:55.925: Row 18: at net.snowflake.client.jdbc.internal.apache.http.impl.DefaultBHttpClientConnection.receiveResponseHeader(DefaultBHttpClientConnection.java:163).
2025-10-23T15:25:55.925: Row 19: at net.snowflake.client.jdbc.internal.apache.http.impl.conn.CPoolProxy.receiveResponseHeader(CPoolProxy.java:157).
2025-10-23T15:25:55.926: Row 20: at net.snowflake.client.jdbc.internal.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:273).
2025-10-23T15:25:55.926: Row 21: at net.snowflake.client.jdbc.internal.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:125).
2025-10-23T15:25:55.926: Row 22: at net.snowflake.client.jdbc.internal.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:272).
2025-10-23T15:25:55.926: Row 23: at net.snowflake.client.jdbc.internal.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:186).
2025-10-23T15:25:55.926: Row 24: at net.snowflake.client.jdbc.internal.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:89).
2025-10-23T15:25:55.926: SUC: 2007, 248ms, lines: 44.
2025-10-23T15:25:55.926: checkJavaStack end: 2007, pid/ret=44.
2025-10-23T15:26:05.927: checkJavaStack starting: 2007.
2025-10-23T15:26:06.013: ------ test: 2007
2025-10-23T15:26:06.014: 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-23T15:26:06.231: SUC: 2007, 217ms, lines: 4096.
2025-10-23T15:26:06.232: checkJavaStack end: 2007, pid/ret=4096.
2025-10-23T15:26:16.232: checkJavaStack starting: 2007.
2025-10-23T15:26:16.347: ------ test: 2007
2025-10-23T15:26:16.347: 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-23T15:26:16.598: SUC: 2007, 251ms, lines: 4096.
2025-10-23T15:26:16.599: checkJavaStack end: 2007, pid/ret=4096.
2025-10-23T15:26:26.599: checkJavaStack starting: 2007.
2025-10-23T15:26:26.683: ------ test: 2007
2025-10-23T15:26:26.683: 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-23T15:26:26.963: SUC: 2007, 280ms, lines: 4096.
2025-10-23T15:26:26.963: checkJavaStack end: 2007, pid/ret=4096.
2025-10-23T15:26:26.966: ------ test: end, 322077ms. Score 39/39.
2025-10-23T15:26:26.968: Test duration: 5m22s.