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/201108241238/p2cudf-trendy-1.13/rand230.cudf.s-e.log.runsolver ./p2cudf-trendy-1.13 /home/misc2010/data/2011/incremental/s-e/rand230.cudf /home/misc2010/tmp/201108241238/p2cudf-trendy-1.13/rand230.cudf.s-e.result 

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


[startup+0 s]
/proc/loadavg: 1.00 1.01 1.00 5/34 6587
/proc/meminfo: memFree=691356/1048576 swapFree=0/0
[pid=6586] ppid=6585 vsize=2564 CPUtime=0
/proc/6586/stat : 6586 (p2cudf-trendy-1) S 6585 6586 1511 34817 1511 4202496 374 0 0 0 0 0 0 0 25 0 1 0 1668595 2625536 270 1283457024 134512640 135304128 4288494592 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6586/statm: 641 270 230 194 0 28 0
[pid=6587] ppid=6586 vsize=2568 CPUtime=0
/proc/6587/stat : 6587 (p2cudf) R 6586 6586 1511 34817 1511 4202496 345 0 0 0 0 0 0 0 25 0 1 0 1668595 2629632 271 1283457024 134512640 135304128 4294500784 18446744073709551615 4294960130 0 65538 4 65536 0 0 0 17 0 0 0 0
/proc/6587/statm: 642 271 231 194 0 29 0
[pid=6588] ppid=6587 vsize=2568 CPUtime=0
/proc/6588/stat : 6588 (p2cudf) R 6587 6586 1511 34817 1511 4202560 0 0 0 0 0 0 0 0 25 0 1 0 1668595 2629632 40 1283457024 134512640 135304128 4294500784 18446744073709551615 4294960130 0 65538 4 65536 0 0 0 17 0 0 0 0
/proc/6588/statm: 642 40 0 194 0 29 0

[startup+0.202289 s]
/proc/loadavg: 1.00 1.01 1.00 5/34 6587
/proc/meminfo: memFree=691356/1048576 swapFree=0/0
[pid=6586] ppid=6585 vsize=2564 CPUtime=0
/proc/6586/stat : 6586 (p2cudf-trendy-1) S 6585 6586 1511 34817 1511 4202496 374 0 0 0 0 0 0 0 25 0 1 0 1668595 2625536 270 1283457024 134512640 135304128 4288494592 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6586/statm: 641 270 230 194 0 28 0
[pid=6587] ppid=6586 vsize=2572 CPUtime=0.03
/proc/6587/stat : 6587 (p2cudf) S 6586 6586 1511 34817 1511 4202496 392 3013 0 1 0 0 1 2 25 0 1 0 1668595 2633728 280 1283457024 134512640 135304128 4294500784 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6587/statm: 643 280 239 194 0 30 0
Current children cumulated CPU time (s) 0.03
Current children cumulated vsize (KiB) 5136

[startup+0.312305 s]
/proc/loadavg: 1.00 1.01 1.00 5/34 6587
/proc/meminfo: memFree=691356/1048576 swapFree=0/0
[pid=6586] ppid=6585 vsize=2564 CPUtime=0
/proc/6586/stat : 6586 (p2cudf-trendy-1) S 6585 6586 1511 34817 1511 4202496 374 0 0 0 0 0 0 0 25 0 1 0 1668595 2625536 270 1283457024 134512640 135304128 4288494592 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6586/statm: 641 270 230 194 0 28 0
[pid=6587] ppid=6586 vsize=2572 CPUtime=0.03
/proc/6587/stat : 6587 (p2cudf) S 6586 6586 1511 34817 1511 4202496 392 3013 0 1 0 0 1 2 25 0 1 0 1668595 2633728 280 1283457024 134512640 135304128 4294500784 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6587/statm: 643 280 239 194 0 30 0
Current children cumulated CPU time (s) 0.03
Current children cumulated vsize (KiB) 5136

[startup+0.412327 s]
/proc/loadavg: 1.00 1.01 1.00 5/34 6587
/proc/meminfo: memFree=691356/1048576 swapFree=0/0
[pid=6586] ppid=6585 vsize=2564 CPUtime=0
/proc/6586/stat : 6586 (p2cudf-trendy-1) S 6585 6586 1511 34817 1511 4202496 374 0 0 0 0 0 0 0 25 0 1 0 1668595 2625536 270 1283457024 134512640 135304128 4288494592 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6586/statm: 641 270 230 194 0 28 0
[pid=6587] ppid=6586 vsize=2572 CPUtime=0.03
/proc/6587/stat : 6587 (p2cudf) S 6586 6586 1511 34817 1511 4202496 392 3013 0 1 0 0 1 2 25 0 1 0 1668595 2633728 280 1283457024 134512640 135304128 4294500784 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6587/statm: 643 280 239 194 0 30 0
Current children cumulated CPU time (s) 0.03
Current children cumulated vsize (KiB) 5136

[startup+0.712405 s]
/proc/loadavg: 1.00 1.01 1.00 5/34 6587
/proc/meminfo: memFree=691356/1048576 swapFree=0/0
[pid=6586] ppid=6585 vsize=2564 CPUtime=0
/proc/6586/stat : 6586 (p2cudf-trendy-1) S 6585 6586 1511 34817 1511 4202496 374 0 0 0 0 0 0 0 25 0 1 0 1668595 2625536 270 1283457024 134512640 135304128 4288494592 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6586/statm: 641 270 230 194 0 28 0
[pid=6587] ppid=6586 vsize=2572 CPUtime=0.03
/proc/6587/stat : 6587 (p2cudf) S 6586 6586 1511 34817 1511 4202496 392 3013 0 1 0 0 1 2 25 0 1 0 1668595 2633728 280 1283457024 134512640 135304128 4294500784 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6587/statm: 643 280 239 194 0 30 0
Current children cumulated CPU time (s) 0.03
Current children cumulated vsize (KiB) 5136

