runsolver Copyright (C) 2010 Olivier ROUSSEL

This is runsolver version 3.2.9a (svn: 651)

This program is distributed in the hope that it will be useful,
but WITHOUT ANY WARRANTY; without even the implied warranty of
MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE.  See the
GNU General Public License for more details.

command line: /home/misc2010/bin/runsolver -s SIGUSR1 -M 1124 -C 290 -d 10 -w /home/misc2010/tmp/201108311143/p2cudf-user-1.13/rand282.cudf.dudf-random.log.runsolver ./p2cudf-user-1.13 /home/misc2010/data/2011/dudf-random//rand282.cudf /home/misc2010/tmp/201108311143/p2cudf-user-1.13/rand282.cudf.dudf-random.result -sum(installedsize) 

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


[startup+0 s]
/proc/loadavg: 1.32 1.07 1.02 5/39 21598
/proc/meminfo: memFree=653148/1048576 swapFree=0/0
[pid=21595] ppid=21594 vsize=2564 CPUtime=0
/proc/21595/stat : 21595 (p2cudf-user-1.1) S 21594 21595 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 18 0 1 0 61621140 2625536 270 1283457024 134512640 135304128 4293486752 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21595/statm: 641 270 230 194 0 28 0
[pid=21596] ppid=21595 vsize=2568 CPUtime=0
/proc/21596/stat : 21596 (p2cudf) S 21595 21595 19908 34817 19908 4202496 352 0 0 0 0 0 0 0 18 0 1 0 61621140 2629632 271 1283457024 134512640 135304128 4293036128 18446744073709551615 4294960130 0 0 4 65536 18446744071564457842 0 0 17 0 0 0 0
/proc/21596/statm: 642 271 231 194 0 29 0
[pid=21597] ppid=21596 vsize=2568 CPUtime=0
/proc/21597/stat : 21597 (p2cudf) R 21596 21595 19908 34817 19908 4202560 94 0 0 0 0 0 0 0 25 0 1 0 61621140 2629632 118 1283457024 134512640 135304128 4293036128 18446744073709551615 4294960130 0 65538 0 65538 0 0 0 17 0 0 0 0
/proc/21597/statm: 642 118 77 194 0 29 0
[pid=21598] ppid=21597 vsize=2568 CPUtime=0
/proc/21598/stat : 21598 (p2cudf) R 21597 21595 19908 34817 19908 4202560 0 0 0 0 0 0 0 0 25 0 1 0 61621140 2629632 41 1283457024 134512640 135304128 4293036128 18446744073709551615 4294960130 0 65538 0 65538 0 0 0 17 0 0 0 0
/proc/21598/statm: 642 41 0 194 0 29 0

[startup+0.155628 s]
/proc/loadavg: 1.32 1.07 1.02 5/39 21598
/proc/meminfo: memFree=653148/1048576 swapFree=0/0
[pid=21595] ppid=21594 vsize=2564 CPUtime=0
/proc/21595/stat : 21595 (p2cudf-user-1.1) S 21594 21595 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 18 0 1 0 61621140 2625536 270 1283457024 134512640 135304128 4293486752 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21595/statm: 641 270 230 194 0 28 0
[pid=21596] ppid=21595 vsize=2576 CPUtime=0.03
/proc/21596/stat : 21596 (p2cudf) S 21595 21595 19908 34817 19908 4202496 393 3014 0 1 1 0 2 0 25 0 1 0 61621140 2637824 281 1283457024 134512640 135304128 4293036128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21596/statm: 644 281 239 194 0 31 0
Current children cumulated CPU time (s) 0.03
Current children cumulated vsize (KiB) 5140

[startup+0.205631 s]
/proc/loadavg: 1.32 1.07 1.02 5/39 21598
/proc/meminfo: memFree=653148/1048576 swapFree=0/0
[pid=21595] ppid=21594 vsize=2564 CPUtime=0
/proc/21595/stat : 21595 (p2cudf-user-1.1) S 21594 21595 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 18 0 1 0 61621140 2625536 270 1283457024 134512640 135304128 4293486752 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21595/statm: 641 270 230 194 0 28 0
[pid=21596] ppid=21595 vsize=2576 CPUtime=0.03
/proc/21596/stat : 21596 (p2cudf) S 21595 21595 19908 34817 19908 4202496 393 3014 0 1 1 0 2 0 25 0 1 0 61621140 2637824 281 1283457024 134512640 135304128 4293036128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21596/statm: 644 281 239 194 0 31 0
Current children cumulated CPU time (s) 0.03
Current children cumulated vsize (KiB) 5140

[startup+0.305649 s]
/proc/loadavg: 1.32 1.07 1.02 5/39 21598
/proc/meminfo: memFree=653148/1048576 swapFree=0/0
[pid=21595] ppid=21594 vsize=2564 CPUtime=0
/proc/21595/stat : 21595 (p2cudf-user-1.1) S 21594 21595 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 18 0 1 0 61621140 2625536 270 1283457024 134512640 135304128 4293486752 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21595/statm: 641 270 230 194 0 28 0
[pid=21596] ppid=21595 vsize=2576 CPUtime=0.03
/proc/21596/stat : 21596 (p2cudf) S 21595 21595 19908 34817 19908 4202496 393 3014 0 1 1 0 2 0 25 0 1 0 61621140 2637824 281 1283457024 134512640 135304128 4293036128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21596/statm: 644 281 239 194 0 31 0
Current children cumulated CPU time (s) 0.03
Current children cumulated vsize (KiB) 5140

[startup+0.705736 s]
/proc/loadavg: 1.32 1.07 1.02 5/39 21598
/proc/meminfo: memFree=653148/1048576 swapFree=0/0
[pid=21595] ppid=21594 vsize=2564 CPUtime=0
/proc/21595/stat : 21595 (p2cudf-user-1.1) S 21594 21595 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 18 0 1 0 61621140 2625536 270 1283457024 134512640 135304128 4293486752 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21595/statm: 641 270 230 194 0 28 0
[pid=21596] ppid=21595 vsize=2576 CPUtime=0.03
/proc/21596/stat : 21596 (p2cudf) S 21595 21595 19908 34817 19908 4202496 393 3014 0 1 1 0 2 0 25 0 1 0 61621140 2637824 281 1283457024 134512640 135304128 4293036128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21596/statm: 644 281 239 194 0 31 0
Current children cumulated CPU time (s) 0.03
Current children cumulated vsize (KiB) 5140

