2024-12-18T05:21:05.149: current working dir: /root/qa/mctester.
2024-12-18T05:21:05.249: current logging dir: ../mctester/www.
2024-12-18T05:21:05.250: ---------------------------------------------------------------
2024-12-18T05:21:05.250: mctester entry: 2024-12-18T05:21:05.250 mode=50
2024-12-18T05:21:05.250: ---------------------------------------------------------------
2024-12-18T05:21:05.369: EXE: 1/git describe --tags.
2024-12-18T05:21:05.383: Row 1: v1.1-201-g90c2042.
2024-12-18T05:21:05.384: EXE: 1/git rev-list --count HEAD.
2024-12-18T05:21:05.389: Row 1: 258.
2024-12-18T05:21:05.391: EXE: 1/git rev-parse HEAD.
2024-12-18T05:21:05.393: Row 1: 90c2042af9ce0b055e0a62dafd703b27e21c4128.
2024-12-18T05:21:05.394: mctester: v1.1.258 (90c2042af9ce0b055e0a62dafd703b27e21c4128).
2024-12-18T05:21:05.394: Entering into a performance tests mode.
2024-12-18T05:21:05.394: ------ test: start, 2024-12-18T05:21:05.394
2024-12-18T05:21:05.395: ------ test: 2000
2024-12-18T05:21:05.395: CMD: ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "top -b -n 1"
2024-12-18T05:21:05.396: EXE: 1/ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "top -b -n 1".
2024-12-18T05:21:35.803: Row 1: top - 05:21:35 up 91 days, 21:48, 0 users, load average: 0.38, 0.16, 0.14.
2024-12-18T05:21:35.803: Row 2: Tasks: 365 total, 1 running, 364 sleeping, 0 stopped, 0 zombie.
2024-12-18T05:21:35.804: 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-18T05:21:35.804: Row 4: KiB Mem : 13202036+total, 626748 free, 57572216 used, 73821408 buff/cache.
2024-12-18T05:21:35.804: Row 5: KiB Swap: 0 total, 0 free, 0 used. 72859616 avail Mem .
2024-12-18T05:21:35.804: Row 6: .
2024-12-18T05:21:35.804: Row 7: PID USER PR NI VIRT RES SHR S %CPU %MEM TIME+ COMMAND.
2024-12-18T05:21:35.808: Row 8: 1978 mysql 20 0 99.646g 0.047t 687316 S 93.8 38.3 13707:00 mysqld.
2024-12-18T05:21:35.808: Row 9: 1 root 20 0 43660 3556 2272 S 0.0 0.0 3:25.04 init.
2024-12-18T05:21:35.808: Row 10: 2 root 20 0 0 0 0 S 0.0 0.0 0:01.23 kthreadd.
2024-12-18T05:21:35.808: Row 11: 3 root 20 0 0 0 0 S 0.0 0.0 4:29.49 ksoftirqd+.
2024-12-18T05:21:35.808: Row 12: 5 root 0 -20 0 0 0 S 0.0 0.0 0:00.00 kworker/0+.
2024-12-18T05:21:35.809: Row 13: 7 root 20 0 0 0 0 S 0.0 0.0 30:03.36 rcu_sched.
2024-12-18T05:21:35.810: Row 14: 8 root 20 0 0 0 0 S 0.0 0.0 0:00.00 rcu_bh.
2024-12-18T05:21:35.813: Row 15: 9 root rt 0 0 0 0 S 0.0 0.0 0:05.50 migration+.
2024-12-18T05:21:35.813: Row 16: 10 root rt 0 0 0 0 S 0.0 0.0 0:22.15 watchdog/0.
2024-12-18T05:21:35.814: Row 17: 11 root rt 0 0 0 0 S 0.0 0.0 0:20.22 watchdog/1.
2024-12-18T05:21:35.814: Row 18: 12 root rt 0 0 0 0 S 0.0 0.0 0:10.80 migration+.
2024-12-18T05:21:35.814: Row 19: 13 root 20 0 0 0 0 S 0.0 0.0 0:01.78 ksoftirqd+.
2024-12-18T05:21:35.815: Row 20: 15 root 0 -20 0 0 0 S 0.0 0.0 0:00.00 kworker/1+.
2024-12-18T05:21:35.815: Row 21: 16 root rt 0 0 0 0 S 0.0 0.0 0:20.67 watchdog/2.
2024-12-18T05:21:35.815: Row 22: 17 root rt 0 0 0 0 S 0.0 0.0 0:04.59 migration+.
2024-12-18T05:21:35.816: Row 23: 18 root 20 0 0 0 0 S 0.0 0.0 0:01.44 ksoftirqd+.
2024-12-18T05:21:35.816: Row 24: 20 root 0 -20 0 0 0 S 0.0 0.0 0:00.00 kworker/2+.
2024-12-18T05:21:35.892: SUC: 30497ms Uptime 91 days, 1min 0.38, 5min 0.16, 15min 0.14, mem:132020360 total / 626748 free / 57572216 used / 73821408 cache / 72859616 avail
2024-12-18T05:21:35.909: ------ test: 2001
2024-12-18T05:21:35.909: CMD: top -b -E k -n 1
2024-12-18T05:21:35.909: EXE: 1/top -b -E k -n 1.
2024-12-18T05:21:36.065: Row 1: top - 05:21:36 up 36 days, 12:03, 0 users, load average: 0.18, 0.08, 0.02.
2024-12-18T05:21:36.066: Row 2: Tasks: 100 total, 1 running, 98 sleeping, 0 stopped, 1 zombie.
2024-12-18T05:21:36.066: 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-18T05:21:36.066: Row 4: KiB Mem : 1907632 total, 428380 free, 393488 used, 1085764 buff/cache.
2024-12-18T05:21:36.066: Row 5: KiB Swap: 0 total, 0 free, 0 used. 1297352 avail Mem .
2024-12-18T05:21:36.066: Row 6: .
2024-12-18T05:21:36.066: Row 7: PID USER PR NI VIRT RES SHR S %CPU %MEM TIME+ COMMAND.
2024-12-18T05:21:36.066: Row 8: 1 root 20 0 167784 12172 7288 S 0.0 0.6 0:57.57 systemd.
2024-12-18T05:21:36.067: Row 9: 2 root 20 0 0 0 0 S 0.0 0.0 0:00.09 kthreadd.
2024-12-18T05:21:36.067: Row 10: 3 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 rcu_gp.
2024-12-18T05:21:36.067: Row 11: 4 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 rcu_par+.
2024-12-18T05:21:36.067: Row 12: 5 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 slub_fl+.
2024-12-18T05:21:36.067: Row 13: 6 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 netns.
2024-12-18T05:21:36.067: Row 14: 8 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 kworker+.
2024-12-18T05:21:36.067: Row 15: 10 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 mm_perc+.
2024-12-18T05:21:36.068: Row 16: 11 root 20 0 0 0 0 S 0.0 0.0 0:00.00 rcu_tas+.
2024-12-18T05:21:36.068: Row 17: 12 root 20 0 0 0 0 S 0.0 0.0 0:00.00 rcu_tas+.
2024-12-18T05:21:36.068: Row 18: 13 root 20 0 0 0 0 S 0.0 0.0 0:31.23 ksoftir+.
2024-12-18T05:21:36.068: Row 19: 14 root 20 0 0 0 0 I 0.0 0.0 0:53.82 rcu_sch+.
2024-12-18T05:21:36.068: Row 20: 15 root rt 0 0 0 0 S 0.0 0.0 0:07.94 migrati+.
2024-12-18T05:21:36.068: Row 21: 16 root -51 0 0 0 0 S 0.0 0.0 0:00.00 idle_in+.
2024-12-18T05:21:36.068: Row 22: 18 root 20 0 0 0 0 S 0.0 0.0 0:00.00 cpuhp/0.
2024-12-18T05:21:36.069: Row 23: 19 root 20 0 0 0 0 S 0.0 0.0 0:00.00 kdevtmp+.
2024-12-18T05:21:36.069: Row 24: 20 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 inet_fr+.
2024-12-18T05:21:36.077: SUC: 168ms Uptime 36 days, 1min 0.18, 5min 0.08, 15min 0.02, mem:1907632 total / 428380 free / 393488 used / 1085764 cache / 1297352 avail
2024-12-18T05:21:36.078: ------ test: 2002
2024-12-18T05:21:36.078: CMD: df -h
2024-12-18T05:21:36.078: EXE: 1/df -h.
2024-12-18T05:21:36.080: Row 1: Filesystem Size Used Avail Use% Mounted on.
2024-12-18T05:21:36.080: Row 2: tmpfs 187M 20M 167M 11% /run.
2024-12-18T05:21:36.080: Row 3: /dev/vda2 20G 14G 5.2G 73% /.
2024-12-18T05:21:36.080: Row 4: tmpfs 932M 0 932M 0% /dev/shm.
2024-12-18T05:21:36.081: Row 5: tmpfs 5.0M 0 5.0M 0% /run/lock.
2024-12-18T05:21:36.083: SUC: 5ms Diskfree qa.headai.com: tmpfs:11%, /dev/vda2:73%, tmpfs:0%, tmpfs:0%.
2024-12-18T05:21:36.083: ------ test: 2003
2024-12-18T05:21:36.083: CMD: ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "df -h"
2024-12-18T05:21:36.083: EXE: 1/ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "df -h".
2024-12-18T05:22:06.375: Row 1: Filesystem Size Used Avail Use% Mounted on.
2024-12-18T05:22:06.375: Row 2: udev 63G 4.0K 63G 1% /dev.
2024-12-18T05:22:06.375: Row 3: tmpfs 13G 544M 13G 5% /run.
2024-12-18T05:22:06.376: Row 4: /dev/vda1 757G 512G 214G 71% /.
2024-12-18T05:22:06.376: Row 5: none 4.0K 0 4.0K 0% /sys/fs/cgroup.
2024-12-18T05:22:06.376: Row 6: none 5.0M 0 5.0M 0% /run/lock.
2024-12-18T05:22:06.376: Row 7: cgmfs 100K 0 100K 0% /run/cgmanager/fs.
2024-12-18T05:22:06.376: Row 8: none 63G 0 63G 0% /run/shm.
2024-12-18T05:22:06.376: Row 9: none 100M 0 100M 0% /run/user.
2024-12-18T05:22:06.376: Row 10: /dev/vdb 985G 230G 705G 25% /opt/tomcat/webapps/ROOT/analysis.
2024-12-18T05:22:06.376: Row 11: tmpfs 100K 0 100K 0% /var/lib/lxd/shmounts.
2024-12-18T05:22:06.377: Row 12: tmpfs 100K 0 100K 0% /var/lib/lxd/devlxd.
2024-12-18T05:22:06.377: Row 13: tmpfs 13G 0 13G 0% /run/user/0.
2024-12-18T05:22:06.380: SUC: 30297ms 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-18T05:22:06.385: ------ test: 2004
2024-12-18T05:22:06.386: URL: https://headai.com
2024-12-18T05:22:06.970: SUC: 583ms, Trusted by 100+ customers and partners globally, length 185391.
2024-12-18T05:22:06.972: ------ test: 2005
2024-12-18T05:22:07.431: SQL: show global status like 'threads_connected';.
2024-12-18T05:22:07.449: Results: value=2/200.
2024-12-18T05:22:07.449: SQL: value, lines: 1, ret=1, 2.
2024-12-18T05:22:07.456: SUC: 483ms 2
2024-12-18T05:22:07.457: ------ test: 2006
2024-12-18T05:22:07.555: SQL: SHOW PROCESSLIST;.
2024-12-18T05:22:07.559: Row 1: 25554117,root,localhost:56466,null,Query,0,starting,SHOW PROCESSLIST.
2024-12-18T05:22:07.560: SQL: COUNTNOTLINES:Command, lines: 1, ret=1, 1.
2024-12-18T05:22:07.561: SUC: 104ms 1
2024-12-18T05:22:07.564: checkJavaStack starting: 2007.
2024-12-18T05:22:37.773: ------ test: 2007
2024-12-18T05:22:37.776: 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-18T05:23:08.138: Row 1: "https-openssl-nio-443-exec-14" #50 daemon prio=5 os_prio=0 tid=0x00007f0eb4004800 nid=0x10097 runnable [0x00007f0f84cbd000].
2024-12-18T05:23:08.139: Row 2: java.lang.Thread.State: RUNNABLE.
2024-12-18T05:23:08.139: Row 3: at java.net.SocketInputStream.socketRead0(Native Method).
2024-12-18T05:23:08.139: Row 4: at java.net.SocketInputStream.socketRead(SocketInputStream.java:116).
2024-12-18T05:23:08.139: Row 5: at java.net.SocketInputStream.read(SocketInputStream.java:171).
2024-12-18T05:23:08.139: Row 6: at java.net.SocketInputStream.read(SocketInputStream.java:141).
2024-12-18T05:23:08.139: Row 7: at com.mysql.jdbc.util.ReadAheadInputStream.fill(ReadAheadInputStream.java:100).
2024-12-18T05:23:08.139: Row 8: at com.mysql.jdbc.util.ReadAheadInputStream.readFromUnderlyingStreamIfNecessary(ReadAheadInputStream.java:143).
2024-12-18T05:23:08.140: Row 9: at com.mysql.jdbc.util.ReadAheadInputStream.read(ReadAheadInputStream.java:173).
2024-12-18T05:23:08.140: Row 10: - locked <0x0000000761c60688> (a com.mysql.jdbc.util.ReadAheadInputStream).
2024-12-18T05:23:08.140: Row 11: at com.mysql.jdbc.MysqlIO.readFully(MysqlIO.java:2911).
2024-12-18T05:23:08.140: Row 12: at com.mysql.jdbc.MysqlIO.reuseAndReadPacket(MysqlIO.java:3337).
2024-12-18T05:23:08.140: Row 13: at com.mysql.jdbc.MysqlIO.reuseAndReadPacket(MysqlIO.java:3327).
2024-12-18T05:23:08.140: Row 14: at com.mysql.jdbc.MysqlIO.checkErrorPacket(MysqlIO.java:3814).
2024-12-18T05:23:08.140: Row 15: at com.mysql.jdbc.MysqlIO.sendCommand(MysqlIO.java:2435).
2024-12-18T05:23:08.140: Row 16: at com.mysql.jdbc.MysqlIO.sqlQueryDirect(MysqlIO.java:2582).
2024-12-18T05:23:08.141: Row 17: at com.mysql.jdbc.ConnectionImpl.execSQL(ConnectionImpl.java:2530).
2024-12-18T05:23:08.141: Row 18: - locked <0x0000000761c50c08> (a com.mysql.jdbc.JDBC4Connection).
2024-12-18T05:23:08.141: Row 19: at com.mysql.jdbc.PreparedStatement.executeInternal(PreparedStatement.java:1907).
2024-12-18T05:23:08.141: Row 20: - locked <0x0000000761c50c08> (a com.mysql.jdbc.JDBC4Connection).
2024-12-18T05:23:08.141: Row 21: at com.mysql.jdbc.PreparedStatement.executeQuery(PreparedStatement.java:2030).
2024-12-18T05:23:08.143: Row 22: - locked <0x0000000761c50c08> (a com.mysql.jdbc.JDBC4Connection).
2024-12-18T05:23:08.143: Row 23: at h2.BuildKnowledgeGraph_v5.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v5.java:1543).
2024-12-18T05:23:08.143: Row 24: at h2.SkillsForecast_methods.build_a_map_on_fly_v4(SkillsForecast_methods.java:5221).
2024-12-18T05:23:08.151: SUC: 2007, 30375ms, lines: 27.
2024-12-18T05:23:08.151: checkJavaStack end: 2007, pid/ret=27.
2024-12-18T05:23:18.152: checkJavaStack starting: 2007.
2024-12-18T05:23:48.351: ------ test: 2007
2024-12-18T05:23:48.351: 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-18T05:24:18.670: Row 1: "https-openssl-nio-443-exec-14" #50 daemon prio=5 os_prio=0 tid=0x00007f0eb4004800 nid=0x10097 runnable [0x00007f0f84cbc000].
2024-12-18T05:24:18.670: Row 2: java.lang.Thread.State: RUNNABLE.
2024-12-18T05:24:18.670: Row 3: at h1.body.wordToBody(body.java:297).
2024-12-18T05:24:18.670: Row 4: at h2.core2021.semanticSimilarity_v3(core2021.java:1393).
2024-12-18T05:24:18.670: Row 5: at h2.core2021.text2keywords_v3(core2021.java:727).
2024-12-18T05:24:18.670: Row 6: at h2.BuildKnowledgeGraph_v5.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v5.java:1727).
2024-12-18T05:24:18.670: Row 7: at h2.SkillsForecast_methods.build_a_map_on_fly_v4(SkillsForecast_methods.java:5221).
2024-12-18T05:24:18.671: Row 8: at h2.helpers.check_pending_works(helpers.java:5270).
2024-12-18T05:24:18.671: Row 9: at h1.mc_api.doPost(mc_api.java:4576).
2024-12-18T05:24:18.671: Row 10: at h1.mc_api.doGet(mc_api.java:38).
2024-12-18T05:24:18.673: SUC: 2007, 30322ms, lines: 10.
2024-12-18T05:24:18.674: checkJavaStack end: 2007, pid/ret=10.
2024-12-18T05:24:28.674: checkJavaStack starting: 2007.
2024-12-18T05:24:59.030: ------ test: 2007
2024-12-18T05:24:59.030: 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-18T05:25:29.349: Row 1: "https-openssl-nio-443-exec-14" #50 daemon prio=5 os_prio=0 tid=0x00007f0eb4004800 nid=0x10097 runnable [0x00007f0f84cbc000].
2024-12-18T05:25:29.351: Row 2: java.lang.Thread.State: RUNNABLE.
2024-12-18T05:25:29.351: Row 3: at h1.body.wordToBody(body.java:286).
2024-12-18T05:25:29.351: Row 4: at h2.core2021.semanticSimilarity_v3(core2021.java:1369).
2024-12-18T05:25:29.351: Row 5: at h2.core2021.text2keywords_v3(core2021.java:727).
2024-12-18T05:25:29.351: Row 6: at h2.BuildKnowledgeGraph_v5.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v5.java:1727).
2024-12-18T05:25:29.351: Row 7: at h2.SkillsForecast_methods.build_a_map_on_fly_v4(SkillsForecast_methods.java:5221).
2024-12-18T05:25:29.351: Row 8: at h2.helpers.check_pending_works(helpers.java:5270).
2024-12-18T05:25:29.352: Row 9: at h1.mc_api.doPost(mc_api.java:4576).
2024-12-18T05:25:29.352: Row 10: at h1.mc_api.doGet(mc_api.java:38).
2024-12-18T05:25:29.358: SUC: 2007, 30328ms, lines: 10.
2024-12-18T05:25:29.359: checkJavaStack end: 2007, pid/ret=10.
2024-12-18T05:25:39.359: checkJavaStack starting: 2007.
2024-12-18T05:26:09.558: ------ test: 2007
2024-12-18T05:26:09.562: 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-18T05:26:39.881: SUC: 2007, 30319ms, lines: 4096.
2024-12-18T05:26:39.882: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T05:26:49.882: checkJavaStack starting: 2007.
2024-12-18T05:27:20.145: ------ test: 2007
2024-12-18T05:27:20.146: 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-18T05:27:50.471: SUC: 2007, 30325ms, lines: 4096.
2024-12-18T05:27:50.471: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T05:28:00.472: checkJavaStack starting: 2007.
2024-12-18T05:28:30.727: ------ test: 2007
2024-12-18T05:28:30.727: 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-18T05:29:01.019: SUC: 2007, 30292ms, lines: 4096.
2024-12-18T05:29:01.019: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T05:29:11.020: checkJavaStack starting: 2007.
2024-12-18T05:29:41.204: ------ test: 2007
2024-12-18T05:29:41.204: 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-18T05:30:11.528: SUC: 2007, 30324ms, lines: 4096.
2024-12-18T05:30:11.528: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T05:30:21.529: checkJavaStack starting: 2007.
2024-12-18T05:30:51.719: ------ test: 2007
2024-12-18T05:30:51.719: 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-18T05:31:22.030: SUC: 2007, 30311ms, lines: 4096.
2024-12-18T05:31:22.030: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T05:31:32.031: checkJavaStack starting: 2007.
2024-12-18T05:32:02.227: ------ test: 2007
2024-12-18T05:32:02.227: 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-18T05:32:32.565: SUC: 2007, 30338ms, lines: 4096.
2024-12-18T05:32:32.566: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T05:32:42.566: checkJavaStack starting: 2007.
2024-12-18T05:33:12.765: ------ test: 2007
2024-12-18T05:33:12.766: 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-18T05:33:43.096: SUC: 2007, 30330ms, lines: 4096.
2024-12-18T05:33:43.096: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T05:33:53.096: checkJavaStack starting: 2007.
2024-12-18T05:34:23.293: ------ test: 2007
2024-12-18T05:34:23.293: 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-18T05:34:53.604: SUC: 2007, 30311ms, lines: 4096.
2024-12-18T05:34:53.604: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T05:35:03.606: checkJavaStack starting: 2007.
2024-12-18T05:35:33.803: ------ test: 2007
2024-12-18T05:35:33.803: 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-18T05:36:04.114: SUC: 2007, 30311ms, lines: 4096.
2024-12-18T05:36:04.115: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T05:36:14.115: checkJavaStack starting: 2007.
2024-12-18T05:36:44.347: ------ test: 2007
2024-12-18T05:36:44.347: 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-18T05:37:14.684: SUC: 2007, 30336ms, lines: 4096.
2024-12-18T05:37:14.684: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T05:37:24.684: checkJavaStack starting: 2007.
2024-12-18T05:37:54.881: ------ test: 2007
2024-12-18T05:37:54.881: 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-18T05:38:25.207: SUC: 2007, 30326ms, lines: 4096.
2024-12-18T05:38:25.207: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T05:38:35.208: checkJavaStack starting: 2007.
2024-12-18T05:39:05.409: ------ test: 2007
2024-12-18T05:39:05.410: 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-18T05:39:35.728: SUC: 2007, 30318ms, lines: 4096.
2024-12-18T05:39:35.728: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T05:39:45.729: checkJavaStack starting: 2007.
2024-12-18T05:40:15.926: ------ test: 2007
2024-12-18T05:40:15.926: 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-18T05:40:46.227: SUC: 2007, 30301ms, lines: 4096.
2024-12-18T05:40:46.227: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T05:40:56.228: checkJavaStack starting: 2007.
2024-12-18T05:41:26.425: ------ test: 2007
2024-12-18T05:41:26.425: 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-18T05:41:56.760: SUC: 2007, 30335ms, lines: 4096.
2024-12-18T05:41:56.760: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T05:42:06.760: checkJavaStack starting: 2007.
2024-12-18T05:42:36.955: ------ test: 2007
2024-12-18T05:42:36.956: 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-18T05:43:07.263: SUC: 2007, 30307ms, lines: 4096.
2024-12-18T05:43:07.264: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T05:43:17.264: checkJavaStack starting: 2007.
2024-12-18T05:43:47.462: ------ test: 2007
2024-12-18T05:43:47.462: 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-18T05:44:17.843: SUC: 2007, 30381ms, lines: 4096.
2024-12-18T05:44:17.843: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T05:44:27.844: checkJavaStack starting: 2007.
2024-12-18T05:44:58.041: ------ test: 2007
2024-12-18T05:44:58.041: 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-18T05:45:28.369: SUC: 2007, 30328ms, lines: 4096.
2024-12-18T05:45:28.370: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T05:45:38.370: checkJavaStack starting: 2007.
2024-12-18T05:46:08.567: ------ test: 2007
2024-12-18T05:46:08.567: 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-18T05:46:38.901: SUC: 2007, 30334ms, lines: 4096.
2024-12-18T05:46:38.901: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T05:46:48.902: checkJavaStack starting: 2007.
2024-12-18T05:47:19.134: ------ test: 2007
2024-12-18T05:47:19.134: 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-18T05:47:49.436: SUC: 2007, 30302ms, lines: 4096.
2024-12-18T05:47:49.437: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T05:47:59.437: checkJavaStack starting: 2007.
2024-12-18T05:48:29.633: ------ test: 2007
2024-12-18T05:48:29.634: 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-18T05:48:59.933: SUC: 2007, 30299ms, lines: 4096.
2024-12-18T05:48:59.933: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T05:49:09.934: checkJavaStack starting: 2007.
2024-12-18T05:49:40.127: ------ test: 2007
2024-12-18T05:49:40.129: 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-18T05:50:10.438: SUC: 2007, 30308ms, lines: 4096.
2024-12-18T05:50:10.438: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T05:50:20.438: checkJavaStack starting: 2007.
2024-12-18T05:50:50.631: ------ test: 2007
2024-12-18T05:50:50.631: 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-18T05:51:20.966: SUC: 2007, 30335ms, lines: 4096.
2024-12-18T05:51:20.966: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T05:51:30.967: checkJavaStack starting: 2007.
2024-12-18T05:52:01.160: ------ test: 2007
2024-12-18T05:52:01.160: 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-18T05:52:31.478: SUC: 2007, 30317ms, lines: 4096.
2024-12-18T05:52:31.478: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T05:52:41.478: checkJavaStack starting: 2007.
2024-12-18T05:53:11.674: ------ test: 2007
2024-12-18T05:53:11.675: 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-18T05:53:41.989: SUC: 2007, 30314ms, lines: 4096.
2024-12-18T05:53:41.989: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T05:53:51.990: checkJavaStack starting: 2007.
2024-12-18T05:54:22.188: ------ test: 2007
2024-12-18T05:54:22.188: 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-18T05:54:52.548: SUC: 2007, 30360ms, lines: 4096.
2024-12-18T05:54:52.549: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T05:55:02.549: checkJavaStack starting: 2007.
2024-12-18T05:55:32.745: ------ test: 2007
2024-12-18T05:55:32.745: 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-18T05:56:03.055: SUC: 2007, 30310ms, lines: 4096.
2024-12-18T05:56:03.056: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T05:56:13.057: checkJavaStack starting: 2007.
2024-12-18T05:56:43.280: ------ test: 2007
2024-12-18T05:56:43.280: 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-18T05:57:13.625: SUC: 2007, 30345ms, lines: 4096.
2024-12-18T05:57:13.626: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T05:57:23.626: checkJavaStack starting: 2007.
2024-12-18T05:57:53.822: ------ test: 2007
2024-12-18T05:57:53.822: 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-18T05:58:24.125: SUC: 2007, 30303ms, lines: 4096.
2024-12-18T05:58:24.126: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T05:58:34.126: checkJavaStack starting: 2007.
2024-12-18T05:59:04.323: ------ test: 2007
2024-12-18T05:59:04.323: 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-18T05:59:34.694: SUC: 2007, 30371ms, lines: 4096.
2024-12-18T05:59:34.694: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T05:59:34.694: ------ test: end, 2309300ms. Score 39/39.
2024-12-18T05:59:34.694: Test duration: 38m29s.