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/201012070034/p2cudf-trendy-1.9/rand550.sarge-etch-lenny.cudf.sarge-etch-lenny.log.runsolver ./p2cudf-trendy-1.9 /home/misc2010/data/icse/sarge-etch-lenny/rand550.sarge-etch-lenny.cudf /home/misc2010/tmp/201012070034/p2cudf-trendy-1.9/rand550.sarge-etch-lenny.cudf.sarge-etch-lenny.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: 0.88 0.97 1.01 1/46 20274
/proc/meminfo: memFree=742744/1048576 swapFree=2077688/2097144
[pid=20274] ppid=20273 vsize=3024 CPUtime=0
/proc/20274/stat : 20274 (runsolver) D 20273 20274 4159 34819 4229 4202560 72 0 0 0 0 0 0 0 25 0 1 0 881642875 3096576 94 1283457024 134512640 134586868 4294635728 18446744073709551615 4294960130 0 0 0 24578 18446744071564332000 0 0 17 0 0 0 0
/proc/20274/statm: 756 94 62 19 0 54 0

[startup+0.169265 s]
/proc/loadavg: 0.88 0.97 1.01 1/46 20274
/proc/meminfo: memFree=742744/1048576 swapFree=2077688/2097144
[pid=20274] ppid=20273 vsize=2572 CPUtime=0
/proc/20274/stat : 20274 (p2cudf-trendy-1) S 20273 20274 4159 34819 4229 4202496 376 0 0 0 0 0 0 0 25 0 1 0 881642875 2633728 273 1283457024 134512640 135304128 4288183168 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/20274/statm: 643 273 233 194 0 29 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 2572

[startup+0.233337 s]
/proc/loadavg: 0.88 0.97 1.01 1/46 20274
/proc/meminfo: memFree=742744/1048576 swapFree=2077688/2097144
[pid=20274] ppid=20273 vsize=2572 CPUtime=0
/proc/20274/stat : 20274 (p2cudf-trendy-1) S 20273 20274 4159 34819 4229 4202496 376 0 0 0 0 0 0 0 25 0 1 0 881642875 2633728 273 1283457024 134512640 135304128 4288183168 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/20274/statm: 643 273 233 194 0 29 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 2572

[startup+0.305243 s]
/proc/loadavg: 0.88 0.97 1.01 1/46 20274
/proc/meminfo: memFree=742744/1048576 swapFree=2077688/2097144
[pid=20274] ppid=20273 vsize=2572 CPUtime=0
/proc/20274/stat : 20274 (p2cudf-trendy-1) S 20273 20274 4159 34819 4229 4202496 376 0 0 0 0 0 0 0 25 0 1 0 881642875 2633728 273 1283457024 134512640 135304128 4288183168 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/20274/statm: 643 273 233 194 0 29 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 2572

[startup+0.705315 s]
/proc/loadavg: 0.88 0.97 1.01 1/46 20274
/proc/meminfo: memFree=742744/1048576 swapFree=2077688/2097144
[pid=20274] ppid=20273 vsize=2572 CPUtime=0
/proc/20274/stat : 20274 (p2cudf-trendy-1) S 20273 20274 4159 34819 4229 4202496 376 0 0 0 0 0 0 0 25 0 1 0 881642875 2633728 273 1283457024 134512640 135304128 4288183168 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/20274/statm: 643 273 233 194 0 29 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 2572

[startup+1.50538 s]
/proc/loadavg: 0.88 0.97 1.01 1/49 20288
/proc/meminfo: memFree=731236/1048576 swapFree=2077688/2097144
[pid=20274] ppid=20273 vsize=2572 CPUtime=0
/proc/20274/stat : 20274 (p2cudf-trendy-1) S 20273 20274 4159 34819 4229 4202496 376 0 0 0 0 0 0 0 25 0 1 0 881642875 2633728 273 1283457024 134512640 135304128 4288183168 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/20274/statm: 643 273 233 194 0 29 0
[pid=20276] ppid=20274 vsize=2580 CPUtime=0
/proc/20276/stat : 20276 (p2cudf) S 20274 20274 4159 34819 4229 4202496 394 2854 0 132 0 0 0 0 18 0 1 0 881642875 2641920 282 1283457024 134512640 135304128 4287816480 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/20276/statm: 645 282 241 194 0 31 0
[pid=20288] ppid=20276 vsize=855556 CPUtime=0.01
/proc/20288/stat : 20288 (java) S 20276 20274 4159 34819 4229 4202496 3415 0 116 0 1 0 0 0 18 0 10 0 881642975 876089344 3230 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/20288/statm: 213889 3230 1584 10 0 211007 0
Current children cumulated CPU time (s) 0.01
Current children cumulated vsize (KiB) 860708