[startup+1.50586 s]
/proc/loadavg: 1.32 1.07 1.02 5/48 21618
/proc/meminfo: memFree=610232/1048576 swapFree=0/0
[pid=21595] ppid=21594 vsize=2564 CPUtime=0
/proc/21595/stat : 21595 (p2cudf-user-1.1) S 21594 21595 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 18 0 1 0 61621140 2625536 270 1283457024 134512640 135304128 4293486752 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21595/statm: 641 270 230 194 0 28 0
[pid=21596] ppid=21595 vsize=2576 CPUtime=0.03
/proc/21596/stat : 21596 (p2cudf) S 21595 21595 19908 34817 19908 4202496 393 3014 0 1 1 0 2 0 25 0 1 0 61621140 2637824 281 1283457024 134512640 135304128 4293036128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21596/statm: 644 281 239 194 0 31 0
[pid=21609] ppid=21596 vsize=889296 CPUtime=1.46
/proc/21609/stat : 21609 (java) S 21596 21595 19908 34817 19908 4202496 20349 0 1 0 138 8 0 0 25 0 10 0 61621143 910639104 16727 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/21609/statm: 222324 16727 1721 10 0 219415 0
[pid=21609/tid=21610] ppid=21596 vsize=889296 CPUtime=0.8
/proc/21609/task/21610/stat : 21610 (java) R 21596 21595 19908 34817 19908 4202560 7775 0 1 0 78 2 0 0 25 0 10 0 61621144 910639104 16727 1283457024 134512640 134550932 4292343376 18446744073709551615 4095420062 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=21609/tid=21611] ppid=21596 vsize=889296 CPUtime=0
/proc/21609/task/21611/stat : 21611 (java) S 21596 21595 19908 34817 19908 4202560 7 0 0 0 0 0 0 0 16 0 10 0 61621145 910639104 16727 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 0 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21612] ppid=21596 vsize=889296 CPUtime=0
/proc/21609/task/21612/stat : 21612 (java) S 21596 21595 19908 34817 19908 4202560 8 0 0 0 0 0 0 0 25 0 10 0 61621146 910639104 16727 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21613] ppid=21596 vsize=889296 CPUtime=0
/proc/21609/task/21613/stat : 21613 (java) S 21596 21595 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 10 0 61621146 910639104 16727 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21614] ppid=21596 vsize=889296 CPUtime=0
/proc/21609/task/21614/stat : 21614 (java) S 21596 21595 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 10 0 61621148 910639104 16727 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21615] ppid=21596 vsize=889296 CPUtime=0.31
/proc/21609/task/21615/stat : 21615 (java) R 21596 21595 19908 34817 19908 4202560 5463 0 0 0 28 3 0 0 18 0 10 0 61621148 910639104 16727 1283457024 134512640 134550932 4292343376 18446744073709551615 4149021729 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=21609/tid=21616] ppid=21596 vsize=889296 CPUtime=0.34
/proc/21609/task/21616/stat : 21616 (java) R 21596 21595 19908 34817 19908 4202560 6031 0 0 0 31 3 0 0 25 0 10 0 61621148 910639104 16727 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=21609/tid=21617] ppid=21596 vsize=889296 CPUtime=0
/proc/21609/task/21617/stat : 21617 (java) S 21596 21595 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 10 0 61621148 910639104 16727 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21618] ppid=21596 vsize=889296 CPUtime=0
/proc/21609/task/21618/stat : 21618 (java) S 21596 21595 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 10 0 61621148 910639104 16727 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 1.49
Current children cumulated vsize (KiB) 894436

[startup+3.10619 s]
/proc/loadavg: 1.29 1.06 1.02 2/48 21618
/proc/meminfo: memFree=510784/1048576 swapFree=0/0
[pid=21595] ppid=21594 vsize=2564 CPUtime=0
/proc/21595/stat : 21595 (p2cudf-user-1.1) S 21594 21595 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 18 0 1 0 61621140 2625536 270 1283457024 134512640 135304128 4293486752 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21595/statm: 641 270 230 194 0 28 0
[pid=21596] ppid=21595 vsize=2576 CPUtime=0.03
/proc/21596/stat : 21596 (p2cudf) S 21595 21595 19908 34817 19908 4202496 393 3014 0 1 1 0 2 0 25 0 1 0 61621140 2637824 281 1283457024 134512640 135304128 4293036128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21596/statm: 644 281 239 194 0 31 0
[pid=21609] ppid=21596 vsize=887676 CPUtime=3.06
/proc/21609/stat : 21609 (java) S 21596 21595 19908 34817 19908 4202496 74190 0 1 0 274 32 0 0 25 0 10 0 61621143 908980224 70422 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/21609/statm: 221919 70422 1742 10 0 219010 0
[pid=21609/tid=21610] ppid=21596 vsize=887676 CPUtime=1.8
/proc/21609/task/21610/stat : 21610 (java) R 21596 21595 19908 34817 19908 4202560 50035 0 1 0 158 22 0 0 25 0 10 0 61621144 908980224 70422 1283457024 134512640 134550932 4292343376 18446744073709551615 4095730813 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=21609/tid=21611] ppid=21596 vsize=887676 CPUtime=0.22
/proc/21609/task/21611/stat : 21611 (java) S 21596 21595 19908 34817 19908 4202560 11178 0 0 0 21 1 0 0 16 0 10 0 61621145 908980224 70422 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 0 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21612] ppid=21596 vsize=887676 CPUtime=0
/proc/21609/task/21612/stat : 21612 (java) S 21596 21595 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 10 0 61621146 908980224 70422 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21613] ppid=21596 vsize=887676 CPUtime=0
/proc/21609/task/21613/stat : 21613 (java) S 21596 21595 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 10 0 61621146 908980224 70422 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21614] ppid=21596 vsize=887676 CPUtime=0
/proc/21609/task/21614/stat : 21614 (java) S 21596 21595 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 10 0 61621148 908980224 70422 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21615] ppid=21596 vsize=887676 CPUtime=0.67
/proc/21609/task/21615/stat : 21615 (java) S 21596 21595 19908 34817 19908 4202560 5846 0 0 0 63 4 0 0 15 0 10 0 61621148 908980224 70422 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21616] ppid=21596 vsize=887676 CPUtime=0.34
/proc/21609/task/21616/stat : 21616 (java) S 21596 21595 19908 34817 19908 4202560 6055 0 0 0 31 3 0 0 25 0 10 0 61621148 908980224 70422 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21617] ppid=21596 vsize=887676 CPUtime=0
/proc/21609/task/21617/stat : 21617 (java) S 21596 21595 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 10 0 61621148 908980224 70422 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21618] ppid=21596 vsize=887676 CPUtime=0
/proc/21609/task/21618/stat : 21618 (java) S 21596 21595 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 10 0 61621148 908980224 70422 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 3.09
Current children cumulated vsize (KiB) 892816

