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/rand439.cudf.s-e-l-s.log.runsolver ./p2cudf-paranoid-1.13 /home/misc2010/data/2011/incremental/s-e-l-s/rand439.cudf /home/misc2010/tmp/201108251442/p2cudf-paranoid-1.13/rand439.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.40 1.24 1.09 5/35 12602
/proc/meminfo: memFree=334984/1048576 swapFree=0/0
[pid=12600] ppid=12599 vsize=2564 CPUtime=0
/proc/12600/stat : 12600 (p2cudf-paranoid) S 12599 12600 4778 34817 4778 4202496 373 0 0 0 0 0 0 0 18 0 1 0 10581999 2625536 269 1283457024 134512640 135304128 4290829856 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12600/statm: 641 269 230 194 0 28 0
[pid=12601] ppid=12600 vsize=2564 CPUtime=0
/proc/12601/stat : 12601 (p2cudf) R 12600 12600 4778 34817 4778 4202496 344 0 0 0 0 0 0 0 25 0 1 0 10581999 2625536 270 1283457024 134512640 135304128 4290334144 18446744073709551615 4294960130 0 65538 4 65536 0 0 0 17 0 0 0 0
/proc/12601/statm: 641 270 231 194 0 28 0
[pid=12602] ppid=12601 vsize=2564 CPUtime=0
/proc/12602/stat : 12602 (p2cudf) R 12601 12600 4778 34817 4778 4202560 0 0 0 0 0 0 0 0 25 0 1 0 10581999 2625536 39 1283457024 134512640 135304128 4290334144 18446744073709551615 4294960130 0 65538 4 65536 0 0 0 17 0 0 0 0
/proc/12602/statm: 641 39 0 194 0 28 0

[startup+0.175911 s]
/proc/loadavg: 1.40 1.24 1.09 5/35 12602
/proc/meminfo: memFree=334984/1048576 swapFree=0/0
[pid=12600] ppid=12599 vsize=2564 CPUtime=0
/proc/12600/stat : 12600 (p2cudf-paranoid) S 12599 12600 4778 34817 4778 4202496 373 0 0 0 0 0 0 0 18 0 1 0 10581999 2625536 269 1283457024 134512640 135304128 4290829856 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12600/statm: 641 269 230 194 0 28 0
[pid=12601] ppid=12600 vsize=2568 CPUtime=0.02
/proc/12601/stat : 12601 (p2cudf) S 12600 12600 4778 34817 4778 4202496 387 3013 0 1 0 0 0 2 25 0 1 0 10581999 2629632 279 1283457024 134512640 135304128 4290334144 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12601/statm: 642 279 239 194 0 29 0
Current children cumulated CPU time (s) 0.02
Current children cumulated vsize (KiB) 5132

[startup+0.205913 s]
/proc/loadavg: 1.40 1.24 1.09 5/35 12602
/proc/meminfo: memFree=334984/1048576 swapFree=0/0
[pid=12600] ppid=12599 vsize=2564 CPUtime=0
/proc/12600/stat : 12600 (p2cudf-paranoid) S 12599 12600 4778 34817 4778 4202496 373 0 0 0 0 0 0 0 18 0 1 0 10581999 2625536 269 1283457024 134512640 135304128 4290829856 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12600/statm: 641 269 230 194 0 28 0
[pid=12601] ppid=12600 vsize=2568 CPUtime=0.02
/proc/12601/stat : 12601 (p2cudf) S 12600 12600 4778 34817 4778 4202496 387 3013 0 1 0 0 0 2 25 0 1 0 10581999 2629632 279 1283457024 134512640 135304128 4290334144 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12601/statm: 642 279 239 194 0 29 0
Current children cumulated CPU time (s) 0.02
Current children cumulated vsize (KiB) 5132

[startup+0.305924 s]
/proc/loadavg: 1.40 1.24 1.09 5/35 12602
/proc/meminfo: memFree=334984/1048576 swapFree=0/0
[pid=12600] ppid=12599 vsize=2564 CPUtime=0
/proc/12600/stat : 12600 (p2cudf-paranoid) S 12599 12600 4778 34817 4778 4202496 373 0 0 0 0 0 0 0 18 0 1 0 10581999 2625536 269 1283457024 134512640 135304128 4290829856 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12600/statm: 641 269 230 194 0 28 0
[pid=12601] ppid=12600 vsize=2568 CPUtime=0.02
/proc/12601/stat : 12601 (p2cudf) S 12600 12600 4778 34817 4778 4202496 387 3013 0 1 0 0 0 2 25 0 1 0 10581999 2629632 279 1283457024 134512640 135304128 4290334144 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12601/statm: 642 279 239 194 0 29 0
Current children cumulated CPU time (s) 0.02
Current children cumulated vsize (KiB) 5132

