2024-12-17T19:21:05.277: current working dir: /root/qa/mctester.
2024-12-17T19:21:05.379: current logging dir: ../mctester/www.
2024-12-17T19:21:05.379: ---------------------------------------------------------------
2024-12-17T19:21:05.379: mctester entry: 2024-12-17T19:21:05.379 mode=50
2024-12-17T19:21:05.380: ---------------------------------------------------------------
2024-12-17T19:21:05.498: EXE: 1/git describe --tags.
2024-12-17T19:21:05.509: Row 1: v1.1-201-g90c2042.
2024-12-17T19:21:05.509: EXE: 1/git rev-list --count HEAD.
2024-12-17T19:21:05.514: Row 1: 258.
2024-12-17T19:21:05.515: EXE: 1/git rev-parse HEAD.
2024-12-17T19:21:05.517: Row 1: 90c2042af9ce0b055e0a62dafd703b27e21c4128.
2024-12-17T19:21:05.517: mctester: v1.1.258 (90c2042af9ce0b055e0a62dafd703b27e21c4128).
2024-12-17T19:21:05.518: Entering into a performance tests mode.
2024-12-17T19:21:05.518: ------ test: start, 2024-12-17T19:21:05.518
2024-12-17T19:21:05.519: ------ test: 2000
2024-12-17T19:21:05.519: CMD: ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "top -b -n 1"
2024-12-17T19:21:05.519: EXE: 1/ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "top -b -n 1".
2024-12-17T19:21:35.848: Row 1: top - 19:21:35 up 91 days, 11:48, 0 users, load average: 0.28, 0.08, 0.02.
2024-12-17T19:21:35.849: Row 2: Tasks: 365 total, 1 running, 364 sleeping, 0 stopped, 0 zombie.
2024-12-17T19:21:35.849: 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-17T19:21:35.849: Row 4: KiB Mem : 13202036+total, 718064 free, 60825776 used, 70476528 buff/cache.
2024-12-17T19:21:35.850: Row 5: KiB Swap: 0 total, 0 free, 0 used. 69606272 avail Mem .
2024-12-17T19:21:35.850: Row 6: .
2024-12-17T19:21:35.850: Row 7: PID USER PR NI VIRT RES SHR S %CPU %MEM TIME+ COMMAND.
2024-12-17T19:21:35.850: Row 8: 1978 mysql 20 0 99.646g 0.048t 1.145g S 93.8 38.7 13655:00 mysqld.
2024-12-17T19:21:35.850: Row 9: 7 root 20 0 0 0 0 S 6.2 0.0 29:55.02 rcu_sched.
2024-12-17T19:21:35.850: Row 10: 129815 root 20 0 42220 3944 3176 R 6.2 0.0 0:00.01 top.
2024-12-17T19:21:35.851: Row 11: 1 root 20 0 43660 2552 1268 S 0.0 0.0 3:24.08 init.
2024-12-17T19:21:35.851: Row 12: 2 root 20 0 0 0 0 S 0.0 0.0 0:01.23 kthreadd.
2024-12-17T19:21:35.851: Row 13: 3 root 20 0 0 0 0 S 0.0 0.0 4:29.22 ksoftirqd+.
2024-12-17T19:21:35.851: Row 14: 5 root 0 -20 0 0 0 S 0.0 0.0 0:00.00 kworker/0+.
2024-12-17T19:21:35.851: Row 15: 8 root 20 0 0 0 0 S 0.0 0.0 0:00.00 rcu_bh.
2024-12-17T19:21:35.851: Row 16: 9 root rt 0 0 0 0 S 0.0 0.0 0:05.48 migration+.
2024-12-17T19:21:35.852: Row 17: 10 root rt 0 0 0 0 S 0.0 0.0 0:22.06 watchdog/0.
2024-12-17T19:21:35.852: Row 18: 11 root rt 0 0 0 0 S 0.0 0.0 0:20.14 watchdog/1.
2024-12-17T19:21:35.852: Row 19: 12 root rt 0 0 0 0 S 0.0 0.0 0:10.73 migration+.
2024-12-17T19:21:35.852: Row 20: 13 root 20 0 0 0 0 S 0.0 0.0 0:01.78 ksoftirqd+.
2024-12-17T19:21:35.852: Row 21: 15 root 0 -20 0 0 0 S 0.0 0.0 0:00.00 kworker/1+.
2024-12-17T19:21:35.853: Row 22: 16 root rt 0 0 0 0 S 0.0 0.0 0:20.57 watchdog/2.
2024-12-17T19:21:35.853: Row 23: 17 root rt 0 0 0 0 S 0.0 0.0 0:04.56 migration+.
2024-12-17T19:21:35.853: Row 24: 18 root 20 0 0 0 0 S 0.0 0.0 0:01.44 ksoftirqd+.
2024-12-17T19:21:35.928: SUC: 30409ms Uptime 91 days, 1min 0.28, 5min 0.08, 15min 0.02, mem:132020360 total / 718064 free / 60825776 used / 70476528 cache / 69606272 avail
2024-12-17T19:21:35.946: ------ test: 2001
2024-12-17T19:21:35.946: CMD: top -b -E k -n 1
2024-12-17T19:21:35.946: EXE: 1/top -b -E k -n 1.
2024-12-17T19:21:36.104: Row 1: top - 19:21:36 up 36 days, 2:03, 0 users, load average: 0.24, 0.08, 0.02.
2024-12-17T19:21:36.104: Row 2: Tasks: 98 total, 1 running, 96 sleeping, 0 stopped, 1 zombie.
2024-12-17T19:21:36.104: 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-17T19:21:36.104: Row 4: KiB Mem : 1907632 total, 494852 free, 391804 used, 1020976 buff/cache.
2024-12-17T19:21:36.104: Row 5: KiB Swap: 0 total, 0 free, 0 used. 1299036 avail Mem .
2024-12-17T19:21:36.105: Row 6: .
2024-12-17T19:21:36.105: Row 7: PID USER PR NI VIRT RES SHR S %CPU %MEM TIME+ COMMAND.
2024-12-17T19:21:36.105: Row 8: 1 root 20 0 167784 11968 7084 S 0.0 0.6 0:57.07 systemd.
2024-12-17T19:21:36.108: Row 9: 2 root 20 0 0 0 0 S 0.0 0.0 0:00.09 kthreadd.
2024-12-17T19:21:36.108: Row 10: 3 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 rcu_gp.
2024-12-17T19:21:36.108: Row 11: 4 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 rcu_par+.
2024-12-17T19:21:36.108: Row 12: 5 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 slub_fl+.
2024-12-17T19:21:36.108: Row 13: 6 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 netns.
2024-12-17T19:21:36.108: Row 14: 8 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 kworker+.
2024-12-17T19:21:36.109: Row 15: 10 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 mm_perc+.
2024-12-17T19:21:36.109: Row 16: 11 root 20 0 0 0 0 S 0.0 0.0 0:00.00 rcu_tas+.
2024-12-17T19:21:36.109: Row 17: 12 root 20 0 0 0 0 S 0.0 0.0 0:00.00 rcu_tas+.
2024-12-17T19:21:36.109: Row 18: 13 root 20 0 0 0 0 S 0.0 0.0 0:30.95 ksoftir+.
2024-12-17T19:21:36.113: Row 19: 14 root 20 0 0 0 0 I 0.0 0.0 0:53.36 rcu_sch+.
2024-12-17T19:21:36.113: Row 20: 15 root rt 0 0 0 0 S 0.0 0.0 0:07.86 migrati+.
2024-12-17T19:21:36.113: Row 21: 16 root -51 0 0 0 0 S 0.0 0.0 0:00.00 idle_in+.
2024-12-17T19:21:36.113: Row 22: 18 root 20 0 0 0 0 S 0.0 0.0 0:00.00 cpuhp/0.
2024-12-17T19:21:36.114: Row 23: 19 root 20 0 0 0 0 S 0.0 0.0 0:00.00 kdevtmp+.
2024-12-17T19:21:36.114: Row 24: 20 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 inet_fr+.
2024-12-17T19:21:36.121: SUC: 174ms Uptime 36 days, 1min 0.24, 5min 0.08, 15min 0.02, mem:1907632 total / 494852 free / 391804 used / 1020976 cache / 1299036 avail
2024-12-17T19:21:36.121: ------ test: 2002
2024-12-17T19:21:36.122: CMD: df -h
2024-12-17T19:21:36.122: EXE: 1/df -h.
2024-12-17T19:21:36.124: Row 1: Filesystem Size Used Avail Use% Mounted on.
2024-12-17T19:21:36.124: Row 2: tmpfs 187M 20M 167M 11% /run.
2024-12-17T19:21:36.124: Row 3: /dev/vda2 20G 14G 5.2G 73% /.
2024-12-17T19:21:36.124: Row 4: tmpfs 932M 0 932M 0% /dev/shm.
2024-12-17T19:21:36.124: Row 5: tmpfs 5.0M 0 5.0M 0% /run/lock.
2024-12-17T19:21:36.127: SUC: 5ms Diskfree qa.headai.com: tmpfs:11%, /dev/vda2:73%, tmpfs:0%, tmpfs:0%.
2024-12-17T19:21:36.127: ------ test: 2003
2024-12-17T19:21:36.127: CMD: ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "df -h"
2024-12-17T19:21:36.127: EXE: 1/ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "df -h".
2024-12-17T19:22:06.308: Row 1: Filesystem Size Used Avail Use% Mounted on.
2024-12-17T19:22:06.308: Row 2: udev 63G 4.0K 63G 1% /dev.
2024-12-17T19:22:06.309: Row 3: tmpfs 13G 544M 13G 5% /run.
2024-12-17T19:22:06.309: Row 4: /dev/vda1 757G 512G 215G 71% /.
2024-12-17T19:22:06.309: Row 5: none 4.0K 0 4.0K 0% /sys/fs/cgroup.
2024-12-17T19:22:06.309: Row 6: none 5.0M 0 5.0M 0% /run/lock.
2024-12-17T19:22:06.310: Row 7: cgmfs 100K 0 100K 0% /run/cgmanager/fs.
2024-12-17T19:22:06.312: Row 8: none 63G 0 63G 0% /run/shm.
2024-12-17T19:22:06.312: Row 9: none 100M 0 100M 0% /run/user.
2024-12-17T19:22:06.313: Row 10: /dev/vdb 985G 230G 705G 25% /opt/tomcat/webapps/ROOT/analysis.
2024-12-17T19:22:06.313: Row 11: tmpfs 100K 0 100K 0% /var/lib/lxd/shmounts.
2024-12-17T19:22:06.313: Row 12: tmpfs 100K 0 100K 0% /var/lib/lxd/devlxd.
2024-12-17T19:22:06.313: Row 13: tmpfs 13G 0 13G 0% /run/user/0.
2024-12-17T19:22:06.316: SUC: 30189ms 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-17T19:22:06.317: ------ test: 2004
2024-12-17T19:22:06.317: URL: https://headai.com
2024-12-17T19:22:06.891: SUC: 573ms, Trusted by 100+ customers and partners globally, length 185391.
2024-12-17T19:22:06.896: ------ test: 2005
2024-12-17T19:22:07.353: SQL: show global status like 'threads_connected';.
2024-12-17T19:22:07.369: Results: value=2/200.
2024-12-17T19:22:07.373: SQL: value, lines: 1, ret=1, 2.
2024-12-17T19:22:07.376: SUC: 480ms 2
2024-12-17T19:22:07.377: ------ test: 2006
2024-12-17T19:22:07.483: SQL: SHOW PROCESSLIST;.
2024-12-17T19:22:07.489: Row 1: 25409128,root,localhost:57246,null,Query,0,starting,SHOW PROCESSLIST.
2024-12-17T19:22:07.490: SQL: COUNTNOTLINES:Command, lines: 1, ret=1, 1.
2024-12-17T19:22:07.491: SUC: 114ms 1
2024-12-17T19:22:07.492: checkJavaStack starting: 2007.
2024-12-17T19:22:37.695: ------ test: 2007
2024-12-17T19:22:37.696: EXE: 5/"jstack 90461 | 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-17T19:23:08.026: Row 1: "https-openssl-nio-443-exec-83" #261400 daemon prio=5 os_prio=0 tid=0x00007f007c568800 nid=0x18159 runnable [0x00007f01820f7000].
2024-12-17T19:23:08.026: Row 2: java.lang.Thread.State: RUNNABLE.
2024-12-17T19:23:08.026: Row 3: at h1.body.wordToBody(body.java:296).
2024-12-17T19:23:08.027: Row 4: at h2.core2021.semanticSimilarity_v3(core2021.java:1393).
2024-12-17T19:23:08.027: Row 5: at h2.core2021.text2keywords_v3(core2021.java:727).
2024-12-17T19:23:08.027: Row 6: at h2.BuildKnowledgeGraph_v5.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v5.java:1727).
2024-12-17T19:23:08.027: Row 7: at h2.SkillsForecast_methods.build_a_map_on_fly_v4(SkillsForecast_methods.java:5221).
2024-12-17T19:23:08.027: Row 8: at h2.helpers.check_pending_works(helpers.java:5270).
2024-12-17T19:23:08.027: Row 9: at h1.mc_api.doPost(mc_api.java:4576).
2024-12-17T19:23:08.027: Row 10: at h1.mc_api.doGet(mc_api.java:38).
2024-12-17T19:23:08.027: SUC: 2007, 30331ms, lines: 10.
2024-12-17T19:23:08.028: checkJavaStack end: 2007, pid/ret=10.
2024-12-17T19:23:18.028: checkJavaStack starting: 2007.
2024-12-17T19:23:48.231: ------ test: 2007
2024-12-17T19:23:48.231: EXE: 5/"jstack 90461 | 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-17T19:24:18.548: Row 1: "https-openssl-nio-443-exec-83" #261400 daemon prio=5 os_prio=0 tid=0x00007f007c568800 nid=0x18159 runnable [0x00007f01820f7000].
2024-12-17T19:24:18.548: Row 2: java.lang.Thread.State: RUNNABLE.
2024-12-17T19:24:18.548: Row 3: at java.util.AbstractCollection.toArray(AbstractCollection.java:180).
2024-12-17T19:24:18.548: Row 4: at java.lang.String.split(String.java:2378).
2024-12-17T19:24:18.548: Row 5: at java.lang.String.split(String.java:2422).
2024-12-17T19:24:18.549: Row 6: at h2.core2021.networkMatchSuperFast(core2021.java:3155).
2024-12-17T19:24:18.549: Row 7: at h2.core2021.semanticSimilarity_v3(core2021.java:1418).
2024-12-17T19:24:18.549: Row 8: at h2.core2021.text2keywords_v3(core2021.java:727).
2024-12-17T19:24:18.549: Row 9: at h2.BuildKnowledgeGraph_v5.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v5.java:1727).
2024-12-17T19:24:18.549: Row 10: at h2.SkillsForecast_methods.build_a_map_on_fly_v4(SkillsForecast_methods.java:5221).
2024-12-17T19:24:18.553: Row 11: at h2.helpers.check_pending_works(helpers.java:5270).
2024-12-17T19:24:18.554: Row 12: at h1.mc_api.doPost(mc_api.java:4576).
2024-12-17T19:24:18.554: Row 13: at h1.mc_api.doGet(mc_api.java:38).
2024-12-17T19:24:18.555: SUC: 2007, 30324ms, lines: 13.
2024-12-17T19:24:18.556: checkJavaStack end: 2007, pid/ret=13.
2024-12-17T19:24:28.556: checkJavaStack starting: 2007.
2024-12-17T19:24:58.760: ------ test: 2007
2024-12-17T19:24:58.760: EXE: 5/"jstack 90461 | 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-17T19:25:29.069: SUC: 2007, 30309ms, lines: 4096.
2024-12-17T19:25:29.070: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T19:25:39.070: checkJavaStack starting: 2007.
2024-12-17T19:26:09.266: ------ test: 2007
2024-12-17T19:26:09.267: EXE: 5/"jstack 90461 | 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-17T19:26:39.575: SUC: 2007, 30307ms, lines: 4096.
2024-12-17T19:26:39.575: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T19:26:49.575: checkJavaStack starting: 2007.
2024-12-17T19:27:19.829: ------ test: 2007
2024-12-17T19:27:19.830: EXE: 5/"jstack 90461 | 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-17T19:27:50.150: SUC: 2007, 30320ms, lines: 4096.
2024-12-17T19:27:50.151: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T19:28:00.151: checkJavaStack starting: 2007.
2024-12-17T19:28:30.352: ------ test: 2007
2024-12-17T19:28:30.352: EXE: 5/"jstack 90461 | 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-17T19:29:00.651: SUC: 2007, 30299ms, lines: 4096.
2024-12-17T19:29:00.651: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T19:29:10.651: checkJavaStack starting: 2007.
2024-12-17T19:29:40.842: ------ test: 2007
2024-12-17T19:29:40.842: EXE: 5/"jstack 90461 | 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-17T19:29:40.880: WRN: stderr, kex_exchange_identification: Connection closed by remote host.
2024-12-17T19:29:40.880: WRN: stderr, Connection closed by 185.20.136.38 port 22.
2024-12-17T19:29:40.884: WRN: 2007, 42ms, lines: -1.
2024-12-17T19:29:40.884: fileio: /var/www/html/ivves/notices.txt, mode: 3, length: 651.
2024-12-17T19:29:40.892: fileio: /var/www/html/ivves/notices.txt, mode: 2, length: 651.
2024-12-17T19:29:40.958: checkJavaStack end: 2007, pid/ret=-1.
2024-12-17T19:29:50.958: checkJavaStack starting: 2007.
2024-12-17T19:30:21.150: ------ test: 2007
2024-12-17T19:30:21.150: EXE: 5/"jstack 90461 | 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-17T19:30:51.451: SUC: 2007, 30301ms, lines: 4096.
2024-12-17T19:30:51.451: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T19:31:01.451: checkJavaStack starting: 2007.
2024-12-17T19:31:31.647: ------ test: 2007
2024-12-17T19:31:31.648: EXE: 5/"jstack 90461 | 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-17T19:32:01.980: SUC: 2007, 30332ms, lines: 4096.
2024-12-17T19:32:01.980: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T19:32:11.981: checkJavaStack starting: 2007.
2024-12-17T19:32:42.182: ------ test: 2007
2024-12-17T19:32:42.183: EXE: 5/"jstack 90461 | 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-17T19:33:12.522: SUC: 2007, 30339ms, lines: 4096.
2024-12-17T19:33:12.523: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T19:33:22.523: checkJavaStack starting: 2007.
2024-12-17T19:33:52.719: ------ test: 2007
2024-12-17T19:33:52.719: EXE: 5/"jstack 90461 | 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-17T19:34:23.033: SUC: 2007, 30314ms, lines: 4096.
2024-12-17T19:34:23.036: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T19:34:33.036: checkJavaStack starting: 2007.
2024-12-17T19:35:03.268: ------ test: 2007
2024-12-17T19:35:03.269: EXE: 5/"jstack 90461 | 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-17T19:35:33.599: SUC: 2007, 30330ms, lines: 4096.
2024-12-17T19:35:33.600: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T19:35:43.600: checkJavaStack starting: 2007.
2024-12-17T19:36:13.834: ------ test: 2007
2024-12-17T19:36:13.834: EXE: 5/"jstack 90461 | 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-17T19:36:44.182: SUC: 2007, 30348ms, lines: 4096.
2024-12-17T19:36:44.182: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T19:36:54.182: checkJavaStack starting: 2007.
2024-12-17T19:37:24.379: ------ test: 2007
2024-12-17T19:37:24.380: EXE: 5/"jstack 90461 | 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-17T19:37:54.710: SUC: 2007, 30330ms, lines: 4096.
2024-12-17T19:37:54.710: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T19:38:04.711: checkJavaStack starting: 2007.
2024-12-17T19:38:34.906: ------ test: 2007
2024-12-17T19:38:34.906: EXE: 5/"jstack 90461 | 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-17T19:39:05.255: SUC: 2007, 30349ms, lines: 4096.
2024-12-17T19:39:05.255: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T19:39:15.255: checkJavaStack starting: 2007.
2024-12-17T19:39:45.453: ------ test: 2007
2024-12-17T19:39:45.453: EXE: 5/"jstack 90461 | 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-17T19:40:15.760: SUC: 2007, 30307ms, lines: 4096.
2024-12-17T19:40:15.760: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T19:40:25.760: checkJavaStack starting: 2007.
2024-12-17T19:40:55.953: ------ test: 2007
2024-12-17T19:40:55.953: EXE: 5/"jstack 90461 | 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-17T19:41:26.273: SUC: 2007, 30320ms, lines: 4096.
2024-12-17T19:41:26.273: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T19:41:36.273: checkJavaStack starting: 2007.
2024-12-17T19:42:06.471: ------ test: 2007
2024-12-17T19:42:06.471: EXE: 5/"jstack 90461 | 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-17T19:42:36.791: SUC: 2007, 30320ms, lines: 4096.
2024-12-17T19:42:36.791: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T19:42:46.791: checkJavaStack starting: 2007.
2024-12-17T19:43:16.989: ------ test: 2007
2024-12-17T19:43:16.989: EXE: 5/"jstack 90461 | 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-17T19:43:47.281: SUC: 2007, 30291ms, lines: 4096.
2024-12-17T19:43:47.281: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T19:43:57.281: checkJavaStack starting: 2007.
2024-12-17T19:44:27.478: ------ test: 2007
2024-12-17T19:44:27.478: EXE: 5/"jstack 90461 | 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-17T19:44:57.800: SUC: 2007, 30322ms, lines: 4096.
2024-12-17T19:44:57.800: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T19:45:07.800: checkJavaStack starting: 2007.
2024-12-17T19:45:38.006: ------ test: 2007
2024-12-17T19:45:38.006: EXE: 5/"jstack 90461 | 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-17T19:46:08.318: SUC: 2007, 30312ms, lines: 4096.
2024-12-17T19:46:08.318: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T19:46:18.318: checkJavaStack starting: 2007.
2024-12-17T19:46:48.514: ------ test: 2007
2024-12-17T19:46:48.514: EXE: 5/"jstack 90461 | 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-17T19:47:18.840: SUC: 2007, 30326ms, lines: 4096.
2024-12-17T19:47:18.841: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T19:47:28.841: checkJavaStack starting: 2007.
2024-12-17T19:47:59.040: ------ test: 2007
2024-12-17T19:47:59.040: EXE: 5/"jstack 90461 | 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-17T19:48:29.351: SUC: 2007, 30311ms, lines: 4096.
2024-12-17T19:48:29.352: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T19:48:39.352: checkJavaStack starting: 2007.
2024-12-17T19:49:09.548: ------ test: 2007
2024-12-17T19:49:09.549: EXE: 5/"jstack 90461 | 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-17T19:49:39.858: SUC: 2007, 30309ms, lines: 4096.
2024-12-17T19:49:39.858: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T19:49:49.858: checkJavaStack starting: 2007.
2024-12-17T19:50:20.056: ------ test: 2007
2024-12-17T19:50:20.057: EXE: 5/"jstack 90461 | 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-17T19:50:50.367: SUC: 2007, 30310ms, lines: 4096.
2024-12-17T19:50:50.368: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T19:51:00.368: checkJavaStack starting: 2007.
2024-12-17T19:51:30.563: ------ test: 2007
2024-12-17T19:51:30.563: EXE: 5/"jstack 90461 | 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-17T19:52:00.881: SUC: 2007, 30318ms, lines: 4096.
2024-12-17T19:52:00.881: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T19:52:10.882: checkJavaStack starting: 2007.
2024-12-17T19:52:41.080: ------ test: 2007
2024-12-17T19:52:41.080: EXE: 5/"jstack 90461 | 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-17T19:53:11.403: SUC: 2007, 30323ms, lines: 4096.
2024-12-17T19:53:11.403: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T19:53:21.404: checkJavaStack starting: 2007.
2024-12-17T19:53:51.599: ------ test: 2007
2024-12-17T19:53:51.600: EXE: 5/"jstack 90461 | 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-17T19:54:21.968: SUC: 2007, 30368ms, lines: 4096.
2024-12-17T19:54:21.969: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T19:54:31.969: checkJavaStack starting: 2007.
2024-12-17T19:55:02.165: ------ test: 2007
2024-12-17T19:55:02.165: EXE: 5/"jstack 90461 | 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-17T19:55:32.470: SUC: 2007, 30305ms, lines: 4096.
2024-12-17T19:55:32.471: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T19:55:42.471: checkJavaStack starting: 2007.
2024-12-17T19:56:12.700: ------ test: 2007
2024-12-17T19:56:12.700: EXE: 5/"jstack 90461 | 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-17T19:56:43.019: SUC: 2007, 30319ms, lines: 4096.
2024-12-17T19:56:43.020: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T19:56:53.021: checkJavaStack starting: 2007.
2024-12-17T19:57:23.216: ------ test: 2007
2024-12-17T19:57:23.216: EXE: 5/"jstack 90461 | 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-17T19:57:53.513: SUC: 2007, 30297ms, lines: 4096.
2024-12-17T19:57:53.514: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T19:58:03.514: checkJavaStack starting: 2007.
2024-12-17T19:58:33.709: ------ test: 2007
2024-12-17T19:58:33.709: EXE: 5/"jstack 90461 | 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-17T19:59:04.018: SUC: 2007, 30309ms, lines: 4096.
2024-12-17T19:59:04.018: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T19:59:04.018: ------ test: end, 2278500ms. Score 39/38.
2024-12-17T19:59:04.018: Test duration: 37m58s.