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/201108251442/p2cudf-paranoid-1.13/rand343.cudf.s-e-l-s.log.runsolver ./p2cudf-paranoid-1.13 /home/misc2010/data/2011/incremental/s-e-l-s/rand343.cudf /home/misc2010/tmp/201108251442/p2cudf-paranoid-1.13/rand343.cudf.s-e-l-s.result 

Enforcing CPUTime limit (soft limit, will send signal-name then SIGKILL): 290 seconds
Enforcing CPUTime limit (hard limit, will send SIGXCPU): 320 seconds
Enforcing VSIZE limit (soft limit, will send signal-name then SIGKILL): 1150976 KiB
Enforcing VSIZE limit (hard limit, stack expansion will fail with SIGSEGV, brk() and mmap() will return ENOMEM): 1202176 KiB
Current StackSize limit: 8192 KiB


[startup+0 s]
/proc/loadavg: 1.01 1.08 1.05 5/34 9725
/proc/meminfo: memFree=368012/1048576 swapFree=0/0
[pid=9724] ppid=9723 vsize=2572 CPUtime=0
/proc/9724/stat : 9724 (p2cudf-paranoid) R 9723 9724 4778 34817 4778 4202496 357 0 0 0 0 0 0 0 25 0 1 0 10373758 2633728 271 1283457024 134512640 135304128 4291991360 18446744073709551615 4294960130 0 65538 4 65536 0 0 0 17 0 0 0 0
/proc/9724/statm: 643 271 230 194 0 30 0
[pid=9725] ppid=9724 vsize=2572 CPUtime=0
/proc/9725/stat : 9725 (p2cudf-paranoid) R 9724 9724 4778 34817 4778 4202560 0 0 0 0 0 0 0 0 25 0 1 0 10373759 2633728 41 1283457024 134512640 135304128 4291991360 18446744073709551615 4294960130 0 65538 4 65536 0 0 0 17 0 0 0 0
/proc/9725/statm: 643 41 0 194 0 30 0

[startup+0.165502 s]
/proc/loadavg: 1.01 1.08 1.05 5/34 9725
/proc/meminfo: memFree=368012/1048576 swapFree=0/0
[pid=9724] ppid=9723 vsize=2572 CPUtime=0
/proc/9724/stat : 9724 (p2cudf-paranoid) S 9723 9724 4778 34817 4778 4202496 374 0 0 0 0 0 0 0 25 0 1 0 10373758 2633728 271 1283457024 134512640 135304128 4291991360 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9724/statm: 643 271 230 194 0 30 0
[pid=9725] ppid=9724 vsize=2572 CPUtime=0.04
/proc/9725/stat : 9725 (p2cudf) S 9724 9724 4778 34817 4778 4202496 387 3015 0 1 0 0 2 2 25 0 1 0 10373759 2633728 279 1283457024 134512640 135304128 4290899536 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9725/statm: 643 279 239 194 0 30 0
Current children cumulated CPU time (s) 0.04
Current children cumulated vsize (KiB) 5144

[startup+0.205504 s]
/proc/loadavg: 1.01 1.08 1.05 5/34 9725
/proc/meminfo: memFree=368012/1048576 swapFree=0/0
[pid=9724] ppid=9723 vsize=2572 CPUtime=0
/proc/9724/stat : 9724 (p2cudf-paranoid) S 9723 9724 4778 34817 4778 4202496 374 0 0 0 0 0 0 0 25 0 1 0 10373758 2633728 271 1283457024 134512640 135304128 4291991360 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9724/statm: 643 271 230 194 0 30 0
[pid=9725] ppid=9724 vsize=2572 CPUtime=0.04
/proc/9725/stat : 9725 (p2cudf) S 9724 9724 4778 34817 4778 4202496 387 3015 0 1 0 0 2 2 25 0 1 0 10373759 2633728 279 1283457024 134512640 135304128 4290899536 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9725/statm: 643 279 239 194 0 30 0
Current children cumulated CPU time (s) 0.04
Current children cumulated vsize (KiB) 5144

[startup+0.305522 s]
/proc/loadavg: 1.01 1.08 1.05 5/34 9725
/proc/meminfo: memFree=368012/1048576 swapFree=0/0
[pid=9724] ppid=9723 vsize=2572 CPUtime=0
/proc/9724/stat : 9724 (p2cudf-paranoid) S 9723 9724 4778 34817 4778 4202496 374 0 0 0 0 0 0 0 25 0 1 0 10373758 2633728 271 1283457024 134512640 135304128 4291991360 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9724/statm: 643 271 230 194 0 30 0
[pid=9725] ppid=9724 vsize=2572 CPUtime=0.04
/proc/9725/stat : 9725 (p2cudf) S 9724 9724 4778 34817 4778 4202496 387 3015 0 1 0 0 2 2 25 0 1 0 10373759 2633728 279 1283457024 134512640 135304128 4290899536 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9725/statm: 643 279 239 194 0 30 0
Current children cumulated CPU time (s) 0.04
Current children cumulated vsize (KiB) 5144

[startup+0.705622 s]
/proc/loadavg: 1.01 1.08 1.05 5/34 9725
/proc/meminfo: memFree=368012/1048576 swapFree=0/0
[pid=9724] ppid=9723 vsize=2572 CPUtime=0
/proc/9724/stat : 9724 (p2cudf-paranoid) S 9723 9724 4778 34817 4778 4202496 374 0 0 0 0 0 0 0 25 0 1 0 10373758 2633728 271 1283457024 134512640 135304128 4291991360 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9724/statm: 643 271 230 194 0 30 0
[pid=9725] ppid=9724 vsize=2572 CPUtime=0.04
/proc/9725/stat : 9725 (p2cudf) S 9724 9724 4778 34817 4778 4202496 387 3015 0 1 0 0 2 2 25 0 1 0 10373759 2633728 279 1283457024 134512640 135304128 4290899536 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9725/statm: 643 279 239 194 0 30 0
Current children cumulated CPU time (s) 0.04
Current children cumulated vsize (KiB) 5144

