2026-04-30T12:21:04.466: current working dir: /root/qa/mctester.
2026-04-30T12:21:04.507: current logging dir: ../mctester/www.
2026-04-30T12:21:04.507: ---------------------------------------------------------------
2026-04-30T12:21:04.513: mctester entry: 2026-04-30T12:21:04.507739 mode=50
2026-04-30T12:21:04.513: ---------------------------------------------------------------
2026-04-30T12:21:04.587: EXE: 1/git describe --tags.
2026-04-30T12:21:04.603: Row 1: v1.1-899-g1a6ba9e.
2026-04-30T12:21:04.605: EXE: 1/git rev-list --count HEAD.
2026-04-30T12:21:04.619: Row 1: 956.
2026-04-30T12:21:04.620: EXE: 1/git rev-parse HEAD.
2026-04-30T12:21:04.622: Row 1: 1a6ba9e60939959d71456f28d200a7c8f886e4f5.
2026-04-30T12:21:04.631: mctester: v1.1.956 (1a6ba9e60939959d71456f28d200a7c8f886e4f5).
2026-04-30T12:21:04.631: Entering into a performance tests mode.
2026-04-30T12:21:04.633: ------ test: start, 2026-04-30T12:21:04.632
2026-04-30T12:21:04.634: ------ test: 2000
2026-04-30T12:21:04.636: CMD: ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "top -b -n 1"
2026-04-30T12:21:04.636: EXE: 1/ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "top -b -n 1".
2026-04-30T12:21:04.878: Row 1: top - 12:21:04 up 49 days, 17:36, 2 users, load average: 1.06, 0.73, 0.40.
2026-04-30T12:21:04.878: Row 2: Tasks: 537 total, 1 running, 536 sleeping, 0 stopped, 0 zombie.
2026-04-30T12:21:04.879: Row 3: %Cpu(s): 2.0 us, 0.1 sy, 0.0 ni, 97.9 id, 0.0 wa, 0.0 hi, 0.0 si, 0.0 st.
2026-04-30T12:21:04.879: Row 4: KiB Mem : 13202036+total, 711028 free, 46891188 used, 84418144 buff/cache.
2026-04-30T12:21:04.879: Row 5: KiB Swap: 0 total, 0 free, 0 used. 84133688 avail Mem .
2026-04-30T12:21:04.879: Row 6: .
2026-04-30T12:21:04.880: Row 7: PID USER PR NI VIRT RES SHR S %CPU %MEM TIME+ COMMAND.
2026-04-30T12:21:04.880: Row 8: 21552 root 20 0 44056 4008 3060 R 6.2 0.0 0:00.01 top.
2026-04-30T12:21:04.880: Row 9: 1 root 20 0 43624 3600 2304 S 0.0 0.0 3:17.95 init.
2026-04-30T12:21:04.880: Row 10: 2 root 20 0 0 0 0 S 0.0 0.0 0:00.21 kthreadd.
2026-04-30T12:21:04.881: Row 11: 3 root 20 0 0 0 0 S 0.0 0.0 0:31.00 ksoftirqd+.
2026-04-30T12:21:04.881: Row 12: 5 root 0 -20 0 0 0 S 0.0 0.0 0:00.00 kworker/0+.
2026-04-30T12:21:04.881: Row 13: 7 root 20 0 0 0 0 S 0.0 0.0 44:46.18 rcu_sched.
2026-04-30T12:21:04.881: Row 14: 8 root 20 0 0 0 0 S 0.0 0.0 0:00.00 rcu_bh.
2026-04-30T12:21:04.882: Row 15: 9 root rt 0 0 0 0 S 0.0 0.0 0:01.14 migration+.
2026-04-30T12:21:04.882: Row 16: 10 root rt 0 0 0 0 S 0.0 0.0 0:24.09 watchdog/0.
2026-04-30T12:21:04.885: Row 17: 11 root rt 0 0 0 0 S 0.0 0.0 0:20.64 watchdog/1.
2026-04-30T12:21:04.885: Row 18: 12 root rt 0 0 0 0 S 0.0 0.0 0:04.51 migration+.
2026-04-30T12:21:04.885: Row 19: 13 root 20 0 0 0 0 S 0.0 0.0 0:00.91 ksoftirqd+.
2026-04-30T12:21:04.885: Row 20: 14 root 20 0 0 0 0 S 0.0 0.0 0:00.00 kworker/1+.
2026-04-30T12:21:04.886: Row 21: 15 root 0 -20 0 0 0 S 0.0 0.0 0:00.00 kworker/1+.
2026-04-30T12:21:04.886: Row 22: 16 root rt 0 0 0 0 S 0.0 0.0 0:21.43 watchdog/2.
2026-04-30T12:21:04.886: Row 23: 17 root rt 0 0 0 0 S 0.0 0.0 0:01.68 migration+.
2026-04-30T12:21:04.886: Row 24: 18 root 20 0 0 0 0 S 0.0 0.0 0:00.93 ksoftirqd+.
2026-04-30T12:21:04.955: SUC: 314ms Uptime 49 days, 1min 1.06, 5min 0.73, 15min 0.40, mem:132020360 total / 711028 free / 46891188 used / 84418144 cache / 84133688 avail
2026-04-30T12:21:04.966: ------ test: 2001
2026-04-30T12:21:04.966: CMD: top -b -E k -n 1
2026-04-30T12:21:04.966: EXE: 1/top -b -E k -n 1.
2026-04-30T12:21:05.128: Row 1: top - 12:21:05 up 147 days, 19:41, 0 users, load average: 8.02, 7.98, 7.99.
2026-04-30T12:21:05.129: Row 2: Tasks: 243 total, 1 running, 241 sleeping, 1 stopped, 0 zombie.
2026-04-30T12:21:05.129: Row 3: %Cpu(s): 2.4 us, 0.4 sy, 0.0 ni, 97.2 id, 0.0 wa, 0.0 hi, 0.0 si, 0.0 st.
2026-04-30T12:21:05.129: Row 4: KiB Mem : 32827244 total, 15738808 free, 2112832 used, 14975604 buff/cache.
2026-04-30T12:21:05.129: Row 5: KiB Swap: 16777212 total, 16776944 free, 268 used. 29888004 avail Mem .
2026-04-30T12:21:05.129: Row 6: .
2026-04-30T12:21:05.130: Row 7: PID USER PR NI VIRT RES SHR S %CPU %MEM TIME+ COMMAND.
2026-04-30T12:21:05.130: Row 8: 963701 root 20 0 5253416 85620 27136 S 40.0 0.3 0:01.19 java.
2026-04-30T12:21:05.130: Row 9: 963731 root 20 0 13712 3800 3200 R 6.7 0.0 0:00.01 top.
2026-04-30T12:21:05.131: Row 10: 1 root 20 0 167688 13104 8168 S 0.0 0.0 8:05.62 systemd.
2026-04-30T12:21:05.131: Row 11: 2 root 20 0 0 0 0 S 0.0 0.0 0:03.41 kthreadd.
2026-04-30T12:21:05.131: Row 12: 3 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 rcu_gp.
2026-04-30T12:21:05.131: Row 13: 4 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 rcu_par+.
2026-04-30T12:21:05.131: Row 14: 5 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 slub_fl+.
2026-04-30T12:21:05.132: Row 15: 6 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 netns.
2026-04-30T12:21:05.132: Row 16: 8 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 kworker+.
2026-04-30T12:21:05.132: Row 17: 10 root 0 -20 0 0 0 I 0.0 0.0 0:00.00 mm_perc+.
2026-04-30T12:21:05.132: Row 18: 11 root 20 0 0 0 0 S 0.0 0.0 0:00.00 rcu_tas+.
2026-04-30T12:21:05.132: Row 19: 12 root 20 0 0 0 0 S 0.0 0.0 0:00.00 rcu_tas+.
2026-04-30T12:21:05.132: Row 20: 13 root 20 0 0 0 0 S 0.0 0.0 0:00.30 ksoftir+.
2026-04-30T12:21:05.133: Row 21: 14 root 20 0 0 0 0 I 0.0 0.0 30:07.00 rcu_sch+.
2026-04-30T12:21:05.133: Row 22: 15 root rt 0 0 0 0 S 0.0 0.0 0:30.52 migrati+.
2026-04-30T12:21:05.133: Row 23: 16 root -51 0 0 0 0 S 0.0 0.0 0:00.00 idle_in+.
2026-04-30T12:21:05.133: Row 24: 18 root 20 0 0 0 0 S 0.0 0.0 0:00.00 cpuhp/0.
2026-04-30T12:21:05.157: SUC: 191ms Uptime 147 days, 1min 8.02, 5min 7.98, 15min 7.99, mem:32827244 total / 15738808 free / 2112832 used / 14975604 cache / 29888004 avail
2026-04-30T12:21:05.157: ------ test: 2002
2026-04-30T12:21:05.158: CMD: df -h
2026-04-30T12:21:05.158: EXE: 1/df -h.
2026-04-30T12:21:05.161: Row 1: Filesystem Size Used Avail Use% Mounted on.
2026-04-30T12:21:05.161: Row 2: tmpfs 3.2G 338M 2.9G 11% /run.
2026-04-30T12:21:05.162: Row 3: /dev/vda2 59G 50G 7.2G 88% /.
2026-04-30T12:21:05.162: Row 4: tmpfs 16G 0 16G 0% /dev/shm.
2026-04-30T12:21:05.162: Row 5: tmpfs 5.0M 0 5.0M 0% /run/lock.
2026-04-30T12:21:05.164: SUC: 5ms Diskfree qa.headai.com: tmpfs:11%, /dev/vda2:88%, tmpfs:0%, tmpfs:0%.
2026-04-30T12:21:05.164: ------ test: 2003
2026-04-30T12:21:05.165: CMD: ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "df -h"
2026-04-30T12:21:05.165: EXE: 1/ssh -o ServerAliveInterval=60 -o ServerAliveCountMax=3 root@megatron.headai.com "df -h".
2026-04-30T12:21:05.239: Row 1: Filesystem Size Used Avail Use% Mounted on.
2026-04-30T12:21:05.239: Row 2: udev 63G 4.0K 63G 1% /dev.
2026-04-30T12:21:05.239: Row 3: tmpfs 13G 5.5M 13G 1% /run.
2026-04-30T12:21:05.239: Row 4: /dev/vda1 757G 332G 395G 46% /.
2026-04-30T12:21:05.240: Row 5: none 4.0K 0 4.0K 0% /sys/fs/cgroup.
2026-04-30T12:21:05.240: Row 6: none 5.0M 0 5.0M 0% /run/lock.
2026-04-30T12:21:05.241: Row 7: none 63G 0 63G 0% /run/shm.
2026-04-30T12:21:05.241: Row 8: none 100M 0 100M 0% /run/user.
2026-04-30T12:21:05.241: Row 9: cgmfs 100K 0 100K 0% /run/cgmanager/fs.
2026-04-30T12:21:05.241: Row 10: /dev/vdb 985G 295G 640G 32% /opt/tomcat/webapps/ROOT/analysis.
2026-04-30T12:21:05.241: Row 11: tmpfs 100K 0 100K 0% /var/lib/lxd/shmounts.
2026-04-30T12:21:05.241: Row 12: tmpfs 100K 0 100K 0% /var/lib/lxd/devlxd.
2026-04-30T12:21:05.242: SUC: 78ms Diskfree megatron.headai.com: udev:1%, tmpfs:1%, /dev/vda1:46%, none:0%, none:0%, none:0%, none:0%, cgmfs:0%, /dev/vdb:32%, tmpfs:0%, tmpfs:0%.
2026-04-30T12:21:05.243: ------ test: 2004
2026-04-30T12:21:05.243: URL: https://headai.com
2026-04-30T12:21:05.775: SUC: 509ms, meets direction. Headai is a deep tech company enabling Decision Intelligence for future-focused organizations through automated analysis of unstructured text data. Unlock Hidden Insights Optimize Workforce Strategies Enable Decision Intelligence Improve Operational Efficiency Metis Training tool for creating machine-readable data Learn how to create high-quality, machine-readable data for better job recommendations and labor market […]" />, length 210717.
2026-04-30T12:21:05.777: ------ test: 2005
2026-04-30T12:21:06.024: SQL: show global status like 'threads_connected';.
2026-04-30T12:21:06.052: Results: value=3/200.
2026-04-30T12:21:06.058: SQL: value, lines: 1, ret=1, 3.
2026-04-30T12:21:06.059: SUC: 282ms 3
2026-04-30T12:21:06.060: ------ test: 2006
2026-04-30T12:21:06.139: SQL: SHOW PROCESSLIST;.
2026-04-30T12:21:06.145: Row 1: 30517324,root,localhost:48550,null,Query,0,starting,SHOW PROCESSLIST.
2026-04-30T12:21:06.145: SQL: COUNTNOTLINES:Command, lines: 1, ret=1, 1.
2026-04-30T12:21:06.146: SUC: 86ms 1
2026-04-30T12:21:06.147: checkJavaStack starting: 2007.
2026-04-30T12:21:06.245: ------ test: 2007
2026-04-30T12:21:06.246: EXE: 5/"jstack 26101 | 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".
2026-04-30T12:21:06.471: Row 1: "https-openssl-nio-443-exec-653" #270198 daemon prio=5 os_prio=0 tid=0x00007fcd08015000 nid=0x48d3 runnable [0x00007fcd07cfc000].
2026-04-30T12:21:06.472: Row 2: java.lang.Thread.State: RUNNABLE.
2026-04-30T12:21:06.472: Row 3: at java.net.SocketInputStream.socketRead0(Native Method).
2026-04-30T12:21:06.472: Row 4: at java.net.SocketInputStream.socketRead(SocketInputStream.java:116).
2026-04-30T12:21:06.472: Row 5: at java.net.SocketInputStream.read(SocketInputStream.java:171).
2026-04-30T12:21:06.472: Row 6: at java.net.SocketInputStream.read(SocketInputStream.java:141).
2026-04-30T12:21:06.473: Row 7: at com.mysql.jdbc.util.ReadAheadInputStream.fill(ReadAheadInputStream.java:100).
2026-04-30T12:21:06.473: Row 8: at com.mysql.jdbc.util.ReadAheadInputStream.readFromUnderlyingStreamIfNecessary(ReadAheadInputStream.java:143).
2026-04-30T12:21:06.473: Row 9: at com.mysql.jdbc.util.ReadAheadInputStream.read(ReadAheadInputStream.java:173).
2026-04-30T12:21:06.473: Row 10: - locked <0x00000007b92dda40> (a com.mysql.jdbc.util.ReadAheadInputStream).
2026-04-30T12:21:06.473: Row 11: at com.mysql.jdbc.MysqlIO.readFully(MysqlIO.java:2911).
2026-04-30T12:21:06.474: Row 12: at com.mysql.jdbc.MysqlIO.reuseAndReadPacket(MysqlIO.java:3337).
2026-04-30T12:21:06.474: Row 13: at com.mysql.jdbc.MysqlIO.reuseAndReadPacket(MysqlIO.java:3327).
2026-04-30T12:21:06.474: Row 14: at com.mysql.jdbc.MysqlIO.checkErrorPacket(MysqlIO.java:3814).
2026-04-30T12:21:06.477: Row 15: at com.mysql.jdbc.MysqlIO.sendCommand(MysqlIO.java:2435).
2026-04-30T12:21:06.477: Row 16: at com.mysql.jdbc.MysqlIO.sqlQueryDirect(MysqlIO.java:2582).
2026-04-30T12:21:06.477: Row 17: at com.mysql.jdbc.ConnectionImpl.execSQL(ConnectionImpl.java:2526).
2026-04-30T12:21:06.477: Row 18: - locked <0x00000007b92d3fc8> (a com.mysql.jdbc.JDBC4Connection).
2026-04-30T12:21:06.478: Row 19: at com.mysql.jdbc.ConnectionImpl.execSQL(ConnectionImpl.java:2484).
2026-04-30T12:21:06.478: Row 20: at com.mysql.jdbc.StatementImpl.executeQuery(StatementImpl.java:1446).
2026-04-30T12:21:06.478: Row 21: - locked <0x00000007b92d3fc8> (a com.mysql.jdbc.JDBC4Connection).
2026-04-30T12:21:06.478: Row 22: at com.mysql.jdbc.ConnectionImpl.isReadOnly(ConnectionImpl.java:3601).
2026-04-30T12:21:06.478: Row 23: at com.mysql.jdbc.ConnectionImpl.isReadOnly(ConnectionImpl.java:3576).
2026-04-30T12:21:06.478: Row 24: at com.mysql.jdbc.PreparedStatement.executeUpdate(PreparedStatement.java:2107).
2026-04-30T12:21:06.479: SUC: 2007, 233ms, lines: 31.
2026-04-30T12:21:06.482: checkJavaStack end: 2007, pid/ret=31.
2026-04-30T12:21:16.482: checkJavaStack starting: 2007.
2026-04-30T12:21:16.578: ------ test: 2007
2026-04-30T12:21:16.578: EXE: 5/"jstack 26101 | 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".
2026-04-30T12:21:16.848: Row 1: "https-openssl-nio-443-exec-639" #270184 daemon prio=5 os_prio=0 tid=0x00007fcd14029000 nid=0x47f4 runnable [0x00007fcb9a032000].
2026-04-30T12:21:16.848: Row 2: java.lang.Thread.State: RUNNABLE.
2026-04-30T12:21:16.848: Row 3: at java.net.SocketInputStream.socketRead0(Native Method).
2026-04-30T12:21:16.849: Row 4: at java.net.SocketInputStream.socketRead(SocketInputStream.java:116).
2026-04-30T12:21:16.849: Row 5: at java.net.SocketInputStream.read(SocketInputStream.java:171).
2026-04-30T12:21:16.849: Row 6: at java.net.SocketInputStream.read(SocketInputStream.java:141).
2026-04-30T12:21:16.849: Row 7: at com.mysql.jdbc.util.ReadAheadInputStream.fill(ReadAheadInputStream.java:100).
2026-04-30T12:21:16.849: Row 8: at com.mysql.jdbc.util.ReadAheadInputStream.readFromUnderlyingStreamIfNecessary(ReadAheadInputStream.java:143).
2026-04-30T12:21:16.849: Row 9: at com.mysql.jdbc.util.ReadAheadInputStream.read(ReadAheadInputStream.java:173).
2026-04-30T12:21:16.849: Row 10: - locked <0x000000079cf170f8> (a com.mysql.jdbc.util.ReadAheadInputStream).
2026-04-30T12:21:16.849: Row 11: at com.mysql.jdbc.MysqlIO.readFully(MysqlIO.java:2911).
2026-04-30T12:21:16.849: Row 12: at com.mysql.jdbc.MysqlIO.reuseAndReadPacket(MysqlIO.java:3337).
2026-04-30T12:21:16.850: Row 13: at com.mysql.jdbc.MysqlIO.reuseAndReadPacket(MysqlIO.java:3327).
2026-04-30T12:21:16.850: Row 14: at com.mysql.jdbc.MysqlIO.checkErrorPacket(MysqlIO.java:3814).
2026-04-30T12:21:16.850: Row 15: at com.mysql.jdbc.MysqlIO.sendCommand(MysqlIO.java:2435).
2026-04-30T12:21:16.850: Row 16: at com.mysql.jdbc.MysqlIO.sqlQueryDirect(MysqlIO.java:2582).
2026-04-30T12:21:16.850: Row 17: at com.mysql.jdbc.ConnectionImpl.execSQL(ConnectionImpl.java:2530).
2026-04-30T12:21:16.850: Row 18: - locked <0x000000079cf0d5c8> (a com.mysql.jdbc.JDBC4Connection).
2026-04-30T12:21:16.850: Row 19: at com.mysql.jdbc.PreparedStatement.executeInternal(PreparedStatement.java:1907).
2026-04-30T12:21:16.850: Row 20: - locked <0x000000079cf0d5c8> (a com.mysql.jdbc.JDBC4Connection).
2026-04-30T12:21:16.851: Row 21: at com.mysql.jdbc.PreparedStatement.executeQuery(PreparedStatement.java:2030).
2026-04-30T12:21:16.851: Row 22: - locked <0x000000079cf0d5c8> (a com.mysql.jdbc.JDBC4Connection).
2026-04-30T12:21:16.851: Row 23: at h2.helpers.check_pending_works(helpers.java:4955).
2026-04-30T12:21:16.851: Row 24: at h1.mc_api.doPost(mc_api.java:4578).
2026-04-30T12:21:16.851: SUC: 2007, 273ms, lines: 25.
2026-04-30T12:21:16.853: checkJavaStack end: 2007, pid/ret=25.
2026-04-30T12:21:26.853: checkJavaStack starting: 2007.
2026-04-30T12:21:26.948: ------ test: 2007
2026-04-30T12:21:26.949: EXE: 5/"jstack 26101 | 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".
2026-04-30T12:21:27.181: Row 1: "https-openssl-nio-443-exec-596" #218582 daemon prio=5 os_prio=0 tid=0x00007fcd1402f800 nid=0x1baae runnable [0x00007fcd608b9000].
2026-04-30T12:21:27.181: Row 2: java.lang.Thread.State: RUNNABLE.
2026-04-30T12:21:27.181: Row 3: at java.net.SocketInputStream.socketRead0(Native Method).
2026-04-30T12:21:27.181: Row 4: at java.net.SocketInputStream.socketRead(SocketInputStream.java:116).
2026-04-30T12:21:27.181: Row 5: at java.net.SocketInputStream.read(SocketInputStream.java:171).
2026-04-30T12:21:27.181: Row 6: at java.net.SocketInputStream.read(SocketInputStream.java:141).
2026-04-30T12:21:27.182: Row 7: at com.mysql.jdbc.util.ReadAheadInputStream.fill(ReadAheadInputStream.java:100).
2026-04-30T12:21:27.182: Row 8: at com.mysql.jdbc.util.ReadAheadInputStream.readFromUnderlyingStreamIfNecessary(ReadAheadInputStream.java:143).
2026-04-30T12:21:27.182: Row 9: at com.mysql.jdbc.util.ReadAheadInputStream.read(ReadAheadInputStream.java:173).
2026-04-30T12:21:27.182: Row 10: - locked <0x0000000799144608> (a com.mysql.jdbc.util.ReadAheadInputStream).
2026-04-30T12:21:27.182: Row 11: at com.mysql.jdbc.MysqlIO.readFully(MysqlIO.java:2911).
2026-04-30T12:21:27.182: Row 12: at com.mysql.jdbc.MysqlIO.reuseAndReadPacket(MysqlIO.java:3337).
2026-04-30T12:21:27.182: Row 13: at com.mysql.jdbc.MysqlIO.reuseAndReadPacket(MysqlIO.java:3327).
2026-04-30T12:21:27.182: Row 14: at com.mysql.jdbc.MysqlIO.checkErrorPacket(MysqlIO.java:3814).
2026-04-30T12:21:27.183: Row 15: at com.mysql.jdbc.MysqlIO.sendCommand(MysqlIO.java:2435).
2026-04-30T12:21:27.183: Row 16: at com.mysql.jdbc.MysqlIO.sqlQueryDirect(MysqlIO.java:2582).
2026-04-30T12:21:27.183: Row 17: at com.mysql.jdbc.ConnectionImpl.execSQL(ConnectionImpl.java:2530).
2026-04-30T12:21:27.183: Row 18: - locked <0x00000007990c76e0> (a com.mysql.jdbc.JDBC4Connection).
2026-04-30T12:21:27.191: Row 19: at com.mysql.jdbc.PreparedStatement.executeInternal(PreparedStatement.java:1907).
2026-04-30T12:21:27.199: Row 20: - locked <0x00000007990c76e0> (a com.mysql.jdbc.JDBC4Connection).
2026-04-30T12:21:27.199: Row 21: at com.mysql.jdbc.PreparedStatement.execute(PreparedStatement.java:1199).
2026-04-30T12:21:27.199: Row 22: - locked <0x00000007990c76e0> (a com.mysql.jdbc.JDBC4Connection).
2026-04-30T12:21:27.199: Row 23: at h2.helpers.delete_data_from_long_queries(helpers.java:9784).
2026-04-30T12:21:27.199: Row 24: at h2.Utils.doPost(Utils.java:2115).
2026-04-30T12:21:27.201: SUC: 2007, 253ms, lines: 25.
2026-04-30T12:21:27.202: checkJavaStack end: 2007, pid/ret=25.
2026-04-30T12:21:37.202: checkJavaStack starting: 2007.
2026-04-30T12:21:37.298: ------ test: 2007
2026-04-30T12:21:37.299: EXE: 5/"jstack 26101 | 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".
2026-04-30T12:21:37.603: Row 1: "https-openssl-nio-443-exec-658" #270203 daemon prio=5 os_prio=0 tid=0x00007fcd08057000 nid=0x492f runnable [0x00007fcd065e7000].
2026-04-30T12:21:37.603: Row 2: java.lang.Thread.State: RUNNABLE.
2026-04-30T12:21:37.603: Row 3: at java.net.SocketInputStream.socketRead0(Native Method).
2026-04-30T12:21:37.603: Row 4: at java.net.SocketInputStream.socketRead(SocketInputStream.java:116).
2026-04-30T12:21:37.603: Row 5: at java.net.SocketInputStream.read(SocketInputStream.java:171).
2026-04-30T12:21:37.603: Row 6: at java.net.SocketInputStream.read(SocketInputStream.java:141).
2026-04-30T12:21:37.603: Row 7: at com.mysql.jdbc.util.ReadAheadInputStream.fill(ReadAheadInputStream.java:100).
2026-04-30T12:21:37.604: Row 8: at com.mysql.jdbc.util.ReadAheadInputStream.readFromUnderlyingStreamIfNecessary(ReadAheadInputStream.java:143).
2026-04-30T12:21:37.604: Row 9: at com.mysql.jdbc.util.ReadAheadInputStream.read(ReadAheadInputStream.java:173).
2026-04-30T12:21:37.604: Row 10: - locked <0x000000076e6463b8> (a com.mysql.jdbc.util.ReadAheadInputStream).
2026-04-30T12:21:37.604: Row 11: at com.mysql.jdbc.MysqlIO.readFully(MysqlIO.java:2911).
2026-04-30T12:21:37.604: Row 12: at com.mysql.jdbc.MysqlIO.reuseAndReadPacket(MysqlIO.java:3337).
2026-04-30T12:21:37.604: Row 13: at com.mysql.jdbc.MysqlIO.reuseAndReadPacket(MysqlIO.java:3327).
2026-04-30T12:21:37.604: Row 14: at com.mysql.jdbc.MysqlIO.checkErrorPacket(MysqlIO.java:3814).
2026-04-30T12:21:37.604: Row 15: at com.mysql.jdbc.MysqlIO.sendCommand(MysqlIO.java:2435).
2026-04-30T12:21:37.604: Row 16: at com.mysql.jdbc.MysqlIO.sqlQueryDirect(MysqlIO.java:2582).
2026-04-30T12:21:37.604: Row 17: at com.mysql.jdbc.ConnectionImpl.execSQL(ConnectionImpl.java:2526).
2026-04-30T12:21:37.604: Row 18: - locked <0x000000076e63c988> (a com.mysql.jdbc.JDBC4Connection).
2026-04-30T12:21:37.605: Row 19: at com.mysql.jdbc.ConnectionImpl.execSQL(ConnectionImpl.java:2484).
2026-04-30T12:21:37.605: Row 20: at com.mysql.jdbc.StatementImpl.executeQuery(StatementImpl.java:1446).
2026-04-30T12:21:37.605: Row 21: - locked <0x000000076e63c988> (a com.mysql.jdbc.JDBC4Connection).
2026-04-30T12:21:37.605: Row 22: at com.mysql.jdbc.ConnectionImpl.loadServerVariables(ConnectionImpl.java:3828).
2026-04-30T12:21:37.605: Row 23: at com.mysql.jdbc.ConnectionImpl.initializePropsFromServer(ConnectionImpl.java:3268).
2026-04-30T12:21:37.605: Row 24: at com.mysql.jdbc.ConnectionImpl.connectOneTryOnly(ConnectionImpl.java:2278).
2026-04-30T12:21:37.612: SUC: 2007, 309ms, lines: 39.
2026-04-30T12:21:37.612: checkJavaStack end: 2007, pid/ret=39.
2026-04-30T12:21:47.613: checkJavaStack starting: 2007.
2026-04-30T12:21:47.710: ------ test: 2007
2026-04-30T12:21:47.710: EXE: 5/"jstack 26101 | 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".
2026-04-30T12:21:47.969: Row 1: "https-openssl-nio-443-exec-596" #218582 daemon prio=5 os_prio=0 tid=0x00007fcd1402f800 nid=0x1baae runnable [0x00007fcd608b9000].
2026-04-30T12:21:47.970: Row 2: java.lang.Thread.State: RUNNABLE.
2026-04-30T12:21:47.970: Row 3: at h2.skills_compass.get_suggestion_with_interests(skills_compass.java:1449).
2026-04-30T12:21:47.970: Row 4: at h2.skills_compass.get_suggestion(skills_compass.java:23).
2026-04-30T12:21:47.970: Row 5: at h2.Utils.doPost(Utils.java:867).
2026-04-30T12:21:47.970: Row 6: at h2.Utils.doGet(Utils.java:32).
2026-04-30T12:21:47.977: SUC: 2007, 263ms, lines: 6.
2026-04-30T12:21:47.979: checkJavaStack end: 2007, pid/ret=6.
2026-04-30T12:21:57.979: checkJavaStack starting: 2007.
2026-04-30T12:21:58.076: ------ test: 2007
2026-04-30T12:21:58.076: EXE: 5/"jstack 26101 | 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".
2026-04-30T12:21:58.293: SUC: 2007, 215ms, lines: 4096.
2026-04-30T12:21:58.295: checkJavaStack end: 2007, pid/ret=4096.
2026-04-30T12:22:08.295: checkJavaStack starting: 2007.
2026-04-30T12:22:08.386: ------ test: 2007
2026-04-30T12:22:08.387: EXE: 5/"jstack 26101 | 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".
2026-04-30T12:22:08.603: SUC: 2007, 216ms, lines: 4096.
2026-04-30T12:22:08.604: checkJavaStack end: 2007, pid/ret=4096.
2026-04-30T12:22:18.604: checkJavaStack starting: 2007.
2026-04-30T12:22:18.695: ------ test: 2007
2026-04-30T12:22:18.695: EXE: 5/"jstack 26101 | 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".
2026-04-30T12:22:18.925: SUC: 2007, 230ms, lines: 4096.
2026-04-30T12:22:18.925: checkJavaStack end: 2007, pid/ret=4096.
2026-04-30T12:22:28.925: checkJavaStack starting: 2007.
2026-04-30T12:22:29.022: ------ test: 2007
2026-04-30T12:22:29.022: EXE: 5/"jstack 26101 | 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".
2026-04-30T12:22:29.234: Row 1: "https-openssl-nio-443-exec-656" #270201 daemon prio=5 os_prio=0 tid=0x00007fcd0803d800 nid=0x48df runnable [0x00007fcd06fef000].
2026-04-30T12:22:29.234: Row 2: java.lang.Thread.State: RUNNABLE.
2026-04-30T12:22:29.234: Row 3: at java.net.SocketInputStream.socketRead0(Native Method).
2026-04-30T12:22:29.234: Row 4: at java.net.SocketInputStream.socketRead(SocketInputStream.java:116).
2026-04-30T12:22:29.234: Row 5: at java.net.SocketInputStream.read(SocketInputStream.java:171).
2026-04-30T12:22:29.234: Row 6: at java.net.SocketInputStream.read(SocketInputStream.java:141).
2026-04-30T12:22:29.235: Row 7: at com.mysql.jdbc.util.ReadAheadInputStream.fill(ReadAheadInputStream.java:100).
2026-04-30T12:22:29.235: Row 8: at com.mysql.jdbc.util.ReadAheadInputStream.readFromUnderlyingStreamIfNecessary(ReadAheadInputStream.java:143).
2026-04-30T12:22:29.235: Row 9: at com.mysql.jdbc.util.ReadAheadInputStream.read(ReadAheadInputStream.java:173).
2026-04-30T12:22:29.235: Row 10: - locked <0x0000000726b38820> (a com.mysql.jdbc.util.ReadAheadInputStream).
2026-04-30T12:22:29.235: Row 11: at com.mysql.jdbc.MysqlIO.readFully(MysqlIO.java:2911).
2026-04-30T12:22:29.235: Row 12: at com.mysql.jdbc.MysqlIO.reuseAndReadPacket(MysqlIO.java:3337).
2026-04-30T12:22:29.235: Row 13: at com.mysql.jdbc.MysqlIO.reuseAndReadPacket(MysqlIO.java:3327).
2026-04-30T12:22:29.235: Row 14: at com.mysql.jdbc.MysqlIO.checkErrorPacket(MysqlIO.java:3814).
2026-04-30T12:22:29.235: Row 15: at com.mysql.jdbc.MysqlIO.sendCommand(MysqlIO.java:2435).
2026-04-30T12:22:29.235: Row 16: at com.mysql.jdbc.MysqlIO.sqlQueryDirect(MysqlIO.java:2582).
2026-04-30T12:22:29.235: Row 17: at com.mysql.jdbc.ConnectionImpl.execSQL(ConnectionImpl.java:2530).
2026-04-30T12:22:29.235: Row 18: - locked <0x0000000726b2ee58> (a com.mysql.jdbc.JDBC4Connection).
2026-04-30T12:22:29.235: Row 19: at com.mysql.jdbc.PreparedStatement.executeInternal(PreparedStatement.java:1907).
2026-04-30T12:22:29.236: Row 20: - locked <0x0000000726b2ee58> (a com.mysql.jdbc.JDBC4Connection).
2026-04-30T12:22:29.236: Row 21: at com.mysql.jdbc.PreparedStatement.executeQuery(PreparedStatement.java:2030).
2026-04-30T12:22:29.236: Row 22: - locked <0x0000000726b2ee58> (a com.mysql.jdbc.JDBC4Connection).
2026-04-30T12:22:29.236: Row 23: at h2.helpers.store_query(helpers.java:4172).
2026-04-30T12:22:29.236: Row 24: at h2.BuildMindMap.doPost(BuildMindMap.java:140).
2026-04-30T12:22:29.236: SUC: 2007, 214ms, lines: 25.
2026-04-30T12:22:29.237: checkJavaStack end: 2007, pid/ret=25.
2026-04-30T12:22:39.237: checkJavaStack starting: 2007.
2026-04-30T12:22:39.332: ------ test: 2007
2026-04-30T12:22:39.333: EXE: 5/"jstack 26101 | 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".
2026-04-30T12:22:39.602: SUC: 2007, 270ms, lines: 4096.
2026-04-30T12:22:39.603: checkJavaStack end: 2007, pid/ret=4096.
2026-04-30T12:22:49.603: checkJavaStack starting: 2007.
2026-04-30T12:22:49.697: ------ test: 2007
2026-04-30T12:22:49.697: EXE: 5/"jstack 26101 | 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".
2026-04-30T12:22:49.940: SUC: 2007, 243ms, lines: 4096.
2026-04-30T12:22:49.941: checkJavaStack end: 2007, pid/ret=4096.
2026-04-30T12:22:59.941: checkJavaStack starting: 2007.
2026-04-30T12:23:00.036: ------ test: 2007
2026-04-30T12:23:00.037: EXE: 5/"jstack 26101 | 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".
2026-04-30T12:23:00.288: Row 1: "https-openssl-nio-443-exec-586" #218563 daemon prio=5 os_prio=0 tid=0x00007fcd08063000 nid=0x1ba0a runnable [0x00007fcd047c5000].
2026-04-30T12:23:00.289: Row 2: java.lang.Thread.State: RUNNABLE.
2026-04-30T12:23:00.289: Row 3: at java.net.SocketInputStream.socketRead0(Native Method).
2026-04-30T12:23:00.289: Row 4: at java.net.SocketInputStream.socketRead(SocketInputStream.java:116).
2026-04-30T12:23:00.289: Row 5: at java.net.SocketInputStream.read(SocketInputStream.java:171).
2026-04-30T12:23:00.289: Row 6: at java.net.SocketInputStream.read(SocketInputStream.java:141).
2026-04-30T12:23:00.289: Row 7: at sun.security.ssl.SSLSocketInputRecord.read(SSLSocketInputRecord.java:457).
2026-04-30T12:23:00.289: Row 8: at sun.security.ssl.SSLSocketInputRecord.bytesInCompletePacket(SSLSocketInputRecord.java:68).
2026-04-30T12:23:00.289: Row 9: at sun.security.ssl.SSLSocketImpl.readApplicationRecord(SSLSocketImpl.java:1332).
2026-04-30T12:23:00.289: Row 10: at sun.security.ssl.SSLSocketImpl.access$300(SSLSocketImpl.java:73).
2026-04-30T12:23:00.289: Row 11: at sun.security.ssl.SSLSocketImpl$AppInputStream.read(SSLSocketImpl.java:948).
2026-04-30T12:23:00.289: Row 12: at net.snowflake.client.jdbc.internal.apache.http.impl.io.SessionInputBufferImpl.streamRead(SessionInputBufferImpl.java:137).
2026-04-30T12:23:00.290: Row 13: at net.snowflake.client.jdbc.internal.apache.http.impl.io.SessionInputBufferImpl.fillBuffer(SessionInputBufferImpl.java:153).
2026-04-30T12:23:00.290: Row 14: at net.snowflake.client.jdbc.internal.apache.http.impl.io.SessionInputBufferImpl.readLine(SessionInputBufferImpl.java:280).
2026-04-30T12:23:00.290: Row 15: at net.snowflake.client.jdbc.internal.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:138).
2026-04-30T12:23:00.290: Row 16: at net.snowflake.client.jdbc.internal.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:56).
2026-04-30T12:23:00.290: Row 17: at net.snowflake.client.jdbc.internal.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:259).
2026-04-30T12:23:00.290: Row 18: at net.snowflake.client.jdbc.internal.apache.http.impl.DefaultBHttpClientConnection.receiveResponseHeader(DefaultBHttpClientConnection.java:163).
2026-04-30T12:23:00.290: Row 19: at net.snowflake.client.jdbc.internal.apache.http.impl.conn.CPoolProxy.receiveResponseHeader(CPoolProxy.java:157).
2026-04-30T12:23:00.290: Row 20: at net.snowflake.client.jdbc.internal.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:273).
2026-04-30T12:23:00.290: Row 21: at net.snowflake.client.jdbc.internal.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:125).
2026-04-30T12:23:00.290: Row 22: at net.snowflake.client.jdbc.internal.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:272).
2026-04-30T12:23:00.290: Row 23: at net.snowflake.client.jdbc.internal.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:186).
2026-04-30T12:23:00.290: Row 24: at net.snowflake.client.jdbc.internal.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:89).
2026-04-30T12:23:00.292: SUC: 2007, 256ms, lines: 44.
2026-04-30T12:23:00.293: checkJavaStack end: 2007, pid/ret=44.
2026-04-30T12:23:10.293: checkJavaStack starting: 2007.
2026-04-30T12:23:10.385: ------ test: 2007
2026-04-30T12:23:10.385: EXE: 5/"jstack 26101 | 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".
2026-04-30T12:23:10.616: SUC: 2007, 231ms, lines: 4096.
2026-04-30T12:23:10.616: checkJavaStack end: 2007, pid/ret=4096.
2026-04-30T12:23:20.617: checkJavaStack starting: 2007.
2026-04-30T12:23:20.713: ------ test: 2007
2026-04-30T12:23:20.713: EXE: 5/"jstack 26101 | 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".
2026-04-30T12:23:20.928: SUC: 2007, 215ms, lines: 4096.
2026-04-30T12:23:20.929: checkJavaStack end: 2007, pid/ret=4096.
2026-04-30T12:23:30.930: checkJavaStack starting: 2007.
2026-04-30T12:23:31.022: ------ test: 2007
2026-04-30T12:23:31.022: EXE: 5/"jstack 26101 | 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".
2026-04-30T12:23:31.283: SUC: 2007, 261ms, lines: 4096.
2026-04-30T12:23:31.283: checkJavaStack end: 2007, pid/ret=4096.
2026-04-30T12:23:41.283: checkJavaStack starting: 2007.
2026-04-30T12:23:41.377: ------ test: 2007
2026-04-30T12:23:41.377: EXE: 5/"jstack 26101 | 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".
2026-04-30T12:23:41.641: SUC: 2007, 264ms, lines: 4096.
2026-04-30T12:23:41.642: checkJavaStack end: 2007, pid/ret=4096.
2026-04-30T12:23:51.643: checkJavaStack starting: 2007.
2026-04-30T12:23:51.738: ------ test: 2007
2026-04-30T12:23:51.738: EXE: 5/"jstack 26101 | 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".
2026-04-30T12:23:51.967: SUC: 2007, 229ms, lines: 4096.
2026-04-30T12:23:51.968: checkJavaStack end: 2007, pid/ret=4096.
2026-04-30T12:24:01.969: checkJavaStack starting: 2007.
2026-04-30T12:24:02.066: ------ test: 2007
2026-04-30T12:24:02.067: EXE: 5/"jstack 26101 | 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".
2026-04-30T12:24:02.340: Row 1: "https-openssl-nio-443-exec-596" #218582 daemon prio=5 os_prio=0 tid=0x00007fcd1402f800 nid=0x1baae runnable [0x00007fcd608b9000].
2026-04-30T12:24:02.340: Row 2: java.lang.Thread.State: RUNNABLE.
2026-04-30T12:24:02.340: Row 3: at java.net.SocketInputStream.socketRead0(Native Method).
2026-04-30T12:24:02.340: Row 4: at java.net.SocketInputStream.socketRead(SocketInputStream.java:116).
2026-04-30T12:24:02.340: Row 5: at java.net.SocketInputStream.read(SocketInputStream.java:171).
2026-04-30T12:24:02.340: Row 6: at java.net.SocketInputStream.read(SocketInputStream.java:141).
2026-04-30T12:24:02.341: Row 7: at sun.security.ssl.SSLSocketInputRecord.read(SSLSocketInputRecord.java:457).
2026-04-30T12:24:02.341: Row 8: at sun.security.ssl.SSLSocketInputRecord.bytesInCompletePacket(SSLSocketInputRecord.java:68).
2026-04-30T12:24:02.341: Row 9: at sun.security.ssl.SSLSocketImpl.readApplicationRecord(SSLSocketImpl.java:1332).
2026-04-30T12:24:02.341: Row 10: at sun.security.ssl.SSLSocketImpl.access$300(SSLSocketImpl.java:73).
2026-04-30T12:24:02.341: Row 11: at sun.security.ssl.SSLSocketImpl$AppInputStream.read(SSLSocketImpl.java:948).
2026-04-30T12:24:02.341: Row 12: at java.io.BufferedInputStream.fill(BufferedInputStream.java:246).
2026-04-30T12:24:02.341: Row 13: at java.io.BufferedInputStream.read1(BufferedInputStream.java:286).
2026-04-30T12:24:02.341: Row 14: at java.io.BufferedInputStream.read(BufferedInputStream.java:345).
2026-04-30T12:24:02.341: Row 15: - locked <0x0000000795a419b0> (a java.io.BufferedInputStream).
2026-04-30T12:24:02.342: Row 16: at sun.net.www.http.HttpClient.parseHTTPHeader(HttpClient.java:735).
2026-04-30T12:24:02.342: Row 17: at sun.net.www.http.HttpClient.parseHTTP(HttpClient.java:678).
2026-04-30T12:24:02.342: Row 18: at sun.net.www.protocol.http.HttpURLConnection.getInputStream0(HttpURLConnection.java:1593).
2026-04-30T12:24:02.342: Row 19: - locked <0x0000000795879668> (a sun.net.www.protocol.https.DelegateHttpsURLConnection).
2026-04-30T12:24:02.342: Row 20: at sun.net.www.protocol.http.HttpURLConnection.getInputStream(HttpURLConnection.java:1498).
2026-04-30T12:24:02.342: Row 21: - locked <0x0000000795879668> (a sun.net.www.protocol.https.DelegateHttpsURLConnection).
2026-04-30T12:24:02.342: Row 22: at java.net.HttpURLConnection.getResponseCode(HttpURLConnection.java:480).
2026-04-30T12:24:02.342: Row 23: at sun.net.www.protocol.https.HttpsURLConnectionImpl.getResponseCode(HttpsURLConnectionImpl.java:352).
2026-04-30T12:24:02.342: Row 24: at h2.jobs_educations.upload_to_dataserver(jobs_educations.java:2287).
2026-04-30T12:24:02.344: SUC: 2007, 276ms, lines: 28.
2026-04-30T12:24:02.345: checkJavaStack end: 2007, pid/ret=28.
2026-04-30T12:24:12.345: checkJavaStack starting: 2007.
2026-04-30T12:24:12.442: ------ test: 2007
2026-04-30T12:24:12.442: EXE: 5/"jstack 26101 | 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".
2026-04-30T12:24:12.741: Row 1: "https-openssl-nio-443-exec-619" #270164 daemon prio=5 os_prio=0 tid=0x00007fcd0801e000 nid=0x46d7 runnable [0x00007fcd04dcd000].
2026-04-30T12:24:12.742: Row 2: java.lang.Thread.State: RUNNABLE.
2026-04-30T12:24:12.742: Row 3: at java.net.SocketInputStream.socketRead0(Native Method).
2026-04-30T12:24:12.742: Row 4: at java.net.SocketInputStream.socketRead(SocketInputStream.java:116).
2026-04-30T12:24:12.742: Row 5: at java.net.SocketInputStream.read(SocketInputStream.java:171).
2026-04-30T12:24:12.742: Row 6: at java.net.SocketInputStream.read(SocketInputStream.java:141).
2026-04-30T12:24:12.742: Row 7: at sun.security.ssl.SSLSocketInputRecord.read(SSLSocketInputRecord.java:457).
2026-04-30T12:24:12.742: Row 8: at sun.security.ssl.SSLSocketInputRecord.bytesInCompletePacket(SSLSocketInputRecord.java:68).
2026-04-30T12:24:12.742: Row 9: at sun.security.ssl.SSLSocketImpl.readApplicationRecord(SSLSocketImpl.java:1332).
2026-04-30T12:24:12.742: Row 10: at sun.security.ssl.SSLSocketImpl.access$300(SSLSocketImpl.java:73).
2026-04-30T12:24:12.742: Row 11: at sun.security.ssl.SSLSocketImpl$AppInputStream.read(SSLSocketImpl.java:948).
2026-04-30T12:24:12.742: Row 12: at java.io.BufferedInputStream.fill(BufferedInputStream.java:246).
2026-04-30T12:24:12.742: Row 13: at java.io.BufferedInputStream.read1(BufferedInputStream.java:286).
2026-04-30T12:24:12.743: Row 14: at java.io.BufferedInputStream.read(BufferedInputStream.java:345).
2026-04-30T12:24:12.743: Row 15: - locked <0x0000000794a84818> (a java.io.BufferedInputStream).
2026-04-30T12:24:12.743: Row 16: at sun.net.www.http.HttpClient.parseHTTPHeader(HttpClient.java:735).
2026-04-30T12:24:12.743: Row 17: at sun.net.www.http.HttpClient.parseHTTP(HttpClient.java:678).
2026-04-30T12:24:12.743: Row 18: at sun.net.www.protocol.http.HttpURLConnection.getInputStream0(HttpURLConnection.java:1593).
2026-04-30T12:24:12.743: Row 19: - locked <0x00000007948b3a88> (a sun.net.www.protocol.https.DelegateHttpsURLConnection).
2026-04-30T12:24:12.743: Row 20: at sun.net.www.protocol.http.HttpURLConnection.getInputStream(HttpURLConnection.java:1498).
2026-04-30T12:24:12.743: Row 21: - locked <0x00000007948b3a88> (a sun.net.www.protocol.https.DelegateHttpsURLConnection).
2026-04-30T12:24:12.743: Row 22: at java.net.HttpURLConnection.getResponseCode(HttpURLConnection.java:480).
2026-04-30T12:24:12.743: Row 23: at sun.net.www.protocol.https.HttpsURLConnectionImpl.getResponseCode(HttpsURLConnectionImpl.java:352).
2026-04-30T12:24:12.743: Row 24: at h2.jobs_educations.upload_to_dataserver(jobs_educations.java:2287).
2026-04-30T12:24:12.746: SUC: 2007, 303ms, lines: 28.
2026-04-30T12:24:12.747: checkJavaStack end: 2007, pid/ret=28.
2026-04-30T12:24:22.747: checkJavaStack starting: 2007.
2026-04-30T12:24:22.839: ------ test: 2007
2026-04-30T12:24:22.839: EXE: 5/"jstack 26101 | 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".
2026-04-30T12:24:23.073: SUC: 2007, 234ms, lines: 4096.
2026-04-30T12:24:23.073: checkJavaStack end: 2007, pid/ret=4096.
2026-04-30T12:24:33.074: checkJavaStack starting: 2007.
2026-04-30T12:24:33.167: ------ test: 2007
2026-04-30T12:24:33.167: EXE: 5/"jstack 26101 | 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".
2026-04-30T12:24:33.413: SUC: 2007, 246ms, lines: 4096.
2026-04-30T12:24:33.414: checkJavaStack end: 2007, pid/ret=4096.
2026-04-30T12:24:43.414: checkJavaStack starting: 2007.
2026-04-30T12:24:43.508: ------ test: 2007
2026-04-30T12:24:43.508: EXE: 5/"jstack 26101 | 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".
2026-04-30T12:24:43.729: SUC: 2007, 220ms, lines: 4096.
2026-04-30T12:24:44.218: checkJavaStack end: 2007, pid/ret=4096.
2026-04-30T12:24:54.218: checkJavaStack starting: 2007.
2026-04-30T12:24:54.311: ------ test: 2007
2026-04-30T12:24:54.311: EXE: 5/"jstack 26101 | 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".
2026-04-30T12:24:54.546: SUC: 2007, 235ms, lines: 4096.
2026-04-30T12:24:54.547: checkJavaStack end: 2007, pid/ret=4096.
2026-04-30T12:25:04.548: checkJavaStack starting: 2007.
2026-04-30T12:25:04.641: ------ test: 2007
2026-04-30T12:25:04.641: EXE: 5/"jstack 26101 | 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".
2026-04-30T12:25:04.907: SUC: 2007, 266ms, lines: 4096.
2026-04-30T12:25:04.908: checkJavaStack end: 2007, pid/ret=4096.
2026-04-30T12:25:14.908: checkJavaStack starting: 2007.
2026-04-30T12:25:15.001: ------ test: 2007
2026-04-30T12:25:15.001: EXE: 5/"jstack 26101 | 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".
2026-04-30T12:25:15.221: SUC: 2007, 220ms, lines: 4096.
2026-04-30T12:25:15.222: checkJavaStack end: 2007, pid/ret=4096.
2026-04-30T12:25:25.223: checkJavaStack starting: 2007.
2026-04-30T12:25:25.316: ------ test: 2007
2026-04-30T12:25:25.316: EXE: 5/"jstack 26101 | 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".
2026-04-30T12:25:25.589: SUC: 2007, 273ms, lines: 4096.
2026-04-30T12:25:25.590: checkJavaStack end: 2007, pid/ret=4096.
2026-04-30T12:25:35.590: checkJavaStack starting: 2007.
2026-04-30T12:25:35.686: ------ test: 2007
2026-04-30T12:25:35.687: EXE: 5/"jstack 26101 | 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".
2026-04-30T12:25:35.925: SUC: 2007, 238ms, lines: 4096.
2026-04-30T12:25:35.926: checkJavaStack end: 2007, pid/ret=4096.
2026-04-30T12:25:45.926: checkJavaStack starting: 2007.
2026-04-30T12:25:46.017: ------ test: 2007
2026-04-30T12:25:46.017: EXE: 5/"jstack 26101 | 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".
2026-04-30T12:25:46.311: SUC: 2007, 294ms, lines: 4096.
2026-04-30T12:25:46.312: checkJavaStack end: 2007, pid/ret=4096.
2026-04-30T12:25:56.312: checkJavaStack starting: 2007.
2026-04-30T12:25:56.402: ------ test: 2007
2026-04-30T12:25:56.403: EXE: 5/"jstack 26101 | 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".
2026-04-30T12:25:56.624: SUC: 2007, 221ms, lines: 4096.
2026-04-30T12:25:56.625: checkJavaStack end: 2007, pid/ret=4096.
2026-04-30T12:26:06.625: checkJavaStack starting: 2007.
2026-04-30T12:26:06.721: ------ test: 2007
2026-04-30T12:26:06.721: EXE: 5/"jstack 26101 | 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".
2026-04-30T12:26:07.009: SUC: 2007, 288ms, lines: 4096.
2026-04-30T12:26:07.010: checkJavaStack end: 2007, pid/ret=4096.
2026-04-30T12:26:17.010: checkJavaStack starting: 2007.
2026-04-30T12:26:17.104: ------ test: 2007
2026-04-30T12:26:17.104: EXE: 5/"jstack 26101 | 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".
2026-04-30T12:26:17.324: SUC: 2007, 220ms, lines: 4096.
2026-04-30T12:26:17.325: checkJavaStack end: 2007, pid/ret=4096.
2026-04-30T12:26:27.330: checkJavaStack starting: 2007.
2026-04-30T12:26:27.428: ------ test: 2007
2026-04-30T12:26:27.429: EXE: 5/"jstack 26101 | 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".
2026-04-30T12:26:27.690: SUC: 2007, 260ms, lines: 4096.
2026-04-30T12:26:27.690: checkJavaStack end: 2007, pid/ret=4096.
2026-04-30T12:26:27.694: ------ test: end, 323058ms. Score 39/39.
2026-04-30T12:26:27.696: Test duration: 5m23s.