[startup+1.51261 s]
/proc/loadavg: 1.08 1.03 1.01 3/45 6609
/proc/meminfo: memFree=633812/1048576 swapFree=0/0
[pid=6586] ppid=6585 vsize=2564 CPUtime=0
/proc/6586/stat : 6586 (p2cudf-trendy-1) S 6585 6586 1511 34817 1511 4202496 374 0 0 0 0 0 0 0 25 0 1 0 1668595 2625536 270 1283457024 134512640 135304128 4288494592 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6586/statm: 641 270 230 194 0 28 0
[pid=6587] ppid=6586 vsize=2572 CPUtime=0.03
/proc/6587/stat : 6587 (p2cudf) S 6586 6586 1511 34817 1511 4202496 392 3013 0 1 0 0 1 2 25 0 1 0 1668595 2633728 280 1283457024 134512640 135304128 4294500784 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6587/statm: 643 280 239 194 0 30 0
[pid=6600] ppid=6587 vsize=896332 CPUtime=1.46
/proc/6600/stat : 6600 (java) S 6587 6586 1511 34817 1511 4202496 25099 0 1 0 134 12 0 0 25 0 10 0 1668598 917843968 21269 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/6600/statm: 224083 21269 1723 10 0 221174 0
[pid=6600/tid=6601] ppid=6587 vsize=896332 CPUtime=0.77
/proc/6600/task/6601/stat : 6601 (java) R 6587 6586 1511 34817 1511 4202560 10808 0 1 0 69 8 0 0 25 0 10 0 1668599 917843968 21269 1283457024 134512640 134550932 4293541728 18446744073709551615 4095373095 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=6600/tid=6602] ppid=6587 vsize=896332 CPUtime=0
/proc/6600/task/6602/stat : 6602 (java) S 6587 6586 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 16 0 10 0 1668600 917843968 21269 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 0 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6603] ppid=6587 vsize=896332 CPUtime=0
/proc/6600/task/6603/stat : 6603 (java) S 6587 6586 1511 34817 1511 4202560 8 0 0 0 0 0 0 0 25 0 10 0 1668601 917843968 21269 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6604] ppid=6587 vsize=896332 CPUtime=0
/proc/6600/task/6604/stat : 6604 (java) S 6587 6586 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 10 0 1668601 917843968 21269 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6605] ppid=6587 vsize=896332 CPUtime=0
/proc/6600/task/6605/stat : 6605 (java) S 6587 6586 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 1668603 917843968 21269 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6606] ppid=6587 vsize=896332 CPUtime=0.48
/proc/6600/task/6606/stat : 6606 (java) R 6587 6586 1511 34817 1511 4202560 7993 0 0 0 47 1 0 0 25 0 10 0 1668603 917843968 21269 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=6600/tid=6607] ppid=6587 vsize=896332 CPUtime=0.2
/proc/6600/task/6607/stat : 6607 (java) R 6587 6586 1511 34817 1511 4202560 5217 0 0 0 18 2 0 0 18 0 10 0 1668603 917843968 21269 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=6600/tid=6608] ppid=6587 vsize=896332 CPUtime=0
/proc/6600/task/6608/stat : 6608 (java) S 6587 6586 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 1668603 917843968 21269 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6609] ppid=6587 vsize=896332 CPUtime=0
/proc/6600/task/6609/stat : 6609 (java) S 6587 6586 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 10 0 1668603 917843968 21269 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 1.49
Current children cumulated vsize (KiB) 901468

[startup+3.11828 s]
/proc/loadavg: 1.08 1.03 1.01 2/45 6609
/proc/meminfo: memFree=537836/1048576 swapFree=0/0
[pid=6586] ppid=6585 vsize=2564 CPUtime=0
/proc/6586/stat : 6586 (p2cudf-trendy-1) S 6585 6586 1511 34817 1511 4202496 374 0 0 0 0 0 0 0 25 0 1 0 1668595 2625536 270 1283457024 134512640 135304128 4288494592 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6586/statm: 641 270 230 194 0 28 0
[pid=6587] ppid=6586 vsize=2572 CPUtime=0.03
/proc/6587/stat : 6587 (p2cudf) S 6586 6586 1511 34817 1511 4202496 392 3013 0 1 0 0 1 2 25 0 1 0 1668595 2633728 280 1283457024 134512640 135304128 4294500784 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6587/statm: 643 280 239 194 0 30 0
[pid=6600] ppid=6587 vsize=896484 CPUtime=3.07
/proc/6600/stat : 6600 (java) S 6587 6586 1511 34817 1511 4202496 58296 0 1 0 280 27 0 0 25 0 10 0 1668598 917999616 52148 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/6600/statm: 224121 52148 1749 10 0 221212 0
[pid=6600/tid=6601] ppid=6587 vsize=896484 CPUtime=1.39
/proc/6600/task/6601/stat : 6601 (java) R 6587 6586 1511 34817 1511 4202560 40854 0 1 0 119 20 0 0 25 0 10 0 1668599 917999616 52148 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=6600/tid=6602] ppid=6587 vsize=896484 CPUtime=0
/proc/6600/task/6602/stat : 6602 (java) S 6587 6586 1511 34817 1511 4202560 7 0 0 0 0 0 0 0 15 0 10 0 1668600 917999616 52148 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 0 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6603] ppid=6587 vsize=896484 CPUtime=0
/proc/6600/task/6603/stat : 6603 (java) S 6587 6586 1511 34817 1511 4202560 8 0 0 0 0 0 0 0 25 0 10 0 1668601 917999616 52148 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6604] ppid=6587 vsize=896484 CPUtime=0
/proc/6600/task/6604/stat : 6604 (java) S 6587 6586 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 10 0 1668601 917999616 52148 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6605] ppid=6587 vsize=896484 CPUtime=0
/proc/6600/task/6605/stat : 6605 (java) S 6587 6586 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 1668603 917999616 52148 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6606] ppid=6587 vsize=896484 CPUtime=0.8
/proc/6600/task/6606/stat : 6606 (java) R 6587 6586 1511 34817 1511 4202560 8740 0 0 0 79 1 0 0 22 0 10 0 1668603 917999616 52148 1283457024 134512640 134550932 4293541728 18446744073709551615 4153511629 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=6600/tid=6607] ppid=6587 vsize=896484 CPUtime=0.85
/proc/6600/task/6607/stat : 6607 (java) S 6587 6586 1511 34817 1511 4202560 7620 0 0 0 81 4 0 0 15 0 10 0 1668603 917999616 52148 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6608] ppid=6587 vsize=896484 CPUtime=0
/proc/6600/task/6608/stat : 6608 (java) S 6587 6586 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 1668603 917999616 52148 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6609] ppid=6587 vsize=896484 CPUtime=0
/proc/6600/task/6609/stat : 6609 (java) S 6587 6586 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 10 0 1668603 917999616 52148 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 3.1
Current children cumulated vsize (KiB) 901620