[startup+3.10836 s]
/proc/loadavg: 0.88 0.97 1.01 3/58 20297
/proc/meminfo: memFree=711464/1048576 swapFree=2077688/2097144
[pid=20274] ppid=20273 vsize=2572 CPUtime=0
/proc/20274/stat : 20274 (p2cudf-trendy-1) S 20273 20274 4159 34819 4229 4202496 376 0 0 0 0 0 0 0 25 0 1 0 881642875 2633728 273 1283457024 134512640 135304128 4288183168 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/20274/statm: 643 273 233 194 0 29 0
[pid=20276] ppid=20274 vsize=2580 CPUtime=0
/proc/20276/stat : 20276 (p2cudf) S 20274 20274 4159 34819 4229 4202496 394 2854 0 132 0 0 0 0 18 0 1 0 881642875 2641920 282 1283457024 134512640 135304128 4287816480 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/20276/statm: 645 282 241 194 0 31 0
[pid=20288] ppid=20276 vsize=865632 CPUtime=1.17
/proc/20288/stat : 20288 (java) S 20276 20274 4159 34819 4229 4202496 21497 0 117 0 108 9 0 0 18 0 10 0 881642975 886407168 20176 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/20288/statm: 216408 20176 1743 10 0 213498 0
[pid=20288/tid=20289] ppid=20276 vsize=865632 CPUtime=0.54
/proc/20288/task/20289/stat : 20289 (java) R 20276 20274 4159 34819 4229 4202560 16406 0 41 0 46 8 0 0 20 0 10 0 881642996 886407168 20176 1283457024 134512640 134550932 4286570640 18446744073709551615 4095031153 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=20288/tid=20290] ppid=20276 vsize=865632 CPUtime=0
/proc/20288/task/20290/stat : 20290 (java) S 20276 20274 4159 34819 4229 4202560 5 0 0 0 0 0 0 0 16 0 10 0 881643006 886407168 20176 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 0 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20291] ppid=20276 vsize=865632 CPUtime=0
/proc/20288/task/20291/stat : 20291 (java) S 20276 20274 4159 34819 4229 4202560 9 0 0 0 0 0 0 0 20 0 10 0 881643007 886407168 20176 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20292] ppid=20276 vsize=865632 CPUtime=0
/proc/20288/task/20292/stat : 20292 (java) S 20276 20274 4159 34819 4229 4202560 4 0 0 0 0 0 0 0 21 0 10 0 881643007 886407168 20176 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20293] ppid=20276 vsize=865632 CPUtime=0
/proc/20288/task/20293/stat : 20293 (java) S 20276 20274 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 21 0 10 0 881643017 886407168 20176 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20294] ppid=20276 vsize=865632 CPUtime=0.62
/proc/20288/task/20294/stat : 20294 (java) S 20276 20274 4159 34819 4229 4202560 3672 0 0 0 62 0 0 0 16 0 10 0 881643017 886407168 20176 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20295] ppid=20276 vsize=865632 CPUtime=0
/proc/20288/task/20295/stat : 20295 (java) S 20276 20274 4159 34819 4229 4202560 377 0 1 0 0 0 0 0 22 0 10 0 881643018 886407168 20176 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20296] ppid=20276 vsize=865632 CPUtime=0
/proc/20288/task/20296/stat : 20296 (java) S 20276 20274 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 23 0 10 0 881643018 886407168 20176 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20297] ppid=20276 vsize=865632 CPUtime=0
/proc/20288/task/20297/stat : 20297 (java) S 20276 20274 4159 34819 4229 4202560 2 0 0 0 0 0 0 0 15 0 10 0 881643018 886407168 20176 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 1.17
Current children cumulated vsize (KiB) 870784
heavy processes:

[startup+6.31003 s]
/proc/loadavg: 0.97 0.99 1.01 2/58 20297
/proc/meminfo: memFree=452812/1048576 swapFree=2077688/2097144
[pid=20274] ppid=20273 vsize=2572 CPUtime=0
/proc/20274/stat : 20274 (p2cudf-trendy-1) S 20273 20274 4159 34819 4229 4202496 376 0 0 0 0 0 0 0 25 0 1 0 881642875 2633728 273 1283457024 134512640 135304128 4288183168 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/20274/statm: 643 273 233 194 0 29 0
[pid=20276] ppid=20274 vsize=2580 CPUtime=0
/proc/20276/stat : 20276 (p2cudf) S 20274 20274 4159 34819 4229 4202496 394 2854 0 132 0 0 0 0 18 0 1 0 881642875 2641920 282 1283457024 134512640 135304128 4287816480 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/20276/statm: 645 282 241 194 0 31 0
[pid=20288] ppid=20276 vsize=871760 CPUtime=4.21
/proc/20288/stat : 20288 (java) S 20276 20274 4159 34819 4229 4202496 73169 0 117 0 391 30 0 0 18 0 10 0 881642975 892682240 69681 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/20288/statm: 217940 69681 1767 10 0 215030 0
[pid=20288/tid=20289] ppid=20276 vsize=871760 CPUtime=1.94
/proc/20288/task/20289/stat : 20289 (java) R 20276 20274 4159 34819 4229 4202560 50359 0 41 0 170 24 0 0 25 0 10 0 881642996 892682240 69681 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=20288/tid=20290] ppid=20276 vsize=871760 CPUtime=0.32
/proc/20288/task/20290/stat : 20290 (java) S 20276 20274 4159 34819 4229 4202560 13799 0 0 0 28 4 0 0 15 0 10 0 881643006 892682240 69681 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 0 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20291] ppid=20276 vsize=871760 CPUtime=0
/proc/20288/task/20291/stat : 20291 (java) S 20276 20274 4159 34819 4229 4202560 10 0 0 0 0 0 0 0 18 0 10 0 881643007 892682240 69681 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20292] ppid=20276 vsize=871760 CPUtime=0
/proc/20288/task/20292/stat : 20292 (java) S 20276 20274 4159 34819 4229 4202560 6 0 0 0 0 0 0 0 18 0 10 0 881643007 892682240 69681 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20293] ppid=20276 vsize=871760 CPUtime=0
/proc/20288/task/20293/stat : 20293 (java) S 20276 20274 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 21 0 10 0 881643017 892682240 69681 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20294] ppid=20276 vsize=871760 CPUtime=1.92
/proc/20288/task/20294/stat : 20294 (java) S 20276 20274 4159 34819 4229 4202560 7594 0 0 0 192 0 0 0 15 0 10 0 881643017 892682240 69681 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20295] ppid=20276 vsize=871760 CPUtime=0
/proc/20288/task/20295/stat : 20295 (java) S 20276 20274 4159 34819 4229 4202560 377 0 1 0 0 0 0 0 22 0 10 0 881643018 892682240 69681 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20296] ppid=20276 vsize=871760 CPUtime=0
/proc/20288/task/20296/stat : 20296 (java) S 20276 20274 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 23 0 10 0 881643018 892682240 69681 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20297] ppid=20276 vsize=871760 CPUtime=0
/proc/20288/task/20297/stat : 20297 (java) S 20276 20274 4159 34819 4229 4202560 2 0 0 0 0 0 0 0 15 0 10 0 881643018 892682240 69681 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 4.21
Current children cumulated vsize (KiB) 876912
heavy processes:

