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/201108300820/p2cudf-user-1.13/6b0d1da0-c730-11df-a7c5-00163e3d3b7c.cudf.dudf-real.log.runsolver ./p2cudf-user-1.13 /home/misc2010/data/2011/dudf-real//6b0d1da0-c730-11df-a7c5-00163e3d3b7c.cudf /home/misc2010/tmp/201108300820/p2cudf-user-1.13/6b0d1da0-c730-11df-a7c5-00163e3d3b7c.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: 0.85 0.98 0.99 1/33 12279
/proc/meminfo: memFree=936120/1048576 swapFree=0/0
[pid=12279] ppid=12278 vsize=3020 CPUtime=0
/proc/12279/stat : 12279 (runsolver) D 12278 12279 2160 34817 2160 4202560 72 0 0 0 0 0 0 0 25 0 1 0 56190838 3092480 94 1283457024 134512640 134586868 4294553760 18446744073709551615 4294960130 0 0 0 24578 18446744071564332000 0 0 17 0 0 0 0
/proc/12279/statm: 755 94 62 19 0 54 0

[startup+0.145698 s]
/proc/loadavg: 0.85 0.98 0.99 1/33 12279
/proc/meminfo: memFree=936120/1048576 swapFree=0/0
[pid=12279] ppid=12278 vsize=2568 CPUtime=0
/proc/12279/stat : 12279 (p2cudf-user-1.1) S 12278 12279 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 56190838 2629632 270 1283457024 134512640 135304128 4294572400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12279/statm: 642 270 230 194 0 29 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 2568

[startup+0.205697 s]
/proc/loadavg: 0.85 0.98 0.99 1/33 12279
/proc/meminfo: memFree=936120/1048576 swapFree=0/0
[pid=12279] ppid=12278 vsize=2568 CPUtime=0
/proc/12279/stat : 12279 (p2cudf-user-1.1) S 12278 12279 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 56190838 2629632 270 1283457024 134512640 135304128 4294572400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12279/statm: 642 270 230 194 0 29 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 2568

[startup+0.305705 s]
/proc/loadavg: 0.85 0.98 0.99 1/33 12279
/proc/meminfo: memFree=936120/1048576 swapFree=0/0
[pid=12279] ppid=12278 vsize=2568 CPUtime=0
/proc/12279/stat : 12279 (p2cudf-user-1.1) S 12278 12279 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 56190838 2629632 270 1283457024 134512640 135304128 4294572400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12279/statm: 642 270 230 194 0 29 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 2568

[startup+0.70571 s]
/proc/loadavg: 0.85 0.98 0.99 1/33 12279
/proc/meminfo: memFree=936120/1048576 swapFree=0/0
[pid=12279] ppid=12278 vsize=2568 CPUtime=0
/proc/12279/stat : 12279 (p2cudf-user-1.1) S 12278 12279 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 56190838 2629632 270 1283457024 134512640 135304128 4294572400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12279/statm: 642 270 230 194 0 29 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 2568

[startup+1.5079 s]
/proc/loadavg: 0.85 0.98 0.99 4/45 12302
/proc/meminfo: memFree=908248/1048576 swapFree=0/0
[pid=12279] ppid=12278 vsize=2568 CPUtime=0
/proc/12279/stat : 12279 (p2cudf-user-1.1) S 12278 12279 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 56190838 2629632 270 1283457024 134512640 135304128 4294572400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12279/statm: 642 270 230 194 0 29 0
[pid=12281] ppid=12279 vsize=2572 CPUtime=0.02
/proc/12281/stat : 12281 (p2cudf) S 12279 12279 2160 34817 2160 4202496 389 3020 0 1 0 0 1 1 25 0 1 0 56190839 2633728 280 1283457024 134512640 135304128 4288965696 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12281/statm: 643 280 239 194 0 30 0
[pid=12293] ppid=12281 vsize=869680 CPUtime=0.76
/proc/12293/stat : 12293 (java) S 12281 12279 2160 34817 2160 4202496 11774 0 110 0 70 6 0 0 22 0 10 0 56190842 890552320 9726 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/12293/statm: 217420 9726 1729 10 0 214511 0
[pid=12293/tid=12294] ppid=12281 vsize=869680 CPUtime=0.25
/proc/12293/task/12294/stat : 12294 (java) R 12281 12279 2160 34817 2160 4202560 4920 0 15 0 23 2 0 0 25 0 10 0 56190879 890552320 9726 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=12293/tid=12295] ppid=12281 vsize=869680 CPUtime=0
/proc/12293/task/12295/stat : 12295 (java) S 12281 12279 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 10 0 56190889 890552320 9726 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 0 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12296] ppid=12281 vsize=869680 CPUtime=0
/proc/12293/task/12296/stat : 12296 (java) S 12281 12279 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 25 0 10 0 56190889 890552320 9726 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12297] ppid=12281 vsize=869680 CPUtime=0
/proc/12293/task/12297/stat : 12297 (java) S 12281 12279 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 10 0 56190890 890552320 9726 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12298] ppid=12281 vsize=869680 CPUtime=0
/proc/12293/task/12298/stat : 12298 (java) S 12281 12279 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 10 0 56190899 890552320 9726 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12299] ppid=12281 vsize=869680 CPUtime=0.25
/proc/12293/task/12299/stat : 12299 (java) R 12281 12279 2160 34817 2160 4202560 4530 0 1 0 23 2 0 0 23 0 10 0 56190899 890552320 9726 1283457024 134512640 134550932 4290036704 18446744073709551615 4152515275 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=12293/tid=12300] ppid=12281 vsize=869680 CPUtime=0.23
/proc/12293/task/12300/stat : 12300 (java) R 12281 12279 2160 34817 2160 4202560 1332 0 7 0 23 0 0 0 24 0 10 0 56190899 890552320 9726 1283457024 134512640 134550932 4290036704 18446744073709551615 4149000016 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=12293/tid=12301] ppid=12281 vsize=869680 CPUtime=0
/proc/12293/task/12301/stat : 12301 (java) S 12281 12279 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 10 0 56190899 890552320 9726 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12302] ppid=12281 vsize=869680 CPUtime=0
/proc/12293/task/12302/stat : 12302 (java) S 12281 12279 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 17 0 10 0 56190899 890552320 9726 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 0.78
Current children cumulated vsize (KiB) 874820

