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/201108311143/p2cudf-user-1.13/8afdd89e-51b8-11e0-acd7-00163e1e087d.cudf.dudf-real.log.runsolver ./p2cudf-user-1.13 /home/misc2010/data/2011/dudf-real//8afdd89e-51b8-11e0-acd7-00163e1e087d.cudf /home/misc2010/tmp/201108311143/p2cudf-user-1.13/8afdd89e-51b8-11e0-acd7-00163e1e087d.cudf.dudf-real.result -sum(installedsize) 

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.10 1.03 1.01 5/36 31887
/proc/meminfo: memFree=580124/1048576 swapFree=0/0
[pid=31884] ppid=31883 vsize=2568 CPUtime=0
/proc/31884/stat : 31884 (p2cudf-user-1.1) S 31883 31884 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 66759738 2629632 270 1283457024 134512640 135304128 4292722608 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31884/statm: 642 270 230 194 0 29 0
[pid=31885] ppid=31884 vsize=2568 CPUtime=0
/proc/31885/stat : 31885 (p2cudf) S 31884 31884 19908 34817 19908 4202496 352 0 0 0 0 0 0 0 18 0 1 0 66759738 2629632 271 1283457024 134512640 135304128 4293349488 18446744073709551615 4294960130 0 0 4 65536 18446744071564457842 0 0 17 0 0 0 0
/proc/31885/statm: 642 271 231 194 0 29 0
[pid=31886] ppid=31885 vsize=2568 CPUtime=0
/proc/31886/stat : 31886 (p2cudf) R 31885 31884 19908 34817 19908 4202560 94 0 0 0 0 0 0 0 25 0 1 0 66759738 2629632 119 1283457024 134512640 135304128 4293349488 18446744073709551615 4294960130 0 65538 0 65538 0 0 0 17 0 0 0 0
/proc/31886/statm: 642 119 77 194 0 29 0
[pid=31887] ppid=31886 vsize=2568 CPUtime=0
/proc/31887/stat : 31887 (p2cudf) R 31886 31884 19908 34817 19908 4202560 0 0 0 0 0 0 0 0 25 0 1 0 66759738 2629632 42 1283457024 134512640 135304128 4293349488 18446744073709551615 4294960130 0 65538 0 65538 0 0 0 17 0 0 0 0
/proc/31887/statm: 642 42 0 194 0 29 0

[startup+0.125647 s]
/proc/loadavg: 1.10 1.03 1.01 5/36 31887
/proc/meminfo: memFree=580124/1048576 swapFree=0/0
[pid=31884] ppid=31883 vsize=2568 CPUtime=0
/proc/31884/stat : 31884 (p2cudf-user-1.1) S 31883 31884 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 66759738 2629632 270 1283457024 134512640 135304128 4292722608 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31884/statm: 642 270 230 194 0 29 0
[pid=31885] ppid=31884 vsize=2576 CPUtime=0.04
/proc/31885/stat : 31885 (p2cudf) S 31884 31884 19908 34817 19908 4202496 392 3010 0 1 0 0 2 2 25 0 1 0 66759738 2637824 281 1283457024 134512640 135304128 4293349488 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31885/statm: 644 281 239 194 0 31 0
Current children cumulated CPU time (s) 0.04
Current children cumulated vsize (KiB) 5144

[startup+0.205647 s]
/proc/loadavg: 1.10 1.03 1.01 5/36 31887
/proc/meminfo: memFree=580124/1048576 swapFree=0/0
[pid=31884] ppid=31883 vsize=2568 CPUtime=0
/proc/31884/stat : 31884 (p2cudf-user-1.1) S 31883 31884 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 66759738 2629632 270 1283457024 134512640 135304128 4292722608 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31884/statm: 642 270 230 194 0 29 0
[pid=31885] ppid=31884 vsize=2576 CPUtime=0.04
/proc/31885/stat : 31885 (p2cudf) S 31884 31884 19908 34817 19908 4202496 392 3010 0 1 0 0 2 2 25 0 1 0 66759738 2637824 281 1283457024 134512640 135304128 4293349488 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31885/statm: 644 281 239 194 0 31 0
Current children cumulated CPU time (s) 0.04
Current children cumulated vsize (KiB) 5144

[startup+0.305657 s]
/proc/loadavg: 1.10 1.03 1.01 5/36 31887
/proc/meminfo: memFree=580124/1048576 swapFree=0/0
[pid=31884] ppid=31883 vsize=2568 CPUtime=0
/proc/31884/stat : 31884 (p2cudf-user-1.1) S 31883 31884 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 66759738 2629632 270 1283457024 134512640 135304128 4292722608 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31884/statm: 642 270 230 194 0 29 0
[pid=31885] ppid=31884 vsize=2576 CPUtime=0.04
/proc/31885/stat : 31885 (p2cudf) S 31884 31884 19908 34817 19908 4202496 392 3010 0 1 0 0 2 2 25 0 1 0 66759738 2637824 281 1283457024 134512640 135304128 4293349488 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31885/statm: 644 281 239 194 0 31 0
Current children cumulated CPU time (s) 0.04
Current children cumulated vsize (KiB) 5144

[startup+0.705742 s]
/proc/loadavg: 1.10 1.03 1.01 5/36 31887
/proc/meminfo: memFree=580124/1048576 swapFree=0/0
[pid=31884] ppid=31883 vsize=2568 CPUtime=0
/proc/31884/stat : 31884 (p2cudf-user-1.1) S 31883 31884 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 66759738 2629632 270 1283457024 134512640 135304128 4292722608 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31884/statm: 642 270 230 194 0 29 0
[pid=31885] ppid=31884 vsize=2576 CPUtime=0.04
/proc/31885/stat : 31885 (p2cudf) S 31884 31884 19908 34817 19908 4202496 392 3010 0 1 0 0 2 2 25 0 1 0 66759738 2637824 281 1283457024 134512640 135304128 4293349488 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31885/statm: 644 281 239 194 0 31 0
Current children cumulated CPU time (s) 0.04
Current children cumulated vsize (KiB) 5144