[startup+12.7097 s]
/proc/loadavg: 0.97 0.99 1.01 2/59 20314
/proc/meminfo: memFree=410776/1048576 swapFree=2077688/2097144
[pid=20274] ppid=20273 vsize=2572 CPUtime=0
/proc/20274/stat : 20274 (p2cudf-trendy-1) S 20273 20274 4159 34819 4229 4202496 376 0 0 0 0 0 0 0 25 0 1 0 881642875 2633728 273 1283457024 134512640 135304128 4288183168 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/20274/statm: 643 273 233 194 0 29 0
[pid=20276] ppid=20274 vsize=2580 CPUtime=0
/proc/20276/stat : 20276 (p2cudf) S 20274 20274 4159 34819 4229 4202496 394 2854 0 132 0 0 0 0 18 0 1 0 881642875 2641920 282 1283457024 134512640 135304128 4287816480 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/20276/statm: 645 282 241 194 0 31 0
[pid=20288] ppid=20276 vsize=873056 CPUtime=10.59
/proc/20288/stat : 20288 (java) S 20276 20274 4159 34819 4229 4202496 88374 0 117 0 1025 34 0 0 18 0 11 0 881642975 894009344 84886 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/20288/statm: 218264 84886 1794 10 0 215354 0
[pid=20288/tid=20289] ppid=20276 vsize=873056 CPUtime=6.81
/proc/20288/task/20289/stat : 20289 (java) R 20276 20274 4159 34819 4229 4202560 50379 0 41 0 657 24 0 0 25 0 11 0 881642996 894009344 84886 1283457024 134512640 134550932 4286570640 18446744073709551615 4096066849 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=20288/tid=20290] ppid=20276 vsize=873056 CPUtime=0.91
/proc/20288/task/20290/stat : 20290 (java) S 20276 20274 4159 34819 4229 4202560 28851 0 0 0 82 9 0 0 16 0 11 0 881643006 894009344 84886 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 0 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20291] ppid=20276 vsize=873056 CPUtime=0
/proc/20288/task/20291/stat : 20291 (java) S 20276 20274 4159 34819 4229 4202560 10 0 0 0 0 0 0 0 15 0 11 0 881643007 894009344 84886 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20292] ppid=20276 vsize=873056 CPUtime=0
/proc/20288/task/20292/stat : 20292 (java) S 20276 20274 4159 34819 4229 4202560 6 0 0 0 0 0 0 0 15 0 11 0 881643007 894009344 84886 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20293] ppid=20276 vsize=873056 CPUtime=0
/proc/20288/task/20293/stat : 20293 (java) S 20276 20274 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 21 0 11 0 881643017 894009344 84886 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20294] ppid=20276 vsize=873056 CPUtime=2.84
/proc/20288/task/20294/stat : 20294 (java) S 20276 20274 4159 34819 4229 4202560 7711 0 0 0 284 0 0 0 16 0 11 0 881643017 894009344 84886 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20295] ppid=20276 vsize=873056 CPUtime=0
/proc/20288/task/20295/stat : 20295 (java) S 20276 20274 4159 34819 4229 4202560 377 0 1 0 0 0 0 0 22 0 11 0 881643018 894009344 84886 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20296] ppid=20276 vsize=873056 CPUtime=0
/proc/20288/task/20296/stat : 20296 (java) S 20276 20274 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 23 0 11 0 881643018 894009344 84886 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20297] ppid=20276 vsize=873056 CPUtime=0
/proc/20288/task/20297/stat : 20297 (java) S 20276 20274 4159 34819 4229 4202560 2 0 0 0 0 0 0 0 15 0 11 0 881643018 894009344 84886 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 10.59
Current children cumulated vsize (KiB) 878208

