2024-12-18T09:57:27.377: current working dir: /root/qa/mctester.
2024-12-18T09:57:27.479: current logging dir: ../mctester/www.
2024-12-18T09:57:27.479: ---------------------------------------------------------------
2024-12-18T09:57:27.479: mctester entry: 2024-12-18T09:57:27.479 mode=50
2024-12-18T09:57:27.480: ---------------------------------------------------------------
2024-12-18T09:57:27.589: EXE: 1/git describe --tags.
2024-12-18T09:57:27.608: Row 1: v1.1-201-g90c2042.
2024-12-18T09:57:27.609: EXE: 1/git rev-list --count HEAD.
2024-12-18T09:57:27.615: Row 1: 258.
2024-12-18T09:57:27.615: EXE: 1/git rev-parse HEAD.
2024-12-18T09:57:27.617: Row 1: 90c2042af9ce0b055e0a62dafd703b27e21c4128.
2024-12-18T09:57:27.618: mctester: v1.1.258 (90c2042af9ce0b055e0a62dafd703b27e21c4128).
2024-12-18T09:57:27.618: Entering into a performance tests mode.
2024-12-18T09:57:27.619: ------ test: start, 2024-12-18T09:57:27.618
2024-12-18T09:57:27.619: ------ test: 2000
2024-12-18T09:57:27.620: CMD: ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "top -b -n 1"
2024-12-18T09:57:27.620: EXE: 1/ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "top -b -n 1".
2024-12-18T09:57:27.879: Row 1: top - 09:57:27 up 92 days, 2:24, 5 users, load average: 0.07, 0.02, 0.04.
2024-12-18T09:57:27.879: Row 2: Tasks: 369 total, 1 running, 368 sleeping, 0 stopped, 0 zombie.
2024-12-18T09:57:27.880: 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-18T09:57:27.880: Row 4: KiB Mem : 13202036+total, 684996 free, 58656524 used, 72678848 buff/cache.
2024-12-18T09:57:27.880: Row 5: KiB Swap: 0 total, 0 free, 0 used. 71776792 avail Mem .
2024-12-18T09:57:27.880: Row 6: .
2024-12-18T09:57:27.880: Row 7: PID USER PR NI VIRT RES SHR S %CPU %MEM TIME+ COMMAND.
2024-12-18T09:57:27.880: Row 8: 53074 root 20 0 43924 3900 3208 R 6.7 0.0 0:00.01 top.
2024-12-18T09:57:27.881: Row 9: 65414 root 20 0 14.664g 7.756g 19584 S 6.7 6.2 188:42.64 java.
2024-12-18T09:57:27.881: Row 10: 1 root 20 0 43660 3816 2532 S 0.0 0.0 3:25.31 init.
2024-12-18T09:57:27.881: Row 11: 2 root 20 0 0 0 0 S 0.0 0.0 0:01.23 kthreadd.
2024-12-18T09:57:27.881: Row 12: 3 root 20 0 0 0 0 S 0.0 0.0 4:30.05 ksoftirqd+.
2024-12-18T09:57:27.882: Row 13: 5 root 0 -20 0 0 0 S 0.0 0.0 0:00.00 kworker/0+.
2024-12-18T09:57:27.885: Row 14: 7 root 20 0 0 0 0 S 0.0 0.0 30:05.80 rcu_sched.
2024-12-18T09:57:27.888: Row 15: 8 root 20 0 0 0 0 S 0.0 0.0 0:00.00 rcu_bh.
2024-12-18T09:57:27.888: Row 16: 9 root rt 0 0 0 0 S 0.0 0.0 0:05.50 migration+.
2024-12-18T09:57:27.889: Row 17: 10 root rt 0 0 0 0 S 0.0 0.0 0:22.19 watchdog/0.
2024-12-18T09:57:27.889: Row 18: 11 root rt 0 0 0 0 S 0.0 0.0 0:20.27 watchdog/1.
2024-12-18T09:57:27.889: Row 19: 12 root rt 0 0 0 0 S 0.0 0.0 0:10.82 migration+.
2024-12-18T09:57:27.890: Row 20: 13 root 20 0 0 0 0 S 0.0 0.0 0:01.79 ksoftirqd+.
2024-12-18T09:57:27.890: Row 21: 15 root 0 -20 0 0 0 S 0.0 0.0 0:00.00 kworker/1+.
2024-12-18T09:57:27.891: Row 22: 16 root rt 0 0 0 0 S 0.0 0.0 0:20.71 watchdog/2.
2024-12-18T09:57:27.891: Row 23: 17 root rt 0 0 0 0 S 0.0 0.0 0:04.60 migration+.
2024-12-18T09:57:27.891: Row 24: 18 root 20 0 0 0 0 S 0.0 0.0 0:01.45 ksoftirqd+.
2024-12-18T09:57:27.959: SUC: 339ms Uptime 92 days, 1min 0.07, 5min 0.02, 15min 0.04, mem:132020360 total / 684996 free / 58656524 used / 72678848 cache / 71776792 avail
2024-12-18T09:57:27.975: ------ test: 2001
2024-12-18T09:57:27.975: CMD: top -b -E k -n 1
2024-12-18T09:57:27.975: EXE: 1/top -b -E k -n 1.
2024-12-18T09:57:28.131: Row 1: top - 09:57:28 up 36 days, 16:39, 3 users, load average: 0.16, 0.06, 0.01.
2024-12-18T09:57:28.132: Row 2: Tasks: 100 total, 1 running, 99 sleeping, 0 stopped, 0 zombie.
2024-12-18T09:57:28.132: Row 3: %Cpu(s): 0.0 us, 0.0 sy, 0.0 ni,100.0 id, 0.0 wa, 0.0 hi, 0.0 si, 0.0 st.
2024-12-18T09:57:28.132: Row 4: KiB Mem : 1907632 total, 501824 free, 339724 used, 1066084 buff/cache.
2024-12-18T09:57:28.132: Row 5: KiB Swap: 0 total, 0 free, 0 used. 1351080 avail Mem .
2024-12-18T09:57:28.132: Row 6: .
2024-12-18T09:57:28.132: Row 7: PID USER PR NI VIRT RES SHR S %CPU %MEM TIME+ COMMAND.
2024-12-18T09:57:28.132: Row 8: 1 root 20 0 167784 12172 7288 S 0.0 0.6 0:57.81 systemd.
2024-12-18T09:57:28.133: Row 9: 2 root 20 0 0 0 0 S 0.0 0.0 0:00.09 kthreadd.
2024-12-18T09:57:28.133: Row 10: 3 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 rcu_gp.
2024-12-18T09:57:28.133: Row 11: 4 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 rcu_par+.
2024-12-18T09:57:28.134: Row 12: 5 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 slub_fl+.
2024-12-18T09:57:28.134: Row 13: 6 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 netns.
2024-12-18T09:57:28.134: Row 14: 8 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 kworker+.
2024-12-18T09:57:28.135: Row 15: 10 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 mm_perc+.
2024-12-18T09:57:28.136: Row 16: 11 root 20 0 0 0 0 S 0.0 0.0 0:00.00 rcu_tas+.
2024-12-18T09:57:28.137: Row 17: 12 root 20 0 0 0 0 S 0.0 0.0 0:00.00 rcu_tas+.
2024-12-18T09:57:28.137: Row 18: 13 root 20 0 0 0 0 S 0.0 0.0 0:31.37 ksoftir+.
2024-12-18T09:57:28.138: Row 19: 14 root 20 0 0 0 0 I 0.0 0.0 0:54.07 rcu_sch+.
2024-12-18T09:57:28.138: Row 20: 15 root rt 0 0 0 0 S 0.0 0.0 0:07.98 migrati+.
2024-12-18T09:57:28.139: Row 21: 16 root -51 0 0 0 0 S 0.0 0.0 0:00.00 idle_in+.
2024-12-18T09:57:28.139: Row 22: 18 root 20 0 0 0 0 S 0.0 0.0 0:00.00 cpuhp/0.
2024-12-18T09:57:28.139: Row 23: 19 root 20 0 0 0 0 S 0.0 0.0 0:00.00 kdevtmp+.
2024-12-18T09:57:28.139: Row 24: 20 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 inet_fr+.
2024-12-18T09:57:28.146: SUC: 171ms Uptime 36 days, 1min 0.16, 5min 0.06, 15min 0.01, mem:1907632 total / 501824 free / 339724 used / 1066084 cache / 1351080 avail
2024-12-18T09:57:28.147: ------ test: 2002
2024-12-18T09:57:28.147: CMD: df -h
2024-12-18T09:57:28.148: EXE: 1/df -h.
2024-12-18T09:57:28.150: Row 1: Filesystem Size Used Avail Use% Mounted on.
2024-12-18T09:57:28.151: Row 2: tmpfs 187M 20M 167M 11% /run.
2024-12-18T09:57:28.151: Row 3: /dev/vda2 20G 14G 5.2G 73% /.
2024-12-18T09:57:28.151: Row 4: tmpfs 932M 0 932M 0% /dev/shm.
2024-12-18T09:57:28.151: Row 5: tmpfs 5.0M 0 5.0M 0% /run/lock.
2024-12-18T09:57:28.151: Row 6: tmpfs 187M 4.0K 187M 1% /run/user/0.
2024-12-18T09:57:28.153: SUC: 6ms Diskfree qa.headai.com: tmpfs:11%, /dev/vda2:73%, tmpfs:0%, tmpfs:0%, tmpfs:1%.
2024-12-18T09:57:28.153: ------ test: 2003
2024-12-18T09:57:28.154: CMD: ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "df -h"
2024-12-18T09:57:28.154: EXE: 1/ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "df -h".
2024-12-18T09:57:28.249: Row 1: Filesystem Size Used Avail Use% Mounted on.
2024-12-18T09:57:28.249: Row 2: udev 63G 4.0K 63G 1% /dev.
2024-12-18T09:57:28.249: Row 3: tmpfs 13G 544M 13G 5% /run.
2024-12-18T09:57:28.250: Row 4: /dev/vda1 757G 512G 214G 71% /.
2024-12-18T09:57:28.250: Row 5: none 4.0K 0 4.0K 0% /sys/fs/cgroup.
2024-12-18T09:57:28.251: Row 6: none 5.0M 0 5.0M 0% /run/lock.
2024-12-18T09:57:28.251: Row 7: cgmfs 100K 0 100K 0% /run/cgmanager/fs.
2024-12-18T09:57:28.251: Row 8: none 63G 0 63G 0% /run/shm.
2024-12-18T09:57:28.251: Row 9: none 100M 0 100M 0% /run/user.
2024-12-18T09:57:28.251: Row 10: /dev/vdb 985G 230G 705G 25% /opt/tomcat/webapps/ROOT/analysis.
2024-12-18T09:57:28.251: Row 11: tmpfs 100K 0 100K 0% /var/lib/lxd/shmounts.
2024-12-18T09:57:28.251: Row 12: tmpfs 100K 0 100K 0% /var/lib/lxd/devlxd.
2024-12-18T09:57:28.251: Row 13: tmpfs 13G 0 13G 0% /run/user/0.
2024-12-18T09:57:28.258: SUC: 104ms 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-18T09:57:28.259: ------ test: 2004
2024-12-18T09:57:28.259: URL: https://headai.com
2024-12-18T09:57:28.834: SUC: 574ms, Trusted by 100+ customers and partners globally, length 185391.
2024-12-18T09:57:28.866: ------ test: 2005
2024-12-18T09:57:29.329: SQL: show global status like 'threads_connected';.
2024-12-18T09:57:29.349: Results: value=3/200.
2024-12-18T09:57:29.349: SQL: value, lines: 1, ret=1, 3.
2024-12-18T09:57:29.350: SUC: 484ms 3
2024-12-18T09:57:29.350: ------ test: 2006
2024-12-18T09:57:29.453: SQL: SHOW PROCESSLIST;.
2024-12-18T09:57:29.456: Row 1: 25576506,root,localhost:55484,null,Query,0,starting,SHOW PROCESSLIST.
2024-12-18T09:57:29.456: SQL: COUNTNOTLINES:Command, lines: 1, ret=1, 1.
2024-12-18T09:57:29.461: SUC: 110ms 1
2024-12-18T09:57:29.463: checkJavaStack starting: 2007.
2024-12-18T09:57:29.574: ------ test: 2007
2024-12-18T09:57:29.574: 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-18T09:57:29.817: SUC: 2007, 243ms, lines: 4096.
2024-12-18T09:57:29.822: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T09:57:39.822: checkJavaStack starting: 2007.
2024-12-18T09:57:39.929: ------ test: 2007
2024-12-18T09:57:39.929: 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-18T09:57:40.156: SUC: 2007, 227ms, lines: 4096.
2024-12-18T09:57:40.157: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T09:57:50.157: checkJavaStack starting: 2007.
2024-12-18T09:57:50.270: ------ test: 2007
2024-12-18T09:57:50.271: 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-18T09:57:50.496: SUC: 2007, 225ms, lines: 4096.
2024-12-18T09:57:50.497: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T09:58:00.497: checkJavaStack starting: 2007.
2024-12-18T09:58:00.605: ------ test: 2007
2024-12-18T09:58:00.606: 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-18T09:58:00.823: SUC: 2007, 217ms, lines: 4096.
2024-12-18T09:58:00.823: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T09:58:10.824: checkJavaStack starting: 2007.
2024-12-18T09:58:10.934: ------ test: 2007
2024-12-18T09:58:10.934: 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-18T09:58:11.156: SUC: 2007, 222ms, lines: 4096.
2024-12-18T09:58:11.156: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T09:58:21.156: checkJavaStack starting: 2007.
2024-12-18T09:58:21.265: ------ test: 2007
2024-12-18T09:58:21.266: 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-18T09:58:21.501: SUC: 2007, 235ms, lines: 4096.
2024-12-18T09:58:21.502: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T09:58:31.502: checkJavaStack starting: 2007.
2024-12-18T09:58:31.614: ------ test: 2007
2024-12-18T09:58:31.614: 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-18T09:58:31.851: SUC: 2007, 237ms, lines: 4096.
2024-12-18T09:58:31.852: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T09:58:41.852: checkJavaStack starting: 2007.
2024-12-18T09:58:41.960: ------ test: 2007
2024-12-18T09:58:41.960: 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-18T09:58:42.175: SUC: 2007, 215ms, lines: 4096.
2024-12-18T09:58:42.175: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T09:58:52.175: checkJavaStack starting: 2007.
2024-12-18T09:58:52.320: ------ test: 2007
2024-12-18T09:58:52.320: 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-18T09:58:52.532: SUC: 2007, 212ms, lines: 4096.
2024-12-18T09:58:52.532: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T09:59:02.532: checkJavaStack starting: 2007.
2024-12-18T09:59:02.645: ------ test: 2007
2024-12-18T09:59:02.645: 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-18T09:59:02.869: SUC: 2007, 224ms, lines: 4096.
2024-12-18T09:59:02.870: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T09:59:12.870: checkJavaStack starting: 2007.
2024-12-18T09:59:12.977: ------ test: 2007
2024-12-18T09:59:12.980: 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-18T09:59:13.208: SUC: 2007, 228ms, lines: 4096.
2024-12-18T09:59:13.208: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T09:59:23.208: checkJavaStack starting: 2007.
2024-12-18T09:59:23.317: ------ test: 2007
2024-12-18T09:59:23.317: 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-18T09:59:23.527: SUC: 2007, 210ms, lines: 4096.
2024-12-18T09:59:23.527: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T09:59:33.527: checkJavaStack starting: 2007.
2024-12-18T09:59:33.642: ------ test: 2007
2024-12-18T09:59:33.643: 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-18T09:59:33.858: SUC: 2007, 215ms, lines: 4096.
2024-12-18T09:59:33.858: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T09:59:43.858: checkJavaStack starting: 2007.
2024-12-18T09:59:43.969: ------ test: 2007
2024-12-18T09:59:43.969: 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-18T09:59:44.195: SUC: 2007, 226ms, lines: 4096.
2024-12-18T09:59:44.196: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T09:59:54.196: checkJavaStack starting: 2007.
2024-12-18T09:59:54.304: ------ test: 2007
2024-12-18T09:59:54.304: 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-18T09:59:54.524: SUC: 2007, 220ms, lines: 4096.
2024-12-18T09:59:54.524: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T10:00:04.525: checkJavaStack starting: 2007.
2024-12-18T10:00:04.638: ------ test: 2007
2024-12-18T10:00:04.638: 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-18T10:00:04.868: SUC: 2007, 230ms, lines: 4096.
2024-12-18T10:00:04.868: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T10:00:14.869: checkJavaStack starting: 2007.
2024-12-18T10:00:14.979: ------ test: 2007
2024-12-18T10:00:14.979: 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-18T10:00:15.188: SUC: 2007, 209ms, lines: 4096.
2024-12-18T10:00:15.189: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T10:00:25.189: checkJavaStack starting: 2007.
2024-12-18T10:00:25.297: ------ test: 2007
2024-12-18T10:00:25.298: 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-18T10:00:25.553: SUC: 2007, 255ms, lines: 4096.
2024-12-18T10:00:25.553: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T10:00:35.554: checkJavaStack starting: 2007.
2024-12-18T10:00:35.666: ------ test: 2007
2024-12-18T10:00:35.666: 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-18T10:00:35.883: SUC: 2007, 217ms, lines: 4096.
2024-12-18T10:00:35.883: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T10:00:45.883: checkJavaStack starting: 2007.
2024-12-18T10:00:45.988: ------ test: 2007
2024-12-18T10:00:45.989: 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-18T10:00:46.199: SUC: 2007, 210ms, lines: 4096.
2024-12-18T10:00:46.200: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T10:00:56.200: checkJavaStack starting: 2007.
2024-12-18T10:00:56.309: ------ test: 2007
2024-12-18T10:00:56.310: 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-18T10:00:56.525: SUC: 2007, 215ms, lines: 4096.
2024-12-18T10:00:56.526: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T10:01:06.527: checkJavaStack starting: 2007.
2024-12-18T10:01:06.638: ------ test: 2007
2024-12-18T10:01:06.638: 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-18T10:01:06.897: SUC: 2007, 259ms, lines: 4096.
2024-12-18T10:01:06.898: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T10:01:16.898: checkJavaStack starting: 2007.
2024-12-18T10:01:17.006: ------ test: 2007
2024-12-18T10:01:17.006: 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-18T10:01:17.219: SUC: 2007, 213ms, lines: 4096.
2024-12-18T10:01:17.219: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T10:01:27.219: checkJavaStack starting: 2007.
2024-12-18T10:01:27.330: ------ test: 2007
2024-12-18T10:01:27.330: 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-18T10:01:27.549: SUC: 2007, 219ms, lines: 4096.
2024-12-18T10:01:27.550: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T10:01:37.550: checkJavaStack starting: 2007.
2024-12-18T10:01:37.657: ------ test: 2007
2024-12-18T10:01:37.657: 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-18T10:01:37.869: SUC: 2007, 212ms, lines: 4096.
2024-12-18T10:01:37.871: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T10:01:47.871: checkJavaStack starting: 2007.
2024-12-18T10:01:47.979: ------ test: 2007
2024-12-18T10:01:47.979: 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-18T10:01:48.245: Row 1: "https-openssl-nio-443-exec-16" #52 daemon prio=5 os_prio=0 tid=0x00007f0ea8003000 nid=0x10099 runnable [0x00007f0f84abb000].
2024-12-18T10:01:48.245: Row 2: java.lang.Thread.State: RUNNABLE.
2024-12-18T10:01:48.245: Row 3: at java.net.SocketInputStream.socketRead0(Native Method).
2024-12-18T10:01:48.245: Row 4: at java.net.SocketInputStream.socketRead(SocketInputStream.java:116).
2024-12-18T10:01:48.246: Row 5: at java.net.SocketInputStream.read(SocketInputStream.java:171).
2024-12-18T10:01:48.246: Row 6: at java.net.SocketInputStream.read(SocketInputStream.java:141).
2024-12-18T10:01:48.246: Row 7: at com.mysql.jdbc.util.ReadAheadInputStream.fill(ReadAheadInputStream.java:100).
2024-12-18T10:01:48.246: Row 8: at com.mysql.jdbc.util.ReadAheadInputStream.readFromUnderlyingStreamIfNecessary(ReadAheadInputStream.java:143).
2024-12-18T10:01:48.246: Row 9: at com.mysql.jdbc.util.ReadAheadInputStream.read(ReadAheadInputStream.java:173).
2024-12-18T10:01:48.246: Row 10: - locked <0x000000077022b8b8> (a com.mysql.jdbc.util.ReadAheadInputStream).
2024-12-18T10:01:48.247: Row 11: at com.mysql.jdbc.MysqlIO.readFully(MysqlIO.java:2911).
2024-12-18T10:01:48.247: Row 12: at com.mysql.jdbc.MysqlIO.reuseAndReadPacket(MysqlIO.java:3337).
2024-12-18T10:01:48.249: Row 13: at com.mysql.jdbc.MysqlIO.reuseAndReadPacket(MysqlIO.java:3327).
2024-12-18T10:01:48.249: Row 14: at com.mysql.jdbc.MysqlIO.checkErrorPacket(MysqlIO.java:3814).
2024-12-18T10:01:48.249: Row 15: at com.mysql.jdbc.MysqlIO.sendCommand(MysqlIO.java:2435).
2024-12-18T10:01:48.249: Row 16: at com.mysql.jdbc.MysqlIO.sqlQueryDirect(MysqlIO.java:2582).
2024-12-18T10:01:48.254: Row 17: at com.mysql.jdbc.ConnectionImpl.execSQL(ConnectionImpl.java:2530).
2024-12-18T10:01:48.254: Row 18: - locked <0x0000000770221ef0> (a com.mysql.jdbc.JDBC4Connection).
2024-12-18T10:01:48.254: Row 19: at com.mysql.jdbc.PreparedStatement.executeInternal(PreparedStatement.java:1907).
2024-12-18T10:01:48.254: Row 20: - locked <0x0000000770221ef0> (a com.mysql.jdbc.JDBC4Connection).
2024-12-18T10:01:48.254: Row 21: at com.mysql.jdbc.PreparedStatement.executeQuery(PreparedStatement.java:2030).
2024-12-18T10:01:48.254: Row 22: - locked <0x0000000770221ef0> (a com.mysql.jdbc.JDBC4Connection).
2024-12-18T10:01:48.254: Row 23: at h2.helpers.store_query(helpers.java:4141).
2024-12-18T10:01:48.254: Row 24: at h2.JoinKnowledgeGraphs.doPost(JoinKnowledgeGraphs.java:126).
2024-12-18T10:01:48.258: SUC: 2007, 279ms, lines: 25.
2024-12-18T10:01:48.258: checkJavaStack end: 2007, pid/ret=25.
2024-12-18T10:01:58.258: checkJavaStack starting: 2007.
2024-12-18T10:01:58.366: ------ test: 2007
2024-12-18T10:01:58.366: 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-18T10:01:58.613: SUC: 2007, 247ms, lines: 4096.
2024-12-18T10:01:58.614: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T10:02:08.614: checkJavaStack starting: 2007.
2024-12-18T10:02:08.721: ------ test: 2007
2024-12-18T10:02:08.722: 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-18T10:02:08.937: SUC: 2007, 215ms, lines: 4096.
2024-12-18T10:02:08.937: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T10:02:18.938: checkJavaStack starting: 2007.
2024-12-18T10:02:19.046: ------ test: 2007
2024-12-18T10:02:19.047: 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-18T10:02:19.274: SUC: 2007, 226ms, lines: 4096.
2024-12-18T10:02:19.274: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T10:02:29.274: checkJavaStack starting: 2007.
2024-12-18T10:02:29.380: ------ test: 2007
2024-12-18T10:02:29.380: 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-18T10:02:29.618: SUC: 2007, 238ms, lines: 4096.
2024-12-18T10:02:29.619: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T10:02:39.619: checkJavaStack starting: 2007.
2024-12-18T10:02:39.730: ------ test: 2007
2024-12-18T10:02:39.730: 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-18T10:02:39.943: SUC: 2007, 213ms, lines: 4096.
2024-12-18T10:02:39.943: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T10:02:49.943: checkJavaStack starting: 2007.
2024-12-18T10:02:50.050: ------ test: 2007
2024-12-18T10:02:50.050: 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-18T10:02:50.283: SUC: 2007, 233ms, lines: 4096.
2024-12-18T10:02:50.284: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T10:02:50.285: ------ test: end, 322667ms. Score 39/39.
2024-12-18T10:02:50.285: Test duration: 5m22s.