runsolver Copyright (C) 2010 Olivier ROUSSEL

This is runsolver version 3.2.9a (svn: 651)

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

command line: /home/misc2010/bin/runsolver -s SIGUSR1 -M 1124 -C 290 -d 10 -w /home/misc2010/tmp/201108300820/p2cudf-user-1.13/rand66.cudf.dudf-random.log.runsolver ./p2cudf-user-1.13 /home/misc2010/data/2011/dudf-random//rand66.cudf /home/misc2010/tmp/201108300820/p2cudf-user-1.13/rand66.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: 0.85 0.97 0.99 2/38 8524
/proc/meminfo: memFree=939100/1048576 swapFree=0/0
[pid=8524] ppid=8523 vsize=3020 CPUtime=0
/proc/8524/stat : 8524 (runsolver) D 8523 8524 2160 34817 2160 4202560 72 0 0 0 0 0 0 0 25 0 1 0 54209321 3092480 94 1283457024 134512640 134586868 4293505008 18446744073709551615 4294960130 0 0 0 24578 18446744071564332000 0 0 17 0 0 0 0
/proc/8524/statm: 755 94 62 19 0 54 0

[startup+0.14222 s]
/proc/loadavg: 0.85 0.97 0.99 2/38 8524
/proc/meminfo: memFree=939100/1048576 swapFree=0/0
[pid=8524] ppid=8523 vsize=2568 CPUtime=0
/proc/8524/stat : 8524 (p2cudf-user-1.1) S 8523 8524 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 54209321 2629632 269 1283457024 134512640 135304128 4291591888 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/8524/statm: 642 269 230 194 0 29 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 2568

[startup+0.206235 s]
/proc/loadavg: 0.85 0.97 0.99 2/38 8524
/proc/meminfo: memFree=939100/1048576 swapFree=0/0
[pid=8524] ppid=8523 vsize=2568 CPUtime=0
/proc/8524/stat : 8524 (p2cudf-user-1.1) S 8523 8524 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 54209321 2629632 269 1283457024 134512640 135304128 4291591888 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/8524/statm: 642 269 230 194 0 29 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 2568

[startup+0.306229 s]
/proc/loadavg: 0.85 0.97 0.99 2/38 8524
/proc/meminfo: memFree=939100/1048576 swapFree=0/0
[pid=8524] ppid=8523 vsize=2568 CPUtime=0
/proc/8524/stat : 8524 (p2cudf-user-1.1) S 8523 8524 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 54209321 2629632 269 1283457024 134512640 135304128 4291591888 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/8524/statm: 642 269 230 194 0 29 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 2568

[startup+0.706252 s]
/proc/loadavg: 0.85 0.97 0.99 2/38 8524
/proc/meminfo: memFree=939100/1048576 swapFree=0/0
[pid=8524] ppid=8523 vsize=2568 CPUtime=0
/proc/8524/stat : 8524 (p2cudf-user-1.1) S 8523 8524 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 54209321 2629632 269 1283457024 134512640 135304128 4291591888 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/8524/statm: 642 269 230 194 0 29 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 2568

[startup+1.51503 s]
/proc/loadavg: 0.94 0.98 0.99 5/50 8547
/proc/meminfo: memFree=903596/1048576 swapFree=0/0
[pid=8524] ppid=8523 vsize=2568 CPUtime=0
/proc/8524/stat : 8524 (p2cudf-user-1.1) S 8523 8524 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 54209321 2629632 269 1283457024 134512640 135304128 4291591888 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/8524/statm: 642 269 230 194 0 29 0
[pid=8526] ppid=8524 vsize=2568 CPUtime=0.02
/proc/8526/stat : 8526 (p2cudf) S 8524 8524 2160 34817 2160 4202496 388 3013 0 1 0 0 2 0 25 0 1 0 54209322 2629632 279 1283457024 134512640 135304128 4291702544 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/8526/statm: 642 279 239 194 0 29 0
[pid=8538] ppid=8526 vsize=879228 CPUtime=0.86
/proc/8538/stat : 8538 (java) S 8526 8524 2160 34817 2160 4202496 14364 0 105 0 80 6 0 0 23 0 10 0 54209325 900329472 11372 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/8538/statm: 219807 11372 1732 10 0 216898 0
[pid=8538/tid=8539] ppid=8526 vsize=879228 CPUtime=0.19
/proc/8538/task/8539/stat : 8539 (java) R 8526 8524 2160 34817 2160 4202560 4291 0 15 0 18 1 0 0 25 0 10 0 54209351 900329472 11372 1283457024 134512640 134550932 4289125184 18446744073709551615 4095800106 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=8538/tid=8540] ppid=8526 vsize=879228 CPUtime=0
/proc/8538/task/8540/stat : 8540 (java) S 8526 8524 2160 34817 2160 4202560 7 0 0 0 0 0 0 0 18 0 10 0 54209361 900329472 11372 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 0 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8541] ppid=8526 vsize=879228 CPUtime=0
/proc/8538/task/8541/stat : 8541 (java) S 8526 8524 2160 34817 2160 4202560 7 0 1 0 0 0 0 0 25 0 10 0 54209361 900329472 11372 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8542] ppid=8526 vsize=879228 CPUtime=0
/proc/8538/task/8542/stat : 8542 (java) S 8526 8524 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 10 0 54209362 900329472 11372 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8543] ppid=8526 vsize=879228 CPUtime=0
/proc/8538/task/8543/stat : 8543 (java) S 8526 8524 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 10 0 54209371 900329472 11372 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8544] ppid=8526 vsize=879228 CPUtime=0.16
/proc/8538/task/8544/stat : 8544 (java) S 8526 8524 2160 34817 2160 4202560 770 0 0 0 16 0 0 0 21 0 10 0 54209371 900329472 11372 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8545] ppid=8526 vsize=879228 CPUtime=0.49
/proc/8538/task/8545/stat : 8545 (java) R 8526 8524 2160 34817 2160 4202560 8305 0 8 0 45 4 0 0 25 0 10 0 54209371 900329472 11372 1283457024 134512640 134550932 4289125184 18446744073709551615 4152809428 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=8538/tid=8546] ppid=8526 vsize=879228 CPUtime=0
/proc/8538/task/8546/stat : 8546 (java) S 8526 8524 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 10 0 54209371 900329472 11372 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8547] ppid=8526 vsize=879228 CPUtime=0
/proc/8538/task/8547/stat : 8547 (java) R 8526 8524 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 10 0 54209371 900329472 11372 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 0.88
Current children cumulated vsize (KiB) 884364