[startup+25.5128 s]
/proc/loadavg: 1.18 1.03 1.03 2/59 20318
/proc/meminfo: memFree=390812/1048576 swapFree=2077688/2097144
[pid=20274] ppid=20273 vsize=2572 CPUtime=0
/proc/20274/stat : 20274 (p2cudf-trendy-1) S 20273 20274 4159 34819 4229 4202496 376 0 0 0 0 0 0 0 25 0 1 0 881642875 2633728 273 1283457024 134512640 135304128 4288183168 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/20274/statm: 643 273 233 194 0 29 0
[pid=20276] ppid=20274 vsize=2580 CPUtime=0
/proc/20276/stat : 20276 (p2cudf) S 20274 20274 4159 34819 4229 4202496 394 2854 0 132 0 0 0 0 18 0 1 0 881642875 2641920 282 1283457024 134512640 135304128 4287816480 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/20276/statm: 645 282 241 194 0 31 0
[pid=20288] ppid=20276 vsize=871936 CPUtime=23.39
/proc/20288/stat : 20288 (java) S 20276 20274 4159 34819 4229 4202496 88779 0 117 0 2305 34 0 0 18 0 11 0 881642975 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/20288/statm: 217984 85035 1794 10 0 215074 0
[pid=20288/tid=20289] ppid=20276 vsize=871936 CPUtime=19.01
/proc/20288/task/20289/stat : 20289 (java) R 20276 20274 4159 34819 4229 4202560 50380 0 41 0 1877 24 0 0 25 0 11 0 881642996 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4095909104 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=20288/tid=20290] ppid=20276 vsize=871936 CPUtime=1.43
/proc/20288/task/20290/stat : 20290 (java) S 20276 20274 4159 34819 4229 4202560 29255 0 0 0 134 9 0 0 15 0 11 0 881643006 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 0 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20291] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20291/stat : 20291 (java) S 20276 20274 4159 34819 4229 4202560 10 0 0 0 0 0 0 0 15 0 11 0 881643007 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20292] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20292/stat : 20292 (java) S 20276 20274 4159 34819 4229 4202560 6 0 0 0 0 0 0 0 15 0 11 0 881643007 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20293] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20293/stat : 20293 (java) S 20276 20274 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 21 0 11 0 881643017 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20294] ppid=20276 vsize=871936 CPUtime=2.93
/proc/20288/task/20294/stat : 20294 (java) S 20276 20274 4159 34819 4229 4202560 7711 0 0 0 293 0 0 0 15 0 11 0 881643017 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20295] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20295/stat : 20295 (java) S 20276 20274 4159 34819 4229 4202560 377 0 1 0 0 0 0 0 22 0 11 0 881643018 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20296] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20296/stat : 20296 (java) S 20276 20274 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 23 0 11 0 881643018 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20297] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20297/stat : 20297 (java) S 20276 20274 4159 34819 4229 4202560 2 0 0 0 0 0 0 0 15 0 11 0 881643018 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20318] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20318/stat : 20318 (java) S 20276 20274 4159 34819 4229 4202560 0 0 0 0 0 0 0 0 25 0 11 0 881644508 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 23.39
Current children cumulated vsize (KiB) 877088

[startup+51.1104 s]
/proc/loadavg: 1.20 1.05 1.03 2/59 20318
/proc/meminfo: memFree=390564/1048576 swapFree=2077688/2097144
[pid=20274] ppid=20273 vsize=2572 CPUtime=0
/proc/20274/stat : 20274 (p2cudf-trendy-1) S 20273 20274 4159 34819 4229 4202496 376 0 0 0 0 0 0 0 25 0 1 0 881642875 2633728 273 1283457024 134512640 135304128 4288183168 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/20274/statm: 643 273 233 194 0 29 0
[pid=20276] ppid=20274 vsize=2580 CPUtime=0
/proc/20276/stat : 20276 (p2cudf) S 20274 20274 4159 34819 4229 4202496 394 2854 0 132 0 0 0 0 18 0 1 0 881642875 2641920 282 1283457024 134512640 135304128 4287816480 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/20276/statm: 645 282 241 194 0 31 0
[pid=20288] ppid=20276 vsize=871936 CPUtime=48.95
/proc/20288/stat : 20288 (java) S 20276 20274 4159 34819 4229 4202496 88779 0 117 0 4861 34 0 0 18 0 11 0 881642975 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/20288/statm: 217984 85035 1794 10 0 215074 0
[pid=20288/tid=20289] ppid=20276 vsize=871936 CPUtime=43.93
/proc/20288/task/20289/stat : 20289 (java) R 20276 20274 4159 34819 4229 4202560 50380 0 41 0 4369 24 0 0 25 0 11 0 881642996 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4095879508 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=20288/tid=20290] ppid=20276 vsize=871936 CPUtime=2.02
/proc/20288/task/20290/stat : 20290 (java) S 20276 20274 4159 34819 4229 4202560 29255 0 0 0 193 9 0 0 15 0 11 0 881643006 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 0 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20291] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20291/stat : 20291 (java) S 20276 20274 4159 34819 4229 4202560 10 0 0 0 0 0 0 0 15 0 11 0 881643007 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20292] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20292/stat : 20292 (java) S 20276 20274 4159 34819 4229 4202560 6 0 0 0 0 0 0 0 15 0 11 0 881643007 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20293] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20293/stat : 20293 (java) S 20276 20274 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 21 0 11 0 881643017 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20294] ppid=20276 vsize=871936 CPUtime=2.97
/proc/20288/task/20294/stat : 20294 (java) S 20276 20274 4159 34819 4229 4202560 7711 0 0 0 297 0 0 0 15 0 11 0 881643017 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20295] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20295/stat : 20295 (java) S 20276 20274 4159 34819 4229 4202560 377 0 1 0 0 0 0 0 22 0 11 0 881643018 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20296] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20296/stat : 20296 (java) S 20276 20274 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 23 0 11 0 881643018 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20297] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20297/stat : 20297 (java) S 20276 20274 4159 34819 4229 4202560 2 0 0 0 0 0 0 0 15 0 11 0 881643018 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20318] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20318/stat : 20318 (java) S 20276 20274 4159 34819 4229 4202560 0 0 0 0 0 0 0 0 25 0 11 0 881644508 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 48.95
Current children cumulated vsize (KiB) 877088