[startup+3.12821 s]
/proc/loadavg: 1.02 1.01 1.00 3/45 12302
/proc/meminfo: memFree=838128/1048576 swapFree=0/0
[pid=12279] ppid=12278 vsize=2568 CPUtime=0
/proc/12279/stat : 12279 (p2cudf-user-1.1) S 12278 12279 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 56190838 2629632 270 1283457024 134512640 135304128 4294572400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12279/statm: 642 270 230 194 0 29 0
[pid=12281] ppid=12279 vsize=2572 CPUtime=0.02
/proc/12281/stat : 12281 (p2cudf) S 12279 12279 2160 34817 2160 4202496 389 3020 0 1 0 0 1 1 25 0 1 0 56190839 2633728 280 1283457024 134512640 135304128 4288965696 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12281/statm: 643 280 239 194 0 30 0
[pid=12293] ppid=12281 vsize=877408 CPUtime=2.38
/proc/12293/stat : 12293 (java) S 12281 12279 2160 34817 2160 4202496 63500 0 110 0 204 34 0 0 22 0 10 0 56190842 898465792 59863 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/12293/statm: 219352 59863 1746 10 0 216443 0
[pid=12293/tid=12294] ppid=12281 vsize=877408 CPUtime=1.4
/proc/12293/task/12294/stat : 12294 (java) R 12281 12279 2160 34817 2160 4202560 50042 0 15 0 113 27 0 0 25 0 10 0 56190879 898465792 59863 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=12293/tid=12295] ppid=12281 vsize=877408 CPUtime=0.07
/proc/12293/task/12295/stat : 12295 (java) R 12281 12279 2160 34817 2160 4202560 3137 0 0 0 7 0 0 0 15 0 10 0 56190889 898465792 59863 1283457024 134512640 134550932 4290036704 18446744073709551615 4149704328 0 0 0 16800975 0 0 0 -1 0 0 0 0
[pid=12293/tid=12296] ppid=12281 vsize=877408 CPUtime=0
/proc/12293/task/12296/stat : 12296 (java) S 12281 12279 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 25 0 10 0 56190889 898465792 59863 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12297] ppid=12281 vsize=877408 CPUtime=0
/proc/12293/task/12297/stat : 12297 (java) S 12281 12279 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 10 0 56190890 898465792 59863 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12298] ppid=12281 vsize=877408 CPUtime=0
/proc/12293/task/12298/stat : 12298 (java) S 12281 12279 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 10 0 56190899 898465792 59863 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12299] ppid=12281 vsize=877408 CPUtime=0.55
/proc/12293/task/12299/stat : 12299 (java) S 12281 12279 2160 34817 2160 4202560 7990 0 1 0 51 4 0 0 21 0 10 0 56190899 898465792 59863 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12300] ppid=12281 vsize=877408 CPUtime=0.32
/proc/12293/task/12300/stat : 12300 (java) S 12281 12279 2160 34817 2160 4202560 1345 0 7 0 32 0 0 0 17 0 10 0 56190899 898465792 59863 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12301] ppid=12281 vsize=877408 CPUtime=0
/proc/12293/task/12301/stat : 12301 (java) S 12281 12279 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 10 0 56190899 898465792 59863 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12302] ppid=12281 vsize=877408 CPUtime=0
/proc/12293/task/12302/stat : 12302 (java) R 12281 12279 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 15 0 10 0 56190899 898465792 59863 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 2.4
Current children cumulated vsize (KiB) 882548
heavy processes:

[startup+6.3103 s]
/proc/loadavg: 1.02 1.01 1.00 4/45 12302
/proc/meminfo: memFree=655876/1048576 swapFree=0/0
[pid=12279] ppid=12278 vsize=2568 CPUtime=0
/proc/12279/stat : 12279 (p2cudf-user-1.1) S 12278 12279 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 56190838 2629632 270 1283457024 134512640 135304128 4294572400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12279/statm: 642 270 230 194 0 29 0
[pid=12281] ppid=12279 vsize=2572 CPUtime=0.02
/proc/12281/stat : 12281 (p2cudf) S 12279 12279 2160 34817 2160 4202496 389 3020 0 1 0 0 1 1 25 0 1 0 56190839 2633728 280 1283457024 134512640 135304128 4288965696 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12281/statm: 643 280 239 194 0 30 0
[pid=12293] ppid=12281 vsize=877732 CPUtime=5.4
/proc/12293/stat : 12293 (java) S 12281 12279 2160 34817 2160 4202496 73455 0 111 0 506 34 0 0 22 0 11 0 56190842 898797568 69119 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/12293/statm: 219433 69119 1780 10 0 216524 0
[pid=12293/tid=12294] ppid=12281 vsize=877732 CPUtime=2.6
/proc/12293/task/12294/stat : 12294 (java) R 12281 12279 2160 34817 2160 4202560 50277 0 15 0 233 27 0 0 25 0 11 0 56190879 898797568 69119 1283457024 134512640 134550932 4290036704 18446744073709551615 4096552874 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=12293/tid=12295] ppid=12281 vsize=877732 CPUtime=0.25
/proc/12293/task/12295/stat : 12295 (java) S 12281 12279 2160 34817 2160 4202560 11911 0 0 0 25 0 0 0 16 0 11 0 56190889 898797568 69119 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 0 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12296] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12296/stat : 12296 (java) S 12281 12279 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 56190889 898797568 69119 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12297] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12297/stat : 12297 (java) S 12281 12279 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 56190890 898797568 69119 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12298] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12298/stat : 12298 (java) S 12281 12279 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 56190899 898797568 69119 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12299] ppid=12281 vsize=877732 CPUtime=2.19
/proc/12293/task/12299/stat : 12299 (java) S 12281 12279 2160 34817 2160 4202560 8930 0 2 0 215 4 0 0 15 0 11 0 56190899 898797568 69119 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12300] ppid=12281 vsize=877732 CPUtime=0.32
/proc/12293/task/12300/stat : 12300 (java) S 12281 12279 2160 34817 2160 4202560 1345 0 7 0 32 0 0 0 17 0 11 0 56190899 898797568 69119 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12301] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12301/stat : 12301 (java) S 12281 12279 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 56190899 898797568 69119 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12302] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12302/stat : 12302 (java) R 12281 12279 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 15 0 11 0 56190899 898797568 69119 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 5.42
Current children cumulated vsize (KiB) 882872