[startup+3.11042 s]
/proc/loadavg: 0.94 0.98 0.99 2/50 8547
/proc/meminfo: memFree=791996/1048576 swapFree=0/0
[pid=8524] ppid=8523 vsize=2568 CPUtime=0
/proc/8524/stat : 8524 (p2cudf-user-1.1) S 8523 8524 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 54209321 2629632 269 1283457024 134512640 135304128 4291591888 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/8524/statm: 642 269 230 194 0 29 0
[pid=8526] ppid=8524 vsize=2568 CPUtime=0.02
/proc/8526/stat : 8526 (p2cudf) S 8524 8524 2160 34817 2160 4202496 388 3013 0 1 0 0 2 0 25 0 1 0 54209322 2629632 279 1283457024 134512640 135304128 4291702544 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/8526/statm: 642 279 239 194 0 29 0
[pid=8538] ppid=8526 vsize=879228 CPUtime=2.35
/proc/8538/stat : 8538 (java) S 8526 8524 2160 34817 2160 4202496 51918 0 105 0 218 17 0 0 23 0 10 0 54209325 900329472 48789 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/8538/statm: 219807 48789 1754 10 0 216898 0
[pid=8538/tid=8539] ppid=8526 vsize=879228 CPUtime=1.08
/proc/8538/task/8539/stat : 8539 (java) R 8526 8524 2160 34817 2160 4202560 41581 0 15 0 96 12 0 0 25 0 10 0 54209351 900329472 48789 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=8538/tid=8540] ppid=8526 vsize=879228 CPUtime=0
/proc/8538/task/8540/stat : 8540 (java) S 8526 8524 2160 34817 2160 4202560 7 0 0 0 0 0 0 0 18 0 10 0 54209361 900329472 48789 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 0 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8541] ppid=8526 vsize=879228 CPUtime=0
/proc/8538/task/8541/stat : 8541 (java) S 8526 8524 2160 34817 2160 4202560 7 0 1 0 0 0 0 0 25 0 10 0 54209361 900329472 48789 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8542] ppid=8526 vsize=879228 CPUtime=0
/proc/8538/task/8542/stat : 8542 (java) S 8526 8524 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 10 0 54209362 900329472 48789 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8543] ppid=8526 vsize=879228 CPUtime=0
/proc/8538/task/8543/stat : 8543 (java) S 8526 8524 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 10 0 54209371 900329472 48789 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8544] ppid=8526 vsize=879228 CPUtime=0.35
/proc/8538/task/8544/stat : 8544 (java) S 8526 8524 2160 34817 2160 4202560 798 0 0 0 35 0 0 0 15 0 10 0 54209371 900329472 48789 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8545] ppid=8526 vsize=879228 CPUtime=0.9
/proc/8538/task/8545/stat : 8545 (java) R 8526 8524 2160 34817 2160 4202560 8541 0 8 0 86 4 0 0 19 0 10 0 54209371 900329472 48789 1283457024 134512640 134550932 4289125184 18446744073709551615 4150307684 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=8538/tid=8546] ppid=8526 vsize=879228 CPUtime=0
/proc/8538/task/8546/stat : 8546 (java) S 8526 8524 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 10 0 54209371 900329472 48789 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8547] ppid=8526 vsize=879228 CPUtime=0
/proc/8538/task/8547/stat : 8547 (java) S 8526 8524 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 10 0 54209371 900329472 48789 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 2.37
Current children cumulated vsize (KiB) 884364
heavy processes:

[startup+6.30946 s]
/proc/loadavg: 0.94 0.98 0.99 2/51 8548
/proc/meminfo: memFree=674956/1048576 swapFree=0/0
[pid=8524] ppid=8523 vsize=2568 CPUtime=0
/proc/8524/stat : 8524 (p2cudf-user-1.1) S 8523 8524 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 54209321 2629632 269 1283457024 134512640 135304128 4291591888 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/8524/statm: 642 269 230 194 0 29 0
[pid=8526] ppid=8524 vsize=2568 CPUtime=0.02
/proc/8526/stat : 8526 (p2cudf) S 8524 8524 2160 34817 2160 4202496 388 3013 0 1 0 0 2 0 25 0 1 0 54209322 2629632 279 1283457024 134512640 135304128 4291702544 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/8526/statm: 642 279 239 194 0 29 0
[pid=8538] ppid=8526 vsize=879552 CPUtime=5.38
/proc/8538/stat : 8538 (java) S 8526 8524 2160 34817 2160 4202496 68982 0 105 0 515 23 0 0 23 0 11 0 54209325 900661248 65297 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/8538/statm: 219888 65297 1781 10 0 216979 0
[pid=8538/tid=8539] ppid=8526 vsize=879552 CPUtime=2.77
/proc/8538/task/8539/stat : 8539 (java) R 8526 8524 2160 34817 2160 4202560 47570 0 15 0 262 15 0 0 25 0 11 0 54209351 900661248 65297 1283457024 134512640 134550932 4289125184 18446744073709551615 4096202648 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=8538/tid=8540] ppid=8526 vsize=879552 CPUtime=0.5
/proc/8538/task/8540/stat : 8540 (java) S 8526 8524 2160 34817 2160 4202560 10377 0 0 0 48 2 0 0 16 0 11 0 54209361 900661248 65297 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 0 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8541] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8541/stat : 8541 (java) S 8526 8524 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 54209361 900661248 65297 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8542] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8542/stat : 8542 (java) S 8526 8524 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 54209362 900661248 65297 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8543] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8543/stat : 8543 (java) S 8526 8524 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 54209371 900661248 65297 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8544] ppid=8526 vsize=879552 CPUtime=0.35
/proc/8538/task/8544/stat : 8544 (java) S 8526 8524 2160 34817 2160 4202560 798 0 0 0 35 0 0 0 15 0 11 0 54209371 900661248 65297 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8545] ppid=8526 vsize=879552 CPUtime=1.73
/proc/8538/task/8545/stat : 8545 (java) S 8526 8524 2160 34817 2160 4202560 9239 0 8 0 169 4 0 0 15 0 11 0 54209371 900661248 65297 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8546] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8546/stat : 8546 (java) S 8526 8524 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 54209371 900661248 65297 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8547] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8547/stat : 8547 (java) S 8526 8524 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 54209371 900661248 65297 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8548] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8548/stat : 8548 (java) S 8526 8524 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 54209703 900661248 65297 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 5.4
Current children cumulated vsize (KiB) 884688