[startup+6.3071 s]
/proc/loadavg: 1.29 1.06 1.02 4/49 21619
/proc/meminfo: memFree=322916/1048576 swapFree=0/0
[pid=21595] ppid=21594 vsize=2564 CPUtime=0
/proc/21595/stat : 21595 (p2cudf-user-1.1) S 21594 21595 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 18 0 1 0 61621140 2625536 270 1283457024 134512640 135304128 4293486752 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21595/statm: 641 270 230 194 0 28 0
[pid=21596] ppid=21595 vsize=2576 CPUtime=0.03
/proc/21596/stat : 21596 (p2cudf) S 21595 21595 19908 34817 19908 4202496 393 3014 0 1 1 0 2 0 25 0 1 0 61621140 2637824 281 1283457024 134512640 135304128 4293036128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21596/statm: 644 281 239 194 0 31 0
[pid=21609] ppid=21596 vsize=888380 CPUtime=6.26
/proc/21609/stat : 21609 (java) S 21596 21595 19908 34817 19908 4202496 89340 0 1 0 590 36 0 0 25 0 11 0 61621143 909701120 84170 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/21609/statm: 222095 84170 1781 10 0 219186 0
[pid=21609/tid=21610] ppid=21596 vsize=888380 CPUtime=2.94
/proc/21609/task/21610/stat : 21610 (java) R 21596 21595 19908 34817 19908 4202560 50277 0 1 0 271 23 0 0 25 0 11 0 61621144 909701120 84170 1283457024 134512640 134550932 4292343376 18446744073709551615 4151816660 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=21609/tid=21611] ppid=21596 vsize=888380 CPUtime=0.53
/proc/21609/task/21611/stat : 21611 (java) S 21596 21595 19908 34817 19908 4202560 24365 0 0 0 48 5 0 0 16 0 11 0 61621145 909701120 84170 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 0 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21612] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21612/stat : 21612 (java) S 21596 21595 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 61621146 909701120 84170 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21613] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21613/stat : 21613 (java) S 21596 21595 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 61621146 909701120 84170 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21614] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21614/stat : 21614 (java) S 21596 21595 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 61621148 909701120 84170 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21615] ppid=21596 vsize=888380 CPUtime=2.43
/proc/21609/task/21615/stat : 21615 (java) S 21596 21595 19908 34817 19908 4202560 7563 0 0 0 239 4 0 0 16 0 11 0 61621148 909701120 84170 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21616] ppid=21596 vsize=888380 CPUtime=0.34
/proc/21609/task/21616/stat : 21616 (java) S 21596 21595 19908 34817 19908 4202560 6055 0 0 0 31 3 0 0 25 0 11 0 61621148 909701120 84170 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21617] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21617/stat : 21617 (java) S 21596 21595 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 61621148 909701120 84170 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21618] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21618/stat : 21618 (java) S 21596 21595 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 61621148 909701120 84170 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21619] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21619/stat : 21619 (java) S 21596 21595 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 24 0 11 0 61621668 909701120 84170 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 6.29
Current children cumulated vsize (KiB) 893520

[startup+12.7088 s]
/proc/loadavg: 1.27 1.06 1.02 2/49 21619
/proc/meminfo: memFree=292288/1048576 swapFree=0/0
[pid=21595] ppid=21594 vsize=2564 CPUtime=0
/proc/21595/stat : 21595 (p2cudf-user-1.1) S 21594 21595 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 18 0 1 0 61621140 2625536 270 1283457024 134512640 135304128 4293486752 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21595/statm: 641 270 230 194 0 28 0
[pid=21596] ppid=21595 vsize=2576 CPUtime=0.03
/proc/21596/stat : 21596 (p2cudf) S 21595 21595 19908 34817 19908 4202496 393 3014 0 1 1 0 2 0 25 0 1 0 61621140 2637824 281 1283457024 134512640 135304128 4293036128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21596/statm: 644 281 239 194 0 31 0
[pid=21609] ppid=21596 vsize=888380 CPUtime=12.66
/proc/21609/stat : 21609 (java) S 21596 21595 19908 34817 19908 4202496 96889 0 1 0 1228 38 0 0 25 0 11 0 61621143 909701120 91719 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/21609/statm: 222095 91719 1786 10 0 219186 0
[pid=21609/tid=21610] ppid=21596 vsize=888380 CPUtime=8.59
/proc/21609/task/21610/stat : 21610 (java) R 21596 21595 19908 34817 19908 4202560 50279 0 1 0 836 23 0 0 25 0 11 0 61621144 909701120 91719 1283457024 134512640 134550932 4292343376 18446744073709551615 4096470172 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=21609/tid=21611] ppid=21596 vsize=888380 CPUtime=1.14
/proc/21609/task/21611/stat : 21611 (java) S 21596 21595 19908 34817 19908 4202560 31895 0 0 0 107 7 0 0 15 0 11 0 61621145 909701120 91719 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 0 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21612] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21612/stat : 21612 (java) S 21596 21595 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 61621146 909701120 91719 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21613] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21613/stat : 21613 (java) S 21596 21595 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 61621146 909701120 91719 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21614] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21614/stat : 21614 (java) S 21596 21595 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 61621148 909701120 91719 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21615] ppid=21596 vsize=888380 CPUtime=2.57
/proc/21609/task/21615/stat : 21615 (java) S 21596 21595 19908 34817 19908 4202560 7580 0 0 0 253 4 0 0 15 0 11 0 61621148 909701120 91719 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21616] ppid=21596 vsize=888380 CPUtime=0.34
/proc/21609/task/21616/stat : 21616 (java) S 21596 21595 19908 34817 19908 4202560 6055 0 0 0 31 3 0 0 25 0 11 0 61621148 909701120 91719 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21617] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21617/stat : 21617 (java) S 21596 21595 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 61621148 909701120 91719 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21618] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21618/stat : 21618 (java) S 21596 21595 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 61621148 909701120 91719 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21619] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21619/stat : 21619 (java) S 21596 21595 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 24 0 11 0 61621668 909701120 91719 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 12.69
Current children cumulated vsize (KiB) 893520