[startup+12.7116 s]
/proc/loadavg: 1.02 1.01 1.00 3/46 12303
/proc/meminfo: memFree=601932/1048576 swapFree=0/0
[pid=12279] ppid=12278 vsize=2568 CPUtime=0
/proc/12279/stat : 12279 (p2cudf-user-1.1) S 12278 12279 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 56190838 2629632 270 1283457024 134512640 135304128 4294572400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12279/statm: 642 270 230 194 0 29 0
[pid=12281] ppid=12279 vsize=2572 CPUtime=0.02
/proc/12281/stat : 12281 (p2cudf) S 12279 12279 2160 34817 2160 4202496 389 3020 0 1 0 0 1 1 25 0 1 0 56190839 2633728 280 1283457024 134512640 135304128 4288965696 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12281/statm: 643 280 239 194 0 30 0
[pid=12293] ppid=12281 vsize=877732 CPUtime=11.8
/proc/12293/stat : 12293 (java) S 12281 12279 2160 34817 2160 4202496 86887 0 111 0 1140 40 0 0 22 0 11 0 56190842 898797568 82551 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/12293/statm: 219433 82551 1787 10 0 216524 0
[pid=12293/tid=12294] ppid=12281 vsize=877732 CPUtime=7.96
/proc/12293/task/12294/stat : 12294 (java) R 12281 12279 2160 34817 2160 4202560 50279 0 15 0 769 27 0 0 25 0 11 0 56190879 898797568 82551 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=12293/tid=12295] ppid=12281 vsize=877732 CPUtime=0.76
/proc/12293/task/12295/stat : 12295 (java) R 12281 12279 2160 34817 2160 4202560 25284 0 0 0 70 6 0 0 16 0 11 0 56190889 898797568 82551 1283457024 134512640 134550932 4290036704 18446744073709551615 4150485688 0 0 0 16800975 0 0 0 -1 0 0 0 0
[pid=12293/tid=12296] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12296/stat : 12296 (java) S 12281 12279 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 56190889 898797568 82551 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12297] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12297/stat : 12297 (java) S 12281 12279 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 56190890 898797568 82551 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12298] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12298/stat : 12298 (java) S 12281 12279 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 56190899 898797568 82551 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12299] ppid=12281 vsize=877732 CPUtime=2.72
/proc/12293/task/12299/stat : 12299 (java) S 12281 12279 2160 34817 2160 4202560 8987 0 2 0 268 4 0 0 16 0 11 0 56190899 898797568 82551 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12300] ppid=12281 vsize=877732 CPUtime=0.32
/proc/12293/task/12300/stat : 12300 (java) S 12281 12279 2160 34817 2160 4202560 1345 0 7 0 32 0 0 0 17 0 11 0 56190899 898797568 82551 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12301] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12301/stat : 12301 (java) S 12281 12279 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 56190899 898797568 82551 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12302] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12302/stat : 12302 (java) S 12281 12279 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 15 0 11 0 56190899 898797568 82551 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12303] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12303/stat : 12303 (java) S 12281 12279 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 56191393 898797568 82551 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 11.82
Current children cumulated vsize (KiB) 882872

[startup+25.5043 s]
/proc/loadavg: 1.01 1.01 1.00 2/46 12303
/proc/meminfo: memFree=574032/1048576 swapFree=0/0
[pid=12279] ppid=12278 vsize=2568 CPUtime=0
/proc/12279/stat : 12279 (p2cudf-user-1.1) S 12278 12279 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 56190838 2629632 270 1283457024 134512640 135304128 4294572400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12279/statm: 642 270 230 194 0 29 0
[pid=12281] ppid=12279 vsize=2572 CPUtime=0.02
/proc/12281/stat : 12281 (p2cudf) S 12279 12279 2160 34817 2160 4202496 389 3020 0 1 0 0 1 1 25 0 1 0 56190839 2633728 280 1283457024 134512640 135304128 4288965696 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12281/statm: 643 280 239 194 0 30 0
[pid=12293] ppid=12281 vsize=877732 CPUtime=24.59
/proc/12293/stat : 12293 (java) S 12281 12279 2160 34817 2160 4202496 93782 0 111 0 2415 44 0 0 22 0 11 0 56190842 898797568 89446 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/12293/statm: 219433 89446 1787 10 0 216524 0
[pid=12293/tid=12294] ppid=12281 vsize=877732 CPUtime=20.36
/proc/12293/task/12294/stat : 12294 (java) R 12281 12279 2160 34817 2160 4202560 50279 0 15 0 2009 27 0 0 25 0 11 0 56190879 898797568 89446 1283457024 134512640 134550932 4290036704 18446744073709551615 4096697290 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=12293/tid=12295] ppid=12281 vsize=877732 CPUtime=1.07
/proc/12293/task/12295/stat : 12295 (java) S 12281 12279 2160 34817 2160 4202560 32179 0 0 0 97 10 0 0 15 0 11 0 56190889 898797568 89446 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 0 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12296] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12296/stat : 12296 (java) S 12281 12279 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 56190889 898797568 89446 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12297] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12297/stat : 12297 (java) S 12281 12279 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 56190890 898797568 89446 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12298] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12298/stat : 12298 (java) S 12281 12279 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 56190899 898797568 89446 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12299] ppid=12281 vsize=877732 CPUtime=2.8
/proc/12293/task/12299/stat : 12299 (java) S 12281 12279 2160 34817 2160 4202560 8987 0 2 0 276 4 0 0 15 0 11 0 56190899 898797568 89446 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12300] ppid=12281 vsize=877732 CPUtime=0.32
/proc/12293/task/12300/stat : 12300 (java) S 12281 12279 2160 34817 2160 4202560 1345 0 7 0 32 0 0 0 17 0 11 0 56190899 898797568 89446 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12301] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12301/stat : 12301 (java) S 12281 12279 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 56190899 898797568 89446 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12302] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12302/stat : 12302 (java) S 12281 12279 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 15 0 11 0 56190899 898797568 89446 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12303] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12303/stat : 12303 (java) S 12281 12279 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 56191393 898797568 89446 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 24.61
Current children cumulated vsize (KiB) 882872