[startup+12.7108 s]
/proc/loadavg: 0.95 0.98 0.99 2/51 8549
/proc/meminfo: memFree=670616/1048576 swapFree=0/0
[pid=8524] ppid=8523 vsize=2568 CPUtime=0
/proc/8524/stat : 8524 (p2cudf-user-1.1) S 8523 8524 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 54209321 2629632 269 1283457024 134512640 135304128 4291591888 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/8524/statm: 642 269 230 194 0 29 0
[pid=8526] ppid=8524 vsize=2568 CPUtime=0.02
/proc/8526/stat : 8526 (p2cudf) S 8524 8524 2160 34817 2160 4202496 388 3013 0 1 0 0 2 0 25 0 1 0 54209322 2629632 279 1283457024 134512640 135304128 4291702544 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/8526/statm: 642 279 239 194 0 29 0
[pid=8538] ppid=8526 vsize=879552 CPUtime=11.78
/proc/8538/stat : 8538 (java) S 8526 8524 2160 34817 2160 4202496 69762 0 105 0 1154 24 0 0 23 0 11 0 54209325 900661248 66077 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/8538/statm: 219888 66077 1783 10 0 216979 0
[pid=8538/tid=8539] ppid=8526 vsize=879552 CPUtime=8.41
/proc/8538/task/8539/stat : 8539 (java) R 8526 8524 2160 34817 2160 4202560 47570 0 15 0 826 15 0 0 25 0 11 0 54209351 900661248 66077 1283457024 134512640 134550932 4289125184 18446744073709551615 4096222732 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=8538/tid=8540] ppid=8526 vsize=879552 CPUtime=1.15
/proc/8538/task/8540/stat : 8540 (java) S 8526 8524 2160 34817 2160 4202560 11146 0 0 0 112 3 0 0 15 0 11 0 54209361 900661248 66077 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 0 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8541] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8541/stat : 8541 (java) S 8526 8524 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 54209361 900661248 66077 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8542] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8542/stat : 8542 (java) S 8526 8524 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 54209362 900661248 66077 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8543] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8543/stat : 8543 (java) S 8526 8524 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 54209371 900661248 66077 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8544] ppid=8526 vsize=879552 CPUtime=0.35
/proc/8538/task/8544/stat : 8544 (java) S 8526 8524 2160 34817 2160 4202560 798 0 0 0 35 0 0 0 15 0 11 0 54209371 900661248 66077 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8545] ppid=8526 vsize=879552 CPUtime=1.84
/proc/8538/task/8545/stat : 8545 (java) S 8526 8524 2160 34817 2160 4202560 9250 0 8 0 180 4 0 0 16 0 11 0 54209371 900661248 66077 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8546] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8546/stat : 8546 (java) S 8526 8524 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 54209371 900661248 66077 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8547] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8547/stat : 8547 (java) S 8526 8524 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 54209371 900661248 66077 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8548] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8548/stat : 8548 (java) S 8526 8524 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 54209703 900661248 66077 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 11.8
Current children cumulated vsize (KiB) 884688

[startup+25.504 s]
/proc/loadavg: 0.95 0.98 0.99 2/51 8550
/proc/meminfo: memFree=669252/1048576 swapFree=0/0
[pid=8524] ppid=8523 vsize=2568 CPUtime=0
/proc/8524/stat : 8524 (p2cudf-user-1.1) S 8523 8524 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 54209321 2629632 269 1283457024 134512640 135304128 4291591888 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/8524/statm: 642 269 230 194 0 29 0
[pid=8526] ppid=8524 vsize=2568 CPUtime=0.02
/proc/8526/stat : 8526 (p2cudf) S 8524 8524 2160 34817 2160 4202496 388 3013 0 1 0 0 2 0 25 0 1 0 54209322 2629632 279 1283457024 134512640 135304128 4291702544 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/8526/statm: 642 279 239 194 0 29 0
[pid=8538] ppid=8526 vsize=879552 CPUtime=24.55
/proc/8538/stat : 8538 (java) S 8526 8524 2160 34817 2160 4202496 70102 0 105 0 2431 24 0 0 23 0 11 0 54209325 900661248 66417 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/8538/statm: 219888 66417 1783 10 0 216979 0
[pid=8538/tid=8539] ppid=8526 vsize=879552 CPUtime=19.92
/proc/8538/task/8539/stat : 8539 (java) R 8526 8524 2160 34817 2160 4202560 47570 0 15 0 1977 15 0 0 25 0 11 0 54209351 900661248 66417 1283457024 134512640 134550932 4289125184 18446744073709551615 4096243206 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=8538/tid=8540] ppid=8526 vsize=879552 CPUtime=2.41
/proc/8538/task/8540/stat : 8540 (java) S 8526 8524 2160 34817 2160 4202560 11486 0 0 0 238 3 0 0 16 0 11 0 54209361 900661248 66417 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 0 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8541] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8541/stat : 8541 (java) S 8526 8524 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 54209361 900661248 66417 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8542] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8542/stat : 8542 (java) S 8526 8524 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 54209362 900661248 66417 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8543] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8543/stat : 8543 (java) S 8526 8524 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 54209371 900661248 66417 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8544] ppid=8526 vsize=879552 CPUtime=0.35
/proc/8538/task/8544/stat : 8544 (java) S 8526 8524 2160 34817 2160 4202560 798 0 0 0 35 0 0 0 15 0 11 0 54209371 900661248 66417 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8545] ppid=8526 vsize=879552 CPUtime=1.84
/proc/8538/task/8545/stat : 8545 (java) S 8526 8524 2160 34817 2160 4202560 9250 0 8 0 180 4 0 0 16 0 11 0 54209371 900661248 66417 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8546] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8546/stat : 8546 (java) S 8526 8524 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 54209371 900661248 66417 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8547] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8547/stat : 8547 (java) S 8526 8524 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 54209371 900661248 66417 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8548] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8548/stat : 8548 (java) S 8526 8524 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 54209703 900661248 66417 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 24.57
Current children cumulated vsize (KiB) 884688