[startup+1.50581 s]
/proc/loadavg: 1.01 1.08 1.05 5/45 9747
/proc/meminfo: memFree=310432/1048576 swapFree=0/0
[pid=9724] ppid=9723 vsize=2572 CPUtime=0
/proc/9724/stat : 9724 (p2cudf-paranoid) S 9723 9724 4778 34817 4778 4202496 374 0 0 0 0 0 0 0 25 0 1 0 10373758 2633728 271 1283457024 134512640 135304128 4291991360 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9724/statm: 643 271 230 194 0 30 0
[pid=9725] ppid=9724 vsize=2572 CPUtime=0.04
/proc/9725/stat : 9725 (p2cudf) S 9724 9724 4778 34817 4778 4202496 387 3015 0 1 0 0 2 2 25 0 1 0 10373759 2633728 279 1283457024 134512640 135304128 4290899536 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9725/statm: 643 279 239 194 0 30 0
[pid=9738] ppid=9725 vsize=898388 CPUtime=1.46
/proc/9738/stat : 9738 (java) S 9725 9724 4778 34817 4778 4202496 25282 0 1 0 136 10 0 0 25 0 10 0 10373762 919949312 21657 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/9738/statm: 224597 21657 1719 10 0 221688 0
[pid=9738/tid=9739] ppid=9725 vsize=898388 CPUtime=0.79
/proc/9738/task/9739/stat : 9739 (java) R 9725 9724 4778 34817 4778 4202560 10691 0 1 0 73 6 0 0 25 0 10 0 10373763 919949312 21657 1283457024 134512640 134550932 4288363136 18446744073709551615 4095821767 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=9738/tid=9740] ppid=9725 vsize=898388 CPUtime=0
/proc/9738/task/9740/stat : 9740 (java) S 9725 9724 4778 34817 4778 4202560 7 0 0 0 0 0 0 0 16 0 10 0 10373764 919949312 21657 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 0 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9741] ppid=9725 vsize=898388 CPUtime=0
/proc/9738/task/9741/stat : 9741 (java) S 9725 9724 4778 34817 4778 4202560 8 0 0 0 0 0 0 0 25 0 10 0 10373765 919949312 21657 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9742] ppid=9725 vsize=898388 CPUtime=0
/proc/9738/task/9742/stat : 9742 (java) S 9725 9724 4778 34817 4778 4202560 4 0 0 0 0 0 0 0 25 0 10 0 10373765 919949312 21657 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9743] ppid=9725 vsize=898388 CPUtime=0
/proc/9738/task/9743/stat : 9743 (java) S 9725 9724 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 10 0 10373767 919949312 21657 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9744] ppid=9725 vsize=898388 CPUtime=0.45
/proc/9738/task/9744/stat : 9744 (java) R 9725 9724 4778 34817 4778 4202560 8915 0 0 0 42 3 0 0 25 0 10 0 10373767 919949312 21657 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=9738/tid=9745] ppid=9725 vsize=898388 CPUtime=0.2
/proc/9738/task/9745/stat : 9745 (java) S 9725 9724 4778 34817 4778 4202560 4596 0 0 0 20 0 0 0 22 0 10 0 10373767 919949312 21657 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9746] ppid=9725 vsize=898388 CPUtime=0
/proc/9738/task/9746/stat : 9746 (java) S 9725 9724 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 10 0 10373767 919949312 21657 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9747] ppid=9725 vsize=898388 CPUtime=0
/proc/9738/task/9747/stat : 9747 (java) S 9725 9724 4778 34817 4778 4202560 2 0 0 0 0 0 0 0 15 0 10 0 10373767 919949312 21657 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 1.5
Current children cumulated vsize (KiB) 903532

[startup+3.10625 s]
/proc/loadavg: 1.01 1.08 1.05 3/45 9747
/proc/meminfo: memFree=209992/1048576 swapFree=0/0
[pid=9724] ppid=9723 vsize=2572 CPUtime=0
/proc/9724/stat : 9724 (p2cudf-paranoid) S 9723 9724 4778 34817 4778 4202496 374 0 0 0 0 0 0 0 25 0 1 0 10373758 2633728 271 1283457024 134512640 135304128 4291991360 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9724/statm: 643 271 230 194 0 30 0
[pid=9725] ppid=9724 vsize=2572 CPUtime=0.04
/proc/9725/stat : 9725 (p2cudf) S 9724 9724 4778 34817 4778 4202496 387 3015 0 1 0 0 2 2 25 0 1 0 10373759 2633728 279 1283457024 134512640 135304128 4290899536 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9725/statm: 643 279 239 194 0 30 0
[pid=9738] ppid=9725 vsize=895968 CPUtime=3.06
/proc/9738/stat : 9738 (java) S 9725 9724 4778 34817 4778 4202496 79084 0 1 0 271 35 0 0 25 0 10 0 10373762 917471232 74337 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/9738/statm: 223992 74337 1732 10 0 221083 0
[pid=9738/tid=9739] ppid=9725 vsize=895968 CPUtime=1.73
/proc/9738/task/9739/stat : 9739 (java) R 9725 9724 4778 34817 4778 4202560 50005 0 1 0 145 28 0 0 25 0 10 0 10373763 917471232 74337 1283457024 134512640 134550932 4288363136 18446744073709551615 4095479660 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=9738/tid=9740] ppid=9725 vsize=895968 CPUtime=0.28
/proc/9738/task/9740/stat : 9740 (java) S 9725 9724 4778 34817 4778 4202560 13290 0 0 0 25 3 0 0 16 0 10 0 10373764 917471232 74337 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 0 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9741] ppid=9725 vsize=895968 CPUtime=0
/proc/9738/task/9741/stat : 9741 (java) S 9725 9724 4778 34817 4778 4202560 8 0 0 0 0 0 0 0 18 0 10 0 10373765 917471232 74337 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9742] ppid=9725 vsize=895968 CPUtime=0
/proc/9738/task/9742/stat : 9742 (java) S 9725 9724 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 18 0 10 0 10373765 917471232 74337 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9743] ppid=9725 vsize=895968 CPUtime=0
/proc/9738/task/9743/stat : 9743 (java) S 9725 9724 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 10 0 10373767 917471232 74337 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9744] ppid=9725 vsize=895968 CPUtime=0.61
/proc/9738/task/9744/stat : 9744 (java) S 9725 9724 4778 34817 4778 4202560 9029 0 0 0 58 3 0 0 18 0 10 0 10373767 917471232 74337 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9745] ppid=9725 vsize=895968 CPUtime=0.42
/proc/9738/task/9745/stat : 9745 (java) S 9725 9724 4778 34817 4778 4202560 5685 0 0 0 42 0 0 0 17 0 10 0 10373767 917471232 74337 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9746] ppid=9725 vsize=895968 CPUtime=0
/proc/9738/task/9746/stat : 9746 (java) S 9725 9724 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 10 0 10373767 917471232 74337 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9747] ppid=9725 vsize=895968 CPUtime=0
/proc/9738/task/9747/stat : 9747 (java) S 9725 9724 4778 34817 4778 4202560 2 0 0 0 0 0 0 0 15 0 10 0 10373767 917471232 74337 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 3.1
Current children cumulated vsize (KiB) 901112