[startup+0.705987 s]
/proc/loadavg: 1.40 1.24 1.09 5/35 12602
/proc/meminfo: memFree=334984/1048576 swapFree=0/0
[pid=12600] ppid=12599 vsize=2564 CPUtime=0
/proc/12600/stat : 12600 (p2cudf-paranoid) S 12599 12600 4778 34817 4778 4202496 373 0 0 0 0 0 0 0 18 0 1 0 10581999 2625536 269 1283457024 134512640 135304128 4290829856 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12600/statm: 641 269 230 194 0 28 0
[pid=12601] ppid=12600 vsize=2568 CPUtime=0.02
/proc/12601/stat : 12601 (p2cudf) S 12600 12600 4778 34817 4778 4202496 387 3013 0 1 0 0 0 2 25 0 1 0 10581999 2629632 279 1283457024 134512640 135304128 4290334144 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12601/statm: 642 279 239 194 0 29 0
Current children cumulated CPU time (s) 0.02
Current children cumulated vsize (KiB) 5132

[startup+1.50614 s]
/proc/loadavg: 1.40 1.24 1.09 5/45 12623
/proc/meminfo: memFree=277668/1048576 swapFree=0/0
[pid=12600] ppid=12599 vsize=2564 CPUtime=0
/proc/12600/stat : 12600 (p2cudf-paranoid) S 12599 12600 4778 34817 4778 4202496 373 0 0 0 0 0 0 0 18 0 1 0 10581999 2625536 269 1283457024 134512640 135304128 4290829856 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12600/statm: 641 269 230 194 0 28 0
[pid=12601] ppid=12600 vsize=2568 CPUtime=0.02
/proc/12601/stat : 12601 (p2cudf) S 12600 12600 4778 34817 4778 4202496 387 3013 0 1 0 0 0 2 25 0 1 0 10581999 2629632 279 1283457024 134512640 135304128 4290334144 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12601/statm: 642 279 239 194 0 29 0
[pid=12614] ppid=12601 vsize=898416 CPUtime=1.47
/proc/12614/stat : 12614 (java) S 12601 12600 4778 34817 4778 4202496 25154 0 1 0 135 12 0 0 25 0 10 0 10582002 919977984 21529 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/12614/statm: 224604 21529 1719 10 0 221695 0
[pid=12614/tid=12615] ppid=12601 vsize=898416 CPUtime=0.79
/proc/12614/task/12615/stat : 12615 (java) R 12601 12600 4778 34817 4778 4202560 10555 0 1 0 75 4 0 0 25 0 10 0 10582003 919977984 21529 1283457024 134512640 134550932 4293025520 18446744073709551615 4095660409 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=12614/tid=12616] ppid=12601 vsize=898416 CPUtime=0
/proc/12614/task/12616/stat : 12616 (java) S 12601 12600 4778 34817 4778 4202560 7 0 0 0 0 0 0 0 17 0 10 0 10582004 919977984 21529 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 0 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=12614/tid=12617] ppid=12601 vsize=898416 CPUtime=0
/proc/12614/task/12617/stat : 12617 (java) S 12601 12600 4778 34817 4778 4202560 8 0 0 0 0 0 0 0 25 0 10 0 10582005 919977984 21529 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=12614/tid=12618] ppid=12601 vsize=898416 CPUtime=0
/proc/12614/task/12618/stat : 12618 (java) S 12601 12600 4778 34817 4778 4202560 4 0 0 0 0 0 0 0 25 0 10 0 10582005 919977984 21529 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=12614/tid=12619] ppid=12601 vsize=898416 CPUtime=0
/proc/12614/task/12619/stat : 12619 (java) S 12601 12600 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 10 0 10582007 919977984 21529 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=12614/tid=12620] ppid=12601 vsize=898416 CPUtime=0.45
/proc/12614/task/12620/stat : 12620 (java) R 12601 12600 4778 34817 4778 4202560 8907 0 0 0 40 5 0 0 25 0 10 0 10582007 919977984 21529 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=12614/tid=12621] ppid=12601 vsize=898416 CPUtime=0.22
/proc/12614/task/12621/stat : 12621 (java) S 12601 12600 4778 34817 4778 4202560 4614 0 0 0 20 2 0 0 22 0 10 0 10582007 919977984 21529 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=12614/tid=12622] ppid=12601 vsize=898416 CPUtime=0
/proc/12614/task/12622/stat : 12622 (java) S 12601 12600 4778 34817 4778 4202560 0 0 0 0 0 0 0 0 25 0 10 0 10582007 919977984 21529 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=12614/tid=12623] ppid=12601 vsize=898416 CPUtime=0
/proc/12614/task/12623/stat : 12623 (java) S 12601 12600 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 15 0 10 0 10582007 919977984 21529 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 1.49
Current children cumulated vsize (KiB) 903548

