2024-12-18T06:21:04.946: current working dir: /root/qa/mctester.
2024-12-18T06:21:05.048: current logging dir: ../mctester/www.
2024-12-18T06:21:05.048: ---------------------------------------------------------------
2024-12-18T06:21:05.049: mctester entry: 2024-12-18T06:21:05.048 mode=50
2024-12-18T06:21:05.049: ---------------------------------------------------------------
2024-12-18T06:21:05.160: EXE: 1/git describe --tags.
2024-12-18T06:21:05.172: Row 1: v1.1-201-g90c2042.
2024-12-18T06:21:05.173: EXE: 1/git rev-list --count HEAD.
2024-12-18T06:21:05.178: Row 1: 258.
2024-12-18T06:21:05.179: EXE: 1/git rev-parse HEAD.
2024-12-18T06:21:05.180: Row 1: 90c2042af9ce0b055e0a62dafd703b27e21c4128.
2024-12-18T06:21:05.181: mctester: v1.1.258 (90c2042af9ce0b055e0a62dafd703b27e21c4128).
2024-12-18T06:21:05.181: Entering into a performance tests mode.
2024-12-18T06:21:05.182: ------ test: start, 2024-12-18T06:21:05.182
2024-12-18T06:21:05.184: ------ test: 2000
2024-12-18T06:21:05.184: CMD: ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "top -b -n 1"
2024-12-18T06:21:05.185: EXE: 1/ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "top -b -n 1".
2024-12-18T06:21:35.515: Row 1: top - 06:21:35 up 91 days, 22:48, 0 users, load average: 0.24, 0.06, 0.02.
2024-12-18T06:21:35.515: Row 2: Tasks: 363 total, 1 running, 362 sleeping, 0 stopped, 0 zombie.
2024-12-18T06:21:35.516: 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-18T06:21:35.516: Row 4: KiB Mem : 13202036+total, 615388 free, 57811752 used, 73593232 buff/cache.
2024-12-18T06:21:35.516: Row 5: KiB Swap: 0 total, 0 free, 0 used. 72619448 avail Mem .
2024-12-18T06:21:35.516: Row 6: .
2024-12-18T06:21:35.517: Row 7: PID USER PR NI VIRT RES SHR S %CPU %MEM TIME+ COMMAND.
2024-12-18T06:21:35.517: Row 8: 1978 mysql 20 0 99.646g 0.047t 715168 S 62.5 38.3 13710:29 mysqld.
2024-12-18T06:21:35.517: Row 9: 13525 root 20 0 42220 3812 3096 R 6.2 0.0 0:00.01 top.
2024-12-18T06:21:35.519: Row 10: 1 root 20 0 43660 3556 2272 S 0.0 0.0 3:25.06 init.
2024-12-18T06:21:35.520: Row 11: 2 root 20 0 0 0 0 S 0.0 0.0 0:01.23 kthreadd.
2024-12-18T06:21:35.521: Row 12: 3 root 20 0 0 0 0 S 0.0 0.0 4:29.64 ksoftirqd+.
2024-12-18T06:21:35.521: Row 13: 5 root 0 -20 0 0 0 S 0.0 0.0 0:00.00 kworker/0+.
2024-12-18T06:21:35.522: Row 14: 7 root 20 0 0 0 0 S 0.0 0.0 30:03.82 rcu_sched.
2024-12-18T06:21:35.525: Row 15: 8 root 20 0 0 0 0 S 0.0 0.0 0:00.00 rcu_bh.
2024-12-18T06:21:35.525: Row 16: 9 root rt 0 0 0 0 S 0.0 0.0 0:05.50 migration+.
2024-12-18T06:21:35.526: Row 17: 10 root rt 0 0 0 0 S 0.0 0.0 0:22.16 watchdog/0.
2024-12-18T06:21:35.526: Row 18: 11 root rt 0 0 0 0 S 0.0 0.0 0:20.23 watchdog/1.
2024-12-18T06:21:35.526: Row 19: 12 root rt 0 0 0 0 S 0.0 0.0 0:10.80 migration+.
2024-12-18T06:21:35.527: Row 20: 13 root 20 0 0 0 0 S 0.0 0.0 0:01.78 ksoftirqd+.
2024-12-18T06:21:35.527: Row 21: 15 root 0 -20 0 0 0 S 0.0 0.0 0:00.00 kworker/1+.
2024-12-18T06:21:35.527: Row 22: 16 root rt 0 0 0 0 S 0.0 0.0 0:20.68 watchdog/2.
2024-12-18T06:21:35.528: Row 23: 17 root rt 0 0 0 0 S 0.0 0.0 0:04.59 migration+.
2024-12-18T06:21:35.528: Row 24: 18 root 20 0 0 0 0 S 0.0 0.0 0:01.44 ksoftirqd+.
2024-12-18T06:21:35.595: SUC: 30411ms Uptime 91 days, 1min 0.24, 5min 0.06, 15min 0.02, mem:132020360 total / 615388 free / 57811752 used / 73593232 cache / 72619448 avail
2024-12-18T06:21:35.606: ------ test: 2001
2024-12-18T06:21:35.607: CMD: top -b -E k -n 1
2024-12-18T06:21:35.607: EXE: 1/top -b -E k -n 1.
2024-12-18T06:21:35.763: Row 1: top - 06:21:35 up 36 days, 13:03, 0 users, load average: 0.02, 0.01, 0.00.
2024-12-18T06:21:35.763: Row 2: Tasks: 99 total, 1 running, 97 sleeping, 0 stopped, 1 zombie.
2024-12-18T06:21:35.763: Row 3: %Cpu(s): 0.0 us, 6.2 sy, 0.0 ni, 93.8 id, 0.0 wa, 0.0 hi, 0.0 si, 0.0 st.
2024-12-18T06:21:35.763: Row 4: KiB Mem : 1907632 total, 434376 free, 397996 used, 1075260 buff/cache.
2024-12-18T06:21:35.763: Row 5: KiB Swap: 0 total, 0 free, 0 used. 1292844 avail Mem .
2024-12-18T06:21:35.763: Row 6: .
2024-12-18T06:21:35.764: Row 7: PID USER PR NI VIRT RES SHR S %CPU %MEM TIME+ COMMAND.
2024-12-18T06:21:35.764: Row 8: 1 root 20 0 167784 12172 7288 S 0.0 0.6 0:57.60 systemd.
2024-12-18T06:21:35.764: Row 9: 2 root 20 0 0 0 0 S 0.0 0.0 0:00.09 kthreadd.
2024-12-18T06:21:35.764: Row 10: 3 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 rcu_gp.
2024-12-18T06:21:35.764: Row 11: 4 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 rcu_par+.
2024-12-18T06:21:35.764: Row 12: 5 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 slub_fl+.
2024-12-18T06:21:35.764: Row 13: 6 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 netns.
2024-12-18T06:21:35.765: Row 14: 8 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 kworker+.
2024-12-18T06:21:35.765: Row 15: 10 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 mm_perc+.
2024-12-18T06:21:35.765: Row 16: 11 root 20 0 0 0 0 S 0.0 0.0 0:00.00 rcu_tas+.
2024-12-18T06:21:35.765: Row 17: 12 root 20 0 0 0 0 S 0.0 0.0 0:00.00 rcu_tas+.
2024-12-18T06:21:35.771: Row 18: 13 root 20 0 0 0 0 S 0.0 0.0 0:31.26 ksoftir+.
2024-12-18T06:21:35.771: Row 19: 14 root 20 0 0 0 0 I 0.0 0.0 0:53.86 rcu_sch+.
2024-12-18T06:21:35.772: Row 20: 15 root rt 0 0 0 0 S 0.0 0.0 0:07.95 migrati+.
2024-12-18T06:21:35.772: Row 21: 16 root -51 0 0 0 0 S 0.0 0.0 0:00.00 idle_in+.
2024-12-18T06:21:35.772: Row 22: 18 root 20 0 0 0 0 S 0.0 0.0 0:00.00 cpuhp/0.
2024-12-18T06:21:35.773: Row 23: 19 root 20 0 0 0 0 S 0.0 0.0 0:00.00 kdevtmp+.
2024-12-18T06:21:35.774: Row 24: 20 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 inet_fr+.
2024-12-18T06:21:35.781: SUC: 174ms Uptime 36 days, 1min 0.02, 5min 0.01, 15min 0.00, mem:1907632 total / 434376 free / 397996 used / 1075260 cache / 1292844 avail
2024-12-18T06:21:35.782: ------ test: 2002
2024-12-18T06:21:35.783: CMD: df -h
2024-12-18T06:21:35.783: EXE: 1/df -h.
2024-12-18T06:21:35.785: Row 1: Filesystem Size Used Avail Use% Mounted on.
2024-12-18T06:21:35.785: Row 2: tmpfs 187M 20M 167M 11% /run.
2024-12-18T06:21:35.785: Row 3: /dev/vda2 20G 14G 5.2G 73% /.
2024-12-18T06:21:35.785: Row 4: tmpfs 932M 0 932M 0% /dev/shm.
2024-12-18T06:21:35.785: Row 5: tmpfs 5.0M 0 5.0M 0% /run/lock.
2024-12-18T06:21:35.787: SUC: 4ms Diskfree qa.headai.com: tmpfs:11%, /dev/vda2:73%, tmpfs:0%, tmpfs:0%.
2024-12-18T06:21:35.788: ------ test: 2003
2024-12-18T06:21:35.788: CMD: ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "df -h"
2024-12-18T06:21:35.788: EXE: 1/ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "df -h".
2024-12-18T06:22:05.974: Row 1: Filesystem Size Used Avail Use% Mounted on.
2024-12-18T06:22:05.975: Row 2: udev 63G 4.0K 63G 1% /dev.
2024-12-18T06:22:05.975: Row 3: tmpfs 13G 544M 13G 5% /run.
2024-12-18T06:22:05.975: Row 4: /dev/vda1 757G 512G 214G 71% /.
2024-12-18T06:22:05.975: Row 5: none 4.0K 0 4.0K 0% /sys/fs/cgroup.
2024-12-18T06:22:05.975: Row 6: none 5.0M 0 5.0M 0% /run/lock.
2024-12-18T06:22:05.975: Row 7: cgmfs 100K 0 100K 0% /run/cgmanager/fs.
2024-12-18T06:22:05.975: Row 8: none 63G 0 63G 0% /run/shm.
2024-12-18T06:22:05.975: Row 9: none 100M 0 100M 0% /run/user.
2024-12-18T06:22:05.976: Row 10: /dev/vdb 985G 230G 705G 25% /opt/tomcat/webapps/ROOT/analysis.
2024-12-18T06:22:05.976: Row 11: tmpfs 100K 0 100K 0% /var/lib/lxd/shmounts.
2024-12-18T06:22:05.976: Row 12: tmpfs 100K 0 100K 0% /var/lib/lxd/devlxd.
2024-12-18T06:22:05.976: Row 13: tmpfs 13G 0 13G 0% /run/user/0.
2024-12-18T06:22:05.982: SUC: 30194ms 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-18T06:22:05.983: ------ test: 2004
2024-12-18T06:22:05.983: URL: https://headai.com
2024-12-18T06:22:06.621: SUC: 638ms, Trusted by 100+ customers and partners globally, length 185391.
2024-12-18T06:22:06.627: ------ test: 2005
2024-12-18T06:22:07.077: SQL: show global status like 'threads_connected';.
2024-12-18T06:22:07.098: Results: value=3/200.
2024-12-18T06:22:07.099: SQL: value, lines: 1, ret=1, 3.
2024-12-18T06:22:07.100: SUC: 471ms 3
2024-12-18T06:22:07.103: ------ test: 2006
2024-12-18T06:22:07.212: SQL: SHOW PROCESSLIST;.
2024-12-18T06:22:07.214: Row 1: 25558345,root,localhost:38604,competences,Query,13,Sending data,SELECT id,url,title,description FROM jobs.items_2021 WHERE (1=1) AND length(description)>100 AND ye.
2024-12-18T06:22:07.214: Row 2: 25558413,root,localhost:38766,null,Query,0,starting,SHOW PROCESSLIST.
2024-12-18T06:22:07.214: SQL: COUNTNOTLINES:Command, lines: 2, ret=2, 2.
2024-12-18T06:22:07.217: SUC: 114ms 2
2024-12-18T06:22:07.218: checkJavaStack starting: 2007.
2024-12-18T06:22:37.418: ------ test: 2007
2024-12-18T06:22:37.418: 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-18T06:23:07.791: Row 1: "https-openssl-nio-443-exec-7" #38 daemon prio=5 os_prio=0 tid=0x00007f0fec710800 nid=0x1008c runnable [0x00007f0f859c7000].
2024-12-18T06:23:07.791: Row 2: java.lang.Thread.State: RUNNABLE.
2024-12-18T06:23:07.791: Row 3: at java.net.SocketInputStream.socketRead0(Native Method).
2024-12-18T06:23:07.791: Row 4: at java.net.SocketInputStream.socketRead(SocketInputStream.java:116).
2024-12-18T06:23:07.791: Row 5: at java.net.SocketInputStream.read(SocketInputStream.java:171).
2024-12-18T06:23:07.791: Row 6: at java.net.SocketInputStream.read(SocketInputStream.java:141).
2024-12-18T06:23:07.791: Row 7: at com.mysql.jdbc.util.ReadAheadInputStream.fill(ReadAheadInputStream.java:100).
2024-12-18T06:23:07.791: Row 8: at com.mysql.jdbc.util.ReadAheadInputStream.readFromUnderlyingStreamIfNecessary(ReadAheadInputStream.java:143).
2024-12-18T06:23:07.792: Row 9: at com.mysql.jdbc.util.ReadAheadInputStream.read(ReadAheadInputStream.java:173).
2024-12-18T06:23:07.792: Row 10: - locked <0x0000000793ab09f0> (a com.mysql.jdbc.util.ReadAheadInputStream).
2024-12-18T06:23:07.793: Row 11: at com.mysql.jdbc.MysqlIO.readFully(MysqlIO.java:2911).
2024-12-18T06:23:07.793: Row 12: at com.mysql.jdbc.MysqlIO.reuseAndReadPacket(MysqlIO.java:3337).
2024-12-18T06:23:07.794: Row 13: at com.mysql.jdbc.MysqlIO.reuseAndReadPacket(MysqlIO.java:3327).
2024-12-18T06:23:07.794: Row 14: at com.mysql.jdbc.MysqlIO.checkErrorPacket(MysqlIO.java:3814).
2024-12-18T06:23:07.794: Row 15: at com.mysql.jdbc.MysqlIO.sendCommand(MysqlIO.java:2435).
2024-12-18T06:23:07.794: Row 16: at com.mysql.jdbc.MysqlIO.sqlQueryDirect(MysqlIO.java:2582).
2024-12-18T06:23:07.794: Row 17: at com.mysql.jdbc.ConnectionImpl.execSQL(ConnectionImpl.java:2530).
2024-12-18T06:23:07.794: Row 18: - locked <0x0000000793aa7028> (a com.mysql.jdbc.JDBC4Connection).
2024-12-18T06:23:07.794: Row 19: at com.mysql.jdbc.PreparedStatement.executeInternal(PreparedStatement.java:1907).
2024-12-18T06:23:07.794: Row 20: - locked <0x0000000793aa7028> (a com.mysql.jdbc.JDBC4Connection).
2024-12-18T06:23:07.794: Row 21: at com.mysql.jdbc.PreparedStatement.executeQuery(PreparedStatement.java:2030).
2024-12-18T06:23:07.795: Row 22: - locked <0x0000000793aa7028> (a com.mysql.jdbc.JDBC4Connection).
2024-12-18T06:23:07.795: Row 23: at h2.SkillsForecast_methods.get_total_data_size_build_a_map_on_fly(SkillsForecast_methods.java:4244).
2024-12-18T06:23:07.795: Row 24: at h2.BuildKnowledgeGraph_v5.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v5.java:716).
2024-12-18T06:23:07.803: SUC: 2007, 30385ms, lines: 28.
2024-12-18T06:23:07.803: checkJavaStack end: 2007, pid/ret=28.
2024-12-18T06:23:17.804: checkJavaStack starting: 2007.
2024-12-18T06:23:48.005: ------ test: 2007
2024-12-18T06:23:48.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-18T06:24:18.311: Row 1: "https-openssl-nio-443-exec-7" #38 daemon prio=5 os_prio=0 tid=0x00007f0fec710800 nid=0x1008c runnable [0x00007f0f859c7000].
2024-12-18T06:24:18.312: Row 2: java.lang.Thread.State: RUNNABLE.
2024-12-18T06:24:18.312: Row 3: at java.util.AbstractCollection.toArray(AbstractCollection.java:183).
2024-12-18T06:24:18.312: Row 4: at java.lang.String.split(String.java:2378).
2024-12-18T06:24:18.312: Row 5: at java.lang.String.split(String.java:2422).
2024-12-18T06:24:18.312: Row 6: at h2.core2021.semanticSimilarity_v3(core2021.java:1265).
2024-12-18T06:24:18.312: Row 7: at h2.core2021.text2keywords_v3(core2021.java:727).
2024-12-18T06:24:18.312: Row 8: at h2.BuildKnowledgeGraph_v5.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v5.java:1727).
2024-12-18T06:24:18.313: Row 9: at h2.SkillsForecast_methods.build_a_map_on_fly_v4(SkillsForecast_methods.java:5221).
2024-12-18T06:24:18.313: Row 10: at h2.helpers.check_pending_works(helpers.java:5270).
2024-12-18T06:24:18.313: Row 11: at h1.mc_api.doPost(mc_api.java:4576).
2024-12-18T06:24:18.313: Row 12: at h1.mc_api.doGet(mc_api.java:38).
2024-12-18T06:24:18.316: SUC: 2007, 30310ms, lines: 12.
2024-12-18T06:24:18.320: checkJavaStack end: 2007, pid/ret=12.
2024-12-18T06:24:28.320: checkJavaStack starting: 2007.
2024-12-18T06:24:58.514: ------ test: 2007
2024-12-18T06:24:58.514: 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-18T06:25:28.832: Row 1: "https-openssl-nio-443-exec-7" #38 daemon prio=5 os_prio=0 tid=0x00007f0fec710800 nid=0x1008c runnable [0x00007f0f859c7000].
2024-12-18T06:25:28.832: Row 2: java.lang.Thread.State: RUNNABLE.
2024-12-18T06:25:28.832: Row 3: at java.lang.String.indexOf(String.java:1769).
2024-12-18T06:25:28.832: Row 4: at java.lang.String.indexOf(String.java:1718).
2024-12-18T06:25:28.832: Row 5: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5362).
2024-12-18T06:25:28.832: Row 6: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5318).
2024-12-18T06:25:28.833: Row 7: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5258).
2024-12-18T06:25:28.833: Row 8: at h2.core2021.semanticSimilarity_v3(core2021.java:1398).
2024-12-18T06:25:28.833: Row 9: at h2.core2021.text2keywords_v3(core2021.java:727).
2024-12-18T06:25:28.833: Row 10: at h2.BuildKnowledgeGraph_v5.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v5.java:1727).
2024-12-18T06:25:28.833: Row 11: at h2.SkillsForecast_methods.build_a_map_on_fly_v4(SkillsForecast_methods.java:5221).
2024-12-18T06:25:28.839: Row 12: at h2.helpers.check_pending_works(helpers.java:5270).
2024-12-18T06:25:28.839: Row 13: at h1.mc_api.doPost(mc_api.java:4576).
2024-12-18T06:25:28.843: Row 14: at h1.mc_api.doGet(mc_api.java:38).
2024-12-18T06:25:28.846: SUC: 2007, 30332ms, lines: 14.
2024-12-18T06:25:28.846: checkJavaStack end: 2007, pid/ret=14.
2024-12-18T06:25:38.847: checkJavaStack starting: 2007.
2024-12-18T06:26:09.228: ------ test: 2007
2024-12-18T06:26:09.229: 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-18T06:26:39.581: SUC: 2007, 30352ms, lines: 4096.
2024-12-18T06:26:39.582: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T06:26:49.582: checkJavaStack starting: 2007.
2024-12-18T06:27:19.781: ------ test: 2007
2024-12-18T06:27:19.781: 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-18T06:27:50.163: SUC: 2007, 30382ms, lines: 4096.
2024-12-18T06:27:50.163: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T06:28:00.164: checkJavaStack starting: 2007.
2024-12-18T06:28:30.363: ------ test: 2007
2024-12-18T06:28:30.363: 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-18T06:29:00.689: SUC: 2007, 30326ms, lines: 4096.
2024-12-18T06:29:00.690: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T06:29:10.691: checkJavaStack starting: 2007.
2024-12-18T06:29:40.868: ------ test: 2007
2024-12-18T06:29:40.868: 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-18T06:30:11.207: SUC: 2007, 30339ms, lines: 4096.
2024-12-18T06:30:11.208: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T06:30:21.208: checkJavaStack starting: 2007.
2024-12-18T06:30:51.400: ------ test: 2007
2024-12-18T06:30:51.400: 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-18T06:31:21.795: SUC: 2007, 30395ms, lines: 4096.
2024-12-18T06:31:21.795: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T06:31:31.796: checkJavaStack starting: 2007.
2024-12-18T06:32:01.994: ------ test: 2007
2024-12-18T06:32:01.995: 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-18T06:32:32.352: SUC: 2007, 30356ms, lines: 4096.
2024-12-18T06:32:32.352: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T06:32:42.352: checkJavaStack starting: 2007.
2024-12-18T06:33:12.571: ------ test: 2007
2024-12-18T06:33:12.571: 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-18T06:33:42.892: SUC: 2007, 30321ms, lines: 4096.
2024-12-18T06:33:42.892: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T06:33:52.893: checkJavaStack starting: 2007.
2024-12-18T06:34:23.091: ------ test: 2007
2024-12-18T06:34:23.091: 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-18T06:34:53.412: SUC: 2007, 30321ms, lines: 4096.
2024-12-18T06:34:53.413: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T06:35:03.413: checkJavaStack starting: 2007.
2024-12-18T06:35:33.610: ------ test: 2007
2024-12-18T06:35:33.610: 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-18T06:36:03.922: SUC: 2007, 30312ms, lines: 4096.
2024-12-18T06:36:03.923: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T06:36:13.923: checkJavaStack starting: 2007.
2024-12-18T06:36:44.118: ------ test: 2007
2024-12-18T06:36:44.118: 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-18T06:37:14.442: SUC: 2007, 30324ms, lines: 4096.
2024-12-18T06:37:14.442: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T06:37:24.442: checkJavaStack starting: 2007.
2024-12-18T06:37:54.637: ------ test: 2007
2024-12-18T06:37:54.637: 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-18T06:38:24.948: SUC: 2007, 30311ms, lines: 4096.
2024-12-18T06:38:24.949: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T06:38:34.949: checkJavaStack starting: 2007.
2024-12-18T06:39:05.146: ------ test: 2007
2024-12-18T06:39:05.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-18T06:39:35.481: SUC: 2007, 30335ms, lines: 4096.
2024-12-18T06:39:35.483: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T06:39:45.483: checkJavaStack starting: 2007.
2024-12-18T06:40:15.684: ------ test: 2007
2024-12-18T06:40:15.685: 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-18T06:40:46.009: SUC: 2007, 30324ms, lines: 4096.
2024-12-18T06:40:46.009: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T06:40:56.010: checkJavaStack starting: 2007.
2024-12-18T06:41:26.205: ------ test: 2007
2024-12-18T06:41:26.206: 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-18T06:41:56.555: SUC: 2007, 30349ms, lines: 4096.
2024-12-18T06:41:56.556: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T06:42:06.556: checkJavaStack starting: 2007.
2024-12-18T06:42:36.748: ------ test: 2007
2024-12-18T06:42:36.748: 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-18T06:43:07.044: SUC: 2007, 30296ms, lines: 4096.
2024-12-18T06:43:07.045: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T06:43:17.045: checkJavaStack starting: 2007.
2024-12-18T06:43:47.241: ------ test: 2007
2024-12-18T06:43:47.242: 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-18T06:44:17.587: SUC: 2007, 30346ms, lines: 4096.
2024-12-18T06:44:17.588: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T06:44:27.588: checkJavaStack starting: 2007.
2024-12-18T06:44:57.781: ------ test: 2007
2024-12-18T06:44:57.782: 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-18T06:45:28.086: SUC: 2007, 30304ms, lines: 4096.
2024-12-18T06:45:28.087: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T06:45:38.087: checkJavaStack starting: 2007.
2024-12-18T06:46:08.405: ------ test: 2007
2024-12-18T06:46:08.406: 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-18T06:46:38.732: SUC: 2007, 30326ms, lines: 4096.
2024-12-18T06:46:38.733: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T06:46:48.733: checkJavaStack starting: 2007.
2024-12-18T06:47:18.926: ------ test: 2007
2024-12-18T06:47:18.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-18T06:47:49.283: SUC: 2007, 30357ms, lines: 4096.
2024-12-18T06:47:49.284: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T06:47:59.284: checkJavaStack starting: 2007.
2024-12-18T06:48:29.483: ------ test: 2007
2024-12-18T06:48:29.484: 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-18T06:48:59.797: SUC: 2007, 30312ms, lines: 4096.
2024-12-18T06:48:59.797: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T06:49:09.797: checkJavaStack starting: 2007.
2024-12-18T06:49:40.452: ------ test: 2007
2024-12-18T06:49:40.452: 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-18T06:50:10.832: SUC: 2007, 30380ms, lines: 4096.
2024-12-18T06:50:10.833: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T06:50:20.833: checkJavaStack starting: 2007.
2024-12-18T06:50:51.321: ------ test: 2007
2024-12-18T06:50:51.321: 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-18T06:51:21.686: SUC: 2007, 30365ms, lines: 4096.
2024-12-18T06:51:21.687: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T06:51:31.687: checkJavaStack starting: 2007.
2024-12-18T06:52:01.878: ------ test: 2007
2024-12-18T06:52:01.878: 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-18T06:52:32.188: SUC: 2007, 30310ms, lines: 4096.
2024-12-18T06:52:32.188: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T06:52:42.188: checkJavaStack starting: 2007.
2024-12-18T06:53:12.383: ------ test: 2007
2024-12-18T06:53:12.383: 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-18T06:53:42.702: SUC: 2007, 30319ms, lines: 4096.
2024-12-18T06:53:42.702: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T06:53:52.703: checkJavaStack starting: 2007.
2024-12-18T06:54:22.898: ------ test: 2007
2024-12-18T06:54:22.898: 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-18T06:54:53.201: SUC: 2007, 30303ms, lines: 4096.
2024-12-18T06:54:53.202: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T06:55:03.203: checkJavaStack starting: 2007.
2024-12-18T06:55:33.444: ------ test: 2007
2024-12-18T06:55:33.444: 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-18T06:56:03.805: SUC: 2007, 30361ms, lines: 4096.
2024-12-18T06:56:03.806: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T06:56:13.806: checkJavaStack starting: 2007.
2024-12-18T06:56:44.052: ------ test: 2007
2024-12-18T06:56:44.053: 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-18T06:57:14.424: SUC: 2007, 30371ms, lines: 4096.
2024-12-18T06:57:14.424: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T06:57:24.425: checkJavaStack starting: 2007.
2024-12-18T06:57:54.621: ------ test: 2007
2024-12-18T06:57:54.621: 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-18T06:58:24.925: SUC: 2007, 30304ms, lines: 4096.
2024-12-18T06:58:24.926: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T06:58:34.926: checkJavaStack starting: 2007.
2024-12-18T06:59:05.121: ------ test: 2007
2024-12-18T06:59:05.121: 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-18T06:59:35.467: SUC: 2007, 30346ms, lines: 4096.
2024-12-18T06:59:35.467: checkJavaStack end: 2007, pid/ret=4096.
2024-12-18T06:59:35.467: ------ test: end, 2310285ms. Score 39/39.
2024-12-18T06:59:35.467: Test duration: 38m30s.