[startup+6.30689 s]
/proc/loadavg: 1.08 1.09 1.06 2/46 9748
/proc/meminfo: memFree=17792/1048576 swapFree=0/0
[pid=9724] ppid=9723 vsize=2572 CPUtime=0
/proc/9724/stat : 9724 (p2cudf-paranoid) S 9723 9724 4778 34817 4778 4202496 374 0 0 0 0 0 0 0 25 0 1 0 10373758 2633728 271 1283457024 134512640 135304128 4291991360 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9724/statm: 643 271 230 194 0 30 0
[pid=9725] ppid=9724 vsize=2572 CPUtime=0.04
/proc/9725/stat : 9725 (p2cudf) S 9724 9724 4778 34817 4778 4202496 387 3015 0 1 0 0 2 2 25 0 1 0 10373759 2633728 279 1283457024 134512640 135304128 4290899536 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9725/statm: 643 279 239 194 0 30 0
[pid=9738] ppid=9725 vsize=896184 CPUtime=6.25
/proc/9738/stat : 9738 (java) S 9725 9724 4778 34817 4778 4202496 96041 0 1 0 586 39 0 0 25 0 11 0 10373762 917692416 89047 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/9738/statm: 224046 89047 1777 10 0 221137 0
[pid=9738/tid=9739] ppid=9725 vsize=896184 CPUtime=3.2
/proc/9738/task/9739/stat : 9739 (java) R 9725 9724 4778 34817 4778 4202560 50276 0 1 0 291 29 0 0 25 0 11 0 10373763 917692416 89047 1283457024 134512640 134550932 4288363136 18446744073709551615 4096506206 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=9738/tid=9740] ppid=9725 vsize=896184 CPUtime=0.64
/proc/9738/task/9740/stat : 9740 (java) S 9725 9724 4778 34817 4778 4202560 27536 0 0 0 60 4 0 0 16 0 11 0 10373764 917692416 89047 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 0 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9741] ppid=9725 vsize=896184 CPUtime=0
/proc/9738/task/9741/stat : 9741 (java) S 9725 9724 4778 34817 4778 4202560 8 0 0 0 0 0 0 0 18 0 11 0 10373765 917692416 89047 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9742] ppid=9725 vsize=896184 CPUtime=0
/proc/9738/task/9742/stat : 9742 (java) S 9725 9724 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 18 0 11 0 10373765 917692416 89047 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9743] ppid=9725 vsize=896184 CPUtime=0
/proc/9738/task/9743/stat : 9743 (java) S 9725 9724 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 10373767 917692416 89047 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9744] ppid=9725 vsize=896184 CPUtime=1.96
/proc/9738/task/9744/stat : 9744 (java) S 9725 9724 4778 34817 4778 4202560 11465 0 0 0 192 4 0 0 15 0 11 0 10373767 917692416 89047 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9745] ppid=9725 vsize=896184 CPUtime=0.42
/proc/9738/task/9745/stat : 9745 (java) S 9725 9724 4778 34817 4778 4202560 5685 0 0 0 42 0 0 0 17 0 11 0 10373767 917692416 89047 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9746] ppid=9725 vsize=896184 CPUtime=0
/proc/9738/task/9746/stat : 9746 (java) S 9725 9724 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 10373767 917692416 89047 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9747] ppid=9725 vsize=896184 CPUtime=0
/proc/9738/task/9747/stat : 9747 (java) S 9725 9724 4778 34817 4778 4202560 2 0 0 0 0 0 0 0 15 0 11 0 10373767 917692416 89047 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9748] ppid=9725 vsize=896184 CPUtime=0
/proc/9738/task/9748/stat : 9748 (java) S 9725 9724 4778 34817 4778 4202560 4 0 0 0 0 0 0 0 25 0 11 0 10374279 917692416 89047 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 6.29
Current children cumulated vsize (KiB) 901328

[startup+12.7085 s]
/proc/loadavg: 1.16 1.11 1.06 2/46 9748
/proc/meminfo: memFree=18412/1048576 swapFree=0/0
[pid=9724] ppid=9723 vsize=2572 CPUtime=0
/proc/9724/stat : 9724 (p2cudf-paranoid) S 9723 9724 4778 34817 4778 4202496 374 0 0 0 0 0 0 0 25 0 1 0 10373758 2633728 271 1283457024 134512640 135304128 4291991360 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9724/statm: 643 271 230 194 0 30 0
[pid=9725] ppid=9724 vsize=2572 CPUtime=0.04
/proc/9725/stat : 9725 (p2cudf) S 9724 9724 4778 34817 4778 4202496 387 3015 0 1 0 0 2 2 25 0 1 0 10373759 2633728 279 1283457024 134512640 135304128 4290899536 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9725/statm: 643 279 239 194 0 30 0
[pid=9738] ppid=9725 vsize=894712 CPUtime=12.66
/proc/9738/stat : 9738 (java) S 9725 9724 4778 34817 4778 4202496 96091 0 1 0 1226 40 0 0 25 0 11 0 10373762 916185088 88729 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/9738/statm: 223678 88729 1782 10 0 220769 0
[pid=9738/tid=9739] ppid=9725 vsize=894712 CPUtime=9.26
/proc/9738/task/9739/stat : 9739 (java) R 9725 9724 4778 34817 4778 4202560 50278 0 1 0 896 30 0 0 25 0 11 0 10373763 916185088 88729 1283457024 134512640 134550932 4288363136 18446744073709551615 4096409145 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=9738/tid=9740] ppid=9725 vsize=894712 CPUtime=0.64
/proc/9738/task/9740/stat : 9740 (java) S 9725 9724 4778 34817 4778 4202560 27536 0 0 0 60 4 0 0 15 0 11 0 10373764 916185088 88729 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 0 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9741] ppid=9725 vsize=894712 CPUtime=0
/proc/9738/task/9741/stat : 9741 (java) S 9725 9724 4778 34817 4778 4202560 8 0 0 0 0 0 0 0 18 0 11 0 10373765 916185088 88729 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9742] ppid=9725 vsize=894712 CPUtime=0
/proc/9738/task/9742/stat : 9742 (java) S 9725 9724 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 18 0 11 0 10373765 916185088 88729 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9743] ppid=9725 vsize=894712 CPUtime=0
/proc/9738/task/9743/stat : 9743 (java) S 9725 9724 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 10373767 916185088 88729 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9744] ppid=9725 vsize=894712 CPUtime=2.3
/proc/9738/task/9744/stat : 9744 (java) S 9725 9724 4778 34817 4778 4202560 11513 0 0 0 226 4 0 0 15 0 11 0 10373767 916185088 88729 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9745] ppid=9725 vsize=894712 CPUtime=0.42
/proc/9738/task/9745/stat : 9745 (java) S 9725 9724 4778 34817 4778 4202560 5685 0 0 0 42 0 0 0 17 0 11 0 10373767 916185088 88729 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9746] ppid=9725 vsize=894712 CPUtime=0
/proc/9738/task/9746/stat : 9746 (java) S 9725 9724 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 10373767 916185088 88729 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9747] ppid=9725 vsize=894712 CPUtime=0
/proc/9738/task/9747/stat : 9747 (java) S 9725 9724 4778 34817 4778 4202560 2 0 0 0 0 0 0 0 15 0 11 0 10373767 916185088 88729 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9748] ppid=9725 vsize=894712 CPUtime=0
/proc/9738/task/9748/stat : 9748 (java) S 9725 9724 4778 34817 4778 4202560 4 0 0 0 0 0 0 0 25 0 11 0 10374279 916185088 88729 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 12.7
Current children cumulated vsize (KiB) 899856