[startup+3.10659 s]
/proc/loadavg: 1.53 1.27 1.10 2/45 12623
/proc/meminfo: memFree=193720/1048576 swapFree=0/0
[pid=12600] ppid=12599 vsize=2564 CPUtime=0
/proc/12600/stat : 12600 (p2cudf-paranoid) S 12599 12600 4778 34817 4778 4202496 373 0 0 0 0 0 0 0 18 0 1 0 10581999 2625536 269 1283457024 134512640 135304128 4290829856 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12600/statm: 641 269 230 194 0 28 0
[pid=12601] ppid=12600 vsize=2568 CPUtime=0.02
/proc/12601/stat : 12601 (p2cudf) S 12600 12600 4778 34817 4778 4202496 387 3013 0 1 0 0 0 2 25 0 1 0 10581999 2629632 279 1283457024 134512640 135304128 4290334144 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12601/statm: 642 279 239 194 0 29 0
[pid=12614] ppid=12601 vsize=896376 CPUtime=3.07
/proc/12614/stat : 12614 (java) S 12601 12600 4778 34817 4778 4202496 79323 0 1 0 276 31 0 0 25 0 10 0 10582002 917889024 74576 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/12614/statm: 224094 74576 1732 10 0 221185 0
[pid=12614/tid=12615] ppid=12601 vsize=896376 CPUtime=1.66
/proc/12614/task/12615/stat : 12615 (java) R 12601 12600 4778 34817 4778 4202560 50003 0 1 0 147 19 0 0 25 0 10 0 10582003 917889024 74576 1283457024 134512640 134550932 4293025520 18446744073709551615 4095784019 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=12614/tid=12616] ppid=12601 vsize=896376 CPUtime=0.29
/proc/12614/task/12616/stat : 12616 (java) S 12601 12600 4778 34817 4778 4202560 13290 0 0 0 26 3 0 0 16 0 10 0 10582004 917889024 74576 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 0 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=12614/tid=12617] ppid=12601 vsize=896376 CPUtime=0
/proc/12614/task/12617/stat : 12617 (java) S 12601 12600 4778 34817 4778 4202560 8 0 0 0 0 0 0 0 18 0 10 0 10582005 917889024 74576 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=12614/tid=12618] ppid=12601 vsize=896376 CPUtime=0
/proc/12614/task/12618/stat : 12618 (java) S 12601 12600 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 18 0 10 0 10582005 917889024 74576 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=12614/tid=12619] ppid=12601 vsize=896376 CPUtime=0
/proc/12614/task/12619/stat : 12619 (java) S 12601 12600 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 10 0 10582007 917889024 74576 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=12614/tid=12620] ppid=12601 vsize=896376 CPUtime=0.51
/proc/12614/task/12620/stat : 12620 (java) S 12601 12600 4778 34817 4778 4202560 8943 0 0 0 46 5 0 0 25 0 10 0 10582007 917889024 74576 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=12614/tid=12621] ppid=12601 vsize=896376 CPUtime=0.59
/proc/12614/task/12621/stat : 12621 (java) S 12601 12600 4778 34817 4778 4202560 6014 0 0 0 57 2 0 0 15 0 10 0 10582007 917889024 74576 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=12614/tid=12622] ppid=12601 vsize=896376 CPUtime=0
/proc/12614/task/12622/stat : 12622 (java) S 12601 12600 4778 34817 4778 4202560 0 0 0 0 0 0 0 0 25 0 10 0 10582007 917889024 74576 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=12614/tid=12623] ppid=12601 vsize=896376 CPUtime=0
/proc/12614/task/12623/stat : 12623 (java) S 12601 12600 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 15 0 10 0 10582007 917889024 74576 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 3.09
Current children cumulated vsize (KiB) 901508

