runsolver Copyright (C) 2010 Olivier ROUSSEL

This is runsolver version 3.2.9a (svn: 651)

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

command line: /home/misc2010/bin/runsolver -s SIGUSR1 -M 1124 -C 290 -d 10 -w /home/misc2010/tmp/201108311143/p2cudf-user-1.13/rand283.cudf.user-upgrades.log.runsolver ./p2cudf-user-1.13 /home/misc2010/data/2011/user-upgrades/rand283.cudf /home/misc2010/tmp/201108311143/p2cudf-user-1.13/rand283.cudf.user-upgrades.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.92 0.98 0.99 6/38 22996
/proc/meminfo: memFree=674472/1048576 swapFree=0/0
[pid=22994] ppid=22993 vsize=2568 CPUtime=0
/proc/22994/stat : 22994 (p2cudf-user-1.1) S 22993 22994 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 62266181 2629632 270 1283457024 134512640 135304128 4292235120 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/22994/statm: 642 270 230 194 0 29 0
[pid=22995] ppid=22994 vsize=2568 CPUtime=0
/proc/22995/stat : 22995 (p2cudf) R 22994 22994 19908 34817 19908 4202496 346 0 0 0 0 0 0 0 25 0 1 0 62266181 2629632 272 1283457024 134512640 135304128 4292585456 18446744073709551615 4294960130 0 65538 4 65536 0 0 0 17 0 0 0 0
/proc/22995/statm: 642 272 231 194 0 29 0
[pid=22996] ppid=22995 vsize=2568 CPUtime=0
/proc/22996/stat : 22996 (p2cudf) R 22995 22994 19908 34817 19908 4202560 0 0 0 0 0 0 0 0 25 0 1 0 62266181 2629632 41 1283457024 134512640 135304128 4292585456 18446744073709551615 4294960130 0 65538 4 65536 0 0 0 17 0 0 0 0
/proc/22996/statm: 642 41 0 194 0 29 0

[startup+0.17702 s]
/proc/loadavg: 0.92 0.98 0.99 6/38 22996
/proc/meminfo: memFree=674472/1048576 swapFree=0/0
[pid=22994] ppid=22993 vsize=2568 CPUtime=0
/proc/22994/stat : 22994 (p2cudf-user-1.1) S 22993 22994 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 62266181 2629632 270 1283457024 134512640 135304128 4292235120 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/22994/statm: 642 270 230 194 0 29 0
[pid=22995] ppid=22994 vsize=2576 CPUtime=0.03
/proc/22995/stat : 22995 (p2cudf) S 22994 22994 19908 34817 19908 4202496 394 3016 0 1 0 0 1 2 25 0 1 0 62266181 2637824 282 1283457024 134512640 135304128 4292585456 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/22995/statm: 644 282 239 194 0 31 0
Current children cumulated CPU time (s) 0.03
Current children cumulated vsize (KiB) 5144

[startup+0.207015 s]
/proc/loadavg: 0.92 0.98 0.99 6/38 22996
/proc/meminfo: memFree=674472/1048576 swapFree=0/0
[pid=22994] ppid=22993 vsize=2568 CPUtime=0
/proc/22994/stat : 22994 (p2cudf-user-1.1) S 22993 22994 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 62266181 2629632 270 1283457024 134512640 135304128 4292235120 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/22994/statm: 642 270 230 194 0 29 0
[pid=22995] ppid=22994 vsize=2576 CPUtime=0.03
/proc/22995/stat : 22995 (p2cudf) S 22994 22994 19908 34817 19908 4202496 394 3016 0 1 0 0 1 2 25 0 1 0 62266181 2637824 282 1283457024 134512640 135304128 4292585456 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/22995/statm: 644 282 239 194 0 31 0
Current children cumulated CPU time (s) 0.03
Current children cumulated vsize (KiB) 5144

[startup+0.307054 s]
/proc/loadavg: 0.92 0.98 0.99 6/38 22996
/proc/meminfo: memFree=674472/1048576 swapFree=0/0
[pid=22994] ppid=22993 vsize=2568 CPUtime=0
/proc/22994/stat : 22994 (p2cudf-user-1.1) S 22993 22994 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 62266181 2629632 270 1283457024 134512640 135304128 4292235120 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/22994/statm: 642 270 230 194 0 29 0
[pid=22995] ppid=22994 vsize=2576 CPUtime=0.03
/proc/22995/stat : 22995 (p2cudf) S 22994 22994 19908 34817 19908 4202496 394 3016 0 1 0 0 1 2 25 0 1 0 62266181 2637824 282 1283457024 134512640 135304128 4292585456 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/22995/statm: 644 282 239 194 0 31 0
Current children cumulated CPU time (s) 0.03
Current children cumulated vsize (KiB) 5144

[startup+0.707147 s]
/proc/loadavg: 0.92 0.98 0.99 6/38 22996
/proc/meminfo: memFree=674472/1048576 swapFree=0/0
[pid=22994] ppid=22993 vsize=2568 CPUtime=0
/proc/22994/stat : 22994 (p2cudf-user-1.1) S 22993 22994 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 62266181 2629632 270 1283457024 134512640 135304128 4292235120 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/22994/statm: 642 270 230 194 0 29 0
[pid=22995] ppid=22994 vsize=2576 CPUtime=0.03
/proc/22995/stat : 22995 (p2cudf) S 22994 22994 19908 34817 19908 4202496 394 3016 0 1 0 0 1 2 25 0 1 0 62266181 2637824 282 1283457024 134512640 135304128 4292585456 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/22995/statm: 644 282 239 194 0 31 0
Current children cumulated CPU time (s) 0.03
Current children cumulated vsize (KiB) 5144