[startup+6.31371 s]
/proc/loadavg: 1.15 1.04 1.01 3/46 6610
/proc/meminfo: memFree=410364/1048576 swapFree=0/0
[pid=6586] ppid=6585 vsize=2564 CPUtime=0
/proc/6586/stat : 6586 (p2cudf-trendy-1) S 6585 6586 1511 34817 1511 4202496 374 0 0 0 0 0 0 0 25 0 1 0 1668595 2625536 270 1283457024 134512640 135304128 4288494592 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6586/statm: 641 270 230 194 0 28 0
[pid=6587] ppid=6586 vsize=2572 CPUtime=0.03
/proc/6587/stat : 6587 (p2cudf) S 6586 6586 1511 34817 1511 4202496 392 3013 0 1 0 0 1 2 25 0 1 0 1668595 2633728 280 1283457024 134512640 135304128 4294500784 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6587/statm: 643 280 239 194 0 30 0
[pid=6600] ppid=6587 vsize=896260 CPUtime=6.27
/proc/6600/stat : 6600 (java) S 6587 6586 1511 34817 1511 4202496 79298 0 1 0 593 34 0 0 25 0 11 0 1668598 917770240 71710 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/6600/statm: 224065 71710 1779 10 0 221156 0
[pid=6600/tid=6601] ppid=6587 vsize=896260 CPUtime=2.96
/proc/6600/task/6601/stat : 6601 (java) R 6587 6586 1511 34817 1511 4202560 50276 0 1 0 274 22 0 0 25 0 11 0 1668599 917770240 71710 1283457024 134512640 134550932 4293541728 18446744073709551615 4096565643 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=6600/tid=6602] ppid=6587 vsize=896260 CPUtime=0.23
/proc/6600/task/6602/stat : 6602 (java) S 6587 6586 1511 34817 1511 4202560 9918 0 0 0 21 2 0 0 15 0 11 0 1668600 917770240 71710 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 0 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6603] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6603/stat : 6603 (java) S 6587 6586 1511 34817 1511 4202560 8 0 0 0 0 0 0 0 18 0 11 0 1668601 917770240 71710 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6604] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6604/stat : 6604 (java) S 6587 6586 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 1668601 917770240 71710 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6605] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6605/stat : 6605 (java) S 6587 6586 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1668603 917770240 71710 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6606] ppid=6587 vsize=896260 CPUtime=1.78
/proc/6600/task/6606/stat : 6606 (java) S 6587 6586 1511 34817 1511 4202560 10347 0 0 0 174 4 0 0 23 0 11 0 1668603 917770240 71710 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6607] ppid=6587 vsize=896260 CPUtime=1.28
/proc/6600/task/6607/stat : 6607 (java) S 6587 6586 1511 34817 1511 4202560 7676 0 0 0 124 4 0 0 15 0 11 0 1668603 917770240 71710 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6608] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6608/stat : 6608 (java) S 6587 6586 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1668603 917770240 71710 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6609] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6609/stat : 6609 (java) S 6587 6586 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 1668603 917770240 71710 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6610] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6610/stat : 6610 (java) S 6587 6586 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 23 0 11 0 1669041 917770240 71710 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 6.3
Current children cumulated vsize (KiB) 901396

[startup+12.7046 s]
/proc/loadavg: 1.14 1.04 1.01 2/46 6610
/proc/meminfo: memFree=383084/1048576 swapFree=0/0
[pid=6586] ppid=6585 vsize=2564 CPUtime=0
/proc/6586/stat : 6586 (p2cudf-trendy-1) S 6585 6586 1511 34817 1511 4202496 374 0 0 0 0 0 0 0 25 0 1 0 1668595 2625536 270 1283457024 134512640 135304128 4288494592 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6586/statm: 641 270 230 194 0 28 0
[pid=6587] ppid=6586 vsize=2572 CPUtime=0.03
/proc/6587/stat : 6587 (p2cudf) S 6586 6586 1511 34817 1511 4202496 392 3013 0 1 0 0 1 2 25 0 1 0 1668595 2633728 280 1283457024 134512640 135304128 4294500784 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6587/statm: 643 280 239 194 0 30 0
[pid=6600] ppid=6587 vsize=896260 CPUtime=12.66
/proc/6600/stat : 6600 (java) S 6587 6586 1511 34817 1511 4202496 86557 0 1 0 1232 34 0 0 25 0 11 0 1668598 917770240 78969 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/6600/statm: 224065 78969 1784 10 0 221156 0
[pid=6600/tid=6601] ppid=6587 vsize=896260 CPUtime=8.83
/proc/6600/task/6601/stat : 6601 (java) R 6587 6586 1511 34817 1511 4202560 50278 0 1 0 861 22 0 0 25 0 11 0 1668599 917770240 78969 1283457024 134512640 134550932 4293541728 18446744073709551615 4096545159 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=6600/tid=6602] ppid=6587 vsize=896260 CPUtime=0.64
/proc/6600/task/6602/stat : 6602 (java) S 6587 6586 1511 34817 1511 4202560 17155 0 0 0 62 2 0 0 16 0 11 0 1668600 917770240 78969 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 0 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6603] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6603/stat : 6603 (java) S 6587 6586 1511 34817 1511 4202560 8 0 0 0 0 0 0 0 18 0 11 0 1668601 917770240 78969 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6604] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6604/stat : 6604 (java) S 6587 6586 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 1668601 917770240 78969 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6605] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6605/stat : 6605 (java) S 6587 6586 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1668603 917770240 78969 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6606] ppid=6587 vsize=896260 CPUtime=1.88
/proc/6600/task/6606/stat : 6606 (java) S 6587 6586 1511 34817 1511 4202560 10367 0 0 0 184 4 0 0 15 0 11 0 1668603 917770240 78969 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6607] ppid=6587 vsize=896260 CPUtime=1.28
/proc/6600/task/6607/stat : 6607 (java) S 6587 6586 1511 34817 1511 4202560 7676 0 0 0 124 4 0 0 15 0 11 0 1668603 917770240 78969 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6608] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6608/stat : 6608 (java) S 6587 6586 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1668603 917770240 78969 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6609] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6609/stat : 6609 (java) S 6587 6586 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 1668603 917770240 78969 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6610] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6610/stat : 6610 (java) S 6587 6586 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 23 0 11 0 1669041 917770240 78969 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 12.69
Current children cumulated vsize (KiB) 901396

[startup+25.5077 s]
/proc/loadavg: 1.11 1.04 1.01 4/46 6610
/proc/meminfo: memFree=379240/1048576 swapFree=0/0
[pid=6586] ppid=6585 vsize=2564 CPUtime=0
/proc/6586/stat : 6586 (p2cudf-trendy-1) S 6585 6586 1511 34817 1511 4202496 374 0 0 0 0 0 0 0 25 0 1 0 1668595 2625536 270 1283457024 134512640 135304128 4288494592 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6586/statm: 641 270 230 194 0 28 0
[pid=6587] ppid=6586 vsize=2572 CPUtime=0.03
/proc/6587/stat : 6587 (p2cudf) S 6586 6586 1511 34817 1511 4202496 392 3013 0 1 0 0 1 2 25 0 1 0 1668595 2633728 280 1283457024 134512640 135304128 4294500784 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6587/statm: 643 280 239 194 0 30 0
[pid=6600] ppid=6587 vsize=896260 CPUtime=25.46
/proc/6600/stat : 6600 (java) S 6587 6586 1511 34817 1511 4202496 87197 0 1 0 2512 34 0 0 25 0 11 0 1668598 917770240 79609 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/6600/statm: 224065 79609 1784 10 0 221156 0
[pid=6600/tid=6601] ppid=6587 vsize=896260 CPUtime=21.04
/proc/6600/task/6601/stat : 6601 (java) R 6587 6586 1511 34817 1511 4202560 50278 0 1 0 2082 22 0 0 25 0 11 0 1668599 917770240 79609 1283457024 134512640 134550932 4293541728 18446744073709551615 4096367694 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=6600/tid=6602] ppid=6587 vsize=896260 CPUtime=1.18
/proc/6600/task/6602/stat : 6602 (java) S 6587 6586 1511 34817 1511 4202560 17786 0 0 0 116 2 0 0 16 0 11 0 1668600 917770240 79609 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 0 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6603] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6603/stat : 6603 (java) S 6587 6586 1511 34817 1511 4202560 8 0 0 0 0 0 0 0 18 0 11 0 1668601 917770240 79609 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6604] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6604/stat : 6604 (java) S 6587 6586 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 1668601 917770240 79609 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6605] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6605/stat : 6605 (java) S 6587 6586 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1668603 917770240 79609 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6606] ppid=6587 vsize=896260 CPUtime=1.93
/proc/6600/task/6606/stat : 6606 (java) S 6587 6586 1511 34817 1511 4202560 10376 0 0 0 189 4 0 0 16 0 11 0 1668603 917770240 79609 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6607] ppid=6587 vsize=896260 CPUtime=1.28
/proc/6600/task/6607/stat : 6607 (java) S 6587 6586 1511 34817 1511 4202560 7676 0 0 0 124 4 0 0 15 0 11 0 1668603 917770240 79609 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6608] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6608/stat : 6608 (java) S 6587 6586 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1668603 917770240 79609 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6609] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6609/stat : 6609 (java) S 6587 6586 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 1668603 917770240 79609 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6610] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6610/stat : 6610 (java) S 6587 6586 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 23 0 11 0 1669041 917770240 79609 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 25.49
Current children cumulated vsize (KiB) 901396