[startup+1.50592 s]
/proc/loadavg: 1.10 1.03 1.01 4/45 31907
/proc/meminfo: memFree=527164/1048576 swapFree=0/0
[pid=31884] ppid=31883 vsize=2568 CPUtime=0
/proc/31884/stat : 31884 (p2cudf-user-1.1) S 31883 31884 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 66759738 2629632 270 1283457024 134512640 135304128 4292722608 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31884/statm: 642 270 230 194 0 29 0
[pid=31885] ppid=31884 vsize=2576 CPUtime=0.04
/proc/31885/stat : 31885 (p2cudf) S 31884 31884 19908 34817 19908 4202496 392 3010 0 1 0 0 2 2 25 0 1 0 66759738 2637824 281 1283457024 134512640 135304128 4293349488 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31885/statm: 644 281 239 194 0 31 0
[pid=31898] ppid=31885 vsize=889272 CPUtime=1.46
/proc/31898/stat : 31898 (java) S 31885 31884 19908 34817 19908 4202496 21440 0 1 0 138 8 0 0 25 0 10 0 66759741 910614528 18350 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/31898/statm: 222318 18350 1734 10 0 219409 0
[pid=31898/tid=31899] ppid=31885 vsize=889272 CPUtime=0.63
/proc/31898/task/31899/stat : 31899 (java) R 31885 31884 19908 34817 19908 4202560 9147 0 1 0 58 5 0 0 25 0 10 0 66759742 910614528 18350 1283457024 134512640 134550932 4289016560 18446744073709551615 4095213958 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=31898/tid=31900] ppid=31885 vsize=889272 CPUtime=0
/proc/31898/task/31900/stat : 31900 (java) S 31885 31884 19908 34817 19908 4202560 7 0 0 0 0 0 0 0 18 0 10 0 66759743 910614528 18350 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31901] ppid=31885 vsize=889272 CPUtime=0
/proc/31898/task/31901/stat : 31901 (java) S 31885 31884 19908 34817 19908 4202560 8 0 0 0 0 0 0 0 25 0 10 0 66759744 910614528 18350 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31902] ppid=31885 vsize=889272 CPUtime=0
/proc/31898/task/31902/stat : 31902 (java) S 31885 31884 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 10 0 66759744 910614528 18350 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31903] ppid=31885 vsize=889272 CPUtime=0
/proc/31898/task/31903/stat : 31903 (java) S 31885 31884 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 10 0 66759746 910614528 18350 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31904] ppid=31885 vsize=889272 CPUtime=0.54
/proc/31898/task/31904/stat : 31904 (java) R 31885 31884 19908 34817 19908 4202560 5160 0 0 0 53 1 0 0 25 0 10 0 66759746 910614528 18350 1283457024 134512640 134550932 4289016560 18446744073709551615 4150113165 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=31898/tid=31905] ppid=31885 vsize=889272 CPUtime=0.28
/proc/31898/task/31905/stat : 31905 (java) R 31885 31884 19908 34817 19908 4202560 6051 0 0 0 26 2 0 0 22 0 10 0 66759746 910614528 18350 1283457024 134512640 134550932 4289016560 18446744073709551615 4150111076 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=31898/tid=31906] ppid=31885 vsize=889272 CPUtime=0
/proc/31898/task/31906/stat : 31906 (java) S 31885 31884 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 10 0 66759746 910614528 18350 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31907] ppid=31885 vsize=889272 CPUtime=0
/proc/31898/task/31907/stat : 31907 (java) S 31885 31884 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 10 0 66759746 910614528 18350 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 1.5
Current children cumulated vsize (KiB) 894416

[startup+3.10633 s]
/proc/loadavg: 1.10 1.03 1.01 2/45 31907
/proc/meminfo: memFree=420028/1048576 swapFree=0/0
[pid=31884] ppid=31883 vsize=2568 CPUtime=0
/proc/31884/stat : 31884 (p2cudf-user-1.1) S 31883 31884 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 66759738 2629632 270 1283457024 134512640 135304128 4292722608 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31884/statm: 642 270 230 194 0 29 0
[pid=31885] ppid=31884 vsize=2576 CPUtime=0.04
/proc/31885/stat : 31885 (p2cudf) S 31884 31884 19908 34817 19908 4202496 392 3010 0 1 0 0 2 2 25 0 1 0 66759738 2637824 281 1283457024 134512640 135304128 4293349488 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31885/statm: 644 281 239 194 0 31 0
[pid=31898] ppid=31885 vsize=885988 CPUtime=3.05
/proc/31898/stat : 31898 (java) S 31885 31884 19908 34817 19908 4202496 71132 0 1 0 283 22 0 0 25 0 10 0 66759741 907251712 67418 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/31898/statm: 221497 67418 1752 10 0 218588 0
[pid=31898/tid=31899] ppid=31885 vsize=885988 CPUtime=1.54
/proc/31898/task/31899/stat : 31899 (java) R 31885 31884 19908 34817 19908 4202560 50087 0 1 0 136 18 0 0 25 0 10 0 66759742 907251712 67418 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=31898/tid=31900] ppid=31885 vsize=885988 CPUtime=0.19
/proc/31898/task/31900/stat : 31900 (java) R 31885 31884 19908 34817 19908 4202560 8490 0 0 0 18 1 0 0 18 0 10 0 66759743 907251712 67418 1283457024 134512640 134550932 4289016560 18446744073709551615 4152793720 0 0 0 16800975 0 0 0 -1 0 0 0 0
[pid=31898/tid=31901] ppid=31885 vsize=885988 CPUtime=0
/proc/31898/task/31901/stat : 31901 (java) S 31885 31884 19908 34817 19908 4202560 8 0 0 0 0 0 0 0 25 0 10 0 66759744 907251712 67418 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31902] ppid=31885 vsize=885988 CPUtime=0
/proc/31898/task/31902/stat : 31902 (java) S 31885 31884 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 10 0 66759744 907251712 67418 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31903] ppid=31885 vsize=885988 CPUtime=0
/proc/31898/task/31903/stat : 31903 (java) S 31885 31884 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 10 0 66759746 907251712 67418 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31904] ppid=31885 vsize=885988 CPUtime=0.84
/proc/31898/task/31904/stat : 31904 (java) S 31885 31884 19908 34817 19908 4202560 5194 0 0 0 83 1 0 0 19 0 10 0 66759746 907251712 67418 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31905] ppid=31885 vsize=885988 CPUtime=0.46
/proc/31898/task/31905/stat : 31905 (java) S 31885 31884 19908 34817 19908 4202560 6286 0 0 0 44 2 0 0 17 0 10 0 66759746 907251712 67418 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31906] ppid=31885 vsize=885988 CPUtime=0
/proc/31898/task/31906/stat : 31906 (java) S 31885 31884 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 10 0 66759746 907251712 67418 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31907] ppid=31885 vsize=885988 CPUtime=0
/proc/31898/task/31907/stat : 31907 (java) S 31885 31884 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 10 0 66759746 907251712 67418 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 3.09
Current children cumulated vsize (KiB) 891132