[startup+51.1098 s]
/proc/loadavg: 0.97 0.98 0.99 2/51 8554
/proc/meminfo: memFree=668632/1048576 swapFree=0/0
[pid=8524] ppid=8523 vsize=2568 CPUtime=0
/proc/8524/stat : 8524 (p2cudf-user-1.1) S 8523 8524 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 54209321 2629632 269 1283457024 134512640 135304128 4291591888 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/8524/statm: 642 269 230 194 0 29 0
[pid=8526] ppid=8524 vsize=2568 CPUtime=0.02
/proc/8526/stat : 8526 (p2cudf) S 8524 8524 2160 34817 2160 4202496 388 3013 0 1 0 0 2 0 25 0 1 0 54209322 2629632 279 1283457024 134512640 135304128 4291702544 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/8526/statm: 642 279 239 194 0 29 0
[pid=8538] ppid=8526 vsize=879552 CPUtime=50.13
/proc/8538/stat : 8538 (java) S 8526 8524 2160 34817 2160 4202496 70223 0 105 0 4989 24 0 0 23 0 11 0 54209325 900661248 66538 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/8538/statm: 219888 66538 1783 10 0 216979 0
[pid=8538/tid=8539] ppid=8526 vsize=879552 CPUtime=43.12
/proc/8538/task/8539/stat : 8539 (java) R 8526 8524 2160 34817 2160 4202560 47570 0 15 0 4297 15 0 0 25 0 11 0 54209351 900661248 66538 1283457024 134512640 134550932 4289125184 18446744073709551615 4096222870 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=8538/tid=8540] ppid=8526 vsize=879552 CPUtime=4.79
/proc/8538/task/8540/stat : 8540 (java) S 8526 8524 2160 34817 2160 4202560 11607 0 0 0 476 3 0 0 16 0 11 0 54209361 900661248 66538 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 0 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8541] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8541/stat : 8541 (java) S 8526 8524 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 54209361 900661248 66538 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8542] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8542/stat : 8542 (java) S 8526 8524 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 54209362 900661248 66538 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8543] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8543/stat : 8543 (java) S 8526 8524 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 54209371 900661248 66538 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8544] ppid=8526 vsize=879552 CPUtime=0.35
/proc/8538/task/8544/stat : 8544 (java) S 8526 8524 2160 34817 2160 4202560 798 0 0 0 35 0 0 0 15 0 11 0 54209371 900661248 66538 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8545] ppid=8526 vsize=879552 CPUtime=1.84
/proc/8538/task/8545/stat : 8545 (java) S 8526 8524 2160 34817 2160 4202560 9250 0 8 0 180 4 0 0 16 0 11 0 54209371 900661248 66538 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8546] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8546/stat : 8546 (java) S 8526 8524 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 54209371 900661248 66538 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8547] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8547/stat : 8547 (java) S 8526 8524 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 54209371 900661248 66538 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8548] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8548/stat : 8548 (java) S 8526 8524 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 54209703 900661248 66538 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 50.15
Current children cumulated vsize (KiB) 884688

[startup+102.312 s]
/proc/loadavg: 1.09 1.01 1.00 2/50 8558
/proc/meminfo: memFree=666168/1048576 swapFree=0/0
[pid=8524] ppid=8523 vsize=2568 CPUtime=0
/proc/8524/stat : 8524 (p2cudf-user-1.1) S 8523 8524 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 54209321 2629632 269 1283457024 134512640 135304128 4291591888 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/8524/statm: 642 269 230 194 0 29 0
[pid=8526] ppid=8524 vsize=2568 CPUtime=0.02
/proc/8526/stat : 8526 (p2cudf) S 8524 8524 2160 34817 2160 4202496 388 3013 0 1 0 0 2 0 25 0 1 0 54209322 2629632 279 1283457024 134512640 135304128 4291702544 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/8526/statm: 642 279 239 194 0 29 0
[pid=8538] ppid=8526 vsize=879552 CPUtime=101.29
/proc/8538/stat : 8538 (java) S 8526 8524 2160 34817 2160 4202496 70785 0 105 0 10103 26 0 0 23 0 11 0 54209325 900661248 67100 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/8538/statm: 219888 67100 1783 10 0 216979 0
[pid=8538/tid=8539] ppid=8526 vsize=879552 CPUtime=89.18
/proc/8538/task/8539/stat : 8539 (java) R 8526 8524 2160 34817 2160 4202560 47570 0 15 0 8902 16 0 0 25 0 11 0 54209351 900661248 67100 1283457024 134512640 134550932 4289125184 18446744073709551615 4096234224 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=8538/tid=8540] ppid=8526 vsize=879552 CPUtime=9.51
/proc/8538/task/8540/stat : 8540 (java) S 8526 8524 2160 34817 2160 4202560 12136 0 0 0 947 4 0 0 16 0 11 0 54209361 900661248 67100 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 0 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8541] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8541/stat : 8541 (java) S 8526 8524 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 54209361 900661248 67100 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8542] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8542/stat : 8542 (java) S 8526 8524 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 54209362 900661248 67100 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8543] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8543/stat : 8543 (java) S 8526 8524 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 54209371 900661248 67100 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8544] ppid=8526 vsize=879552 CPUtime=0.35
/proc/8538/task/8544/stat : 8544 (java) S 8526 8524 2160 34817 2160 4202560 798 0 0 0 35 0 0 0 15 0 11 0 54209371 900661248 67100 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8545] ppid=8526 vsize=879552 CPUtime=2.22
/proc/8538/task/8545/stat : 8545 (java) S 8526 8524 2160 34817 2160 4202560 9283 0 8 0 218 4 0 0 16 0 11 0 54209371 900661248 67100 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8546] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8546/stat : 8546 (java) S 8526 8524 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 54209371 900661248 67100 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8547] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8547/stat : 8547 (java) S 8526 8524 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 54209371 900661248 67100 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8548] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8548/stat : 8548 (java) S 8526 8524 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 54209703 900661248 67100 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 101.31
Current children cumulated vsize (KiB) 884688