[startup+6.30752 s]
/proc/loadavg: 1.53 1.27 1.10 2/46 12624
/proc/meminfo: memFree=5516/1048576 swapFree=0/0
[pid=12600] ppid=12599 vsize=2564 CPUtime=0
/proc/12600/stat : 12600 (p2cudf-paranoid) S 12599 12600 4778 34817 4778 4202496 373 0 0 0 0 0 0 0 18 0 1 0 10581999 2625536 269 1283457024 134512640 135304128 4290829856 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12600/statm: 641 269 230 194 0 28 0
[pid=12601] ppid=12600 vsize=2568 CPUtime=0.02
/proc/12601/stat : 12601 (p2cudf) S 12600 12600 4778 34817 4778 4202496 387 3013 0 1 0 0 0 2 25 0 1 0 10581999 2629632 279 1283457024 134512640 135304128 4290334144 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12601/statm: 642 279 239 194 0 29 0
[pid=12614] ppid=12601 vsize=896212 CPUtime=6.27
/proc/12614/stat : 12614 (java) S 12601 12600 4778 34817 4778 4202496 96396 0 1 0 590 37 0 0 25 0 11 0 10582002 917721088 89193 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/12614/statm: 224053 89193 1777 10 0 221144 0
[pid=12614/tid=12615] ppid=12601 vsize=896212 CPUtime=3.11
/proc/12614/task/12615/stat : 12615 (java) R 12601 12600 4778 34817 4778 4202560 50277 0 1 0 291 20 0 0 25 0 11 0 10582003 917721088 89193 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=12614/tid=12616] ppid=12601 vsize=896212 CPUtime=0.64
/proc/12614/task/12616/stat : 12616 (java) S 12601 12600 4778 34817 4778 4202560 27539 0 0 0 56 8 0 0 16 0 11 0 10582004 917721088 89193 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 0 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=12614/tid=12617] ppid=12601 vsize=896212 CPUtime=0
/proc/12614/task/12617/stat : 12617 (java) S 12601 12600 4778 34817 4778 4202560 8 0 0 0 0 0 0 0 18 0 11 0 10582005 917721088 89193 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=12614/tid=12618] ppid=12601 vsize=896212 CPUtime=0
/proc/12614/task/12618/stat : 12618 (java) S 12601 12600 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 18 0 11 0 10582005 917721088 89193 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=12614/tid=12619] ppid=12601 vsize=896212 CPUtime=0
/proc/12614/task/12619/stat : 12619 (java) S 12601 12600 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 10582007 917721088 89193 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=12614/tid=12620] ppid=12601 vsize=896212 CPUtime=0.51
/proc/12614/task/12620/stat : 12620 (java) S 12601 12600 4778 34817 4778 4202560 8943 0 0 0 46 5 0 0 25 0 11 0 10582007 917721088 89193 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=12614/tid=12621] ppid=12601 vsize=896212 CPUtime=1.98
/proc/12614/task/12621/stat : 12621 (java) R 12601 12600 4778 34817 4778 4202560 8560 0 0 0 196 2 0 0 16 0 11 0 10582007 917721088 89193 1283457024 134512640 134550932 4293025520 18446744073709551615 4152878726 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=12614/tid=12622] ppid=12601 vsize=896212 CPUtime=0
/proc/12614/task/12622/stat : 12622 (java) S 12601 12600 4778 34817 4778 4202560 0 0 0 0 0 0 0 0 25 0 11 0 10582007 917721088 89193 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=12614/tid=12623] ppid=12601 vsize=896212 CPUtime=0
/proc/12614/task/12623/stat : 12623 (java) R 12601 12600 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 15 0 11 0 10582007 917721088 89193 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=12614/tid=12624] ppid=12601 vsize=896212 CPUtime=0
/proc/12614/task/12624/stat : 12624 (java) S 12601 12600 4778 34817 4778 4202560 4 0 0 0 0 0 0 0 25 0 11 0 10582529 917721088 89193 1283457024 134512640 134550932 4293025520 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) 901344

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

