2024-11-11T16:43:22.863: mctester entry: 2024-11-11T16:43:22.575 mode=50
2024-11-11T16:43:22.911: current working dir: /root/qa/mctester.
2024-11-11T16:43:22.914: EXE: 1/git describe --tags.
2024-11-11T16:43:23.461: Row 1: v1.1-123-g6b8988b.
2024-11-11T16:43:23.464: EXE: 1/git rev-list --count HEAD.
2024-11-11T16:43:23.472: Row 1: 180.
2024-11-11T16:43:23.480: EXE: 1/git rev-parse HEAD.
2024-11-11T16:43:23.490: Row 1: 6b8988b2a697666eb7455cb7986689f0dc88bbdf.
2024-11-11T16:43:23.498: mctester: v1.1.180 (6b8988b2a697666eb7455cb7986689f0dc88bbdf).
2024-11-11T16:43:23.498: Entering into a performance tests mode.
2024-11-11T16:43:23.499: Test Starting 2024-11-11T16:43:23.498
2024-11-11T16:43:23.499: ------ test: 2000
2024-11-11T16:43:23.500: CMD: ssh root@megatron.headai.com "top -b -n 1"
2024-11-11T16:43:23.500: EXE: 1/ssh root@megatron.headai.com "top -b -n 1".
2024-11-11T16:43:24.095: Row 1: top - 16:43:24 up 55 days, 9:10, 1 user, load average: 0.08, 0.02, 0.06.
2024-11-11T16:43:24.095: Row 2: Tasks: 378 total, 1 running, 377 sleeping, 0 stopped, 0 zombie.
2024-11-11T16:43:24.096: Row 3: %Cpu(s): 3.2 us, 0.1 sy, 0.0 ni, 96.7 id, 0.0 wa, 0.0 hi, 0.0 si, 0.0 st.
2024-11-11T16:43:24.097: Row 4: KiB Mem : 13202036+total, 692316 free, 60344456 used, 70983600 buff/cache.
2024-11-11T16:43:24.097: Row 5: KiB Swap: 0 total, 0 free, 0 used. 70392784 avail Mem .
2024-11-11T16:43:24.098: Row 6: .
2024-11-11T16:43:24.099: Row 7: PID USER PR NI VIRT RES SHR S %CPU %MEM TIME+ COMMAND.
2024-11-11T16:43:24.099: Row 8: 1978 mysql 20 0 0.105t 0.047t 809040 S 93.8 38.2 8938:39 mysqld.
2024-11-11T16:43:24.099: Row 9: 1 root 20 0 43660 3448 2164 S 0.0 0.0 1:52.48 init.
2024-11-11T16:43:24.100: Row 10: 2 root 20 0 0 0 0 S 0.0 0.0 0:00.73 kthreadd.
2024-11-11T16:43:24.100: Row 11: 3 root 20 0 0 0 0 S 0.0 0.0 2:12.22 ksoftirqd+.
2024-11-11T16:43:24.100: Row 12: 5 root 0 -20 0 0 0 S 0.0 0.0 0:00.00 kworker/0+.
2024-11-11T16:43:24.100: Row 13: 7 root 20 0 0 0 0 S 0.0 0.0 17:07.70 rcu_sched.
2024-11-11T16:43:24.101: Row 14: 8 root 20 0 0 0 0 S 0.0 0.0 0:00.00 rcu_bh.
2024-11-11T16:43:24.103: Row 15: 9 root rt 0 0 0 0 S 0.0 0.0 0:03.79 migration+.
2024-11-11T16:43:24.106: Row 16: 10 root rt 0 0 0 0 S 0.0 0.0 0:13.26 watchdog/0.
2024-11-11T16:43:24.106: Row 17: 11 root rt 0 0 0 0 S 0.0 0.0 0:12.22 watchdog/1.
2024-11-11T16:43:24.108: Row 18: 12 root rt 0 0 0 0 S 0.0 0.0 0:04.96 migration+.
2024-11-11T16:43:24.108: Row 19: 13 root 20 0 0 0 0 S 0.0 0.0 0:01.01 ksoftirqd+.
2024-11-11T16:43:24.109: Row 20: 15 root 0 -20 0 0 0 S 0.0 0.0 0:00.00 kworker/1+.
2024-11-11T16:43:24.110: Row 21: 16 root rt 0 0 0 0 S 0.0 0.0 0:12.43 watchdog/2.
2024-11-11T16:43:24.110: Row 22: 17 root rt 0 0 0 0 S 0.0 0.0 0:02.74 migration+.
2024-11-11T16:43:24.113: Row 23: 18 root 20 0 0 0 0 S 0.0 0.0 0:00.75 ksoftirqd+.
2024-11-11T16:43:24.114: Row 24: 20 root 0 -20 0 0 0 S 0.0 0.0 0:00.00 kworker/2+.
2024-11-11T16:43:24.299: SUC: 798ms Uptime 55 days, 1min 0.08, 5min 0.02, 15min 0.06, mem:132020360 total / 692316 free / 60344456 used / 70983600 cache / 70392784 avail
2024-11-11T16:43:24.355: ------ test: 2001
2024-11-11T16:43:24.356: CMD: top -b -E k -n 1
2024-11-11T16:43:24.356: EXE: 1/top -b -E k -n 1.
2024-11-11T16:43:24.531: Row 1: top - 16:43:24 up 13 days, 23:26, 1 user, load average: 24.07, 29.54, 27.33.
2024-11-11T16:43:24.531: Row 2: Tasks: 119 total, 1 running, 118 sleeping, 0 stopped, 0 zombie.
2024-11-11T16:43:24.531: Row 3: %Cpu(s): 93.8 us, 6.2 sy, 0.0 ni, 0.0 id, 0.0 wa, 0.0 hi, 0.0 si, 0.0 st.
2024-11-11T16:43:24.531: Row 4: KiB Mem : 876996 total, 63648 free, 635060 used, 178288 buff/cache.
2024-11-11T16:43:24.531: Row 5: KiB Swap: 0 total, 0 free, 0 used. 98956 avail Mem .
2024-11-11T16:43:24.531: Row 6: .
2024-11-11T16:43:24.532: Row 7: PID USER PR NI VIRT RES SHR S %CPU %MEM TIME+ COMMAND.
2024-11-11T16:43:24.532: Row 8: 469687 root 20 0 3975360 96388 17668 S 86.7 11.0 0:00.84 java.
2024-11-11T16:43:24.532: Row 9: 1 root 20 0 167632 10068 5228 S 0.0 1.1 0:32.52 systemd.
2024-11-11T16:43:24.532: Row 10: 2 root 20 0 0 0 0 S 0.0 0.0 0:00.04 kthreadd.
2024-11-11T16:43:24.532: Row 11: 3 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 rcu_gp.
2024-11-11T16:43:24.532: Row 12: 4 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 rcu_par+.
2024-11-11T16:43:24.532: Row 13: 5 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 slub_fl+.
2024-11-11T16:43:24.532: Row 14: 6 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 netns.
2024-11-11T16:43:24.533: Row 15: 8 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 kworker+.
2024-11-11T16:43:24.533: Row 16: 10 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 mm_perc+.
2024-11-11T16:43:24.533: Row 17: 11 root 20 0 0 0 0 S 0.0 0.0 0:00.00 rcu_tas+.
2024-11-11T16:43:24.537: Row 18: 12 root 20 0 0 0 0 S 0.0 0.0 0:00.00 rcu_tas+.
2024-11-11T16:43:24.537: Row 19: 13 root 20 0 0 0 0 S 0.0 0.0 0:13.19 ksoftir+.
2024-11-11T16:43:24.538: Row 20: 14 root 20 0 0 0 0 I 0.0 0.0 0:18.60 rcu_sch+.
2024-11-11T16:43:24.538: Row 21: 15 root rt 0 0 0 0 S 0.0 0.0 0:03.07 migrati+.
2024-11-11T16:43:24.543: Row 22: 16 root -51 0 0 0 0 S 0.0 0.0 0:00.00 idle_in+.
2024-11-11T16:43:24.545: Row 23: 18 root 20 0 0 0 0 S 0.0 0.0 0:00.00 cpuhp/0.
2024-11-11T16:43:24.546: Row 24: 19 root 20 0 0 0 0 S 0.0 0.0 0:00.00 kdevtmp+.
2024-11-11T16:43:24.573: ERR: 217ms Uptime 13 days, 1min 24.07, 5min 29.54, 15min 27.33, mem:876996 total / 63648 free / 635060 used / 178288 cache / 98956 avail
2024-11-11T16:43:24.578: fileio: /var/www/html/ivves/notices.txt, mode: 3, length: 2189.
2024-11-11T16:43:24.617: fileio: /var/www/html/ivves/notices.txt, mode: 2, length: 2189.
2024-11-11T16:43:24.905: ------ test: 2002
2024-11-11T16:43:24.907: CMD: df -h
2024-11-11T16:43:24.907: EXE: 1/df -h.
2024-11-11T16:43:24.955: Row 1: Filesystem Size Used Avail Use% Mounted on.
2024-11-11T16:43:24.955: Row 2: tmpfs 86M 9.7M 76M 12% /run.
2024-11-11T16:43:24.955: Row 3: /dev/vda2 20G 13G 5.9G 70% /.
2024-11-11T16:43:24.955: Row 4: tmpfs 429M 0 429M 0% /dev/shm.
2024-11-11T16:43:24.955: Row 5: tmpfs 5.0M 0 5.0M 0% /run/lock.
2024-11-11T16:43:24.955: Row 6: tmpfs 86M 0 86M 0% /run/user/0.
2024-11-11T16:43:24.956: SUC: 49ms Diskfree qa.headai.com: tmpfs:12%, /dev/vda2:70%, tmpfs:0%, tmpfs:0%, tmpfs:0%.
2024-11-11T16:43:24.957: ------ test: 2003
2024-11-11T16:43:24.957: CMD: ssh root@megatron.headai.com "df -h"
2024-11-11T16:43:24.958: EXE: 1/ssh root@megatron.headai.com "df -h".
2024-11-11T16:43:32.536: Row 1: Filesystem Size Used Avail Use% Mounted on.
2024-11-11T16:43:32.731: Row 2: udev 63G 4.0K 63G 1% /dev.
2024-11-11T16:43:32.731: Row 3: tmpfs 13G 294M 13G 3% /run.
2024-11-11T16:43:32.731: Row 4: /dev/vda1 757G 489G 238G 68% /.
2024-11-11T16:43:32.731: Row 5: none 4.0K 0 4.0K 0% /sys/fs/cgroup.
2024-11-11T16:43:32.731: Row 6: none 5.0M 0 5.0M 0% /run/lock.
2024-11-11T16:43:32.731: Row 7: cgmfs 100K 0 100K 0% /run/cgmanager/fs.
2024-11-11T16:43:32.731: Row 8: none 63G 0 63G 0% /run/shm.
2024-11-11T16:43:32.731: Row 9: none 100M 0 100M 0% /run/user.
2024-11-11T16:43:32.731: Row 10: /dev/vdb 985G 225G 710G 25% /opt/tomcat/webapps/ROOT/analysis.
2024-11-11T16:43:32.732: Row 11: tmpfs 100K 0 100K 0% /var/lib/lxd/shmounts.
2024-11-11T16:43:32.732: Row 12: tmpfs 100K 0 100K 0% /var/lib/lxd/devlxd.
2024-11-11T16:43:32.732: Row 13: tmpfs 13G 0 13G 0% /run/user/0.
2024-11-11T16:43:32.735: SUC: 7778ms Diskfree megatron.headai.com: udev:1%, tmpfs:3%, /dev/vda1:68%, none:0%, none:0%, cgmfs:0%, none:0%, none:0%, /dev/vdb:25%, tmpfs:0%, tmpfs:0%, tmpfs:0%.
2024-11-11T16:43:32.828: ------ test: 2004
2024-11-11T16:43:32.829: URL: https://headai.com
2024-11-11T16:43:37.259: SUC: 4427ms, Anneli Frantti Novia, length 753352.
2024-11-11T16:43:37.333: ------ test: 2005
2024-11-11T16:43:51.941: SQL: show global status like 'threads_connected';.
2024-11-11T16:43:52.628: Results: value=4/200.
2024-11-11T16:43:52.629: SQL: value, lines: 1, ret=1, 4.
2024-11-11T16:43:52.731: SUC: 15397ms 4
2024-11-11T16:43:52.732: ------ test: 2006
2024-11-11T16:43:53.260: SQL: SHOW PROCESSLIST;.
2024-11-11T16:43:53.261: Row 1: 16136684,root,localhost:59858,jobs,Query,11,Sending data,select country, count(id) from items_2021 where country='se' and language='sv' and datediff(readtime.
2024-11-11T16:43:53.261: Row 2: 16136700,root,localhost:59894,null,Query,0,starting,SHOW PROCESSLIST.
2024-11-11T16:43:53.261: SQL: COUNTNOTLINES:Command, lines: 2, ret=2, 2.
2024-11-11T16:43:53.261: SUC: 528ms 2
2024-11-11T16:43:54.333: ------ test: 2007
2024-11-11T16:43:54.333: EXE: 5/"jstack 45238 | grep -E "h2|h1" || true".
2024-11-11T16:43:55.226: SUC: 2007, 893ms, lines: 4096.
2024-11-11T16:44:09.400: ------ test: 2007
2024-11-11T16:44:09.490: EXE: 5/"jstack 45238 | grep -E "h2|h1" || true".
2024-11-11T16:44:15.071: SUC: 2007, 5579ms, lines: 4096.
2024-11-11T16:44:31.957: ------ test: 2007
2024-11-11T16:44:32.051: EXE: 5/"jstack 45238 | grep -E "h2|h1" || true".
2024-11-11T16:44:33.158: Row 1: at h2.core2021.semanticSimilarity_v3(core2021.java:1211).
2024-11-11T16:44:33.159: Row 2: at h2.core2021.text2keywords_v3(core2021.java:727).
2024-11-11T16:44:33.159: Row 3: at h2.SkillsForecast_methods.build_a_map_on_fly_builder(SkillsForecast_methods.java:8252).
2024-11-11T16:44:33.159: Row 4: at h2.SkillsForecast_methods.build_a_map_on_fly_prepare(SkillsForecast_methods.java:8202).
2024-11-11T16:44:33.253: Row 5: at h2.helpers.lambda$22(helpers.java:5387).
2024-11-11T16:44:33.254: Row 6: at h2.helpers$$Lambda$178/1718005659.run(Unknown Source).
2024-11-11T16:44:33.254: SUC: 2007, 1203ms, lines: 6.
2024-11-11T16:44:46.522: ------ test: 2007
2024-11-11T16:44:46.621: EXE: 5/"jstack 45238 | grep -E "h2|h1" || true".
2024-11-11T16:44:48.324: Row 1: at h1.languages.enPluralToSingular(languages.java:1420).
2024-11-11T16:44:48.325: Row 2: at h1.body.wordToBody(body.java:399).
2024-11-11T16:44:48.325: Row 3: at h2.core2021.semanticSimilarity_v3(core2021.java:1393).
2024-11-11T16:44:48.325: Row 4: at h2.core2021.text2keywords_v3(core2021.java:727).
2024-11-11T16:44:48.325: Row 5: at h2.SkillsForecast_methods.build_a_map_on_fly_builder(SkillsForecast_methods.java:8252).
2024-11-11T16:44:48.325: Row 6: at h2.SkillsForecast_methods.build_a_map_on_fly_prepare(SkillsForecast_methods.java:8202).
2024-11-11T16:44:48.325: Row 7: at h2.helpers.check_pending_works(helpers.java:5379).
2024-11-11T16:44:48.326: Row 8: at h1.mc_api.doPost(mc_api.java:4576).
2024-11-11T16:44:48.326: Row 9: at h1.mc_api.doGet(mc_api.java:38).
2024-11-11T16:44:48.331: SUC: 2007, 1710ms, lines: 9.
2024-11-11T16:45:00.928: ------ test: 2007
2024-11-11T16:45:01.030: EXE: 5/"jstack 45238 | grep -E "h2|h1" || true".
2024-11-11T16:45:06.580: SUC: 2007, 5549ms, lines: 4096.
2024-11-11T16:45:54.476: ------ test: 2007
2024-11-11T16:45:54.674: EXE: 5/"jstack 45238 | grep -E "h2|h1" || true".
2024-11-11T16:46:48.235: SUC: 2007, 53162ms, lines: 4096.
2024-11-11T16:47:59.982: ------ test: 2007
2024-11-11T16:47:59.984: EXE: 5/"jstack 45238 | grep -E "h2|h1" || true".
2024-11-11T16:48:05.518: Row 1: at h2.ontology2021.HeadaiDynamicOntology(ontology2021.java:253).
2024-11-11T16:48:05.581: Row 2: at h2.core2021.text2keywords_v3(core2021.java:653).
2024-11-11T16:48:05.582: Row 3: at h2.jobs_educations.search_terms_to_weighted_map(jobs_educations.java:1770).
2024-11-11T16:48:05.582: Row 4: at h2.jobs_educations.get_jobs_by_text(jobs_educations.java:72).
2024-11-11T16:48:05.582: Row 5: at h2.Utils.doPost(Utils.java:925).
2024-11-11T16:48:05.582: Row 6: at h2.Utils.doGet(Utils.java:30).
2024-11-11T16:48:05.887: SUC: 2007, 5903ms, lines: 6.
2024-11-11T16:48:16.888: ------ test: 2007
2024-11-11T16:48:16.889: EXE: 5/"jstack 45238 | grep -E "h2|h1" || true".
2024-11-11T16:48:17.983: SUC: 2007, 1094ms, lines: 4096.
2024-11-11T16:48:31.187: ------ test: 2007
2024-11-11T16:48:31.289: EXE: 5/"jstack 45238 | grep -E "h2|h1" || true".
2024-11-11T16:48:31.784: SUC: 2007, 495ms, lines: 4096.
2024-11-11T16:48:44.299: ------ test: 2007
2024-11-11T16:48:44.394: EXE: 5/"jstack 45238 | grep -E "h2|h1" || true".
2024-11-11T16:48:49.100: SUC: 2007, 4705ms, lines: 4096.
2024-11-11T16:49:00.701: ------ test: 2007
2024-11-11T16:49:00.794: EXE: 5/"jstack 45238 | grep -E "h2|h1" || true".
2024-11-11T16:49:01.596: SUC: 2007, 802ms, lines: 4096.
2024-11-11T16:49:13.996: ------ test: 2007
2024-11-11T16:49:14.100: EXE: 5/"jstack 45238 | grep -E "h2|h1" || true".
2024-11-11T16:49:15.193: SUC: 2007, 1093ms, lines: 4096.
2024-11-11T16:49:25.746: ------ test: 2007
2024-11-11T16:49:25.748: EXE: 5/"jstack 45238 | grep -E "h2|h1" || true".
2024-11-11T16:49:26.108: SUC: 2007, 360ms, lines: 4096.
2024-11-11T16:49:36.402: ------ test: 2007
2024-11-11T16:49:36.402: EXE: 5/"jstack 45238 | grep -E "h2|h1" || true".
2024-11-11T16:49:36.756: SUC: 2007, 354ms, lines: 4096.
2024-11-11T16:49:47.012: ------ test: 2007
2024-11-11T16:49:47.012: EXE: 5/"jstack 45238 | grep -E "h2|h1" || true".
2024-11-11T16:49:47.375: SUC: 2007, 363ms, lines: 4096.
2024-11-11T16:49:57.630: ------ test: 2007
2024-11-11T16:49:57.630: EXE: 5/"jstack 45238 | grep -E "h2|h1" || true".
2024-11-11T16:49:57.987: SUC: 2007, 357ms, lines: 4096.
2024-11-11T16:50:08.253: ------ test: 2007
2024-11-11T16:50:08.253: EXE: 5/"jstack 45238 | grep -E "h2|h1" || true".
2024-11-11T16:50:08.622: SUC: 2007, 369ms, lines: 4096.
2024-11-11T16:50:18.886: ------ test: 2007
2024-11-11T16:50:18.886: EXE: 5/"jstack 45238 | grep -E "h2|h1" || true".
2024-11-11T16:50:19.254: SUC: 2007, 368ms, lines: 4096.
2024-11-11T16:50:29.516: ------ test: 2007
2024-11-11T16:50:29.516: EXE: 5/"jstack 45238 | grep -E "h2|h1" || true".
2024-11-11T16:50:29.895: SUC: 2007, 379ms, lines: 4096.
2024-11-11T16:50:40.155: ------ test: 2007
2024-11-11T16:50:40.156: EXE: 5/"jstack 45238 | grep -E "h2|h1" || true".
2024-11-11T16:50:40.521: SUC: 2007, 365ms, lines: 4096.
2024-11-11T16:50:50.780: ------ test: 2007
2024-11-11T16:50:50.780: EXE: 5/"jstack 45238 | grep -E "h2|h1" || true".
2024-11-11T16:50:51.153: SUC: 2007, 373ms, lines: 4096.
2024-11-11T16:51:01.421: ------ test: 2007
2024-11-11T16:51:01.421: EXE: 5/"jstack 45238 | grep -E "h2|h1" || true".
2024-11-11T16:51:01.790: SUC: 2007, 369ms, lines: 4096.
2024-11-11T16:51:12.043: ------ test: 2007
2024-11-11T16:51:12.043: EXE: 5/"jstack 45238 | grep -E "h2|h1" || true".
2024-11-11T16:51:12.418: SUC: 2007, 375ms, lines: 4096.
2024-11-11T16:51:22.667: ------ test: 2007
2024-11-11T16:51:22.667: EXE: 5/"jstack 45238 | grep -E "h2|h1" || true".
2024-11-11T16:51:23.041: SUC: 2007, 374ms, lines: 4096.
2024-11-11T16:51:33.047: WRN: ssh: Could not resolve hostname megatron.headai.com: Temporary failure in name resolution.
2024-11-11T16:51:33.047: Abnormal exit: 255, lines: 0, output: .
2024-11-11T16:51:33.047: ------ Test ended 489548 ms. Score 31/30.
2024-11-11T16:51:33.047: Test duration: 8m9s.