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/201103031013/p2cudf-trendy-1.12/d1583bd8-d489-11df-9a24-00163e3d3b7c.cudf.debian.log.runsolver ./p2cudf-trendy-1.12 /home/misc2010/data/misc4/debian//d1583bd8-d489-11df-9a24-00163e3d3b7c.cudf /home/misc2010/tmp/201103031013/p2cudf-trendy-1.12/d1583bd8-d489-11df-9a24-00163e3d3b7c.cudf.debian.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.18 1.12 1.08 5/36 28031
/proc/meminfo: memFree=653704/1048576 swapFree=0/0
[pid=28029] ppid=28028 vsize=2568 CPUtime=0
/proc/28029/stat : 28029 (p2cudf-trendy-1) S 28028 28029 29493 34817 29493 4202496 372 0 0 0 0 0 0 0 18 0 1 0 75575736 2629632 269 1283457024 134512640 135304128 4290825728 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/28029/statm: 642 269 230 194 0 29 0
[pid=28030] ppid=28029 vsize=2572 CPUtime=0
/proc/28030/stat : 28030 (p2cudf) R 28029 28029 29493 34817 29493 4202496 346 0 0 0 0 0 0 0 25 0 1 0 75575736 2633728 272 1283457024 134512640 135304128 4291622576 18446744073709551615 4294960130 0 65538 4 65536 0 0 0 17 0 0 0 0
/proc/28030/statm: 643 272 231 194 0 30 0
[pid=28031] ppid=28030 vsize=2572 CPUtime=0
/proc/28031/stat : 28031 (p2cudf) R 28030 28029 29493 34817 29493 4202560 0 0 0 0 0 0 0 0 25 0 1 0 75575736 2633728 41 1283457024 134512640 135304128 4291622576 18446744073709551615 4294960130 0 65538 4 65536 0 0 0 17 0 0 0 0
/proc/28031/statm: 643 41 0 194 0 30 0

[startup+0.105498 s]
/proc/loadavg: 1.18 1.12 1.08 5/36 28031
/proc/meminfo: memFree=653704/1048576 swapFree=0/0
[pid=28029] ppid=28028 vsize=2568 CPUtime=0
/proc/28029/stat : 28029 (p2cudf-trendy-1) S 28028 28029 29493 34817 29493 4202496 372 0 0 0 0 0 0 0 18 0 1 0 75575736 2629632 269 1283457024 134512640 135304128 4290825728 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/28029/statm: 642 269 230 194 0 29 0
[pid=28030] ppid=28029 vsize=2576 CPUtime=0.04
/proc/28030/stat : 28030 (p2cudf) S 28029 28029 29493 34817 29493 4202496 391 3015 0 1 0 0 2 2 25 0 1 0 75575736 2637824 281 1283457024 134512640 135304128 4291622576 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/28030/statm: 644 281 239 194 0 31 0
Current children cumulated CPU time (s) 0.04
Current children cumulated vsize (KiB) 5144

[startup+0.205512 s]
/proc/loadavg: 1.18 1.12 1.08 5/36 28031
/proc/meminfo: memFree=653704/1048576 swapFree=0/0
[pid=28029] ppid=28028 vsize=2568 CPUtime=0
/proc/28029/stat : 28029 (p2cudf-trendy-1) S 28028 28029 29493 34817 29493 4202496 372 0 0 0 0 0 0 0 18 0 1 0 75575736 2629632 269 1283457024 134512640 135304128 4290825728 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/28029/statm: 642 269 230 194 0 29 0
[pid=28030] ppid=28029 vsize=2576 CPUtime=0.04
/proc/28030/stat : 28030 (p2cudf) S 28029 28029 29493 34817 29493 4202496 391 3015 0 1 0 0 2 2 25 0 1 0 75575736 2637824 281 1283457024 134512640 135304128 4291622576 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/28030/statm: 644 281 239 194 0 31 0
Current children cumulated CPU time (s) 0.04
Current children cumulated vsize (KiB) 5144

[startup+0.30553 s]
/proc/loadavg: 1.18 1.12 1.08 5/36 28031
/proc/meminfo: memFree=653704/1048576 swapFree=0/0
[pid=28029] ppid=28028 vsize=2568 CPUtime=0
/proc/28029/stat : 28029 (p2cudf-trendy-1) S 28028 28029 29493 34817 29493 4202496 372 0 0 0 0 0 0 0 18 0 1 0 75575736 2629632 269 1283457024 134512640 135304128 4290825728 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/28029/statm: 642 269 230 194 0 29 0
[pid=28030] ppid=28029 vsize=2576 CPUtime=0.04
/proc/28030/stat : 28030 (p2cudf) S 28029 28029 29493 34817 29493 4202496 391 3015 0 1 0 0 2 2 25 0 1 0 75575736 2637824 281 1283457024 134512640 135304128 4291622576 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/28030/statm: 644 281 239 194 0 31 0
Current children cumulated CPU time (s) 0.04
Current children cumulated vsize (KiB) 5144

[startup+0.705654 s]
/proc/loadavg: 1.18 1.12 1.08 5/36 28031
/proc/meminfo: memFree=653704/1048576 swapFree=0/0
[pid=28029] ppid=28028 vsize=2568 CPUtime=0
/proc/28029/stat : 28029 (p2cudf-trendy-1) S 28028 28029 29493 34817 29493 4202496 372 0 0 0 0 0 0 0 18 0 1 0 75575736 2629632 269 1283457024 134512640 135304128 4290825728 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/28029/statm: 642 269 230 194 0 29 0
[pid=28030] ppid=28029 vsize=2576 CPUtime=0.04
/proc/28030/stat : 28030 (p2cudf) S 28029 28029 29493 34817 29493 4202496 391 3015 0 1 0 0 2 2 25 0 1 0 75575736 2637824 281 1283457024 134512640 135304128 4291622576 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/28030/statm: 644 281 239 194 0 31 0
Current children cumulated CPU time (s) 0.04
Current children cumulated vsize (KiB) 5144