[startup+25.5115 s]
/proc/loadavg: 1.12 1.10 1.06 2/46 9748
/proc/meminfo: memFree=5776/1048576 swapFree=0/0
[pid=9724] ppid=9723 vsize=2572 CPUtime=0
/proc/9724/stat : 9724 (p2cudf-paranoid) S 9723 9724 4778 34817 4778 4202496 374 0 0 0 0 0 0 0 25 0 1 0 10373758 2633728 271 1283457024 134512640 135304128 4291991360 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9724/statm: 643 271 230 194 0 30 0
[pid=9725] ppid=9724 vsize=2572 CPUtime=0.04
/proc/9725/stat : 9725 (p2cudf) S 9724 9724 4778 34817 4778 4202496 387 3015 0 1 0 0 2 2 25 0 1 0 10373759 2633728 279 1283457024 134512640 135304128 4290899536 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9725/statm: 643 279 239 194 0 30 0
[pid=9738] ppid=9725 vsize=894712 CPUtime=25.42
/proc/9738/stat : 9738 (java) S 9725 9724 4778 34817 4778 4202496 103913 0 1 0 2500 42 0 0 25 0 11 0 10373762 916185088 96551 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/9738/statm: 223678 96551 1787 10 0 220769 0
[pid=9738/tid=9739] ppid=9725 vsize=894712 CPUtime=21.18
/proc/9738/task/9739/stat : 9739 (java) R 9725 9724 4778 34817 4778 4202560 50279 0 1 0 2088 30 0 0 25 0 11 0 10373763 916185088 96551 1283457024 134512640 134550932 4288363136 18446744073709551615 4096472356 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=9738/tid=9740] ppid=9725 vsize=894712 CPUtime=1.41
/proc/9738/task/9740/stat : 9740 (java) S 9725 9724 4778 34817 4778 4202560 35341 0 0 0 134 7 0 0 15 0 11 0 10373764 916185088 96551 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 0 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9741] ppid=9725 vsize=894712 CPUtime=0
/proc/9738/task/9741/stat : 9741 (java) S 9725 9724 4778 34817 4778 4202560 8 0 0 0 0 0 0 0 18 0 11 0 10373765 916185088 96551 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9742] ppid=9725 vsize=894712 CPUtime=0
/proc/9738/task/9742/stat : 9742 (java) S 9725 9724 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 18 0 11 0 10373765 916185088 96551 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9743] ppid=9725 vsize=894712 CPUtime=0
/proc/9738/task/9743/stat : 9743 (java) S 9725 9724 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 10373767 916185088 96551 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9744] ppid=9725 vsize=894712 CPUtime=2.4
/proc/9738/task/9744/stat : 9744 (java) S 9725 9724 4778 34817 4778 4202560 11529 0 0 0 236 4 0 0 15 0 11 0 10373767 916185088 96551 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9745] ppid=9725 vsize=894712 CPUtime=0.42
/proc/9738/task/9745/stat : 9745 (java) S 9725 9724 4778 34817 4778 4202560 5685 0 0 0 42 0 0 0 17 0 11 0 10373767 916185088 96551 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9746] ppid=9725 vsize=894712 CPUtime=0
/proc/9738/task/9746/stat : 9746 (java) S 9725 9724 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 10373767 916185088 96551 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9747] ppid=9725 vsize=894712 CPUtime=0
/proc/9738/task/9747/stat : 9747 (java) S 9725 9724 4778 34817 4778 4202560 2 0 0 0 0 0 0 0 15 0 11 0 10373767 916185088 96551 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9748] ppid=9725 vsize=894712 CPUtime=0
/proc/9738/task/9748/stat : 9748 (java) S 9725 9724 4778 34817 4778 4202560 4 0 0 0 0 0 0 0 25 0 11 0 10374279 916185088 96551 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 25.46
Current children cumulated vsize (KiB) 899856

[startup+51.1091 s]
/proc/loadavg: 1.08 1.09 1.06 2/46 9748
/proc/meminfo: memFree=5156/1048576 swapFree=0/0
[pid=9724] ppid=9723 vsize=2572 CPUtime=0
/proc/9724/stat : 9724 (p2cudf-paranoid) S 9723 9724 4778 34817 4778 4202496 374 0 0 0 0 0 0 0 25 0 1 0 10373758 2633728 271 1283457024 134512640 135304128 4291991360 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9724/statm: 643 271 230 194 0 30 0
[pid=9725] ppid=9724 vsize=2572 CPUtime=0.04
/proc/9725/stat : 9725 (p2cudf) S 9724 9724 4778 34817 4778 4202496 387 3015 0 1 0 0 2 2 25 0 1 0 10373759 2633728 279 1283457024 134512640 135304128 4290899536 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9725/statm: 643 279 239 194 0 30 0
[pid=9738] ppid=9725 vsize=894712 CPUtime=51
/proc/9738/stat : 9738 (java) S 9725 9724 4778 34817 4778 4202496 104039 0 1 0 5058 42 0 0 25 0 11 0 10373762 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/9738/statm: 223678 96677 1787 10 0 220769 0
[pid=9738/tid=9739] ppid=9725 vsize=894712 CPUtime=45.54
/proc/9738/task/9739/stat : 9739 (java) R 9725 9724 4778 34817 4778 4202560 50279 0 1 0 4524 30 0 0 25 0 11 0 10373763 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4096610154 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=9738/tid=9740] ppid=9725 vsize=894712 CPUtime=2.55
/proc/9738/task/9740/stat : 9740 (java) S 9725 9724 4778 34817 4778 4202560 35467 0 0 0 248 7 0 0 15 0 11 0 10373764 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 0 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9741] ppid=9725 vsize=894712 CPUtime=0
/proc/9738/task/9741/stat : 9741 (java) S 9725 9724 4778 34817 4778 4202560 8 0 0 0 0 0 0 0 18 0 11 0 10373765 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9742] ppid=9725 vsize=894712 CPUtime=0
/proc/9738/task/9742/stat : 9742 (java) S 9725 9724 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 18 0 11 0 10373765 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9743] ppid=9725 vsize=894712 CPUtime=0
/proc/9738/task/9743/stat : 9743 (java) S 9725 9724 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 10373767 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9744] ppid=9725 vsize=894712 CPUtime=2.46
/proc/9738/task/9744/stat : 9744 (java) S 9725 9724 4778 34817 4778 4202560 11529 0 0 0 242 4 0 0 16 0 11 0 10373767 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9745] ppid=9725 vsize=894712 CPUtime=0.42
/proc/9738/task/9745/stat : 9745 (java) S 9725 9724 4778 34817 4778 4202560 5685 0 0 0 42 0 0 0 17 0 11 0 10373767 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9746] ppid=9725 vsize=894712 CPUtime=0
/proc/9738/task/9746/stat : 9746 (java) S 9725 9724 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 10373767 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9747] ppid=9725 vsize=894712 CPUtime=0
/proc/9738/task/9747/stat : 9747 (java) S 9725 9724 4778 34817 4778 4202560 2 0 0 0 0 0 0 0 15 0 11 0 10373767 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9748] ppid=9725 vsize=894712 CPUtime=0
/proc/9738/task/9748/stat : 9748 (java) S 9725 9724 4778 34817 4778 4202560 4 0 0 0 0 0 0 0 25 0 11 0 10374279 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 51.04
Current children cumulated vsize (KiB) 899856