[startup+51.1021 s]
/proc/loadavg: 1.01 1.01 1.00 2/46 12303
/proc/meminfo: memFree=567212/1048576 swapFree=0/0
[pid=12279] ppid=12278 vsize=2568 CPUtime=0
/proc/12279/stat : 12279 (p2cudf-user-1.1) S 12278 12279 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 56190838 2629632 270 1283457024 134512640 135304128 4294572400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12279/statm: 642 270 230 194 0 29 0
[pid=12281] ppid=12279 vsize=2572 CPUtime=0.02
/proc/12281/stat : 12281 (p2cudf) S 12279 12279 2160 34817 2160 4202496 389 3020 0 1 0 0 1 1 25 0 1 0 56190839 2633728 280 1283457024 134512640 135304128 4288965696 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12281/statm: 643 280 239 194 0 30 0
[pid=12293] ppid=12281 vsize=877732 CPUtime=50.15
/proc/12293/stat : 12293 (java) S 12281 12279 2160 34817 2160 4202496 95462 0 111 0 4971 44 0 0 22 0 11 0 56190842 898797568 91126 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/12293/statm: 219433 91126 1787 10 0 216524 0
[pid=12293/tid=12294] ppid=12281 vsize=877732 CPUtime=45.02
/proc/12293/task/12294/stat : 12294 (java) R 12281 12279 2160 34817 2160 4202560 50279 0 15 0 4475 27 0 0 25 0 11 0 56190879 898797568 91126 1283457024 134512640 134550932 4290036704 18446744073709551615 4096697228 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=12293/tid=12295] ppid=12281 vsize=877732 CPUtime=1.9
/proc/12293/task/12295/stat : 12295 (java) S 12281 12279 2160 34817 2160 4202560 33847 0 0 0 180 10 0 0 15 0 11 0 56190889 898797568 91126 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 0 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12296] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12296/stat : 12296 (java) S 12281 12279 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 56190889 898797568 91126 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12297] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12297/stat : 12297 (java) S 12281 12279 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 56190890 898797568 91126 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12298] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12298/stat : 12298 (java) S 12281 12279 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 56190899 898797568 91126 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12299] ppid=12281 vsize=877732 CPUtime=2.87
/proc/12293/task/12299/stat : 12299 (java) S 12281 12279 2160 34817 2160 4202560 8999 0 2 0 283 4 0 0 16 0 11 0 56190899 898797568 91126 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12300] ppid=12281 vsize=877732 CPUtime=0.32
/proc/12293/task/12300/stat : 12300 (java) S 12281 12279 2160 34817 2160 4202560 1345 0 7 0 32 0 0 0 17 0 11 0 56190899 898797568 91126 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12301] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12301/stat : 12301 (java) S 12281 12279 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 56190899 898797568 91126 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12302] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12302/stat : 12302 (java) S 12281 12279 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 15 0 11 0 56190899 898797568 91126 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12303] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12303/stat : 12303 (java) S 12281 12279 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 56191393 898797568 91126 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 50.17
Current children cumulated vsize (KiB) 882872

[startup+102.313 s]
/proc/loadavg: 1.10 1.03 1.01 2/46 12303
/proc/meminfo: memFree=549108/1048576 swapFree=0/0
[pid=12279] ppid=12278 vsize=2568 CPUtime=0
/proc/12279/stat : 12279 (p2cudf-user-1.1) S 12278 12279 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 56190838 2629632 270 1283457024 134512640 135304128 4294572400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12279/statm: 642 270 230 194 0 29 0
[pid=12281] ppid=12279 vsize=2572 CPUtime=0.02
/proc/12281/stat : 12281 (p2cudf) S 12279 12279 2160 34817 2160 4202496 389 3020 0 1 0 0 1 1 25 0 1 0 56190839 2633728 280 1283457024 134512640 135304128 4288965696 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12281/statm: 643 280 239 194 0 30 0
[pid=12293] ppid=12281 vsize=877732 CPUtime=101.32
/proc/12293/stat : 12293 (java) S 12281 12279 2160 34817 2160 4202496 99929 0 111 0 10086 46 0 0 22 0 11 0 56190842 898797568 95593 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/12293/statm: 219433 95593 1787 10 0 216524 0
[pid=12293/tid=12294] ppid=12281 vsize=877732 CPUtime=95.12
/proc/12293/task/12294/stat : 12294 (java) R 12281 12279 2160 34817 2160 4202560 50279 0 15 0 9485 27 0 0 25 0 11 0 56190879 898797568 95593 1283457024 134512640 134550932 4290036704 18446744073709551615 4096548820 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=12293/tid=12295] ppid=12281 vsize=877732 CPUtime=2.98
/proc/12293/task/12295/stat : 12295 (java) S 12281 12279 2160 34817 2160 4202560 38314 0 0 0 286 12 0 0 15 0 11 0 56190889 898797568 95593 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 0 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12296] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12296/stat : 12296 (java) S 12281 12279 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 56190889 898797568 95593 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12297] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12297/stat : 12297 (java) S 12281 12279 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 56190890 898797568 95593 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12298] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12298/stat : 12298 (java) S 12281 12279 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 56190899 898797568 95593 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12299] ppid=12281 vsize=877732 CPUtime=2.87
/proc/12293/task/12299/stat : 12299 (java) S 12281 12279 2160 34817 2160 4202560 8999 0 2 0 283 4 0 0 16 0 11 0 56190899 898797568 95593 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12300] ppid=12281 vsize=877732 CPUtime=0.32
/proc/12293/task/12300/stat : 12300 (java) S 12281 12279 2160 34817 2160 4202560 1345 0 7 0 32 0 0 0 17 0 11 0 56190899 898797568 95593 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12301] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12301/stat : 12301 (java) S 12281 12279 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 56190899 898797568 95593 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12302] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12302/stat : 12302 (java) S 12281 12279 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 15 0 11 0 56190899 898797568 95593 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12303] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12303/stat : 12303 (java) S 12281 12279 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 56191393 898797568 95593 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 101.34
Current children cumulated vsize (KiB) 882872