[startup+1.50737 s]
/proc/loadavg: 0.92 0.98 0.99 5/48 23018
/proc/meminfo: memFree=623172/1048576 swapFree=0/0
[pid=22994] ppid=22993 vsize=2568 CPUtime=0
/proc/22994/stat : 22994 (p2cudf-user-1.1) S 22993 22994 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 62266181 2629632 270 1283457024 134512640 135304128 4292235120 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/22994/statm: 642 270 230 194 0 29 0
[pid=22995] ppid=22994 vsize=2576 CPUtime=0.03
/proc/22995/stat : 22995 (p2cudf) S 22994 22994 19908 34817 19908 4202496 394 3016 0 1 0 0 1 2 25 0 1 0 62266181 2637824 282 1283457024 134512640 135304128 4292585456 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/22995/statm: 644 282 239 194 0 31 0
[pid=23008] ppid=22995 vsize=896048 CPUtime=1.45
/proc/23008/stat : 23008 (java) S 22995 22994 19908 34817 19908 4202496 22145 0 1 0 136 9 0 0 25 0 10 0 62266185 917553152 18205 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/23008/statm: 224012 18205 1720 10 0 221103 0
[pid=23008/tid=23009] ppid=22995 vsize=896048 CPUtime=0.76
/proc/23008/task/23009/stat : 23009 (java) R 22995 22994 19908 34817 19908 4202560 7805 0 1 0 69 7 0 0 25 0 10 0 62266186 917553152 18205 1283457024 134512640 134550932 4292488816 18446744073709551615 4148819237 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=23008/tid=23010] ppid=22995 vsize=896048 CPUtime=0
/proc/23008/task/23010/stat : 23010 (java) S 22995 22994 19908 34817 19908 4202560 5 0 0 0 0 0 0 0 16 0 10 0 62266187 917553152 18205 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23011] ppid=22995 vsize=896048 CPUtime=0
/proc/23008/task/23011/stat : 23011 (java) S 22995 22994 19908 34817 19908 4202560 8 0 0 0 0 0 0 0 25 0 10 0 62266188 917553152 18205 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23012] ppid=22995 vsize=896048 CPUtime=0
/proc/23008/task/23012/stat : 23012 (java) S 22995 22994 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 25 0 10 0 62266188 917553152 18205 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23013] ppid=22995 vsize=896048 CPUtime=0
/proc/23008/task/23013/stat : 23013 (java) S 22995 22994 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 10 0 62266190 917553152 18205 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23014] ppid=22995 vsize=896048 CPUtime=0.3
/proc/23008/task/23014/stat : 23014 (java) S 22995 22994 19908 34817 19908 4202560 6312 0 0 0 30 0 0 0 21 0 10 0 62266190 917553152 18205 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23015] ppid=22995 vsize=896048 CPUtime=0.37
/proc/23008/task/23015/stat : 23015 (java) R 22995 22994 19908 34817 19908 4202560 6949 0 0 0 36 1 0 0 25 0 10 0 62266190 917553152 18205 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=23008/tid=23016] ppid=22995 vsize=896048 CPUtime=0
/proc/23008/task/23016/stat : 23016 (java) S 22995 22994 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 10 0 62266190 917553152 18205 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23017] ppid=22995 vsize=896048 CPUtime=0
/proc/23008/task/23017/stat : 23017 (java) S 22995 22994 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 10 0 62266190 917553152 18205 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 1.48
Current children cumulated vsize (KiB) 901192

[startup+3.10782 s]
/proc/loadavg: 0.93 0.98 0.99 2/48 23018
/proc/meminfo: memFree=532280/1048576 swapFree=0/0
[pid=22994] ppid=22993 vsize=2568 CPUtime=0
/proc/22994/stat : 22994 (p2cudf-user-1.1) S 22993 22994 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 62266181 2629632 270 1283457024 134512640 135304128 4292235120 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/22994/statm: 642 270 230 194 0 29 0
[pid=22995] ppid=22994 vsize=2576 CPUtime=0.03
/proc/22995/stat : 22995 (p2cudf) S 22994 22994 19908 34817 19908 4202496 394 3016 0 1 0 0 1 2 25 0 1 0 62266181 2637824 282 1283457024 134512640 135304128 4292585456 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/22995/statm: 644 282 239 194 0 31 0
[pid=23008] ppid=22995 vsize=892480 CPUtime=3.05
/proc/23008/stat : 23008 (java) S 22995 22994 19908 34817 19908 4202496 75287 0 1 0 282 23 0 0 25 0 10 0 62266185 913899520 71081 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/23008/statm: 223120 71081 1742 10 0 220211 0
[pid=23008/tid=23009] ppid=22995 vsize=892480 CPUtime=1.76
/proc/23008/task/23009/stat : 23009 (java) R 22995 22994 19908 34817 19908 4202560 50035 0 1 0 156 20 0 0 25 0 10 0 62266186 913899520 71081 1283457024 134512640 134550932 4292488816 18446744073709551615 4094877891 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=23008/tid=23010] ppid=22995 vsize=892480 CPUtime=0.21
/proc/23008/task/23010/stat : 23010 (java) S 22995 22994 19908 34817 19908 4202560 10624 0 0 0 20 1 0 0 16 0 10 0 62266187 913899520 71081 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23011] ppid=22995 vsize=892480 CPUtime=0
/proc/23008/task/23011/stat : 23011 (java) S 22995 22994 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 10 0 62266188 913899520 71081 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23012] ppid=22995 vsize=892480 CPUtime=0
/proc/23008/task/23012/stat : 23012 (java) S 22995 22994 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 10 0 62266188 913899520 71081 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23013] ppid=22995 vsize=892480 CPUtime=0
/proc/23008/task/23013/stat : 23013 (java) S 22995 22994 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 10 0 62266190 913899520 71081 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23014] ppid=22995 vsize=892480 CPUtime=0.68
/proc/23008/task/23014/stat : 23014 (java) S 22995 22994 19908 34817 19908 4202560 6576 0 0 0 68 0 0 0 15 0 10 0 62266190 913899520 71081 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23015] ppid=22995 vsize=892480 CPUtime=0.38
/proc/23008/task/23015/stat : 23015 (java) S 22995 22994 19908 34817 19908 4202560 6975 0 0 0 37 1 0 0 25 0 10 0 62266190 913899520 71081 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23016] ppid=22995 vsize=892480 CPUtime=0
/proc/23008/task/23016/stat : 23016 (java) S 22995 22994 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 10 0 62266190 913899520 71081 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23017] ppid=22995 vsize=892480 CPUtime=0
/proc/23008/task/23017/stat : 23017 (java) S 22995 22994 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 10 0 62266190 913899520 71081 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 3.08
Current children cumulated vsize (KiB) 897624