[startup+1.50585 s]
/proc/loadavg: 1.18 1.12 1.08 4/46 28052
/proc/meminfo: memFree=604076/1048576 swapFree=0/0
[pid=28029] ppid=28028 vsize=2568 CPUtime=0
/proc/28029/stat : 28029 (p2cudf-trendy-1) S 28028 28029 29493 34817 29493 4202496 372 0 0 0 0 0 0 0 18 0 1 0 75575736 2629632 269 1283457024 134512640 135304128 4290825728 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/28029/statm: 642 269 230 194 0 29 0
[pid=28030] ppid=28029 vsize=2576 CPUtime=0.04
/proc/28030/stat : 28030 (p2cudf) S 28029 28029 29493 34817 29493 4202496 391 3015 0 1 0 0 2 2 25 0 1 0 75575736 2637824 281 1283457024 134512640 135304128 4291622576 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/28030/statm: 644 281 239 194 0 31 0
[pid=28043] ppid=28030 vsize=885224 CPUtime=1.46
/proc/28043/stat : 28043 (java) S 28030 28029 29493 34817 29493 4202496 24230 0 1 0 132 14 0 0 25 0 10 0 75575739 906469376 21070 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/28043/statm: 221306 21070 1723 10 0 218397 0
[pid=28043/tid=28044] ppid=28030 vsize=885224 CPUtime=0.8
/proc/28043/task/28044/stat : 28044 (java) R 28030 28029 29493 34817 29493 4202560 12941 0 1 0 67 13 0 0 25 0 10 0 75575740 906469376 21070 1283457024 134512640 134550932 4293836656 18446744073709551615 4094684987 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=28043/tid=28045] ppid=28030 vsize=885224 CPUtime=0
/proc/28043/task/28045/stat : 28045 (java) S 28030 28029 29493 34817 29493 4202560 6 0 0 0 0 0 0 0 16 0 10 0 75575742 906469376 21070 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 0 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28046] ppid=28030 vsize=885224 CPUtime=0
/proc/28043/task/28046/stat : 28046 (java) S 28030 28029 29493 34817 29493 4202560 8 0 0 0 0 0 0 0 25 0 10 0 75575742 906469376 21070 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28047] ppid=28030 vsize=885224 CPUtime=0
/proc/28043/task/28047/stat : 28047 (java) S 28030 28029 29493 34817 29493 4202560 4 0 0 0 0 0 0 0 25 0 10 0 75575742 906469376 21070 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28048] ppid=28030 vsize=885224 CPUtime=0
/proc/28043/task/28048/stat : 28048 (java) S 28030 28029 29493 34817 29493 4202560 1 0 0 0 0 0 0 0 25 0 10 0 75575745 906469376 21070 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28049] ppid=28030 vsize=885224 CPUtime=0.43
/proc/28043/task/28049/stat : 28049 (java) R 28030 28029 29493 34817 29493 4202560 8372 0 0 0 43 0 0 0 25 0 10 0 75575745 906469376 21070 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=28043/tid=28050] ppid=28030 vsize=885224 CPUtime=0.22
/proc/28043/task/28050/stat : 28050 (java) S 28030 28029 29493 34817 29493 4202560 1836 0 0 0 22 0 0 0 22 0 10 0 75575745 906469376 21070 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28051] ppid=28030 vsize=885224 CPUtime=0
/proc/28043/task/28051/stat : 28051 (java) S 28030 28029 29493 34817 29493 4202560 1 0 0 0 0 0 0 0 25 0 10 0 75575745 906469376 21070 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28052] ppid=28030 vsize=885224 CPUtime=0
/proc/28043/task/28052/stat : 28052 (java) S 28030 28029 29493 34817 29493 4202560 2 0 0 0 0 0 0 0 15 0 10 0 75575745 906469376 21070 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 1.5
Current children cumulated vsize (KiB) 890368

