2024-12-17T17:21:05.146: current working dir: /root/qa/mctester.
2024-12-17T17:21:05.252: current logging dir: ../mctester/www.
2024-12-17T17:21:05.252: ---------------------------------------------------------------
2024-12-17T17:21:05.253: mctester entry: 2024-12-17T17:21:05.253 mode=50
2024-12-17T17:21:05.253: ---------------------------------------------------------------
2024-12-17T17:21:05.369: EXE: 1/git describe --tags.
2024-12-17T17:21:05.381: Row 1: v1.1-201-g90c2042.
2024-12-17T17:21:05.382: EXE: 1/git rev-list --count HEAD.
2024-12-17T17:21:05.387: Row 1: 258.
2024-12-17T17:21:05.388: EXE: 1/git rev-parse HEAD.
2024-12-17T17:21:05.390: Row 1: 90c2042af9ce0b055e0a62dafd703b27e21c4128.
2024-12-17T17:21:05.390: mctester: v1.1.258 (90c2042af9ce0b055e0a62dafd703b27e21c4128).
2024-12-17T17:21:05.391: Entering into a performance tests mode.
2024-12-17T17:21:05.391: ------ test: start, 2024-12-17T17:21:05.391
2024-12-17T17:21:05.391: ------ test: 2000
2024-12-17T17:21:05.392: CMD: ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "top -b -n 1"
2024-12-17T17:21:05.392: EXE: 1/ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "top -b -n 1".
2024-12-17T17:21:35.722: Row 1: top - 17:21:35 up 91 days, 9:48, 0 users, load average: 0.28, 0.08, 0.03.
2024-12-17T17:21:35.722: Row 2: Tasks: 359 total, 1 running, 358 sleeping, 0 stopped, 0 zombie.
2024-12-17T17:21:35.723: 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-17T17:21:35.723: Row 4: KiB Mem : 13202036+total, 704756 free, 60822688 used, 70492928 buff/cache.
2024-12-17T17:21:35.723: Row 5: KiB Swap: 0 total, 0 free, 0 used. 69609984 avail Mem .
2024-12-17T17:21:35.724: Row 6: .
2024-12-17T17:21:35.724: Row 7: PID USER PR NI VIRT RES SHR S %CPU %MEM TIME+ COMMAND.
2024-12-17T17:21:35.727: Row 8: 1978 mysql 20 0 99.646g 0.048t 1.138g S 100.0 38.7 13648:57 mysqld.
2024-12-17T17:21:35.727: Row 9: 1 root 20 0 43660 2552 1268 S 0.0 0.0 3:23.92 init.
2024-12-17T17:21:35.727: Row 10: 2 root 20 0 0 0 0 S 0.0 0.0 0:01.23 kthreadd.
2024-12-17T17:21:35.727: Row 11: 3 root 20 0 0 0 0 S 0.0 0.0 4:28.71 ksoftirqd+.
2024-12-17T17:21:35.728: Row 12: 5 root 0 -20 0 0 0 S 0.0 0.0 0:00.00 kworker/0+.
2024-12-17T17:21:35.728: Row 13: 7 root 20 0 0 0 0 S 0.0 0.0 29:53.89 rcu_sched.
2024-12-17T17:21:35.730: Row 14: 8 root 20 0 0 0 0 S 0.0 0.0 0:00.00 rcu_bh.
2024-12-17T17:21:35.733: Row 15: 9 root rt 0 0 0 0 S 0.0 0.0 0:05.47 migration+.
2024-12-17T17:21:35.733: Row 16: 10 root rt 0 0 0 0 S 0.0 0.0 0:22.04 watchdog/0.
2024-12-17T17:21:35.733: Row 17: 11 root rt 0 0 0 0 S 0.0 0.0 0:20.12 watchdog/1.
2024-12-17T17:21:35.734: Row 18: 12 root rt 0 0 0 0 S 0.0 0.0 0:10.71 migration+.
2024-12-17T17:21:35.734: Row 19: 13 root 20 0 0 0 0 S 0.0 0.0 0:01.78 ksoftirqd+.
2024-12-17T17:21:35.734: Row 20: 15 root 0 -20 0 0 0 S 0.0 0.0 0:00.00 kworker/1+.
2024-12-17T17:21:35.734: Row 21: 16 root rt 0 0 0 0 S 0.0 0.0 0:20.55 watchdog/2.
2024-12-17T17:21:35.734: Row 22: 17 root rt 0 0 0 0 S 0.0 0.0 0:04.56 migration+.
2024-12-17T17:21:35.734: Row 23: 18 root 20 0 0 0 0 S 0.0 0.0 0:01.43 ksoftirqd+.
2024-12-17T17:21:35.735: Row 24: 20 root 0 -20 0 0 0 S 0.0 0.0 0:00.00 kworker/2+.
2024-12-17T17:21:35.802: SUC: 30410ms Uptime 91 days, 1min 0.28, 5min 0.08, 15min 0.03, mem:132020360 total / 704756 free / 60822688 used / 70492928 cache / 69609984 avail
2024-12-17T17:21:35.815: ------ test: 2001
2024-12-17T17:21:35.815: CMD: top -b -E k -n 1
2024-12-17T17:21:35.815: EXE: 1/top -b -E k -n 1.
2024-12-17T17:21:35.971: Row 1: top - 17:21:35 up 36 days, 3 min, 0 users, load average: 0.18, 0.07, 0.02.
2024-12-17T17:21:35.971: Row 2: Tasks: 99 total, 1 running, 97 sleeping, 0 stopped, 1 zombie.
2024-12-17T17:21:35.972: 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-17T17:21:35.972: Row 4: KiB Mem : 1907632 total, 374172 free, 447200 used, 1086260 buff/cache.
2024-12-17T17:21:35.972: Row 5: KiB Swap: 0 total, 0 free, 0 used. 1243636 avail Mem .
2024-12-17T17:21:35.972: Row 6: .
2024-12-17T17:21:35.972: Row 7: PID USER PR NI VIRT RES SHR S %CPU %MEM TIME+ COMMAND.
2024-12-17T17:21:35.972: Row 8: 1 root 20 0 167784 11968 7084 S 0.0 0.6 0:56.99 systemd.
2024-12-17T17:21:35.972: Row 9: 2 root 20 0 0 0 0 S 0.0 0.0 0:00.09 kthreadd.
2024-12-17T17:21:35.973: Row 10: 3 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 rcu_gp.
2024-12-17T17:21:35.973: Row 11: 4 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 rcu_par+.
2024-12-17T17:21:35.973: Row 12: 5 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 slub_fl+.
2024-12-17T17:21:35.973: Row 13: 6 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 netns.
2024-12-17T17:21:35.977: Row 14: 8 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 kworker+.
2024-12-17T17:21:35.977: Row 15: 10 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 mm_perc+.
2024-12-17T17:21:35.979: Row 16: 11 root 20 0 0 0 0 S 0.0 0.0 0:00.00 rcu_tas+.
2024-12-17T17:21:35.979: Row 17: 12 root 20 0 0 0 0 S 0.0 0.0 0:00.00 rcu_tas+.
2024-12-17T17:21:35.979: Row 18: 13 root 20 0 0 0 0 S 0.0 0.0 0:30.89 ksoftir+.
2024-12-17T17:21:35.979: Row 19: 14 root 20 0 0 0 0 I 0.0 0.0 0:53.27 rcu_sch+.
2024-12-17T17:21:35.979: Row 20: 15 root rt 0 0 0 0 S 0.0 0.0 0:07.84 migrati+.
2024-12-17T17:21:35.979: Row 21: 16 root -51 0 0 0 0 S 0.0 0.0 0:00.00 idle_in+.
2024-12-17T17:21:35.980: Row 22: 18 root 20 0 0 0 0 S 0.0 0.0 0:00.00 cpuhp/0.
2024-12-17T17:21:35.980: Row 23: 19 root 20 0 0 0 0 S 0.0 0.0 0:00.00 kdevtmp+.
2024-12-17T17:21:35.980: Row 24: 20 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 inet_fr+.
2024-12-17T17:21:35.988: SUC: 173ms Uptime 36 days, 1min 0.18, 5min 0.07, 15min 0.02, mem:1907632 total / 374172 free / 447200 used / 1086260 cache / 1243636 avail
2024-12-17T17:21:35.990: ------ test: 2002
2024-12-17T17:21:35.990: CMD: df -h
2024-12-17T17:21:35.990: EXE: 1/df -h.
2024-12-17T17:21:35.992: Row 1: Filesystem Size Used Avail Use% Mounted on.
2024-12-17T17:21:35.993: Row 2: tmpfs 187M 20M 167M 11% /run.
2024-12-17T17:21:35.993: Row 3: /dev/vda2 20G 14G 5.2G 73% /.
2024-12-17T17:21:35.993: Row 4: tmpfs 932M 0 932M 0% /dev/shm.
2024-12-17T17:21:35.993: Row 5: tmpfs 5.0M 0 5.0M 0% /run/lock.
2024-12-17T17:21:35.995: SUC: 5ms Diskfree qa.headai.com: tmpfs:11%, /dev/vda2:73%, tmpfs:0%, tmpfs:0%.
2024-12-17T17:21:35.995: ------ test: 2003
2024-12-17T17:21:35.996: CMD: ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "df -h"
2024-12-17T17:21:35.996: EXE: 1/ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "df -h".
2024-12-17T17:22:06.203: Row 1: Filesystem Size Used Avail Use% Mounted on.
2024-12-17T17:22:06.203: Row 2: udev 63G 4.0K 63G 1% /dev.
2024-12-17T17:22:06.203: Row 3: tmpfs 13G 544M 13G 5% /run.
2024-12-17T17:22:06.203: Row 4: /dev/vda1 757G 512G 215G 71% /.
2024-12-17T17:22:06.203: Row 5: none 4.0K 0 4.0K 0% /sys/fs/cgroup.
2024-12-17T17:22:06.204: Row 6: none 5.0M 0 5.0M 0% /run/lock.
2024-12-17T17:22:06.204: Row 7: cgmfs 100K 0 100K 0% /run/cgmanager/fs.
2024-12-17T17:22:06.204: Row 8: none 63G 0 63G 0% /run/shm.
2024-12-17T17:22:06.204: Row 9: none 100M 0 100M 0% /run/user.
2024-12-17T17:22:06.204: Row 10: /dev/vdb 985G 230G 705G 25% /opt/tomcat/webapps/ROOT/analysis.
2024-12-17T17:22:06.204: Row 11: tmpfs 100K 0 100K 0% /var/lib/lxd/shmounts.
2024-12-17T17:22:06.205: Row 12: tmpfs 100K 0 100K 0% /var/lib/lxd/devlxd.
2024-12-17T17:22:06.205: Row 13: tmpfs 13G 0 13G 0% /run/user/0.
2024-12-17T17:22:06.210: SUC: 30214ms 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-17T17:22:06.210: ------ test: 2004
2024-12-17T17:22:06.210: URL: https://headai.com
2024-12-17T17:22:06.790: SUC: 579ms, Trusted by 100+ customers and partners globally, length 185335.
2024-12-17T17:22:06.792: ------ test: 2005
2024-12-17T17:22:07.264: SQL: show global status like 'threads_connected';.
2024-12-17T17:22:07.287: Results: value=2/200.
2024-12-17T17:22:07.288: SQL: value, lines: 1, ret=1, 2.
2024-12-17T17:22:07.293: SUC: 501ms 2
2024-12-17T17:22:07.295: ------ test: 2006
2024-12-17T17:22:07.401: SQL: SHOW PROCESSLIST;.
2024-12-17T17:22:07.403: Row 1: 25401532,root,localhost:37272,null,Query,0,starting,SHOW PROCESSLIST.
2024-12-17T17:22:07.403: SQL: COUNTNOTLINES:Command, lines: 1, ret=1, 1.
2024-12-17T17:22:07.404: SUC: 108ms 1
2024-12-17T17:22:07.404: checkJavaStack starting: 2007.
2024-12-17T17:22:37.613: ------ test: 2007
2024-12-17T17:22:37.613: 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-17T17:23:07.944: Row 1: "https-openssl-nio-443-exec-82" #261399 daemon prio=5 os_prio=0 tid=0x00007f00942c9000 nid=0x18157 runnable [0x00007f0181ff6000].
2024-12-17T17:23:07.944: Row 2: java.lang.Thread.State: RUNNABLE.
2024-12-17T17:23:07.944: Row 3: at h1.body.wordToBody(body.java:286).
2024-12-17T17:23:07.944: Row 4: at h2.core2021.semanticSimilarity_v3(core2021.java:1393).
2024-12-17T17:23:07.944: Row 5: at h2.core2021.text2keywords_v3(core2021.java:727).
2024-12-17T17:23:07.945: Row 6: at h2.BuildKnowledgeGraph_v5.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v5.java:1727).
2024-12-17T17:23:07.945: Row 7: at h2.SkillsForecast_methods.build_a_map_on_fly_v4(SkillsForecast_methods.java:5221).
2024-12-17T17:23:07.945: Row 8: at h2.helpers.check_pending_works(helpers.java:5270).
2024-12-17T17:23:07.945: Row 9: at h1.mc_api.doPost(mc_api.java:4576).
2024-12-17T17:23:07.947: Row 10: at h1.mc_api.doGet(mc_api.java:38).
2024-12-17T17:23:07.949: SUC: 2007, 30336ms, lines: 10.
2024-12-17T17:23:07.951: checkJavaStack end: 2007, pid/ret=10.
2024-12-17T17:23:17.951: checkJavaStack starting: 2007.
2024-12-17T17:23:48.149: ------ test: 2007
2024-12-17T17:23:48.149: 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-17T17:24:18.535: Row 1: "https-openssl-nio-443-exec-82" #261399 daemon prio=5 os_prio=0 tid=0x00007f00942c9000 nid=0x18157 runnable [0x00007f0181ff6000].
2024-12-17T17:24:18.535: Row 2: java.lang.Thread.State: RUNNABLE.
2024-12-17T17:24:18.535: Row 3: at java.lang.String.indexOf(String.java:1769).
2024-12-17T17:24:18.535: Row 4: at java.lang.String.indexOf(String.java:1718).
2024-12-17T17:24:18.535: Row 5: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5362).
2024-12-17T17:24:18.536: Row 6: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5318).
2024-12-17T17:24:18.536: Row 7: at org.apache.commons.lang3.StringUtils.replace(StringUtils.java:5258).
2024-12-17T17:24:18.536: Row 8: at h2.core2021.semanticSimilarity_v3(core2021.java:1402).
2024-12-17T17:24:18.536: Row 9: at h2.core2021.text2keywords_v3(core2021.java:727).
2024-12-17T17:24:18.536: Row 10: at h2.BuildKnowledgeGraph_v5.build_a_map_on_fly_v4_1(BuildKnowledgeGraph_v5.java:1727).
2024-12-17T17:24:18.536: Row 11: at h2.SkillsForecast_methods.build_a_map_on_fly_v4(SkillsForecast_methods.java:5221).
2024-12-17T17:24:18.536: Row 12: at h2.helpers.check_pending_works(helpers.java:5270).
2024-12-17T17:24:18.536: Row 13: at h1.mc_api.doPost(mc_api.java:4576).
2024-12-17T17:24:18.537: Row 14: at h1.mc_api.doGet(mc_api.java:38).
2024-12-17T17:24:18.543: SUC: 2007, 30394ms, lines: 14.
2024-12-17T17:24:18.544: checkJavaStack end: 2007, pid/ret=14.
2024-12-17T17:24:28.544: checkJavaStack starting: 2007.
2024-12-17T17:24:58.739: ------ test: 2007
2024-12-17T17:24:58.739: 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-17T17:25:29.022: SUC: 2007, 30283ms, lines: 4096.
2024-12-17T17:25:29.022: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T17:25:39.023: checkJavaStack starting: 2007.
2024-12-17T17:26:09.236: ------ test: 2007
2024-12-17T17:26:09.236: 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-17T17:26:39.575: SUC: 2007, 30339ms, lines: 4096.
2024-12-17T17:26:39.575: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T17:26:49.576: checkJavaStack starting: 2007.
2024-12-17T17:27:19.773: ------ test: 2007
2024-12-17T17:27:19.774: 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-17T17:27:50.087: SUC: 2007, 30313ms, lines: 4096.
2024-12-17T17:27:50.088: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T17:28:00.088: checkJavaStack starting: 2007.
2024-12-17T17:28:30.284: ------ test: 2007
2024-12-17T17:28:30.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-17T17:29:00.613: SUC: 2007, 30328ms, lines: 4096.
2024-12-17T17:29:00.614: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T17:29:10.614: checkJavaStack starting: 2007.
2024-12-17T17:29:40.810: ------ test: 2007
2024-12-17T17:29:40.811: 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-17T17:30:11.115: SUC: 2007, 30304ms, lines: 4096.
2024-12-17T17:30:11.119: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T17:30:21.119: checkJavaStack starting: 2007.
2024-12-17T17:30:51.318: ------ test: 2007
2024-12-17T17:30:51.318: 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-17T17:31:21.635: SUC: 2007, 30317ms, lines: 4096.
2024-12-17T17:31:21.636: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T17:31:31.636: checkJavaStack starting: 2007.
2024-12-17T17:32:01.907: ------ test: 2007
2024-12-17T17:32:01.908: 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-17T17:32:32.243: SUC: 2007, 30335ms, lines: 4096.
2024-12-17T17:32:32.243: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T17:32:42.244: checkJavaStack starting: 2007.
2024-12-17T17:33:12.440: ------ test: 2007
2024-12-17T17:33:12.440: 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-17T17:33:42.779: SUC: 2007, 30339ms, lines: 4096.
2024-12-17T17:33:42.780: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T17:33:52.780: checkJavaStack starting: 2007.
2024-12-17T17:34:22.986: ------ test: 2007
2024-12-17T17:34:22.987: 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-17T17:34:53.318: SUC: 2007, 30331ms, lines: 4096.
2024-12-17T17:34:53.319: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T17:35:03.319: checkJavaStack starting: 2007.
2024-12-17T17:35:33.525: ------ test: 2007
2024-12-17T17:35:33.526: 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-17T17:36:03.838: SUC: 2007, 30312ms, lines: 4096.
2024-12-17T17:36:03.838: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T17:36:13.839: checkJavaStack starting: 2007.
2024-12-17T17:36:44.033: ------ test: 2007
2024-12-17T17:36:44.033: 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-17T17:37:14.349: SUC: 2007, 30316ms, lines: 4096.
2024-12-17T17:37:14.350: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T17:37:24.350: checkJavaStack starting: 2007.
2024-12-17T17:37:54.549: ------ test: 2007
2024-12-17T17:37:54.549: EXE: 5/"jstack 90461 | awk '/nid=/ {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]} start_line = NR; last_h1_h2 = 0; has_h1_h2 = 0; in_block = 1} /h1|h2/ {has_h1_h2 = 1; last_h1_h2 = NR} {lines[NR] = $0} END {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]}}' || true".
2024-12-17T17:38:24.873: SUC: 2007, 30324ms, lines: 4096.
2024-12-17T17:38:24.874: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T17:38:34.874: checkJavaStack starting: 2007.
2024-12-17T17:39:05.074: ------ test: 2007
2024-12-17T17:39:05.074: 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-17T17:39:35.400: SUC: 2007, 30326ms, lines: 4096.
2024-12-17T17:39:35.401: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T17:39:45.401: checkJavaStack starting: 2007.
2024-12-17T17:40:15.599: ------ test: 2007
2024-12-17T17:40:15.600: EXE: 5/"jstack 90461 | awk '/nid=/ {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]} start_line = NR; last_h1_h2 = 0; has_h1_h2 = 0; in_block = 1} /h1|h2/ {has_h1_h2 = 1; last_h1_h2 = NR} {lines[NR] = $0} END {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]}}' || true".
2024-12-17T17:40:45.941: SUC: 2007, 30341ms, lines: 4096.
2024-12-17T17:40:45.941: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T17:40:55.943: checkJavaStack starting: 2007.
2024-12-17T17:41:26.143: ------ test: 2007
2024-12-17T17:41:26.144: 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-17T17:41:56.471: SUC: 2007, 30327ms, lines: 4096.
2024-12-17T17:41:56.471: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T17:42:06.471: checkJavaStack starting: 2007.
2024-12-17T17:42:36.666: ------ test: 2007
2024-12-17T17:42:36.666: 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-17T17:43:06.979: SUC: 2007, 30312ms, lines: 4096.
2024-12-17T17:43:06.979: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T17:43:16.979: checkJavaStack starting: 2007.
2024-12-17T17:43:47.167: ------ test: 2007
2024-12-17T17:43:47.168: 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-17T17:44:17.518: SUC: 2007, 30350ms, lines: 4096.
2024-12-17T17:44:17.519: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T17:44:27.519: checkJavaStack starting: 2007.
2024-12-17T17:44:57.693: ------ test: 2007
2024-12-17T17:44:57.694: 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-17T17:45:28.021: SUC: 2007, 30326ms, lines: 4096.
2024-12-17T17:45:28.021: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T17:45:38.021: checkJavaStack starting: 2007.
2024-12-17T17:46:08.209: ------ test: 2007
2024-12-17T17:46:08.209: 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-17T17:46:38.585: SUC: 2007, 30376ms, lines: 4096.
2024-12-17T17:46:38.585: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T17:46:48.586: checkJavaStack starting: 2007.
2024-12-17T17:47:18.784: ------ test: 2007
2024-12-17T17:47:18.785: 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-17T17:47:49.133: SUC: 2007, 30349ms, lines: 4096.
2024-12-17T17:47:49.134: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T17:47:59.134: checkJavaStack starting: 2007.
2024-12-17T17:48:29.332: ------ test: 2007
2024-12-17T17:48:29.333: 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-17T17:48:59.659: SUC: 2007, 30326ms, lines: 4096.
2024-12-17T17:48:59.660: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T17:49:09.660: checkJavaStack starting: 2007.
2024-12-17T17:49:39.856: ------ test: 2007
2024-12-17T17:49:39.857: 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-17T17:50:10.181: SUC: 2007, 30324ms, lines: 4096.
2024-12-17T17:50:10.182: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T17:50:20.182: checkJavaStack starting: 2007.
2024-12-17T17:50:50.380: ------ test: 2007
2024-12-17T17:50:50.380: EXE: 5/"jstack 90461 | awk '/nid=/ {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]} start_line = NR; last_h1_h2 = 0; has_h1_h2 = 0; in_block = 1} /h1|h2/ {has_h1_h2 = 1; last_h1_h2 = NR} {lines[NR] = $0} END {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]}}' || true".
2024-12-17T17:51:20.686: SUC: 2007, 30306ms, lines: 4096.
2024-12-17T17:51:20.686: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T17:51:30.687: checkJavaStack starting: 2007.
2024-12-17T17:52:00.882: ------ test: 2007
2024-12-17T17:52:00.882: 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-17T17:52:31.192: SUC: 2007, 30310ms, lines: 4096.
2024-12-17T17:52:31.192: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T17:52:41.193: checkJavaStack starting: 2007.
2024-12-17T17:53:11.391: ------ test: 2007
2024-12-17T17:53:11.392: 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-17T17:53:41.725: SUC: 2007, 30333ms, lines: 4096.
2024-12-17T17:53:41.726: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T17:53:51.726: checkJavaStack starting: 2007.
2024-12-17T17:54:21.924: ------ test: 2007
2024-12-17T17:54:21.925: 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-17T17:54:52.242: SUC: 2007, 30317ms, lines: 4096.
2024-12-17T17:54:52.242: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T17:55:02.243: checkJavaStack starting: 2007.
2024-12-17T17:55:32.450: ------ test: 2007
2024-12-17T17:55:32.450: 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-17T17:56:02.767: SUC: 2007, 30317ms, lines: 4096.
2024-12-17T17:56:02.767: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T17:56:12.767: checkJavaStack starting: 2007.
2024-12-17T17:56:42.971: ------ test: 2007
2024-12-17T17:56:42.971: 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-17T17:57:13.317: SUC: 2007, 30346ms, lines: 4096.
2024-12-17T17:57:13.318: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T17:57:23.318: checkJavaStack starting: 2007.
2024-12-17T17:57:53.514: ------ test: 2007
2024-12-17T17:57:53.514: EXE: 5/"jstack 90461 | awk '/nid=/ {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]} start_line = NR; last_h1_h2 = 0; has_h1_h2 = 0; in_block = 1} /h1|h2/ {has_h1_h2 = 1; last_h1_h2 = NR} {lines[NR] = $0} END {if (in_block && has_h1_h2) {for (i = start_line; i <= last_h1_h2; i++) print lines[i]}}' || true".
2024-12-17T17:58:23.817: SUC: 2007, 30303ms, lines: 4096.
2024-12-17T17:58:23.818: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T17:58:33.818: checkJavaStack starting: 2007.
2024-12-17T17:59:04.014: ------ test: 2007
2024-12-17T17:59:04.015: 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-17T17:59:34.312: SUC: 2007, 30297ms, lines: 4096.
2024-12-17T17:59:34.312: checkJavaStack end: 2007, pid/ret=4096.
2024-12-17T17:59:34.313: ------ test: end, 2308922ms. Score 39/39.
2024-12-17T17:59:34.314: Test duration: 38m28s.