[startup+6.30869 s]
/proc/loadavg: 0.93 0.98 0.99 2/49 23019
/proc/meminfo: memFree=394384/1048576 swapFree=0/0
[pid=22994] ppid=22993 vsize=2568 CPUtime=0
/proc/22994/stat : 22994 (p2cudf-user-1.1) S 22993 22994 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 62266181 2629632 270 1283457024 134512640 135304128 4292235120 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/22994/statm: 642 270 230 194 0 29 0
[pid=22995] ppid=22994 vsize=2576 CPUtime=0.03
/proc/22995/stat : 22995 (p2cudf) S 22994 22994 19908 34817 19908 4202496 394 3016 0 1 0 0 1 2 25 0 1 0 62266181 2637824 282 1283457024 134512640 135304128 4292585456 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/22995/statm: 644 282 239 194 0 31 0
[pid=23008] ppid=22995 vsize=892804 CPUtime=6.24
/proc/23008/stat : 23008 (java) S 22995 22994 19908 34817 19908 4202496 79853 0 1 0 594 30 0 0 25 0 11 0 62266185 914231296 73339 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/23008/statm: 223201 73339 1781 10 0 220292 0
[pid=23008/tid=23009] ppid=22995 vsize=892804 CPUtime=3.12
/proc/23008/task/23009/stat : 23009 (java) R 22995 22994 19908 34817 19908 4202560 50274 0 1 0 292 20 0 0 25 0 11 0 62266186 914231296 73339 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=23008/tid=23010] ppid=22995 vsize=892804 CPUtime=0.54
/proc/23008/task/23010/stat : 23010 (java) R 22995 22994 19908 34817 19908 4202560 12456 0 0 0 51 3 0 0 16 0 11 0 62266187 914231296 73339 1283457024 134512640 134550932 4292488816 18446744073709551615 4152282900 0 0 0 16800975 0 0 0 -1 0 0 0 0
[pid=23008/tid=23011] ppid=22995 vsize=892804 CPUtime=0
/proc/23008/task/23011/stat : 23011 (java) S 22995 22994 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 62266188 914231296 73339 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23012] ppid=22995 vsize=892804 CPUtime=0
/proc/23008/task/23012/stat : 23012 (java) S 22995 22994 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 62266188 914231296 73339 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23013] ppid=22995 vsize=892804 CPUtime=0
/proc/23008/task/23013/stat : 23013 (java) S 22995 22994 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 62266190 914231296 73339 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23014] ppid=22995 vsize=892804 CPUtime=2.17
/proc/23008/task/23014/stat : 23014 (java) S 22995 22994 19908 34817 19908 4202560 9067 0 0 0 212 5 0 0 16 0 11 0 62266190 914231296 73339 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23015] ppid=22995 vsize=892804 CPUtime=0.38
/proc/23008/task/23015/stat : 23015 (java) S 22995 22994 19908 34817 19908 4202560 6975 0 0 0 37 1 0 0 25 0 11 0 62266190 914231296 73339 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23016] ppid=22995 vsize=892804 CPUtime=0
/proc/23008/task/23016/stat : 23016 (java) S 22995 22994 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 62266190 914231296 73339 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23017] ppid=22995 vsize=892804 CPUtime=0
/proc/23008/task/23017/stat : 23017 (java) S 22995 22994 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 62266190 914231296 73339 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23019] ppid=22995 vsize=892804 CPUtime=0
/proc/23008/task/23019/stat : 23019 (java) S 22995 22994 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 23 0 11 0 62266636 914231296 73339 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 6.27
Current children cumulated vsize (KiB) 897948

[startup+12.7102 s]
/proc/loadavg: 0.93 0.98 0.99 4/49 23019
/proc/meminfo: memFree=352844/1048576 swapFree=0/0
[pid=22994] ppid=22993 vsize=2568 CPUtime=0
/proc/22994/stat : 22994 (p2cudf-user-1.1) S 22993 22994 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 62266181 2629632 270 1283457024 134512640 135304128 4292235120 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/22994/statm: 642 270 230 194 0 29 0
[pid=22995] ppid=22994 vsize=2576 CPUtime=0.03
/proc/22995/stat : 22995 (p2cudf) S 22994 22994 19908 34817 19908 4202496 394 3016 0 1 0 0 1 2 25 0 1 0 62266181 2637824 282 1283457024 134512640 135304128 4292585456 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/22995/statm: 644 282 239 194 0 31 0
[pid=23008] ppid=22995 vsize=886356 CPUtime=12.64
/proc/23008/stat : 23008 (java) S 22995 22994 19908 34817 19908 4202496 89920 0 1 0 1230 34 0 0 25 0 11 0 62266185 907628544 81848 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/23008/statm: 221589 81848 1783 10 0 218680 0
[pid=23008/tid=23009] ppid=22995 vsize=886356 CPUtime=8.28
/proc/23008/task/23009/stat : 23009 (java) R 22995 22994 19908 34817 19908 4202560 50274 0 1 0 808 20 0 0 25 0 11 0 62266186 907628544 81848 1283457024 134512640 134550932 4292488816 18446744073709551615 4095634774 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=23008/tid=23010] ppid=22995 vsize=886356 CPUtime=1.64
/proc/23008/task/23010/stat : 23010 (java) S 22995 22994 19908 34817 19908 4202560 22496 0 0 0 158 6 0 0 16 0 11 0 62266187 907628544 81848 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23011] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23011/stat : 23011 (java) S 22995 22994 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 62266188 907628544 81848 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23012] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23012/stat : 23012 (java) S 22995 22994 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 62266188 907628544 81848 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23013] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23013/stat : 23013 (java) S 22995 22994 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 62266190 907628544 81848 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23014] ppid=22995 vsize=886356 CPUtime=2.31
/proc/23008/task/23014/stat : 23014 (java) S 22995 22994 19908 34817 19908 4202560 9094 0 0 0 226 5 0 0 16 0 11 0 62266190 907628544 81848 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23015] ppid=22995 vsize=886356 CPUtime=0.38
/proc/23008/task/23015/stat : 23015 (java) S 22995 22994 19908 34817 19908 4202560 6975 0 0 0 37 1 0 0 25 0 11 0 62266190 907628544 81848 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23016] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23016/stat : 23016 (java) S 22995 22994 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 62266190 907628544 81848 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23017] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23017/stat : 23017 (java) S 22995 22994 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 62266190 907628544 81848 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23019] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23019/stat : 23019 (java) S 22995 22994 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 23 0 11 0 62266636 907628544 81848 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 12.67
Current children cumulated vsize (KiB) 891500

