2024-12-18T08:21:05.189: current working dir: /root/qa/mctester.
2024-12-18T08:21:05.288: current logging dir: ../mctester/www.
2024-12-18T08:21:05.288: ---------------------------------------------------------------
2024-12-18T08:21:05.289: mctester entry: 2024-12-18T08:21:05.289 mode=50
2024-12-18T08:21:05.289: ---------------------------------------------------------------
2024-12-18T08:21:05.410: EXE: 1/git describe --tags.
2024-12-18T08:21:05.423: Row 1: v1.1-201-g90c2042.
2024-12-18T08:21:05.424: EXE: 1/git rev-list --count HEAD.
2024-12-18T08:21:05.429: Row 1: 258.
2024-12-18T08:21:05.429: EXE: 1/git rev-parse HEAD.
2024-12-18T08:21:05.431: Row 1: 90c2042af9ce0b055e0a62dafd703b27e21c4128.
2024-12-18T08:21:05.433: mctester: v1.1.258 (90c2042af9ce0b055e0a62dafd703b27e21c4128).
2024-12-18T08:21:05.434: Entering into a performance tests mode.
2024-12-18T08:21:05.434: ------ test: start, 2024-12-18T08:21:05.434
2024-12-18T08:21:05.435: ------ test: 2000
2024-12-18T08:21:05.435: CMD: ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "top -b -n 1"
2024-12-18T08:21:05.435: EXE: 1/ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "top -b -n 1".
2024-12-18T08:21:35.710: Row 1: top - 08:21:35 up 92 days, 48 min, 1 user, load average: 0.20, 0.09, 0.25.
2024-12-18T08:21:35.710: Row 2: Tasks: 362 total, 1 running, 361 sleeping, 0 stopped, 0 zombie.
2024-12-18T08:21:35.711: Row 3: %Cpu(s): 3.2 us, 0.1 sy, 0.0 ni, 96.6 id, 0.1 wa, 0.0 hi, 0.0 si, 0.0 st.
2024-12-18T08:21:35.711: Row 4: KiB Mem : 13202036+total, 681392 free, 58313940 used, 73025040 buff/cache.
2024-12-18T08:21:35.711: Row 5: KiB Swap: 0 total, 0 free, 0 used. 72119296 avail Mem .
2024-12-18T08:21:35.711: Row 6: .
2024-12-18T08:21:35.712: Row 7: PID USER PR NI VIRT RES SHR S %CPU %MEM TIME+ COMMAND.
2024-12-18T08:21:35.712: Row 8: 1978 mysql 20 0 99.646g 0.047t 674284 S 166.7 38.3 13733:12 mysqld.
2024-12-18T08:21:35.712: Row 9: 65414 root 20 0 14.664g 7.446g 19764 S 20.0 5.9 181:25.80 java.
2024-12-18T08:21:35.712: Row 10: 184 root 20 0 0 0 0 S 13.3 0.0 58:00.25 kswapd0.
2024-12-18T08:21:35.712: Row 11: 1 root 20 0 43660 3788 2504 S 0.0 0.0 3:25.18 init.
2024-12-18T08:21:35.712: Row 12: 2 root 20 0 0 0 0 S 0.0 0.0 0:01.23 kthreadd.
2024-12-18T08:21:35.713: Row 13: 3 root 20 0 0 0 0 S 0.0 0.0 4:29.65 ksoftirqd+.
2024-12-18T08:21:35.713: Row 14: 5 root 0 -20 0 0 0 S 0.0 0.0 0:00.00 kworker/0+.
2024-12-18T08:21:35.713: Row 15: 7 root 20 0 0 0 0 S 0.0 0.0 30:04.87 rcu_sched.
2024-12-18T08:21:35.716: Row 16: 8 root 20 0 0 0 0 S 0.0 0.0 0:00.00 rcu_bh.
2024-12-18T08:21:35.716: Row 17: 9 root rt 0 0 0 0 S 0.0 0.0 0:05.50 migration+.
2024-12-18T08:21:35.717: Row 18: 10 root rt 0 0 0 0 S 0.0 0.0 0:22.18 watchdog/0.
2024-12-18T08:21:35.717: Row 19: 11 root rt 0 0 0 0 S 0.0 0.0 0:20.25 watchdog/1.
2024-12-18T08:21:35.723: Row 20: 12 root rt 0 0 0 0 S 0.0 0.0 0:10.81 migration+.
2024-12-18T08:21:35.723: Row 21: 13 root 20 0 0 0 0 S 0.0 0.0 0:01.79 ksoftirqd+.
2024-12-18T08:21:35.724: Row 22: 15 root 0 -20 0 0 0 S 0.0 0.0 0:00.00 kworker/1+.
2024-12-18T08:21:35.724: Row 23: 16 root rt 0 0 0 0 S 0.0 0.0 0:20.70 watchdog/2.
2024-12-18T08:21:35.724: Row 24: 17 root rt 0 0 0 0 S 0.0 0.0 0:04.59 migration+.
2024-12-18T08:21:35.788: SUC: 30353ms Uptime 92 days, 1min 0.20, 5min 0.09, 15min 0.25, mem:132020360 total / 681392 free / 58313940 used / 73025040 cache / 72119296 avail
2024-12-18T08:21:35.804: ------ test: 2001
2024-12-18T08:21:35.805: CMD: top -b -E k -n 1
2024-12-18T08:21:35.805: EXE: 1/top -b -E k -n 1.
2024-12-18T08:21:35.962: Row 1: top - 08:21:35 up 36 days, 15:03, 1 user, load average: 0.16, 0.03, 0.01.
2024-12-18T08:21:35.962: Row 2: Tasks: 108 total, 1 running, 106 sleeping, 0 stopped, 1 zombie.
2024-12-18T08:21:35.962: Row 3: %Cpu(s): 5.9 us, 5.9 sy, 0.0 ni, 88.2 id, 0.0 wa, 0.0 hi, 0.0 si, 0.0 st.
2024-12-18T08:21:35.962: Row 4: KiB Mem : 1907632 total, 424144 free, 412488 used, 1071000 buff/cache.
2024-12-18T08:21:35.962: Row 5: KiB Swap: 0 total, 0 free, 0 used. 1278328 avail Mem .
2024-12-18T08:21:35.962: Row 6: .
2024-12-18T08:21:35.963: Row 7: PID USER PR NI VIRT RES SHR S %CPU %MEM TIME+ COMMAND.
2024-12-18T08:21:35.963: Row 8: 1 root 20 0 167784 12172 7288 S 0.0 0.6 0:57.72 systemd.
2024-12-18T08:21:35.963: Row 9: 2 root 20 0 0 0 0 S 0.0 0.0 0:00.09 kthreadd.
2024-12-18T08:21:35.963: Row 10: 3 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 rcu_gp.
2024-12-18T08:21:35.963: Row 11: 4 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 rcu_par+.
2024-12-18T08:21:35.963: Row 12: 5 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 slub_fl+.
2024-12-18T08:21:35.963: Row 13: 6 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 netns.
2024-12-18T08:21:35.964: Row 14: 8 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 kworker+.
2024-12-18T08:21:35.964: Row 15: 10 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 mm_perc+.
2024-12-18T08:21:35.964: Row 16: 11 root 20 0 0 0 0 S 0.0 0.0 0:00.00 rcu_tas+.
2024-12-18T08:21:35.964: Row 17: 12 root 20 0 0 0 0 S 0.0 0.0 0:00.00 rcu_tas+.
2024-12-18T08:21:35.964: Row 18: 13 root 20 0 0 0 0 S 0.0 0.0 0:31.32 ksoftir+.
2024-12-18T08:21:35.964: Row 19: 14 root 20 0 0 0 0 I 0.0 0.0 0:53.98 rcu_sch+.
2024-12-18T08:21:35.964: Row 20: 15 root rt 0 0 0 0 S 0.0 0.0 0:07.96 migrati+.
2024-12-18T08:21:35.965: Row 21: 16 root -51 0 0 0 0 S 0.0 0.0 0:00.00 idle_in+.
2024-12-18T08:21:35.965: Row 22: 18 root 20 0 0 0 0 S 0.0 0.0 0:00.00 cpuhp/0.
2024-12-18T08:21:35.965: Row 23: 19 root 20 0 0 0 0 S 0.0 0.0 0:00.00 kdevtmp+.
2024-12-18T08:21:35.965: Row 24: 20 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 inet_fr+.
2024-12-18T08:21:35.976: SUC: 172ms Uptime 36 days, 1min 0.16, 5min 0.03, 15min 0.01, mem:1907632 total / 424144 free / 412488 used / 1071000 cache / 1278328 avail
2024-12-18T08:21:35.977: ------ test: 2002
2024-12-18T08:21:35.977: CMD: df -h
2024-12-18T08:21:35.978: EXE: 1/df -h.
2024-12-18T08:21:35.979: Row 1: Filesystem Size Used Avail Use% Mounted on.
2024-12-18T08:21:35.979: Row 2: tmpfs 187M 20M 167M 11% /run.
2024-12-18T08:21:35.980: Row 3: /dev/vda2 20G 14G 5.2G 73% /.
2024-12-18T08:21:35.980: Row 4: tmpfs 932M 0 932M 0% /dev/shm.
2024-12-18T08:21:35.980: Row 5: tmpfs 5.0M 0 5.0M 0% /run/lock.
2024-12-18T08:21:35.980: Row 6: tmpfs 187M 4.0K 187M 1% /run/user/0.
2024-12-18T08:21:35.982: SUC: 5ms Diskfree qa.headai.com: tmpfs:11%, /dev/vda2:73%, tmpfs:0%, tmpfs:0%, tmpfs:1%.
2024-12-18T08:21:35.982: ------ test: 2003
2024-12-18T08:21:35.982: CMD: ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "df -h"
2024-12-18T08:21:35.983: EXE: 1/ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "df -h".
2024-12-18T08:22:06.109: Row 1: Filesystem Size Used Avail Use% Mounted on.
2024-12-18T08:22:06.110: Row 2: udev 63G 4.0K 63G 1% /dev.
2024-12-18T08:22:06.110: Row 3: tmpfs 13G 544M 13G 5% /run.
2024-12-18T08:22:06.110: Row 4: /dev/vda1 757G 512G 214G 71% /.
2024-12-18T08:22:06.110: Row 5: none 4.0K 0 4.0K 0% /sys/fs/cgroup.
2024-12-18T08:22:06.110: Row 6: none 5.0M 0 5.0M 0% /run/lock.
2024-12-18T08:22:06.110: Row 7: cgmfs 100K 0 100K 0% /run/cgmanager/fs.
2024-12-18T08:22:06.110: Row 8: none 63G 0 63G 0% /run/shm.
2024-12-18T08:22:06.110: Row 9: none 100M 0 100M 0% /run/user.
2024-12-18T08:22:06.111: Row 10: /dev/vdb 985G 230G 705G 25% /opt/tomcat/webapps/ROOT/analysis.
2024-12-18T08:22:06.111: Row 11: tmpfs 100K 0 100K 0% /var/lib/lxd/shmounts.
2024-12-18T08:22:06.111: Row 12: tmpfs 100K 0 100K 0% /var/lib/lxd/devlxd.
2024-12-18T08:22:06.111: Row 13: tmpfs 13G 0 13G 0% /run/user/0.
2024-12-18T08:22:06.115: SUC: 30133ms Diskfree megatron.headai.com: udev:1%, tmpfs:5%, /dev/vda1:71%, none:0%, none:0%, cgmfs:0%, none:0%, none:0%, /dev/vdb:25%, tmpfs:0%, tmpfs:0%, tmpfs:0%.
2024-12-18T08:22:06.121: ------ test: 2004
2024-12-18T08:22:06.122: URL: https://headai.com
2024-12-18T08:22:06.798: SUC: 675ms, Trusted by 100+ customers and partners globally, length 185391.
2024-12-18T08:22:06.800: ------ test: 2005
2024-12-18T08:22:07.245: SQL: show global status like 'threads_connected';.
2024-12-18T08:22:07.262: Results: value=4/200.
2024-12-18T08:22:07.262: SQL: value, lines: 1, ret=1, 4.
2024-12-18T08:22:07.269: SUC: 469ms 4
2024-12-18T08:22:07.270: ------ test: 2006
2024-12-18T08:22:07.373: SQL: SHOW PROCESSLIST;.
2024-12-18T08:22:07.382: Row 1: 25567811,root,localhost:34086,competences,Query,40,Sending data,SELECT count(id) as total FROM jobs.items_2021 WHERE (1=1) AND length(description)>100 AND year(rea.
2024-12-18T08:22:07.383: Row 2: 25568002,root,localhost:34492,null,Query,0,starting,SHOW PROCESSLIST.
2024-12-18T08:22:07.383: SQL: COUNTNOTLINES:Command, lines: 2, ret=2, 2.
2024-12-18T08:22:07.385: SUC: 115ms 2
2024-12-18T08:22:07.387: checkJavaStack starting: 2007.
2024-12-18T08:22:37.537: ------ test: 2007
2024-12-18T08:22:37.537: EXE: 5/"jstack 65414 | 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".
2024-12-18T08:23:07.801: Row 1: "https-openssl-nio-443-exec-4" #35 daemon prio=5 os_prio=0 tid=0x00007f0fec733000 nid=0x10089 runnable [0x00007f0f85cca000].
2024-12-18T08:23:07.801: Row 2: java.lang.Thread.State: RUNNABLE.
2024-12-18T08:23:07.802: Row 3: at h1.body.wordToBody(body.java:286).
2024-12-18T08:23:07.802: Row 4: at h2.core2021.semanticSimilarity_v3(core2021.java:1369).
2024-12-18T08:23:07.802: Row 5: at h2.core2021.text2keywords_v3(core2021.java:727).
2024-12-18T08:23:07.802: Row 6: at h2.BuildKnowledgeGraph_v5.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v5.java:1727).
2024-12-18T08:23:07.802: Row 7: at h2.SkillsForecast_methods.build_a_map_on_fly_v4(SkillsForecast_methods.java:5221).
2024-12-18T08:23:07.802: Row 8: at h2.helpers.check_pending_works(helpers.java:5270).
2024-12-18T08:23:07.802: Row 9: at h1.mc_api.doPost(mc_api.java:4576).
2024-12-18T08:23:07.802: Row 10: at h1.mc_api.doGet(mc_api.java:38).
2024-12-18T08:23:07.805: SUC: 2007, 30268ms, lines: 10.
2024-12-18T08:23:07.806: checkJavaStack end: 2007, pid/ret=10.
2024-12-18T08:23:17.806: checkJavaStack starting: 2007.
2024-12-18T08:23:47.930: ------ test: 2007
2024-12-18T08:23:47.931: EXE: 5/"jstack 65414 | 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".
2024-12-18T08:24:18.235: Row 1: "https-openssl-nio-443-exec-16" #52 daemon prio=5 os_prio=0 tid=0x00007f0ea8003000 nid=0x10099 runnable [0x00007f0f84aba000].
2024-12-18T08:24:18.244: Row 2: java.lang.Thread.State: RUNNABLE.
2024-12-18T08:24:18.245: Row 3: at h1.body.wordToBody(body.java:286).
2024-12-18T08:24:18.245: Row 4: at h2.core2021.semanticSimilarity_v3(core2021.java:1393).
2024-12-18T08:24:18.245: Row 5: at h2.core2021.text2keywords_v3(core2021.java:727).
2024-12-18T08:24:18.245: Row 6: at h2.BuildKnowledgeGraph_v5.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v5.java:1727).
2024-12-18T08:24:18.245: Row 7: at h2.SkillsForecast_methods.build_a_map_on_fly_v4(SkillsForecast_methods.java:5221).
2024-12-18T08:24:18.246: Row 8: at h2.helpers.check_pending_works(helpers.java:5270).
2024-12-18T08:24:18.246: Row 9: at h1.mc_api.doPost(mc_api.java:4576).
2024-12-18T08:24:18.246: Row 10: at h1.mc_api.doGet(mc_api.java:38).
2024-12-18T08:24:18.247: SUC: 2007, 30316ms, lines: 10.
2024-12-18T08:24:18.247: checkJavaStack end: 2007, pid/ret=10.
2024-12-18T08:24:28.247: checkJavaStack starting: 2007.
2024-12-18T08:24:58.387: ------ test: 2007
2024-12-18T08:24:58.387: EXE: 5/"jstack 65414 | 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".
2024-12-18T08:25:28.624: Row 1: "https-openssl-nio-443-exec-16" #52 daemon prio=5 os_prio=0 tid=0x00007f0ea8003000 nid=0x10099 runnable [0x00007f0f84aba000].
2024-12-18T08:25:28.625: Row 2: java.lang.Thread.State: RUNNABLE.
2024-12-18T08:25:28.625: Row 3: at java.lang.String.split(String.java:2354).
2024-12-18T08:25:28.625: Row 4: at java.lang.String.split(String.java:2422).
2024-12-18T08:25:28.625: Row 5: at h2.core2021.networkMatchSuperFast(core2021.java:3160).
2024-12-18T08:25:28.625: Row 6: at h2.core2021.semanticSimilarity_v3(core2021.java:1418).
2024-12-18T08:25:28.625: Row 7: at h2.core2021.text2keywords_v3(core2021.java:727).
2024-12-18T08:25:28.625: Row 8: at h2.BuildKnowledgeGraph_v5.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v5.java:1727).
2024-12-18T08:25:28.625: Row 9: at h2.SkillsForecast_methods.build_a_map_on_fly_v4(SkillsForecast_methods.java:5221).
2024-12-18T08:25:28.625: Row 10: at h2.helpers.check_pending_works(helpers.java:5270).
2024-12-18T08:25:28.626: Row 11: at h1.mc_api.doPost(mc_api.java:4576).
2024-12-18T08:25:28.627: Row 12: at h1.mc_api.doGet(mc_api.java:38).
2024-12-18T08:25:28.628: SUC: 2007, 30241ms, lines: 12.
2024-12-18T08:25:28.631: checkJavaStack end: 2007, pid/ret=12.
2024-12-18T08:25:38.631: checkJavaStack starting: 2007.
2024-12-18T08:26:08.774: ------ test: 2007
2024-12-18T08:26:08.775: EXE: 5/"jstack 65414 | 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".
2024-12-18T08:26:39.038: SUC: 2007, 30263ms, lines: 4096.
2024-12-18T08:26:39.039: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T08:26:49.039: checkJavaStack starting: 2007.
2024-12-18T08:27:19.181: ------ test: 2007
2024-12-18T08:27:19.181: EXE: 5/"jstack 65414 | 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".
2024-12-18T08:27:49.405: SUC: 2007, 30224ms, lines: 4096.
2024-12-18T08:27:49.406: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T08:27:59.406: checkJavaStack starting: 2007.
2024-12-18T08:28:29.530: ------ test: 2007
2024-12-18T08:28:29.530: EXE: 5/"jstack 65414 | 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".
2024-12-18T08:29:00.128: Row 1: "https-openssl-nio-443-exec-9" #40 daemon prio=5 os_prio=0 tid=0x00007f0fec713800 nid=0x1008e runnable [0x00007f0f857c6000].
2024-12-18T08:29:00.128: Row 2: java.lang.Thread.State: RUNNABLE.
2024-12-18T08:29:00.128: Row 3: at java.util.regex.Pattern$7.isSatisfiedBy(Pattern.java:5285).
2024-12-18T08:29:00.128: Row 4: at java.util.regex.Pattern$7.isSatisfiedBy(Pattern.java:5285).
2024-12-18T08:29:00.129: Row 5: at java.util.regex.Pattern$7.isSatisfiedBy(Pattern.java:5285).
2024-12-18T08:29:00.129: Row 6: at java.util.regex.Pattern$7.isSatisfiedBy(Pattern.java:5285).
2024-12-18T08:29:00.129: Row 7: at java.util.regex.Pattern$7.isSatisfiedBy(Pattern.java:5285).
2024-12-18T08:29:00.129: Row 8: at java.util.regex.Pattern$7.isSatisfiedBy(Pattern.java:5285).
2024-12-18T08:29:00.129: Row 9: at java.util.regex.Pattern$CharProperty.match(Pattern.java:3790).
2024-12-18T08:29:00.131: Row 10: at java.util.regex.Pattern$Start.match(Pattern.java:3475).
2024-12-18T08:29:00.131: Row 11: at java.util.regex.Matcher.search(Matcher.java:1248).
2024-12-18T08:29:00.131: Row 12: at java.util.regex.Matcher.find(Matcher.java:637).
2024-12-18T08:29:00.131: Row 13: at java.util.regex.Matcher.replaceAll(Matcher.java:956).
2024-12-18T08:29:00.131: Row 14: at java.lang.String.replaceAll(String.java:2223).
2024-12-18T08:29:00.131: Row 15: at h2.core2021.semanticSimilarity_v3(core2021.java:1211).
2024-12-18T08:29:00.131: Row 16: at h2.core2021.text2keywords_v3(core2021.java:727).
2024-12-18T08:29:00.132: Row 17: at h2.jobs_educations.search_terms_to_weighted_map(jobs_educations.java:1770).
2024-12-18T08:29:00.132: Row 18: at h2.scorecard.similarity_match_in_cache_table(scorecard.java:1874).
2024-12-18T08:29:00.132: Row 19: at h2.SemanticSimilarity.doPost(SemanticSimilarity.java:140).
2024-12-18T08:29:00.132: Row 20: at h2.SemanticSimilarity.doGet(SemanticSimilarity.java:20).
2024-12-18T08:29:00.140: SUC: 2007, 30610ms, lines: 20.
2024-12-18T08:29:00.140: checkJavaStack end: 2007, pid/ret=20.
2024-12-18T08:29:10.140: checkJavaStack starting: 2007.
2024-12-18T08:29:40.256: ------ test: 2007
2024-12-18T08:29:40.256: EXE: 5/"jstack 65414 | 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".
2024-12-18T08:30:10.474: Row 1: "https-openssl-nio-443-exec-10" #41 daemon prio=5 os_prio=0 tid=0x00007f0fec1bf800 nid=0x1008f runnable [0x00007f0f856c4000].
2024-12-18T08:30:10.474: Row 2: java.lang.Thread.State: RUNNABLE.
2024-12-18T08:30:10.474: Row 3: at java.net.SocketInputStream.socketRead0(Native Method).
2024-12-18T08:30:10.474: Row 4: at java.net.SocketInputStream.socketRead(SocketInputStream.java:116).
2024-12-18T08:30:10.474: Row 5: at java.net.SocketInputStream.read(SocketInputStream.java:171).
2024-12-18T08:30:10.474: Row 6: at java.net.SocketInputStream.read(SocketInputStream.java:141).
2024-12-18T08:30:10.475: Row 7: at sun.security.ssl.SSLSocketInputRecord.read(SSLSocketInputRecord.java:457).
2024-12-18T08:30:10.475: Row 8: at sun.security.ssl.SSLSocketInputRecord.bytesInCompletePacket(SSLSocketInputRecord.java:68).
2024-12-18T08:30:10.475: Row 9: at sun.security.ssl.SSLSocketImpl.readApplicationRecord(SSLSocketImpl.java:1332).
2024-12-18T08:30:10.475: Row 10: at sun.security.ssl.SSLSocketImpl.access$300(SSLSocketImpl.java:73).
2024-12-18T08:30:10.475: Row 11: at sun.security.ssl.SSLSocketImpl$AppInputStream.read(SSLSocketImpl.java:948).
2024-12-18T08:30:10.475: Row 12: at net.snowflake.client.jdbc.internal.apache.http.impl.io.SessionInputBufferImpl.streamRead(SessionInputBufferImpl.java:137).
2024-12-18T08:30:10.481: Row 13: at net.snowflake.client.jdbc.internal.apache.http.impl.io.SessionInputBufferImpl.fillBuffer(SessionInputBufferImpl.java:153).
2024-12-18T08:30:10.481: Row 14: at net.snowflake.client.jdbc.internal.apache.http.impl.io.SessionInputBufferImpl.readLine(SessionInputBufferImpl.java:280).
2024-12-18T08:30:10.481: Row 15: at net.snowflake.client.jdbc.internal.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:138).
2024-12-18T08:30:10.482: Row 16: at net.snowflake.client.jdbc.internal.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:56).
2024-12-18T08:30:10.482: Row 17: at net.snowflake.client.jdbc.internal.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:259).
2024-12-18T08:30:10.484: Row 18: at net.snowflake.client.jdbc.internal.apache.http.impl.DefaultBHttpClientConnection.receiveResponseHeader(DefaultBHttpClientConnection.java:163).
2024-12-18T08:30:10.484: Row 19: at net.snowflake.client.jdbc.internal.apache.http.impl.conn.CPoolProxy.receiveResponseHeader(CPoolProxy.java:157).
2024-12-18T08:30:10.486: Row 20: at net.snowflake.client.jdbc.internal.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:273).
2024-12-18T08:30:10.486: Row 21: at net.snowflake.client.jdbc.internal.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:125).
2024-12-18T08:30:10.486: Row 22: at net.snowflake.client.jdbc.internal.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:272).
2024-12-18T08:30:10.486: Row 23: at net.snowflake.client.jdbc.internal.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:186).
2024-12-18T08:30:10.487: Row 24: at net.snowflake.client.jdbc.internal.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:89).
2024-12-18T08:30:10.492: SUC: 2007, 30236ms, lines: 70.
2024-12-18T08:30:10.493: checkJavaStack end: 2007, pid/ret=70.
2024-12-18T08:30:20.493: checkJavaStack starting: 2007.
2024-12-18T08:30:50.608: ------ test: 2007
2024-12-18T08:30:50.609: EXE: 5/"jstack 65414 | 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".
2024-12-18T08:31:20.880: SUC: 2007, 30271ms, lines: 4096.
2024-12-18T08:31:20.880: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T08:31:30.880: checkJavaStack starting: 2007.
2024-12-18T08:32:01.027: ------ test: 2007
2024-12-18T08:32:01.028: EXE: 5/"jstack 65414 | 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".
2024-12-18T08:32:31.274: SUC: 2007, 30246ms, lines: 4096.
2024-12-18T08:32:31.274: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T08:32:41.274: checkJavaStack starting: 2007.
2024-12-18T08:33:11.416: ------ test: 2007
2024-12-18T08:33:11.416: EXE: 5/"jstack 65414 | 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".
2024-12-18T08:33:41.710: SUC: 2007, 30294ms, lines: 4096.
2024-12-18T08:33:41.710: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T08:33:51.711: checkJavaStack starting: 2007.
2024-12-18T08:34:21.830: ------ test: 2007
2024-12-18T08:34:21.830: EXE: 5/"jstack 65414 | 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".
2024-12-18T08:34:52.070: SUC: 2007, 30239ms, lines: 4096.
2024-12-18T08:34:52.070: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T08:35:02.070: checkJavaStack starting: 2007.
2024-12-18T08:35:32.212: ------ test: 2007
2024-12-18T08:35:32.212: EXE: 5/"jstack 65414 | 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".
2024-12-18T08:36:02.472: SUC: 2007, 30260ms, lines: 4096.
2024-12-18T08:36:02.473: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T08:36:12.473: checkJavaStack starting: 2007.
2024-12-18T08:36:42.616: ------ test: 2007
2024-12-18T08:36:42.617: EXE: 5/"jstack 65414 | 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".
2024-12-18T08:37:12.842: SUC: 2007, 30225ms, lines: 4096.
2024-12-18T08:37:12.843: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T08:37:22.843: checkJavaStack starting: 2007.
2024-12-18T08:37:22.951: WRN: stderr, bash: warning: setlocale: LC_ALL: cannot change locale (C.utf8).
2024-12-18T08:37:22.953: checkJavaStack end: 2007, pid/ret=0.
2024-12-18T08:37:22.953: ------ test: end, 977519ms. Score 20/20.
2024-12-18T08:37:22.953: Test duration: 16m17s.