[startup+102.304 s]
/proc/loadavg: 1.07 1.09 1.06 2/46 9748
/proc/meminfo: memFree=5156/1048576 swapFree=0/0
[pid=9724] ppid=9723 vsize=2572 CPUtime=0
/proc/9724/stat : 9724 (p2cudf-paranoid) S 9723 9724 4778 34817 4778 4202496 374 0 0 0 0 0 0 0 25 0 1 0 10373758 2633728 271 1283457024 134512640 135304128 4291991360 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9724/statm: 643 271 230 194 0 30 0
[pid=9725] ppid=9724 vsize=2572 CPUtime=0.04
/proc/9725/stat : 9725 (p2cudf) S 9724 9724 4778 34817 4778 4202496 387 3015 0 1 0 0 2 2 25 0 1 0 10373759 2633728 279 1283457024 134512640 135304128 4290899536 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9725/statm: 643 279 239 194 0 30 0
[pid=9738] ppid=9725 vsize=894712 CPUtime=102.17
/proc/9738/stat : 9738 (java) S 9725 9724 4778 34817 4778 4202496 104039 0 1 0 10173 44 0 0 25 0 11 0 10373762 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/9738/statm: 223678 96677 1787 10 0 220769 0
[pid=9738/tid=9739] ppid=9725 vsize=894712 CPUtime=94.87
/proc/9738/task/9739/stat : 9739 (java) R 9725 9724 4778 34817 4778 4202560 50279 0 1 0 9456 31 0 0 25 0 11 0 10373763 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4096378287 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=9738/tid=9740] ppid=9725 vsize=894712 CPUtime=4.36
/proc/9738/task/9740/stat : 9740 (java) S 9725 9724 4778 34817 4778 4202560 35467 0 0 0 429 7 0 0 15 0 11 0 10373764 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 0 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9741] ppid=9725 vsize=894712 CPUtime=0
/proc/9738/task/9741/stat : 9741 (java) S 9725 9724 4778 34817 4778 4202560 8 0 0 0 0 0 0 0 18 0 11 0 10373765 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9742] ppid=9725 vsize=894712 CPUtime=0
/proc/9738/task/9742/stat : 9742 (java) S 9725 9724 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 18 0 11 0 10373765 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9743] ppid=9725 vsize=894712 CPUtime=0
/proc/9738/task/9743/stat : 9743 (java) S 9725 9724 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 10373767 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9744] ppid=9725 vsize=894712 CPUtime=2.48
/proc/9738/task/9744/stat : 9744 (java) S 9725 9724 4778 34817 4778 4202560 11529 0 0 0 244 4 0 0 15 0 11 0 10373767 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9745] ppid=9725 vsize=894712 CPUtime=0.42
/proc/9738/task/9745/stat : 9745 (java) S 9725 9724 4778 34817 4778 4202560 5685 0 0 0 42 0 0 0 17 0 11 0 10373767 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9746] ppid=9725 vsize=894712 CPUtime=0
/proc/9738/task/9746/stat : 9746 (java) S 9725 9724 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 10373767 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9747] ppid=9725 vsize=894712 CPUtime=0
/proc/9738/task/9747/stat : 9747 (java) S 9725 9724 4778 34817 4778 4202560 2 0 0 0 0 0 0 0 15 0 11 0 10373767 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9748] ppid=9725 vsize=894712 CPUtime=0
/proc/9738/task/9748/stat : 9748 (java) S 9725 9724 4778 34817 4778 4202560 4 0 0 0 0 0 0 0 25 0 11 0 10374279 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 102.21
Current children cumulated vsize (KiB) 899856

[startup+162.31 s]
/proc/loadavg: 1.02 1.07 1.05 2/46 9748
/proc/meminfo: memFree=6172/1048576 swapFree=0/0
[pid=9724] ppid=9723 vsize=2572 CPUtime=0
/proc/9724/stat : 9724 (p2cudf-paranoid) S 9723 9724 4778 34817 4778 4202496 374 0 0 0 0 0 0 0 25 0 1 0 10373758 2633728 271 1283457024 134512640 135304128 4291991360 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9724/statm: 643 271 230 194 0 30 0
[pid=9725] ppid=9724 vsize=2572 CPUtime=0.04
/proc/9725/stat : 9725 (p2cudf) S 9724 9724 4778 34817 4778 4202496 387 3015 0 1 0 0 2 2 25 0 1 0 10373759 2633728 279 1283457024 134512640 135304128 4290899536 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9725/statm: 643 279 239 194 0 30 0
[pid=9738] ppid=9725 vsize=894712 CPUtime=162.12
/proc/9738/stat : 9738 (java) S 9725 9724 4778 34817 4778 4202496 104039 0 1 0 16167 45 0 0 25 0 11 0 10373762 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/9738/statm: 223678 96677 1787 10 0 220769 0
[pid=9738/tid=9739] ppid=9725 vsize=894712 CPUtime=152.59
/proc/9738/task/9739/stat : 9739 (java) R 9725 9724 4778 34817 4778 4202560 50279 0 1 0 15227 32 0 0 25 0 11 0 10373763 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4096469445 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=9738/tid=9740] ppid=9725 vsize=894712 CPUtime=6.54
/proc/9738/task/9740/stat : 9740 (java) S 9725 9724 4778 34817 4778 4202560 35467 0 0 0 647 7 0 0 15 0 11 0 10373764 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 0 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9741] ppid=9725 vsize=894712 CPUtime=0
/proc/9738/task/9741/stat : 9741 (java) S 9725 9724 4778 34817 4778 4202560 8 0 0 0 0 0 0 0 18 0 11 0 10373765 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9742] ppid=9725 vsize=894712 CPUtime=0
/proc/9738/task/9742/stat : 9742 (java) S 9725 9724 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 18 0 11 0 10373765 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9743] ppid=9725 vsize=894712 CPUtime=0
/proc/9738/task/9743/stat : 9743 (java) S 9725 9724 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 10373767 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9744] ppid=9725 vsize=894712 CPUtime=2.54
/proc/9738/task/9744/stat : 9744 (java) S 9725 9724 4778 34817 4778 4202560 11529 0 0 0 250 4 0 0 15 0 11 0 10373767 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9745] ppid=9725 vsize=894712 CPUtime=0.42
/proc/9738/task/9745/stat : 9745 (java) S 9725 9724 4778 34817 4778 4202560 5685 0 0 0 42 0 0 0 17 0 11 0 10373767 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9746] ppid=9725 vsize=894712 CPUtime=0
/proc/9738/task/9746/stat : 9746 (java) S 9725 9724 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 10373767 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9747] ppid=9725 vsize=894712 CPUtime=0
/proc/9738/task/9747/stat : 9747 (java) S 9725 9724 4778 34817 4778 4202560 2 0 0 0 0 0 0 0 15 0 11 0 10373767 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9748] ppid=9725 vsize=894712 CPUtime=0
/proc/9738/task/9748/stat : 9748 (java) S 9725 9724 4778 34817 4778 4202560 4 0 0 0 0 0 0 0 25 0 11 0 10374279 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 162.16
Current children cumulated vsize (KiB) 899856