[startup+162.306 s]
/proc/loadavg: 1.04 1.03 1.00 2/46 12303
/proc/meminfo: memFree=529516/1048576 swapFree=0/0
[pid=12279] ppid=12278 vsize=2568 CPUtime=0
/proc/12279/stat : 12279 (p2cudf-user-1.1) S 12278 12279 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 56190838 2629632 270 1283457024 134512640 135304128 4294572400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12279/statm: 642 270 230 194 0 29 0
[pid=12281] ppid=12279 vsize=2572 CPUtime=0.02
/proc/12281/stat : 12281 (p2cudf) S 12279 12279 2160 34817 2160 4202496 389 3020 0 1 0 0 1 1 25 0 1 0 56190839 2633728 280 1283457024 134512640 135304128 4288965696 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12281/statm: 643 280 239 194 0 30 0
[pid=12293] ppid=12281 vsize=877732 CPUtime=161.26
/proc/12293/stat : 12293 (java) S 12281 12279 2160 34817 2160 4202496 104807 0 111 0 16080 46 0 0 22 0 11 0 56190842 898797568 100471 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/12293/statm: 219433 100471 1787 10 0 216524 0
[pid=12293/tid=12294] ppid=12281 vsize=877732 CPUtime=154.23
/proc/12293/task/12294/stat : 12294 (java) R 12281 12279 2160 34817 2160 4202560 50279 0 15 0 15396 27 0 0 25 0 11 0 56190879 898797568 100471 1283457024 134512640 134550932 4290036704 18446744073709551615 4096611200 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=12293/tid=12295] ppid=12281 vsize=877732 CPUtime=3.8
/proc/12293/task/12295/stat : 12295 (java) S 12281 12279 2160 34817 2160 4202560 43192 0 0 0 368 12 0 0 15 0 11 0 56190889 898797568 100471 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 0 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12296] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12296/stat : 12296 (java) S 12281 12279 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 56190889 898797568 100471 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12297] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12297/stat : 12297 (java) S 12281 12279 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 56190890 898797568 100471 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12298] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12298/stat : 12298 (java) S 12281 12279 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 56190899 898797568 100471 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12299] ppid=12281 vsize=877732 CPUtime=2.87
/proc/12293/task/12299/stat : 12299 (java) S 12281 12279 2160 34817 2160 4202560 8999 0 2 0 283 4 0 0 16 0 11 0 56190899 898797568 100471 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12300] ppid=12281 vsize=877732 CPUtime=0.32
/proc/12293/task/12300/stat : 12300 (java) S 12281 12279 2160 34817 2160 4202560 1345 0 7 0 32 0 0 0 17 0 11 0 56190899 898797568 100471 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12301] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12301/stat : 12301 (java) S 12281 12279 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 56190899 898797568 100471 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12302] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12302/stat : 12302 (java) S 12281 12279 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 15 0 11 0 56190899 898797568 100471 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12303] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12303/stat : 12303 (java) S 12281 12279 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 56191393 898797568 100471 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 161.28
Current children cumulated vsize (KiB) 882872

[startup+222.309 s]
/proc/loadavg: 1.01 1.02 1.00 2/46 12303
/proc/meminfo: memFree=506328/1048576 swapFree=0/0
[pid=12279] ppid=12278 vsize=2568 CPUtime=0
/proc/12279/stat : 12279 (p2cudf-user-1.1) S 12278 12279 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 56190838 2629632 270 1283457024 134512640 135304128 4294572400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12279/statm: 642 270 230 194 0 29 0
[pid=12281] ppid=12279 vsize=2572 CPUtime=0.02
/proc/12281/stat : 12281 (p2cudf) S 12279 12279 2160 34817 2160 4202496 389 3020 0 1 0 0 1 1 25 0 1 0 56190839 2633728 280 1283457024 134512640 135304128 4288965696 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12281/statm: 643 280 239 194 0 30 0
[pid=12293] ppid=12281 vsize=877732 CPUtime=221.26
/proc/12293/stat : 12293 (java) S 12281 12279 2160 34817 2160 4202496 110578 0 111 0 22079 47 0 0 22 0 11 0 56190842 898797568 106242 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/12293/statm: 219433 106242 1787 10 0 216524 0
[pid=12293/tid=12294] ppid=12281 vsize=877732 CPUtime=213.4
/proc/12293/task/12294/stat : 12294 (java) R 12281 12279 2160 34817 2160 4202560 50279 0 15 0 21312 28 0 0 25 0 11 0 56190879 898797568 106242 1283457024 134512640 134550932 4290036704 18446744073709551615 4096751210 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=12293/tid=12295] ppid=12281 vsize=877732 CPUtime=4.61
/proc/12293/task/12295/stat : 12295 (java) S 12281 12279 2160 34817 2160 4202560 48963 0 0 0 449 12 0 0 15 0 11 0 56190889 898797568 106242 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 0 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12296] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12296/stat : 12296 (java) S 12281 12279 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 56190889 898797568 106242 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12297] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12297/stat : 12297 (java) S 12281 12279 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 56190890 898797568 106242 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12298] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12298/stat : 12298 (java) S 12281 12279 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 56190899 898797568 106242 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12299] ppid=12281 vsize=877732 CPUtime=2.89
/proc/12293/task/12299/stat : 12299 (java) S 12281 12279 2160 34817 2160 4202560 8999 0 2 0 285 4 0 0 15 0 11 0 56190899 898797568 106242 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12300] ppid=12281 vsize=877732 CPUtime=0.32
/proc/12293/task/12300/stat : 12300 (java) S 12281 12279 2160 34817 2160 4202560 1345 0 7 0 32 0 0 0 17 0 11 0 56190899 898797568 106242 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12301] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12301/stat : 12301 (java) S 12281 12279 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 56190899 898797568 106242 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12302] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12302/stat : 12302 (java) R 12281 12279 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 15 0 11 0 56190899 898797568 106242 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=12293/tid=12303] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12303/stat : 12303 (java) S 12281 12279 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 56191393 898797568 106242 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 221.28
Current children cumulated vsize (KiB) 882872