[startup+25.5032 s]
/proc/loadavg: 1.03 1.00 1.00 2/49 23019
/proc/meminfo: memFree=351232/1048576 swapFree=0/0
[pid=22994] ppid=22993 vsize=2568 CPUtime=0
/proc/22994/stat : 22994 (p2cudf-user-1.1) S 22993 22994 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 62266181 2629632 270 1283457024 134512640 135304128 4292235120 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/22994/statm: 642 270 230 194 0 29 0
[pid=22995] ppid=22994 vsize=2576 CPUtime=0.03
/proc/22995/stat : 22995 (p2cudf) S 22994 22994 19908 34817 19908 4202496 394 3016 0 1 0 0 1 2 25 0 1 0 62266181 2637824 282 1283457024 134512640 135304128 4292585456 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/22995/statm: 644 282 239 194 0 31 0
[pid=23008] ppid=22995 vsize=886356 CPUtime=25.42
/proc/23008/stat : 23008 (java) S 22995 22994 19908 34817 19908 4202496 90323 0 1 0 2508 34 0 0 25 0 11 0 62266185 907628544 82251 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/23008/statm: 221589 82251 1783 10 0 218680 0
[pid=23008/tid=23009] ppid=22995 vsize=886356 CPUtime=19.53
/proc/23008/task/23009/stat : 23009 (java) R 22995 22994 19908 34817 19908 4202560 50274 0 1 0 1933 20 0 0 25 0 11 0 62266186 907628544 82251 1283457024 134512640 134550932 4292488816 18446744073709551615 4095604718 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=23008/tid=23010] ppid=22995 vsize=886356 CPUtime=3.17
/proc/23008/task/23010/stat : 23010 (java) S 22995 22994 19908 34817 19908 4202560 22899 0 0 0 311 6 0 0 15 0 11 0 62266187 907628544 82251 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23011] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23011/stat : 23011 (java) S 22995 22994 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 62266188 907628544 82251 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23012] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23012/stat : 23012 (java) S 22995 22994 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 62266188 907628544 82251 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23013] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23013/stat : 23013 (java) S 22995 22994 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 62266190 907628544 82251 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23014] ppid=22995 vsize=886356 CPUtime=2.31
/proc/23008/task/23014/stat : 23014 (java) S 22995 22994 19908 34817 19908 4202560 9094 0 0 0 226 5 0 0 16 0 11 0 62266190 907628544 82251 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23015] ppid=22995 vsize=886356 CPUtime=0.38
/proc/23008/task/23015/stat : 23015 (java) S 22995 22994 19908 34817 19908 4202560 6975 0 0 0 37 1 0 0 25 0 11 0 62266190 907628544 82251 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23016] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23016/stat : 23016 (java) S 22995 22994 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 62266190 907628544 82251 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23017] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23017/stat : 23017 (java) S 22995 22994 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 62266190 907628544 82251 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23019] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23019/stat : 23019 (java) S 22995 22994 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 23 0 11 0 62266636 907628544 82251 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 25.45
Current children cumulated vsize (KiB) 891500

[startup+51.1076 s]
/proc/loadavg: 1.02 1.00 1.00 2/49 23019
/proc/meminfo: memFree=348628/1048576 swapFree=0/0
[pid=22994] ppid=22993 vsize=2568 CPUtime=0
/proc/22994/stat : 22994 (p2cudf-user-1.1) S 22993 22994 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 62266181 2629632 270 1283457024 134512640 135304128 4292235120 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/22994/statm: 642 270 230 194 0 29 0
[pid=22995] ppid=22994 vsize=2576 CPUtime=0.03
/proc/22995/stat : 22995 (p2cudf) S 22994 22994 19908 34817 19908 4202496 394 3016 0 1 0 0 1 2 25 0 1 0 62266181 2637824 282 1283457024 134512640 135304128 4292585456 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/22995/statm: 644 282 239 194 0 31 0
[pid=23008] ppid=22995 vsize=886356 CPUtime=51.02
/proc/23008/stat : 23008 (java) S 22995 22994 19908 34817 19908 4202496 90923 0 1 0 5068 34 0 0 25 0 11 0 62266185 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/23008/statm: 221589 82851 1783 10 0 218680 0
[pid=23008/tid=23009] ppid=22995 vsize=886356 CPUtime=42.27
/proc/23008/task/23009/stat : 23009 (java) R 22995 22994 19908 34817 19908 4202560 50274 0 1 0 4207 20 0 0 25 0 11 0 62266186 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4095668780 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=23008/tid=23010] ppid=22995 vsize=886356 CPUtime=6.03
/proc/23008/task/23010/stat : 23010 (java) S 22995 22994 19908 34817 19908 4202560 23499 0 0 0 597 6 0 0 15 0 11 0 62266187 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23011] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23011/stat : 23011 (java) S 22995 22994 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 62266188 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23012] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23012/stat : 23012 (java) S 22995 22994 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 62266188 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23013] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23013/stat : 23013 (java) S 22995 22994 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 62266190 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23014] ppid=22995 vsize=886356 CPUtime=2.31
/proc/23008/task/23014/stat : 23014 (java) S 22995 22994 19908 34817 19908 4202560 9094 0 0 0 226 5 0 0 16 0 11 0 62266190 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23015] ppid=22995 vsize=886356 CPUtime=0.38
/proc/23008/task/23015/stat : 23015 (java) S 22995 22994 19908 34817 19908 4202560 6975 0 0 0 37 1 0 0 25 0 11 0 62266190 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23016] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23016/stat : 23016 (java) S 22995 22994 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 62266190 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23017] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23017/stat : 23017 (java) S 22995 22994 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 62266190 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23019] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23019/stat : 23019 (java) S 22995 22994 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 23 0 11 0 62266636 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 51.05
Current children cumulated vsize (KiB) 891500