[startup+6.40755 s]
/proc/loadavg: 1.53 1.27 1.10 2/46 12624
/proc/meminfo: memFree=5516/1048576 swapFree=0/0
[pid=12600] ppid=12599 vsize=2564 CPUtime=0
/proc/12600/stat : 12600 (p2cudf-paranoid) S 12599 12600 4778 34817 4778 4202496 373 0 0 0 0 0 0 0 18 0 1 0 10581999 2625536 269 1283457024 134512640 135304128 4290829856 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12600/statm: 641 269 230 194 0 28 0
[pid=12601] ppid=12600 vsize=2568 CPUtime=0.02
/proc/12601/stat : 12601 (p2cudf) S 12600 12600 4778 34817 4778 4202496 387 3013 0 1 0 0 0 2 25 0 1 0 10581999 2629632 279 1283457024 134512640 135304128 4290334144 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12601/statm: 642 279 239 194 0 29 0
[pid=12614] ppid=12601 vsize=896212 CPUtime=6.37
/proc/12614/stat : 12614 (java) S 12601 12600 4778 34817 4778 4202496 96403 0 1 0 600 37 0 0 25 0 11 0 10582002 917721088 89200 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/12614/statm: 224053 89200 1777 10 0 221144 0
[pid=12614/tid=12615] ppid=12601 vsize=896212 CPUtime=3.18
/proc/12614/task/12615/stat : 12615 (java) R 12601 12600 4778 34817 4778 4202560 50277 0 1 0 298 20 0 0 25 0 11 0 10582003 917721088 89200 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=12614/tid=12616] ppid=12601 vsize=896212 CPUtime=0.64
/proc/12614/task/12616/stat : 12616 (java) S 12601 12600 4778 34817 4778 4202560 27539 0 0 0 56 8 0 0 16 0 11 0 10582004 917721088 89200 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 0 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=12614/tid=12617] ppid=12601 vsize=896212 CPUtime=0
/proc/12614/task/12617/stat : 12617 (java) S 12601 12600 4778 34817 4778 4202560 8 0 0 0 0 0 0 0 18 0 11 0 10582005 917721088 89200 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=12614/tid=12618] ppid=12601 vsize=896212 CPUtime=0
/proc/12614/task/12618/stat : 12618 (java) S 12601 12600 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 18 0 11 0 10582005 917721088 89200 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=12614/tid=12619] ppid=12601 vsize=896212 CPUtime=0
/proc/12614/task/12619/stat : 12619 (java) S 12601 12600 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 10582007 917721088 89200 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=12614/tid=12620] ppid=12601 vsize=896212 CPUtime=0.51
/proc/12614/task/12620/stat : 12620 (java) S 12601 12600 4778 34817 4778 4202560 8943 0 0 0 46 5 0 0 25 0 11 0 10582007 917721088 89200 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=12614/tid=12621] ppid=12601 vsize=896212 CPUtime=2
/proc/12614/task/12621/stat : 12621 (java) R 12601 12600 4778 34817 4778 4202560 8567 0 0 0 198 2 0 0 16 0 11 0 10582007 917721088 89200 1283457024 134512640 134550932 4293025520 18446744073709551615 4152000282 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=12614/tid=12622] ppid=12601 vsize=896212 CPUtime=0
/proc/12614/task/12622/stat : 12622 (java) S 12601 12600 4778 34817 4778 4202560 0 0 0 0 0 0 0 0 25 0 11 0 10582007 917721088 89200 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=12614/tid=12623] ppid=12601 vsize=896212 CPUtime=0
/proc/12614/task/12623/stat : 12623 (java) S 12601 12600 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 15 0 11 0 10582007 917721088 89200 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=12614/tid=12624] ppid=12601 vsize=896212 CPUtime=0
/proc/12614/task/12624/stat : 12624 (java) S 12601 12600 4778 34817 4778 4202560 4 0 0 0 0 0 0 0 25 0 11 0 10582529 917721088 89200 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 6.39
Current children cumulated vsize (KiB) 901344