[startup+282.314 s]
/proc/loadavg: 1.00 1.01 1.00 2/48 12309
/proc/meminfo: memFree=506180/1048576 swapFree=0/0
[pid=12279] ppid=12278 vsize=2568 CPUtime=0
/proc/12279/stat : 12279 (p2cudf-user-1.1) S 12278 12279 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 56190838 2629632 270 1283457024 134512640 135304128 4294572400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12279/statm: 642 270 230 194 0 29 0
[pid=12281] ppid=12279 vsize=2572 CPUtime=0.02
/proc/12281/stat : 12281 (p2cudf) S 12279 12279 2160 34817 2160 4202496 389 3020 0 1 0 0 1 1 25 0 1 0 56190839 2633728 280 1283457024 134512640 135304128 4288965696 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12281/statm: 643 280 239 194 0 30 0
[pid=12293] ppid=12281 vsize=877732 CPUtime=281.22
/proc/12293/stat : 12293 (java) S 12281 12279 2160 34817 2160 4202496 110578 0 111 0 28074 48 0 0 22 0 11 0 56190842 898797568 106242 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/12293/statm: 219433 106242 1787 10 0 216524 0
[pid=12293/tid=12294] ppid=12281 vsize=877732 CPUtime=272.76
/proc/12293/task/12294/stat : 12294 (java) R 12281 12279 2160 34817 2160 4202560 50279 0 15 0 27247 29 0 0 25 0 11 0 56190879 898797568 106242 1283457024 134512640 134550932 4290036704 18446744073709551615 4096697330 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=12293/tid=12295] ppid=12281 vsize=877732 CPUtime=5.22
/proc/12293/task/12295/stat : 12295 (java) S 12281 12279 2160 34817 2160 4202560 48963 0 0 0 510 12 0 0 15 0 11 0 56190889 898797568 106242 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 0 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12296] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12296/stat : 12296 (java) S 12281 12279 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 56190889 898797568 106242 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12297] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12297/stat : 12297 (java) S 12281 12279 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 56190890 898797568 106242 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12298] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12298/stat : 12298 (java) S 12281 12279 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 56190899 898797568 106242 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12299] ppid=12281 vsize=877732 CPUtime=2.89
/proc/12293/task/12299/stat : 12299 (java) S 12281 12279 2160 34817 2160 4202560 8999 0 2 0 285 4 0 0 15 0 11 0 56190899 898797568 106242 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12300] ppid=12281 vsize=877732 CPUtime=0.32
/proc/12293/task/12300/stat : 12300 (java) S 12281 12279 2160 34817 2160 4202560 1345 0 7 0 32 0 0 0 17 0 11 0 56190899 898797568 106242 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12301] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12301/stat : 12301 (java) S 12281 12279 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 56190899 898797568 106242 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12302] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12302/stat : 12302 (java) S 12281 12279 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 15 0 11 0 56190899 898797568 106242 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12303] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12303/stat : 12303 (java) S 12281 12279 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 56191393 898797568 106242 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 281.24
Current children cumulated vsize (KiB) 882872

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

[startup+284.804 s]
/proc/loadavg: 1.00 1.01 1.00 2/48 12309
/proc/meminfo: memFree=506056/1048576 swapFree=0/0
[pid=12279] ppid=12278 vsize=2568 CPUtime=0
/proc/12279/stat : 12279 (p2cudf-user-1.1) S 12278 12279 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 56190838 2629632 270 1283457024 134512640 135304128 4294572400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12279/statm: 642 270 230 194 0 29 0
[pid=12281] ppid=12279 vsize=2572 CPUtime=0.02
/proc/12281/stat : 12281 (p2cudf) S 12279 12279 2160 34817 2160 4202496 389 3020 0 1 0 0 1 1 25 0 1 0 56190839 2633728 280 1283457024 134512640 135304128 4288965696 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12281/statm: 643 280 239 194 0 30 0
[pid=12293] ppid=12281 vsize=877732 CPUtime=283.72
/proc/12293/stat : 12293 (java) S 12281 12279 2160 34817 2160 4202496 110578 0 111 0 28324 48 0 0 22 0 11 0 56190842 898797568 106242 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/12293/statm: 219433 106242 1787 10 0 216524 0
[pid=12293/tid=12294] ppid=12281 vsize=877732 CPUtime=275.25
/proc/12293/task/12294/stat : 12294 (java) R 12281 12279 2160 34817 2160 4202560 50279 0 15 0 27496 29 0 0 25 0 11 0 56190879 898797568 106242 1283457024 134512640 134550932 4290036704 18446744073709551615 4096553082 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=12293/tid=12295] ppid=12281 vsize=877732 CPUtime=5.22
/proc/12293/task/12295/stat : 12295 (java) S 12281 12279 2160 34817 2160 4202560 48963 0 0 0 510 12 0 0 15 0 11 0 56190889 898797568 106242 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 0 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12296] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12296/stat : 12296 (java) S 12281 12279 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 56190889 898797568 106242 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12297] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12297/stat : 12297 (java) S 12281 12279 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 56190890 898797568 106242 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12298] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12298/stat : 12298 (java) S 12281 12279 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 56190899 898797568 106242 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12299] ppid=12281 vsize=877732 CPUtime=2.89
/proc/12293/task/12299/stat : 12299 (java) S 12281 12279 2160 34817 2160 4202560 8999 0 2 0 285 4 0 0 15 0 11 0 56190899 898797568 106242 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12300] ppid=12281 vsize=877732 CPUtime=0.32
/proc/12293/task/12300/stat : 12300 (java) S 12281 12279 2160 34817 2160 4202560 1345 0 7 0 32 0 0 0 17 0 11 0 56190899 898797568 106242 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12301] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12301/stat : 12301 (java) S 12281 12279 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 56190899 898797568 106242 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12302] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12302/stat : 12302 (java) S 12281 12279 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 15 0 11 0 56190899 898797568 106242 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12303] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12303/stat : 12303 (java) S 12281 12279 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 56191393 898797568 106242 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 283.74
Current children cumulated vsize (KiB) 882872