[startup+3.1063 s]
/proc/loadavg: 1.18 1.12 1.08 2/46 28052
/proc/meminfo: memFree=482804/1048576 swapFree=0/0
[pid=28029] ppid=28028 vsize=2568 CPUtime=0
/proc/28029/stat : 28029 (p2cudf-trendy-1) S 28028 28029 29493 34817 29493 4202496 372 0 0 0 0 0 0 0 18 0 1 0 75575736 2629632 269 1283457024 134512640 135304128 4290825728 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/28029/statm: 642 269 230 194 0 29 0
[pid=28030] ppid=28029 vsize=2576 CPUtime=0.04
/proc/28030/stat : 28030 (p2cudf) S 28029 28029 29493 34817 29493 4202496 391 3015 0 1 0 0 2 2 25 0 1 0 75575736 2637824 281 1283457024 134512640 135304128 4291622576 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/28030/statm: 644 281 239 194 0 31 0
[pid=28043] ppid=28030 vsize=883088 CPUtime=3.06
/proc/28043/stat : 28043 (java) S 28030 28029 29493 34817 29493 4202496 74915 0 1 0 266 40 0 0 25 0 10 0 75575739 904282112 71494 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/28043/statm: 220772 71494 1743 10 0 217863 0
[pid=28043/tid=28044] ppid=28030 vsize=883088 CPUtime=1.62
/proc/28043/task/28044/stat : 28044 (java) R 28030 28029 29493 34817 29493 4202560 50069 0 1 0 129 33 0 0 25 0 10 0 75575740 904282112 71494 1283457024 134512640 134550932 4293836656 18446744073709551615 4095277972 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=28043/tid=28045] ppid=28030 vsize=883088 CPUtime=0.3
/proc/28043/task/28045/stat : 28045 (java) S 28030 28029 29493 34817 29493 4202560 13318 0 0 0 24 6 0 0 16 0 10 0 75575742 904282112 71494 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 0 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28046] ppid=28030 vsize=883088 CPUtime=0
/proc/28043/task/28046/stat : 28046 (java) S 28030 28029 29493 34817 29493 4202560 8 0 0 0 0 0 0 0 18 0 10 0 75575742 904282112 71494 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28047] ppid=28030 vsize=883088 CPUtime=0
/proc/28043/task/28047/stat : 28047 (java) S 28030 28029 29493 34817 29493 4202560 6 0 0 0 0 0 0 0 18 0 10 0 75575742 904282112 71494 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28048] ppid=28030 vsize=883088 CPUtime=0
/proc/28043/task/28048/stat : 28048 (java) S 28030 28029 29493 34817 29493 4202560 1 0 0 0 0 0 0 0 25 0 10 0 75575745 904282112 71494 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28049] ppid=28030 vsize=883088 CPUtime=0.49
/proc/28043/task/28049/stat : 28049 (java) S 28030 28029 29493 34817 29493 4202560 8432 0 0 0 49 0 0 0 25 0 10 0 75575745 904282112 71494 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28050] ppid=28030 vsize=883088 CPUtime=0.62
/proc/28043/task/28050/stat : 28050 (java) S 28030 28029 29493 34817 29493 4202560 2019 0 0 0 62 0 0 0 16 0 10 0 75575745 904282112 71494 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28051] ppid=28030 vsize=883088 CPUtime=0
/proc/28043/task/28051/stat : 28051 (java) S 28030 28029 29493 34817 29493 4202560 1 0 0 0 0 0 0 0 25 0 10 0 75575745 904282112 71494 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28052] ppid=28030 vsize=883088 CPUtime=0
/proc/28043/task/28052/stat : 28052 (java) S 28030 28029 29493 34817 29493 4202560 2 0 0 0 0 0 0 0 15 0 10 0 75575745 904282112 71494 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 3.1
Current children cumulated vsize (KiB) 888232

[startup+6.30686 s]
/proc/loadavg: 1.25 1.13 1.09 2/47 28053
/proc/meminfo: memFree=371824/1048576 swapFree=0/0
[pid=28029] ppid=28028 vsize=2568 CPUtime=0
/proc/28029/stat : 28029 (p2cudf-trendy-1) S 28028 28029 29493 34817 29493 4202496 372 0 0 0 0 0 0 0 18 0 1 0 75575736 2629632 269 1283457024 134512640 135304128 4290825728 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/28029/statm: 642 269 230 194 0 29 0
[pid=28030] ppid=28029 vsize=2576 CPUtime=0.04
/proc/28030/stat : 28030 (p2cudf) S 28029 28029 29493 34817 29493 4202496 391 3015 0 1 0 0 2 2 25 0 1 0 75575736 2637824 281 1283457024 134512640 135304128 4291622576 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/28030/statm: 644 281 239 194 0 31 0
[pid=28043] ppid=28030 vsize=884060 CPUtime=6.25
/proc/28043/stat : 28043 (java) S 28030 28029 29493 34817 29493 4202496 77054 0 1 0 584 41 0 0 25 0 11 0 75575739 905277440 72010 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/28043/statm: 221015 72010 1779 10 0 218106 0
[pid=28043/tid=28044] ppid=28030 vsize=884060 CPUtime=3.33
/proc/28043/task/28044/stat : 28044 (java) R 28030 28029 29493 34817 29493 4202560 50260 0 1 0 300 33 0 0 25 0 11 0 75575740 905277440 72010 1283457024 134512640 134550932 4293836656 18446744073709551615 4095739839 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=28043/tid=28045] ppid=28030 vsize=884060 CPUtime=0.3
/proc/28043/task/28045/stat : 28045 (java) S 28030 28029 29493 34817 29493 4202560 13318 0 0 0 24 6 0 0 16 0 11 0 75575742 905277440 72010 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 0 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28046] ppid=28030 vsize=884060 CPUtime=0
/proc/28043/task/28046/stat : 28046 (java) S 28030 28029 29493 34817 29493 4202560 8 0 0 0 0 0 0 0 18 0 11 0 75575742 905277440 72010 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28047] ppid=28030 vsize=884060 CPUtime=0
/proc/28043/task/28047/stat : 28047 (java) S 28030 28029 29493 34817 29493 4202560 6 0 0 0 0 0 0 0 18 0 11 0 75575742 905277440 72010 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28048] ppid=28030 vsize=884060 CPUtime=0
/proc/28043/task/28048/stat : 28048 (java) S 28030 28029 29493 34817 29493 4202560 1 0 0 0 0 0 0 0 25 0 11 0 75575745 905277440 72010 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28049] ppid=28030 vsize=884060 CPUtime=0.49
/proc/28043/task/28049/stat : 28049 (java) S 28030 28029 29493 34817 29493 4202560 8432 0 0 0 49 0 0 0 25 0 11 0 75575745 905277440 72010 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28050] ppid=28030 vsize=884060 CPUtime=2.09
/proc/28043/task/28050/stat : 28050 (java) S 28030 28029 29493 34817 29493 4202560 3963 0 0 0 209 0 0 0 15 0 11 0 75575745 905277440 72010 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28051] ppid=28030 vsize=884060 CPUtime=0
/proc/28043/task/28051/stat : 28051 (java) S 28030 28029 29493 34817 29493 4202560 1 0 0 0 0 0 0 0 25 0 11 0 75575745 905277440 72010 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28052] ppid=28030 vsize=884060 CPUtime=0
/proc/28043/task/28052/stat : 28052 (java) S 28030 28029 29493 34817 29493 4202560 2 0 0 0 0 0 0 0 15 0 11 0 75575745 905277440 72010 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28053] ppid=28030 vsize=884060 CPUtime=0
/proc/28043/task/28053/stat : 28053 (java) S 28030 28029 29493 34817 29493 4202560 4 0 0 0 0 0 0 0 24 0 11 0 75576235 905277440 72010 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 6.29
Current children cumulated vsize (KiB) 889204