[startup+6.30715 s]
/proc/loadavg: 1.09 1.03 1.01 2/46 31908
/proc/meminfo: memFree=303468/1048576 swapFree=0/0
[pid=31884] ppid=31883 vsize=2568 CPUtime=0
/proc/31884/stat : 31884 (p2cudf-user-1.1) S 31883 31884 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 66759738 2629632 270 1283457024 134512640 135304128 4292722608 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31884/statm: 642 270 230 194 0 29 0
[pid=31885] ppid=31884 vsize=2576 CPUtime=0.04
/proc/31885/stat : 31885 (p2cudf) S 31884 31884 19908 34817 19908 4202496 392 3010 0 1 0 0 2 2 25 0 1 0 66759738 2637824 281 1283457024 134512640 135304128 4293349488 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31885/statm: 644 281 239 194 0 31 0
[pid=31898] ppid=31885 vsize=887124 CPUtime=6.25
/proc/31898/stat : 31898 (java) S 31885 31884 19908 34817 19908 4202496 75148 0 1 0 600 25 0 0 25 0 11 0 66759741 908414976 70734 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/31898/statm: 221781 70734 1781 10 0 218872 0
[pid=31898/tid=31899] ppid=31885 vsize=887124 CPUtime=3.5
/proc/31898/task/31899/stat : 31899 (java) R 31885 31884 19908 34817 19908 4202560 50274 0 1 0 330 20 0 0 25 0 11 0 66759742 908414976 70734 1283457024 134512640 134550932 4289016560 18446744073709551615 4096287895 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=31898/tid=31900] ppid=31885 vsize=887124 CPUtime=0.25
/proc/31898/task/31900/stat : 31900 (java) S 31885 31884 19908 34817 19908 4202560 11255 0 0 0 23 2 0 0 16 0 11 0 66759743 908414976 70734 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31901] ppid=31885 vsize=887124 CPUtime=0
/proc/31898/task/31901/stat : 31901 (java) S 31885 31884 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 66759744 908414976 70734 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31902] ppid=31885 vsize=887124 CPUtime=0
/proc/31898/task/31902/stat : 31902 (java) S 31885 31884 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 66759744 908414976 70734 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31903] ppid=31885 vsize=887124 CPUtime=0
/proc/31898/task/31903/stat : 31903 (java) S 31885 31884 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 66759746 908414976 70734 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31904] ppid=31885 vsize=887124 CPUtime=2.01
/proc/31898/task/31904/stat : 31904 (java) S 31885 31884 19908 34817 19908 4202560 6251 0 0 0 200 1 0 0 16 0 11 0 66759746 908414976 70734 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31905] ppid=31885 vsize=887124 CPUtime=0.46
/proc/31898/task/31905/stat : 31905 (java) S 31885 31884 19908 34817 19908 4202560 6286 0 0 0 44 2 0 0 17 0 11 0 66759746 908414976 70734 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31906] ppid=31885 vsize=887124 CPUtime=0
/proc/31898/task/31906/stat : 31906 (java) S 31885 31884 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 66759746 908414976 70734 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31907] ppid=31885 vsize=887124 CPUtime=0
/proc/31898/task/31907/stat : 31907 (java) S 31885 31884 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 66759746 908414976 70734 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31908] ppid=31885 vsize=887124 CPUtime=0
/proc/31898/task/31908/stat : 31908 (java) S 31885 31884 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 66760159 908414976 70734 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 6.29
Current children cumulated vsize (KiB) 892268

[startup+12.7089 s]
/proc/loadavg: 1.08 1.03 1.01 3/46 31908
/proc/meminfo: memFree=269740/1048576 swapFree=0/0
[pid=31884] ppid=31883 vsize=2568 CPUtime=0
/proc/31884/stat : 31884 (p2cudf-user-1.1) S 31883 31884 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 66759738 2629632 270 1283457024 134512640 135304128 4292722608 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31884/statm: 642 270 230 194 0 29 0
[pid=31885] ppid=31884 vsize=2576 CPUtime=0.04
/proc/31885/stat : 31885 (p2cudf) S 31884 31884 19908 34817 19908 4202496 392 3010 0 1 0 0 2 2 25 0 1 0 66759738 2637824 281 1283457024 134512640 135304128 4293349488 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31885/statm: 644 281 239 194 0 31 0
[pid=31898] ppid=31885 vsize=886180 CPUtime=12.65
/proc/31898/stat : 31898 (java) S 31885 31884 19908 34817 19908 4202496 83725 0 1 0 1237 28 0 0 25 0 11 0 66759741 907448320 79107 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/31898/statm: 221545 79107 1786 10 0 218636 0
[pid=31898/tid=31899] ppid=31885 vsize=886180 CPUtime=9.03
/proc/31898/task/31899/stat : 31899 (java) R 31885 31884 19908 34817 19908 4202560 50275 0 1 0 883 20 0 0 25 0 11 0 66759742 907448320 79107 1283457024 134512640 134550932 4289016560 18446744073709551615 4096087980 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=31898/tid=31900] ppid=31885 vsize=886180 CPUtime=0.99
/proc/31898/task/31900/stat : 31900 (java) S 31885 31884 19908 34817 19908 4202560 19811 0 0 0 94 5 0 0 15 0 11 0 66759743 907448320 79107 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31901] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31901/stat : 31901 (java) S 31885 31884 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 66759744 907448320 79107 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31902] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31902/stat : 31902 (java) S 31885 31884 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 66759744 907448320 79107 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31903] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31903/stat : 31903 (java) S 31885 31884 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 66759746 907448320 79107 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31904] ppid=31885 vsize=886180 CPUtime=2.15
/proc/31898/task/31904/stat : 31904 (java) S 31885 31884 19908 34817 19908 4202560 6271 0 0 0 214 1 0 0 16 0 11 0 66759746 907448320 79107 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31905] ppid=31885 vsize=886180 CPUtime=0.46
/proc/31898/task/31905/stat : 31905 (java) S 31885 31884 19908 34817 19908 4202560 6286 0 0 0 44 2 0 0 17 0 11 0 66759746 907448320 79107 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31906] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31906/stat : 31906 (java) S 31885 31884 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 66759746 907448320 79107 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31907] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31907/stat : 31907 (java) R 31885 31884 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 66759746 907448320 79107 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=31898/tid=31908] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31908/stat : 31908 (java) S 31885 31884 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 66760159 907448320 79107 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 12.69
Current children cumulated vsize (KiB) 891324

