runsolver Copyright (C) 2010 Olivier ROUSSEL This is runsolver version 3.2.9a (svn: 651) This program is distributed in the hope that it will be useful, but WITHOUT ANY WARRANTY; without even the implied warranty of MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE. See the GNU General Public License for more details. command line: /home/misc2010/bin/runsolver -s SIGUSR1 -M 1124 -C 290 -d 10 -w /home/misc2010/tmp/201108241238/gj-trendy-solver-1.0/rand933.cudf.dudf-random.log.runsolver ./gj-trendy-solver-1.0 /home/misc2010/data/2011/dudf-random//rand933.cudf /home/misc2010/tmp/201108241238/gj-trendy-solver-1.0/rand933.cudf.dudf-random.result Enforcing CPUTime limit (soft limit, will send signal-name then SIGKILL): 290 seconds Enforcing CPUTime limit (hard limit, will send SIGXCPU): 320 seconds Enforcing VSIZE limit (soft limit, will send signal-name then SIGKILL): 1150976 KiB Enforcing VSIZE limit (hard limit, stack expansion will fail with SIGSEGV, brk() and mmap() will return ENOMEM): 1202176 KiB Current StackSize limit: 8192 KiB [startup+0 s] /proc/loadavg: 1.26 1.23 1.14 4/34 25668 /proc/meminfo: memFree=361532/1048576 swapFree=0/0 [pid=25667] ppid=25666 vsize=2568 CPUtime=0 /proc/25667/stat : 25667 (gj-trendy-solve) S 25666 25667 1511 34817 1511 4202496 372 0 0 0 0 0 0 0 18 0 1 0 4764680 2629632 269 1283457024 134512640 135304128 4289244320 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/25667/statm: 642 269 229 194 0 29 0 [pid=25668] ppid=25667 vsize=11048 CPUtime=0.01 /proc/25668/stat : 25668 (java) R 25667 25667 1511 34817 1511 4202496 696 0 0 0 0 1 0 0 25 0 1 0 4764680 11313152 432 1283457024 134512640 134550932 4287558192 18446744073709551615 4159653602 0 0 0 0 0 0 0 17 0 0 0 0 /proc/25668/statm: 2762 432 180 10 0 1104 0 [startup+0.155479 s] /proc/loadavg: 1.26 1.23 1.14 4/34 25668 /proc/meminfo: memFree=361532/1048576 swapFree=0/0 [pid=25667] ppid=25666 vsize=2568 CPUtime=0 /proc/25667/stat : 25667 (gj-trendy-solve) S 25666 25667 1511 34817 1511 4202496 372 0 0 0 0 0 0 0 18 0 1 0 4764680 2629632 269 1283457024 134512640 135304128 4289244320 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/25667/statm: 642 269 229 194 0 29 0 [pid=25668] ppid=25667 vsize=409804 CPUtime=0.16 /proc/25668/stat : 25668 (java) S 25667 25667 1511 34817 1511 4202496 3953 0 1 0 14 2 0 0 25 0 9 0 4764680 419639296 3381 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/25668/statm: 102451 3381 1910 10 0 96599 0 Current children cumulated CPU time (s) 0.16 Current children cumulated vsize (KiB) 412372 [startup+0.205481 s] /proc/loadavg: 1.26 1.23 1.14 4/34 25668 /proc/meminfo: memFree=361532/1048576 swapFree=0/0 [pid=25667] ppid=25666 vsize=2568 CPUtime=0 /proc/25667/stat : 25667 (gj-trendy-solve) S 25666 25667 1511 34817 1511 4202496 372 0 0 0 0 0 0 0 18 0 1 0 4764680 2629632 269 1283457024 134512640 135304128 4289244320 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/25667/statm: 642 269 229 194 0 29 0 [pid=25668] ppid=25667 vsize=409804 CPUtime=0.21 /proc/25668/stat : 25668 (java) S 25667 25667 1511 34817 1511 4202496 4063 0 1 0 19 2 0 0 25 0 9 0 4764680 419639296 3491 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/25668/statm: 102451 3491 1910 10 0 96599 0 Current children cumulated CPU time (s) 0.21 Current children cumulated vsize (KiB) 412372 [startup+0.305509 s] /proc/loadavg: 1.26 1.23 1.14 4/34 25668 /proc/meminfo: memFree=361532/1048576 swapFree=0/0 [pid=25667] ppid=25666 vsize=2568 CPUtime=0 /proc/25667/stat : 25667 (gj-trendy-solve) S 25666 25667 1511 34817 1511 4202496 372 0 0 0 0 0 0 0 18 0 1 0 4764680 2629632 269 1283457024 134512640 135304128 4289244320 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/25667/statm: 642 269 229 194 0 29 0 [pid=25668] ppid=25667 vsize=410384 CPUtime=0.31 /proc/25668/stat : 25668 (java) S 25667 25667 1511 34817 1511 4202496 4433 0 1 0 29 2 0 0 25 0 9 0 4764680 420233216 3861 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/25668/statm: 102596 3861 1933 10 0 96744 0 Current children cumulated CPU time (s) 0.31 Current children cumulated vsize (KiB) 412952 [startup+0.705632 s] /proc/loadavg: 1.26 1.23 1.14 4/34 25668 /proc/meminfo: memFree=361532/1048576 swapFree=0/0 [pid=25667] ppid=25666 vsize=2568 CPUtime=0 /proc/25667/stat : 25667 (gj-trendy-solve) S 25666 25667 1511 34817 1511 4202496 372 0 0 0 0 0 0 0 18 0 1 0 4764680 2629632 269 1283457024 134512640 135304128 4289244320 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/25667/statm: 642 269 229 194 0 29 0 [pid=25668] ppid=25667 vsize=410652 CPUtime=0.7 /proc/25668/stat : 25668 (java) S 25667 25667 1511 34817 1511 4202496 11641 0 1 0 68 2 0 0 25 0 9 0 4764680 420507648 10881 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/25668/statm: 102663 10881 2901 10 0 96811 0 Current children cumulated CPU time (s) 0.7 Current children cumulated vsize (KiB) 413220 [startup+1.50586 s] /proc/loadavg: 1.26 1.23 1.14 2/43 25677 /proc/meminfo: memFree=303664/1048576 swapFree=0/0 [pid=25667] ppid=25666 vsize=2568 CPUtime=0 /proc/25667/stat : 25667 (gj-trendy-solve) S 25666 25667 1511 34817 1511 4202496 372 0 0 0 0 0 0 0 18 0 1 0 4764680 2629632 269 1283457024 134512640 135304128 4289244320 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/25667/statm: 642 269 229 194 0 29 0 [pid=25668] ppid=25667 vsize=410784 CPUtime=1.51 /proc/25668/stat : 25668 (java) S 25667 25667 1511 34817 1511 4202496 26518 0 1 0 139 12 0 0 25 0 9 0 4764680 420642816 25758 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/25668/statm: 102696 25758 2901 10 0 96844 0 [pid=25668/tid=25670] ppid=25667 vsize=410784 CPUtime=0.85 /proc/25668/task/25670/stat : 25670 (java) R 25667 25667 1511 34817 1511 4202560 6753 0 1 0 82 3 0 0 25 0 9 0 4764681 420642816 25758 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=25668/tid=25671] ppid=25667 vsize=410784 CPUtime=0.61 /proc/25668/task/25671/stat : 25671 (java) R 25667 25667 1511 34817 1511 4202560 18376 0 0 0 54 7 0 0 18 0 9 0 4764681 420642816 25758 1283457024 134512640 134550932 4287558192 18446744073709551615 4150829984 0 0 0 16800975 0 0 0 -1 0 0 0 0 [pid=25668/tid=25672] ppid=25667 vsize=410784 CPUtime=0 /proc/25668/task/25672/stat : 25672 (java) S 25667 25667 1511 34817 1511 4202560 15 0 0 0 0 0 0 0 20 0 9 0 4764681 420642816 25758 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 [pid=25668/tid=25673] ppid=25667 vsize=410784 CPUtime=0 /proc/25668/task/25673/stat : 25673 (java) S 25667 25667 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 20 0 9 0 4764681 420642816 25758 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 [pid=25668/tid=25674] ppid=25667 vsize=410784 CPUtime=0 /proc/25668/task/25674/stat : 25674 (java) S 25667 25667 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 9 0 4764683 420642816 25758 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 [pid=25668/tid=25675] ppid=25667 vsize=410784 CPUtime=0.03 /proc/25668/task/25675/stat : 25675 (java) S 25667 25667 1511 34817 1511 4202560 448 0 0 0 3 0 0 0 16 0 9 0 4764683 420642816 25758 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 [pid=25668/tid=25676] ppid=25667 vsize=410784 CPUtime=0 /proc/25668/task/25676/stat : 25676 (java) S 25667 25667 1511 34817 1511 4202560 0 0 0 0 0 0 0 0 25 0 9 0 4764683 420642816 25758 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 [pid=25668/tid=25677] ppid=25667 vsize=410784 CPUtime=0 /proc/25668/task/25677/stat : 25677 (java) S 25667 25667 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 15 0 9 0 4764683 420642816 25758 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 1.51 Current children cumulated vsize (KiB) 413352 [startup+3.10614 s] /proc/loadavg: 1.24 1.23 1.14 2/43 25677 /proc/meminfo: memFree=231124/1048576 swapFree=0/0 [pid=25667] ppid=25666 vsize=2568 CPUtime=0 /proc/25667/stat : 25667 (gj-trendy-solve) S 25666 25667 1511 34817 1511 4202496 372 0 0 0 0 0 0 0 18 0 1 0 4764680 2629632 269 1283457024 134512640 135304128 4289244320 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/25667/statm: 642 269 229 194 0 29 0 [pid=25668] ppid=25667 vsize=410784 CPUtime=3.1 /proc/25668/stat : 25668 (java) S 25667 25667 1511 34817 1511 4202496 48357 0 1 0 293 17 0 0 25 0 9 0 4764680 420642816 47597 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/25668/statm: 102696 47597 2901 10 0 96844 0 [pid=25668/tid=25670] ppid=25667 vsize=410784 CPUtime=1.48 /proc/25668/task/25670/stat : 25670 (java) R 25667 25667 1511 34817 1511 4202560 13937 0 1 0 142 6 0 0 25 0 9 0 4764681 420642816 47597 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=25668/tid=25671] ppid=25667 vsize=410784 CPUtime=1.57 /proc/25668/task/25671/stat : 25671 (java) R 25667 25667 1511 34817 1511 4202560 33026 0 0 0 148 9 0 0 16 0 9 0 4764681 420642816 47597 1283457024 134512640 134550932 4287558192 18446744073709551615 4150532024 0 0 0 16800975 0 0 0 -1 0 0 0 0 [pid=25668/tid=25672] ppid=25667 vsize=410784 CPUtime=0 /proc/25668/task/25672/stat : 25672 (java) S 25667 25667 1511 34817 1511 4202560 15 0 0 0 0 0 0 0 20 0 9 0 4764681 420642816 47597 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 [pid=25668/tid=25673] ppid=25667 vsize=410784 CPUtime=0 /proc/25668/task/25673/stat : 25673 (java) S 25667 25667 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 20 0 9 0 4764681 420642816 47597 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 [pid=25668/tid=25674] ppid=25667 vsize=410784 CPUtime=0 /proc/25668/task/25674/stat : 25674 (java) S 25667 25667 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 9 0 4764683 420642816 47597 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 [pid=25668/tid=25675] ppid=25667 vsize=410784 CPUtime=0.03 /proc/25668/task/25675/stat : 25675 (java) S 25667 25667 1511 34817 1511 4202560 453 0 0 0 3 0 0 0 16 0 9 0 4764683 420642816 47597 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 [pid=25668/tid=25676] ppid=25667 vsize=410784 CPUtime=0 /proc/25668/task/25676/stat : 25676 (java) S 25667 25667 1511 34817 1511 4202560 0 0 0 0 0 0 0 0 25 0 9 0 4764683 420642816 47597 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 [pid=25668/tid=25677] ppid=25667 vsize=410784 CPUtime=0 /proc/25668/task/25677/stat : 25677 (java) S 25667 25667 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 15 0 9 0 4764683 420642816 47597 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 3.1 Current children cumulated vsize (KiB) 413352 [startup+6.30713 s] /proc/loadavg: 1.24 1.23 1.14 3/43 25677 /proc/meminfo: memFree=95468/1048576 swapFree=0/0 [pid=25667] ppid=25666 vsize=2568 CPUtime=0 /proc/25667/stat : 25667 (gj-trendy-solve) S 25666 25667 1511 34817 1511 4202496 372 0 0 0 0 0 0 0 18 0 1 0 4764680 2629632 269 1283457024 134512640 135304128 4289244320 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/25667/statm: 642 269 229 194 0 29 0 [pid=25668] ppid=25667 vsize=438900 CPUtime=6.28 /proc/25668/stat : 25668 (java) S 25667 25667 1511 34817 1511 4202496 77985 0 1 0 606 22 0 0 25 0 9 0 4764680 449433600 77219 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/25668/statm: 109725 77219 2903 10 0 103873 0 [pid=25668/tid=25670] ppid=25667 vsize=438900 CPUtime=2.37 /proc/25668/task/25670/stat : 25670 (java) R 25667 25667 1511 34817 1511 4202560 13954 0 1 0 231 6 0 0 25 0 9 0 4764681 449433600 77219 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=25668/tid=25671] ppid=25667 vsize=438900 CPUtime=3.86 /proc/25668/task/25671/stat : 25671 (java) R 25667 25667 1511 34817 1511 4202560 62617 0 0 0 371 15 0 0 16 0 9 0 4764681 449433600 77219 1283457024 134512640 134550932 4287558192 18446744073709551615 4152641909 0 0 0 16800975 0 0 0 -1 0 0 0 0 [pid=25668/tid=25672] ppid=25667 vsize=438900 CPUtime=0 /proc/25668/task/25672/stat : 25672 (java) S 25667 25667 1511 34817 1511 4202560 15 0 0 0 0 0 0 0 18 0 9 0 4764681 449433600 77219 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 [pid=25668/tid=25673] ppid=25667 vsize=438900 CPUtime=0 /proc/25668/task/25673/stat : 25673 (java) S 25667 25667 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 18 0 9 0 4764681 449433600 77219 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 [pid=25668/tid=25674] ppid=25667 vsize=438900 CPUtime=0 /proc/25668/task/25674/stat : 25674 (java) S 25667 25667 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 9 0 4764683 449433600 77219 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 [pid=25668/tid=25675] ppid=25667 vsize=438900 CPUtime=0.04 /proc/25668/task/25675/stat : 25675 (java) S 25667 25667 1511 34817 1511 4202560 473 0 0 0 4 0 0 0 16 0 9 0 4764683 449433600 77219 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 [pid=25668/tid=25676] ppid=25667 vsize=438900 CPUtime=0 /proc/25668/task/25676/stat : 25676 (java) S 25667 25667 1511 34817 1511 4202560 0 0 0 0 0 0 0 0 25 0 9 0 4764683 449433600 77219 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 [pid=25668/tid=25677] ppid=25667 vsize=438900 CPUtime=0 /proc/25668/task/25677/stat : 25677 (java) S 25667 25667 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 15 0 9 0 4764683 449433600 77219 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 6.28 Current children cumulated vsize (KiB) 441468 [startup+12.7093 s] /proc/loadavg: 1.44 1.27 1.15 3/43 25677 /proc/meminfo: memFree=63484/1048576 swapFree=0/0 [pid=25667] ppid=25666 vsize=2568 CPUtime=0 /proc/25667/stat : 25667 (gj-trendy-solve) S 25666 25667 1511 34817 1511 4202496 372 0 0 0 0 0 0 0 18 0 1 0 4764680 2629632 269 1283457024 134512640 135304128 4289244320 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/25667/statm: 642 269 229 194 0 29 0 [pid=25668] ppid=25667 vsize=414072 CPUtime=12.68 /proc/25668/stat : 25668 (java) S 25667 25667 1511 34817 1511 4202496 104292 0 1 0 1233 35 0 0 25 0 9 0 4764680 424009728 71209 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/25668/statm: 103518 71209 2917 10 0 97663 0 [pid=25668/tid=25670] ppid=25667 vsize=414072 CPUtime=3.26 /proc/25668/task/25670/stat : 25670 (java) R 25667 25667 1511 34817 1511 4202560 14182 0 1 0 320 6 0 0 25 0 9 0 4764681 424009728 71209 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=25668/tid=25671] ppid=25667 vsize=414072 CPUtime=9.32 /proc/25668/task/25671/stat : 25671 (java) R 25667 25667 1511 34817 1511 4202560 88663 0 0 0 904 28 0 0 16 0 9 0 4764681 424009728 71209 1283457024 134512640 134550932 4287558192 18446744073709551615 4152642146 0 0 0 16800975 0 0 0 -1 0 0 0 0 [pid=25668/tid=25672] ppid=25667 vsize=414072 CPUtime=0 /proc/25668/task/25672/stat : 25672 (java) S 25667 25667 1511 34817 1511 4202560 15 0 0 0 0 0 0 0 18 0 9 0 4764681 424009728 71209 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 [pid=25668/tid=25673] ppid=25667 vsize=414072 CPUtime=0 /proc/25668/task/25673/stat : 25673 (java) S 25667 25667 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 18 0 9 0 4764681 424009728 71209 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 [pid=25668/tid=25674] ppid=25667 vsize=414072 CPUtime=0 /proc/25668/task/25674/stat : 25674 (java) S 25667 25667 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 9 0 4764683 424009728 71209 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 [pid=25668/tid=25675] ppid=25667 vsize=414072 CPUtime=0.08 /proc/25668/task/25675/stat : 25675 (java) S 25667 25667 1511 34817 1511 4202560 506 0 0 0 8 0 0 0 15 0 9 0 4764683 424009728 71209 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 [pid=25668/tid=25676] ppid=25667 vsize=414072 CPUtime=0 /proc/25668/task/25676/stat : 25676 (java) S 25667 25667 1511 34817 1511 4202560 0 0 0 0 0 0 0 0 25 0 9 0 4764683 424009728 71209 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 [pid=25668/tid=25677] ppid=25667 vsize=414072 CPUtime=0 /proc/25668/task/25677/stat : 25677 (java) S 25667 25667 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 15 0 9 0 4764683 424009728 71209 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 12.68 Current children cumulated vsize (KiB) 416640 Solver just ended. Dumping a history of the last processes samples [startup+12.8094 s] /proc/loadavg: 1.44 1.27 1.15 3/43 25677 /proc/meminfo: memFree=63484/1048576 swapFree=0/0 [pid=25667] ppid=25666 vsize=2568 CPUtime=0 /proc/25667/stat : 25667 (gj-trendy-solve) S 25666 25667 1511 34817 1511 4202496 372 0 0 0 0 0 0 0 18 0 1 0 4764680 2629632 269 1283457024 134512640 135304128 4289244320 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/25667/statm: 642 269 229 194 0 29 0 [pid=25668] ppid=25667 vsize=414072 CPUtime=12.78 /proc/25668/stat : 25668 (java) S 25667 25667 1511 34817 1511 4202496 104292 0 1 0 1243 35 0 0 25 0 9 0 4764680 424009728 71209 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/25668/statm: 103518 71209 2917 10 0 97663 0 [pid=25668/tid=25670] ppid=25667 vsize=414072 CPUtime=3.26 /proc/25668/task/25670/stat : 25670 (java) R 25667 25667 1511 34817 1511 4202560 14182 0 1 0 320 6 0 0 25 0 9 0 4764681 424009728 71209 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=25668/tid=25671] ppid=25667 vsize=414072 CPUtime=9.42 /proc/25668/task/25671/stat : 25671 (java) R 25667 25667 1511 34817 1511 4202560 88663 0 0 0 914 28 0 0 16 0 9 0 4764681 424009728 71209 1283457024 134512640 134550932 4287558192 18446744073709551615 4150923912 0 0 0 16800975 0 0 0 -1 0 0 0 0 [pid=25668/tid=25672] ppid=25667 vsize=414072 CPUtime=0 /proc/25668/task/25672/stat : 25672 (java) S 25667 25667 1511 34817 1511 4202560 15 0 0 0 0 0 0 0 18 0 9 0 4764681 424009728 71209 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 [pid=25668/tid=25673] ppid=25667 vsize=414072 CPUtime=0 /proc/25668/task/25673/stat : 25673 (java) S 25667 25667 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 18 0 9 0 4764681 424009728 71209 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 [pid=25668/tid=25674] ppid=25667 vsize=414072 CPUtime=0 /proc/25668/task/25674/stat : 25674 (java) S 25667 25667 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 9 0 4764683 424009728 71209 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 [pid=25668/tid=25675] ppid=25667 vsize=414072 CPUtime=0.08 /proc/25668/task/25675/stat : 25675 (java) S 25667 25667 1511 34817 1511 4202560 506 0 0 0 8 0 0 0 15 0 9 0 4764683 424009728 71209 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 [pid=25668/tid=25676] ppid=25667 vsize=414072 CPUtime=0 /proc/25668/task/25676/stat : 25676 (java) S 25667 25667 1511 34817 1511 4202560 0 0 0 0 0 0 0 0 25 0 9 0 4764683 424009728 71209 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 [pid=25668/tid=25677] ppid=25667 vsize=414072 CPUtime=0 /proc/25668/task/25677/stat : 25677 (java) S 25667 25667 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 15 0 9 0 4764683 424009728 71209 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 12.78 Current children cumulated vsize (KiB) 416640 [startup+16.0103 s] /proc/loadavg: 1.44 1.27 1.15 2/44 25678 /proc/meminfo: memFree=87904/1048576 swapFree=0/0 [pid=25667] ppid=25666 vsize=2568 CPUtime=0 /proc/25667/stat : 25667 (gj-trendy-solve) S 25666 25667 1511 34817 1511 4202496 372 0 0 0 0 0 0 0 18 0 1 0 4764680 2629632 269 1283457024 134512640 135304128 4289244320 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/25667/statm: 642 269 229 194 0 29 0 [pid=25668] ppid=25667 vsize=414396 CPUtime=15.98 /proc/25668/stat : 25668 (java) S 25667 25667 1511 34817 1511 4202496 104372 0 1 0 1560 38 0 0 25 0 10 0 4764680 424341504 71285 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/25668/statm: 103599 71285 2918 10 0 97744 0 [pid=25668/tid=25670] ppid=25667 vsize=414396 CPUtime=6.28 /proc/25668/task/25670/stat : 25670 (java) R 25667 25667 1511 34817 1511 4202560 14206 0 1 0 621 7 0 0 25 0 10 0 4764681 424341504 71285 1283457024 134512640 134550932 4287558192 18446744073709551615 4115137251 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=25668/tid=25671] ppid=25667 vsize=414396 CPUtime=9.55 /proc/25668/task/25671/stat : 25671 (java) S 25667 25667 1511 34817 1511 4202560 88663 0 0 0 927 28 0 0 16 0 10 0 4764681 424341504 71285 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 0 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 [pid=25668/tid=25672] ppid=25667 vsize=414396 CPUtime=0 /proc/25668/task/25672/stat : 25672 (java) S 25667 25667 1511 34817 1511 4202560 15 0 0 0 0 0 0 0 18 0 10 0 4764681 424341504 71285 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 [pid=25668/tid=25673] ppid=25667 vsize=414396 CPUtime=0 /proc/25668/task/25673/stat : 25673 (java) S 25667 25667 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 18 0 10 0 4764681 424341504 71285 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 [pid=25668/tid=25674] ppid=25667 vsize=414396 CPUtime=0 /proc/25668/task/25674/stat : 25674 (java) S 25667 25667 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 4764683 424341504 71285 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 [pid=25668/tid=25675] ppid=25667 vsize=414396 CPUtime=0.13 /proc/25668/task/25675/stat : 25675 (java) S 25667 25667 1511 34817 1511 4202560 558 0 0 0 11 2 0 0 15 0 10 0 4764683 424341504 71285 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 [pid=25668/tid=25676] ppid=25667 vsize=414396 CPUtime=0 /proc/25668/task/25676/stat : 25676 (java) S 25667 25667 1511 34817 1511 4202560 0 0 0 0 0 0 0 0 25 0 10 0 4764683 424341504 71285 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 [pid=25668/tid=25677] ppid=25667 vsize=414396 CPUtime=0 /proc/25668/task/25677/stat : 25677 (java) S 25667 25667 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 15 0 10 0 4764683 424341504 71285 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 [pid=25668/tid=25678] ppid=25667 vsize=414396 CPUtime=0 /proc/25668/task/25678/stat : 25678 (java) S 25667 25667 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 10 0 4765983 424341504 71285 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 15.98 Current children cumulated vsize (KiB) 416964 [startup+17.6107 s] /proc/loadavg: 1.40 1.26 1.15 3/44 25678 /proc/meminfo: memFree=87904/1048576 swapFree=0/0 [pid=25667] ppid=25666 vsize=2568 CPUtime=0 /proc/25667/stat : 25667 (gj-trendy-solve) S 25666 25667 1511 34817 1511 4202496 372 0 0 0 0 0 0 0 18 0 1 0 4764680 2629632 269 1283457024 134512640 135304128 4289244320 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/25667/statm: 642 269 229 194 0 29 0 [pid=25668] ppid=25667 vsize=414396 CPUtime=17.58 /proc/25668/stat : 25668 (java) S 25667 25667 1511 34817 1511 4202496 104377 0 1 0 1720 38 0 0 25 0 10 0 4764680 424341504 71290 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/25668/statm: 103599 71290 2920 10 0 97744 0 [pid=25668/tid=25670] ppid=25667 vsize=414396 CPUtime=7.81 /proc/25668/task/25670/stat : 25670 (java) R 25667 25667 1511 34817 1511 4202560 14206 0 1 0 774 7 0 0 25 0 10 0 4764681 424341504 71290 1283457024 134512640 134550932 4287558192 18446744073709551615 4115257148 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=25668/tid=25671] ppid=25667 vsize=414396 CPUtime=9.61 /proc/25668/task/25671/stat : 25671 (java) S 25667 25667 1511 34817 1511 4202560 88665 0 0 0 933 28 0 0 16 0 10 0 4764681 424341504 71290 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 0 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 [pid=25668/tid=25672] ppid=25667 vsize=414396 CPUtime=0 /proc/25668/task/25672/stat : 25672 (java) S 25667 25667 1511 34817 1511 4202560 15 0 0 0 0 0 0 0 18 0 10 0 4764681 424341504 71290 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 [pid=25668/tid=25673] ppid=25667 vsize=414396 CPUtime=0 /proc/25668/task/25673/stat : 25673 (java) S 25667 25667 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 18 0 10 0 4764681 424341504 71290 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 [pid=25668/tid=25674] ppid=25667 vsize=414396 CPUtime=0 /proc/25668/task/25674/stat : 25674 (java) S 25667 25667 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 4764683 424341504 71290 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 [pid=25668/tid=25675] ppid=25667 vsize=414396 CPUtime=0.14 /proc/25668/task/25675/stat : 25675 (java) S 25667 25667 1511 34817 1511 4202560 561 0 0 0 12 2 0 0 15 0 10 0 4764683 424341504 71290 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 [pid=25668/tid=25676] ppid=25667 vsize=414396 CPUtime=0 /proc/25668/task/25676/stat : 25676 (java) S 25667 25667 1511 34817 1511 4202560 0 0 0 0 0 0 0 0 25 0 10 0 4764683 424341504 71290 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 [pid=25668/tid=25677] ppid=25667 vsize=414396 CPUtime=0 /proc/25668/task/25677/stat : 25677 (java) R 25667 25667 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 15 0 10 0 4764683 424341504 71290 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=25668/tid=25678] ppid=25667 vsize=414396 CPUtime=0 /proc/25668/task/25678/stat : 25678 (java) S 25667 25667 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 10 0 4765983 424341504 71290 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 17.58 Current children cumulated vsize (KiB) 416964 [startup+18.0108 s] /proc/loadavg: 1.40 1.26 1.15 3/44 25678 /proc/meminfo: memFree=87904/1048576 swapFree=0/0 [pid=25667] ppid=25666 vsize=2568 CPUtime=0 /proc/25667/stat : 25667 (gj-trendy-solve) S 25666 25667 1511 34817 1511 4202496 372 0 0 0 0 0 0 0 18 0 1 0 4764680 2629632 269 1283457024 134512640 135304128 4289244320 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/25667/statm: 642 269 229 194 0 29 0 [pid=25668] ppid=25667 vsize=414396 CPUtime=17.98 /proc/25668/stat : 25668 (java) S 25667 25667 1511 34817 1511 4202496 104377 0 1 0 1760 38 0 0 25 0 10 0 4764680 424341504 71290 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/25668/statm: 103599 71290 2920 10 0 97744 0 [pid=25668/tid=25670] ppid=25667 vsize=414396 CPUtime=8.17 /proc/25668/task/25670/stat : 25670 (java) R 25667 25667 1511 34817 1511 4202560 14206 0 1 0 810 7 0 0 25 0 10 0 4764681 424341504 71290 1283457024 134512640 134550932 4287558192 18446744073709551615 4115167660 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=25668/tid=25671] ppid=25667 vsize=414396 CPUtime=9.65 /proc/25668/task/25671/stat : 25671 (java) S 25667 25667 1511 34817 1511 4202560 88665 0 0 0 937 28 0 0 16 0 10 0 4764681 424341504 71290 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 0 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 [pid=25668/tid=25672] ppid=25667 vsize=414396 CPUtime=0 /proc/25668/task/25672/stat : 25672 (java) S 25667 25667 1511 34817 1511 4202560 15 0 0 0 0 0 0 0 18 0 10 0 4764681 424341504 71290 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 [pid=25668/tid=25673] ppid=25667 vsize=414396 CPUtime=0 /proc/25668/task/25673/stat : 25673 (java) S 25667 25667 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 18 0 10 0 4764681 424341504 71290 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 [pid=25668/tid=25674] ppid=25667 vsize=414396 CPUtime=0 /proc/25668/task/25674/stat : 25674 (java) S 25667 25667 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 4764683 424341504 71290 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 [pid=25668/tid=25675] ppid=25667 vsize=414396 CPUtime=0.14 /proc/25668/task/25675/stat : 25675 (java) S 25667 25667 1511 34817 1511 4202560 561 0 0 0 12 2 0 0 15 0 10 0 4764683 424341504 71290 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 [pid=25668/tid=25676] ppid=25667 vsize=414396 CPUtime=0 /proc/25668/task/25676/stat : 25676 (java) S 25667 25667 1511 34817 1511 4202560 0 0 0 0 0 0 0 0 25 0 10 0 4764683 424341504 71290 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 [pid=25668/tid=25677] ppid=25667 vsize=414396 CPUtime=0 /proc/25668/task/25677/stat : 25677 (java) S 25667 25667 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 15 0 10 0 4764683 424341504 71290 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 [pid=25668/tid=25678] ppid=25667 vsize=414396 CPUtime=0 /proc/25668/task/25678/stat : 25678 (java) S 25667 25667 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 10 0 4765983 424341504 71290 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 17.98 Current children cumulated vsize (KiB) 416964 [startup+18.4209 s] /proc/loadavg: 1.40 1.26 1.15 3/44 25678 /proc/meminfo: memFree=87904/1048576 swapFree=0/0 [pid=25667] ppid=25666 vsize=2568 CPUtime=0 /proc/25667/stat : 25667 (gj-trendy-solve) S 25666 25667 1511 34817 1511 4202496 372 0 0 0 0 0 0 0 18 0 1 0 4764680 2629632 269 1283457024 134512640 135304128 4289244320 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/25667/statm: 642 269 229 194 0 29 0 [pid=25668] ppid=25667 vsize=414396 CPUtime=18.38 /proc/25668/stat : 25668 (java) S 25667 25667 1511 34817 1511 4202496 104377 0 1 0 1800 38 0 0 25 0 10 0 4764680 424341504 71290 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/25668/statm: 103599 71290 2920 10 0 97744 0 [pid=25668/tid=25670] ppid=25667 vsize=414396 CPUtime=8.56 /proc/25668/task/25670/stat : 25670 (java) R 25667 25667 1511 34817 1511 4202560 14206 0 1 0 849 7 0 0 25 0 10 0 4764681 424341504 71290 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=25668/tid=25671] ppid=25667 vsize=414396 CPUtime=9.67 /proc/25668/task/25671/stat : 25671 (java) R 25667 25667 1511 34817 1511 4202560 88665 0 0 0 939 28 0 0 15 0 10 0 4764681 424341504 71290 1283457024 134512640 134550932 4287558192 18446744073709551615 4152646512 0 0 0 16800975 0 0 0 -1 0 0 0 0 [pid=25668/tid=25672] ppid=25667 vsize=414396 CPUtime=0 /proc/25668/task/25672/stat : 25672 (java) S 25667 25667 1511 34817 1511 4202560 15 0 0 0 0 0 0 0 18 0 10 0 4764681 424341504 71290 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 [pid=25668/tid=25673] ppid=25667 vsize=414396 CPUtime=0 /proc/25668/task/25673/stat : 25673 (java) S 25667 25667 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 18 0 10 0 4764681 424341504 71290 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 [pid=25668/tid=25674] ppid=25667 vsize=414396 CPUtime=0 /proc/25668/task/25674/stat : 25674 (java) S 25667 25667 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 4764683 424341504 71290 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 [pid=25668/tid=25675] ppid=25667 vsize=414396 CPUtime=0.14 /proc/25668/task/25675/stat : 25675 (java) S 25667 25667 1511 34817 1511 4202560 561 0 0 0 12 2 0 0 15 0 10 0 4764683 424341504 71290 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 [pid=25668/tid=25676] ppid=25667 vsize=414396 CPUtime=0 /proc/25668/task/25676/stat : 25676 (java) S 25667 25667 1511 34817 1511 4202560 0 0 0 0 0 0 0 0 25 0 10 0 4764683 424341504 71290 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 [pid=25668/tid=25677] ppid=25667 vsize=414396 CPUtime=0 /proc/25668/task/25677/stat : 25677 (java) S 25667 25667 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 15 0 10 0 4764683 424341504 71290 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 [pid=25668/tid=25678] ppid=25667 vsize=414396 CPUtime=0 /proc/25668/task/25678/stat : 25678 (java) S 25667 25667 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 18 0 10 0 4765983 424341504 71290 1283457024 134512640 134550932 4287558192 18446744073709551615 4294960130 0 4 0 16800975 18446612133395359680 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 18.38 Current children cumulated vsize (KiB) 416964 Child status: 0 Real time (s): 18.4715 CPU time (s): 18.4372 CPU user time (s): 18.0291 CPU system time (s): 0.408025 CPU usage (%): 99.814 Max. virtual memory (cumulated for all children) (KiB): 441652 getrusage(RUSAGE_CHILDREN,...) data: user time used= 18.0291 system time used= 0.408025 maximum resident set size= 0 integral shared memory size= 0 integral unshared data size= 0 integral unshared stack size= 0 page reclaims= 104773 page faults= 1 swaps= 0 block input operations= 0 block output operations= 0 messages sent= 0 messages received= 0 signals received= 0 voluntary context switches= 1193 involuntary context switches= 1397 runsolver used 0 second user time and 0 second system time The end