[startup+8.00791 s]
/proc/loadavg: 1.57 1.28 1.10 2/46 12624
/proc/meminfo: memFree=6144/1048576 swapFree=0/0
[pid=12600] ppid=12599 vsize=2564 CPUtime=0
/proc/12600/stat : 12600 (p2cudf-paranoid) S 12599 12600 4778 34817 4778 4202496 373 0 0 0 0 0 0 0 18 0 1 0 10581999 2625536 269 1283457024 134512640 135304128 4290829856 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12600/statm: 641 269 230 194 0 28 0
[pid=12601] ppid=12600 vsize=2568 CPUtime=0.02
/proc/12601/stat : 12601 (p2cudf) S 12600 12600 4778 34817 4778 4202496 387 3013 0 1 0 0 0 2 25 0 1 0 10581999 2629632 279 1283457024 134512640 135304128 4290334144 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12601/statm: 642 279 239 194 0 29 0
[pid=12614] ppid=12601 vsize=894740 CPUtime=7.97
/proc/12614/stat : 12614 (java) S 12601 12600 4778 34817 4778 4202496 96459 0 1 0 760 37 0 0 25 0 11 0 10582002 916213760 88888 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/12614/statm: 223685 88888 1782 10 0 220776 0
[pid=12614/tid=12615] ppid=12601 vsize=894740 CPUtime=4.51
/proc/12614/task/12615/stat : 12615 (java) R 12601 12600 4778 34817 4778 4202560 50278 0 1 0 431 20 0 0 25 0 11 0 10582003 916213760 88888 1283457024 134512640 134550932 4293025520 18446744073709551615 4096443539 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=12614/tid=12616] ppid=12601 vsize=894740 CPUtime=0.65
/proc/12614/task/12616/stat : 12616 (java) S 12601 12600 4778 34817 4778 4202560 27539 0 0 0 57 8 0 0 15 0 11 0 10582004 916213760 88888 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 0 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=12614/tid=12617] ppid=12601 vsize=894740 CPUtime=0
/proc/12614/task/12617/stat : 12617 (java) S 12601 12600 4778 34817 4778 4202560 8 0 0 0 0 0 0 0 18 0 11 0 10582005 916213760 88888 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=12614/tid=12618] ppid=12601 vsize=894740 CPUtime=0
/proc/12614/task/12618/stat : 12618 (java) S 12601 12600 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 18 0 11 0 10582005 916213760 88888 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=12614/tid=12619] ppid=12601 vsize=894740 CPUtime=0
/proc/12614/task/12619/stat : 12619 (java) S 12601 12600 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 10582007 916213760 88888 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=12614/tid=12620] ppid=12601 vsize=894740 CPUtime=0.51
/proc/12614/task/12620/stat : 12620 (java) S 12601 12600 4778 34817 4778 4202560 8943 0 0 0 46 5 0 0 25 0 11 0 10582007 916213760 88888 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=12614/tid=12621] ppid=12601 vsize=894740 CPUtime=2.27
/proc/12614/task/12621/stat : 12621 (java) S 12601 12600 4778 34817 4778 4202560 8622 0 0 0 225 2 0 0 15 0 11 0 10582007 916213760 88888 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=12614/tid=12622] ppid=12601 vsize=894740 CPUtime=0
/proc/12614/task/12622/stat : 12622 (java) S 12601 12600 4778 34817 4778 4202560 0 0 0 0 0 0 0 0 25 0 11 0 10582007 916213760 88888 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=12614/tid=12623] ppid=12601 vsize=894740 CPUtime=0
/proc/12614/task/12623/stat : 12623 (java) S 12601 12600 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 15 0 11 0 10582007 916213760 88888 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=12614/tid=12624] ppid=12601 vsize=894740 CPUtime=0
/proc/12614/task/12624/stat : 12624 (java) S 12601 12600 4778 34817 4778 4202560 4 0 0 0 0 0 0 0 25 0 11 0 10582529 916213760 88888 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 7.99
Current children cumulated vsize (KiB) 899872