[startup+25.5116 s]
/proc/loadavg: 1.07 1.03 1.00 3/46 31908
/proc/meminfo: memFree=269740/1048576 swapFree=0/0
[pid=31884] ppid=31883 vsize=2568 CPUtime=0
/proc/31884/stat : 31884 (p2cudf-user-1.1) S 31883 31884 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 66759738 2629632 270 1283457024 134512640 135304128 4292722608 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31884/statm: 642 270 230 194 0 29 0
[pid=31885] ppid=31884 vsize=2576 CPUtime=0.04
/proc/31885/stat : 31885 (p2cudf) S 31884 31884 19908 34817 19908 4202496 392 3010 0 1 0 0 2 2 25 0 1 0 66759738 2637824 281 1283457024 134512640 135304128 4293349488 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31885/statm: 644 281 239 194 0 31 0
[pid=31898] ppid=31885 vsize=886180 CPUtime=25.44
/proc/31898/stat : 31898 (java) S 31885 31884 19908 34817 19908 4202496 83736 0 1 0 2516 28 0 0 25 0 11 0 66759741 907448320 79118 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/31898/statm: 221545 79118 1788 10 0 218636 0
[pid=31898/tid=31899] ppid=31885 vsize=886180 CPUtime=20.88
/proc/31898/task/31899/stat : 31899 (java) R 31885 31884 19908 34817 19908 4202560 50275 0 1 0 2068 20 0 0 25 0 11 0 66759742 907448320 79118 1283457024 134512640 134550932 4289016560 18446744073709551615 4096287895 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=31898/tid=31900] ppid=31885 vsize=886180 CPUtime=1.87
/proc/31898/task/31900/stat : 31900 (java) S 31885 31884 19908 34817 19908 4202560 19811 0 0 0 182 5 0 0 15 0 11 0 66759743 907448320 79118 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31901] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31901/stat : 31901 (java) S 31885 31884 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 66759744 907448320 79118 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31902] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31902/stat : 31902 (java) S 31885 31884 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 66759744 907448320 79118 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31903] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31903/stat : 31903 (java) S 31885 31884 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 66759746 907448320 79118 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31904] ppid=31885 vsize=886180 CPUtime=2.21
/proc/31898/task/31904/stat : 31904 (java) S 31885 31884 19908 34817 19908 4202560 6282 0 0 0 220 1 0 0 15 0 11 0 66759746 907448320 79118 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31905] ppid=31885 vsize=886180 CPUtime=0.46
/proc/31898/task/31905/stat : 31905 (java) S 31885 31884 19908 34817 19908 4202560 6286 0 0 0 44 2 0 0 17 0 11 0 66759746 907448320 79118 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31906] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31906/stat : 31906 (java) S 31885 31884 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 66759746 907448320 79118 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31907] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31907/stat : 31907 (java) S 31885 31884 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 66759746 907448320 79118 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31908] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31908/stat : 31908 (java) S 31885 31884 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 66760159 907448320 79118 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 25.48
Current children cumulated vsize (KiB) 891324

[startup+51.1076 s]
/proc/loadavg: 1.04 1.02 1.00 2/46 31908
/proc/meminfo: memFree=268252/1048576 swapFree=0/0
[pid=31884] ppid=31883 vsize=2568 CPUtime=0
/proc/31884/stat : 31884 (p2cudf-user-1.1) S 31883 31884 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 66759738 2629632 270 1283457024 134512640 135304128 4292722608 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31884/statm: 642 270 230 194 0 29 0
[pid=31885] ppid=31884 vsize=2576 CPUtime=0.04
/proc/31885/stat : 31885 (p2cudf) S 31884 31884 19908 34817 19908 4202496 392 3010 0 1 0 0 2 2 25 0 1 0 66759738 2637824 281 1283457024 134512640 135304128 4293349488 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31885/statm: 644 281 239 194 0 31 0
[pid=31898] ppid=31885 vsize=886180 CPUtime=51.02
/proc/31898/stat : 31898 (java) S 31885 31884 19908 34817 19908 4202496 84069 0 1 0 5074 28 0 0 25 0 11 0 66759741 907448320 79451 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/31898/statm: 221545 79451 1788 10 0 218636 0
[pid=31898/tid=31899] ppid=31885 vsize=886180 CPUtime=45.6
/proc/31898/task/31899/stat : 31899 (java) R 31885 31884 19908 34817 19908 4202560 50275 0 1 0 4540 20 0 0 25 0 11 0 66759742 907448320 79451 1283457024 134512640 134550932 4289016560 18446744073709551615 4096288384 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=31898/tid=31900] ppid=31885 vsize=886180 CPUtime=2.73
/proc/31898/task/31900/stat : 31900 (java) S 31885 31884 19908 34817 19908 4202560 20144 0 0 0 268 5 0 0 15 0 11 0 66759743 907448320 79451 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31901] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31901/stat : 31901 (java) S 31885 31884 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 66759744 907448320 79451 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31902] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31902/stat : 31902 (java) S 31885 31884 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 66759744 907448320 79451 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31903] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31903/stat : 31903 (java) S 31885 31884 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 66759746 907448320 79451 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31904] ppid=31885 vsize=886180 CPUtime=2.21
/proc/31898/task/31904/stat : 31904 (java) S 31885 31884 19908 34817 19908 4202560 6282 0 0 0 220 1 0 0 15 0 11 0 66759746 907448320 79451 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31905] ppid=31885 vsize=886180 CPUtime=0.46
/proc/31898/task/31905/stat : 31905 (java) S 31885 31884 19908 34817 19908 4202560 6286 0 0 0 44 2 0 0 17 0 11 0 66759746 907448320 79451 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31906] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31906/stat : 31906 (java) S 31885 31884 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 66759746 907448320 79451 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31907] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31907/stat : 31907 (java) S 31885 31884 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 66759746 907448320 79451 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31908] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31908/stat : 31908 (java) S 31885 31884 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 66760159 907448320 79451 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 51.06
Current children cumulated vsize (KiB) 891324