[startup+25.5119 s]
/proc/loadavg: 1.21 1.06 1.02 2/49 21619
/proc/meminfo: memFree=291172/1048576 swapFree=0/0
[pid=21595] ppid=21594 vsize=2564 CPUtime=0
/proc/21595/stat : 21595 (p2cudf-user-1.1) S 21594 21595 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 18 0 1 0 61621140 2625536 270 1283457024 134512640 135304128 4293486752 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21595/statm: 641 270 230 194 0 28 0
[pid=21596] ppid=21595 vsize=2576 CPUtime=0.03
/proc/21596/stat : 21596 (p2cudf) S 21595 21595 19908 34817 19908 4202496 393 3014 0 1 1 0 2 0 25 0 1 0 61621140 2637824 281 1283457024 134512640 135304128 4293036128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21596/statm: 644 281 239 194 0 31 0
[pid=21609] ppid=21596 vsize=888380 CPUtime=25.44
/proc/21609/stat : 21609 (java) S 21596 21595 19908 34817 19908 4202496 97149 0 1 0 2506 38 0 0 25 0 11 0 61621143 909701120 91979 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/21609/statm: 222095 91979 1786 10 0 219186 0
[pid=21609/tid=21610] ppid=21596 vsize=888380 CPUtime=20.41
/proc/21609/task/21610/stat : 21610 (java) R 21596 21595 19908 34817 19908 4202560 50279 0 1 0 2018 23 0 0 25 0 11 0 61621144 909701120 91979 1283457024 134512640 134550932 4292343376 18446744073709551615 4096374192 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=21609/tid=21611] ppid=21596 vsize=888380 CPUtime=2.05
/proc/21609/task/21611/stat : 21611 (java) S 21596 21595 19908 34817 19908 4202560 32146 0 0 0 198 7 0 0 15 0 11 0 61621145 909701120 91979 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 0 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21612] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21612/stat : 21612 (java) S 21596 21595 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 61621146 909701120 91979 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21613] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21613/stat : 21613 (java) S 21596 21595 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 61621146 909701120 91979 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21614] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21614/stat : 21614 (java) S 21596 21595 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 61621148 909701120 91979 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21615] ppid=21596 vsize=888380 CPUtime=2.62
/proc/21609/task/21615/stat : 21615 (java) S 21596 21595 19908 34817 19908 4202560 7589 0 0 0 258 4 0 0 16 0 11 0 61621148 909701120 91979 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21616] ppid=21596 vsize=888380 CPUtime=0.34
/proc/21609/task/21616/stat : 21616 (java) S 21596 21595 19908 34817 19908 4202560 6055 0 0 0 31 3 0 0 25 0 11 0 61621148 909701120 91979 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21617] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21617/stat : 21617 (java) S 21596 21595 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 61621148 909701120 91979 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21618] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21618/stat : 21618 (java) R 21596 21595 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 61621148 909701120 91979 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=21609/tid=21619] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21619/stat : 21619 (java) S 21596 21595 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 24 0 11 0 61621668 909701120 91979 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 25.47
Current children cumulated vsize (KiB) 893520

[startup+51.1076 s]
/proc/loadavg: 1.14 1.05 1.02 2/49 21619
/proc/meminfo: memFree=291048/1048576 swapFree=0/0
[pid=21595] ppid=21594 vsize=2564 CPUtime=0
/proc/21595/stat : 21595 (p2cudf-user-1.1) S 21594 21595 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 18 0 1 0 61621140 2625536 270 1283457024 134512640 135304128 4293486752 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21595/statm: 641 270 230 194 0 28 0
[pid=21596] ppid=21595 vsize=2576 CPUtime=0.03
/proc/21596/stat : 21596 (p2cudf) S 21595 21595 19908 34817 19908 4202496 393 3014 0 1 1 0 2 0 25 0 1 0 61621140 2637824 281 1283457024 134512640 135304128 4293036128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21596/statm: 644 281 239 194 0 31 0
[pid=21609] ppid=21596 vsize=888380 CPUtime=51.02
/proc/21609/stat : 21609 (java) S 21596 21595 19908 34817 19908 4202496 97149 0 1 0 5064 38 0 0 25 0 11 0 61621143 909701120 91979 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/21609/statm: 222095 91979 1786 10 0 219186 0
[pid=21609/tid=21610] ppid=21596 vsize=888380 CPUtime=44.86
/proc/21609/task/21610/stat : 21610 (java) R 21596 21595 19908 34817 19908 4202560 50279 0 1 0 4463 23 0 0 25 0 11 0 61621144 909701120 91979 1283457024 134512640 134550932 4292343376 18446744073709551615 4096374729 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=21609/tid=21611] ppid=21596 vsize=888380 CPUtime=3.17
/proc/21609/task/21611/stat : 21611 (java) S 21596 21595 19908 34817 19908 4202560 32146 0 0 0 310 7 0 0 15 0 11 0 61621145 909701120 91979 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 0 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21612] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21612/stat : 21612 (java) S 21596 21595 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 61621146 909701120 91979 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21613] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21613/stat : 21613 (java) S 21596 21595 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 61621146 909701120 91979 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21614] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21614/stat : 21614 (java) S 21596 21595 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 61621148 909701120 91979 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21615] ppid=21596 vsize=888380 CPUtime=2.63
/proc/21609/task/21615/stat : 21615 (java) S 21596 21595 19908 34817 19908 4202560 7589 0 0 0 259 4 0 0 15 0 11 0 61621148 909701120 91979 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21616] ppid=21596 vsize=888380 CPUtime=0.34
/proc/21609/task/21616/stat : 21616 (java) S 21596 21595 19908 34817 19908 4202560 6055 0 0 0 31 3 0 0 25 0 11 0 61621148 909701120 91979 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21617] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21617/stat : 21617 (java) S 21596 21595 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 61621148 909701120 91979 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21618] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21618/stat : 21618 (java) S 21596 21595 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 61621148 909701120 91979 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21619] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21619/stat : 21619 (java) S 21596 21595 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 24 0 11 0 61621668 909701120 91979 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 51.05
Current children cumulated vsize (KiB) 893520

[startup+102.31 s]
/proc/loadavg: 1.06 1.04 1.01 2/51 21624
/proc/meminfo: memFree=286436/1048576 swapFree=0/0
[pid=21595] ppid=21594 vsize=2564 CPUtime=0
/proc/21595/stat : 21595 (p2cudf-user-1.1) S 21594 21595 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 18 0 1 0 61621140 2625536 270 1283457024 134512640 135304128 4293486752 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21595/statm: 641 270 230 194 0 28 0
[pid=21596] ppid=21595 vsize=2576 CPUtime=0.03
/proc/21596/stat : 21596 (p2cudf) S 21595 21595 19908 34817 19908 4202496 393 3014 0 1 1 0 2 0 25 0 1 0 61621140 2637824 281 1283457024 134512640 135304128 4293036128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21596/statm: 644 281 239 194 0 31 0
[pid=21609] ppid=21596 vsize=888380 CPUtime=102.17
/proc/21609/stat : 21609 (java) S 21596 21595 19908 34817 19908 4202496 98210 0 1 0 10179 38 0 0 25 0 11 0 61621143 909701120 93040 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/21609/statm: 222095 93040 1786 10 0 219186 0
[pid=21609/tid=21610] ppid=21596 vsize=888380 CPUtime=94
/proc/21609/task/21610/stat : 21610 (java) R 21596 21595 19908 34817 19908 4202560 50279 0 1 0 9377 23 0 0 25 0 11 0 61621144 909701120 93040 1283457024 134512640 134550932 4292343376 18446744073709551615 4096470143 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=21609/tid=21611] ppid=21596 vsize=888380 CPUtime=5.18
/proc/21609/task/21611/stat : 21611 (java) S 21596 21595 19908 34817 19908 4202560 33207 0 0 0 511 7 0 0 15 0 11 0 61621145 909701120 93040 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 0 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21612] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21612/stat : 21612 (java) S 21596 21595 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 61621146 909701120 93040 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21613] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21613/stat : 21613 (java) S 21596 21595 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 61621146 909701120 93040 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21614] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21614/stat : 21614 (java) S 21596 21595 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 61621148 909701120 93040 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21615] ppid=21596 vsize=888380 CPUtime=2.63
/proc/21609/task/21615/stat : 21615 (java) S 21596 21595 19908 34817 19908 4202560 7589 0 0 0 259 4 0 0 15 0 11 0 61621148 909701120 93040 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21616] ppid=21596 vsize=888380 CPUtime=0.34
/proc/21609/task/21616/stat : 21616 (java) S 21596 21595 19908 34817 19908 4202560 6055 0 0 0 31 3 0 0 25 0 11 0 61621148 909701120 93040 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21617] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21617/stat : 21617 (java) S 21596 21595 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 61621148 909701120 93040 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21618] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21618/stat : 21618 (java) S 21596 21595 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 61621148 909701120 93040 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21619] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21619/stat : 21619 (java) S 21596 21595 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 24 0 11 0 61621668 909701120 93040 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 102.2
Current children cumulated vsize (KiB) 893520