[startup+285.604 s]
/proc/loadavg: 1.00 1.01 1.00 2/48 12309
/proc/meminfo: memFree=506056/1048576 swapFree=0/0
[pid=12279] ppid=12278 vsize=2568 CPUtime=0
/proc/12279/stat : 12279 (p2cudf-user-1.1) S 12278 12279 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 56190838 2629632 270 1283457024 134512640 135304128 4294572400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12279/statm: 642 270 230 194 0 29 0
[pid=12281] ppid=12279 vsize=2572 CPUtime=0.02
/proc/12281/stat : 12281 (p2cudf) S 12279 12279 2160 34817 2160 4202496 389 3020 0 1 0 0 1 1 25 0 1 0 56190839 2633728 280 1283457024 134512640 135304128 4288965696 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12281/statm: 643 280 239 194 0 30 0
[pid=12293] ppid=12281 vsize=877732 CPUtime=284.5
/proc/12293/stat : 12293 (java) S 12281 12279 2160 34817 2160 4202496 110579 0 111 0 28402 48 0 0 22 0 11 0 56190842 898797568 106243 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/12293/statm: 219433 106243 1787 10 0 216524 0
[pid=12293/tid=12294] ppid=12281 vsize=877732 CPUtime=276.02
/proc/12293/task/12294/stat : 12294 (java) D 12281 12279 2160 34817 2160 4202560 50280 0 15 0 27573 29 0 0 25 0 11 0 56190879 898797568 106243 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446744071564332000 0 0 -1 0 0 0 0
[pid=12293/tid=12295] ppid=12281 vsize=877732 CPUtime=5.22
/proc/12293/task/12295/stat : 12295 (java) S 12281 12279 2160 34817 2160 4202560 48963 0 0 0 510 12 0 0 15 0 11 0 56190889 898797568 106243 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 0 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12296] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12296/stat : 12296 (java) S 12281 12279 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 56190889 898797568 106243 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12297] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12297/stat : 12297 (java) S 12281 12279 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 56190890 898797568 106243 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12298] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12298/stat : 12298 (java) S 12281 12279 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 56190899 898797568 106243 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12299] ppid=12281 vsize=877732 CPUtime=2.91
/proc/12293/task/12299/stat : 12299 (java) S 12281 12279 2160 34817 2160 4202560 8999 0 2 0 287 4 0 0 16 0 11 0 56190899 898797568 106243 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12300] ppid=12281 vsize=877732 CPUtime=0.32
/proc/12293/task/12300/stat : 12300 (java) S 12281 12279 2160 34817 2160 4202560 1345 0 7 0 32 0 0 0 17 0 11 0 56190899 898797568 106243 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12301] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12301/stat : 12301 (java) S 12281 12279 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 56190899 898797568 106243 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12302] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12302/stat : 12302 (java) S 12281 12279 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 15 0 11 0 56190899 898797568 106243 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12303] ppid=12281 vsize=877732 CPUtime=0
/proc/12293/task/12303/stat : 12303 (java) S 12281 12279 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 18 0 11 0 56191393 898797568 106243 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 284.52
Current children cumulated vsize (KiB) 882872