[startup+12.7089 s]
/proc/loadavg: 1.23 1.13 1.09 2/47 28053
/proc/meminfo: memFree=374056/1048576 swapFree=0/0
[pid=28029] ppid=28028 vsize=2568 CPUtime=0
/proc/28029/stat : 28029 (p2cudf-trendy-1) S 28028 28029 29493 34817 29493 4202496 372 0 0 0 0 0 0 0 18 0 1 0 75575736 2629632 269 1283457024 134512640 135304128 4290825728 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/28029/statm: 642 269 230 194 0 29 0
[pid=28030] ppid=28029 vsize=2576 CPUtime=0.04
/proc/28030/stat : 28030 (p2cudf) S 28029 28029 29493 34817 29493 4202496 391 3015 0 1 0 0 2 2 25 0 1 0 75575736 2637824 281 1283457024 134512640 135304128 4291622576 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/28030/statm: 644 281 239 194 0 31 0
[pid=28043] ppid=28030 vsize=879752 CPUtime=12.64
/proc/28043/stat : 28043 (java) S 28030 28029 29493 34817 29493 4202496 77088 0 1 0 1223 41 0 0 25 0 11 0 75575739 900866048 71001 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/28043/statm: 219938 71001 1782 10 0 217029 0
[pid=28043/tid=28044] ppid=28030 vsize=879752 CPUtime=9.53
/proc/28043/task/28044/stat : 28044 (java) R 28030 28029 29493 34817 29493 4202560 50262 0 1 0 920 33 0 0 25 0 11 0 75575740 900866048 71001 1283457024 134512640 134550932 4293836656 18446744073709551615 4095799397 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=28043/tid=28045] ppid=28030 vsize=879752 CPUtime=0.3
/proc/28043/task/28045/stat : 28045 (java) S 28030 28029 29493 34817 29493 4202560 13318 0 0 0 24 6 0 0 15 0 11 0 75575742 900866048 71001 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 0 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28046] ppid=28030 vsize=879752 CPUtime=0
/proc/28043/task/28046/stat : 28046 (java) S 28030 28029 29493 34817 29493 4202560 8 0 0 0 0 0 0 0 18 0 11 0 75575742 900866048 71001 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28047] ppid=28030 vsize=879752 CPUtime=0
/proc/28043/task/28047/stat : 28047 (java) S 28030 28029 29493 34817 29493 4202560 6 0 0 0 0 0 0 0 18 0 11 0 75575742 900866048 71001 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28048] ppid=28030 vsize=879752 CPUtime=0
/proc/28043/task/28048/stat : 28048 (java) S 28030 28029 29493 34817 29493 4202560 1 0 0 0 0 0 0 0 25 0 11 0 75575745 900866048 71001 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28049] ppid=28030 vsize=879752 CPUtime=0.49
/proc/28043/task/28049/stat : 28049 (java) S 28030 28029 29493 34817 29493 4202560 8432 0 0 0 49 0 0 0 25 0 11 0 75575745 900866048 71001 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28050] ppid=28030 vsize=879752 CPUtime=2.28
/proc/28043/task/28050/stat : 28050 (java) S 28030 28029 29493 34817 29493 4202560 3995 0 0 0 228 0 0 0 15 0 11 0 75575745 900866048 71001 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28051] ppid=28030 vsize=879752 CPUtime=0
/proc/28043/task/28051/stat : 28051 (java) S 28030 28029 29493 34817 29493 4202560 1 0 0 0 0 0 0 0 25 0 11 0 75575745 900866048 71001 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28052] ppid=28030 vsize=879752 CPUtime=0
/proc/28043/task/28052/stat : 28052 (java) S 28030 28029 29493 34817 29493 4202560 2 0 0 0 0 0 0 0 15 0 11 0 75575745 900866048 71001 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28053] ppid=28030 vsize=879752 CPUtime=0
/proc/28043/task/28053/stat : 28053 (java) S 28030 28029 29493 34817 29493 4202560 4 0 0 0 0 0 0 0 24 0 11 0 75576235 900866048 71001 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 12.68
Current children cumulated vsize (KiB) 884896

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