[startup+102.31 s]
/proc/loadavg: 1.19 1.06 1.02 2/51 23025
/proc/meminfo: memFree=348356/1048576 swapFree=0/0
[pid=22994] ppid=22993 vsize=2568 CPUtime=0
/proc/22994/stat : 22994 (p2cudf-user-1.1) S 22993 22994 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 62266181 2629632 270 1283457024 134512640 135304128 4292235120 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/22994/statm: 642 270 230 194 0 29 0
[pid=22995] ppid=22994 vsize=2576 CPUtime=0.03
/proc/22995/stat : 22995 (p2cudf) S 22994 22994 19908 34817 19908 4202496 394 3016 0 1 0 0 1 2 25 0 1 0 62266181 2637824 282 1283457024 134512640 135304128 4292585456 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/22995/statm: 644 282 239 194 0 31 0
[pid=23008] ppid=22995 vsize=886356 CPUtime=102.18
/proc/23008/stat : 23008 (java) S 22995 22994 19908 34817 19908 4202496 90923 0 1 0 10184 34 0 0 25 0 11 0 62266185 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/23008/statm: 221589 82851 1783 10 0 218680 0
[pid=23008/tid=23009] ppid=22995 vsize=886356 CPUtime=87.17
/proc/23008/task/23009/stat : 23009 (java) R 22995 22994 19908 34817 19908 4202560 50274 0 1 0 8697 20 0 0 25 0 11 0 62266186 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4094839559 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=23008/tid=23010] ppid=22995 vsize=886356 CPUtime=12.29
/proc/23008/task/23010/stat : 23010 (java) S 22995 22994 19908 34817 19908 4202560 23499 0 0 0 1223 6 0 0 16 0 11 0 62266187 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23011] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23011/stat : 23011 (java) S 22995 22994 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 62266188 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23012] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23012/stat : 23012 (java) S 22995 22994 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 62266188 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23013] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23013/stat : 23013 (java) S 22995 22994 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 62266190 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23014] ppid=22995 vsize=886356 CPUtime=2.31
/proc/23008/task/23014/stat : 23014 (java) S 22995 22994 19908 34817 19908 4202560 9094 0 0 0 226 5 0 0 15 0 11 0 62266190 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23015] ppid=22995 vsize=886356 CPUtime=0.38
/proc/23008/task/23015/stat : 23015 (java) S 22995 22994 19908 34817 19908 4202560 6975 0 0 0 37 1 0 0 25 0 11 0 62266190 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23016] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23016/stat : 23016 (java) S 22995 22994 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 62266190 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23017] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23017/stat : 23017 (java) S 22995 22994 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 62266190 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23019] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23019/stat : 23019 (java) S 22995 22994 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 23 0 11 0 62266636 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 102.21
Current children cumulated vsize (KiB) 891500

[startup+162.314 s]
/proc/loadavg: 1.16 1.08 1.02 4/51 23030
/proc/meminfo: memFree=348232/1048576 swapFree=0/0
[pid=22994] ppid=22993 vsize=2568 CPUtime=0
/proc/22994/stat : 22994 (p2cudf-user-1.1) S 22993 22994 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 62266181 2629632 270 1283457024 134512640 135304128 4292235120 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/22994/statm: 642 270 230 194 0 29 0
[pid=22995] ppid=22994 vsize=2576 CPUtime=0.03
/proc/22995/stat : 22995 (p2cudf) S 22994 22994 19908 34817 19908 4202496 394 3016 0 1 0 0 1 2 25 0 1 0 62266181 2637824 282 1283457024 134512640 135304128 4292585456 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/22995/statm: 644 282 239 194 0 31 0
[pid=23008] ppid=22995 vsize=886356 CPUtime=162.11
/proc/23008/stat : 23008 (java) S 22995 22994 19908 34817 19908 4202496 90923 0 1 0 16176 35 0 0 25 0 11 0 62266185 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/23008/statm: 221589 82851 1783 10 0 218680 0
[pid=23008/tid=23009] ppid=22995 vsize=886356 CPUtime=140.08
/proc/23008/task/23009/stat : 23009 (java) R 22995 22994 19908 34817 19908 4202560 50274 0 1 0 13986 22 0 0 25 0 11 0 62266186 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4094696017 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=23008/tid=23010] ppid=22995 vsize=886356 CPUtime=19.3
/proc/23008/task/23010/stat : 23010 (java) S 22995 22994 19908 34817 19908 4202560 23499 0 0 0 1924 6 0 0 16 0 11 0 62266187 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23011] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23011/stat : 23011 (java) S 22995 22994 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 62266188 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23012] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23012/stat : 23012 (java) S 22995 22994 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 62266188 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23013] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23013/stat : 23013 (java) S 22995 22994 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 62266190 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23014] ppid=22995 vsize=886356 CPUtime=2.33
/proc/23008/task/23014/stat : 23014 (java) S 22995 22994 19908 34817 19908 4202560 9094 0 0 0 228 5 0 0 15 0 11 0 62266190 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23015] ppid=22995 vsize=886356 CPUtime=0.38
/proc/23008/task/23015/stat : 23015 (java) S 22995 22994 19908 34817 19908 4202560 6975 0 0 0 37 1 0 0 25 0 11 0 62266190 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23016] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23016/stat : 23016 (java) S 22995 22994 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 62266190 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23017] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23017/stat : 23017 (java) R 22995 22994 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 62266190 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=23008/tid=23019] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23019/stat : 23019 (java) S 22995 22994 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 23 0 11 0 62266636 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 162.14
Current children cumulated vsize (KiB) 891500

[startup+222.306 s]
/proc/loadavg: 1.14 1.09 1.03 2/49 23030
/proc/meminfo: memFree=348256/1048576 swapFree=0/0
[pid=22994] ppid=22993 vsize=2568 CPUtime=0
/proc/22994/stat : 22994 (p2cudf-user-1.1) S 22993 22994 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 62266181 2629632 270 1283457024 134512640 135304128 4292235120 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/22994/statm: 642 270 230 194 0 29 0
[pid=22995] ppid=22994 vsize=2576 CPUtime=0.03
/proc/22995/stat : 22995 (p2cudf) S 22994 22994 19908 34817 19908 4202496 394 3016 0 1 0 0 1 2 25 0 1 0 62266181 2637824 282 1283457024 134512640 135304128 4292585456 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/22995/statm: 644 282 239 194 0 31 0
[pid=23008] ppid=22995 vsize=886356 CPUtime=222.06
/proc/23008/stat : 23008 (java) S 22995 22994 19908 34817 19908 4202496 90923 0 1 0 22171 35 0 0 25 0 11 0 62266185 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/23008/statm: 221589 82851 1783 10 0 218680 0
[pid=23008/tid=23009] ppid=22995 vsize=886356 CPUtime=193.13
/proc/23008/task/23009/stat : 23009 (java) R 22995 22994 19908 34817 19908 4202560 50274 0 1 0 19291 22 0 0 25 0 11 0 62266186 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4094696019 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=23008/tid=23010] ppid=22995 vsize=886356 CPUtime=26.2
/proc/23008/task/23010/stat : 23010 (java) S 22995 22994 19908 34817 19908 4202560 23499 0 0 0 2614 6 0 0 15 0 11 0 62266187 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23011] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23011/stat : 23011 (java) S 22995 22994 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 62266188 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23012] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23012/stat : 23012 (java) S 22995 22994 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 62266188 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23013] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23013/stat : 23013 (java) S 22995 22994 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 62266190 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23014] ppid=22995 vsize=886356 CPUtime=2.33
/proc/23008/task/23014/stat : 23014 (java) S 22995 22994 19908 34817 19908 4202560 9094 0 0 0 228 5 0 0 15 0 11 0 62266190 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23015] ppid=22995 vsize=886356 CPUtime=0.38
/proc/23008/task/23015/stat : 23015 (java) S 22995 22994 19908 34817 19908 4202560 6975 0 0 0 37 1 0 0 25 0 11 0 62266190 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23016] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23016/stat : 23016 (java) S 22995 22994 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 62266190 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23017] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23017/stat : 23017 (java) S 22995 22994 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 62266190 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23019] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23019/stat : 23019 (java) S 22995 22994 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 23 0 11 0 62266636 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 222.09
Current children cumulated vsize (KiB) 891500