[startup+102.309 s]
/proc/loadavg: 1.13 1.05 1.01 2/48 31914
/proc/meminfo: memFree=264880/1048576 swapFree=0/0
[pid=31884] ppid=31883 vsize=2568 CPUtime=0
/proc/31884/stat : 31884 (p2cudf-user-1.1) S 31883 31884 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 66759738 2629632 270 1283457024 134512640 135304128 4292722608 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31884/statm: 642 270 230 194 0 29 0
[pid=31885] ppid=31884 vsize=2576 CPUtime=0.04
/proc/31885/stat : 31885 (p2cudf) S 31884 31884 19908 34817 19908 4202496 392 3010 0 1 0 0 2 2 25 0 1 0 66759738 2637824 281 1283457024 134512640 135304128 4293349488 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31885/statm: 644 281 239 194 0 31 0
[pid=31898] ppid=31885 vsize=886180 CPUtime=102.17
/proc/31898/stat : 31898 (java) S 31885 31884 19908 34817 19908 4202496 84841 0 1 0 10189 28 0 0 25 0 11 0 66759741 907448320 80223 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/31898/statm: 221545 80223 1788 10 0 218636 0
[pid=31898/tid=31899] ppid=31885 vsize=886180 CPUtime=94.52
/proc/31898/task/31899/stat : 31899 (java) R 31885 31884 19908 34817 19908 4202560 50275 0 1 0 9432 20 0 0 25 0 11 0 66759742 907448320 80223 1283457024 134512640 134550932 4289016560 18446744073709551615 4096088431 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=31898/tid=31900] ppid=31885 vsize=886180 CPUtime=4.95
/proc/31898/task/31900/stat : 31900 (java) S 31885 31884 19908 34817 19908 4202560 20916 0 0 0 490 5 0 0 15 0 11 0 66759743 907448320 80223 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31901] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31901/stat : 31901 (java) S 31885 31884 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 66759744 907448320 80223 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31902] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31902/stat : 31902 (java) S 31885 31884 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 66759744 907448320 80223 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31903] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31903/stat : 31903 (java) S 31885 31884 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 66759746 907448320 80223 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31904] ppid=31885 vsize=886180 CPUtime=2.21
/proc/31898/task/31904/stat : 31904 (java) S 31885 31884 19908 34817 19908 4202560 6282 0 0 0 220 1 0 0 15 0 11 0 66759746 907448320 80223 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31905] ppid=31885 vsize=886180 CPUtime=0.46
/proc/31898/task/31905/stat : 31905 (java) S 31885 31884 19908 34817 19908 4202560 6286 0 0 0 44 2 0 0 17 0 11 0 66759746 907448320 80223 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31906] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31906/stat : 31906 (java) S 31885 31884 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 66759746 907448320 80223 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31907] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31907/stat : 31907 (java) S 31885 31884 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 66759746 907448320 80223 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31908] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31908/stat : 31908 (java) S 31885 31884 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 66760159 907448320 80223 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 102.21
Current children cumulated vsize (KiB) 891324

[startup+162.313 s]
/proc/loadavg: 1.04 1.04 1.00 3/47 31919
/proc/meminfo: memFree=259564/1048576 swapFree=0/0
[pid=31884] ppid=31883 vsize=2568 CPUtime=0
/proc/31884/stat : 31884 (p2cudf-user-1.1) S 31883 31884 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 66759738 2629632 270 1283457024 134512640 135304128 4292722608 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31884/statm: 642 270 230 194 0 29 0
[pid=31885] ppid=31884 vsize=2576 CPUtime=0.04
/proc/31885/stat : 31885 (p2cudf) S 31884 31884 19908 34817 19908 4202496 392 3010 0 1 0 0 2 2 25 0 1 0 66759738 2637824 281 1283457024 134512640 135304128 4293349488 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31885/statm: 644 281 239 194 0 31 0
[pid=31898] ppid=31885 vsize=886180 CPUtime=162.12
/proc/31898/stat : 31898 (java) S 31885 31884 19908 34817 19908 4202496 86132 0 1 0 16183 29 0 0 25 0 11 0 66759741 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/31898/statm: 221545 81514 1788 10 0 218636 0
[pid=31898/tid=31899] ppid=31885 vsize=886180 CPUtime=153.1
/proc/31898/task/31899/stat : 31899 (java) R 31885 31884 19908 34817 19908 4202560 50275 0 1 0 15289 21 0 0 25 0 11 0 66759742 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4096224143 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=31898/tid=31900] ppid=31885 vsize=886180 CPUtime=6.31
/proc/31898/task/31900/stat : 31900 (java) S 31885 31884 19908 34817 19908 4202560 22207 0 0 0 626 5 0 0 15 0 11 0 66759743 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31901] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31901/stat : 31901 (java) S 31885 31884 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 66759744 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31902] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31902/stat : 31902 (java) S 31885 31884 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 66759744 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31903] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31903/stat : 31903 (java) S 31885 31884 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 66759746 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31904] ppid=31885 vsize=886180 CPUtime=2.23
/proc/31898/task/31904/stat : 31904 (java) S 31885 31884 19908 34817 19908 4202560 6282 0 0 0 222 1 0 0 15 0 11 0 66759746 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31905] ppid=31885 vsize=886180 CPUtime=0.46
/proc/31898/task/31905/stat : 31905 (java) S 31885 31884 19908 34817 19908 4202560 6286 0 0 0 44 2 0 0 17 0 11 0 66759746 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31906] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31906/stat : 31906 (java) S 31885 31884 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 66759746 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31907] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31907/stat : 31907 (java) R 31885 31884 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 66759746 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=31898/tid=31908] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31908/stat : 31908 (java) S 31885 31884 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 66760159 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 162.16
Current children cumulated vsize (KiB) 891324