[startup+162.314 s]
/proc/loadavg: 1.03 1.01 1.00 3/49 8558
/proc/meminfo: memFree=665804/1048576 swapFree=0/0
[pid=8524] ppid=8523 vsize=2568 CPUtime=0
/proc/8524/stat : 8524 (p2cudf-user-1.1) S 8523 8524 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 54209321 2629632 269 1283457024 134512640 135304128 4291591888 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/8524/statm: 642 269 230 194 0 29 0
[pid=8526] ppid=8524 vsize=2568 CPUtime=0.02
/proc/8526/stat : 8526 (p2cudf) S 8524 8524 2160 34817 2160 4202496 388 3013 0 1 0 0 2 0 25 0 1 0 54209322 2629632 279 1283457024 134512640 135304128 4291702544 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/8526/statm: 642 279 239 194 0 29 0
[pid=8538] ppid=8526 vsize=879552 CPUtime=161.25
/proc/8538/stat : 8538 (java) S 8526 8524 2160 34817 2160 4202496 70912 0 105 0 16098 27 0 0 23 0 11 0 54209325 900661248 67227 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/8538/statm: 219888 67227 1783 10 0 216979 0
[pid=8538/tid=8539] ppid=8526 vsize=879552 CPUtime=143.57
/proc/8538/task/8539/stat : 8539 (java) R 8526 8524 2160 34817 2160 4202560 47570 0 15 0 14340 17 0 0 25 0 11 0 54209351 900661248 67227 1283457024 134512640 134550932 4289125184 18446744073709551615 4096277351 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=8538/tid=8540] ppid=8526 vsize=879552 CPUtime=15.07
/proc/8538/task/8540/stat : 8540 (java) S 8526 8524 2160 34817 2160 4202560 12263 0 0 0 1503 4 0 0 16 0 11 0 54209361 900661248 67227 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 0 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8541] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8541/stat : 8541 (java) S 8526 8524 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 54209361 900661248 67227 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8542] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8542/stat : 8542 (java) S 8526 8524 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 54209362 900661248 67227 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8543] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8543/stat : 8543 (java) S 8526 8524 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 54209371 900661248 67227 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8544] ppid=8526 vsize=879552 CPUtime=0.35
/proc/8538/task/8544/stat : 8544 (java) S 8526 8524 2160 34817 2160 4202560 798 0 0 0 35 0 0 0 15 0 11 0 54209371 900661248 67227 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8545] ppid=8526 vsize=879552 CPUtime=2.24
/proc/8538/task/8545/stat : 8545 (java) S 8526 8524 2160 34817 2160 4202560 9283 0 8 0 220 4 0 0 15 0 11 0 54209371 900661248 67227 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8546] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8546/stat : 8546 (java) S 8526 8524 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 54209371 900661248 67227 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8547] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8547/stat : 8547 (java) S 8526 8524 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 54209371 900661248 67227 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8548] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8548/stat : 8548 (java) S 8526 8524 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 54209703 900661248 67227 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 161.27
Current children cumulated vsize (KiB) 884688

[startup+222.312 s]
/proc/loadavg: 1.01 1.00 1.00 2/49 8558
/proc/meminfo: memFree=664440/1048576 swapFree=0/0
[pid=8524] ppid=8523 vsize=2568 CPUtime=0
/proc/8524/stat : 8524 (p2cudf-user-1.1) S 8523 8524 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 54209321 2629632 269 1283457024 134512640 135304128 4291591888 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/8524/statm: 642 269 230 194 0 29 0
[pid=8526] ppid=8524 vsize=2568 CPUtime=0.02
/proc/8526/stat : 8526 (p2cudf) S 8524 8524 2160 34817 2160 4202496 388 3013 0 1 0 0 2 0 25 0 1 0 54209322 2629632 279 1283457024 134512640 135304128 4291702544 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/8526/statm: 642 279 239 194 0 29 0
[pid=8538] ppid=8526 vsize=879552 CPUtime=221.27
/proc/8538/stat : 8538 (java) S 8526 8524 2160 34817 2160 4202496 71189 0 105 0 22099 28 0 0 23 0 11 0 54209325 900661248 67504 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/8538/statm: 219888 67504 1783 10 0 216979 0
[pid=8538/tid=8539] ppid=8526 vsize=879552 CPUtime=197.68
/proc/8538/task/8539/stat : 8539 (java) R 8526 8524 2160 34817 2160 4202560 47570 0 15 0 19750 18 0 0 25 0 11 0 54209351 900661248 67504 1283457024 134512640 134550932 4289125184 18446744073709551615 4096222675 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=8538/tid=8540] ppid=8526 vsize=879552 CPUtime=20.97
/proc/8538/task/8540/stat : 8540 (java) S 8526 8524 2160 34817 2160 4202560 12540 0 0 0 2093 4 0 0 16 0 11 0 54209361 900661248 67504 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 0 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8541] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8541/stat : 8541 (java) S 8526 8524 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 54209361 900661248 67504 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8542] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8542/stat : 8542 (java) S 8526 8524 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 54209362 900661248 67504 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8543] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8543/stat : 8543 (java) S 8526 8524 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 54209371 900661248 67504 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8544] ppid=8526 vsize=879552 CPUtime=0.35
/proc/8538/task/8544/stat : 8544 (java) S 8526 8524 2160 34817 2160 4202560 798 0 0 0 35 0 0 0 15 0 11 0 54209371 900661248 67504 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8545] ppid=8526 vsize=879552 CPUtime=2.24
/proc/8538/task/8545/stat : 8545 (java) S 8526 8524 2160 34817 2160 4202560 9283 0 8 0 220 4 0 0 15 0 11 0 54209371 900661248 67504 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8546] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8546/stat : 8546 (java) S 8526 8524 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 54209371 900661248 67504 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8547] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8547/stat : 8547 (java) R 8526 8524 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 54209371 900661248 67504 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=8538/tid=8548] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8548/stat : 8548 (java) S 8526 8524 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 54209703 900661248 67504 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 221.29
Current children cumulated vsize (KiB) 884688

