2025-10-27T06:21:04.628: current working dir: /root/qa/mctester.
2025-10-27T06:21:04.671: current logging dir: ../mctester/www.
2025-10-27T06:21:04.672: ---------------------------------------------------------------
2025-10-27T06:21:04.678: mctester entry: 2025-10-27T06:21:04.672322 mode=50
2025-10-27T06:21:04.678: ---------------------------------------------------------------
2025-10-27T06:21:04.745: EXE: 1/git describe --tags.
2025-10-27T06:21:04.756: Row 1: v1.1-504-g086ac75.
2025-10-27T06:21:04.757: EXE: 1/git rev-list --count HEAD.
2025-10-27T06:21:04.765: Row 1: 561.
2025-10-27T06:21:04.766: EXE: 1/git rev-parse HEAD.
2025-10-27T06:21:04.768: Row 1: 086ac75dcf1e8ec082e95df89960efbddf5fcb4a.
2025-10-27T06:21:04.777: mctester: v1.1.561 (086ac75dcf1e8ec082e95df89960efbddf5fcb4a).
2025-10-27T06:21:04.777: Entering into a performance tests mode.
2025-10-27T06:21:04.778: ------ test: start, 2025-10-27T06:21:04.777
2025-10-27T06:21:04.780: ------ test: 2000
2025-10-27T06:21:04.781: CMD: ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "top -b -n 1"
2025-10-27T06:21:04.781: EXE: 1/ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "top -b -n 1".
2025-10-27T06:21:05.043: Row 1: top - 06:21:05 up 147 days, 21:08, 0 users, load average: 0.39, 0.11, 0.07.
2025-10-27T06:21:05.043: Row 2: Tasks: 537 total, 1 running, 536 sleeping, 0 stopped, 0 zombie.
2025-10-27T06:21:05.043: 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-27T06:21:05.044: Row 4: KiB Mem : 13202036+total, 717600 free, 67624384 used, 63678392 buff/cache.
2025-10-27T06:21:05.044: Row 5: KiB Swap: 0 total, 0 free, 0 used. 63405912 avail Mem .
2025-10-27T06:21:05.044: Row 6: .
2025-10-27T06:21:05.044: Row 7: PID USER PR NI VIRT RES SHR S %CPU %MEM TIME+ COMMAND.
2025-10-27T06:21:05.045: Row 8: 89817 root 20 0 22.709g 0.011t 33852 S 93.8 9.0 35187:28 java.
2025-10-27T06:21:05.045: Row 9: 2892 snmp 20 0 64180 6752 1784 S 6.2 0.0 126:21.68 snmpd.
2025-10-27T06:21:05.045: Row 10: 1 root 20 0 43692 3724 2352 S 0.0 0.0 7:44.46 init.
2025-10-27T06:21:05.045: Row 11: 2 root 20 0 0 0 0 S 0.0 0.0 0:00.95 kthreadd.
2025-10-27T06:21:05.045: Row 12: 3 root 20 0 0 0 0 S 0.0 0.0 0:50.55 ksoftirqd+.
2025-10-27T06:21:05.046: Row 13: 4 root 20 0 0 0 0 S 0.0 0.0 0:00.00 kworker/0+.
2025-10-27T06:21:05.046: Row 14: 5 root 0 -20 0 0 0 S 0.0 0.0 0:00.00 kworker/0+.
2025-10-27T06:21:05.046: Row 15: 7 root 20 0 0 0 0 S 0.0 0.0 63:01.99 rcu_sched.
2025-10-27T06:21:05.046: Row 16: 8 root 20 0 0 0 0 S 0.0 0.0 0:00.00 rcu_bh.
2025-10-27T06:21:05.047: Row 17: 9 root rt 0 0 0 0 S 0.0 0.0 0:02.89 migration+.
2025-10-27T06:21:05.047: Row 18: 10 root rt 0 0 0 0 S 0.0 0.0 0:35.78 watchdog/0.
2025-10-27T06:21:05.047: Row 19: 11 root rt 0 0 0 0 S 0.0 0.0 0:34.76 watchdog/1.
2025-10-27T06:21:05.047: Row 20: 12 root rt 0 0 0 0 S 0.0 0.0 0:12.07 migration+.
2025-10-27T06:21:05.048: Row 21: 13 root 20 0 0 0 0 S 0.0 0.0 0:02.56 ksoftirqd+.
2025-10-27T06:21:05.048: Row 22: 14 root 20 0 0 0 0 S 0.0 0.0 0:00.00 kworker/1+.
2025-10-27T06:21:05.048: Row 23: 15 root 0 -20 0 0 0 S 0.0 0.0 0:00.00 kworker/1+.
2025-10-27T06:21:05.048: Row 24: 16 root rt 0 0 0 0 S 0.0 0.0 0:35.00 watchdog/2.
2025-10-27T06:21:05.118: SUC: 330ms Uptime 147 days, 1min 0.39, 5min 0.11, 15min 0.07, mem:132020360 total / 717600 free / 67624384 used / 63678392 cache / 63405912 avail
2025-10-27T06:21:05.127: ------ test: 2001
2025-10-27T06:21:05.128: CMD: top -b -E k -n 1
2025-10-27T06:21:05.128: EXE: 1/top -b -E k -n 1.
2025-10-27T06:21:05.285: Row 1: top - 06:21:05 up 1 day, 22:15, 0 users, load average: 0.15, 0.04, 0.01.
2025-10-27T06:21:05.286: Row 2: Tasks: 166 total, 1 running, 164 sleeping, 0 stopped, 1 zombie.
2025-10-27T06:21:05.286: Row 3: %Cpu(s): 7.3 us, 0.8 sy, 0.0 ni, 91.9 id, 0.0 wa, 0.0 hi, 0.0 si, 0.0 st.
2025-10-27T06:21:05.286: Row 4: KiB Mem : 16336752 total, 12102744 free, 867796 used, 3366212 buff/cache.
2025-10-27T06:21:05.287: Row 5: KiB Swap: 0 total, 0 free, 0 used. 15063336 avail Mem .
2025-10-27T06:21:05.287: Row 6: .
2025-10-27T06:21:05.287: Row 7: PID USER PR NI VIRT RES SHR S %CPU %MEM TIME+ COMMAND.
2025-10-27T06:21:05.287: Row 8: 98142 root 20 0 4977416 81080 27160 S 56.2 0.5 0:01.06 java.
2025-10-27T06:21:05.287: Row 9: 1 root 20 0 167684 12892 8196 S 0.0 0.1 0:04.07 systemd.
2025-10-27T06:21:05.288: Row 10: 2 root 20 0 0 0 0 S 0.0 0.0 0:00.02 kthreadd.
2025-10-27T06:21:05.288: Row 11: 3 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 rcu_gp.
2025-10-27T06:21:05.288: Row 12: 4 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 rcu_par+.
2025-10-27T06:21:05.288: Row 13: 5 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 slub_fl+.
2025-10-27T06:21:05.288: Row 14: 6 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 netns.
2025-10-27T06:21:05.288: Row 15: 8 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 kworker+.
2025-10-27T06:21:05.289: Row 16: 10 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 mm_perc+.
2025-10-27T06:21:05.289: Row 17: 11 root 20 0 0 0 0 S 0.0 0.0 0:00.00 rcu_tas+.
2025-10-27T06:21:05.289: Row 18: 12 root 20 0 0 0 0 S 0.0 0.0 0:00.00 rcu_tas+.
2025-10-27T06:21:05.289: Row 19: 13 root 20 0 0 0 0 S 0.0 0.0 0:00.04 ksoftir+.
2025-10-27T06:21:05.289: Row 20: 14 root 20 0 0 0 0 I 0.0 0.0 0:03.96 rcu_sch+.
2025-10-27T06:21:05.289: Row 21: 15 root rt 0 0 0 0 S 0.0 0.0 0:00.46 migrati+.
2025-10-27T06:21:05.290: Row 22: 16 root -51 0 0 0 0 S 0.0 0.0 0:00.00 idle_in+.
2025-10-27T06:21:05.290: Row 23: 18 root 20 0 0 0 0 S 0.0 0.0 0:00.00 cpuhp/0.
2025-10-27T06:21:05.290: Row 24: 19 root 20 0 0 0 0 S 0.0 0.0 0:00.00 cpuhp/1.
2025-10-27T06:21:05.306: SUC: 178ms Uptime 1 days, 1min 0.15, 5min 0.04, 15min 0.01, mem:16336752 total / 12102744 free / 867796 used / 3366212 cache / 15063336 avail
2025-10-27T06:21:05.306: ------ test: 2002
2025-10-27T06:21:05.307: CMD: df -h
2025-10-27T06:21:05.307: EXE: 1/df -h.
2025-10-27T06:21:05.308: Row 1: Filesystem Size Used Avail Use% Mounted on.
2025-10-27T06:21:05.309: Row 2: tmpfs 1.6G 58M 1.6G 4% /run.
2025-10-27T06:21:05.309: Row 3: /dev/vda2 40G 23G 15G 61% /.
2025-10-27T06:21:05.309: Row 4: tmpfs 7.8G 0 7.8G 0% /dev/shm.
2025-10-27T06:21:05.309: Row 5: tmpfs 5.0M 0 5.0M 0% /run/lock.
2025-10-27T06:21:05.311: SUC: 4ms Diskfree qa.headai.com: tmpfs:4%, /dev/vda2:61%, tmpfs:0%, tmpfs:0%.
2025-10-27T06:21:05.312: ------ test: 2003
2025-10-27T06:21:05.312: CMD: ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "df -h"
2025-10-27T06:21:05.312: EXE: 1/ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "df -h".
2025-10-27T06:21:05.382: Row 1: Filesystem Size Used Avail Use% Mounted on.
2025-10-27T06:21:05.382: Row 2: udev 63G 4.0K 63G 1% /dev.
2025-10-27T06:21:05.382: Row 3: tmpfs 13G 5.5M 13G 1% /run.
2025-10-27T06:21:05.383: Row 4: /dev/vda1 757G 306G 420G 43% /.
2025-10-27T06:21:05.383: Row 5: none 4.0K 0 4.0K 0% /sys/fs/cgroup.
2025-10-27T06:21:05.383: Row 6: none 5.0M 0 5.0M 0% /run/lock.
2025-10-27T06:21:05.383: Row 7: none 63G 0 63G 0% /run/shm.
2025-10-27T06:21:05.383: Row 8: none 100M 0 100M 0% /run/user.
2025-10-27T06:21:05.384: Row 9: cgmfs 100K 0 100K 0% /run/cgmanager/fs.
2025-10-27T06:21:05.384: Row 10: /dev/vdb 985G 275G 660G 30% /opt/tomcat/webapps/ROOT/analysis.
2025-10-27T06:21:05.384: Row 11: tmpfs 100K 0 100K 0% /var/lib/lxd/shmounts.
2025-10-27T06:21:05.384: Row 12: tmpfs 100K 0 100K 0% /var/lib/lxd/devlxd.
2025-10-27T06:21:05.385: SUC: 73ms 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-27T06:21:05.385: ------ test: 2004
2025-10-27T06:21:05.386: URL: https://headai.com
2025-10-27T06:21:05.834: SUC: 438ms, 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-27T06:21:05.834: ------ test: 2005
2025-10-27T06:21:06.071: SQL: show global status like 'threads_connected';.
2025-10-27T06:21:06.097: Results: value=2/200.
2025-10-27T06:21:06.102: SQL: value, lines: 1, ret=1, 2.
2025-10-27T06:21:06.103: SUC: 268ms 2
2025-10-27T06:21:06.104: ------ test: 2006
2025-10-27T06:21:06.185: SQL: SHOW PROCESSLIST;.
2025-10-27T06:21:06.189: Row 1: 57976499,root,localhost:37708,null,Query,0,starting,SHOW PROCESSLIST.
2025-10-27T06:21:06.189: SQL: COUNTNOTLINES:Command, lines: 1, ret=1, 1.
2025-10-27T06:21:06.190: SUC: 86ms 1
2025-10-27T06:21:06.190: checkJavaStack starting: 2007.
2025-10-27T06:21:06.282: ------ test: 2007
2025-10-27T06:21:06.282: 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-27T06:21:06.478: Row 1: "https-openssl-nio-443-exec-1773" #1124937 daemon prio=5 os_prio=0 tid=0x00007f560c1ba000 nid=0xec71 runnable [0x00007f5637efb000].
2025-10-27T06:21:06.478: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-27T06:21:06.478: Row 3: at h2.core2021.semanticSimilarity_v3(core2021.java:1398).
2025-10-27T06:21:06.478: Row 4: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-27T06:21:06.478: Row 5: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:803).
2025-10-27T06:21:06.478: Row 6: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-27T06:21:06.479: Row 7: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-27T06:21:06.479: Row 8: at h1.mc_api.doGet(mc_api.java:39).
2025-10-27T06:21:06.479: Row 9: "https-openssl-nio-443-exec-1760" #1124924 daemon prio=5 os_prio=0 tid=0x00007f563c1cd000 nid=0xebe4 runnable [0x00007f56377f5000].
2025-10-27T06:21:06.479: Row 10: java.lang.Thread.State: RUNNABLE.
2025-10-27T06:21:06.479: Row 11: at java.net.SocketInputStream.socketRead0(Native Method).
2025-10-27T06:21:06.480: Row 12: at java.net.SocketInputStream.socketRead(SocketInputStream.java:116).
2025-10-27T06:21:06.480: Row 13: at java.net.SocketInputStream.read(SocketInputStream.java:171).
2025-10-27T06:21:06.480: Row 14: at java.net.SocketInputStream.read(SocketInputStream.java:141).
2025-10-27T06:21:06.480: Row 15: at com.mysql.jdbc.util.ReadAheadInputStream.fill(ReadAheadInputStream.java:100).
2025-10-27T06:21:06.480: Row 16: at com.mysql.jdbc.util.ReadAheadInputStream.readFromUnderlyingStreamIfNecessary(ReadAheadInputStream.java:143).
2025-10-27T06:21:06.481: Row 17: at com.mysql.jdbc.util.ReadAheadInputStream.read(ReadAheadInputStream.java:173).
2025-10-27T06:21:06.481: Row 18: - locked <0x000000078c0d76a8> (a com.mysql.jdbc.util.ReadAheadInputStream).
2025-10-27T06:21:06.481: Row 19: at com.mysql.jdbc.MysqlIO.readFully(MysqlIO.java:2911).
2025-10-27T06:21:06.481: Row 20: at com.mysql.jdbc.MysqlIO.reuseAndReadPacket(MysqlIO.java:3337).
2025-10-27T06:21:06.481: Row 21: at com.mysql.jdbc.MysqlIO.reuseAndReadPacket(MysqlIO.java:3327).
2025-10-27T06:21:06.481: Row 22: at com.mysql.jdbc.MysqlIO.checkErrorPacket(MysqlIO.java:3814).
2025-10-27T06:21:06.481: Row 23: at com.mysql.jdbc.MysqlIO.sendCommand(MysqlIO.java:2435).
2025-10-27T06:21:06.481: Row 24: at com.mysql.jdbc.MysqlIO.sqlQueryDirect(MysqlIO.java:2582).
2025-10-27T06:21:06.482: SUC: 2007, 200ms, lines: 33.
2025-10-27T06:21:06.484: checkJavaStack end: 2007, pid/ret=33.
2025-10-27T06:21:16.484: checkJavaStack starting: 2007.
2025-10-27T06:21:16.571: ------ test: 2007
2025-10-27T06:21:16.571: 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-27T06:21:16.844: Row 1: "https-openssl-nio-443-exec-1773" #1124937 daemon prio=5 os_prio=0 tid=0x00007f560c1ba000 nid=0xec71 runnable [0x00007f5637efb000].
2025-10-27T06:21:16.845: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-27T06:21:16.845: Row 3: at h2.core2021.semanticSimilarity_v3(core2021.java:1396).
2025-10-27T06:21:16.845: Row 4: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-27T06:21:16.845: Row 5: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:803).
2025-10-27T06:21:16.845: Row 6: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-27T06:21:16.845: Row 7: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-27T06:21:16.846: Row 8: at h1.mc_api.doGet(mc_api.java:39).
2025-10-27T06:21:16.846: SUC: 2007, 275ms, lines: 8.
2025-10-27T06:21:16.847: checkJavaStack end: 2007, pid/ret=8.
2025-10-27T06:21:26.847: checkJavaStack starting: 2007.
2025-10-27T06:21:26.935: ------ test: 2007
2025-10-27T06:21:26.935: 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-27T06:21:27.131: SUC: 2007, 196ms, lines: 4096.
2025-10-27T06:21:27.132: checkJavaStack end: 2007, pid/ret=4096.
2025-10-27T06:21:37.132: checkJavaStack starting: 2007.
2025-10-27T06:21:37.219: ------ test: 2007
2025-10-27T06:21:37.219: 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-27T06:21:37.451: Row 1: "https-openssl-nio-443-exec-1758" #1124920 daemon prio=5 os_prio=0 tid=0x00007f560069e800 nid=0xebda runnable [0x00007f56b8e86000].
2025-10-27T06:21:37.451: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-27T06:21:37.451: Row 3: at java.util.ArrayList.subList(ArrayList.java:1007).
2025-10-27T06:21:37.451: Row 4: at java.lang.String.split(String.java:2378).
2025-10-27T06:21:37.451: Row 5: at java.lang.String.split(String.java:2422).
2025-10-27T06:21:37.452: Row 6: at h2.core2021.semanticSimilarity_v3(core2021.java:1269).
2025-10-27T06:21:37.452: Row 7: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-27T06:21:37.452: Row 8: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:803).
2025-10-27T06:21:37.452: Row 9: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-27T06:21:37.452: Row 10: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-27T06:21:37.452: Row 11: at h1.mc_api.doGet(mc_api.java:39).
2025-10-27T06:21:37.454: SUC: 2007, 235ms, lines: 11.
2025-10-27T06:21:37.455: checkJavaStack end: 2007, pid/ret=11.
2025-10-27T06:21:47.455: checkJavaStack starting: 2007.
2025-10-27T06:21:47.570: ------ test: 2007
2025-10-27T06:21:47.570: EXE: 5/"jstack 89817 | awk '/nid=/ {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]} start_line = NR; last_h1_h2 = 0; has_h1_h2 = 0; in_block = 1} /h1|h2/ {has_h1_h2 = 1; last_h1_h2 = NR} {lines[NR] = $0} END {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]}}' || true".
2025-10-27T06:21:47.813: Row 1: "https-openssl-nio-443-exec-1758" #1124920 daemon prio=5 os_prio=0 tid=0x00007f560069e800 nid=0xebda runnable [0x00007f56b8e85000].
2025-10-27T06:21:47.813: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-27T06:21:47.813: Row 3: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5318).
2025-10-27T06:21:47.813: Row 4: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5258).
2025-10-27T06:21:47.813: Row 5: at h2.core2021.semanticSimilarity_v3(core2021.java:1419).
2025-10-27T06:21:47.814: Row 6: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-27T06:21:47.814: Row 7: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:803).
2025-10-27T06:21:47.814: Row 8: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-27T06:21:47.814: Row 9: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-27T06:21:47.814: Row 10: at h1.mc_api.doGet(mc_api.java:39).
2025-10-27T06:21:47.815: SUC: 2007, 245ms, lines: 10.
2025-10-27T06:21:47.815: checkJavaStack end: 2007, pid/ret=10.
2025-10-27T06:21:57.816: checkJavaStack starting: 2007.
2025-10-27T06:21:57.902: ------ test: 2007
2025-10-27T06:21:57.902: EXE: 5/"jstack 89817 | awk '/nid=/ {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]} start_line = NR; last_h1_h2 = 0; has_h1_h2 = 0; in_block = 1} /h1|h2/ {has_h1_h2 = 1; last_h1_h2 = NR} {lines[NR] = $0} END {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]}}' || true".
2025-10-27T06:21:58.151: Row 1: "https-openssl-nio-443-exec-1758" #1124920 daemon prio=5 os_prio=0 tid=0x00007f560069e800 nid=0xebda runnable [0x00007f56b8e85000].
2025-10-27T06:21:58.151: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-27T06:21:58.151: Row 3: at h2.core2021.semanticSimilarity_v3(core2021.java:1397).
2025-10-27T06:21:58.151: Row 4: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-27T06:21:58.151: Row 5: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:803).
2025-10-27T06:21:58.151: Row 6: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-27T06:21:58.152: Row 7: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-27T06:21:58.152: Row 8: at h1.mc_api.doGet(mc_api.java:39).
2025-10-27T06:21:58.152: SUC: 2007, 250ms, lines: 8.
2025-10-27T06:21:58.153: checkJavaStack end: 2007, pid/ret=8.
2025-10-27T06:22:08.153: checkJavaStack starting: 2007.
2025-10-27T06:22:08.268: ------ test: 2007
2025-10-27T06:22:08.269: 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-27T06:22:08.511: Row 1: "https-openssl-nio-443-exec-1758" #1124920 daemon prio=5 os_prio=0 tid=0x00007f560069e800 nid=0xebda runnable [0x00007f56b8e85000].
2025-10-27T06:22:08.511: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-27T06:22:08.511: Row 3: at java.lang.String.indexOf(String.java:1769).
2025-10-27T06:22:08.512: Row 4: at java.lang.String.indexOf(String.java:1718).
2025-10-27T06:22:08.512: Row 5: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5362).
2025-10-27T06:22:08.512: Row 6: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5318).
2025-10-27T06:22:08.512: Row 7: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5258).
2025-10-27T06:22:08.512: Row 8: at h2.core2021.semanticSimilarity_v3(core2021.java:1407).
2025-10-27T06:22:08.512: Row 9: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-27T06:22:08.512: Row 10: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:803).
2025-10-27T06:22:08.512: Row 11: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-27T06:22:08.512: Row 12: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-27T06:22:08.513: Row 13: at h1.mc_api.doGet(mc_api.java:39).
2025-10-27T06:22:08.513: SUC: 2007, 244ms, lines: 13.
2025-10-27T06:22:08.513: checkJavaStack end: 2007, pid/ret=13.
2025-10-27T06:22:18.514: checkJavaStack starting: 2007.
2025-10-27T06:22:18.599: ------ test: 2007
2025-10-27T06:22:18.599: 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-27T06:22:18.831: Row 1: "https-openssl-nio-443-exec-1758" #1124920 daemon prio=5 os_prio=0 tid=0x00007f560069e800 nid=0xebda runnable [0x00007f56b8e85000].
2025-10-27T06:22:18.832: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-27T06:22:18.832: Row 3: at h2.core2021.semanticSimilarity_v3(core2021.java:1384).
2025-10-27T06:22:18.832: Row 4: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-27T06:22:18.832: Row 5: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:803).
2025-10-27T06:22:18.832: Row 6: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-27T06:22:18.832: Row 7: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-27T06:22:18.832: Row 8: at h1.mc_api.doGet(mc_api.java:39).
2025-10-27T06:22:18.834: SUC: 2007, 235ms, lines: 8.
2025-10-27T06:22:18.834: checkJavaStack end: 2007, pid/ret=8.
2025-10-27T06:22:28.834: checkJavaStack starting: 2007.
2025-10-27T06:22:28.918: ------ test: 2007
2025-10-27T06:22:28.919: 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-27T06:22:29.117: Row 1: "https-openssl-nio-443-exec-1758" #1124920 daemon prio=5 os_prio=0 tid=0x00007f560069e800 nid=0xebda runnable [0x00007f56b8e85000].
2025-10-27T06:22:29.117: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-27T06:22:29.117: Row 3: at java.lang.String.indexOf(String.java:1769).
2025-10-27T06:22:29.117: Row 4: at java.lang.String.indexOf(String.java:1718).
2025-10-27T06:22:29.117: Row 5: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5362).
2025-10-27T06:22:29.117: Row 6: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5318).
2025-10-27T06:22:29.117: Row 7: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5258).
2025-10-27T06:22:29.118: Row 8: at h2.core2021.semanticSimilarity_v3(core2021.java:1404).
2025-10-27T06:22:29.118: Row 9: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-27T06:22:29.118: Row 10: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:803).
2025-10-27T06:22:29.118: Row 11: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-27T06:22:29.118: Row 12: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-27T06:22:29.118: Row 13: at h1.mc_api.doGet(mc_api.java:39).
2025-10-27T06:22:29.119: SUC: 2007, 200ms, lines: 13.
2025-10-27T06:22:29.120: checkJavaStack end: 2007, pid/ret=13.
2025-10-27T06:22:39.120: checkJavaStack starting: 2007.
2025-10-27T06:22:39.206: ------ test: 2007
2025-10-27T06:22:39.206: 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-27T06:22:39.470: Row 1: "https-openssl-nio-443-exec-1758" #1124920 daemon prio=5 os_prio=0 tid=0x00007f560069e800 nid=0xebda runnable [0x00007f56b8e85000].
2025-10-27T06:22:39.470: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-27T06:22:39.471: Row 3: at java.util.AbstractCollection.toArray(AbstractCollection.java:196).
2025-10-27T06:22:39.471: Row 4: at java.lang.String.split(String.java:2378).
2025-10-27T06:22:39.471: Row 5: at java.lang.String.split(String.java:2422).
2025-10-27T06:22:39.471: Row 6: at h2.core2021.networkMatchSuperFast(core2021.java:3159).
2025-10-27T06:22:39.471: Row 7: at h2.core2021.semanticSimilarity_v3(core2021.java:1422).
2025-10-27T06:22:39.471: Row 8: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-27T06:22:39.471: Row 9: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:803).
2025-10-27T06:22:39.471: Row 10: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-27T06:22:39.471: Row 11: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-27T06:22:39.472: Row 12: at h1.mc_api.doGet(mc_api.java:39).
2025-10-27T06:22:39.472: SUC: 2007, 266ms, lines: 12.
2025-10-27T06:22:39.473: checkJavaStack end: 2007, pid/ret=12.
2025-10-27T06:22:49.473: checkJavaStack starting: 2007.
2025-10-27T06:22:49.558: ------ test: 2007
2025-10-27T06:22:49.558: 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-27T06:22:49.789: Row 1: "https-openssl-nio-443-exec-1758" #1124920 daemon prio=5 os_prio=0 tid=0x00007f560069e800 nid=0xebda runnable [0x00007f56b8e85000].
2025-10-27T06:22:49.789: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-27T06:22:49.789: Row 3: at h1.body.wordToBody(body.java:288).
2025-10-27T06:22:49.789: Row 4: at h2.core2021.semanticSimilarity_v3(core2021.java:1397).
2025-10-27T06:22:49.789: Row 5: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-27T06:22:49.789: Row 6: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:803).
2025-10-27T06:22:49.789: Row 7: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-27T06:22:49.790: Row 8: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-27T06:22:49.790: Row 9: at h1.mc_api.doGet(mc_api.java:39).
2025-10-27T06:22:49.791: SUC: 2007, 233ms, lines: 9.
2025-10-27T06:22:49.792: checkJavaStack end: 2007, pid/ret=9.
2025-10-27T06:22:59.792: checkJavaStack starting: 2007.
2025-10-27T06:22:59.879: ------ test: 2007
2025-10-27T06:22:59.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-27T06:23:00.152: Row 1: "https-openssl-nio-443-exec-1758" #1124920 daemon prio=5 os_prio=0 tid=0x00007f560069e800 nid=0xebda runnable [0x00007f56b8e85000].
2025-10-27T06:23:00.152: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-27T06:23:00.153: Row 3: at java.lang.String.split(String.java:2354).
2025-10-27T06:23:00.153: Row 4: at java.lang.String.split(String.java:2422).
2025-10-27T06:23:00.153: Row 5: at h2.core2021.networkMatchSuperFast(core2021.java:3164).
2025-10-27T06:23:00.153: Row 6: at h2.core2021.semanticSimilarity_v3(core2021.java:1422).
2025-10-27T06:23:00.153: Row 7: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-27T06:23:00.153: Row 8: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:803).
2025-10-27T06:23:00.153: Row 9: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-27T06:23:00.153: Row 10: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-27T06:23:00.153: Row 11: at h1.mc_api.doGet(mc_api.java:39).
2025-10-27T06:23:00.170: SUC: 2007, 291ms, lines: 11.
2025-10-27T06:23:00.171: checkJavaStack end: 2007, pid/ret=11.
2025-10-27T06:23:10.171: checkJavaStack starting: 2007.
2025-10-27T06:23:10.284: ------ test: 2007
2025-10-27T06:23:10.284: 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-27T06:23:10.518: Row 1: "https-openssl-nio-443-exec-1758" #1124920 daemon prio=5 os_prio=0 tid=0x00007f560069e800 nid=0xebda runnable [0x00007f56b8e85000].
2025-10-27T06:23:10.518: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-27T06:23:10.518: Row 3: at h2.core2021.semanticSimilarity_v3(core2021.java:1396).
2025-10-27T06:23:10.518: Row 4: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-27T06:23:10.519: Row 5: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:803).
2025-10-27T06:23:10.519: Row 6: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-27T06:23:10.519: Row 7: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-27T06:23:10.519: Row 8: at h1.mc_api.doGet(mc_api.java:39).
2025-10-27T06:23:10.520: SUC: 2007, 236ms, lines: 8.
2025-10-27T06:23:10.521: checkJavaStack end: 2007, pid/ret=8.
2025-10-27T06:23:20.521: checkJavaStack starting: 2007.
2025-10-27T06:23:20.607: ------ test: 2007
2025-10-27T06:23:20.607: 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-27T06:23:20.940: Row 1: "https-openssl-nio-443-exec-1758" #1124920 daemon prio=5 os_prio=0 tid=0x00007f560069e800 nid=0xebda runnable [0x00007f56b8e85000].
2025-10-27T06:23:20.941: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-27T06:23:20.941: Row 3: at h2.core2021.semanticSimilarity_v3(core2021.java:1262).
2025-10-27T06:23:20.941: Row 4: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-27T06:23:20.941: Row 5: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:803).
2025-10-27T06:23:20.941: Row 6: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-27T06:23:20.941: Row 7: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-27T06:23:20.941: Row 8: at h1.mc_api.doGet(mc_api.java:39).
2025-10-27T06:23:20.942: SUC: 2007, 335ms, lines: 8.
2025-10-27T06:23:20.943: checkJavaStack end: 2007, pid/ret=8.
2025-10-27T06:23:30.943: checkJavaStack starting: 2007.
2025-10-27T06:23:31.030: ------ test: 2007
2025-10-27T06:23:31.030: 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-27T06:23:31.253: Row 1: "https-openssl-nio-443-exec-1758" #1124920 daemon prio=5 os_prio=0 tid=0x00007f560069e800 nid=0xebda runnable [0x00007f56b8e85000].
2025-10-27T06:23:31.253: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-27T06:23:31.253: Row 3: at java.lang.String.split(String.java:2354).
2025-10-27T06:23:31.254: Row 4: at java.lang.String.split(String.java:2422).
2025-10-27T06:23:31.254: Row 5: at h2.core2021.semanticSimilarity_v3(core2021.java:1269).
2025-10-27T06:23:31.254: Row 6: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-27T06:23:31.254: Row 7: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:803).
2025-10-27T06:23:31.254: Row 8: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-27T06:23:31.254: Row 9: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-27T06:23:31.254: Row 10: at h1.mc_api.doGet(mc_api.java:39).
2025-10-27T06:23:31.255: SUC: 2007, 224ms, lines: 10.
2025-10-27T06:23:31.255: checkJavaStack end: 2007, pid/ret=10.
2025-10-27T06:23:41.256: checkJavaStack starting: 2007.
2025-10-27T06:23:41.343: ------ test: 2007
2025-10-27T06:23:41.343: 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-27T06:23:41.559: Row 1: "https-openssl-nio-443-exec-1758" #1124920 daemon prio=5 os_prio=0 tid=0x00007f560069e800 nid=0xebda runnable [0x00007f56b8e85000].
2025-10-27T06:23:41.561: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-27T06:23:41.561: Row 3: at java.lang.String.indexOf(String.java:1769).
2025-10-27T06:23:41.561: Row 4: at java.lang.String.indexOf(String.java:1718).
2025-10-27T06:23:41.561: Row 5: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5362).
2025-10-27T06:23:41.561: Row 6: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5318).
2025-10-27T06:23:41.561: Row 7: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5258).
2025-10-27T06:23:41.561: Row 8: at h2.core2021.semanticSimilarity_v3(core2021.java:1417).
2025-10-27T06:23:41.561: Row 9: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-27T06:23:41.562: Row 10: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:803).
2025-10-27T06:23:41.562: Row 11: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-27T06:23:41.562: Row 12: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-27T06:23:41.562: Row 13: at h1.mc_api.doGet(mc_api.java:39).
2025-10-27T06:23:41.563: SUC: 2007, 220ms, lines: 13.
2025-10-27T06:23:41.563: checkJavaStack end: 2007, pid/ret=13.
2025-10-27T06:23:51.563: checkJavaStack starting: 2007.
2025-10-27T06:23:51.652: ------ test: 2007
2025-10-27T06:23:51.652: 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-27T06:23:51.878: Row 1: "https-openssl-nio-443-exec-1758" #1124920 daemon prio=5 os_prio=0 tid=0x00007f560069e800 nid=0xebda runnable [0x00007f56b8e85000].
2025-10-27T06:23:51.878: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-27T06:23:51.878: Row 3: at h1.body.wordToBody(body.java:286).
2025-10-27T06:23:51.878: Row 4: at h2.core2021.semanticSimilarity_v3(core2021.java:1373).
2025-10-27T06:23:51.879: Row 5: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-27T06:23:51.879: Row 6: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:803).
2025-10-27T06:23:51.879: Row 7: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-27T06:23:51.879: Row 8: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-27T06:23:51.879: Row 9: at h1.mc_api.doGet(mc_api.java:39).
2025-10-27T06:23:51.880: SUC: 2007, 228ms, lines: 9.
2025-10-27T06:23:51.881: checkJavaStack end: 2007, pid/ret=9.
2025-10-27T06:24:01.882: checkJavaStack starting: 2007.
2025-10-27T06:24:01.973: ------ test: 2007
2025-10-27T06:24:01.973: 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-27T06:24:02.185: Row 1: "https-openssl-nio-443-exec-1758" #1124920 daemon prio=5 os_prio=0 tid=0x00007f560069e800 nid=0xebda runnable [0x00007f56b8e85000].
2025-10-27T06:24:02.185: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-27T06:24:02.185: Row 3: at java.lang.String.split(String.java:2354).
2025-10-27T06:24:02.185: Row 4: at java.lang.String.split(String.java:2422).
2025-10-27T06:24:02.185: Row 5: at h2.core2021.semanticSimilarity_v3(core2021.java:1269).
2025-10-27T06:24:02.185: Row 6: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-27T06:24:02.185: Row 7: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:803).
2025-10-27T06:24:02.185: Row 8: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-27T06:24:02.185: Row 9: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-27T06:24:02.185: Row 10: at h1.mc_api.doGet(mc_api.java:39).
2025-10-27T06:24:02.187: SUC: 2007, 213ms, lines: 10.
2025-10-27T06:24:02.187: checkJavaStack end: 2007, pid/ret=10.
2025-10-27T06:24:12.187: checkJavaStack starting: 2007.
2025-10-27T06:24:12.304: ------ test: 2007
2025-10-27T06:24:12.304: 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-27T06:24:12.530: Row 1: "https-openssl-nio-443-exec-1758" #1124920 daemon prio=5 os_prio=0 tid=0x00007f560069e800 nid=0xebda runnable [0x00007f56b8e85000].
2025-10-27T06:24:12.530: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-27T06:24:12.531: Row 3: at h2.core2021.semanticSimilarity_v3(core2021.java:1398).
2025-10-27T06:24:12.531: Row 4: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-27T06:24:12.531: Row 5: at h2.BuildKnowledgeGraph_v7.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v7.java:803).
2025-10-27T06:24:12.531: Row 6: at h2.helpers.check_pending_works(helpers.java:5411).
2025-10-27T06:24:12.531: Row 7: at h1.mc_api.doPost(mc_api.java:4578).
2025-10-27T06:24:12.531: Row 8: at h1.mc_api.doGet(mc_api.java:39).
2025-10-27T06:24:12.533: SUC: 2007, 229ms, lines: 8.
2025-10-27T06:24:12.533: checkJavaStack end: 2007, pid/ret=8.
2025-10-27T06:24:22.533: checkJavaStack starting: 2007.
2025-10-27T06:24:22.619: ------ test: 2007
2025-10-27T06:24:22.619: 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-27T06:24:22.819: SUC: 2007, 200ms, lines: 4096.
2025-10-27T06:24:22.820: checkJavaStack end: 2007, pid/ret=4096.
2025-10-27T06:24:32.820: checkJavaStack starting: 2007.
2025-10-27T06:24:32.908: ------ test: 2007
2025-10-27T06:24:32.908: 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-27T06:24:33.105: SUC: 2007, 197ms, lines: 4096.
2025-10-27T06:24:33.106: checkJavaStack end: 2007, pid/ret=4096.
2025-10-27T06:24:43.106: checkJavaStack starting: 2007.
2025-10-27T06:24:43.191: ------ test: 2007
2025-10-27T06:24:43.191: 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-27T06:24:43.430: SUC: 2007, 239ms, lines: 4096.
2025-10-27T06:24:43.430: checkJavaStack end: 2007, pid/ret=4096.
2025-10-27T06:24:53.430: checkJavaStack starting: 2007.
2025-10-27T06:24:53.519: ------ test: 2007
2025-10-27T06:24:53.519: 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-27T06:24:53.779: Row 1: "https-openssl-nio-443-exec-1778" #1124942 daemon prio=5 os_prio=0 tid=0x00007f5614029000 nid=0xec7f runnable [0x00007f56ba095000].
2025-10-27T06:24:53.779: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-27T06:24:53.779: Row 3: at h2.skills_compass.get_suggestion_with_interests(skills_compass.java:1449).
2025-10-27T06:24:53.779: Row 4: at h2.skills_compass.get_suggestion(skills_compass.java:23).
2025-10-27T06:24:53.779: Row 5: at h2.Utils.doPost(Utils.java:794).
2025-10-27T06:24:53.779: Row 6: at h2.Utils.doGet(Utils.java:30).
2025-10-27T06:24:53.780: SUC: 2007, 261ms, lines: 6.
2025-10-27T06:24:53.781: checkJavaStack end: 2007, pid/ret=6.
2025-10-27T06:25:03.781: checkJavaStack starting: 2007.
2025-10-27T06:25:03.868: ------ test: 2007
2025-10-27T06:25:03.868: 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-27T06:25:04.075: SUC: 2007, 207ms, lines: 4096.
2025-10-27T06:25:04.076: checkJavaStack end: 2007, pid/ret=4096.
2025-10-27T06:25:14.076: checkJavaStack starting: 2007.
2025-10-27T06:25:14.196: ------ test: 2007
2025-10-27T06:25:14.196: 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-27T06:25:14.467: SUC: 2007, 271ms, lines: 4096.
2025-10-27T06:25:14.468: checkJavaStack end: 2007, pid/ret=4096.
2025-10-27T06:25:24.468: checkJavaStack starting: 2007.
2025-10-27T06:25:24.556: ------ test: 2007
2025-10-27T06:25:24.556: 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-27T06:25:24.848: SUC: 2007, 292ms, lines: 4096.
2025-10-27T06:25:24.848: checkJavaStack end: 2007, pid/ret=4096.
2025-10-27T06:25:34.848: checkJavaStack starting: 2007.
2025-10-27T06:25:34.935: ------ test: 2007
2025-10-27T06:25:34.935: 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-27T06:25:35.156: Row 1: "Thread-1711" #1161351 daemon prio=5 os_prio=0 tid=0x00007f5620038000 nid=0x17036 runnable [0x00007f564f2fc000].
2025-10-27T06:25:35.157: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-27T06:25:35.157: Row 3: at h2.core2021.semanticSimilarity_v3(core2021.java:1406).
2025-10-27T06:25:35.157: Row 4: at h2.core2021.text2keywords_v3(core2021.java:731).
2025-10-27T06:25:35.157: Row 5: at h2.SkillsForecast_methods.build_a_map_on_fly_builder(SkillsForecast_methods.java:8288).
2025-10-27T06:25:35.157: Row 6: at h2.SkillsForecast_methods.build_a_map_on_fly_prepare(SkillsForecast_methods.java:8203).
2025-10-27T06:25:35.157: Row 7: at h2.helpers.lambda$22(helpers.java:5589).
2025-10-27T06:25:35.157: Row 8: at h2.helpers$$Lambda$566/1475615679.run(Unknown Source).
2025-10-27T06:25:35.158: SUC: 2007, 223ms, lines: 8.
2025-10-27T06:25:35.159: checkJavaStack end: 2007, pid/ret=8.
2025-10-27T06:25:45.159: checkJavaStack starting: 2007.
2025-10-27T06:25:45.243: ------ test: 2007
2025-10-27T06:25:45.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-27T06:25:45.451: SUC: 2007, 208ms, lines: 4096.
2025-10-27T06:25:45.451: checkJavaStack end: 2007, pid/ret=4096.
2025-10-27T06:25:55.451: checkJavaStack starting: 2007.
2025-10-27T06:25:55.539: ------ test: 2007
2025-10-27T06:25:55.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-27T06:25:55.753: SUC: 2007, 214ms, lines: 4096.
2025-10-27T06:25:55.754: checkJavaStack end: 2007, pid/ret=4096.
2025-10-27T06:26:05.754: checkJavaStack starting: 2007.
2025-10-27T06:26:05.839: ------ test: 2007
2025-10-27T06:26:05.839: 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-27T06:26:06.178: Row 1: "https-openssl-nio-443-exec-1760" #1124924 daemon prio=5 os_prio=0 tid=0x00007f563c1cd000 nid=0xebe4 runnable [0x00007f56377f3000].
2025-10-27T06:26:06.178: Row 2: java.lang.Thread.State: RUNNABLE.
2025-10-27T06:26:06.178: Row 3: at java.net.SocketInputStream.socketRead0(Native Method).
2025-10-27T06:26:06.178: Row 4: at java.net.SocketInputStream.socketRead(SocketInputStream.java:116).
2025-10-27T06:26:06.178: Row 5: at java.net.SocketInputStream.read(SocketInputStream.java:171).
2025-10-27T06:26:06.179: Row 6: at java.net.SocketInputStream.read(SocketInputStream.java:141).
2025-10-27T06:26:06.179: Row 7: at sun.security.ssl.SSLSocketInputRecord.read(SSLSocketInputRecord.java:457).
2025-10-27T06:26:06.179: Row 8: at sun.security.ssl.SSLSocketInputRecord.bytesInCompletePacket(SSLSocketInputRecord.java:68).
2025-10-27T06:26:06.179: Row 9: at sun.security.ssl.SSLSocketImpl.readApplicationRecord(SSLSocketImpl.java:1332).
2025-10-27T06:26:06.179: Row 10: at sun.security.ssl.SSLSocketImpl.access$300(SSLSocketImpl.java:73).
2025-10-27T06:26:06.179: Row 11: at sun.security.ssl.SSLSocketImpl$AppInputStream.read(SSLSocketImpl.java:948).
2025-10-27T06:26:06.179: Row 12: at net.snowflake.client.jdbc.internal.apache.http.impl.io.SessionInputBufferImpl.streamRead(SessionInputBufferImpl.java:137).
2025-10-27T06:26:06.179: Row 13: at net.snowflake.client.jdbc.internal.apache.http.impl.io.SessionInputBufferImpl.fillBuffer(SessionInputBufferImpl.java:153).
2025-10-27T06:26:06.179: Row 14: at net.snowflake.client.jdbc.internal.apache.http.impl.io.SessionInputBufferImpl.readLine(SessionInputBufferImpl.java:280).
2025-10-27T06:26:06.179: Row 15: at net.snowflake.client.jdbc.internal.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:138).
2025-10-27T06:26:06.179: Row 16: at net.snowflake.client.jdbc.internal.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:56).
2025-10-27T06:26:06.179: Row 17: at net.snowflake.client.jdbc.internal.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:259).
2025-10-27T06:26:06.180: Row 18: at net.snowflake.client.jdbc.internal.apache.http.impl.DefaultBHttpClientConnection.receiveResponseHeader(DefaultBHttpClientConnection.java:163).
2025-10-27T06:26:06.180: Row 19: at net.snowflake.client.jdbc.internal.apache.http.impl.conn.CPoolProxy.receiveResponseHeader(CPoolProxy.java:157).
2025-10-27T06:26:06.180: Row 20: at net.snowflake.client.jdbc.internal.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:273).
2025-10-27T06:26:06.180: Row 21: at net.snowflake.client.jdbc.internal.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:125).
2025-10-27T06:26:06.180: Row 22: at net.snowflake.client.jdbc.internal.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:272).
2025-10-27T06:26:06.180: Row 23: at net.snowflake.client.jdbc.internal.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:186).
2025-10-27T06:26:06.180: Row 24: at net.snowflake.client.jdbc.internal.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:89).
2025-10-27T06:26:06.181: SUC: 2007, 341ms, lines: 44.
2025-10-27T06:26:06.181: checkJavaStack end: 2007, pid/ret=44.
2025-10-27T06:26:16.181: checkJavaStack starting: 2007.
2025-10-27T06:26:16.299: ------ test: 2007
2025-10-27T06:26:16.299: 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-27T06:26:16.498: SUC: 2007, 199ms, lines: 4096.
2025-10-27T06:26:16.498: checkJavaStack end: 2007, pid/ret=4096.
2025-10-27T06:26:26.498: checkJavaStack starting: 2007.
2025-10-27T06:26:26.589: ------ test: 2007
2025-10-27T06:26:26.589: 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-27T06:26:26.830: SUC: 2007, 240ms, lines: 4096.
2025-10-27T06:26:26.830: checkJavaStack end: 2007, pid/ret=4096.
2025-10-27T06:26:26.833: ------ test: end, 322053ms. Score 39/39.
2025-10-27T06:26:26.835: Test duration: 5m22s.