[startup+222.308 s]
/proc/loadavg: 1.01 1.03 1.00 2/46 31919
/proc/meminfo: memFree=259572/1048576 swapFree=0/0
[pid=31884] ppid=31883 vsize=2568 CPUtime=0
/proc/31884/stat : 31884 (p2cudf-user-1.1) S 31883 31884 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 66759738 2629632 270 1283457024 134512640 135304128 4292722608 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31884/statm: 642 270 230 194 0 29 0
[pid=31885] ppid=31884 vsize=2576 CPUtime=0.04
/proc/31885/stat : 31885 (p2cudf) S 31884 31884 19908 34817 19908 4202496 392 3010 0 1 0 0 2 2 25 0 1 0 66759738 2637824 281 1283457024 134512640 135304128 4293349488 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31885/statm: 644 281 239 194 0 31 0
[pid=31898] ppid=31885 vsize=886180 CPUtime=222.04
/proc/31898/stat : 31898 (java) S 31885 31884 19908 34817 19908 4202496 86132 0 1 0 22175 29 0 0 25 0 11 0 66759741 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/31898/statm: 221545 81514 1788 10 0 218636 0
[pid=31898/tid=31899] ppid=31885 vsize=886180 CPUtime=211.82
/proc/31898/task/31899/stat : 31899 (java) R 31885 31884 19908 34817 19908 4202560 50275 0 1 0 21161 21 0 0 25 0 11 0 66759742 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4096287873 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=31898/tid=31900] ppid=31885 vsize=886180 CPUtime=7.51
/proc/31898/task/31900/stat : 31900 (java) S 31885 31884 19908 34817 19908 4202560 22207 0 0 0 746 5 0 0 15 0 11 0 66759743 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31901] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31901/stat : 31901 (java) S 31885 31884 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 66759744 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31902] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31902/stat : 31902 (java) S 31885 31884 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 66759744 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31903] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31903/stat : 31903 (java) S 31885 31884 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 66759746 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31904] ppid=31885 vsize=886180 CPUtime=2.23
/proc/31898/task/31904/stat : 31904 (java) S 31885 31884 19908 34817 19908 4202560 6282 0 0 0 222 1 0 0 15 0 11 0 66759746 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31905] ppid=31885 vsize=886180 CPUtime=0.46
/proc/31898/task/31905/stat : 31905 (java) S 31885 31884 19908 34817 19908 4202560 6286 0 0 0 44 2 0 0 17 0 11 0 66759746 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31906] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31906/stat : 31906 (java) S 31885 31884 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 66759746 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31907] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31907/stat : 31907 (java) S 31885 31884 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 66759746 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31908] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31908/stat : 31908 (java) S 31885 31884 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 66760159 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 222.08
Current children cumulated vsize (KiB) 891324

[startup+282.303 s]
/proc/loadavg: 1.08 1.05 1.01 3/46 31919
/proc/meminfo: memFree=259572/1048576 swapFree=0/0
[pid=31884] ppid=31883 vsize=2568 CPUtime=0
/proc/31884/stat : 31884 (p2cudf-user-1.1) S 31883 31884 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 66759738 2629632 270 1283457024 134512640 135304128 4292722608 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31884/statm: 642 270 230 194 0 29 0
[pid=31885] ppid=31884 vsize=2576 CPUtime=0.04
/proc/31885/stat : 31885 (p2cudf) S 31884 31884 19908 34817 19908 4202496 392 3010 0 1 0 0 2 2 25 0 1 0 66759738 2637824 281 1283457024 134512640 135304128 4293349488 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31885/statm: 644 281 239 194 0 31 0
[pid=31898] ppid=31885 vsize=886180 CPUtime=281.97
/proc/31898/stat : 31898 (java) S 31885 31884 19908 34817 19908 4202496 86132 0 1 0 28167 30 0 0 25 0 11 0 66759741 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/31898/statm: 221545 81514 1788 10 0 218636 0
[pid=31898/tid=31899] ppid=31885 vsize=886180 CPUtime=270.39
/proc/31898/task/31899/stat : 31899 (java) R 31885 31884 19908 34817 19908 4202560 50275 0 1 0 27017 22 0 0 25 0 11 0 66759742 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4096179344 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=31898/tid=31900] ppid=31885 vsize=886180 CPUtime=8.87
/proc/31898/task/31900/stat : 31900 (java) S 31885 31884 19908 34817 19908 4202560 22207 0 0 0 882 5 0 0 15 0 11 0 66759743 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31901] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31901/stat : 31901 (java) S 31885 31884 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 66759744 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31902] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31902/stat : 31902 (java) S 31885 31884 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 66759744 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31903] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31903/stat : 31903 (java) S 31885 31884 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 66759746 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31904] ppid=31885 vsize=886180 CPUtime=2.23
/proc/31898/task/31904/stat : 31904 (java) S 31885 31884 19908 34817 19908 4202560 6282 0 0 0 222 1 0 0 15 0 11 0 66759746 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31905] ppid=31885 vsize=886180 CPUtime=0.46
/proc/31898/task/31905/stat : 31905 (java) S 31885 31884 19908 34817 19908 4202560 6286 0 0 0 44 2 0 0 17 0 11 0 66759746 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31906] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31906/stat : 31906 (java) S 31885 31884 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 66759746 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31907] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31907/stat : 31907 (java) S 31885 31884 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 66759746 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31908] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31908/stat : 31908 (java) S 31885 31884 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 66760159 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 282.01
Current children cumulated vsize (KiB) 891324

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

