2025-02-27T02:21:05.627: current working dir: /root/qa/mctester.
2025-02-27T02:21:05.731: current logging dir: ../mctester/www.
2025-02-27T02:21:05.732: ---------------------------------------------------------------
2025-02-27T02:21:05.732: mctester entry: 2025-02-27T02:21:05.732 mode=50
2025-02-27T02:21:05.732: ---------------------------------------------------------------
2025-02-27T02:21:05.853: EXE: 1/git describe --tags.
2025-02-27T02:21:05.870: Row 1: v1.1-257-g3195fc1.
2025-02-27T02:21:05.871: EXE: 1/git rev-list --count HEAD.
2025-02-27T02:21:05.877: Row 1: 314.
2025-02-27T02:21:05.877: EXE: 1/git rev-parse HEAD.
2025-02-27T02:21:05.879: Row 1: 3195fc1a5f05079bbbf1e5bfcbcc4741c44bc972.
2025-02-27T02:21:05.880: mctester: v1.1.314 (3195fc1a5f05079bbbf1e5bfcbcc4741c44bc972).
2025-02-27T02:21:05.880: Entering into a performance tests mode.
2025-02-27T02:21:05.880: ------ test: start, 2025-02-27T02:21:05.880
2025-02-27T02:21:05.881: ------ test: 2000
2025-02-27T02:21:05.882: CMD: ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "top -b -n 1"
2025-02-27T02:21:05.883: EXE: 1/ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "top -b -n 1".
2025-02-27T02:21:05.890: stderr: kex_exchange_identification: Connection closed by remote host.
2025-02-27T02:21:05.890: stderr: Connection closed by 185.20.136.38 port 22.
2025-02-27T02:21:05.891: Abnormal exit: 255, lines: 0, output: .
2025-02-27T02:21:05.891: ERR: 9ms
2025-02-27T02:21:05.904: ------ test: 2001
2025-02-27T02:21:05.904: CMD: top -b -E k -n 1
2025-02-27T02:21:05.905: EXE: 1/top -b -E k -n 1.
2025-02-27T02:21:06.062: Row 1: top - 02:21:06 up 107 days, 9:03, 0 users, load average: 0.67, 0.19, 0.08.
2025-02-27T02:21:06.062: Row 2: Tasks: 123 total, 1 running, 121 sleeping, 0 stopped, 1 zombie.
2025-02-27T02:21:06.062: Row 3: %Cpu(s): 6.2 us, 0.0 sy, 0.0 ni, 93.8 id, 0.0 wa, 0.0 hi, 0.0 si, 0.0 st.
2025-02-27T02:21:06.062: Row 4: KiB Mem : 1907632 total, 521944 free, 764368 used, 621320 buff/cache.
2025-02-27T02:21:06.062: Row 5: KiB Swap: 0 total, 0 free, 0 used. 928912 avail Mem .
2025-02-27T02:21:06.063: Row 6: .
2025-02-27T02:21:06.063: Row 7: PID USER PR NI VIRT RES SHR S %CPU %MEM TIME+ COMMAND.
2025-02-27T02:21:06.063: Row 8: 796823 root 12 -8 1155.8g 72616 19072 S 6.2 3.8 21:21.57 chrome.
2025-02-27T02:21:06.063: Row 9: 1 root 20 0 167764 10096 5212 S 0.0 0.5 2:49.00 systemd.
2025-02-27T02:21:06.063: Row 10: 2 root 20 0 0 0 0 S 0.0 0.0 0:00.29 kthreadd.
2025-02-27T02:21:06.063: Row 11: 3 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 rcu_gp.
2025-02-27T02:21:06.064: Row 12: 4 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 rcu_par+.
2025-02-27T02:21:06.064: Row 13: 5 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 slub_fl+.
2025-02-27T02:21:06.075: Row 14: 6 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 netns.
2025-02-27T02:21:06.075: Row 15: 8 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 kworker+.
2025-02-27T02:21:06.075: Row 16: 10 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 mm_perc+.
2025-02-27T02:21:06.076: Row 17: 11 root 20 0 0 0 0 S 0.0 0.0 0:00.00 rcu_tas+.
2025-02-27T02:21:06.076: Row 18: 12 root 20 0 0 0 0 S 0.0 0.0 0:00.00 rcu_tas+.
2025-02-27T02:21:06.076: Row 19: 13 root 20 0 0 0 0 S 0.0 0.0 1:30.85 ksoftir+.
2025-02-27T02:21:06.076: Row 20: 14 root 20 0 0 0 0 I 0.0 0.0 2:40.97 rcu_sch+.
2025-02-27T02:21:06.076: Row 21: 15 root rt 0 0 0 0 S 0.0 0.0 0:22.64 migrati+.
2025-02-27T02:21:06.077: Row 22: 16 root -51 0 0 0 0 S 0.0 0.0 0:00.00 idle_in+.
2025-02-27T02:21:06.077: Row 23: 18 root 20 0 0 0 0 S 0.0 0.0 0:00.00 cpuhp/0.
2025-02-27T02:21:06.077: Row 24: 19 root 20 0 0 0 0 S 0.0 0.0 0:00.00 kdevtmp+.
2025-02-27T02:21:06.117: SUC: 213ms Uptime 107 days, 1min 0.67, 5min 0.19, 15min 0.08, mem:1907632 total / 521944 free / 764368 used / 621320 cache / 928912 avail
2025-02-27T02:21:06.118: ------ test: 2002
2025-02-27T02:21:06.119: CMD: df -h
2025-02-27T02:21:06.120: EXE: 1/df -h.
2025-02-27T02:21:06.126: Row 1: Filesystem Size Used Avail Use% Mounted on.
2025-02-27T02:21:06.127: Row 2: tmpfs 187M 20M 167M 11% /run.
2025-02-27T02:21:06.127: Row 3: /dev/vda2 20G 16G 3.8G 81% /.
2025-02-27T02:21:06.127: Row 4: tmpfs 932M 0 932M 0% /dev/shm.
2025-02-27T02:21:06.127: Row 5: tmpfs 5.0M 0 5.0M 0% /run/lock.
2025-02-27T02:21:06.128: SUC: 9ms Diskfree qa.headai.com: tmpfs:11%, /dev/vda2:81%, tmpfs:0%, tmpfs:0%.
2025-02-27T02:21:06.129: ------ test: 2003
2025-02-27T02:21:06.129: CMD: ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "df -h"
2025-02-27T02:21:06.129: EXE: 1/ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "df -h".
2025-02-27T02:21:06.203: Row 1: Filesystem Size Used Avail Use% Mounted on.
2025-02-27T02:21:06.203: Row 2: udev 63G 4.0K 63G 1% /dev.
2025-02-27T02:21:06.204: Row 3: tmpfs 13G 5.5M 13G 1% /run.
2025-02-27T02:21:06.204: Row 4: /dev/vda1 757G 537G 190G 74% /.
2025-02-27T02:21:06.204: Row 5: none 4.0K 0 4.0K 0% /sys/fs/cgroup.
2025-02-27T02:21:06.204: Row 6: none 5.0M 0 5.0M 0% /run/lock.
2025-02-27T02:21:06.204: Row 7: cgmfs 100K 0 100K 0% /run/cgmanager/fs.
2025-02-27T02:21:06.204: Row 8: none 63G 0 63G 0% /run/shm.
2025-02-27T02:21:06.204: Row 9: none 100M 0 100M 0% /run/user.
2025-02-27T02:21:06.204: Row 10: /dev/vdb 985G 245G 690G 27% /opt/tomcat/webapps/ROOT/analysis.
2025-02-27T02:21:06.205: Row 11: tmpfs 100K 0 100K 0% /var/lib/lxd/shmounts.
2025-02-27T02:21:06.205: Row 12: tmpfs 100K 0 100K 0% /var/lib/lxd/devlxd.
2025-02-27T02:21:06.209: SUC: 80ms Diskfree megatron.headai.com: udev:1%, tmpfs:1%, /dev/vda1:74%, none:0%, none:0%, cgmfs:0%, none:0%, none:0%, /dev/vdb:27%, tmpfs:0%, tmpfs:0%.
2025-02-27T02:21:06.210: ------ test: 2004
2025-02-27T02:21:06.210: URL: https://headai.com
2025-02-27T02:21:06.842: SUC: 630ms, Trusted by 100+ customers and partners globally, length 195362.
2025-02-27T02:21:06.844: ------ test: 2005
2025-02-27T02:21:07.446: SQL: show global status like 'threads_connected';.
2025-02-27T02:21:07.467: Results: value=11/200.
2025-02-27T02:21:07.468: SQL: value, lines: 1, ret=1, 11.
2025-02-27T02:21:07.470: SUC: 625ms 11
2025-02-27T02:21:07.474: ------ test: 2006
2025-02-27T02:21:07.574: SQL: SHOW PROCESSLIST;.
2025-02-27T02:21:07.576: Row 1: 12093701,root,localhost:34272,analysis,Query,0,Sending data,SELECT method FROM analysis.long_queries WHERE started IS NULL AND finished IS NULL AND SUBSTRING_IN.
2025-02-27T02:21:07.578: Row 2: 12093711,root,localhost:34296,null,Query,0,starting,SHOW PROCESSLIST.
2025-02-27T02:21:07.578: SQL: COUNTNOTLINES:Command, lines: 2, ret=2, 2.
2025-02-27T02:21:07.578: SUC: 104ms 2
2025-02-27T02:21:07.582: checkJavaStack starting: 2007.
2025-02-27T02:21:07.670: ------ test: 2007
2025-02-27T02:21:07.671: EXE: 5/"jstack 1968 | 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".
2025-02-27T02:21:08.106: Row 1: "Thread-3994" #1539826 daemon prio=5 os_prio=0 tid=0x00007fde40250800 nid=0x13b5a runnable [0x00007fdf82aeb000].
2025-02-27T02:21:08.106: Row 2: java.lang.Thread.State: RUNNABLE.
2025-02-27T02:21:08.106: Row 3: at h2.core2021.semanticSimilarity_v3(core2021.java:1394).
2025-02-27T02:21:08.106: Row 4: at h2.core2021.text2keywords_v3(core2021.java:728).
2025-02-27T02:21:08.106: Row 5: at h2.jobs_educations.update_job_keywords_thread_arraylist(jobs_educations.java:2341).
2025-02-27T02:21:08.107: Row 6: at h2.jobs_educations.lambda$1(jobs_educations.java:2303).
2025-02-27T02:21:08.107: Row 7: at h2.jobs_educations$$Lambda$373/39330309.run(Unknown Source).
2025-02-27T02:21:08.107: Row 8: "Thread-3993" #1539825 daemon prio=5 os_prio=0 tid=0x00007fde4029e800 nid=0x13b59 runnable [0x00007fdef2ceb000].
2025-02-27T02:21:08.107: Row 9: java.lang.Thread.State: RUNNABLE.
2025-02-27T02:21:08.107: Row 10: at java.util.Arrays.copyOfRange(Arrays.java:3664).
2025-02-27T02:21:08.107: Row 11: at java.lang.String.(String.java:207).
2025-02-27T02:21:08.107: Row 12: at java.lang.String.substring(String.java:1969).
2025-02-27T02:21:08.107: Row 13: at java.lang.String.split(String.java:2368).
2025-02-27T02:21:08.107: Row 14: at java.lang.String.split(String.java:2422).
2025-02-27T02:21:08.108: Row 15: at h2.core2021.semanticSimilarity_v3(core2021.java:1266).
2025-02-27T02:21:08.108: Row 16: at h2.core2021.text2keywords_v3(core2021.java:728).
2025-02-27T02:21:08.108: Row 17: at h2.jobs_educations.update_job_keywords_thread_arraylist(jobs_educations.java:2341).
2025-02-27T02:21:08.108: Row 18: at h2.jobs_educations.lambda$1(jobs_educations.java:2303).
2025-02-27T02:21:08.108: Row 19: at h2.jobs_educations$$Lambda$373/39330309.run(Unknown Source).
2025-02-27T02:21:08.108: Row 20: "Thread-3992" #1539824 daemon prio=5 os_prio=0 tid=0x00007fde40230800 nid=0x13b58 runnable [0x00007fdf381c0000].
2025-02-27T02:21:08.108: Row 21: java.lang.Thread.State: RUNNABLE.
2025-02-27T02:21:08.108: Row 22: at h2.core2021.semanticSimilarity_v3(core2021.java:1394).
2025-02-27T02:21:08.109: Row 23: at h2.core2021.text2keywords_v3(core2021.java:728).
2025-02-27T02:21:08.116: Row 24: at h2.jobs_educations.update_job_keywords_thread_arraylist(jobs_educations.java:2341).
2025-02-27T02:21:08.128: SUC: 2007, 457ms, lines: 221.
2025-02-27T02:21:08.163: checkJavaStack end: 2007, pid/ret=221.
2025-02-27T02:21:18.164: checkJavaStack starting: 2007.
2025-02-27T02:21:18.171: stderr: kex_exchange_identification: read: Connection reset by peer.
2025-02-27T02:21:18.171: stderr: Connection reset by 185.20.136.38 port 22.
2025-02-27T02:21:18.173: Abnormal exit: 255, lines: 0, output: .
2025-02-27T02:21:18.173: checkJavaStack end: 2007, pid/ret=0.
2025-02-27T02:21:18.173: ------ test: end, 12293ms. Score 8/7.
2025-02-27T02:21:18.173: Test duration: 0m12s.