[startup+282.305 s]
/proc/loadavg: 1.06 1.01 1.00 2/49 8558
/proc/meminfo: memFree=663944/1048576 swapFree=0/0
[pid=8524] ppid=8523 vsize=2568 CPUtime=0
/proc/8524/stat : 8524 (p2cudf-user-1.1) S 8523 8524 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 54209321 2629632 269 1283457024 134512640 135304128 4291591888 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/8524/statm: 642 269 230 194 0 29 0
[pid=8526] ppid=8524 vsize=2568 CPUtime=0.02
/proc/8526/stat : 8526 (p2cudf) S 8524 8524 2160 34817 2160 4202496 388 3013 0 1 0 0 2 0 25 0 1 0 54209322 2629632 279 1283457024 134512640 135304128 4291702544 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/8526/statm: 642 279 239 194 0 29 0
[pid=8538] ppid=8526 vsize=879552 CPUtime=281.18
/proc/8538/stat : 8538 (java) S 8526 8524 2160 34817 2160 4202496 71311 0 105 0 28088 30 0 0 23 0 11 0 54209325 900661248 67626 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/8538/statm: 219888 67626 1783 10 0 216979 0
[pid=8538/tid=8539] ppid=8526 vsize=879552 CPUtime=251.83
/proc/8538/task/8539/stat : 8539 (java) R 8526 8524 2160 34817 2160 4202560 47570 0 15 0 25164 19 0 0 25 0 11 0 54209351 900661248 67626 1283457024 134512640 134550932 4289125184 18446744073709551615 4096261968 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=8538/tid=8540] ppid=8526 vsize=879552 CPUtime=26.73
/proc/8538/task/8540/stat : 8540 (java) S 8526 8524 2160 34817 2160 4202560 12662 0 0 0 2668 5 0 0 16 0 11 0 54209361 900661248 67626 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 0 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8541] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8541/stat : 8541 (java) S 8526 8524 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 54209361 900661248 67626 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8542] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8542/stat : 8542 (java) S 8526 8524 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 54209362 900661248 67626 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8543] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8543/stat : 8543 (java) S 8526 8524 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 54209371 900661248 67626 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8544] ppid=8526 vsize=879552 CPUtime=0.35
/proc/8538/task/8544/stat : 8544 (java) S 8526 8524 2160 34817 2160 4202560 798 0 0 0 35 0 0 0 15 0 11 0 54209371 900661248 67626 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8545] ppid=8526 vsize=879552 CPUtime=2.24
/proc/8538/task/8545/stat : 8545 (java) S 8526 8524 2160 34817 2160 4202560 9283 0 8 0 220 4 0 0 15 0 11 0 54209371 900661248 67626 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8546] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8546/stat : 8546 (java) S 8526 8524 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 54209371 900661248 67626 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8547] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8547/stat : 8547 (java) S 8526 8524 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 54209371 900661248 67626 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8548] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8548/stat : 8548 (java) S 8526 8524 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 54209703 900661248 67626 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 281.2
Current children cumulated vsize (KiB) 884688

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

[startup+282.806 s]
/proc/loadavg: 1.06 1.01 1.00 2/49 8558
/proc/meminfo: memFree=663944/1048576 swapFree=0/0
[pid=8524] ppid=8523 vsize=2568 CPUtime=0
/proc/8524/stat : 8524 (p2cudf-user-1.1) S 8523 8524 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 54209321 2629632 269 1283457024 134512640 135304128 4291591888 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/8524/statm: 642 269 230 194 0 29 0
[pid=8526] ppid=8524 vsize=2568 CPUtime=0.02
/proc/8526/stat : 8526 (p2cudf) S 8524 8524 2160 34817 2160 4202496 388 3013 0 1 0 0 2 0 25 0 1 0 54209322 2629632 279 1283457024 134512640 135304128 4291702544 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/8526/statm: 642 279 239 194 0 29 0
[pid=8538] ppid=8526 vsize=879552 CPUtime=281.68
/proc/8538/stat : 8538 (java) S 8526 8524 2160 34817 2160 4202496 71311 0 105 0 28138 30 0 0 23 0 11 0 54209325 900661248 67626 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/8538/statm: 219888 67626 1783 10 0 216979 0
[pid=8538/tid=8539] ppid=8526 vsize=879552 CPUtime=252.33
/proc/8538/task/8539/stat : 8539 (java) R 8526 8524 2160 34817 2160 4202560 47570 0 15 0 25214 19 0 0 25 0 11 0 54209351 900661248 67626 1283457024 134512640 134550932 4289125184 18446744073709551615 4096214094 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=8538/tid=8540] ppid=8526 vsize=879552 CPUtime=26.73
/proc/8538/task/8540/stat : 8540 (java) S 8526 8524 2160 34817 2160 4202560 12662 0 0 0 2668 5 0 0 16 0 11 0 54209361 900661248 67626 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 0 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8541] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8541/stat : 8541 (java) S 8526 8524 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 54209361 900661248 67626 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8542] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8542/stat : 8542 (java) S 8526 8524 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 54209362 900661248 67626 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8543] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8543/stat : 8543 (java) S 8526 8524 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 54209371 900661248 67626 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8544] ppid=8526 vsize=879552 CPUtime=0.35
/proc/8538/task/8544/stat : 8544 (java) S 8526 8524 2160 34817 2160 4202560 798 0 0 0 35 0 0 0 15 0 11 0 54209371 900661248 67626 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8545] ppid=8526 vsize=879552 CPUtime=2.24
/proc/8538/task/8545/stat : 8545 (java) S 8526 8524 2160 34817 2160 4202560 9283 0 8 0 220 4 0 0 15 0 11 0 54209371 900661248 67626 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8546] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8546/stat : 8546 (java) S 8526 8524 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 54209371 900661248 67626 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8547] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8547/stat : 8547 (java) S 8526 8524 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 54209371 900661248 67626 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8548] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8548/stat : 8548 (java) S 8526 8524 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 54209703 900661248 67626 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 281.7
Current children cumulated vsize (KiB) 884688