[startup+162.313 s]
/proc/loadavg: 1.18 1.08 1.02 2/51 21630
/proc/meminfo: memFree=282964/1048576 swapFree=0/0
[pid=21595] ppid=21594 vsize=2564 CPUtime=0
/proc/21595/stat : 21595 (p2cudf-user-1.1) S 21594 21595 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 18 0 1 0 61621140 2625536 270 1283457024 134512640 135304128 4293486752 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21595/statm: 641 270 230 194 0 28 0
[pid=21596] ppid=21595 vsize=2576 CPUtime=0.03
/proc/21596/stat : 21596 (p2cudf) S 21595 21595 19908 34817 19908 4202496 393 3014 0 1 1 0 2 0 25 0 1 0 61621140 2637824 281 1283457024 134512640 135304128 4293036128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21596/statm: 644 281 239 194 0 31 0
[pid=21609] ppid=21596 vsize=888380 CPUtime=162.13
/proc/21609/stat : 21609 (java) S 21596 21595 19908 34817 19908 4202496 99068 0 1 0 16174 39 0 0 25 0 11 0 61621143 909701120 93898 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/21609/statm: 222095 93898 1786 10 0 219186 0
[pid=21609/tid=21610] ppid=21596 vsize=888380 CPUtime=152.48
/proc/21609/task/21610/stat : 21610 (java) R 21596 21595 19908 34817 19908 4202560 50279 0 1 0 15224 24 0 0 25 0 11 0 61621144 909701120 93898 1283457024 134512640 134550932 4292343376 18446744073709551615 4096648376 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=21609/tid=21611] ppid=21596 vsize=888380 CPUtime=6.65
/proc/21609/task/21611/stat : 21611 (java) S 21596 21595 19908 34817 19908 4202560 34065 0 0 0 658 7 0 0 15 0 11 0 61621145 909701120 93898 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 0 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21612] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21612/stat : 21612 (java) S 21596 21595 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 61621146 909701120 93898 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21613] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21613/stat : 21613 (java) S 21596 21595 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 61621146 909701120 93898 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21614] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21614/stat : 21614 (java) S 21596 21595 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 61621148 909701120 93898 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21615] ppid=21596 vsize=888380 CPUtime=2.63
/proc/21609/task/21615/stat : 21615 (java) S 21596 21595 19908 34817 19908 4202560 7589 0 0 0 259 4 0 0 15 0 11 0 61621148 909701120 93898 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21616] ppid=21596 vsize=888380 CPUtime=0.34
/proc/21609/task/21616/stat : 21616 (java) S 21596 21595 19908 34817 19908 4202560 6055 0 0 0 31 3 0 0 25 0 11 0 61621148 909701120 93898 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21617] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21617/stat : 21617 (java) S 21596 21595 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 61621148 909701120 93898 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21618] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21618/stat : 21618 (java) S 21596 21595 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 61621148 909701120 93898 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21619] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21619/stat : 21619 (java) S 21596 21595 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 24 0 11 0 61621668 909701120 93898 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 162.16
Current children cumulated vsize (KiB) 893520

[startup+222.307 s]
/proc/loadavg: 1.06 1.06 1.02 2/50 21633
/proc/meminfo: memFree=271324/1048576 swapFree=0/0
[pid=21595] ppid=21594 vsize=2564 CPUtime=0
/proc/21595/stat : 21595 (p2cudf-user-1.1) S 21594 21595 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 18 0 1 0 61621140 2625536 270 1283457024 134512640 135304128 4293486752 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21595/statm: 641 270 230 194 0 28 0
[pid=21596] ppid=21595 vsize=2576 CPUtime=0.03
/proc/21596/stat : 21596 (p2cudf) S 21595 21595 19908 34817 19908 4202496 393 3014 0 1 1 0 2 0 25 0 1 0 61621140 2637824 281 1283457024 134512640 135304128 4293036128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21596/statm: 644 281 239 194 0 31 0
[pid=21609] ppid=21596 vsize=888380 CPUtime=222.06
/proc/21609/stat : 21609 (java) S 21596 21595 19908 34817 19908 4202496 101999 0 1 0 22165 41 0 0 25 0 11 0 61621143 909701120 96829 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/21609/statm: 222095 96829 1786 10 0 219186 0
[pid=21609/tid=21610] ppid=21596 vsize=888380 CPUtime=210.93
/proc/21609/task/21610/stat : 21610 (java) R 21596 21595 19908 34817 19908 4202560 50279 0 1 0 21069 24 0 0 25 0 11 0 61621144 909701120 96829 1283457024 134512640 134550932 4292343376 18446744073709551615 4096397565 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=21609/tid=21611] ppid=21596 vsize=888380 CPUtime=8.14
/proc/21609/task/21611/stat : 21611 (java) S 21596 21595 19908 34817 19908 4202560 36996 0 0 0 805 9 0 0 15 0 11 0 61621145 909701120 96829 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 0 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21612] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21612/stat : 21612 (java) S 21596 21595 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 61621146 909701120 96829 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21613] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21613/stat : 21613 (java) S 21596 21595 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 61621146 909701120 96829 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21614] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21614/stat : 21614 (java) S 21596 21595 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 61621148 909701120 96829 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21615] ppid=21596 vsize=888380 CPUtime=2.63
/proc/21609/task/21615/stat : 21615 (java) S 21596 21595 19908 34817 19908 4202560 7589 0 0 0 259 4 0 0 15 0 11 0 61621148 909701120 96829 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21616] ppid=21596 vsize=888380 CPUtime=0.34
/proc/21609/task/21616/stat : 21616 (java) S 21596 21595 19908 34817 19908 4202560 6055 0 0 0 31 3 0 0 25 0 11 0 61621148 909701120 96829 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21617] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21617/stat : 21617 (java) S 21596 21595 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 61621148 909701120 96829 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21618] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21618/stat : 21618 (java) S 21596 21595 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 61621148 909701120 96829 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21619] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21619/stat : 21619 (java) S 21596 21595 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 24 0 11 0 61621668 909701120 96829 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 222.09
Current children cumulated vsize (KiB) 893520