[startup+282.309 s]
/proc/loadavg: 1.31 1.14 1.05 3/49 23030
/proc/meminfo: memFree=348256/1048576 swapFree=0/0
[pid=22994] ppid=22993 vsize=2568 CPUtime=0
/proc/22994/stat : 22994 (p2cudf-user-1.1) S 22993 22994 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 62266181 2629632 270 1283457024 134512640 135304128 4292235120 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/22994/statm: 642 270 230 194 0 29 0
[pid=22995] ppid=22994 vsize=2576 CPUtime=0.03
/proc/22995/stat : 22995 (p2cudf) S 22994 22994 19908 34817 19908 4202496 394 3016 0 1 0 0 1 2 25 0 1 0 62266181 2637824 282 1283457024 134512640 135304128 4292585456 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/22995/statm: 644 282 239 194 0 31 0
[pid=23008] ppid=22995 vsize=886356 CPUtime=282.02
/proc/23008/stat : 23008 (java) S 22995 22994 19908 34817 19908 4202496 90923 0 1 0 28166 36 0 0 25 0 11 0 62266185 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/23008/statm: 221589 82851 1783 10 0 218680 0
[pid=23008/tid=23009] ppid=22995 vsize=886356 CPUtime=245.93
/proc/23008/task/23009/stat : 23009 (java) R 22995 22994 19908 34817 19908 4202560 50274 0 1 0 24571 22 0 0 25 0 11 0 62266186 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4095717506 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=23008/tid=23010] ppid=22995 vsize=886356 CPUtime=33.37
/proc/23008/task/23010/stat : 23010 (java) S 22995 22994 19908 34817 19908 4202560 23499 0 0 0 3329 8 0 0 16 0 11 0 62266187 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23011] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23011/stat : 23011 (java) S 22995 22994 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 62266188 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23012] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23012/stat : 23012 (java) S 22995 22994 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 62266188 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23013] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23013/stat : 23013 (java) S 22995 22994 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 62266190 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23014] ppid=22995 vsize=886356 CPUtime=2.33
/proc/23008/task/23014/stat : 23014 (java) S 22995 22994 19908 34817 19908 4202560 9094 0 0 0 228 5 0 0 15 0 11 0 62266190 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23015] ppid=22995 vsize=886356 CPUtime=0.38
/proc/23008/task/23015/stat : 23015 (java) S 22995 22994 19908 34817 19908 4202560 6975 0 0 0 37 1 0 0 25 0 11 0 62266190 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23016] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23016/stat : 23016 (java) S 22995 22994 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 62266190 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23017] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23017/stat : 23017 (java) S 22995 22994 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 62266190 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23019] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23019/stat : 23019 (java) S 22995 22994 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 23 0 11 0 62266636 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 282.05
Current children cumulated vsize (KiB) 891500

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

[startup+283.01 s]
/proc/loadavg: 1.29 1.14 1.05 2/49 23030
/proc/meminfo: memFree=348256/1048576 swapFree=0/0
[pid=22994] ppid=22993 vsize=2568 CPUtime=0
/proc/22994/stat : 22994 (p2cudf-user-1.1) S 22993 22994 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 62266181 2629632 270 1283457024 134512640 135304128 4292235120 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/22994/statm: 642 270 230 194 0 29 0
[pid=22995] ppid=22994 vsize=2576 CPUtime=0.03
/proc/22995/stat : 22995 (p2cudf) S 22994 22994 19908 34817 19908 4202496 394 3016 0 1 0 0 1 2 25 0 1 0 62266181 2637824 282 1283457024 134512640 135304128 4292585456 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/22995/statm: 644 282 239 194 0 31 0
[pid=23008] ppid=22995 vsize=886356 CPUtime=282.72
/proc/23008/stat : 23008 (java) S 22995 22994 19908 34817 19908 4202496 90923 0 1 0 28236 36 0 0 25 0 11 0 62266185 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/23008/statm: 221589 82851 1783 10 0 218680 0
[pid=23008/tid=23009] ppid=22995 vsize=886356 CPUtime=246.63
/proc/23008/task/23009/stat : 23009 (java) R 22995 22994 19908 34817 19908 4202560 50274 0 1 0 24641 22 0 0 25 0 11 0 62266186 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4095667688 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=23008/tid=23010] ppid=22995 vsize=886356 CPUtime=33.37
/proc/23008/task/23010/stat : 23010 (java) S 22995 22994 19908 34817 19908 4202560 23499 0 0 0 3329 8 0 0 15 0 11 0 62266187 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23011] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23011/stat : 23011 (java) S 22995 22994 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 62266188 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23012] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23012/stat : 23012 (java) S 22995 22994 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 62266188 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23013] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23013/stat : 23013 (java) S 22995 22994 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 62266190 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23014] ppid=22995 vsize=886356 CPUtime=2.33
/proc/23008/task/23014/stat : 23014 (java) S 22995 22994 19908 34817 19908 4202560 9094 0 0 0 228 5 0 0 15 0 11 0 62266190 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23015] ppid=22995 vsize=886356 CPUtime=0.38
/proc/23008/task/23015/stat : 23015 (java) S 22995 22994 19908 34817 19908 4202560 6975 0 0 0 37 1 0 0 25 0 11 0 62266190 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23016] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23016/stat : 23016 (java) S 22995 22994 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 62266190 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23017] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23017/stat : 23017 (java) R 22995 22994 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 62266190 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=23008/tid=23019] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23019/stat : 23019 (java) S 22995 22994 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 23 0 11 0 62266636 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 282.75
Current children cumulated vsize (KiB) 891500