[startup+12.8089 s]
/proc/loadavg: 1.23 1.13 1.09 2/47 28053
/proc/meminfo: memFree=374056/1048576 swapFree=0/0
[pid=28029] ppid=28028 vsize=2568 CPUtime=0
/proc/28029/stat : 28029 (p2cudf-trendy-1) S 28028 28029 29493 34817 29493 4202496 372 0 0 0 0 0 0 0 18 0 1 0 75575736 2629632 269 1283457024 134512640 135304128 4290825728 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/28029/statm: 642 269 230 194 0 29 0
[pid=28030] ppid=28029 vsize=2576 CPUtime=0.04
/proc/28030/stat : 28030 (p2cudf) S 28029 28029 29493 34817 29493 4202496 391 3015 0 1 0 0 2 2 25 0 1 0 75575736 2637824 281 1283457024 134512640 135304128 4291622576 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/28030/statm: 644 281 239 194 0 31 0
[pid=28043] ppid=28030 vsize=879752 CPUtime=12.74
/proc/28043/stat : 28043 (java) S 28030 28029 29493 34817 29493 4202496 77088 0 1 0 1233 41 0 0 25 0 11 0 75575739 900866048 71001 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/28043/statm: 219938 71001 1782 10 0 217029 0
[pid=28043/tid=28044] ppid=28030 vsize=879752 CPUtime=9.63
/proc/28043/task/28044/stat : 28044 (java) R 28030 28029 29493 34817 29493 4202560 50262 0 1 0 930 33 0 0 25 0 11 0 75575740 900866048 71001 1283457024 134512640 134550932 4293836656 18446744073709551615 4095740017 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=28043/tid=28045] ppid=28030 vsize=879752 CPUtime=0.3
/proc/28043/task/28045/stat : 28045 (java) S 28030 28029 29493 34817 29493 4202560 13318 0 0 0 24 6 0 0 15 0 11 0 75575742 900866048 71001 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 0 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28046] ppid=28030 vsize=879752 CPUtime=0
/proc/28043/task/28046/stat : 28046 (java) S 28030 28029 29493 34817 29493 4202560 8 0 0 0 0 0 0 0 18 0 11 0 75575742 900866048 71001 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28047] ppid=28030 vsize=879752 CPUtime=0
/proc/28043/task/28047/stat : 28047 (java) S 28030 28029 29493 34817 29493 4202560 6 0 0 0 0 0 0 0 18 0 11 0 75575742 900866048 71001 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28048] ppid=28030 vsize=879752 CPUtime=0
/proc/28043/task/28048/stat : 28048 (java) S 28030 28029 29493 34817 29493 4202560 1 0 0 0 0 0 0 0 25 0 11 0 75575745 900866048 71001 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28049] ppid=28030 vsize=879752 CPUtime=0.49
/proc/28043/task/28049/stat : 28049 (java) S 28030 28029 29493 34817 29493 4202560 8432 0 0 0 49 0 0 0 25 0 11 0 75575745 900866048 71001 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28050] ppid=28030 vsize=879752 CPUtime=2.28
/proc/28043/task/28050/stat : 28050 (java) S 28030 28029 29493 34817 29493 4202560 3995 0 0 0 228 0 0 0 15 0 11 0 75575745 900866048 71001 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28051] ppid=28030 vsize=879752 CPUtime=0
/proc/28043/task/28051/stat : 28051 (java) S 28030 28029 29493 34817 29493 4202560 1 0 0 0 0 0 0 0 25 0 11 0 75575745 900866048 71001 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28052] ppid=28030 vsize=879752 CPUtime=0
/proc/28043/task/28052/stat : 28052 (java) S 28030 28029 29493 34817 29493 4202560 2 0 0 0 0 0 0 0 15 0 11 0 75575745 900866048 71001 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28053] ppid=28030 vsize=879752 CPUtime=0
/proc/28043/task/28053/stat : 28053 (java) S 28030 28029 29493 34817 29493 4202560 4 0 0 0 0 0 0 0 24 0 11 0 75576235 900866048 71001 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 12.78
Current children cumulated vsize (KiB) 884896

[startup+16.0096 s]
/proc/loadavg: 1.21 1.13 1.09 2/47 28053
/proc/meminfo: memFree=331028/1048576 swapFree=0/0
[pid=28029] ppid=28028 vsize=2568 CPUtime=0
/proc/28029/stat : 28029 (p2cudf-trendy-1) S 28028 28029 29493 34817 29493 4202496 372 0 0 0 0 0 0 0 18 0 1 0 75575736 2629632 269 1283457024 134512640 135304128 4290825728 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/28029/statm: 642 269 230 194 0 29 0
[pid=28030] ppid=28029 vsize=2576 CPUtime=0.04
/proc/28030/stat : 28030 (p2cudf) S 28029 28029 29493 34817 29493 4202496 391 3015 0 1 0 0 2 2 25 0 1 0 75575736 2637824 281 1283457024 134512640 135304128 4291622576 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/28030/statm: 644 281 239 194 0 31 0
[pid=28043] ppid=28030 vsize=879752 CPUtime=15.94
/proc/28043/stat : 28043 (java) S 28030 28029 29493 34817 29493 4202496 88274 0 1 0 1551 43 0 0 25 0 11 0 75575739 900866048 82187 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/28043/statm: 219938 82187 1782 10 0 217029 0
[pid=28043/tid=28044] ppid=28030 vsize=879752 CPUtime=12.48
/proc/28043/task/28044/stat : 28044 (java) R 28030 28029 29493 34817 29493 4202560 50263 0 1 0 1215 33 0 0 25 0 11 0 75575740 900866048 82187 1283457024 134512640 134550932 4293836656 18446744073709551615 4095740017 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=28043/tid=28045] ppid=28030 vsize=879752 CPUtime=0.59
/proc/28043/task/28045/stat : 28045 (java) S 28030 28029 29493 34817 29493 4202560 24498 0 0 0 51 8 0 0 16 0 11 0 75575742 900866048 82187 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 0 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28046] ppid=28030 vsize=879752 CPUtime=0
/proc/28043/task/28046/stat : 28046 (java) S 28030 28029 29493 34817 29493 4202560 8 0 0 0 0 0 0 0 18 0 11 0 75575742 900866048 82187 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28047] ppid=28030 vsize=879752 CPUtime=0
/proc/28043/task/28047/stat : 28047 (java) S 28030 28029 29493 34817 29493 4202560 6 0 0 0 0 0 0 0 18 0 11 0 75575742 900866048 82187 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28048] ppid=28030 vsize=879752 CPUtime=0
/proc/28043/task/28048/stat : 28048 (java) S 28030 28029 29493 34817 29493 4202560 1 0 0 0 0 0 0 0 25 0 11 0 75575745 900866048 82187 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28049] ppid=28030 vsize=879752 CPUtime=0.49
/proc/28043/task/28049/stat : 28049 (java) S 28030 28029 29493 34817 29493 4202560 8432 0 0 0 49 0 0 0 25 0 11 0 75575745 900866048 82187 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28050] ppid=28030 vsize=879752 CPUtime=2.35
/proc/28043/task/28050/stat : 28050 (java) S 28030 28029 29493 34817 29493 4202560 4000 0 0 0 235 0 0 0 15 0 11 0 75575745 900866048 82187 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28051] ppid=28030 vsize=879752 CPUtime=0
/proc/28043/task/28051/stat : 28051 (java) S 28030 28029 29493 34817 29493 4202560 1 0 0 0 0 0 0 0 25 0 11 0 75575745 900866048 82187 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28052] ppid=28030 vsize=879752 CPUtime=0
/proc/28043/task/28052/stat : 28052 (java) S 28030 28029 29493 34817 29493 4202560 2 0 0 0 0 0 0 0 15 0 11 0 75575745 900866048 82187 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28053] ppid=28030 vsize=879752 CPUtime=0
/proc/28043/task/28053/stat : 28053 (java) S 28030 28029 29493 34817 29493 4202560 4 0 0 0 0 0 0 0 24 0 11 0 75576235 900866048 82187 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 15.98
Current children cumulated vsize (KiB) 884896