[startup+283.606 s]
/proc/loadavg: 1.06 1.01 1.00 2/49 8558
/proc/meminfo: memFree=663944/1048576 swapFree=0/0
[pid=8524] ppid=8523 vsize=2568 CPUtime=0
/proc/8524/stat : 8524 (p2cudf-user-1.1) S 8523 8524 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 54209321 2629632 269 1283457024 134512640 135304128 4291591888 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/8524/statm: 642 269 230 194 0 29 0
[pid=8526] ppid=8524 vsize=2568 CPUtime=0.02
/proc/8526/stat : 8526 (p2cudf) S 8524 8524 2160 34817 2160 4202496 388 3013 0 1 0 0 2 0 25 0 1 0 54209322 2629632 279 1283457024 134512640 135304128 4291702544 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/8526/statm: 642 279 239 194 0 29 0
[pid=8538] ppid=8526 vsize=879552 CPUtime=282.48
/proc/8538/stat : 8538 (java) S 8526 8524 2160 34817 2160 4202496 71311 0 105 0 28218 30 0 0 23 0 11 0 54209325 900661248 67626 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/8538/statm: 219888 67626 1783 10 0 216979 0
[pid=8538/tid=8539] ppid=8526 vsize=879552 CPUtime=252.97
/proc/8538/task/8539/stat : 8539 (java) R 8526 8524 2160 34817 2160 4202560 47570 0 15 0 25278 19 0 0 25 0 11 0 54209351 900661248 67626 1283457024 134512640 134550932 4289125184 18446744073709551615 4096216688 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=8538/tid=8540] ppid=8526 vsize=879552 CPUtime=26.89
/proc/8538/task/8540/stat : 8540 (java) S 8526 8524 2160 34817 2160 4202560 12662 0 0 0 2684 5 0 0 16 0 11 0 54209361 900661248 67626 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 0 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8541] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8541/stat : 8541 (java) S 8526 8524 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 54209361 900661248 67626 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8542] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8542/stat : 8542 (java) S 8526 8524 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 54209362 900661248 67626 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8543] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8543/stat : 8543 (java) S 8526 8524 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 54209371 900661248 67626 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8544] ppid=8526 vsize=879552 CPUtime=0.35
/proc/8538/task/8544/stat : 8544 (java) S 8526 8524 2160 34817 2160 4202560 798 0 0 0 35 0 0 0 15 0 11 0 54209371 900661248 67626 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8545] ppid=8526 vsize=879552 CPUtime=2.24
/proc/8538/task/8545/stat : 8545 (java) S 8526 8524 2160 34817 2160 4202560 9283 0 8 0 220 4 0 0 15 0 11 0 54209371 900661248 67626 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8546] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8546/stat : 8546 (java) S 8526 8524 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 54209371 900661248 67626 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8547] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8547/stat : 8547 (java) S 8526 8524 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 54209371 900661248 67626 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8548] ppid=8526 vsize=879552 CPUtime=0
/proc/8538/task/8548/stat : 8548 (java) S 8526 8524 2160 34817 2160 4202560 4 0 0 0 0 0 0 0 25 0 11 0 54209703 900661248 67626 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 282.5
Current children cumulated vsize (KiB) 884688

[startup+284.005 s]
/proc/loadavg: 1.06 1.01 1.00 2/49 8558
/proc/meminfo: memFree=663944/1048576 swapFree=0/0
[pid=8524] ppid=8523 vsize=2568 CPUtime=0
/proc/8524/stat : 8524 (p2cudf-user-1.1) S 8523 8524 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 54209321 2629632 269 1283457024 134512640 135304128 4291591888 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/8524/statm: 642 269 230 194 0 29 0
[pid=8526] ppid=8524 vsize=2568 CPUtime=0.02
/proc/8526/stat : 8526 (p2cudf) S 8524 8524 2160 34817 2160 4202496 388 3013 0 1 0 0 2 0 25 0 1 0 54209322 2629632 279 1283457024 134512640 135304128 4291702544 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/8526/statm: 642 279 239 194 0 29 0
[pid=8538] ppid=8526 vsize=879876 CPUtime=282.7
/proc/8538/stat : 8538 (java) S 8526 8524 2160 34817 2160 4202496 71323 0 105 0 28240 30 0 0 23 0 11 0 54209325 900993024 67638 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/8538/statm: 219969 67638 1784 10 0 217060 0
[pid=8538/tid=8539] ppid=8526 vsize=879876 CPUtime=253.2
/proc/8538/task/8539/stat : 8539 (java) S 8526 8524 2160 34817 2160 4202560 47577 0 15 0 25301 19 0 0 25 0 11 0 54209351 900993024 67638 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8540] ppid=8526 vsize=879876 CPUtime=26.89
/proc/8538/task/8540/stat : 8540 (java) S 8526 8524 2160 34817 2160 4202560 12662 0 0 0 2684 5 0 0 16 0 11 0 54209361 900993024 67638 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 0 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8541] ppid=8526 vsize=879876 CPUtime=0
/proc/8538/task/8541/stat : 8541 (java) S 8526 8524 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 54209361 900993024 67638 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8542] ppid=8526 vsize=879876 CPUtime=0
/proc/8538/task/8542/stat : 8542 (java) S 8526 8524 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 54209362 900993024 67638 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8543] ppid=8526 vsize=879876 CPUtime=0
/proc/8538/task/8543/stat : 8543 (java) S 8526 8524 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 54209371 900993024 67638 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8544] ppid=8526 vsize=879876 CPUtime=0.35
/proc/8538/task/8544/stat : 8544 (java) S 8526 8524 2160 34817 2160 4202560 798 0 0 0 35 0 0 0 15 0 11 0 54209371 900993024 67638 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8545] ppid=8526 vsize=879876 CPUtime=2.24
/proc/8538/task/8545/stat : 8545 (java) S 8526 8524 2160 34817 2160 4202560 9283 0 8 0 220 4 0 0 15 0 11 0 54209371 900993024 67638 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8546] ppid=8526 vsize=879876 CPUtime=0
/proc/8538/task/8546/stat : 8546 (java) S 8526 8524 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 54209371 900993024 67638 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8547] ppid=8526 vsize=879876 CPUtime=0
/proc/8538/task/8547/stat : 8547 (java) S 8526 8524 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 54209371 900993024 67638 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 282.72
Current children cumulated vsize (KiB) 885012