[startup+283.81 s]
/proc/loadavg: 1.29 1.14 1.05 3/49 23030
/proc/meminfo: memFree=348256/1048576 swapFree=0/0
[pid=22994] ppid=22993 vsize=2568 CPUtime=0
/proc/22994/stat : 22994 (p2cudf-user-1.1) S 22993 22994 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 62266181 2629632 270 1283457024 134512640 135304128 4292235120 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/22994/statm: 642 270 230 194 0 29 0
[pid=22995] ppid=22994 vsize=2576 CPUtime=0.03
/proc/22995/stat : 22995 (p2cudf) S 22994 22994 19908 34817 19908 4202496 394 3016 0 1 0 0 1 2 25 0 1 0 62266181 2637824 282 1283457024 134512640 135304128 4292585456 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/22995/statm: 644 282 239 194 0 31 0
[pid=23008] ppid=22995 vsize=886356 CPUtime=283.52
/proc/23008/stat : 23008 (java) S 22995 22994 19908 34817 19908 4202496 90923 0 1 0 28316 36 0 0 25 0 11 0 62266185 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/23008/statm: 221589 82851 1783 10 0 218680 0
[pid=23008/tid=23009] ppid=22995 vsize=886356 CPUtime=247.15
/proc/23008/task/23009/stat : 23009 (java) R 22995 22994 19908 34817 19908 4202560 50274 0 1 0 24693 22 0 0 25 0 11 0 62266186 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4095717299 0 4 0 16800975 0 0 0 -1 0 0 0 0
[pid=23008/tid=23010] ppid=22995 vsize=886356 CPUtime=33.65
/proc/23008/task/23010/stat : 23010 (java) S 22995 22994 19908 34817 19908 4202560 23499 0 0 0 3357 8 0 0 16 0 11 0 62266187 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23011] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23011/stat : 23011 (java) S 22995 22994 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 62266188 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23012] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23012/stat : 23012 (java) S 22995 22994 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 62266188 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23013] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23013/stat : 23013 (java) S 22995 22994 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 62266190 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23014] ppid=22995 vsize=886356 CPUtime=2.33
/proc/23008/task/23014/stat : 23014 (java) S 22995 22994 19908 34817 19908 4202560 9094 0 0 0 228 5 0 0 15 0 11 0 62266190 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23015] ppid=22995 vsize=886356 CPUtime=0.38
/proc/23008/task/23015/stat : 23015 (java) S 22995 22994 19908 34817 19908 4202560 6975 0 0 0 37 1 0 0 25 0 11 0 62266190 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23016] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23016/stat : 23016 (java) S 22995 22994 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 62266190 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23017] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23017/stat : 23017 (java) S 22995 22994 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 62266190 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23019] ppid=22995 vsize=886356 CPUtime=0
/proc/23008/task/23019/stat : 23019 (java) S 22995 22994 19908 34817 19908 4202560 4 0 0 0 0 0 0 0 23 0 11 0 62266636 907628544 82851 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 283.55
Current children cumulated vsize (KiB) 891500

[startup+284.603 s]
/proc/loadavg: 1.29 1.14 1.05 3/49 23030
/proc/meminfo: memFree=348256/1048576 swapFree=0/0
[pid=22994] ppid=22993 vsize=2568 CPUtime=0
/proc/22994/stat : 22994 (p2cudf-user-1.1) S 22993 22994 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 62266181 2629632 270 1283457024 134512640 135304128 4292235120 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/22994/statm: 642 270 230 194 0 29 0
[pid=22995] ppid=22994 vsize=2576 CPUtime=0.03
/proc/22995/stat : 22995 (p2cudf) S 22994 22994 19908 34817 19908 4202496 394 3016 0 1 0 0 1 2 25 0 1 0 62266181 2637824 282 1283457024 134512640 135304128 4292585456 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/22995/statm: 644 282 239 194 0 31 0
[pid=23008] ppid=22995 vsize=886680 CPUtime=284.29
/proc/23008/stat : 23008 (java) S 22995 22994 19908 34817 19908 4202496 90936 0 1 0 28393 36 0 0 25 0 11 0 62266185 907960320 82864 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/23008/statm: 221670 82864 1784 10 0 218761 0
[pid=23008/tid=23009] ppid=22995 vsize=886680 CPUtime=247.9
/proc/23008/task/23009/stat : 23009 (java) S 22995 22994 19908 34817 19908 4202560 50281 0 1 0 24768 22 0 0 25 0 11 0 62266186 907960320 82864 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23010] ppid=22995 vsize=886680 CPUtime=33.65
/proc/23008/task/23010/stat : 23010 (java) S 22995 22994 19908 34817 19908 4202560 23499 0 0 0 3357 8 0 0 16 0 11 0 62266187 907960320 82864 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23011] ppid=22995 vsize=886680 CPUtime=0
/proc/23008/task/23011/stat : 23011 (java) S 22995 22994 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 62266188 907960320 82864 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23012] ppid=22995 vsize=886680 CPUtime=0
/proc/23008/task/23012/stat : 23012 (java) S 22995 22994 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 62266188 907960320 82864 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23013] ppid=22995 vsize=886680 CPUtime=0
/proc/23008/task/23013/stat : 23013 (java) S 22995 22994 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 62266190 907960320 82864 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23014] ppid=22995 vsize=886680 CPUtime=2.35
/proc/23008/task/23014/stat : 23014 (java) S 22995 22994 19908 34817 19908 4202560 9094 0 0 0 230 5 0 0 15 0 11 0 62266190 907960320 82864 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23015] ppid=22995 vsize=886680 CPUtime=0.38
/proc/23008/task/23015/stat : 23015 (java) S 22995 22994 19908 34817 19908 4202560 6975 0 0 0 37 1 0 0 25 0 11 0 62266190 907960320 82864 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23016] ppid=22995 vsize=886680 CPUtime=0
/proc/23008/task/23016/stat : 23016 (java) S 22995 22994 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 62266190 907960320 82864 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23017] ppid=22995 vsize=886680 CPUtime=0
/proc/23008/task/23017/stat : 23017 (java) S 22995 22994 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 62266190 907960320 82864 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 284.32
Current children cumulated vsize (KiB) 891824