[startup+51.1128 s]
/proc/loadavg: 1.07 1.04 1.01 2/46 6610
/proc/meminfo: memFree=377628/1048576 swapFree=0/0
[pid=6586] ppid=6585 vsize=2564 CPUtime=0
/proc/6586/stat : 6586 (p2cudf-trendy-1) S 6585 6586 1511 34817 1511 4202496 374 0 0 0 0 0 0 0 25 0 1 0 1668595 2625536 270 1283457024 134512640 135304128 4288494592 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6586/statm: 641 270 230 194 0 28 0
[pid=6587] ppid=6586 vsize=2572 CPUtime=0.03
/proc/6587/stat : 6587 (p2cudf) S 6586 6586 1511 34817 1511 4202496 392 3013 0 1 0 0 1 2 25 0 1 0 1668595 2633728 280 1283457024 134512640 135304128 4294500784 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6587/statm: 643 280 239 194 0 30 0
[pid=6600] ppid=6587 vsize=896260 CPUtime=51.04
/proc/6600/stat : 6600 (java) S 6587 6586 1511 34817 1511 4202496 87421 0 1 0 5069 35 0 0 25 0 11 0 1668598 917770240 79833 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/6600/statm: 224065 79833 1784 10 0 221156 0
[pid=6600/tid=6601] ppid=6587 vsize=896260 CPUtime=45.9
/proc/6600/task/6601/stat : 6601 (java) R 6587 6586 1511 34817 1511 4202560 50278 0 1 0 4566 24 0 0 25 0 11 0 1668599 917770240 79833 1283457024 134512640 134550932 4293541728 18446744073709551615 4096453211 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=6600/tid=6602] ppid=6587 vsize=896260 CPUtime=1.92
/proc/6600/task/6602/stat : 6602 (java) S 6587 6586 1511 34817 1511 4202560 18010 0 0 0 190 2 0 0 15 0 11 0 1668600 917770240 79833 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 0 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6603] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6603/stat : 6603 (java) S 6587 6586 1511 34817 1511 4202560 8 0 0 0 0 0 0 0 18 0 11 0 1668601 917770240 79833 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6604] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6604/stat : 6604 (java) S 6587 6586 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 1668601 917770240 79833 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6605] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6605/stat : 6605 (java) S 6587 6586 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1668603 917770240 79833 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6606] ppid=6587 vsize=896260 CPUtime=1.93
/proc/6600/task/6606/stat : 6606 (java) S 6587 6586 1511 34817 1511 4202560 10376 0 0 0 189 4 0 0 16 0 11 0 1668603 917770240 79833 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6607] ppid=6587 vsize=896260 CPUtime=1.28
/proc/6600/task/6607/stat : 6607 (java) S 6587 6586 1511 34817 1511 4202560 7676 0 0 0 124 4 0 0 15 0 11 0 1668603 917770240 79833 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6608] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6608/stat : 6608 (java) S 6587 6586 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1668603 917770240 79833 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6609] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6609/stat : 6609 (java) S 6587 6586 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 1668603 917770240 79833 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6610] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6610/stat : 6610 (java) S 6587 6586 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 23 0 11 0 1669041 917770240 79833 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 51.07
Current children cumulated vsize (KiB) 901396

[startup+102.305 s]
/proc/loadavg: 1.03 1.03 1.00 2/46 6610
/proc/meminfo: memFree=373536/1048576 swapFree=0/0
[pid=6586] ppid=6585 vsize=2564 CPUtime=0
/proc/6586/stat : 6586 (p2cudf-trendy-1) S 6585 6586 1511 34817 1511 4202496 374 0 0 0 0 0 0 0 25 0 1 0 1668595 2625536 270 1283457024 134512640 135304128 4288494592 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6586/statm: 641 270 230 194 0 28 0
[pid=6587] ppid=6586 vsize=2572 CPUtime=0.03
/proc/6587/stat : 6587 (p2cudf) S 6586 6586 1511 34817 1511 4202496 392 3013 0 1 0 0 1 2 25 0 1 0 1668595 2633728 280 1283457024 134512640 135304128 4294500784 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6587/statm: 643 280 239 194 0 30 0
[pid=6600] ppid=6587 vsize=896260 CPUtime=102.2
/proc/6600/stat : 6600 (java) S 6587 6586 1511 34817 1511 4202496 88420 0 1 0 10185 35 0 0 25 0 11 0 1668598 917770240 80832 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/6600/statm: 224065 80832 1784 10 0 221156 0
[pid=6600/tid=6601] ppid=6587 vsize=896260 CPUtime=96.08
/proc/6600/task/6601/stat : 6601 (java) R 6587 6586 1511 34817 1511 4202560 50278 0 1 0 9584 24 0 0 25 0 11 0 1668599 917770240 80832 1283457024 134512640 134550932 4293541728 18446744073709551615 4096468770 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=6600/tid=6602] ppid=6587 vsize=896260 CPUtime=2.87
/proc/6600/task/6602/stat : 6602 (java) S 6587 6586 1511 34817 1511 4202560 19009 0 0 0 285 2 0 0 15 0 11 0 1668600 917770240 80832 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 0 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6603] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6603/stat : 6603 (java) S 6587 6586 1511 34817 1511 4202560 8 0 0 0 0 0 0 0 18 0 11 0 1668601 917770240 80832 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6604] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6604/stat : 6604 (java) S 6587 6586 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 1668601 917770240 80832 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6605] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6605/stat : 6605 (java) S 6587 6586 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1668603 917770240 80832 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6606] ppid=6587 vsize=896260 CPUtime=1.95
/proc/6600/task/6606/stat : 6606 (java) S 6587 6586 1511 34817 1511 4202560 10376 0 0 0 191 4 0 0 15 0 11 0 1668603 917770240 80832 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6607] ppid=6587 vsize=896260 CPUtime=1.28
/proc/6600/task/6607/stat : 6607 (java) S 6587 6586 1511 34817 1511 4202560 7676 0 0 0 124 4 0 0 15 0 11 0 1668603 917770240 80832 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6608] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6608/stat : 6608 (java) S 6587 6586 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1668603 917770240 80832 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6609] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6609/stat : 6609 (java) S 6587 6586 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 1668603 917770240 80832 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6610] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6610/stat : 6610 (java) S 6587 6586 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 23 0 11 0 1669041 917770240 80832 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 102.23
Current children cumulated vsize (KiB) 901396