[startup+102.313 s]
/proc/loadavg: 1.24 1.08 1.04 2/59 20318
/proc/meminfo: memFree=390564/1048576 swapFree=2077688/2097144
[pid=20274] ppid=20273 vsize=2572 CPUtime=0
/proc/20274/stat : 20274 (p2cudf-trendy-1) S 20273 20274 4159 34819 4229 4202496 376 0 0 0 0 0 0 0 25 0 1 0 881642875 2633728 273 1283457024 134512640 135304128 4288183168 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/20274/statm: 643 273 233 194 0 29 0
[pid=20276] ppid=20274 vsize=2580 CPUtime=0
/proc/20276/stat : 20276 (p2cudf) S 20274 20274 4159 34819 4229 4202496 394 2854 0 132 0 0 0 0 18 0 1 0 881642875 2641920 282 1283457024 134512640 135304128 4287816480 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/20276/statm: 645 282 241 194 0 31 0
[pid=20288] ppid=20276 vsize=871936 CPUtime=100.11
/proc/20288/stat : 20288 (java) S 20276 20274 4159 34819 4229 4202496 88779 0 117 0 9976 35 0 0 18 0 11 0 881642975 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/20288/statm: 217984 85035 1794 10 0 215074 0
[pid=20288/tid=20289] ppid=20276 vsize=871936 CPUtime=94.05
/proc/20288/task/20289/stat : 20289 (java) R 20276 20274 4159 34819 4229 4202560 50380 0 41 0 9380 25 0 0 25 0 11 0 881642996 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4096066849 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=20288/tid=20290] ppid=20276 vsize=871936 CPUtime=3.06
/proc/20288/task/20290/stat : 20290 (java) S 20276 20274 4159 34819 4229 4202560 29255 0 0 0 297 9 0 0 15 0 11 0 881643006 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 0 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20291] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20291/stat : 20291 (java) S 20276 20274 4159 34819 4229 4202560 10 0 0 0 0 0 0 0 15 0 11 0 881643007 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20292] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20292/stat : 20292 (java) S 20276 20274 4159 34819 4229 4202560 6 0 0 0 0 0 0 0 15 0 11 0 881643007 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20293] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20293/stat : 20293 (java) S 20276 20274 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 21 0 11 0 881643017 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20294] ppid=20276 vsize=871936 CPUtime=2.97
/proc/20288/task/20294/stat : 20294 (java) S 20276 20274 4159 34819 4229 4202560 7711 0 0 0 297 0 0 0 15 0 11 0 881643017 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20295] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20295/stat : 20295 (java) S 20276 20274 4159 34819 4229 4202560 377 0 1 0 0 0 0 0 22 0 11 0 881643018 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20296] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20296/stat : 20296 (java) S 20276 20274 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 23 0 11 0 881643018 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20297] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20297/stat : 20297 (java) S 20276 20274 4159 34819 4229 4202560 2 0 0 0 0 0 0 0 15 0 11 0 881643018 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20318] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20318/stat : 20318 (java) S 20276 20274 4159 34819 4229 4202560 0 0 0 0 0 0 0 0 25 0 11 0 881644508 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 100.11
Current children cumulated vsize (KiB) 877088

Solver just ended. Dumping a history of the last processes samples

[startup+115.006 s]
/proc/loadavg: 1.25 1.09 1.05 2/59 20318
/proc/meminfo: memFree=390564/1048576 swapFree=2077688/2097144
[pid=20274] ppid=20273 vsize=2572 CPUtime=0
/proc/20274/stat : 20274 (p2cudf-trendy-1) S 20273 20274 4159 34819 4229 4202496 376 0 0 0 0 0 0 0 25 0 1 0 881642875 2633728 273 1283457024 134512640 135304128 4288183168 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/20274/statm: 643 273 233 194 0 29 0
[pid=20276] ppid=20274 vsize=2580 CPUtime=0
/proc/20276/stat : 20276 (p2cudf) S 20274 20274 4159 34819 4229 4202496 394 2854 0 132 0 0 0 0 18 0 1 0 881642875 2641920 282 1283457024 134512640 135304128 4287816480 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/20276/statm: 645 282 241 194 0 31 0
[pid=20288] ppid=20276 vsize=871936 CPUtime=112.79
/proc/20288/stat : 20288 (java) S 20276 20274 4159 34819 4229 4202496 88779 0 117 0 11244 35 0 0 18 0 11 0 881642975 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/20288/statm: 217984 85035 1794 10 0 215074 0
[pid=20288/tid=20289] ppid=20276 vsize=871936 CPUtime=106.48
/proc/20288/task/20289/stat : 20289 (java) R 20276 20274 4159 34819 4229 4202560 50380 0 41 0 10623 25 0 0 25 0 11 0 881642996 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4095885843 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=20288/tid=20290] ppid=20276 vsize=871936 CPUtime=3.32
/proc/20288/task/20290/stat : 20290 (java) S 20276 20274 4159 34819 4229 4202560 29255 0 0 0 323 9 0 0 15 0 11 0 881643006 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 0 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20291] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20291/stat : 20291 (java) S 20276 20274 4159 34819 4229 4202560 10 0 0 0 0 0 0 0 15 0 11 0 881643007 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20292] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20292/stat : 20292 (java) S 20276 20274 4159 34819 4229 4202560 6 0 0 0 0 0 0 0 15 0 11 0 881643007 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20293] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20293/stat : 20293 (java) S 20276 20274 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 21 0 11 0 881643017 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20294] ppid=20276 vsize=871936 CPUtime=2.97
/proc/20288/task/20294/stat : 20294 (java) S 20276 20274 4159 34819 4229 4202560 7711 0 0 0 297 0 0 0 15 0 11 0 881643017 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20295] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20295/stat : 20295 (java) S 20276 20274 4159 34819 4229 4202560 377 0 1 0 0 0 0 0 22 0 11 0 881643018 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20296] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20296/stat : 20296 (java) S 20276 20274 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 23 0 11 0 881643018 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20297] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20297/stat : 20297 (java) S 20276 20274 4159 34819 4229 4202560 2 0 0 0 0 0 0 0 15 0 11 0 881643018 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20318] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20318/stat : 20318 (java) S 20276 20274 4159 34819 4229 4202560 0 0 0 0 0 0 0 0 25 0 11 0 881644508 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 112.79
Current children cumulated vsize (KiB) 877088