[startup+285.007 s]
/proc/loadavg: 1.29 1.14 1.05 2/49 23031
/proc/meminfo: memFree=348256/1048576 swapFree=0/0
[pid=22994] ppid=22993 vsize=2568 CPUtime=0
/proc/22994/stat : 22994 (p2cudf-user-1.1) S 22993 22994 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 62266181 2629632 270 1283457024 134512640 135304128 4292235120 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/22994/statm: 642 270 230 194 0 29 0
[pid=22995] ppid=22994 vsize=2576 CPUtime=0.03
/proc/22995/stat : 22995 (p2cudf) S 22994 22994 19908 34817 19908 4202496 394 3016 0 1 0 0 1 2 25 0 1 0 62266181 2637824 282 1283457024 134512640 135304128 4292585456 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/22995/statm: 644 282 239 194 0 31 0
[pid=23008] ppid=22995 vsize=886680 CPUtime=284.29
/proc/23008/stat : 23008 (java) S 22995 22994 19908 34817 19908 4202496 90936 0 1 0 28393 36 0 0 25 0 11 0 62266185 907960320 82864 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/23008/statm: 221670 82864 1784 10 0 218761 0
[pid=23008/tid=23009] ppid=22995 vsize=886680 CPUtime=247.9
/proc/23008/task/23009/stat : 23009 (java) S 22995 22994 19908 34817 19908 4202560 50281 0 1 0 24768 22 0 0 25 0 11 0 62266186 907960320 82864 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23010] ppid=22995 vsize=886680 CPUtime=33.65
/proc/23008/task/23010/stat : 23010 (java) S 22995 22994 19908 34817 19908 4202560 23499 0 0 0 3357 8 0 0 16 0 11 0 62266187 907960320 82864 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 0 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23011] ppid=22995 vsize=886680 CPUtime=0
/proc/23008/task/23011/stat : 23011 (java) S 22995 22994 19908 34817 19908 4202560 9 0 0 0 0 0 0 0 18 0 11 0 62266188 907960320 82864 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23012] ppid=22995 vsize=886680 CPUtime=0
/proc/23008/task/23012/stat : 23012 (java) S 22995 22994 19908 34817 19908 4202560 6 0 0 0 0 0 0 0 18 0 11 0 62266188 907960320 82864 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23013] ppid=22995 vsize=886680 CPUtime=0
/proc/23008/task/23013/stat : 23013 (java) S 22995 22994 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 62266190 907960320 82864 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23014] ppid=22995 vsize=886680 CPUtime=2.35
/proc/23008/task/23014/stat : 23014 (java) S 22995 22994 19908 34817 19908 4202560 9094 0 0 0 230 5 0 0 15 0 11 0 62266190 907960320 82864 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23015] ppid=22995 vsize=886680 CPUtime=0.38
/proc/23008/task/23015/stat : 23015 (java) S 22995 22994 19908 34817 19908 4202560 6975 0 0 0 37 1 0 0 25 0 11 0 62266190 907960320 82864 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23016] ppid=22995 vsize=886680 CPUtime=0
/proc/23008/task/23016/stat : 23016 (java) S 22995 22994 19908 34817 19908 4202560 1 0 0 0 0 0 0 0 25 0 11 0 62266190 907960320 82864 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23017] ppid=22995 vsize=886680 CPUtime=0
/proc/23008/task/23017/stat : 23017 (java) S 22995 22994 19908 34817 19908 4202560 2 0 0 0 0 0 0 0 15 0 11 0 62266190 907960320 82864 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
[pid=23008/tid=23031] ppid=22995 vsize=886680 CPUtime=0
/proc/23008/task/23031/stat : 23031 (java) S 22995 22994 19908 34817 19908 4202560 5 0 0 0 0 0 0 0 25 0 11 0 62294639 907960320 82864 1283457024 134512640 134550932 4292488816 18446744073709551615 4294960130 0 4 0 16800975 18446612133392889664 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 284.32
Current children cumulated vsize (KiB) 891824

[startup+285.115 s]
/proc/loadavg: 1.29 1.14 1.05 2/49 23031
/proc/meminfo: memFree=348256/1048576 swapFree=0/0
[pid=22994] ppid=22993 vsize=2568 CPUtime=0
/proc/22994/stat : 22994 (p2cudf-user-1.1) S 22993 22994 19908 34817 19908 4202496 374 0 0 0 0 0 0 0 18 0 1 0 62266181 2629632 270 1283457024 134512640 135304128 4292235120 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/22994/statm: 642 270 230 194 0 29 0
[pid=22995] ppid=22994 vsize=2576 CPUtime=0.03
/proc/22995/stat : 22995 (p2cudf) S 22994 22994 19908 34817 19908 4202496 394 3016 0 1 0 0 1 2 25 0 1 0 62266181 2637824 282 1283457024 134512640 135304128 4292585456 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0
/proc/22995/statm: 644 282 239 194 0 31 0
[pid=23008] ppid=22995 vsize=0 CPUtime=284.31
/proc/23008/stat : 23008 (java) Z 22995 22994 19908 34817 19908 4203532 90942 0 1 0 28393 38 0 0 18 0 2 0 62266185 0 0 1283457024 0 0 0 0 0 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0
/proc/23008/statm: 0 0 0 0 0 0 0
[pid=23008/tid=23009] ppid=22995 vsize=0 CPUtime=247.91
/proc/23008/task/23009/stat : 23009 (java) R 22995 22994 19908 34817 19908 4203588 50281 0 1 0 24768 23 0 0 20 0 2 0 62266186 0 0 1283457024 0 0 0 0 0 0 4 0 16800975 0 0 0 -1 0 0 0 0
Current children cumulated CPU time (s) 284.34
Current children cumulated vsize (KiB) 5144

Child status: 0
Real time (s): 285.12
CPU time (s): 284.362
CPU user time (s): 283.946
CPU system time (s): 0.416026
CPU usage (%): 99.7339
Max. virtual memory (cumulated for all children) (KiB): 901864

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 283.946
system time used= 0.416026
maximum resident set size= 0
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 94745
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= 6199
involuntary context switches= 9012

runsolver used 0 second user time and 0.016001 second system time

The end