2024-12-17T18:21:04.765: current working dir: /root/qa/mctester.
2024-12-17T18:21:04.866: current logging dir: ../mctester/www.
2024-12-17T18:21:04.866: ---------------------------------------------------------------
2024-12-17T18:21:04.866: mctester entry: 2024-12-17T18:21:04.866 mode=50
2024-12-17T18:21:04.867: ---------------------------------------------------------------
2024-12-17T18:21:04.980: EXE: 1/git describe --tags.
2024-12-17T18:21:04.996: Row 1: v1.1-201-g90c2042.
2024-12-17T18:21:04.997: EXE: 1/git rev-list --count HEAD.
2024-12-17T18:21:05.001: Row 1: 258.
2024-12-17T18:21:05.002: EXE: 1/git rev-parse HEAD.
2024-12-17T18:21:05.004: Row 1: 90c2042af9ce0b055e0a62dafd703b27e21c4128.
2024-12-17T18:21:05.004: mctester: v1.1.258 (90c2042af9ce0b055e0a62dafd703b27e21c4128).
2024-12-17T18:21:05.004: Entering into a performance tests mode.
2024-12-17T18:21:05.005: ------ test: start, 2024-12-17T18:21:05.005
2024-12-17T18:21:05.007: ------ test: 2000
2024-12-17T18:21:05.008: CMD: ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "top -b -n 1"
2024-12-17T18:21:05.008: EXE: 1/ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "top -b -n 1".
2024-12-17T18:21:35.337: Row 1: top - 18:21:35 up 91 days, 10:48, 0 users, load average: 0.18, 0.04, 0.01.
2024-12-17T18:21:35.338: Row 2: Tasks: 359 total, 1 running, 358 sleeping, 0 stopped, 0 zombie.
2024-12-17T18:21:35.338: 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-17T18:21:35.339: Row 4: KiB Mem : 13202036+total, 720548 free, 60823468 used, 70476352 buff/cache.
2024-12-17T18:21:35.339: Row 5: KiB Swap: 0 total, 0 free, 0 used. 69606464 avail Mem .
2024-12-17T18:21:35.339: Row 6: .
2024-12-17T18:21:35.339: Row 7: PID USER PR NI VIRT RES SHR S %CPU %MEM TIME+ COMMAND.
2024-12-17T18:21:35.342: Row 8: 1978 mysql 20 0 99.646g 0.048t 1.138g S 113.3 38.7 13651:55 mysqld.
2024-12-17T18:21:35.343: Row 9: 1 root 20 0 43660 2552 1268 S 0.0 0.0 3:23.96 init.
2024-12-17T18:21:35.343: Row 10: 2 root 20 0 0 0 0 S 0.0 0.0 0:01.23 kthreadd.
2024-12-17T18:21:35.343: Row 11: 3 root 20 0 0 0 0 S 0.0 0.0 4:29.05 ksoftirqd+.
2024-12-17T18:21:35.343: Row 12: 5 root 0 -20 0 0 0 S 0.0 0.0 0:00.00 kworker/0+.
2024-12-17T18:21:35.343: Row 13: 7 root 20 0 0 0 0 S 0.0 0.0 29:54.43 rcu_sched.
2024-12-17T18:21:35.345: Row 14: 8 root 20 0 0 0 0 S 0.0 0.0 0:00.00 rcu_bh.
2024-12-17T18:21:35.348: Row 15: 9 root rt 0 0 0 0 S 0.0 0.0 0:05.48 migration+.
2024-12-17T18:21:35.349: Row 16: 10 root rt 0 0 0 0 S 0.0 0.0 0:22.04 watchdog/0.
2024-12-17T18:21:35.349: Row 17: 11 root rt 0 0 0 0 S 0.0 0.0 0:20.13 watchdog/1.
2024-12-17T18:21:35.349: Row 18: 12 root rt 0 0 0 0 S 0.0 0.0 0:10.72 migration+.
2024-12-17T18:21:35.349: Row 19: 13 root 20 0 0 0 0 S 0.0 0.0 0:01.78 ksoftirqd+.
2024-12-17T18:21:35.349: Row 20: 15 root 0 -20 0 0 0 S 0.0 0.0 0:00.00 kworker/1+.
2024-12-17T18:21:35.350: Row 21: 16 root rt 0 0 0 0 S 0.0 0.0 0:20.56 watchdog/2.
2024-12-17T18:21:35.350: Row 22: 17 root rt 0 0 0 0 S 0.0 0.0 0:04.56 migration+.
2024-12-17T18:21:35.350: Row 23: 18 root 20 0 0 0 0 S 0.0 0.0 0:01.44 ksoftirqd+.
2024-12-17T18:21:35.350: Row 24: 20 root 0 -20 0 0 0 S 0.0 0.0 0:00.00 kworker/2+.
2024-12-17T18:21:35.418: SUC: 30410ms Uptime 91 days, 1min 0.18, 5min 0.04, 15min 0.01, mem:132020360 total / 720548 free / 60823468 used / 70476352 cache / 69606464 avail
2024-12-17T18:21:35.432: ------ test: 2001
2024-12-17T18:21:35.432: CMD: top -b -E k -n 1
2024-12-17T18:21:35.432: EXE: 1/top -b -E k -n 1.
2024-12-17T18:21:35.588: Row 1: top - 18:21:35 up 36 days, 1:03, 0 users, load average: 0.03, 0.02, 0.00.
2024-12-17T18:21:35.588: Row 2: Tasks: 99 total, 1 running, 97 sleeping, 0 stopped, 1 zombie.
2024-12-17T18:21:35.588: 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-17T18:21:35.588: Row 4: KiB Mem : 1907632 total, 497692 free, 391704 used, 1018236 buff/cache.
2024-12-17T18:21:35.589: Row 5: KiB Swap: 0 total, 0 free, 0 used. 1299136 avail Mem .
2024-12-17T18:21:35.589: Row 6: .
2024-12-17T18:21:35.589: Row 7: PID USER PR NI VIRT RES SHR S %CPU %MEM TIME+ COMMAND.
2024-12-17T18:21:35.589: Row 8: 1 root 20 0 167784 11968 7084 S 0.0 0.6 0:57.04 systemd.
2024-12-17T18:21:35.592: Row 9: 2 root 20 0 0 0 0 S 0.0 0.0 0:00.09 kthreadd.
2024-12-17T18:21:35.593: Row 10: 3 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 rcu_gp.
2024-12-17T18:21:35.593: Row 11: 4 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 rcu_par+.
2024-12-17T18:21:35.593: Row 12: 5 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 slub_fl+.
2024-12-17T18:21:35.593: Row 13: 6 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 netns.
2024-12-17T18:21:35.594: Row 14: 8 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 kworker+.
2024-12-17T18:21:35.594: Row 15: 10 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 mm_perc+.
2024-12-17T18:21:35.594: Row 16: 11 root 20 0 0 0 0 S 0.0 0.0 0:00.00 rcu_tas+.
2024-12-17T18:21:35.594: Row 17: 12 root 20 0 0 0 0 S 0.0 0.0 0:00.00 rcu_tas+.
2024-12-17T18:21:35.594: Row 18: 13 root 20 0 0 0 0 S 0.0 0.0 0:30.92 ksoftir+.
2024-12-17T18:21:35.595: Row 19: 14 root 20 0 0 0 0 I 0.0 0.0 0:53.32 rcu_sch+.
2024-12-17T18:21:35.595: Row 20: 15 root rt 0 0 0 0 S 0.0 0.0 0:07.85 migrati+.
2024-12-17T18:21:35.595: Row 21: 16 root -51 0 0 0 0 S 0.0 0.0 0:00.00 idle_in+.
2024-12-17T18:21:35.595: Row 22: 18 root 20 0 0 0 0 S 0.0 0.0 0:00.00 cpuhp/0.
2024-12-17T18:21:35.595: Row 23: 19 root 20 0 0 0 0 S 0.0 0.0 0:00.00 kdevtmp+.
2024-12-17T18:21:35.595: Row 24: 20 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 inet_fr+.
2024-12-17T18:21:35.606: SUC: 174ms Uptime 36 days, 1min 0.03, 5min 0.02, 15min 0.00, mem:1907632 total / 497692 free / 391704 used / 1018236 cache / 1299136 avail
2024-12-17T18:21:35.606: ------ test: 2002
2024-12-17T18:21:35.607: CMD: df -h
2024-12-17T18:21:35.607: EXE: 1/df -h.
2024-12-17T18:21:35.621: Row 1: Filesystem Size Used Avail Use% Mounted on.
2024-12-17T18:21:35.621: Row 2: tmpfs 187M 20M 167M 11% /run.
2024-12-17T18:21:35.621: Row 3: /dev/vda2 20G 14G 5.2G 73% /.
2024-12-17T18:21:35.622: Row 4: tmpfs 932M 0 932M 0% /dev/shm.
2024-12-17T18:21:35.622: Row 5: tmpfs 5.0M 0 5.0M 0% /run/lock.
2024-12-17T18:21:35.623: SUC: 16ms Diskfree qa.headai.com: tmpfs:11%, /dev/vda2:73%, tmpfs:0%, tmpfs:0%.
2024-12-17T18:21:35.624: ------ test: 2003
2024-12-17T18:21:35.624: CMD: ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "df -h"
2024-12-17T18:21:35.624: EXE: 1/ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "df -h".
2024-12-17T18:22:05.809: Row 1: Filesystem Size Used Avail Use% Mounted on.
2024-12-17T18:22:05.809: Row 2: udev 63G 4.0K 63G 1% /dev.
2024-12-17T18:22:05.809: Row 3: tmpfs 13G 544M 13G 5% /run.
2024-12-17T18:22:05.809: Row 4: /dev/vda1 757G 512G 215G 71% /.
2024-12-17T18:22:05.810: Row 5: none 4.0K 0 4.0K 0% /sys/fs/cgroup.
2024-12-17T18:22:05.810: Row 6: none 5.0M 0 5.0M 0% /run/lock.
2024-12-17T18:22:05.810: Row 7: cgmfs 100K 0 100K 0% /run/cgmanager/fs.
2024-12-17T18:22:05.810: Row 8: none 63G 0 63G 0% /run/shm.
2024-12-17T18:22:05.811: Row 9: none 100M 0 100M 0% /run/user.
2024-12-17T18:22:05.811: Row 10: /dev/vdb 985G 230G 705G 25% /opt/tomcat/webapps/ROOT/analysis.
2024-12-17T18:22:05.811: Row 11: tmpfs 100K 0 100K 0% /var/lib/lxd/shmounts.
2024-12-17T18:22:05.811: Row 12: tmpfs 100K 0 100K 0% /var/lib/lxd/devlxd.
2024-12-17T18:22:05.811: Row 13: tmpfs 13G 0 13G 0% /run/user/0.
2024-12-17T18:22:05.814: SUC: 30190ms 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-17T18:22:05.814: ------ test: 2004
2024-12-17T18:22:05.814: URL: https://headai.com
2024-12-17T18:22:06.478: SUC: 663ms, Trusted by 100+ customers and partners globally, length 185391.
2024-12-17T18:22:06.481: ------ test: 2005
2024-12-17T18:22:06.976: SQL: show global status like 'threads_connected';.
2024-12-17T18:22:06.995: Results: value=2/200.
2024-12-17T18:22:06.995: SQL: value, lines: 1, ret=1, 2.
2024-12-17T18:22:07.001: SUC: 520ms 2
2024-12-17T18:22:07.002: ------ test: 2006
2024-12-17T18:22:07.083: SQL: SHOW PROCESSLIST;.
2024-12-17T18:22:07.084: Row 1: 25405107,root,localhost:46360,null,Query,0,starting,SHOW PROCESSLIST.
2024-12-17T18:22:07.085: SQL: COUNTNOTLINES:Command, lines: 1, ret=1, 1.
2024-12-17T18:22:07.087: SUC: 85ms 1
2024-12-17T18:22:07.089: checkJavaStack starting: 2007.
2024-12-17T18:22:37.284: ------ test: 2007
2024-12-17T18:22:37.285: 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-17T18:23:07.651: Row 1: "https-openssl-nio-443-exec-79" #261396 daemon prio=5 os_prio=0 tid=0x00007f004c033000 nid=0x18150 runnable [0x00007f0181ef5000].
2024-12-17T18:23:07.652: Row 2: java.lang.Thread.State: RUNNABLE.
2024-12-17T18:23:07.652: Row 3: at java.util.AbstractCollection.toArray(AbstractCollection.java:196).
2024-12-17T18:23:07.652: Row 4: at java.lang.String.split(String.java:2378).
2024-12-17T18:23:07.652: Row 5: at java.lang.String.split(String.java:2422).
2024-12-17T18:23:07.652: Row 6: at h2.core2021.networkMatchSuperFast(core2021.java:3160).
2024-12-17T18:23:07.652: Row 7: at h2.core2021.semanticSimilarity_v3(core2021.java:1418).
2024-12-17T18:23:07.652: Row 8: at h2.core2021.text2keywords_v3(core2021.java:727).
2024-12-17T18:23:07.652: Row 9: at h2.BuildKnowledgeGraph_v5.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v5.java:1727).
2024-12-17T18:23:07.653: Row 10: at h2.SkillsForecast_methods.build_a_map_on_fly_v4(SkillsForecast_methods.java:5221).
2024-12-17T18:23:07.653: Row 11: at h2.helpers.check_pending_works(helpers.java:5270).
2024-12-17T18:23:07.653: Row 12: at h1.mc_api.doPost(mc_api.java:4576).
2024-12-17T18:23:07.653: Row 13: at h1.mc_api.doGet(mc_api.java:38).
2024-12-17T18:23:07.657: SUC: 2007, 30371ms, lines: 13.
2024-12-17T18:23:07.659: checkJavaStack end: 2007, pid/ret=13.
2024-12-17T18:23:17.660: checkJavaStack starting: 2007.
2024-12-17T18:23:47.857: ------ test: 2007
2024-12-17T18:23:47.858: 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-17T18:24:18.194: Row 1: "https-openssl-nio-443-exec-79" #261396 daemon prio=5 os_prio=0 tid=0x00007f004c033000 nid=0x18150 runnable [0x00007f0181ef5000].
2024-12-17T18:24:18.195: Row 2: java.lang.Thread.State: RUNNABLE.
2024-12-17T18:24:18.195: Row 3: at java.lang.String.indexOf(String.java:1769).
2024-12-17T18:24:18.195: Row 4: at java.lang.String.indexOf(String.java:1718).
2024-12-17T18:24:18.195: Row 5: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5362).
2024-12-17T18:24:18.195: Row 6: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5318).
2024-12-17T18:24:18.195: Row 7: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5258).
2024-12-17T18:24:18.196: Row 8: at h2.core2021.semanticSimilarity_v3(core2021.java:1416).
2024-12-17T18:24:18.196: Row 9: at h2.core2021.text2keywords_v3(core2021.java:727).
2024-12-17T18:24:18.196: Row 10: at h2.BuildKnowledgeGraph_v5.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v5.java:1727).
2024-12-17T18:24:18.196: Row 11: at h2.SkillsForecast_methods.build_a_map_on_fly_v4(SkillsForecast_methods.java:5221).
2024-12-17T18:24:18.196: Row 12: at h2.helpers.check_pending_works(helpers.java:5270).
2024-12-17T18:24:18.196: Row 13: at h1.mc_api.doPost(mc_api.java:4576).
2024-12-17T18:24:18.196: Row 14: at h1.mc_api.doGet(mc_api.java:38).
2024-12-17T18:24:18.203: SUC: 2007, 30345ms, lines: 14.
2024-12-17T18:24:18.204: checkJavaStack end: 2007, pid/ret=14.
2024-12-17T18:24:28.204: checkJavaStack starting: 2007.
2024-12-17T18:24:58.400: ------ test: 2007
2024-12-17T18:24:58.401: 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-17T18:25:28.735: SUC: 2007, 30334ms, lines: 4096.
2024-12-17T18:25:28.780: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T18:25:38.780: checkJavaStack starting: 2007.
2024-12-17T18:26:08.977: ------ test: 2007
2024-12-17T18:26:08.977: 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-17T18:26:39.328: SUC: 2007, 30351ms, lines: 4096.
2024-12-17T18:26:39.328: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T18:26:49.328: checkJavaStack starting: 2007.
2024-12-17T18:27:19.529: ------ test: 2007
2024-12-17T18:27:19.529: 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-17T18:27:49.872: SUC: 2007, 30343ms, lines: 4096.
2024-12-17T18:27:49.873: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T18:27:59.873: checkJavaStack starting: 2007.
2024-12-17T18:28:30.062: ------ test: 2007
2024-12-17T18:28:30.063: 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-17T18:29:00.366: SUC: 2007, 30303ms, lines: 4096.
2024-12-17T18:29:00.367: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T18:29:10.367: checkJavaStack starting: 2007.
2024-12-17T18:29:40.563: ------ test: 2007
2024-12-17T18:29:40.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-17T18:30:10.894: SUC: 2007, 30331ms, lines: 4096.
2024-12-17T18:30:10.895: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T18:30:20.895: checkJavaStack starting: 2007.
2024-12-17T18:30:51.080: ------ test: 2007
2024-12-17T18:30:51.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-17T18:31:21.405: SUC: 2007, 30325ms, lines: 4096.
2024-12-17T18:31:21.409: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T18:31:31.410: checkJavaStack starting: 2007.
2024-12-17T18:32:01.595: ------ test: 2007
2024-12-17T18:32:01.595: 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-17T18:32:31.929: SUC: 2007, 30334ms, lines: 4096.
2024-12-17T18:32:31.930: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T18:32:41.930: checkJavaStack starting: 2007.
2024-12-17T18:33:12.104: ------ test: 2007
2024-12-17T18:33:12.104: 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-17T18:33:42.447: SUC: 2007, 30343ms, lines: 4096.
2024-12-17T18:33:42.448: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T18:33:52.448: checkJavaStack starting: 2007.
2024-12-17T18:34:22.615: ------ test: 2007
2024-12-17T18:34:22.615: 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-17T18:34:52.923: SUC: 2007, 30308ms, lines: 4096.
2024-12-17T18:34:52.924: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T18:35:02.924: checkJavaStack starting: 2007.
2024-12-17T18:35:33.135: ------ test: 2007
2024-12-17T18:35:33.135: 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-17T18:36:03.476: SUC: 2007, 30341ms, lines: 4096.
2024-12-17T18:36:03.477: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T18:36:13.477: checkJavaStack starting: 2007.
2024-12-17T18:36:43.668: ------ test: 2007
2024-12-17T18:36:43.668: 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-17T18:37:14.017: SUC: 2007, 30349ms, lines: 4096.
2024-12-17T18:37:14.017: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T18:37:24.017: checkJavaStack starting: 2007.
2024-12-17T18:37:54.217: ------ test: 2007
2024-12-17T18:37:54.217: 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-17T18:38:24.529: SUC: 2007, 30312ms, lines: 4096.
2024-12-17T18:38:24.530: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T18:38:34.533: checkJavaStack starting: 2007.
2024-12-17T18:39:04.736: ------ test: 2007
2024-12-17T18:39:04.736: 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-17T18:39:35.086: SUC: 2007, 30350ms, lines: 4096.
2024-12-17T18:39:35.086: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T18:39:45.087: checkJavaStack starting: 2007.
2024-12-17T18:40:15.296: ------ test: 2007
2024-12-17T18:40:15.296: 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-17T18:40:45.606: SUC: 2007, 30310ms, lines: 4096.
2024-12-17T18:40:45.607: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T18:40:55.607: checkJavaStack starting: 2007.
2024-12-17T18:41:25.806: ------ test: 2007
2024-12-17T18:41:25.807: 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-17T18:41:56.103: SUC: 2007, 30296ms, lines: 4096.
2024-12-17T18:41:56.104: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T18:42:06.104: checkJavaStack starting: 2007.
2024-12-17T18:42:36.296: ------ test: 2007
2024-12-17T18:42:36.297: 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-17T18:43:06.638: SUC: 2007, 30341ms, lines: 4096.
2024-12-17T18:43:06.638: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T18:43:16.638: checkJavaStack starting: 2007.
2024-12-17T18:43:46.833: ------ test: 2007
2024-12-17T18:43:46.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-17T18:44:17.142: SUC: 2007, 30308ms, lines: 4096.
2024-12-17T18:44:17.143: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T18:44:27.143: checkJavaStack starting: 2007.
2024-12-17T18:44:57.335: ------ test: 2007
2024-12-17T18:44:57.335: 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-17T18:45:27.681: SUC: 2007, 30346ms, lines: 4096.
2024-12-17T18:45:27.682: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T18:45:37.682: checkJavaStack starting: 2007.
2024-12-17T18:46:07.942: ------ test: 2007
2024-12-17T18:46:07.942: 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-17T18:46:38.258: SUC: 2007, 30316ms, lines: 4096.
2024-12-17T18:46:38.258: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T18:46:48.258: checkJavaStack starting: 2007.
2024-12-17T18:47:18.455: ------ test: 2007
2024-12-17T18:47:18.455: 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-17T18:47:48.768: SUC: 2007, 30313ms, lines: 4096.
2024-12-17T18:47:48.768: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T18:47:58.768: checkJavaStack starting: 2007.
2024-12-17T18:48:28.964: ------ test: 2007
2024-12-17T18:48:28.964: 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-17T18:48:59.273: SUC: 2007, 30309ms, lines: 4096.
2024-12-17T18:48:59.274: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T18:49:09.274: checkJavaStack starting: 2007.
2024-12-17T18:49:39.473: ------ test: 2007
2024-12-17T18:49:39.473: 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-17T18:50:09.793: SUC: 2007, 30320ms, lines: 4096.
2024-12-17T18:50:09.795: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T18:50:19.795: checkJavaStack starting: 2007.
2024-12-17T18:50:49.991: ------ test: 2007
2024-12-17T18:50:49.991: 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-17T18:51:20.368: SUC: 2007, 30377ms, lines: 4096.
2024-12-17T18:51:20.369: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T18:51:30.369: checkJavaStack starting: 2007.
2024-12-17T18:52:00.612: ------ test: 2007
2024-12-17T18:52:00.612: 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-17T18:52:30.952: SUC: 2007, 30340ms, lines: 4096.
2024-12-17T18:52:30.953: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T18:52:40.953: checkJavaStack starting: 2007.
2024-12-17T18:53:11.147: ------ test: 2007
2024-12-17T18:53:11.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-17T18:53:41.469: SUC: 2007, 30318ms, lines: 4096.
2024-12-17T18:53:41.469: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T18:53:51.469: checkJavaStack starting: 2007.
2024-12-17T18:54:21.667: ------ test: 2007
2024-12-17T18:54:21.668: 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-17T18:54:52.003: SUC: 2007, 30335ms, lines: 4096.
2024-12-17T18:54:52.003: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T18:55:02.003: checkJavaStack starting: 2007.
2024-12-17T18:55:32.199: ------ test: 2007
2024-12-17T18:55:32.199: 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-17T18:56:02.508: SUC: 2007, 30309ms, lines: 4096.
2024-12-17T18:56:02.508: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T18:56:12.509: checkJavaStack starting: 2007.
2024-12-17T18:56:42.704: ------ test: 2007
2024-12-17T18:56:42.704: 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-17T18:57:13.075: SUC: 2007, 30371ms, lines: 4096.
2024-12-17T18:57:13.076: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T18:57:23.076: checkJavaStack starting: 2007.
2024-12-17T18:57:53.271: ------ test: 2007
2024-12-17T18:57:53.272: 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-17T18:58:23.638: SUC: 2007, 30367ms, lines: 4096.
2024-12-17T18:58:23.639: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T18:58:33.639: checkJavaStack starting: 2007.
2024-12-17T18:59:03.837: ------ test: 2007
2024-12-17T18:59:03.838: 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-17T18:59:34.130: SUC: 2007, 30292ms, lines: 4096.
2024-12-17T18:59:34.132: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T18:59:34.132: ------ test: end, 2309127ms. Score 39/39.
2024-12-17T18:59:34.132: Test duration: 38m29s.