[startup+286.008 s]
/proc/loadavg: 1.00 1.01 1.00 1/48 12310
/proc/meminfo: memFree=506056/1048576 swapFree=0/0
[pid=12279] ppid=12278 vsize=2568 CPUtime=0
/proc/12279/stat : 12279 (p2cudf-user-1.1) S 12278 12279 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 56190838 2629632 270 1283457024 134512640 135304128 4294572400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12279/statm: 642 270 230 194 0 29 0
[pid=12281] ppid=12279 vsize=2572 CPUtime=0.02
/proc/12281/stat : 12281 (p2cudf) S 12279 12279 2160 34817 2160 4202496 389 3020 0 1 0 0 1 1 25 0 1 0 56190839 2633728 280 1283457024 134512640 135304128 4288965696 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12281/statm: 643 280 239 194 0 30 0
[pid=12293] ppid=12281 vsize=878056 CPUtime=284.53
/proc/12293/stat : 12293 (java) S 12281 12279 2160 34817 2160 4202496 110591 0 111 0 28405 48 0 0 22 0 11 0 56190842 899129344 106255 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/12293/statm: 219514 106255 1788 10 0 216605 0
[pid=12293/tid=12294] ppid=12281 vsize=878056 CPUtime=276.03
/proc/12293/task/12294/stat : 12294 (java) S 12281 12279 2160 34817 2160 4202560 50287 0 15 0 27574 29 0 0 25 0 11 0 56190879 899129344 106255 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12295] ppid=12281 vsize=878056 CPUtime=5.22
/proc/12293/task/12295/stat : 12295 (java) S 12281 12279 2160 34817 2160 4202560 48963 0 0 0 510 12 0 0 16 0 11 0 56190889 899129344 106255 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 0 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12296] ppid=12281 vsize=878056 CPUtime=0
/proc/12293/task/12296/stat : 12296 (java) S 12281 12279 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 56190889 899129344 106255 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12297] ppid=12281 vsize=878056 CPUtime=0
/proc/12293/task/12297/stat : 12297 (java) S 12281 12279 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 56190890 899129344 106255 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12298] ppid=12281 vsize=878056 CPUtime=0
/proc/12293/task/12298/stat : 12298 (java) S 12281 12279 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 56190899 899129344 106255 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12299] ppid=12281 vsize=878056 CPUtime=2.93
/proc/12293/task/12299/stat : 12299 (java) S 12281 12279 2160 34817 2160 4202560 8999 0 2 0 289 4 0 0 15 0 11 0 56190899 899129344 106255 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12300] ppid=12281 vsize=878056 CPUtime=0.32
/proc/12293/task/12300/stat : 12300 (java) S 12281 12279 2160 34817 2160 4202560 1345 0 7 0 32 0 0 0 17 0 11 0 56190899 899129344 106255 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12301] ppid=12281 vsize=878056 CPUtime=0
/proc/12293/task/12301/stat : 12301 (java) S 12281 12279 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 56190899 899129344 106255 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12302] ppid=12281 vsize=878056 CPUtime=0
/proc/12293/task/12302/stat : 12302 (java) S 12281 12279 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 15 0 11 0 56190899 899129344 106255 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12310] ppid=12281 vsize=878056 CPUtime=0
/proc/12293/task/12310/stat : 12310 (java) S 12281 12279 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 56219403 899129344 106255 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 284.55
Current children cumulated vsize (KiB) 883196

[startup+286.408 s]
/proc/loadavg: 1.00 1.01 1.00 1/48 12310
/proc/meminfo: memFree=506056/1048576 swapFree=0/0
[pid=12279] ppid=12278 vsize=2568 CPUtime=0
/proc/12279/stat : 12279 (p2cudf-user-1.1) S 12278 12279 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 56190838 2629632 270 1283457024 134512640 135304128 4294572400 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12279/statm: 642 270 230 194 0 29 0
[pid=12281] ppid=12279 vsize=2572 CPUtime=0.02
/proc/12281/stat : 12281 (p2cudf) S 12279 12279 2160 34817 2160 4202496 389 3020 0 1 0 0 1 1 25 0 1 0 56190839 2633728 280 1283457024 134512640 135304128 4288965696 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12281/statm: 643 280 239 194 0 30 0
[pid=12293] ppid=12281 vsize=878056 CPUtime=284.76
/proc/12293/stat : 12293 (java) S 12281 12279 2160 34817 2160 4202496 110593 0 111 0 28421 55 0 0 22 0 10 0 56190842 899129344 106257 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/12293/statm: 219514 106257 1788 10 0 216605 0
[pid=12293/tid=12294] ppid=12281 vsize=878056 CPUtime=276.03
/proc/12293/task/12294/stat : 12294 (java) S 12281 12279 2160 34817 2160 4202560 50287 0 15 0 27574 29 0 0 18 0 10 0 56190879 899129344 106257 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12295] ppid=12281 vsize=878056 CPUtime=5.22
/proc/12293/task/12295/stat : 12295 (java) S 12281 12279 2160 34817 2160 4202560 48963 0 0 0 510 12 0 0 16 0 10 0 56190889 899129344 106257 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 0 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12296] ppid=12281 vsize=878056 CPUtime=0
/proc/12293/task/12296/stat : 12296 (java) S 12281 12279 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 10 0 56190889 899129344 106257 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12297] ppid=12281 vsize=878056 CPUtime=0
/proc/12293/task/12297/stat : 12297 (java) S 12281 12279 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 10 0 56190890 899129344 106257 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12298] ppid=12281 vsize=878056 CPUtime=0
/proc/12293/task/12298/stat : 12298 (java) S 12281 12279 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 10 0 56190899 899129344 106257 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12299] ppid=12281 vsize=878056 CPUtime=3
/proc/12293/task/12299/stat : 12299 (java) S 12281 12279 2160 34817 2160 4202560 8999 0 2 0 296 4 0 0 16 0 10 0 56190899 899129344 106257 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12300] ppid=12281 vsize=878056 CPUtime=0.32
/proc/12293/task/12300/stat : 12300 (java) S 12281 12279 2160 34817 2160 4202560 1345 0 7 0 32 0 0 0 17 0 10 0 56190899 899129344 106257 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12301] ppid=12281 vsize=878056 CPUtime=0
/proc/12293/task/12301/stat : 12301 (java) S 12281 12279 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 10 0 56190899 899129344 106257 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0
[pid=12293/tid=12302] ppid=12281 vsize=878056 CPUtime=0
/proc/12293/task/12302/stat : 12302 (java) R 12281 12279 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 15 0 10 0 56190899 899129344 106257 1283457024 134512640 134550932 4290036704 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 284.78
Current children cumulated vsize (KiB) 883196

Child status: 0
Real time (s): 286.433
CPU time (s): 284.818
CPU user time (s): 284.23
CPU system time (s): 0.588036
CPU usage (%): 99.436
Max. virtual memory (cumulated for all children) (KiB): 883300

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 284.23
system time used= 0.588036
maximum resident set size= 0
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 114400
page faults= 112
swaps= 0
block input operations= 0
block output operations= 0
messages sent= 0
messages received= 0
signals received= 0
voluntary context switches= 6508
involuntary context switches= 8668

runsolver used 0 second user time and 0.004 second system time

The end