[startup+162.308 s]
/proc/loadavg: 1.01 1.02 1.00 2/46 6610
/proc/meminfo: memFree=371800/1048576 swapFree=0/0
[pid=6586] ppid=6585 vsize=2564 CPUtime=0
/proc/6586/stat : 6586 (p2cudf-trendy-1) S 6585 6586 1511 34817 1511 4202496 374 0 0 0 0 0 0 0 25 0 1 0 1668595 2625536 270 1283457024 134512640 135304128 4288494592 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6586/statm: 641 270 230 194 0 28 0
[pid=6587] ppid=6586 vsize=2572 CPUtime=0.03
/proc/6587/stat : 6587 (p2cudf) S 6586 6586 1511 34817 1511 4202496 392 3013 0 1 0 0 1 2 25 0 1 0 1668595 2633728 280 1283457024 134512640 135304128 4294500784 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6587/statm: 643 280 239 194 0 30 0
[pid=6600] ppid=6587 vsize=896260 CPUtime=162.17
/proc/6600/stat : 6600 (java) S 6587 6586 1511 34817 1511 4202496 88845 0 1 0 16181 36 0 0 25 0 11 0 1668598 917770240 81257 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/6600/statm: 224065 81257 1784 10 0 221156 0
[pid=6600/tid=6601] ppid=6587 vsize=896260 CPUtime=154.87
/proc/6600/task/6601/stat : 6601 (java) R 6587 6586 1511 34817 1511 4202560 50278 0 1 0 15462 25 0 0 25 0 11 0 1668599 917770240 81257 1283457024 134512640 134550932 4293541728 18446744073709551615 4096545101 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=6600/tid=6602] ppid=6587 vsize=896260 CPUtime=4.05
/proc/6600/task/6602/stat : 6602 (java) S 6587 6586 1511 34817 1511 4202560 19434 0 0 0 403 2 0 0 16 0 11 0 1668600 917770240 81257 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 0 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6603] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6603/stat : 6603 (java) S 6587 6586 1511 34817 1511 4202560 8 0 0 0 0 0 0 0 18 0 11 0 1668601 917770240 81257 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6604] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6604/stat : 6604 (java) S 6587 6586 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 1668601 917770240 81257 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6605] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6605/stat : 6605 (java) S 6587 6586 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1668603 917770240 81257 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6606] ppid=6587 vsize=896260 CPUtime=1.95
/proc/6600/task/6606/stat : 6606 (java) S 6587 6586 1511 34817 1511 4202560 10376 0 0 0 191 4 0 0 15 0 11 0 1668603 917770240 81257 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6607] ppid=6587 vsize=896260 CPUtime=1.28
/proc/6600/task/6607/stat : 6607 (java) S 6587 6586 1511 34817 1511 4202560 7676 0 0 0 124 4 0 0 15 0 11 0 1668603 917770240 81257 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6608] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6608/stat : 6608 (java) S 6587 6586 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1668603 917770240 81257 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6609] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6609/stat : 6609 (java) S 6587 6586 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 1668603 917770240 81257 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6610] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6610/stat : 6610 (java) S 6587 6586 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 23 0 11 0 1669041 917770240 81257 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 162.2
Current children cumulated vsize (KiB) 901396

[startup+222.311 s]
/proc/loadavg: 1.04 1.03 1.00 2/48 6612
/proc/meminfo: memFree=369420/1048576 swapFree=0/0
[pid=6586] ppid=6585 vsize=2564 CPUtime=0
/proc/6586/stat : 6586 (p2cudf-trendy-1) S 6585 6586 1511 34817 1511 4202496 374 0 0 0 0 0 0 0 25 0 1 0 1668595 2625536 270 1283457024 134512640 135304128 4288494592 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6586/statm: 641 270 230 194 0 28 0
[pid=6587] ppid=6586 vsize=2572 CPUtime=0.03
/proc/6587/stat : 6587 (p2cudf) S 6586 6586 1511 34817 1511 4202496 392 3013 0 1 0 0 1 2 25 0 1 0 1668595 2633728 280 1283457024 134512640 135304128 4294500784 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6587/statm: 643 280 239 194 0 30 0
[pid=6600] ppid=6587 vsize=896260 CPUtime=222.13
/proc/6600/stat : 6600 (java) S 6587 6586 1511 34817 1511 4202496 89368 0 1 0 22175 38 0 0 25 0 11 0 1668598 917770240 81780 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/6600/statm: 224065 81780 1784 10 0 221156 0
[pid=6600/tid=6601] ppid=6587 vsize=896260 CPUtime=214.03
/proc/6600/task/6601/stat : 6601 (java) R 6587 6586 1511 34817 1511 4202560 50278 0 1 0 21377 26 0 0 25 0 11 0 1668599 917770240 81780 1283457024 134512640 134550932 4293541728 18446744073709551615 4096453200 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=6600/tid=6602] ppid=6587 vsize=896260 CPUtime=4.84
/proc/6600/task/6602/stat : 6602 (java) S 6587 6586 1511 34817 1511 4202560 19957 0 0 0 482 2 0 0 15 0 11 0 1668600 917770240 81780 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 0 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6603] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6603/stat : 6603 (java) S 6587 6586 1511 34817 1511 4202560 8 0 0 0 0 0 0 0 18 0 11 0 1668601 917770240 81780 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6604] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6604/stat : 6604 (java) S 6587 6586 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 1668601 917770240 81780 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6605] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6605/stat : 6605 (java) S 6587 6586 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1668603 917770240 81780 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6606] ppid=6587 vsize=896260 CPUtime=1.95
/proc/6600/task/6606/stat : 6606 (java) S 6587 6586 1511 34817 1511 4202560 10376 0 0 0 191 4 0 0 15 0 11 0 1668603 917770240 81780 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6607] ppid=6587 vsize=896260 CPUtime=1.28
/proc/6600/task/6607/stat : 6607 (java) S 6587 6586 1511 34817 1511 4202560 7676 0 0 0 124 4 0 0 15 0 11 0 1668603 917770240 81780 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6608] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6608/stat : 6608 (java) S 6587 6586 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1668603 917770240 81780 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6609] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6609/stat : 6609 (java) S 6587 6586 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 1668603 917770240 81780 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6610] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6610/stat : 6610 (java) S 6587 6586 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 23 0 11 0 1669041 917770240 81780 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 222.16
Current children cumulated vsize (KiB) 901396