[startup+121.407 s]
/proc/loadavg: 1.23 1.09 1.05 2/59 20318
/proc/meminfo: memFree=390564/1048576 swapFree=2077688/2097144
[pid=20274] ppid=20273 vsize=2572 CPUtime=0
/proc/20274/stat : 20274 (p2cudf-trendy-1) S 20273 20274 4159 34819 4229 4202496 376 0 0 0 0 0 0 0 25 0 1 0 881642875 2633728 273 1283457024 134512640 135304128 4288183168 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/20274/statm: 643 273 233 194 0 29 0
[pid=20276] ppid=20274 vsize=2580 CPUtime=0
/proc/20276/stat : 20276 (p2cudf) S 20274 20274 4159 34819 4229 4202496 394 2854 0 132 0 0 0 0 18 0 1 0 881642875 2641920 282 1283457024 134512640 135304128 4287816480 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/20276/statm: 645 282 241 194 0 31 0
[pid=20288] ppid=20276 vsize=871936 CPUtime=119.18
/proc/20288/stat : 20288 (java) S 20276 20274 4159 34819 4229 4202496 88779 0 117 0 11883 35 0 0 18 0 11 0 881642975 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/20288/statm: 217984 85035 1794 10 0 215074 0
[pid=20288/tid=20289] ppid=20276 vsize=871936 CPUtime=112.86
/proc/20288/task/20289/stat : 20289 (java) R 20276 20274 4159 34819 4229 4202560 50380 0 41 0 11261 25 0 0 25 0 11 0 881642996 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4095879519 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=20288/tid=20290] ppid=20276 vsize=871936 CPUtime=3.32
/proc/20288/task/20290/stat : 20290 (java) S 20276 20274 4159 34819 4229 4202560 29255 0 0 0 323 9 0 0 15 0 11 0 881643006 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 0 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20291] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20291/stat : 20291 (java) S 20276 20274 4159 34819 4229 4202560 10 0 0 0 0 0 0 0 15 0 11 0 881643007 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20292] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20292/stat : 20292 (java) S 20276 20274 4159 34819 4229 4202560 6 0 0 0 0 0 0 0 15 0 11 0 881643007 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20293] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20293/stat : 20293 (java) S 20276 20274 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 21 0 11 0 881643017 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20294] ppid=20276 vsize=871936 CPUtime=2.97
/proc/20288/task/20294/stat : 20294 (java) S 20276 20274 4159 34819 4229 4202560 7711 0 0 0 297 0 0 0 15 0 11 0 881643017 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20295] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20295/stat : 20295 (java) S 20276 20274 4159 34819 4229 4202560 377 0 1 0 0 0 0 0 22 0 11 0 881643018 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20296] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20296/stat : 20296 (java) S 20276 20274 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 23 0 11 0 881643018 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20297] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20297/stat : 20297 (java) S 20276 20274 4159 34819 4229 4202560 2 0 0 0 0 0 0 0 15 0 11 0 881643018 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20318] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20318/stat : 20318 (java) S 20276 20274 4159 34819 4229 4202560 0 0 0 0 0 0 0 0 25 0 11 0 881644508 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 119.18
Current children cumulated vsize (KiB) 877088

[startup+124.608 s]
/proc/loadavg: 1.21 1.09 1.04 2/59 20318
/proc/meminfo: memFree=390564/1048576 swapFree=2077688/2097144
[pid=20274] ppid=20273 vsize=2572 CPUtime=0
/proc/20274/stat : 20274 (p2cudf-trendy-1) S 20273 20274 4159 34819 4229 4202496 376 0 0 0 0 0 0 0 25 0 1 0 881642875 2633728 273 1283457024 134512640 135304128 4288183168 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/20274/statm: 643 273 233 194 0 29 0
[pid=20276] ppid=20274 vsize=2580 CPUtime=0
/proc/20276/stat : 20276 (p2cudf) S 20274 20274 4159 34819 4229 4202496 394 2854 0 132 0 0 0 0 18 0 1 0 881642875 2641920 282 1283457024 134512640 135304128 4287816480 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/20276/statm: 645 282 241 194 0 31 0
[pid=20288] ppid=20276 vsize=871936 CPUtime=122.38
/proc/20288/stat : 20288 (java) S 20276 20274 4159 34819 4229 4202496 88779 0 117 0 12203 35 0 0 18 0 11 0 881642975 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/20288/statm: 217984 85035 1794 10 0 215074 0
[pid=20288/tid=20289] ppid=20276 vsize=871936 CPUtime=116.06
/proc/20288/task/20289/stat : 20289 (java) R 20276 20274 4159 34819 4229 4202560 50380 0 41 0 11581 25 0 0 25 0 11 0 881642996 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4095961300 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=20288/tid=20290] ppid=20276 vsize=871936 CPUtime=3.32
/proc/20288/task/20290/stat : 20290 (java) S 20276 20274 4159 34819 4229 4202560 29255 0 0 0 323 9 0 0 15 0 11 0 881643006 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 0 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20291] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20291/stat : 20291 (java) S 20276 20274 4159 34819 4229 4202560 10 0 0 0 0 0 0 0 15 0 11 0 881643007 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20292] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20292/stat : 20292 (java) S 20276 20274 4159 34819 4229 4202560 6 0 0 0 0 0 0 0 15 0 11 0 881643007 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20293] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20293/stat : 20293 (java) S 20276 20274 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 21 0 11 0 881643017 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20294] ppid=20276 vsize=871936 CPUtime=2.97
/proc/20288/task/20294/stat : 20294 (java) S 20276 20274 4159 34819 4229 4202560 7711 0 0 0 297 0 0 0 15 0 11 0 881643017 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20295] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20295/stat : 20295 (java) S 20276 20274 4159 34819 4229 4202560 377 0 1 0 0 0 0 0 22 0 11 0 881643018 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20296] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20296/stat : 20296 (java) S 20276 20274 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 23 0 11 0 881643018 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20297] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20297/stat : 20297 (java) S 20276 20274 4159 34819 4229 4202560 2 0 0 0 0 0 0 0 15 0 11 0 881643018 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20318] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20318/stat : 20318 (java) S 20276 20274 4159 34819 4229 4202560 0 0 0 0 0 0 0 0 25 0 11 0 881644508 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 122.38
Current children cumulated vsize (KiB) 877088