[startup+222.312 s]
/proc/loadavg: 1.01 1.05 1.05 2/46 9748
/proc/meminfo: memFree=6048/1048576 swapFree=0/0
[pid=9724] ppid=9723 vsize=2572 CPUtime=0
/proc/9724/stat : 9724 (p2cudf-paranoid) S 9723 9724 4778 34817 4778 4202496 374 0 0 0 0 0 0 0 25 0 1 0 10373758 2633728 271 1283457024 134512640 135304128 4291991360 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9724/statm: 643 271 230 194 0 30 0
[pid=9725] ppid=9724 vsize=2572 CPUtime=0.04
/proc/9725/stat : 9725 (p2cudf) S 9724 9724 4778 34817 4778 4202496 387 3015 0 1 0 0 2 2 25 0 1 0 10373759 2633728 279 1283457024 134512640 135304128 4290899536 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9725/statm: 643 279 239 194 0 30 0
[pid=9738] ppid=9725 vsize=894712 CPUtime=222.08
/proc/9738/stat : 9738 (java) S 9725 9724 4778 34817 4778 4202496 104039 0 1 0 22161 47 0 0 25 0 11 0 10373762 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/9738/statm: 223678 96677 1787 10 0 220769 0
[pid=9738/tid=9739] ppid=9725 vsize=894712 CPUtime=210.38
/proc/9738/task/9739/stat : 9739 (java) R 9725 9724 4778 34817 4778 4202560 50279 0 1 0 21004 34 0 0 25 0 11 0 10373763 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4096610171 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=9738/tid=9740] ppid=9725 vsize=894712 CPUtime=8.68
/proc/9738/task/9740/stat : 9740 (java) S 9725 9724 4778 34817 4778 4202560 35467 0 0 0 861 7 0 0 15 0 11 0 10373764 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 0 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9741] ppid=9725 vsize=894712 CPUtime=0
/proc/9738/task/9741/stat : 9741 (java) S 9725 9724 4778 34817 4778 4202560 8 0 0 0 0 0 0 0 18 0 11 0 10373765 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9742] ppid=9725 vsize=894712 CPUtime=0
/proc/9738/task/9742/stat : 9742 (java) S 9725 9724 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 18 0 11 0 10373765 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9743] ppid=9725 vsize=894712 CPUtime=0
/proc/9738/task/9743/stat : 9743 (java) S 9725 9724 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 10373767 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9744] ppid=9725 vsize=894712 CPUtime=2.56
/proc/9738/task/9744/stat : 9744 (java) S 9725 9724 4778 34817 4778 4202560 11529 0 0 0 252 4 0 0 15 0 11 0 10373767 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9745] ppid=9725 vsize=894712 CPUtime=0.42
/proc/9738/task/9745/stat : 9745 (java) S 9725 9724 4778 34817 4778 4202560 5685 0 0 0 42 0 0 0 17 0 11 0 10373767 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9746] ppid=9725 vsize=894712 CPUtime=0
/proc/9738/task/9746/stat : 9746 (java) S 9725 9724 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 10373767 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9747] ppid=9725 vsize=894712 CPUtime=0
/proc/9738/task/9747/stat : 9747 (java) S 9725 9724 4778 34817 4778 4202560 2 0 0 0 0 0 0 0 15 0 11 0 10373767 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9748] ppid=9725 vsize=894712 CPUtime=0
/proc/9738/task/9748/stat : 9748 (java) S 9725 9724 4778 34817 4778 4202560 4 0 0 0 0 0 0 0 25 0 11 0 10374279 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 222.12
Current children cumulated vsize (KiB) 899856

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

[startup+224.013 s]
/proc/loadavg: 1.01 1.05 1.05 2/46 9748
/proc/meminfo: memFree=6048/1048576 swapFree=0/0
[pid=9724] ppid=9723 vsize=2572 CPUtime=0
/proc/9724/stat : 9724 (p2cudf-paranoid) S 9723 9724 4778 34817 4778 4202496 374 0 0 0 0 0 0 0 25 0 1 0 10373758 2633728 271 1283457024 134512640 135304128 4291991360 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9724/statm: 643 271 230 194 0 30 0
[pid=9725] ppid=9724 vsize=2572 CPUtime=0.04
/proc/9725/stat : 9725 (p2cudf) S 9724 9724 4778 34817 4778 4202496 387 3015 0 1 0 0 2 2 25 0 1 0 10373759 2633728 279 1283457024 134512640 135304128 4290899536 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9725/statm: 643 279 239 194 0 30 0
[pid=9738] ppid=9725 vsize=894712 CPUtime=223.78
/proc/9738/stat : 9738 (java) S 9725 9724 4778 34817 4778 4202496 104039 0 1 0 22331 47 0 0 25 0 11 0 10373762 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/9738/statm: 223678 96677 1787 10 0 220769 0
[pid=9738/tid=9739] ppid=9725 vsize=894712 CPUtime=212.08
/proc/9738/task/9739/stat : 9739 (java) R 9725 9724 4778 34817 4778 4202560 50279 0 1 0 21174 34 0 0 25 0 11 0 10373763 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4096472465 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=9738/tid=9740] ppid=9725 vsize=894712 CPUtime=8.68
/proc/9738/task/9740/stat : 9740 (java) S 9725 9724 4778 34817 4778 4202560 35467 0 0 0 861 7 0 0 15 0 11 0 10373764 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 0 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9741] ppid=9725 vsize=894712 CPUtime=0
/proc/9738/task/9741/stat : 9741 (java) S 9725 9724 4778 34817 4778 4202560 8 0 0 0 0 0 0 0 18 0 11 0 10373765 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9742] ppid=9725 vsize=894712 CPUtime=0
/proc/9738/task/9742/stat : 9742 (java) S 9725 9724 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 18 0 11 0 10373765 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9743] ppid=9725 vsize=894712 CPUtime=0
/proc/9738/task/9743/stat : 9743 (java) S 9725 9724 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 10373767 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9744] ppid=9725 vsize=894712 CPUtime=2.56
/proc/9738/task/9744/stat : 9744 (java) S 9725 9724 4778 34817 4778 4202560 11529 0 0 0 252 4 0 0 15 0 11 0 10373767 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9745] ppid=9725 vsize=894712 CPUtime=0.42
/proc/9738/task/9745/stat : 9745 (java) S 9725 9724 4778 34817 4778 4202560 5685 0 0 0 42 0 0 0 17 0 11 0 10373767 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9746] ppid=9725 vsize=894712 CPUtime=0
/proc/9738/task/9746/stat : 9746 (java) S 9725 9724 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 10373767 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9747] ppid=9725 vsize=894712 CPUtime=0
/proc/9738/task/9747/stat : 9747 (java) S 9725 9724 4778 34817 4778 4202560 2 0 0 0 0 0 0 0 15 0 11 0 10373767 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9748] ppid=9725 vsize=894712 CPUtime=0
/proc/9738/task/9748/stat : 9748 (java) S 9725 9724 4778 34817 4778 4202560 4 0 0 0 0 0 0 0 25 0 11 0 10374279 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 223.82
Current children cumulated vsize (KiB) 899856