[startup+283.214 s]
/proc/loadavg: 1.08 1.05 1.01 2/46 31919
/proc/meminfo: memFree=259572/1048576 swapFree=0/0
[pid=31884] ppid=31883 vsize=2568 CPUtime=0
/proc/31884/stat : 31884 (p2cudf-user-1.1) S 31883 31884 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 66759738 2629632 270 1283457024 134512640 135304128 4292722608 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31884/statm: 642 270 230 194 0 29 0
[pid=31885] ppid=31884 vsize=2576 CPUtime=0.04
/proc/31885/stat : 31885 (p2cudf) S 31884 31884 19908 34817 19908 4202496 392 3010 0 1 0 0 2 2 25 0 1 0 66759738 2637824 281 1283457024 134512640 135304128 4293349488 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31885/statm: 644 281 239 194 0 31 0
[pid=31898] ppid=31885 vsize=886180 CPUtime=282.88
/proc/31898/stat : 31898 (java) S 31885 31884 19908 34817 19908 4202496 86132 0 1 0 28258 30 0 0 25 0 11 0 66759741 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/31898/statm: 221545 81514 1788 10 0 218636 0
[pid=31898/tid=31899] ppid=31885 vsize=886180 CPUtime=271.3
/proc/31898/task/31899/stat : 31899 (java) R 31885 31884 19908 34817 19908 4202560 50275 0 1 0 27108 22 0 0 25 0 11 0 66759742 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4096223787 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=31898/tid=31900] ppid=31885 vsize=886180 CPUtime=8.87
/proc/31898/task/31900/stat : 31900 (java) S 31885 31884 19908 34817 19908 4202560 22207 0 0 0 882 5 0 0 15 0 11 0 66759743 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31901] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31901/stat : 31901 (java) S 31885 31884 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 66759744 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31902] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31902/stat : 31902 (java) S 31885 31884 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 66759744 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31903] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31903/stat : 31903 (java) S 31885 31884 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 66759746 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31904] ppid=31885 vsize=886180 CPUtime=2.23
/proc/31898/task/31904/stat : 31904 (java) S 31885 31884 19908 34817 19908 4202560 6282 0 0 0 222 1 0 0 15 0 11 0 66759746 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31905] ppid=31885 vsize=886180 CPUtime=0.46
/proc/31898/task/31905/stat : 31905 (java) S 31885 31884 19908 34817 19908 4202560 6286 0 0 0 44 2 0 0 17 0 11 0 66759746 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31906] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31906/stat : 31906 (java) S 31885 31884 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 66759746 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31907] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31907/stat : 31907 (java) S 31885 31884 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 66759746 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31908] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31908/stat : 31908 (java) S 31885 31884 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 66760159 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 282.92
Current children cumulated vsize (KiB) 891324

[startup+284.014 s]
/proc/loadavg: 1.08 1.05 1.01 2/46 31919
/proc/meminfo: memFree=259572/1048576 swapFree=0/0
[pid=31884] ppid=31883 vsize=2568 CPUtime=0
/proc/31884/stat : 31884 (p2cudf-user-1.1) S 31883 31884 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 66759738 2629632 270 1283457024 134512640 135304128 4292722608 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31884/statm: 642 270 230 194 0 29 0
[pid=31885] ppid=31884 vsize=2576 CPUtime=0.04
/proc/31885/stat : 31885 (p2cudf) S 31884 31884 19908 34817 19908 4202496 392 3010 0 1 0 0 2 2 25 0 1 0 66759738 2637824 281 1283457024 134512640 135304128 4293349488 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31885/statm: 644 281 239 194 0 31 0
[pid=31898] ppid=31885 vsize=886180 CPUtime=283.68
/proc/31898/stat : 31898 (java) S 31885 31884 19908 34817 19908 4202496 86132 0 1 0 28338 30 0 0 25 0 11 0 66759741 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/31898/statm: 221545 81514 1788 10 0 218636 0
[pid=31898/tid=31899] ppid=31885 vsize=886180 CPUtime=272.1
/proc/31898/task/31899/stat : 31899 (java) R 31885 31884 19908 34817 19908 4202560 50275 0 1 0 27188 22 0 0 25 0 11 0 66759742 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4096169248 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=31898/tid=31900] ppid=31885 vsize=886180 CPUtime=8.87
/proc/31898/task/31900/stat : 31900 (java) S 31885 31884 19908 34817 19908 4202560 22207 0 0 0 882 5 0 0 15 0 11 0 66759743 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31901] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31901/stat : 31901 (java) S 31885 31884 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 66759744 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31902] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31902/stat : 31902 (java) S 31885 31884 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 66759744 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31903] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31903/stat : 31903 (java) S 31885 31884 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 66759746 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31904] ppid=31885 vsize=886180 CPUtime=2.23
/proc/31898/task/31904/stat : 31904 (java) S 31885 31884 19908 34817 19908 4202560 6282 0 0 0 222 1 0 0 15 0 11 0 66759746 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31905] ppid=31885 vsize=886180 CPUtime=0.46
/proc/31898/task/31905/stat : 31905 (java) S 31885 31884 19908 34817 19908 4202560 6286 0 0 0 44 2 0 0 17 0 11 0 66759746 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31906] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31906/stat : 31906 (java) S 31885 31884 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 66759746 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31907] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31907/stat : 31907 (java) R 31885 31884 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 66759746 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=31898/tid=31908] ppid=31885 vsize=886180 CPUtime=0
/proc/31898/task/31908/stat : 31908 (java) S 31885 31884 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 66760159 907448320 81514 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 283.72
Current children cumulated vsize (KiB) 891324