[startup+282.305 s]
/proc/loadavg: 1.02 1.05 1.01 2/49 21633
/proc/meminfo: memFree=269100/1048576 swapFree=0/0
[pid=21595] ppid=21594 vsize=2564 CPUtime=0
/proc/21595/stat : 21595 (p2cudf-user-1.1) S 21594 21595 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 18 0 1 0 61621140 2625536 270 1283457024 134512640 135304128 4293486752 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21595/statm: 641 270 230 194 0 28 0
[pid=21596] ppid=21595 vsize=2576 CPUtime=0.03
/proc/21596/stat : 21596 (p2cudf) S 21595 21595 19908 34817 19908 4202496 393 3014 0 1 1 0 2 0 25 0 1 0 61621140 2637824 281 1283457024 134512640 135304128 4293036128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21596/statm: 644 281 239 194 0 31 0
[pid=21609] ppid=21596 vsize=888380 CPUtime=282
/proc/21609/stat : 21609 (java) S 21596 21595 19908 34817 19908 4202496 102552 0 1 0 28159 41 0 0 25 0 11 0 61621143 909701120 97382 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/21609/statm: 222095 97382 1786 10 0 219186 0
[pid=21609/tid=21610] ppid=21596 vsize=888380 CPUtime=269.66
/proc/21609/task/21610/stat : 21610 (java) R 21596 21595 19908 34817 19908 4202560 50279 0 1 0 26942 24 0 0 25 0 11 0 61621144 909701120 97382 1283457024 134512640 134550932 4292343376 18446744073709551615 4095551781 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=21609/tid=21611] ppid=21596 vsize=888380 CPUtime=9.35
/proc/21609/task/21611/stat : 21611 (java) S 21596 21595 19908 34817 19908 4202560 37549 0 0 0 926 9 0 0 15 0 11 0 61621145 909701120 97382 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 0 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21612] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21612/stat : 21612 (java) S 21596 21595 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 61621146 909701120 97382 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21613] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21613/stat : 21613 (java) S 21596 21595 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 61621146 909701120 97382 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21614] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21614/stat : 21614 (java) S 21596 21595 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 61621148 909701120 97382 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21615] ppid=21596 vsize=888380 CPUtime=2.63
/proc/21609/task/21615/stat : 21615 (java) S 21596 21595 19908 34817 19908 4202560 7589 0 0 0 259 4 0 0 15 0 11 0 61621148 909701120 97382 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21616] ppid=21596 vsize=888380 CPUtime=0.34
/proc/21609/task/21616/stat : 21616 (java) S 21596 21595 19908 34817 19908 4202560 6055 0 0 0 31 3 0 0 25 0 11 0 61621148 909701120 97382 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21617] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21617/stat : 21617 (java) S 21596 21595 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 61621148 909701120 97382 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21618] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21618/stat : 21618 (java) S 21596 21595 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 61621148 909701120 97382 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21619] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21619/stat : 21619 (java) S 21596 21595 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 24 0 11 0 61621668 909701120 97382 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 282.03
Current children cumulated vsize (KiB) 893520

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

[startup+283.005 s]
/proc/loadavg: 1.02 1.05 1.01 2/49 21633
/proc/meminfo: memFree=269100/1048576 swapFree=0/0
[pid=21595] ppid=21594 vsize=2564 CPUtime=0
/proc/21595/stat : 21595 (p2cudf-user-1.1) S 21594 21595 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 18 0 1 0 61621140 2625536 270 1283457024 134512640 135304128 4293486752 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21595/statm: 641 270 230 194 0 28 0
[pid=21596] ppid=21595 vsize=2576 CPUtime=0.03
/proc/21596/stat : 21596 (p2cudf) S 21595 21595 19908 34817 19908 4202496 393 3014 0 1 1 0 2 0 25 0 1 0 61621140 2637824 281 1283457024 134512640 135304128 4293036128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21596/statm: 644 281 239 194 0 31 0
[pid=21609] ppid=21596 vsize=888380 CPUtime=282.7
/proc/21609/stat : 21609 (java) S 21596 21595 19908 34817 19908 4202496 102552 0 1 0 28229 41 0 0 25 0 11 0 61621143 909701120 97382 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/21609/statm: 222095 97382 1786 10 0 219186 0
[pid=21609/tid=21610] ppid=21596 vsize=888380 CPUtime=270.36
/proc/21609/task/21610/stat : 21610 (java) R 21596 21595 19908 34817 19908 4202560 50279 0 1 0 27012 24 0 0 25 0 11 0 61621144 909701120 97382 1283457024 134512640 134550932 4292343376 18446744073709551615 4096556850 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=21609/tid=21611] ppid=21596 vsize=888380 CPUtime=9.35
/proc/21609/task/21611/stat : 21611 (java) S 21596 21595 19908 34817 19908 4202560 37549 0 0 0 926 9 0 0 15 0 11 0 61621145 909701120 97382 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 0 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21612] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21612/stat : 21612 (java) S 21596 21595 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 61621146 909701120 97382 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21613] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21613/stat : 21613 (java) S 21596 21595 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 61621146 909701120 97382 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21614] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21614/stat : 21614 (java) S 21596 21595 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 61621148 909701120 97382 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21615] ppid=21596 vsize=888380 CPUtime=2.63
/proc/21609/task/21615/stat : 21615 (java) S 21596 21595 19908 34817 19908 4202560 7589 0 0 0 259 4 0 0 15 0 11 0 61621148 909701120 97382 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21616] ppid=21596 vsize=888380 CPUtime=0.34
/proc/21609/task/21616/stat : 21616 (java) S 21596 21595 19908 34817 19908 4202560 6055 0 0 0 31 3 0 0 25 0 11 0 61621148 909701120 97382 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21617] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21617/stat : 21617 (java) S 21596 21595 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 61621148 909701120 97382 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21618] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21618/stat : 21618 (java) S 21596 21595 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 61621148 909701120 97382 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21619] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21619/stat : 21619 (java) S 21596 21595 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 24 0 11 0 61621668 909701120 97382 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 282.73
Current children cumulated vsize (KiB) 893520