[startup+282.316 s]
/proc/loadavg: 1.01 1.02 1.00 3/48 6618
/proc/meminfo: memFree=368056/1048576 swapFree=0/0
[pid=6586] ppid=6585 vsize=2564 CPUtime=0
/proc/6586/stat : 6586 (p2cudf-trendy-1) S 6585 6586 1511 34817 1511 4202496 374 0 0 0 0 0 0 0 25 0 1 0 1668595 2625536 270 1283457024 134512640 135304128 4288494592 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6586/statm: 641 270 230 194 0 28 0
[pid=6587] ppid=6586 vsize=2572 CPUtime=0.03
/proc/6587/stat : 6587 (p2cudf) S 6586 6586 1511 34817 1511 4202496 392 3013 0 1 0 0 1 2 25 0 1 0 1668595 2633728 280 1283457024 134512640 135304128 4294500784 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6587/statm: 643 280 239 194 0 30 0
[pid=6600] ppid=6587 vsize=896260 CPUtime=282.09
/proc/6600/stat : 6600 (java) S 6587 6586 1511 34817 1511 4202496 89714 0 1 0 28171 38 0 0 25 0 11 0 1668598 917770240 82126 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/6600/statm: 224065 82126 1784 10 0 221156 0
[pid=6600/tid=6601] ppid=6587 vsize=896260 CPUtime=273.6
/proc/6600/task/6601/stat : 6601 (java) R 6587 6586 1511 34817 1511 4202560 50278 0 1 0 27333 27 0 0 25 0 11 0 1668599 917770240 82126 1283457024 134512640 134550932 4293541728 18446744073709551615 4095713252 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=6600/tid=6602] ppid=6587 vsize=896260 CPUtime=5.23
/proc/6600/task/6602/stat : 6602 (java) S 6587 6586 1511 34817 1511 4202560 20303 0 0 0 521 2 0 0 15 0 11 0 1668600 917770240 82126 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 0 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6603] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6603/stat : 6603 (java) S 6587 6586 1511 34817 1511 4202560 8 0 0 0 0 0 0 0 18 0 11 0 1668601 917770240 82126 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6604] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6604/stat : 6604 (java) S 6587 6586 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 1668601 917770240 82126 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6605] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6605/stat : 6605 (java) S 6587 6586 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1668603 917770240 82126 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6606] ppid=6587 vsize=896260 CPUtime=1.95
/proc/6600/task/6606/stat : 6606 (java) S 6587 6586 1511 34817 1511 4202560 10376 0 0 0 191 4 0 0 15 0 11 0 1668603 917770240 82126 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6607] ppid=6587 vsize=896260 CPUtime=1.28
/proc/6600/task/6607/stat : 6607 (java) S 6587 6586 1511 34817 1511 4202560 7676 0 0 0 124 4 0 0 15 0 11 0 1668603 917770240 82126 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6608] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6608/stat : 6608 (java) S 6587 6586 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1668603 917770240 82126 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6609] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6609/stat : 6609 (java) S 6587 6586 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 1668603 917770240 82126 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6610] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6610/stat : 6610 (java) S 6587 6586 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 23 0 11 0 1669041 917770240 82126 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 282.12
Current children cumulated vsize (KiB) 901396

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

[startup+283.216 s]
/proc/loadavg: 1.01 1.02 1.00 2/48 6618
/proc/meminfo: memFree=368056/1048576 swapFree=0/0
[pid=6586] ppid=6585 vsize=2564 CPUtime=0
/proc/6586/stat : 6586 (p2cudf-trendy-1) S 6585 6586 1511 34817 1511 4202496 374 0 0 0 0 0 0 0 25 0 1 0 1668595 2625536 270 1283457024 134512640 135304128 4288494592 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6586/statm: 641 270 230 194 0 28 0
[pid=6587] ppid=6586 vsize=2572 CPUtime=0.03
/proc/6587/stat : 6587 (p2cudf) S 6586 6586 1511 34817 1511 4202496 392 3013 0 1 0 0 1 2 25 0 1 0 1668595 2633728 280 1283457024 134512640 135304128 4294500784 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6587/statm: 643 280 239 194 0 30 0
[pid=6600] ppid=6587 vsize=896260 CPUtime=282.99
/proc/6600/stat : 6600 (java) S 6587 6586 1511 34817 1511 4202496 89714 0 1 0 28261 38 0 0 25 0 11 0 1668598 917770240 82126 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/6600/statm: 224065 82126 1784 10 0 221156 0
[pid=6600/tid=6601] ppid=6587 vsize=896260 CPUtime=274.5
/proc/6600/task/6601/stat : 6601 (java) R 6587 6586 1511 34817 1511 4202560 50278 0 1 0 27423 27 0 0 25 0 11 0 1668599 917770240 82126 1283457024 134512640 134550932 4293541728 18446744073709551615 4096545167 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=6600/tid=6602] ppid=6587 vsize=896260 CPUtime=5.23
/proc/6600/task/6602/stat : 6602 (java) S 6587 6586 1511 34817 1511 4202560 20303 0 0 0 521 2 0 0 15 0 11 0 1668600 917770240 82126 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 0 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6603] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6603/stat : 6603 (java) S 6587 6586 1511 34817 1511 4202560 8 0 0 0 0 0 0 0 18 0 11 0 1668601 917770240 82126 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6604] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6604/stat : 6604 (java) S 6587 6586 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 1668601 917770240 82126 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6605] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6605/stat : 6605 (java) S 6587 6586 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1668603 917770240 82126 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6606] ppid=6587 vsize=896260 CPUtime=1.95
/proc/6600/task/6606/stat : 6606 (java) S 6587 6586 1511 34817 1511 4202560 10376 0 0 0 191 4 0 0 15 0 11 0 1668603 917770240 82126 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6607] ppid=6587 vsize=896260 CPUtime=1.28
/proc/6600/task/6607/stat : 6607 (java) S 6587 6586 1511 34817 1511 4202560 7676 0 0 0 124 4 0 0 15 0 11 0 1668603 917770240 82126 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6608] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6608/stat : 6608 (java) S 6587 6586 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1668603 917770240 82126 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6609] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6609/stat : 6609 (java) S 6587 6586 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 1668603 917770240 82126 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6610] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6610/stat : 6610 (java) S 6587 6586 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 23 0 11 0 1669041 917770240 82126 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 283.02
Current children cumulated vsize (KiB) 901396