[startup+126.208 s]
/proc/loadavg: 1.21 1.09 1.04 2/59 20318
/proc/meminfo: memFree=390564/1048576 swapFree=2077688/2097144
[pid=20274] ppid=20273 vsize=2572 CPUtime=0
/proc/20274/stat : 20274 (p2cudf-trendy-1) S 20273 20274 4159 34819 4229 4202496 376 0 0 0 0 0 0 0 25 0 1 0 881642875 2633728 273 1283457024 134512640 135304128 4288183168 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/20274/statm: 643 273 233 194 0 29 0
[pid=20276] ppid=20274 vsize=2580 CPUtime=0
/proc/20276/stat : 20276 (p2cudf) S 20274 20274 4159 34819 4229 4202496 394 2854 0 132 0 0 0 0 18 0 1 0 881642875 2641920 282 1283457024 134512640 135304128 4287816480 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/20276/statm: 645 282 241 194 0 31 0
[pid=20288] ppid=20276 vsize=871936 CPUtime=123.98
/proc/20288/stat : 20288 (java) S 20276 20274 4159 34819 4229 4202496 88779 0 117 0 12363 35 0 0 18 0 11 0 881642975 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/20288/statm: 217984 85035 1794 10 0 215074 0
[pid=20288/tid=20289] ppid=20276 vsize=871936 CPUtime=117.66
/proc/20288/task/20289/stat : 20289 (java) R 20276 20274 4159 34819 4229 4202560 50380 0 41 0 11741 25 0 0 25 0 11 0 881642996 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4096066981 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=20288/tid=20290] ppid=20276 vsize=871936 CPUtime=3.32
/proc/20288/task/20290/stat : 20290 (java) S 20276 20274 4159 34819 4229 4202560 29255 0 0 0 323 9 0 0 15 0 11 0 881643006 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 0 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20291] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20291/stat : 20291 (java) S 20276 20274 4159 34819 4229 4202560 10 0 0 0 0 0 0 0 15 0 11 0 881643007 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20292] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20292/stat : 20292 (java) S 20276 20274 4159 34819 4229 4202560 6 0 0 0 0 0 0 0 15 0 11 0 881643007 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20293] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20293/stat : 20293 (java) S 20276 20274 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 21 0 11 0 881643017 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20294] ppid=20276 vsize=871936 CPUtime=2.97
/proc/20288/task/20294/stat : 20294 (java) S 20276 20274 4159 34819 4229 4202560 7711 0 0 0 297 0 0 0 15 0 11 0 881643017 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20295] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20295/stat : 20295 (java) S 20276 20274 4159 34819 4229 4202560 377 0 1 0 0 0 0 0 22 0 11 0 881643018 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20296] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20296/stat : 20296 (java) S 20276 20274 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 23 0 11 0 881643018 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20297] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20297/stat : 20297 (java) S 20276 20274 4159 34819 4229 4202560 2 0 0 0 0 0 0 0 15 0 11 0 881643018 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20318] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20318/stat : 20318 (java) S 20276 20274 4159 34819 4229 4202560 0 0 0 0 0 0 0 0 25 0 11 0 881644508 892862464 85035 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 123.98
Current children cumulated vsize (KiB) 877088