[startup+284.415 s]
/proc/loadavg: 1.06 1.01 1.00 2/49 8558
/proc/meminfo: memFree=663944/1048576 swapFree=0/0
[pid=8524] ppid=8523 vsize=2568 CPUtime=0
/proc/8524/stat : 8524 (p2cudf-user-1.1) S 8523 8524 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 54209321 2629632 269 1283457024 134512640 135304128 4291591888 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/8524/statm: 642 269 230 194 0 29 0
[pid=8526] ppid=8524 vsize=2568 CPUtime=0.02
/proc/8526/stat : 8526 (p2cudf) S 8524 8524 2160 34817 2160 4202496 388 3013 0 1 0 0 2 0 25 0 1 0 54209322 2629632 279 1283457024 134512640 135304128 4291702544 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/8526/statm: 642 279 239 194 0 29 0
[pid=8538] ppid=8526 vsize=879876 CPUtime=282.75
/proc/8538/stat : 8538 (java) S 8526 8524 2160 34817 2160 4202496 71325 0 105 0 28244 31 0 0 23 0 11 0 54209325 900993024 67640 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/8538/statm: 219969 67640 1785 10 0 217060 0
[pid=8538/tid=8539] ppid=8526 vsize=879876 CPUtime=253.2
/proc/8538/task/8539/stat : 8539 (java) S 8526 8524 2160 34817 2160 4202560 47577 0 15 0 25301 19 0 0 25 0 11 0 54209351 900993024 67640 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8540] ppid=8526 vsize=879876 CPUtime=26.89
/proc/8538/task/8540/stat : 8540 (java) S 8526 8524 2160 34817 2160 4202560 12662 0 0 0 2684 5 0 0 16 0 11 0 54209361 900993024 67640 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 0 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8541] ppid=8526 vsize=879876 CPUtime=0
/proc/8538/task/8541/stat : 8541 (java) S 8526 8524 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 54209361 900993024 67640 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8542] ppid=8526 vsize=879876 CPUtime=0
/proc/8538/task/8542/stat : 8542 (java) S 8526 8524 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 54209362 900993024 67640 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8543] ppid=8526 vsize=879876 CPUtime=0
/proc/8538/task/8543/stat : 8543 (java) S 8526 8524 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 54209371 900993024 67640 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8544] ppid=8526 vsize=879876 CPUtime=0.35
/proc/8538/task/8544/stat : 8544 (java) S 8526 8524 2160 34817 2160 4202560 798 0 0 0 35 0 0 0 15 0 11 0 54209371 900993024 67640 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8545] ppid=8526 vsize=879876 CPUtime=2.26
/proc/8538/task/8545/stat : 8545 (java) S 8526 8524 2160 34817 2160 4202560 9284 0 8 0 222 4 0 0 15 0 11 0 54209371 900993024 67640 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8546] ppid=8526 vsize=879876 CPUtime=0
/proc/8538/task/8546/stat : 8546 (java) S 8526 8524 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 54209371 900993024 67640 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8547] ppid=8526 vsize=879876 CPUtime=0
/proc/8538/task/8547/stat : 8547 (java) S 8526 8524 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 54209371 900993024 67640 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 282.77
Current children cumulated vsize (KiB) 885012

[startup+284.501 s]
/proc/loadavg: 1.06 1.01 1.00 2/49 8559
/proc/meminfo: memFree=663820/1048576 swapFree=0/0
[pid=8524] ppid=8523 vsize=2568 CPUtime=0
/proc/8524/stat : 8524 (p2cudf-user-1.1) S 8523 8524 2160 34817 2160 4202496 373 0 0 0 0 0 0 0 25 0 1 0 54209321 2629632 269 1283457024 134512640 135304128 4291591888 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/8524/statm: 642 269 230 194 0 29 0
[pid=8526] ppid=8524 vsize=2568 CPUtime=0.02
/proc/8526/stat : 8526 (p2cudf) S 8524 8524 2160 34817 2160 4202496 388 3013 0 1 0 0 2 0 25 0 1 0 54209322 2629632 279 1283457024 134512640 135304128 4291702544 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/8526/statm: 642 279 239 194 0 29 0
[pid=8538] ppid=8526 vsize=879876 CPUtime=282.84
/proc/8538/stat : 8538 (java) S 8526 8524 2160 34817 2160 4202496 71326 0 105 0 28251 33 0 0 23 0 11 0 54209325 900993024 67641 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/8538/statm: 219969 67641 1785 10 0 217060 0
[pid=8538/tid=8539] ppid=8526 vsize=879876 CPUtime=253.2
/proc/8538/task/8539/stat : 8539 (java) S 8526 8524 2160 34817 2160 4202560 47577 0 15 0 25301 19 0 0 25 0 11 0 54209351 900993024 67641 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8540] ppid=8526 vsize=879876 CPUtime=26.89
/proc/8538/task/8540/stat : 8540 (java) S 8526 8524 2160 34817 2160 4202560 12662 0 0 0 2684 5 0 0 16 0 11 0 54209361 900993024 67641 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 0 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8541] ppid=8526 vsize=879876 CPUtime=0
/proc/8538/task/8541/stat : 8541 (java) S 8526 8524 2160 34817 2160 4202560 8 0 1 0 0 0 0 0 18 0 11 0 54209361 900993024 67641 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8542] ppid=8526 vsize=879876 CPUtime=0
/proc/8538/task/8542/stat : 8542 (java) S 8526 8524 2160 34817 2160 4202560 6 0 0 0 0 0 0 0 18 0 11 0 54209362 900993024 67641 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8543] ppid=8526 vsize=879876 CPUtime=0
/proc/8538/task/8543/stat : 8543 (java) S 8526 8524 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 54209371 900993024 67641 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8544] ppid=8526 vsize=879876 CPUtime=0.35
/proc/8538/task/8544/stat : 8544 (java) S 8526 8524 2160 34817 2160 4202560 798 0 0 0 35 0 0 0 15 0 11 0 54209371 900993024 67641 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8545] ppid=8526 vsize=879876 CPUtime=2.28
/proc/8538/task/8545/stat : 8545 (java) S 8526 8524 2160 34817 2160 4202560 9284 0 8 0 224 4 0 0 16 0 11 0 54209371 900993024 67641 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8546] ppid=8526 vsize=879876 CPUtime=0
/proc/8538/task/8546/stat : 8546 (java) S 8526 8524 2160 34817 2160 4202560 1 0 0 0 0 0 0 0 25 0 11 0 54209371 900993024 67641 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8547] ppid=8526 vsize=879876 CPUtime=0
/proc/8538/task/8547/stat : 8547 (java) S 8526 8524 2160 34817 2160 4202560 2 0 0 0 0 0 0 0 15 0 11 0 54209371 900993024 67641 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 18446612132371209152 0 0 -1 0 0 0 0
[pid=8538/tid=8559] ppid=8526 vsize=879876 CPUtime=0.09
/proc/8538/task/8559/stat : 8559 (java) R 8526 8524 2160 34817 2160 4202560 6 0 0 0 6 3 0 0 20 0 11 0 54237712 900993024 67641 1283457024 134512640 134550932 4289125184 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 282.86
Current children cumulated vsize (KiB) 885012

Child status: 0
Real time (s): 284.533
CPU time (s): 282.894
CPU user time (s): 282.538
CPU system time (s): 0.356022
CPU usage (%): 99.4238
Max. virtual memory (cumulated for all children) (KiB): 885112

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 282.538
system time used= 0.356022
maximum resident set size= 0
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 75124
page faults= 106
swaps= 0
block input operations= 0
block output operations= 0
messages sent= 0
messages received= 0
signals received= 0
voluntary context switches= 6988
involuntary context switches= 9306

runsolver used 0 second user time and 0.020001 second system time

The end