[startup+19.2104 s]
/proc/loadavg: 1.21 1.13 1.09 2/46 28053
/proc/meminfo: memFree=331036/1048576 swapFree=0/0
[pid=28029] ppid=28028 vsize=2568 CPUtime=0
/proc/28029/stat : 28029 (p2cudf-trendy-1) S 28028 28029 29493 34817 29493 4202496 372 0 0 0 0 0 0 0 18 0 1 0 75575736 2629632 269 1283457024 134512640 135304128 4290825728 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/28029/statm: 642 269 230 194 0 29 0
[pid=28030] ppid=28029 vsize=2576 CPUtime=0.04
/proc/28030/stat : 28030 (p2cudf) S 28029 28029 29493 34817 29493 4202496 391 3015 0 1 0 0 2 2 25 0 1 0 75575736 2637824 281 1283457024 134512640 135304128 4291622576 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/28030/statm: 644 281 239 194 0 31 0
[pid=28043] ppid=28030 vsize=879752 CPUtime=19.14
/proc/28043/stat : 28043 (java) S 28030 28029 29493 34817 29493 4202496 88276 0 1 0 1871 43 0 0 25 0 11 0 75575739 900866048 82189 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/28043/statm: 219938 82189 1782 10 0 217029 0
[pid=28043/tid=28044] ppid=28030 vsize=879752 CPUtime=15.66
/proc/28043/task/28044/stat : 28044 (java) R 28030 28029 29493 34817 29493 4202560 50263 0 1 0 1533 33 0 0 25 0 11 0 75575740 900866048 82189 1283457024 134512640 134550932 4293836656 18446744073709551615 4095761367 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=28043/tid=28045] ppid=28030 vsize=879752 CPUtime=0.59
/proc/28043/task/28045/stat : 28045 (java) S 28030 28029 29493 34817 29493 4202560 24498 0 0 0 51 8 0 0 15 0 11 0 75575742 900866048 82189 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 0 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28046] ppid=28030 vsize=879752 CPUtime=0
/proc/28043/task/28046/stat : 28046 (java) S 28030 28029 29493 34817 29493 4202560 8 0 0 0 0 0 0 0 18 0 11 0 75575742 900866048 82189 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28047] ppid=28030 vsize=879752 CPUtime=0
/proc/28043/task/28047/stat : 28047 (java) S 28030 28029 29493 34817 29493 4202560 6 0 0 0 0 0 0 0 18 0 11 0 75575742 900866048 82189 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28048] ppid=28030 vsize=879752 CPUtime=0
/proc/28043/task/28048/stat : 28048 (java) S 28030 28029 29493 34817 29493 4202560 1 0 0 0 0 0 0 0 25 0 11 0 75575745 900866048 82189 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28049] ppid=28030 vsize=879752 CPUtime=0.49
/proc/28043/task/28049/stat : 28049 (java) S 28030 28029 29493 34817 29493 4202560 8432 0 0 0 49 0 0 0 25 0 11 0 75575745 900866048 82189 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28050] ppid=28030 vsize=879752 CPUtime=2.37
/proc/28043/task/28050/stat : 28050 (java) S 28030 28029 29493 34817 29493 4202560 4002 0 0 0 237 0 0 0 15 0 11 0 75575745 900866048 82189 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28051] ppid=28030 vsize=879752 CPUtime=0
/proc/28043/task/28051/stat : 28051 (java) S 28030 28029 29493 34817 29493 4202560 1 0 0 0 0 0 0 0 25 0 11 0 75575745 900866048 82189 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28052] ppid=28030 vsize=879752 CPUtime=0
/proc/28043/task/28052/stat : 28052 (java) S 28030 28029 29493 34817 29493 4202560 2 0 0 0 0 0 0 0 15 0 11 0 75575745 900866048 82189 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28053] ppid=28030 vsize=879752 CPUtime=0
/proc/28043/task/28053/stat : 28053 (java) S 28030 28029 29493 34817 29493 4202560 4 0 0 0 0 0 0 0 24 0 11 0 75576235 900866048 82189 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 19.18
Current children cumulated vsize (KiB) 884896