[startup+225.614 s]
/proc/loadavg: 1.01 1.05 1.05 2/46 9748
/proc/meminfo: memFree=6048/1048576 swapFree=0/0
[pid=9724] ppid=9723 vsize=2572 CPUtime=0
/proc/9724/stat : 9724 (p2cudf-paranoid) S 9723 9724 4778 34817 4778 4202496 374 0 0 0 0 0 0 0 25 0 1 0 10373758 2633728 271 1283457024 134512640 135304128 4291991360 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9724/statm: 643 271 230 194 0 30 0
[pid=9725] ppid=9724 vsize=2572 CPUtime=0.04
/proc/9725/stat : 9725 (p2cudf) S 9724 9724 4778 34817 4778 4202496 387 3015 0 1 0 0 2 2 25 0 1 0 10373759 2633728 279 1283457024 134512640 135304128 4290899536 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9725/statm: 643 279 239 194 0 30 0
[pid=9738] ppid=9725 vsize=894712 CPUtime=225.38
/proc/9738/stat : 9738 (java) S 9725 9724 4778 34817 4778 4202496 104039 0 1 0 22491 47 0 0 25 0 11 0 10373762 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/9738/statm: 223678 96677 1787 10 0 220769 0
[pid=9738/tid=9739] ppid=9725 vsize=894712 CPUtime=213.68
/proc/9738/task/9739/stat : 9739 (java) R 9725 9724 4778 34817 4778 4202560 50279 0 1 0 21334 34 0 0 25 0 11 0 10373763 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4096529077 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=9738/tid=9740] ppid=9725 vsize=894712 CPUtime=8.68
/proc/9738/task/9740/stat : 9740 (java) S 9725 9724 4778 34817 4778 4202560 35467 0 0 0 861 7 0 0 15 0 11 0 10373764 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 0 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9741] ppid=9725 vsize=894712 CPUtime=0
/proc/9738/task/9741/stat : 9741 (java) S 9725 9724 4778 34817 4778 4202560 8 0 0 0 0 0 0 0 18 0 11 0 10373765 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9742] ppid=9725 vsize=894712 CPUtime=0
/proc/9738/task/9742/stat : 9742 (java) S 9725 9724 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 18 0 11 0 10373765 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9743] ppid=9725 vsize=894712 CPUtime=0
/proc/9738/task/9743/stat : 9743 (java) S 9725 9724 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 10373767 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9744] ppid=9725 vsize=894712 CPUtime=2.56
/proc/9738/task/9744/stat : 9744 (java) S 9725 9724 4778 34817 4778 4202560 11529 0 0 0 252 4 0 0 15 0 11 0 10373767 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9745] ppid=9725 vsize=894712 CPUtime=0.42
/proc/9738/task/9745/stat : 9745 (java) S 9725 9724 4778 34817 4778 4202560 5685 0 0 0 42 0 0 0 17 0 11 0 10373767 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9746] ppid=9725 vsize=894712 CPUtime=0
/proc/9738/task/9746/stat : 9746 (java) S 9725 9724 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 10373767 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9747] ppid=9725 vsize=894712 CPUtime=0
/proc/9738/task/9747/stat : 9747 (java) S 9725 9724 4778 34817 4778 4202560 2 0 0 0 0 0 0 0 15 0 11 0 10373767 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9748] ppid=9725 vsize=894712 CPUtime=0
/proc/9738/task/9748/stat : 9748 (java) S 9725 9724 4778 34817 4778 4202560 4 0 0 0 0 0 0 0 25 0 11 0 10374279 916185088 96677 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 225.42
Current children cumulated vsize (KiB) 899856

[startup+226.408 s]
/proc/loadavg: 1.01 1.05 1.05 2/46 9748
/proc/meminfo: memFree=6048/1048576 swapFree=0/0
[pid=9724] ppid=9723 vsize=2572 CPUtime=0
/proc/9724/stat : 9724 (p2cudf-paranoid) S 9723 9724 4778 34817 4778 4202496 374 0 0 0 0 0 0 0 25 0 1 0 10373758 2633728 271 1283457024 134512640 135304128 4291991360 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9724/statm: 643 271 230 194 0 30 0
[pid=9725] ppid=9724 vsize=2572 CPUtime=0.04
/proc/9725/stat : 9725 (p2cudf) S 9724 9724 4778 34817 4778 4202496 387 3015 0 1 0 0 2 2 25 0 1 0 10373759 2633728 279 1283457024 134512640 135304128 4290899536 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9725/statm: 643 279 239 194 0 30 0
[pid=9738] ppid=9725 vsize=895036 CPUtime=226.16
/proc/9738/stat : 9738 (java) S 9725 9724 4778 34817 4778 4202496 104052 0 1 0 22569 47 0 0 25 0 11 0 10373762 916516864 96690 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/9738/statm: 223759 96690 1788 10 0 220850 0
[pid=9738/tid=9739] ppid=9725 vsize=895036 CPUtime=214.42
/proc/9738/task/9739/stat : 9739 (java) S 9725 9724 4778 34817 4778 4202560 50287 0 1 0 21408 34 0 0 25 0 11 0 10373763 916516864 96690 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9740] ppid=9725 vsize=895036 CPUtime=8.68
/proc/9738/task/9740/stat : 9740 (java) S 9725 9724 4778 34817 4778 4202560 35467 0 0 0 861 7 0 0 16 0 11 0 10373764 916516864 96690 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 0 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9741] ppid=9725 vsize=895036 CPUtime=0
/proc/9738/task/9741/stat : 9741 (java) S 9725 9724 4778 34817 4778 4202560 8 0 0 0 0 0 0 0 18 0 11 0 10373765 916516864 96690 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9742] ppid=9725 vsize=895036 CPUtime=0
/proc/9738/task/9742/stat : 9742 (java) S 9725 9724 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 18 0 11 0 10373765 916516864 96690 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9743] ppid=9725 vsize=895036 CPUtime=0
/proc/9738/task/9743/stat : 9743 (java) S 9725 9724 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 10373767 916516864 96690 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9744] ppid=9725 vsize=895036 CPUtime=2.6
/proc/9738/task/9744/stat : 9744 (java) S 9725 9724 4778 34817 4778 4202560 11529 0 0 0 256 4 0 0 16 0 11 0 10373767 916516864 96690 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9745] ppid=9725 vsize=895036 CPUtime=0.42
/proc/9738/task/9745/stat : 9745 (java) S 9725 9724 4778 34817 4778 4202560 5685 0 0 0 42 0 0 0 17 0 11 0 10373767 916516864 96690 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9746] ppid=9725 vsize=895036 CPUtime=0
/proc/9738/task/9746/stat : 9746 (java) S 9725 9724 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 10373767 916516864 96690 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9747] ppid=9725 vsize=895036 CPUtime=0
/proc/9738/task/9747/stat : 9747 (java) S 9725 9724 4778 34817 4778 4202560 2 0 0 0 0 0 0 0 15 0 11 0 10373767 916516864 96690 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 226.2
Current children cumulated vsize (KiB) 900180