[startup+284.605 s]
/proc/loadavg: 1.02 1.05 1.01 2/49 21633
/proc/meminfo: memFree=269100/1048576 swapFree=0/0
[pid=21595] ppid=21594 vsize=2564 CPUtime=0
/proc/21595/stat : 21595 (p2cudf-user-1.1) S 21594 21595 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 18 0 1 0 61621140 2625536 270 1283457024 134512640 135304128 4293486752 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21595/statm: 641 270 230 194 0 28 0
[pid=21596] ppid=21595 vsize=2576 CPUtime=0.03
/proc/21596/stat : 21596 (p2cudf) S 21595 21595 19908 34817 19908 4202496 393 3014 0 1 1 0 2 0 25 0 1 0 61621140 2637824 281 1283457024 134512640 135304128 4293036128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21596/statm: 644 281 239 194 0 31 0
[pid=21609] ppid=21596 vsize=888380 CPUtime=284.29
/proc/21609/stat : 21609 (java) S 21596 21595 19908 34817 19908 4202496 102552 0 1 0 28388 41 0 0 25 0 11 0 61621143 909701120 97382 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/21609/statm: 222095 97382 1786 10 0 219186 0
[pid=21609/tid=21610] ppid=21596 vsize=888380 CPUtime=271.95
/proc/21609/task/21610/stat : 21610 (java) R 21596 21595 19908 34817 19908 4202560 50279 0 1 0 27171 24 0 0 25 0 11 0 61621144 909701120 97382 1283457024 134512640 134550932 4292343376 18446744073709551615 4096470159 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=21609/tid=21611] ppid=21596 vsize=888380 CPUtime=9.35
/proc/21609/task/21611/stat : 21611 (java) S 21596 21595 19908 34817 19908 4202560 37549 0 0 0 926 9 0 0 15 0 11 0 61621145 909701120 97382 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 0 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21612] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21612/stat : 21612 (java) S 21596 21595 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 61621146 909701120 97382 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21613] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21613/stat : 21613 (java) S 21596 21595 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 61621146 909701120 97382 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21614] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21614/stat : 21614 (java) S 21596 21595 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 61621148 909701120 97382 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21615] ppid=21596 vsize=888380 CPUtime=2.63
/proc/21609/task/21615/stat : 21615 (java) S 21596 21595 19908 34817 19908 4202560 7589 0 0 0 259 4 0 0 15 0 11 0 61621148 909701120 97382 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21616] ppid=21596 vsize=888380 CPUtime=0.34
/proc/21609/task/21616/stat : 21616 (java) S 21596 21595 19908 34817 19908 4202560 6055 0 0 0 31 3 0 0 25 0 11 0 61621148 909701120 97382 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21617] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21617/stat : 21617 (java) S 21596 21595 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 61621148 909701120 97382 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21618] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21618/stat : 21618 (java) S 21596 21595 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 61621148 909701120 97382 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21619] ppid=21596 vsize=888380 CPUtime=0
/proc/21609/task/21619/stat : 21619 (java) S 21596 21595 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 24 0 11 0 61621668 909701120 97382 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 284.32
Current children cumulated vsize (KiB) 893520

[startup+285.403 s]
/proc/loadavg: 1.02 1.05 1.01 2/49 21633
/proc/meminfo: memFree=269100/1048576 swapFree=0/0
[pid=21595] ppid=21594 vsize=2564 CPUtime=0
/proc/21595/stat : 21595 (p2cudf-user-1.1) S 21594 21595 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 18 0 1 0 61621140 2625536 270 1283457024 134512640 135304128 4293486752 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21595/statm: 641 270 230 194 0 28 0
[pid=21596] ppid=21595 vsize=2576 CPUtime=0.03
/proc/21596/stat : 21596 (p2cudf) S 21595 21595 19908 34817 19908 4202496 393 3014 0 1 1 0 2 0 25 0 1 0 61621140 2637824 281 1283457024 134512640 135304128 4293036128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21596/statm: 644 281 239 194 0 31 0
[pid=21609] ppid=21596 vsize=888704 CPUtime=285.03
/proc/21609/stat : 21609 (java) S 21596 21595 19908 34817 19908 4202496 102564 0 1 0 28462 41 0 0 25 0 11 0 61621143 910032896 97394 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/21609/statm: 222176 97394 1787 10 0 219267 0
[pid=21609/tid=21610] ppid=21596 vsize=888704 CPUtime=272.64
/proc/21609/task/21610/stat : 21610 (java) S 21596 21595 19908 34817 19908 4202560 50286 0 1 0 27240 24 0 0 25 0 11 0 61621144 910032896 97394 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21611] ppid=21596 vsize=888704 CPUtime=9.35
/proc/21609/task/21611/stat : 21611 (java) S 21596 21595 19908 34817 19908 4202560 37549 0 0 0 926 9 0 0 16 0 11 0 61621145 910032896 97394 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 0 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21612] ppid=21596 vsize=888704 CPUtime=0
/proc/21609/task/21612/stat : 21612 (java) S 21596 21595 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 61621146 910032896 97394 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21613] ppid=21596 vsize=888704 CPUtime=0
/proc/21609/task/21613/stat : 21613 (java) S 21596 21595 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 61621146 910032896 97394 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21614] ppid=21596 vsize=888704 CPUtime=0
/proc/21609/task/21614/stat : 21614 (java) S 21596 21595 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 61621148 910032896 97394 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21615] ppid=21596 vsize=888704 CPUtime=2.67
/proc/21609/task/21615/stat : 21615 (java) S 21596 21595 19908 34817 19908 4202560 7589 0 0 0 263 4 0 0 15 0 11 0 61621148 910032896 97394 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21616] ppid=21596 vsize=888704 CPUtime=0.34
/proc/21609/task/21616/stat : 21616 (java) S 21596 21595 19908 34817 19908 4202560 6055 0 0 0 31 3 0 0 25 0 11 0 61621148 910032896 97394 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21617] ppid=21596 vsize=888704 CPUtime=0
/proc/21609/task/21617/stat : 21617 (java) S 21596 21595 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 61621148 910032896 97394 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21618] ppid=21596 vsize=888704 CPUtime=0
/proc/21609/task/21618/stat : 21618 (java) S 21596 21595 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 61621148 910032896 97394 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 285.06
Current children cumulated vsize (KiB) 893844