[startup+20.0067 s]
/proc/loadavg: 1.21 1.13 1.09 2/46 28053
/proc/meminfo: memFree=330912/1048576 swapFree=0/0
[pid=28029] ppid=28028 vsize=2568 CPUtime=0
/proc/28029/stat : 28029 (p2cudf-trendy-1) S 28028 28029 29493 34817 29493 4202496 372 0 0 0 0 0 0 0 18 0 1 0 75575736 2629632 269 1283457024 134512640 135304128 4290825728 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/28029/statm: 642 269 230 194 0 29 0
[pid=28030] ppid=28029 vsize=2576 CPUtime=0.04
/proc/28030/stat : 28030 (p2cudf) S 28029 28029 29493 34817 29493 4202496 391 3015 0 1 0 0 2 2 25 0 1 0 75575736 2637824 281 1283457024 134512640 135304128 4291622576 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/28030/statm: 644 281 239 194 0 31 0
[pid=28043] ppid=28030 vsize=880076 CPUtime=19.8
/proc/28043/stat : 28043 (java) S 28030 28029 29493 34817 29493 4202496 88294 0 1 0 1937 43 0 0 25 0 12 0 75575739 901197824 82207 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/28043/statm: 220019 82207 1782 10 0 217110 0
[pid=28043/tid=28044] ppid=28030 vsize=880076 CPUtime=16.26
/proc/28043/task/28044/stat : 28044 (java) S 28030 28029 29493 34817 29493 4202560 50271 0 1 0 1593 33 0 0 25 0 12 0 75575740 901197824 82207 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28045] ppid=28030 vsize=880076 CPUtime=0.59
/proc/28043/task/28045/stat : 28045 (java) S 28030 28029 29493 34817 29493 4202560 24498 0 0 0 51 8 0 0 16 0 12 0 75575742 901197824 82207 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 0 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28046] ppid=28030 vsize=880076 CPUtime=0
/proc/28043/task/28046/stat : 28046 (java) S 28030 28029 29493 34817 29493 4202560 8 0 0 0 0 0 0 0 18 0 12 0 75575742 901197824 82207 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28047] ppid=28030 vsize=880076 CPUtime=0
/proc/28043/task/28047/stat : 28047 (java) S 28030 28029 29493 34817 29493 4202560 6 0 0 0 0 0 0 0 18 0 12 0 75575742 901197824 82207 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28048] ppid=28030 vsize=880076 CPUtime=0
/proc/28043/task/28048/stat : 28048 (java) S 28030 28029 29493 34817 29493 4202560 1 0 0 0 0 0 0 0 25 0 12 0 75575745 901197824 82207 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28049] ppid=28030 vsize=880076 CPUtime=0.49
/proc/28043/task/28049/stat : 28049 (java) S 28030 28029 29493 34817 29493 4202560 8432 0 0 0 49 0 0 0 25 0 12 0 75575745 901197824 82207 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28050] ppid=28030 vsize=880076 CPUtime=2.43
/proc/28043/task/28050/stat : 28050 (java) S 28030 28029 29493 34817 29493 4202560 4007 0 0 0 243 0 0 0 15 0 12 0 75575745 901197824 82207 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28051] ppid=28030 vsize=880076 CPUtime=0
/proc/28043/task/28051/stat : 28051 (java) S 28030 28029 29493 34817 29493 4202560 1 0 0 0 0 0 0 0 25 0 12 0 75575745 901197824 82207 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28052] ppid=28030 vsize=880076 CPUtime=0
/proc/28043/task/28052/stat : 28052 (java) S 28030 28029 29493 34817 29493 4202560 2 0 0 0 0 0 0 0 15 0 12 0 75575745 901197824 82207 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28053] ppid=28030 vsize=880076 CPUtime=0
/proc/28043/task/28053/stat : 28053 (java) S 28030 28029 29493 34817 29493 4202560 4 0 0 0 0 0 0 0 24 0 12 0 75576235 901197824 82207 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 19.84
Current children cumulated vsize (KiB) 885220

[startup+20.4127 s]
/proc/loadavg: 1.21 1.13 1.09 2/46 28053
/proc/meminfo: memFree=330912/1048576 swapFree=0/0
[pid=28029] ppid=28028 vsize=2568 CPUtime=0
/proc/28029/stat : 28029 (p2cudf-trendy-1) S 28028 28029 29493 34817 29493 4202496 372 0 0 0 0 0 0 0 18 0 1 0 75575736 2629632 269 1283457024 134512640 135304128 4290825728 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/28029/statm: 642 269 230 194 0 29 0
[pid=28030] ppid=28029 vsize=2576 CPUtime=0.04
/proc/28030/stat : 28030 (p2cudf) S 28029 28029 29493 34817 29493 4202496 391 3015 0 1 0 0 2 2 25 0 1 0 75575736 2637824 281 1283457024 134512640 135304128 4291622576 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/28030/statm: 644 281 239 194 0 31 0
[pid=28043] ppid=28030 vsize=880076 CPUtime=19.83
/proc/28043/stat : 28043 (java) S 28030 28029 29493 34817 29493 4202496 88294 0 1 0 1939 44 0 0 25 0 12 0 75575739 901197824 82207 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/28043/statm: 220019 82207 1782 10 0 217110 0
[pid=28043/tid=28044] ppid=28030 vsize=880076 CPUtime=16.26
/proc/28043/task/28044/stat : 28044 (java) S 28030 28029 29493 34817 29493 4202560 50271 0 1 0 1593 33 0 0 25 0 12 0 75575740 901197824 82207 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28045] ppid=28030 vsize=880076 CPUtime=0.59
/proc/28043/task/28045/stat : 28045 (java) S 28030 28029 29493 34817 29493 4202560 24498 0 0 0 51 8 0 0 16 0 12 0 75575742 901197824 82207 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 0 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28046] ppid=28030 vsize=880076 CPUtime=0
/proc/28043/task/28046/stat : 28046 (java) S 28030 28029 29493 34817 29493 4202560 8 0 0 0 0 0 0 0 18 0 12 0 75575742 901197824 82207 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28047] ppid=28030 vsize=880076 CPUtime=0
/proc/28043/task/28047/stat : 28047 (java) S 28030 28029 29493 34817 29493 4202560 6 0 0 0 0 0 0 0 18 0 12 0 75575742 901197824 82207 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28048] ppid=28030 vsize=880076 CPUtime=0
/proc/28043/task/28048/stat : 28048 (java) S 28030 28029 29493 34817 29493 4202560 1 0 0 0 0 0 0 0 25 0 12 0 75575745 901197824 82207 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28049] ppid=28030 vsize=880076 CPUtime=0.49
/proc/28043/task/28049/stat : 28049 (java) S 28030 28029 29493 34817 29493 4202560 8432 0 0 0 49 0 0 0 25 0 12 0 75575745 901197824 82207 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28050] ppid=28030 vsize=880076 CPUtime=2.44
/proc/28043/task/28050/stat : 28050 (java) S 28030 28029 29493 34817 29493 4202560 4007 0 0 0 244 0 0 0 15 0 12 0 75575745 901197824 82207 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28051] ppid=28030 vsize=880076 CPUtime=0
/proc/28043/task/28051/stat : 28051 (java) S 28030 28029 29493 34817 29493 4202560 1 0 0 0 0 0 0 0 25 0 12 0 75575745 901197824 82207 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28052] ppid=28030 vsize=880076 CPUtime=0
/proc/28043/task/28052/stat : 28052 (java) S 28030 28029 29493 34817 29493 4202560 2 0 0 0 0 0 0 0 15 0 12 0 75575745 901197824 82207 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28053] ppid=28030 vsize=880076 CPUtime=0
/proc/28043/task/28053/stat : 28053 (java) S 28030 28029 29493 34817 29493 4202560 4 0 0 0 0 0 0 0 24 0 12 0 75576235 901197824 82207 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 19.87
Current children cumulated vsize (KiB) 885220