[startup+127.005 s]
/proc/loadavg: 1.21 1.09 1.04 3/59 20318
/proc/meminfo: memFree=390564/1048576 swapFree=2077688/2097144
[pid=20274] ppid=20273 vsize=2572 CPUtime=0
/proc/20274/stat : 20274 (p2cudf-trendy-1) S 20273 20274 4159 34819 4229 4202496 376 0 0 0 0 0 0 0 25 0 1 0 881642875 2633728 273 1283457024 134512640 135304128 4288183168 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/20274/statm: 643 273 233 194 0 29 0
[pid=20276] ppid=20274 vsize=2580 CPUtime=0
/proc/20276/stat : 20276 (p2cudf) S 20274 20274 4159 34819 4229 4202496 394 2854 0 132 0 0 0 0 18 0 1 0 881642875 2641920 282 1283457024 134512640 135304128 4287816480 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/20276/statm: 645 282 241 194 0 31 0
[pid=20288] ppid=20276 vsize=871936 CPUtime=124.56
/proc/20288/stat : 20288 (java) S 20276 20274 4159 34819 4229 4202496 88785 0 117 0 12421 35 0 0 18 0 11 0 881642975 892862464 85041 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/20288/statm: 217984 85041 1794 10 0 215074 0
[pid=20288/tid=20289] ppid=20276 vsize=871936 CPUtime=118.21
/proc/20288/task/20289/stat : 20289 (java) S 20276 20274 4159 34819 4229 4202560 50386 0 41 0 11796 25 0 0 25 0 11 0 881642996 892862464 85041 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20290] ppid=20276 vsize=871936 CPUtime=3.32
/proc/20288/task/20290/stat : 20290 (java) S 20276 20274 4159 34819 4229 4202560 29255 0 0 0 323 9 0 0 15 0 11 0 881643006 892862464 85041 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 0 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20291] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20291/stat : 20291 (java) S 20276 20274 4159 34819 4229 4202560 10 0 0 0 0 0 0 0 15 0 11 0 881643007 892862464 85041 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20292] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20292/stat : 20292 (java) S 20276 20274 4159 34819 4229 4202560 6 0 0 0 0 0 0 0 15 0 11 0 881643007 892862464 85041 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20293] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20293/stat : 20293 (java) S 20276 20274 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 21 0 11 0 881643017 892862464 85041 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20294] ppid=20276 vsize=871936 CPUtime=3
/proc/20288/task/20294/stat : 20294 (java) S 20276 20274 4159 34819 4229 4202560 7711 0 0 0 300 0 0 0 15 0 11 0 881643017 892862464 85041 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20295] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20295/stat : 20295 (java) S 20276 20274 4159 34819 4229 4202560 377 0 1 0 0 0 0 0 22 0 11 0 881643018 892862464 85041 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20296] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20296/stat : 20296 (java) S 20276 20274 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 23 0 11 0 881643018 892862464 85041 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20297] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20297/stat : 20297 (java) S 20276 20274 4159 34819 4229 4202560 2 0 0 0 0 0 0 0 15 0 11 0 881643018 892862464 85041 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 124.56
Current children cumulated vsize (KiB) 877088

[startup+127.405 s]
/proc/loadavg: 1.12 1.07 1.04 1/58 20319
/proc/meminfo: memFree=390512/1048576 swapFree=2077688/2097144
[pid=20274] ppid=20273 vsize=2572 CPUtime=0
/proc/20274/stat : 20274 (p2cudf-trendy-1) S 20273 20274 4159 34819 4229 4202496 376 0 0 0 0 0 0 0 25 0 1 0 881642875 2633728 273 1283457024 134512640 135304128 4288183168 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/20274/statm: 643 273 233 194 0 29 0
[pid=20276] ppid=20274 vsize=2580 CPUtime=0
/proc/20276/stat : 20276 (p2cudf) S 20274 20274 4159 34819 4229 4202496 394 2854 0 132 0 0 0 0 18 0 1 0 881642875 2641920 282 1283457024 134512640 135304128 4287816480 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/20276/statm: 645 282 241 194 0 31 0
[pid=20288] ppid=20276 vsize=871936 CPUtime=124.63
/proc/20288/stat : 20288 (java) S 20276 20274 4159 34819 4229 4202496 88786 0 117 0 12426 37 0 0 18 0 10 0 881642975 892862464 85042 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/20288/statm: 217984 85042 1794 10 0 215074 0
[pid=20288/tid=20289] ppid=20276 vsize=871936 CPUtime=118.21
/proc/20288/task/20289/stat : 20289 (java) S 20276 20274 4159 34819 4229 4202560 50386 0 41 0 11796 25 0 0 20 0 10 0 881642996 892862464 85042 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20290] ppid=20276 vsize=871936 CPUtime=3.32
/proc/20288/task/20290/stat : 20290 (java) S 20276 20274 4159 34819 4229 4202560 29255 0 0 0 323 9 0 0 15 0 10 0 881643006 892862464 85042 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 0 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20291] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20291/stat : 20291 (java) S 20276 20274 4159 34819 4229 4202560 10 0 0 0 0 0 0 0 15 0 10 0 881643007 892862464 85042 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20292] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20292/stat : 20292 (java) S 20276 20274 4159 34819 4229 4202560 6 0 0 0 0 0 0 0 15 0 10 0 881643007 892862464 85042 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20293] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20293/stat : 20293 (java) S 20276 20274 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 21 0 10 0 881643017 892862464 85042 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20294] ppid=20276 vsize=871936 CPUtime=3
/proc/20288/task/20294/stat : 20294 (java) S 20276 20274 4159 34819 4229 4202560 7711 0 0 0 300 0 0 0 15 0 10 0 881643017 892862464 85042 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20295] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20295/stat : 20295 (java) S 20276 20274 4159 34819 4229 4202560 377 0 1 0 0 0 0 0 22 0 10 0 881643018 892862464 85042 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20296] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20296/stat : 20296 (java) S 20276 20274 4159 34819 4229 4202560 1 0 0 0 0 0 0 0 23 0 10 0 881643018 892862464 85042 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
[pid=20288/tid=20297] ppid=20276 vsize=871936 CPUtime=0
/proc/20288/task/20297/stat : 20297 (java) S 20276 20274 4159 34819 4229 4202560 2 0 0 0 0 0 0 0 15 0 10 0 881643018 892862464 85042 1283457024 134512640 134550932 4286570640 18446744073709551615 4294960130 0 4 0 16800975 18446612132790284352 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 124.63
Current children cumulated vsize (KiB) 877088

Child status: 0
Real time (s): 127.452
CPU time (s): 124.66
CPU user time (s): 124.264
CPU system time (s): 0.396024
CPU usage (%): 97.809
Max. virtual memory (cumulated for all children) (KiB): 878208

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 124.264
system time used= 0.396024
maximum resident set size= 0
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 92433
page faults= 250
swaps= 0
block input operations= 0
block output operations= 0
messages sent= 0
messages received= 0
signals received= 0
voluntary context switches= 4510
involuntary context switches= 4953

runsolver used 0 second user time and 0 second system time

The end