[startup+8.80804 s]
/proc/loadavg: 1.57 1.28 1.10 2/46 12624
/proc/meminfo: memFree=6144/1048576 swapFree=0/0
[pid=12600] ppid=12599 vsize=2564 CPUtime=0
/proc/12600/stat : 12600 (p2cudf-paranoid) S 12599 12600 4778 34817 4778 4202496 373 0 0 0 0 0 0 0 18 0 1 0 10581999 2625536 269 1283457024 134512640 135304128 4290829856 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12600/statm: 641 269 230 194 0 28 0
[pid=12601] ppid=12600 vsize=2568 CPUtime=0.02
/proc/12601/stat : 12601 (p2cudf) S 12600 12600 4778 34817 4778 4202496 387 3013 0 1 0 0 0 2 25 0 1 0 10581999 2629632 279 1283457024 134512640 135304128 4290334144 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12601/statm: 642 279 239 194 0 29 0
[pid=12614] ppid=12601 vsize=894740 CPUtime=8.77
/proc/12614/stat : 12614 (java) S 12601 12600 4778 34817 4778 4202496 96459 0 1 0 840 37 0 0 25 0 11 0 10582002 916213760 88888 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/12614/statm: 223685 88888 1782 10 0 220776 0
[pid=12614/tid=12615] ppid=12601 vsize=894740 CPUtime=5.31
/proc/12614/task/12615/stat : 12615 (java) R 12601 12600 4778 34817 4778 4202560 50278 0 1 0 511 20 0 0 25 0 11 0 10582003 916213760 88888 1283457024 134512640 134550932 4293025520 18446744073709551615 4096476844 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=12614/tid=12616] ppid=12601 vsize=894740 CPUtime=0.65
/proc/12614/task/12616/stat : 12616 (java) S 12601 12600 4778 34817 4778 4202560 27539 0 0 0 57 8 0 0 15 0 11 0 10582004 916213760 88888 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 0 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=12614/tid=12617] ppid=12601 vsize=894740 CPUtime=0
/proc/12614/task/12617/stat : 12617 (java) S 12601 12600 4778 34817 4778 4202560 8 0 0 0 0 0 0 0 18 0 11 0 10582005 916213760 88888 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=12614/tid=12618] ppid=12601 vsize=894740 CPUtime=0
/proc/12614/task/12618/stat : 12618 (java) S 12601 12600 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 18 0 11 0 10582005 916213760 88888 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=12614/tid=12619] ppid=12601 vsize=894740 CPUtime=0
/proc/12614/task/12619/stat : 12619 (java) S 12601 12600 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 10582007 916213760 88888 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=12614/tid=12620] ppid=12601 vsize=894740 CPUtime=0.51
/proc/12614/task/12620/stat : 12620 (java) S 12601 12600 4778 34817 4778 4202560 8943 0 0 0 46 5 0 0 25 0 11 0 10582007 916213760 88888 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=12614/tid=12621] ppid=12601 vsize=894740 CPUtime=2.27
/proc/12614/task/12621/stat : 12621 (java) S 12601 12600 4778 34817 4778 4202560 8622 0 0 0 225 2 0 0 15 0 11 0 10582007 916213760 88888 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=12614/tid=12622] ppid=12601 vsize=894740 CPUtime=0
/proc/12614/task/12622/stat : 12622 (java) S 12601 12600 4778 34817 4778 4202560 0 0 0 0 0 0 0 0 25 0 11 0 10582007 916213760 88888 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=12614/tid=12623] ppid=12601 vsize=894740 CPUtime=0
/proc/12614/task/12623/stat : 12623 (java) S 12601 12600 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 15 0 11 0 10582007 916213760 88888 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=12614/tid=12624] ppid=12601 vsize=894740 CPUtime=0
/proc/12614/task/12624/stat : 12624 (java) S 12601 12600 4778 34817 4778 4202560 4 0 0 0 0 0 0 0 25 0 11 0 10582529 916213760 88888 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 8.79
Current children cumulated vsize (KiB) 899872