[startup+20.6068 s]
/proc/loadavg: 1.21 1.13 1.09 2/46 28053
/proc/meminfo: memFree=330912/1048576 swapFree=0/0
[pid=28029] ppid=28028 vsize=2568 CPUtime=0
/proc/28029/stat : 28029 (p2cudf-trendy-1) S 28028 28029 29493 34817 29493 4202496 372 0 0 0 0 0 0 0 18 0 1 0 75575736 2629632 269 1283457024 134512640 135304128 4290825728 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/28029/statm: 642 269 230 194 0 29 0
[pid=28030] ppid=28029 vsize=2576 CPUtime=0.04
/proc/28030/stat : 28030 (p2cudf) S 28029 28029 29493 34817 29493 4202496 391 3015 0 1 0 0 2 2 25 0 1 0 75575736 2637824 281 1283457024 134512640 135304128 4291622576 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/28030/statm: 644 281 239 194 0 31 0
[pid=28043] ppid=28030 vsize=880076 CPUtime=20
/proc/28043/stat : 28043 (java) S 28030 28029 29493 34817 29493 4202496 88308 0 1 0 1953 47 0 0 25 0 11 0 75575739 901197824 82221 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/28043/statm: 220019 82221 1783 10 0 217110 0
[pid=28043/tid=28044] ppid=28030 vsize=880076 CPUtime=16.26
/proc/28043/task/28044/stat : 28044 (java) S 28030 28029 29493 34817 29493 4202560 50271 0 1 0 1593 33 0 0 18 0 11 0 75575740 901197824 82221 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28045] ppid=28030 vsize=880076 CPUtime=0.59
/proc/28043/task/28045/stat : 28045 (java) S 28030 28029 29493 34817 29493 4202560 24498 0 0 0 51 8 0 0 16 0 11 0 75575742 901197824 82221 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 0 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28046] ppid=28030 vsize=880076 CPUtime=0
/proc/28043/task/28046/stat : 28046 (java) S 28030 28029 29493 34817 29493 4202560 8 0 0 0 0 0 0 0 18 0 11 0 75575742 901197824 82221 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28047] ppid=28030 vsize=880076 CPUtime=0
/proc/28043/task/28047/stat : 28047 (java) S 28030 28029 29493 34817 29493 4202560 6 0 0 0 0 0 0 0 18 0 11 0 75575742 901197824 82221 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28048] ppid=28030 vsize=880076 CPUtime=0
/proc/28043/task/28048/stat : 28048 (java) S 28030 28029 29493 34817 29493 4202560 1 0 0 0 0 0 0 0 25 0 11 0 75575745 901197824 82221 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28049] ppid=28030 vsize=880076 CPUtime=0.49
/proc/28043/task/28049/stat : 28049 (java) S 28030 28029 29493 34817 29493 4202560 8432 0 0 0 49 0 0 0 25 0 11 0 75575745 901197824 82221 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28050] ppid=28030 vsize=880076 CPUtime=2.52
/proc/28043/task/28050/stat : 28050 (java) S 28030 28029 29493 34817 29493 4202560 4018 0 0 0 252 0 0 0 16 0 11 0 75575745 901197824 82221 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28051] ppid=28030 vsize=880076 CPUtime=0
/proc/28043/task/28051/stat : 28051 (java) S 28030 28029 29493 34817 29493 4202560 1 0 0 0 0 0 0 0 25 0 11 0 75575745 901197824 82221 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28052] ppid=28030 vsize=880076 CPUtime=0
/proc/28043/task/28052/stat : 28052 (java) S 28030 28029 29493 34817 29493 4202560 2 0 0 0 0 0 0 0 15 0 11 0 75575745 901197824 82221 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
[pid=28043/tid=28053] ppid=28030 vsize=880076 CPUtime=0
/proc/28043/task/28053/stat : 28053 (java) S 28030 28029 29493 34817 29493 4202560 4 0 0 0 0 0 0 0 24 0 11 0 75576235 901197824 82221 1283457024 134512640 134550932 4293836656 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 20.04
Current children cumulated vsize (KiB) 885220

Child status: 0
Real time (s): 20.6624
CPU time (s): 20.0853
CPU user time (s): 19.5572
CPU system time (s): 0.528033
CPU usage (%): 97.2066
Max. virtual memory (cumulated for all children) (KiB): 890624

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 19.5572
system time used= 0.528033
maximum resident set size= 0
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 92109
page faults= 2
swaps= 0
block input operations= 0
block output operations= 0
messages sent= 0
messages received= 0
signals received= 0
voluntary context switches= 1223
involuntary context switches= 1354

runsolver used 0 second user time and 0 second system time

The end