[startup+285.807 s]
/proc/loadavg: 1.02 1.05 1.01 2/49 21634
/proc/meminfo: memFree=268976/1048576 swapFree=0/0
[pid=21595] ppid=21594 vsize=2564 CPUtime=0
/proc/21595/stat : 21595 (p2cudf-user-1.1) S 21594 21595 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 18 0 1 0 61621140 2625536 270 1283457024 134512640 135304128 4293486752 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21595/statm: 641 270 230 194 0 28 0
[pid=21596] ppid=21595 vsize=2576 CPUtime=0.03
/proc/21596/stat : 21596 (p2cudf) S 21595 21595 19908 34817 19908 4202496 393 3014 0 1 1 0 2 0 25 0 1 0 61621140 2637824 281 1283457024 134512640 135304128 4293036128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21596/statm: 644 281 239 194 0 31 0
[pid=21609] ppid=21596 vsize=888704 CPUtime=285.03
/proc/21609/stat : 21609 (java) S 21596 21595 19908 34817 19908 4202496 102564 0 1 0 28462 41 0 0 25 0 11 0 61621143 910032896 97394 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/21609/statm: 222176 97394 1787 10 0 219267 0
[pid=21609/tid=21610] ppid=21596 vsize=888704 CPUtime=272.64
/proc/21609/task/21610/stat : 21610 (java) S 21596 21595 19908 34817 19908 4202560 50286 0 1 0 27240 24 0 0 25 0 11 0 61621144 910032896 97394 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21611] ppid=21596 vsize=888704 CPUtime=9.35
/proc/21609/task/21611/stat : 21611 (java) S 21596 21595 19908 34817 19908 4202560 37549 0 0 0 926 9 0 0 16 0 11 0 61621145 910032896 97394 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 0 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21612] ppid=21596 vsize=888704 CPUtime=0
/proc/21609/task/21612/stat : 21612 (java) S 21596 21595 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 61621146 910032896 97394 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21613] ppid=21596 vsize=888704 CPUtime=0
/proc/21609/task/21613/stat : 21613 (java) S 21596 21595 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 61621146 910032896 97394 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21614] ppid=21596 vsize=888704 CPUtime=0
/proc/21609/task/21614/stat : 21614 (java) S 21596 21595 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 61621148 910032896 97394 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21615] ppid=21596 vsize=888704 CPUtime=2.67
/proc/21609/task/21615/stat : 21615 (java) S 21596 21595 19908 34817 19908 4202560 7589 0 0 0 263 4 0 0 15 0 11 0 61621148 910032896 97394 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21616] ppid=21596 vsize=888704 CPUtime=0.34
/proc/21609/task/21616/stat : 21616 (java) S 21596 21595 19908 34817 19908 4202560 6055 0 0 0 31 3 0 0 25 0 11 0 61621148 910032896 97394 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21617] ppid=21596 vsize=888704 CPUtime=0
/proc/21609/task/21617/stat : 21617 (java) S 21596 21595 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 61621148 910032896 97394 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21618] ppid=21596 vsize=888704 CPUtime=0
/proc/21609/task/21618/stat : 21618 (java) R 21596 21595 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 61621148 910032896 97394 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=21609/tid=21634] ppid=21596 vsize=888704 CPUtime=0
/proc/21609/task/21634/stat : 21634 (java) S 21596 21595 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 11 0 61649674 910032896 97394 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 285.06
Current children cumulated vsize (KiB) 893844

[startup+285.907 s]
/proc/loadavg: 1.02 1.05 1.01 2/49 21634
/proc/meminfo: memFree=268976/1048576 swapFree=0/0
[pid=21595] ppid=21594 vsize=2564 CPUtime=0
/proc/21595/stat : 21595 (p2cudf-user-1.1) S 21594 21595 19908 34817 19908 4202496 375 0 0 0 0 0 0 0 18 0 1 0 61621140 2625536 270 1283457024 134512640 135304128 4293486752 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21595/statm: 641 270 230 194 0 28 0
[pid=21596] ppid=21595 vsize=2576 CPUtime=0.03
/proc/21596/stat : 21596 (p2cudf) S 21595 21595 19908 34817 19908 4202496 393 3014 0 1 1 0 2 0 25 0 1 0 61621140 2637824 281 1283457024 134512640 135304128 4293036128 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/21596/statm: 644 281 239 194 0 31 0
[pid=21609] ppid=21596 vsize=888704 CPUtime=285.06
/proc/21609/stat : 21609 (java) S 21596 21595 19908 34817 19908 4202496 102564 0 1 0 28465 41 0 0 25 0 10 0 61621143 910032896 97394 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/21609/statm: 222176 97394 1787 10 0 219267 0
[pid=21609/tid=21610] ppid=21596 vsize=888704 CPUtime=272.64
/proc/21609/task/21610/stat : 21610 (java) S 21596 21595 19908 34817 19908 4202560 50286 0 1 0 27240 24 0 0 20 0 10 0 61621144 910032896 97394 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21611] ppid=21596 vsize=888704 CPUtime=9.35
/proc/21609/task/21611/stat : 21611 (java) S 21596 21595 19908 34817 19908 4202560 37549 0 0 0 926 9 0 0 16 0 10 0 61621145 910032896 97394 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 0 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21612] ppid=21596 vsize=888704 CPUtime=0
/proc/21609/task/21612/stat : 21612 (java) S 21596 21595 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 10 0 61621146 910032896 97394 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21613] ppid=21596 vsize=888704 CPUtime=0
/proc/21609/task/21613/stat : 21613 (java) S 21596 21595 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 10 0 61621146 910032896 97394 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21614] ppid=21596 vsize=888704 CPUtime=0
/proc/21609/task/21614/stat : 21614 (java) S 21596 21595 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 10 0 61621148 910032896 97394 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21615] ppid=21596 vsize=888704 CPUtime=2.69
/proc/21609/task/21615/stat : 21615 (java) S 21596 21595 19908 34817 19908 4202560 7589 0 0 0 265 4 0 0 15 0 10 0 61621148 910032896 97394 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21616] ppid=21596 vsize=888704 CPUtime=0.34
/proc/21609/task/21616/stat : 21616 (java) S 21596 21595 19908 34817 19908 4202560 6055 0 0 0 31 3 0 0 25 0 10 0 61621148 910032896 97394 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21617] ppid=21596 vsize=888704 CPUtime=0
/proc/21609/task/21617/stat : 21617 (java) S 21596 21595 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 10 0 61621148 910032896 97394 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
[pid=21609/tid=21618] ppid=21596 vsize=888704 CPUtime=0
/proc/21609/task/21618/stat : 21618 (java) S 21596 21595 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 10 0 61621148 910032896 97394 1283457024 134512640 134550932 4292343376 18446744073709551615 4294960130 0 4 0 16800975 18446612132465455552 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 285.09
Current children cumulated vsize (KiB) 893844

Child status: 0
Real time (s): 285.946
CPU time (s): 285.122
CPU user time (s): 284.686
CPU system time (s): 0.436027
CPU usage (%): 99.7117
Max. virtual memory (cumulated for all children) (KiB): 896452

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 284.686
system time used= 0.436027
maximum resident set size= 0
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 106371
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= 5939
involuntary context switches= 8903

runsolver used 0 second user time and 0.008 second system time

The end