[startup+9.20644 s]
/proc/loadavg: 1.57 1.28 1.10 2/46 12624
/proc/meminfo: memFree=6144/1048576 swapFree=0/0
[pid=12600] ppid=12599 vsize=2564 CPUtime=0
/proc/12600/stat : 12600 (p2cudf-paranoid) S 12599 12600 4778 34817 4778 4202496 373 0 0 0 0 0 0 0 18 0 1 0 10581999 2625536 269 1283457024 134512640 135304128 4290829856 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12600/statm: 641 269 230 194 0 28 0
[pid=12601] ppid=12600 vsize=2568 CPUtime=0.02
/proc/12601/stat : 12601 (p2cudf) S 12600 12600 4778 34817 4778 4202496 387 3013 0 1 0 0 0 2 25 0 1 0 10581999 2629632 279 1283457024 134512640 135304128 4290334144 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12601/statm: 642 279 239 194 0 29 0
[pid=12614] ppid=12601 vsize=895064 CPUtime=8.92
/proc/12614/stat : 12614 (java) S 12601 12600 4778 34817 4778 4202496 96475 0 1 0 855 37 0 0 25 0 11 0 10582002 916545536 88904 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/12614/statm: 223766 88904 1783 10 0 220857 0
[pid=12614/tid=12615] ppid=12601 vsize=895064 CPUtime=5.44
/proc/12614/task/12615/stat : 12615 (java) S 12601 12600 4778 34817 4778 4202560 50286 0 1 0 524 20 0 0 25 0 11 0 10582003 916545536 88904 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=12614/tid=12616] ppid=12601 vsize=895064 CPUtime=0.65
/proc/12614/task/12616/stat : 12616 (java) S 12601 12600 4778 34817 4778 4202560 27539 0 0 0 57 8 0 0 16 0 11 0 10582004 916545536 88904 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 0 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=12614/tid=12617] ppid=12601 vsize=895064 CPUtime=0
/proc/12614/task/12617/stat : 12617 (java) S 12601 12600 4778 34817 4778 4202560 8 0 0 0 0 0 0 0 18 0 11 0 10582005 916545536 88904 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=12614/tid=12618] ppid=12601 vsize=895064 CPUtime=0
/proc/12614/task/12618/stat : 12618 (java) S 12601 12600 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 18 0 11 0 10582005 916545536 88904 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=12614/tid=12619] ppid=12601 vsize=895064 CPUtime=0
/proc/12614/task/12619/stat : 12619 (java) S 12601 12600 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 10582007 916545536 88904 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=12614/tid=12620] ppid=12601 vsize=895064 CPUtime=0.51
/proc/12614/task/12620/stat : 12620 (java) S 12601 12600 4778 34817 4778 4202560 8943 0 0 0 46 5 0 0 25 0 11 0 10582007 916545536 88904 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=12614/tid=12621] ppid=12601 vsize=895064 CPUtime=2.29
/proc/12614/task/12621/stat : 12621 (java) S 12601 12600 4778 34817 4778 4202560 8625 0 0 0 227 2 0 0 15 0 11 0 10582007 916545536 88904 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=12614/tid=12622] ppid=12601 vsize=895064 CPUtime=0
/proc/12614/task/12622/stat : 12622 (java) S 12601 12600 4778 34817 4778 4202560 0 0 0 0 0 0 0 0 25 0 11 0 10582007 916545536 88904 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
[pid=12614/tid=12623] ppid=12601 vsize=895064 CPUtime=0
/proc/12614/task/12623/stat : 12623 (java) S 12601 12600 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 15 0 11 0 10582007 916545536 88904 1283457024 134512640 134550932 4293025520 18446744073709551615 4294960130 0 4 0 16800975 18446612133155119552 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 8.94
Current children cumulated vsize (KiB) 900196

[startup+9.60663 s]
/proc/loadavg: 1.57 1.28 1.10 2/46 12624
/proc/meminfo: memFree=6144/1048576 swapFree=0/0
[pid=12600] ppid=12599 vsize=2564 CPUtime=0
/proc/12600/stat : 12600 (p2cudf-paranoid) S 12599 12600 4778 34817 4778 4202496 373 0 0 0 0 0 0 0 18 0 1 0 10581999 2625536 269 1283457024 134512640 135304128 4290829856 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12600/statm: 641 269 230 194 0 28 0
[pid=12601] ppid=12600 vsize=2568 CPUtime=0.02
/proc/12601/stat : 12601 (p2cudf) S 12600 12600 4778 34817 4778 4202496 387 3013 0 1 0 0 0 2 25 0 1 0 10581999 2629632 279 1283457024 134512640 135304128 4290334144 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/12601/statm: 642 279 239 194 0 29 0
[pid=12614] ppid=12601 vsize=0 CPUtime=9.01
/proc/12614/stat : 12614 (java) Z 12601 12600 4778 34817 4778 4203532 96482 0 1 0 860 41 0 0 18 0 2 0 10582002 0 0 1283457024 0 0 0 0 0 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/12614/statm: 0 0 0 0 0 0 0
[pid=12614/tid=12615] ppid=12601 vsize=0 CPUtime=5.46
/proc/12614/task/12615/stat : 12615 (java) R 12601 12600 4778 34817 4778 4203588 50286 0 1 0 524 22 0 0 19 0 2 0 10582003 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) 9.03
Current children cumulated vsize (KiB) 5132

Child status: 0
Real time (s): 9.61562
CPU time (s): 9.04057
CPU user time (s): 8.60854
CPU system time (s): 0.432027
CPU usage (%): 94.0195
Max. virtual memory (cumulated for all children) (KiB): 905956

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 8.60854
system time used= 0.432027
maximum resident set size= 0
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 100276
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= 904
involuntary context switches= 929

runsolver used 0 second user time and 0 second system time

The end