[startup+284.006 s]
/proc/loadavg: 1.01 1.02 1.00 2/48 6618
/proc/meminfo: memFree=368056/1048576 swapFree=0/0
[pid=6586] ppid=6585 vsize=2564 CPUtime=0
/proc/6586/stat : 6586 (p2cudf-trendy-1) S 6585 6586 1511 34817 1511 4202496 374 0 0 0 0 0 0 0 25 0 1 0 1668595 2625536 270 1283457024 134512640 135304128 4288494592 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6586/statm: 641 270 230 194 0 28 0
[pid=6587] ppid=6586 vsize=2572 CPUtime=0.03
/proc/6587/stat : 6587 (p2cudf) S 6586 6586 1511 34817 1511 4202496 392 3013 0 1 0 0 1 2 25 0 1 0 1668595 2633728 280 1283457024 134512640 135304128 4294500784 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6587/statm: 643 280 239 194 0 30 0
[pid=6600] ppid=6587 vsize=896260 CPUtime=283.78
/proc/6600/stat : 6600 (java) S 6587 6586 1511 34817 1511 4202496 89714 0 1 0 28340 38 0 0 25 0 11 0 1668598 917770240 82126 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/6600/statm: 224065 82126 1784 10 0 221156 0
[pid=6600/tid=6601] ppid=6587 vsize=896260 CPUtime=275.29
/proc/6600/task/6601/stat : 6601 (java) R 6587 6586 1511 34817 1511 4202560 50278 0 1 0 27502 27 0 0 25 0 11 0 1668599 917770240 82126 1283457024 134512640 134550932 4293541728 18446744073709551615 4096570340 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=6600/tid=6602] ppid=6587 vsize=896260 CPUtime=5.23
/proc/6600/task/6602/stat : 6602 (java) S 6587 6586 1511 34817 1511 4202560 20303 0 0 0 521 2 0 0 15 0 11 0 1668600 917770240 82126 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 0 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6603] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6603/stat : 6603 (java) S 6587 6586 1511 34817 1511 4202560 8 0 0 0 0 0 0 0 18 0 11 0 1668601 917770240 82126 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6604] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6604/stat : 6604 (java) S 6587 6586 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 1668601 917770240 82126 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6605] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6605/stat : 6605 (java) S 6587 6586 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1668603 917770240 82126 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6606] ppid=6587 vsize=896260 CPUtime=1.95
/proc/6600/task/6606/stat : 6606 (java) S 6587 6586 1511 34817 1511 4202560 10376 0 0 0 191 4 0 0 15 0 11 0 1668603 917770240 82126 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6607] ppid=6587 vsize=896260 CPUtime=1.28
/proc/6600/task/6607/stat : 6607 (java) S 6587 6586 1511 34817 1511 4202560 7676 0 0 0 124 4 0 0 15 0 11 0 1668603 917770240 82126 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6608] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6608/stat : 6608 (java) S 6587 6586 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1668603 917770240 82126 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6609] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6609/stat : 6609 (java) S 6587 6586 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 1668603 917770240 82126 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6610] ppid=6587 vsize=896260 CPUtime=0
/proc/6600/task/6610/stat : 6610 (java) S 6587 6586 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 23 0 11 0 1669041 917770240 82126 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 283.81
Current children cumulated vsize (KiB) 901396

[startup+284.806 s]
/proc/loadavg: 1.01 1.02 1.00 2/48 6618
/proc/meminfo: memFree=368056/1048576 swapFree=0/0
[pid=6586] ppid=6585 vsize=2564 CPUtime=0
/proc/6586/stat : 6586 (p2cudf-trendy-1) S 6585 6586 1511 34817 1511 4202496 374 0 0 0 0 0 0 0 25 0 1 0 1668595 2625536 270 1283457024 134512640 135304128 4288494592 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6586/statm: 641 270 230 194 0 28 0
[pid=6587] ppid=6586 vsize=2572 CPUtime=0.03
/proc/6587/stat : 6587 (p2cudf) S 6586 6586 1511 34817 1511 4202496 392 3013 0 1 0 0 1 2 25 0 1 0 1668595 2633728 280 1283457024 134512640 135304128 4294500784 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6587/statm: 643 280 239 194 0 30 0
[pid=6600] ppid=6587 vsize=896584 CPUtime=284.54
/proc/6600/stat : 6600 (java) S 6587 6586 1511 34817 1511 4202496 90182 0 1 0 28416 38 0 0 25 0 11 0 1668598 918102016 82594 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/6600/statm: 224146 82594 1785 10 0 221237 0
[pid=6600/tid=6601] ppid=6587 vsize=896584 CPUtime=275.83
/proc/6600/task/6601/stat : 6601 (java) S 6587 6586 1511 34817 1511 4202560 50286 0 1 0 27556 27 0 0 25 0 11 0 1668599 918102016 82594 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6602] ppid=6587 vsize=896584 CPUtime=5.43
/proc/6600/task/6602/stat : 6602 (java) S 6587 6586 1511 34817 1511 4202560 20758 0 0 0 541 2 0 0 16 0 11 0 1668600 918102016 82594 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 0 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6603] ppid=6587 vsize=896584 CPUtime=0
/proc/6600/task/6603/stat : 6603 (java) S 6587 6586 1511 34817 1511 4202560 8 0 0 0 0 0 0 0 18 0 11 0 1668601 918102016 82594 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6604] ppid=6587 vsize=896584 CPUtime=0
/proc/6600/task/6604/stat : 6604 (java) S 6587 6586 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 1668601 918102016 82594 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6605] ppid=6587 vsize=896584 CPUtime=0
/proc/6600/task/6605/stat : 6605 (java) S 6587 6586 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1668603 918102016 82594 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6606] ppid=6587 vsize=896584 CPUtime=1.98
/proc/6600/task/6606/stat : 6606 (java) S 6587 6586 1511 34817 1511 4202560 10376 0 0 0 194 4 0 0 15 0 11 0 1668603 918102016 82594 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6607] ppid=6587 vsize=896584 CPUtime=1.28
/proc/6600/task/6607/stat : 6607 (java) S 6587 6586 1511 34817 1511 4202560 7676 0 0 0 124 4 0 0 15 0 11 0 1668603 918102016 82594 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6608] ppid=6587 vsize=896584 CPUtime=0
/proc/6600/task/6608/stat : 6608 (java) S 6587 6586 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1668603 918102016 82594 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6609] ppid=6587 vsize=896584 CPUtime=0
/proc/6600/task/6609/stat : 6609 (java) S 6587 6586 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 1668603 918102016 82594 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 284.57
Current children cumulated vsize (KiB) 901720