[startup+284.407 s]
/proc/loadavg: 1.08 1.05 1.01 2/46 31919
/proc/meminfo: memFree=259572/1048576 swapFree=0/0
[pid=31884] ppid=31883 vsize=2568 CPUtime=0
/proc/31884/stat : 31884 (p2cudf-user-1.1) S 31883 31884 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 66759738 2629632 270 1283457024 134512640 135304128 4292722608 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31884/statm: 642 270 230 194 0 29 0
[pid=31885] ppid=31884 vsize=2576 CPUtime=0.04
/proc/31885/stat : 31885 (p2cudf) S 31884 31884 19908 34817 19908 4202496 392 3010 0 1 0 0 2 2 25 0 1 0 66759738 2637824 281 1283457024 134512640 135304128 4293349488 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31885/statm: 644 281 239 194 0 31 0
[pid=31898] ppid=31885 vsize=886504 CPUtime=283.91
/proc/31898/stat : 31898 (java) S 31885 31884 19908 34817 19908 4202496 86144 0 1 0 28361 30 0 0 25 0 11 0 66759741 907780096 81526 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/31898/statm: 221626 81526 1789 10 0 218717 0
[pid=31898/tid=31899] ppid=31885 vsize=886504 CPUtime=272.32
/proc/31898/task/31899/stat : 31899 (java) S 31885 31884 19908 34817 19908 4202560 50282 0 1 0 27210 22 0 0 25 0 11 0 66759742 907780096 81526 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31900] ppid=31885 vsize=886504 CPUtime=8.87
/proc/31898/task/31900/stat : 31900 (java) S 31885 31884 19908 34817 19908 4202560 22207 0 0 0 882 5 0 0 16 0 11 0 66759743 907780096 81526 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31901] ppid=31885 vsize=886504 CPUtime=0
/proc/31898/task/31901/stat : 31901 (java) S 31885 31884 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 66759744 907780096 81526 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31902] ppid=31885 vsize=886504 CPUtime=0
/proc/31898/task/31902/stat : 31902 (java) S 31885 31884 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 66759744 907780096 81526 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31903] ppid=31885 vsize=886504 CPUtime=0
/proc/31898/task/31903/stat : 31903 (java) S 31885 31884 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 66759746 907780096 81526 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31904] ppid=31885 vsize=886504 CPUtime=2.24
/proc/31898/task/31904/stat : 31904 (java) S 31885 31884 19908 34817 19908 4202560 6282 0 0 0 223 1 0 0 15 0 11 0 66759746 907780096 81526 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31905] ppid=31885 vsize=886504 CPUtime=0.46
/proc/31898/task/31905/stat : 31905 (java) S 31885 31884 19908 34817 19908 4202560 6286 0 0 0 44 2 0 0 17 0 11 0 66759746 907780096 81526 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31906] ppid=31885 vsize=886504 CPUtime=0
/proc/31898/task/31906/stat : 31906 (java) S 31885 31884 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 66759746 907780096 81526 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31907] ppid=31885 vsize=886504 CPUtime=0
/proc/31898/task/31907/stat : 31907 (java) S 31885 31884 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 66759746 907780096 81526 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 283.95
Current children cumulated vsize (KiB) 891648

[startup+284.807 s]
/proc/loadavg: 1.08 1.05 1.01 2/46 31919
/proc/meminfo: memFree=259572/1048576 swapFree=0/0
[pid=31884] ppid=31883 vsize=2568 CPUtime=0
/proc/31884/stat : 31884 (p2cudf-user-1.1) S 31883 31884 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 66759738 2629632 270 1283457024 134512640 135304128 4292722608 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31884/statm: 642 270 230 194 0 29 0
[pid=31885] ppid=31884 vsize=2576 CPUtime=0.04
/proc/31885/stat : 31885 (p2cudf) S 31884 31884 19908 34817 19908 4202496 392 3010 0 1 0 0 2 2 25 0 1 0 66759738 2637824 281 1283457024 134512640 135304128 4293349488 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/31885/statm: 644 281 239 194 0 31 0
[pid=31898] ppid=31885 vsize=886504 CPUtime=283.94
/proc/31898/stat : 31898 (java) S 31885 31884 19908 34817 19908 4202496 86144 0 1 0 28364 30 0 0 25 0 10 0 66759741 907780096 81526 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/31898/statm: 221626 81526 1789 10 0 218717 0
[pid=31898/tid=31899] ppid=31885 vsize=886504 CPUtime=272.32
/proc/31898/task/31899/stat : 31899 (java) S 31885 31884 19908 34817 19908 4202560 50282 0 1 0 27210 22 0 0 20 0 10 0 66759742 907780096 81526 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31900] ppid=31885 vsize=886504 CPUtime=8.87
/proc/31898/task/31900/stat : 31900 (java) S 31885 31884 19908 34817 19908 4202560 22207 0 0 0 882 5 0 0 16 0 10 0 66759743 907780096 81526 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31901] ppid=31885 vsize=886504 CPUtime=0
/proc/31898/task/31901/stat : 31901 (java) S 31885 31884 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 10 0 66759744 907780096 81526 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31902] ppid=31885 vsize=886504 CPUtime=0
/proc/31898/task/31902/stat : 31902 (java) S 31885 31884 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 10 0 66759744 907780096 81526 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31903] ppid=31885 vsize=886504 CPUtime=0
/proc/31898/task/31903/stat : 31903 (java) S 31885 31884 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 10 0 66759746 907780096 81526 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31904] ppid=31885 vsize=886504 CPUtime=2.26
/proc/31898/task/31904/stat : 31904 (java) S 31885 31884 19908 34817 19908 4202560 6282 0 0 0 225 1 0 0 15 0 10 0 66759746 907780096 81526 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31905] ppid=31885 vsize=886504 CPUtime=0.46
/proc/31898/task/31905/stat : 31905 (java) S 31885 31884 19908 34817 19908 4202560 6286 0 0 0 44 2 0 0 17 0 10 0 66759746 907780096 81526 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31906] ppid=31885 vsize=886504 CPUtime=0
/proc/31898/task/31906/stat : 31906 (java) S 31885 31884 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 10 0 66759746 907780096 81526 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=31898/tid=31907] ppid=31885 vsize=886504 CPUtime=0
/proc/31898/task/31907/stat : 31907 (java) S 31885 31884 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 10 0 66759746 907780096 81526 1283457024 134512640 134550932 4289016560 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 283.98
Current children cumulated vsize (KiB) 891648

Child status: 0
Real time (s): 284.832
CPU time (s): 284.006
CPU user time (s): 283.662
CPU system time (s): 0.344021
CPU usage (%): 99.71
Max. virtual memory (cumulated for all children) (KiB): 894416

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 283.662
system time used= 0.344021
maximum resident set size= 0
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 89943
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= 5916
involuntary context switches= 8712

runsolver used 0 second user time and 0 second system time

The end