[startup+226.808 s]
/proc/loadavg: 1.01 1.05 1.05 1/48 9751
/proc/meminfo: memFree=5900/1048576 swapFree=0/0
[pid=9724] ppid=9723 vsize=2572 CPUtime=0
/proc/9724/stat : 9724 (p2cudf-paranoid) S 9723 9724 4778 34817 4778 4202496 374 0 0 0 0 0 0 0 25 0 1 0 10373758 2633728 271 1283457024 134512640 135304128 4291991360 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9724/statm: 643 271 230 194 0 30 0
[pid=9725] ppid=9724 vsize=2572 CPUtime=0.04
/proc/9725/stat : 9725 (p2cudf) S 9724 9724 4778 34817 4778 4202496 387 3015 0 1 0 0 2 2 25 0 1 0 10373759 2633728 279 1283457024 134512640 135304128 4290899536 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9725/statm: 643 279 239 194 0 30 0
[pid=9738] ppid=9725 vsize=895036 CPUtime=226.16
/proc/9738/stat : 9738 (java) S 9725 9724 4778 34817 4778 4202496 104052 0 1 0 22569 47 0 0 25 0 11 0 10373762 916516864 96690 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/9738/statm: 223759 96690 1788 10 0 220850 0
[pid=9738/tid=9739] ppid=9725 vsize=895036 CPUtime=214.42
/proc/9738/task/9739/stat : 9739 (java) S 9725 9724 4778 34817 4778 4202560 50287 0 1 0 21408 34 0 0 25 0 11 0 10373763 916516864 96690 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9740] ppid=9725 vsize=895036 CPUtime=8.68
/proc/9738/task/9740/stat : 9740 (java) S 9725 9724 4778 34817 4778 4202560 35467 0 0 0 861 7 0 0 16 0 11 0 10373764 916516864 96690 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 0 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9741] ppid=9725 vsize=895036 CPUtime=0
/proc/9738/task/9741/stat : 9741 (java) S 9725 9724 4778 34817 4778 4202560 8 0 0 0 0 0 0 0 18 0 11 0 10373765 916516864 96690 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9742] ppid=9725 vsize=895036 CPUtime=0
/proc/9738/task/9742/stat : 9742 (java) S 9725 9724 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 18 0 11 0 10373765 916516864 96690 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9743] ppid=9725 vsize=895036 CPUtime=0
/proc/9738/task/9743/stat : 9743 (java) S 9725 9724 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 10373767 916516864 96690 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9744] ppid=9725 vsize=895036 CPUtime=2.6
/proc/9738/task/9744/stat : 9744 (java) S 9725 9724 4778 34817 4778 4202560 11529 0 0 0 256 4 0 0 16 0 11 0 10373767 916516864 96690 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9745] ppid=9725 vsize=895036 CPUtime=0.42
/proc/9738/task/9745/stat : 9745 (java) S 9725 9724 4778 34817 4778 4202560 5685 0 0 0 42 0 0 0 17 0 11 0 10373767 916516864 96690 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9746] ppid=9725 vsize=895036 CPUtime=0
/proc/9738/task/9746/stat : 9746 (java) S 9725 9724 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 10373767 916516864 96690 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9747] ppid=9725 vsize=895036 CPUtime=0
/proc/9738/task/9747/stat : 9747 (java) S 9725 9724 4778 34817 4778 4202560 2 0 0 0 0 0 0 0 15 0 11 0 10373767 916516864 96690 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=9738/tid=9751] ppid=9725 vsize=895036 CPUtime=0
/proc/9738/task/9751/stat : 9751 (java) S 9725 9724 4778 34817 4778 4202560 4 0 0 0 0 0 0 0 25 0 11 0 10396398 916516864 96690 1283457024 134512640 134550932 4288363136 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 226.2
Current children cumulated vsize (KiB) 900180

[startup+227.01 s]
/proc/loadavg: 1.01 1.05 1.05 1/48 9751
/proc/meminfo: memFree=5900/1048576 swapFree=0/0
[pid=9724] ppid=9723 vsize=2572 CPUtime=0
/proc/9724/stat : 9724 (p2cudf-paranoid) S 9723 9724 4778 34817 4778 4202496 374 0 0 0 0 0 0 0 25 0 1 0 10373758 2633728 271 1283457024 134512640 135304128 4291991360 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9724/statm: 643 271 230 194 0 30 0
[pid=9725] ppid=9724 vsize=2572 CPUtime=0.04
/proc/9725/stat : 9725 (p2cudf) S 9724 9724 4778 34817 4778 4202496 387 3015 0 1 0 0 2 2 25 0 1 0 10373759 2633728 279 1283457024 134512640 135304128 4290899536 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/9725/statm: 643 279 239 194 0 30 0
[pid=9738] ppid=9725 vsize=0 CPUtime=226.26
/proc/9738/stat : 9738 (java) Z 9725 9724 4778 34817 4778 4203532 104058 0 1 0 22576 50 0 0 18 0 2 0 10373762 0 0 1283457024 0 0 0 0 0 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/9738/statm: 0 0 0 0 0 0 0
[pid=9738/tid=9739] ppid=9725 vsize=0 CPUtime=214.44
/proc/9738/task/9739/stat : 9739 (java) R 9725 9724 4778 34817 4778 4203588 50287 0 1 0 21408 36 0 0 20 0 2 0 10373763 0 0 1283457024 0 0 0 0 0 0 4 0 16800975 0 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 226.3
Current children cumulated vsize (KiB) 5144

Child status: 0
Real time (s): 227.022
CPU time (s): 226.318
CPU user time (s): 225.786
CPU system time (s): 0.532033
CPU usage (%): 99.69
Max. virtual memory (cumulated for all children) (KiB): 903912

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 225.786
system time used= 0.532033
maximum resident set size= 0
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 107856
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= 4929
involuntary context switches= 7247

runsolver used 0 second user time and 0 second system time

The end