[startup+285.206 s]
/proc/loadavg: 1.01 1.02 1.00 1/48 6619
/proc/meminfo: memFree=366072/1048576 swapFree=0/0
[pid=6586] ppid=6585 vsize=2564 CPUtime=0
/proc/6586/stat : 6586 (p2cudf-trendy-1) S 6585 6586 1511 34817 1511 4202496 374 0 0 0 0 0 0 0 25 0 1 0 1668595 2625536 270 1283457024 134512640 135304128 4288494592 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6586/statm: 641 270 230 194 0 28 0
[pid=6587] ppid=6586 vsize=2572 CPUtime=0.03
/proc/6587/stat : 6587 (p2cudf) S 6586 6586 1511 34817 1511 4202496 392 3013 0 1 0 0 1 2 25 0 1 0 1668595 2633728 280 1283457024 134512640 135304128 4294500784 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6587/statm: 643 280 239 194 0 30 0
[pid=6600] ppid=6587 vsize=896584 CPUtime=284.54
/proc/6600/stat : 6600 (java) S 6587 6586 1511 34817 1511 4202496 90182 0 1 0 28416 38 0 0 25 0 11 0 1668598 918102016 82594 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/6600/statm: 224146 82594 1785 10 0 221237 0
[pid=6600/tid=6601] ppid=6587 vsize=896584 CPUtime=275.83
/proc/6600/task/6601/stat : 6601 (java) S 6587 6586 1511 34817 1511 4202560 50286 0 1 0 27556 27 0 0 25 0 11 0 1668599 918102016 82594 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6602] ppid=6587 vsize=896584 CPUtime=5.43
/proc/6600/task/6602/stat : 6602 (java) S 6587 6586 1511 34817 1511 4202560 20758 0 0 0 541 2 0 0 16 0 11 0 1668600 918102016 82594 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 0 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6603] ppid=6587 vsize=896584 CPUtime=0
/proc/6600/task/6603/stat : 6603 (java) S 6587 6586 1511 34817 1511 4202560 8 0 0 0 0 0 0 0 18 0 11 0 1668601 918102016 82594 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6604] ppid=6587 vsize=896584 CPUtime=0
/proc/6600/task/6604/stat : 6604 (java) S 6587 6586 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 1668601 918102016 82594 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6605] ppid=6587 vsize=896584 CPUtime=0
/proc/6600/task/6605/stat : 6605 (java) S 6587 6586 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1668603 918102016 82594 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6606] ppid=6587 vsize=896584 CPUtime=1.98
/proc/6600/task/6606/stat : 6606 (java) S 6587 6586 1511 34817 1511 4202560 10376 0 0 0 194 4 0 0 15 0 11 0 1668603 918102016 82594 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6607] ppid=6587 vsize=896584 CPUtime=1.28
/proc/6600/task/6607/stat : 6607 (java) S 6587 6586 1511 34817 1511 4202560 7676 0 0 0 124 4 0 0 15 0 11 0 1668603 918102016 82594 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6608] ppid=6587 vsize=896584 CPUtime=0
/proc/6600/task/6608/stat : 6608 (java) S 6587 6586 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1668603 918102016 82594 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6609] ppid=6587 vsize=896584 CPUtime=0
/proc/6600/task/6609/stat : 6609 (java) S 6587 6586 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 1668603 918102016 82594 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6619] ppid=6587 vsize=896584 CPUtime=0
/proc/6600/task/6619/stat : 6619 (java) S 6587 6586 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 11 0 1697072 918102016 82594 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 284.57
Current children cumulated vsize (KiB) 901720

[startup+285.308 s]
/proc/loadavg: 1.01 1.02 1.00 1/48 6619
/proc/meminfo: memFree=366072/1048576 swapFree=0/0
[pid=6586] ppid=6585 vsize=2564 CPUtime=0
/proc/6586/stat : 6586 (p2cudf-trendy-1) S 6585 6586 1511 34817 1511 4202496 374 0 0 0 0 0 0 0 25 0 1 0 1668595 2625536 270 1283457024 134512640 135304128 4288494592 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6586/statm: 641 270 230 194 0 28 0
[pid=6587] ppid=6586 vsize=2572 CPUtime=0.03
/proc/6587/stat : 6587 (p2cudf) S 6586 6586 1511 34817 1511 4202496 392 3013 0 1 0 0 1 2 25 0 1 0 1668595 2633728 280 1283457024 134512640 135304128 4294500784 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/6587/statm: 643 280 239 194 0 30 0
[pid=6600] ppid=6587 vsize=896584 CPUtime=284.57
/proc/6600/stat : 6600 (java) S 6587 6586 1511 34817 1511 4202496 90183 0 1 0 28419 38 0 0 25 0 11 0 1668598 918102016 82595 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/6600/statm: 224146 82595 1785 10 0 221237 0
[pid=6600/tid=6601] ppid=6587 vsize=896584 CPUtime=275.83
/proc/6600/task/6601/stat : 6601 (java) S 6587 6586 1511 34817 1511 4202560 50286 0 1 0 27556 27 0 0 25 0 11 0 1668599 918102016 82595 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6602] ppid=6587 vsize=896584 CPUtime=5.43
/proc/6600/task/6602/stat : 6602 (java) S 6587 6586 1511 34817 1511 4202560 20758 0 0 0 541 2 0 0 16 0 11 0 1668600 918102016 82595 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 0 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6603] ppid=6587 vsize=896584 CPUtime=0
/proc/6600/task/6603/stat : 6603 (java) S 6587 6586 1511 34817 1511 4202560 8 0 0 0 0 0 0 0 18 0 11 0 1668601 918102016 82595 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6604] ppid=6587 vsize=896584 CPUtime=0
/proc/6600/task/6604/stat : 6604 (java) S 6587 6586 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 1668601 918102016 82595 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6605] ppid=6587 vsize=896584 CPUtime=0
/proc/6600/task/6605/stat : 6605 (java) S 6587 6586 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1668603 918102016 82595 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6606] ppid=6587 vsize=896584 CPUtime=1.98
/proc/6600/task/6606/stat : 6606 (java) S 6587 6586 1511 34817 1511 4202560 10376 0 0 0 194 4 0 0 15 0 11 0 1668603 918102016 82595 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6607] ppid=6587 vsize=896584 CPUtime=1.28
/proc/6600/task/6607/stat : 6607 (java) S 6587 6586 1511 34817 1511 4202560 7676 0 0 0 124 4 0 0 15 0 11 0 1668603 918102016 82595 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6608] ppid=6587 vsize=896584 CPUtime=0
/proc/6600/task/6608/stat : 6608 (java) S 6587 6586 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 1668603 918102016 82595 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6609] ppid=6587 vsize=896584 CPUtime=0
/proc/6600/task/6609/stat : 6609 (java) S 6587 6586 1511 34817 1511 4202560 2 0 0 0 0 0 0 0 15 0 11 0 1668603 918102016 82595 1283457024 134512640 134550932 4293541728 18446744073709551615 4294960130 0 4 0 16800975 18446612133234251008 0 0 -1 0 0 0 0
[pid=6600/tid=6619] ppid=6587 vsize=896584 CPUtime=0.02
/proc/6600/task/6619/stat : 6619 (java) R 6587 6586 1511 34817 1511 4202560 5 0 0 0 2 0 0 0 20 0 11 0 1697072 918102016 82595 1283457024 134512640 134550932 4293541728 18446744073709551615 4095435966 0 4 0 16800975 0 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 284.6
Current children cumulated vsize (KiB) 901720

Child status: 0
Real time (s): 285.394
CPU time (s): 284.678
CPU user time (s): 284.25
CPU system time (s): 0.428026
CPU usage (%): 99.749
Max. virtual memory (cumulated for all children) (KiB): 906520

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 284.25
system time used= 0.428026
maximum resident set size= 0
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 93988
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= 5945
involuntary context switches= 8716

runsolver used 0 second user time and 0.008 second system time

The end