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: runsolver -s SIGUSR1 -M 1124 -C 150 -d 10 -w /tmp/misc2012/2012-09-02-17:21/basic/p2cudf-basic-1.15/paranoid-size/install/rand308.cudf.log.runsolver /home/competition/p2cudf-basic-1.15/p2cudf-basic-1.15 /home/competition/data/install/rand308.cudf /tmp/misc2012/2012-09-02-17:21/basic/p2cudf-basic-1.15/paranoid-size/install/rand308.cudf.result -count(removed),-sum(solution,installedsize),-count(changed) 

Enforcing CPUTime limit (soft limit, will send signal-name then SIGKILL): 150 seconds
Enforcing CPUTime limit (hard limit, will send SIGXCPU): 180 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.01 1.00 0.91 2/65 4284
/proc/meminfo: memFree=583396/1022884 swapFree=0/0
[pid=4284] ppid=4283 vsize=1068 CPUtime=0
/proc/4284/stat : 4284 (p2cudf-basic-1.) D 4283 4284 1745 0 -1 4194304 75 0 0 0 0 0 0 0 20 0 1 0 115408861 1093632 1 18446744073709551615 0 0 140734861683669 4292025824 4152071216 0 0 16781316 0 0 0 0 17 0 0 0 0 0 0
/proc/4284/statm: 267 1 0 0 0 28 0

[startup+0.16103 s]
/proc/loadavg: 1.01 1.00 0.91 2/65 4284
/proc/meminfo: memFree=583396/1022884 swapFree=0/0
[pid=4284] ppid=4283 vsize=9168 CPUtime=0
/proc/4284/stat : 4284 (p2cudf-basic-1.) S 4283 4284 1745 0 -1 4202496 455 290 2 2 0 0 0 0 20 0 1 0 115408861 9388032 331 18446744073709551615 4194304 5129932 140734861675264 140734861673408 140027703104606 0 65536 16781316 65538 0 0 0 17 0 0 0 2 0 0
/proc/4284/statm: 2292 331 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+0.200386 s]
/proc/loadavg: 1.01 1.00 0.91 2/65 4284
/proc/meminfo: memFree=583396/1022884 swapFree=0/0
[pid=4284] ppid=4283 vsize=9168 CPUtime=0
/proc/4284/stat : 4284 (p2cudf-basic-1.) S 4283 4284 1745 0 -1 4202496 455 290 2 2 0 0 0 0 20 0 1 0 115408861 9388032 331 18446744073709551615 4194304 5129932 140734861675264 140734861673408 140027703104606 0 65536 16781316 65538 0 0 0 17 0 0 0 2 0 0
/proc/4284/statm: 2292 331 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+0.300244 s]
/proc/loadavg: 1.01 1.00 0.91 2/65 4284
/proc/meminfo: memFree=583396/1022884 swapFree=0/0
[pid=4284] ppid=4283 vsize=9168 CPUtime=0
/proc/4284/stat : 4284 (p2cudf-basic-1.) S 4283 4284 1745 0 -1 4202496 455 290 2 2 0 0 0 0 20 0 1 0 115408861 9388032 331 18446744073709551615 4194304 5129932 140734861675264 140734861673408 140027703104606 0 65536 16781316 65538 0 0 0 17 0 0 0 2 0 0
/proc/4284/statm: 2292 331 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+0.700253 s]
/proc/loadavg: 1.01 1.00 0.91 2/65 4284
/proc/meminfo: memFree=583396/1022884 swapFree=0/0
[pid=4284] ppid=4283 vsize=9168 CPUtime=0
/proc/4284/stat : 4284 (p2cudf-basic-1.) S 4283 4284 1745 0 -1 4202496 455 290 2 2 0 0 0 0 20 0 1 0 115408861 9388032 331 18446744073709551615 4194304 5129932 140734861675264 140734861673408 140027703104606 0 65536 16781316 65538 0 0 0 17 0 0 0 2 0 0
/proc/4284/statm: 2292 331 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+1.50074 s]
/proc/loadavg: 1.01 1.00 0.91 4/76 4296
/proc/meminfo: memFree=555028/1022884 swapFree=0/0
[pid=4284] ppid=4283 vsize=9168 CPUtime=0
/proc/4284/stat : 4284 (p2cudf-basic-1.) S 4283 4284 1745 0 -1 4202496 455 290 2 2 0 0 0 0 20 0 1 0 115408861 9388032 331 18446744073709551615 4194304 5129932 140734861675264 140734861673408 140027703104606 0 65536 16781316 65538 0 0 0 17 0 0 0 2 0 0
/proc/4284/statm: 2292 331 280 229 0 52 0
[pid=4287] ppid=4284 vsize=964272 CPUtime=1.05
/proc/4287/stat : 4287 (java) S 4284 4284 1745 0 -1 4202496 15994 0 20 0 97 8 0 0 20 0 10 0 115408867 987414528 14545 18446744073709551615 4194304 4228012 140734277360608 140734277351632 140061068144245 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 7 0 0
/proc/4287/statm: 241068 14545 2345 9 0 228418 0
[pid=4287/tid=4288] ppid=4284 vsize=964272 CPUtime=0.54
/proc/4287/task/4288/stat : 4288 (java) R 4284 4284 1745 0 -1 4202560 9617 0 8 0 47 7 0 0 20 0 10 0 115408875 987414528 14545 18446744073709551615 4194304 4228012 140734277360608 140061074670240 140060972151969 0 4 0 16800975 0 0 0 -1 0 0 0 31 0 0
[pid=4287/tid=4289] ppid=4284 vsize=964272 CPUtime=0
/proc/4287/task/4289/stat : 4289 (java) S 4284 4284 1745 0 -1 4202560 3 0 0 0 0 0 0 0 20 0 10 0 115408892 987414528 14545 18446744073709551615 4194304 4228012 140734277360608 140060967316608 140061068158539 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4290] ppid=4284 vsize=964272 CPUtime=0
/proc/4287/task/4290/stat : 4290 (java) S 4284 4284 1745 0 -1 4202560 15 0 0 0 0 0 0 0 20 0 10 0 115408893 987414528 14545 18446744073709551615 4194304 4228012 140734277360608 140060966262800 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4291] ppid=4284 vsize=964272 CPUtime=0
/proc/4287/task/4291/stat : 4291 (java) S 4284 4284 1745 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 10 0 115408893 987414528 14545 18446744073709551615 4194304 4228012 140734277360608 140060965210016 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4292] ppid=4284 vsize=964272 CPUtime=0
/proc/4287/task/4292/stat : 4292 (java) S 4284 4284 1745 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 115408901 987414528 14545 18446744073709551615 4194304 4228012 140734277360608 140060964158448 140061068166176 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4293] ppid=4284 vsize=964272 CPUtime=0.23
/proc/4287/task/4293/stat : 4293 (java) R 4284 4284 1745 0 -1 4202560 2500 0 0 0 23 0 0 0 20 0 10 0 115408901 987414528 14545 18446744073709551615 4194304 4228012 140734277360608 140060963098472 140061055480208 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4294] ppid=4284 vsize=964272 CPUtime=0.24
/proc/4287/task/4294/stat : 4294 (java) R 4284 4284 1745 0 -1 4202560 2598 0 0 0 24 0 0 0 20 0 10 0 115408901 987414528 14545 18446744073709551615 4194304 4228012 140734277360608 140060962038312 140061060720894 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4295] ppid=4284 vsize=964272 CPUtime=0
/proc/4287/task/4295/stat : 4295 (java) S 4284 4284 1745 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 115408901 987414528 14545 18446744073709551615 4194304 4228012 140734277360608 140060961000656 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4296] ppid=4284 vsize=964272 CPUtime=0
/proc/4287/task/4296/stat : 4296 (java) S 4284 4284 1745 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 115408901 987414528 14545 18446744073709551615 4194304 4228012 140734277360608 140060959948160 140061068158539 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 1.05
Current children cumulated vsize (KiB) 973440

[startup+3.10076 s]
/proc/loadavg: 1.01 1.00 0.91 4/76 4296
/proc/meminfo: memFree=452356/1022884 swapFree=0/0
[pid=4284] ppid=4283 vsize=9168 CPUtime=0
/proc/4284/stat : 4284 (p2cudf-basic-1.) S 4283 4284 1745 0 -1 4202496 455 290 2 2 0 0 0 0 20 0 1 0 115408861 9388032 331 18446744073709551615 4194304 5129932 140734861675264 140734861673408 140027703104606 0 65536 16781316 65538 0 0 0 17 0 0 0 2 0 0
/proc/4284/statm: 2292 331 280 229 0 52 0
[pid=4287] ppid=4284 vsize=1051252 CPUtime=2.63
/proc/4287/stat : 4287 (java) S 4284 4284 1745 0 -1 4202496 73299 0 20 0 238 25 0 0 20 0 10 0 115408867 1076482048 67942 18446744073709551615 4194304 4228012 140734277360608 140734277351632 140061068144245 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 7 0 0
/proc/4287/statm: 262813 67942 2362 9 0 250163 0
[pid=4287/tid=4288] ppid=4284 vsize=1051252 CPUtime=1.22
/proc/4287/task/4288/stat : 4288 (java) S 4284 4284 1745 0 -1 4202560 47381 0 8 0 106 16 0 0 20 0 10 0 115408875 1076482048 67942 18446744073709551615 4194304 4228012 140734277360608 140061074678352 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 31 0 0
[pid=4287/tid=4289] ppid=4284 vsize=1051252 CPUtime=0.1
/proc/4287/task/4289/stat : 4289 (java) R 4284 4284 1745 0 -1 4202560 5049 0 0 0 9 1 0 0 20 0 10 0 115408892 1076482048 67942 18446744073709551615 4194304 4228012 140734277360608 140060967315984 140061052455136 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4290] ppid=4284 vsize=1051252 CPUtime=0
/proc/4287/task/4290/stat : 4290 (java) S 4284 4284 1745 0 -1 4202560 15 0 0 0 0 0 0 0 20 0 10 0 115408893 1076482048 67942 18446744073709551615 4194304 4228012 140734277360608 140060966262800 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4291] ppid=4284 vsize=1051252 CPUtime=0
/proc/4287/task/4291/stat : 4291 (java) S 4284 4284 1745 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 10 0 115408893 1076482048 67942 18446744073709551615 4194304 4228012 140734277360608 140060965210016 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4292] ppid=4284 vsize=1051252 CPUtime=0
/proc/4287/task/4292/stat : 4292 (java) S 4284 4284 1745 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 115408901 1076482048 67942 18446744073709551615 4194304 4228012 140734277360608 140060964158448 140061068166176 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4293] ppid=4284 vsize=1051252 CPUtime=0.62
/proc/4287/task/4293/stat : 4293 (java) S 4284 4284 1745 0 -1 4202560 10276 0 0 0 58 4 0 0 20 0 10 0 115408901 1076482048 67942 18446744073709551615 4194304 4228012 140734277360608 140060963105808 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4294] ppid=4284 vsize=1051252 CPUtime=0.65
/proc/4287/task/4294/stat : 4294 (java) S 4284 4284 1745 0 -1 4202560 9317 0 0 0 62 3 0 0 20 0 10 0 115408901 1076482048 67942 18446744073709551615 4194304 4228012 140734277360608 140060962053136 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4295] ppid=4284 vsize=1051252 CPUtime=0
/proc/4287/task/4295/stat : 4295 (java) S 4284 4284 1745 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 115408901 1076482048 67942 18446744073709551615 4194304 4228012 140734277360608 140060961000656 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4296] ppid=4284 vsize=1051252 CPUtime=0
/proc/4287/task/4296/stat : 4296 (java) S 4284 4284 1745 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 115408901 1076482048 67942 18446744073709551615 4194304 4228012 140734277360608 140060959948160 140061068158539 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 2.63
Current children cumulated vsize (KiB) 1060420

[startup+6.30078 s]
/proc/loadavg: 1.01 1.00 0.91 1/76 4296
/proc/meminfo: memFree=102676/1022884 swapFree=0/0
[pid=4284] ppid=4283 vsize=9168 CPUtime=0
/proc/4284/stat : 4284 (p2cudf-basic-1.) S 4283 4284 1745 0 -1 4202496 455 290 2 2 0 0 0 0 20 0 1 0 115408861 9388032 331 18446744073709551615 4194304 5129932 140734861675264 140734861673408 140027703104606 0 65536 16781316 65538 0 0 0 17 0 0 0 2 0 0
/proc/4284/statm: 2292 331 280 229 0 52 0
[pid=4287] ppid=4284 vsize=1051252 CPUtime=5.36
/proc/4287/stat : 4287 (java) S 4284 4284 1745 0 -1 4202496 129556 0 20 0 492 44 0 0 20 0 10 0 115408867 1076482048 123839 18446744073709551615 4194304 4228012 140734277360608 140734277351632 140061068144245 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 7 0 0
/proc/4287/statm: 262813 123839 2368 9 0 250163 0
[pid=4287/tid=4288] ppid=4284 vsize=1051252 CPUtime=2.87
/proc/4287/task/4288/stat : 4288 (java) R 4284 4284 1745 0 -1 4202560 47385 0 8 0 267 20 0 0 20 0 10 0 115408875 1076482048 123839 18446744073709551615 4194304 4228012 140734277360608 140061074670272 140060972169043 0 4 0 16800975 0 0 0 -1 0 0 0 75 0 0
[pid=4287/tid=4289] ppid=4284 vsize=1051252 CPUtime=1.14
/proc/4287/task/4289/stat : 4289 (java) S 4284 4284 1745 0 -1 4202560 61289 0 0 0 98 16 0 0 20 0 10 0 115408892 1076482048 123839 18446744073709551615 4194304 4228012 140734277360608 140060967316608 140061068158539 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4290] ppid=4284 vsize=1051252 CPUtime=0
/proc/4287/task/4290/stat : 4290 (java) S 4284 4284 1745 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 10 0 115408893 1076482048 123839 18446744073709551615 4194304 4228012 140734277360608 140060966262800 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4291] ppid=4284 vsize=1051252 CPUtime=0
/proc/4287/task/4291/stat : 4291 (java) S 4284 4284 1745 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 10 0 115408893 1076482048 123839 18446744073709551615 4194304 4228012 140734277360608 140060965210016 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4292] ppid=4284 vsize=1051252 CPUtime=0
/proc/4287/task/4292/stat : 4292 (java) S 4284 4284 1745 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 115408901 1076482048 123839 18446744073709551615 4194304 4228012 140734277360608 140060964158448 140061068166176 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4293] ppid=4284 vsize=1051252 CPUtime=0.65
/proc/4287/task/4293/stat : 4293 (java) S 4284 4284 1745 0 -1 4202560 10282 0 0 0 61 4 0 0 20 0 10 0 115408901 1076482048 123839 18446744073709551615 4194304 4228012 140734277360608 140060963105808 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4294] ppid=4284 vsize=1051252 CPUtime=0.68
/proc/4287/task/4294/stat : 4294 (java) S 4284 4284 1745 0 -1 4202560 9319 0 0 0 65 3 0 0 20 0 10 0 115408901 1076482048 123839 18446744073709551615 4194304 4228012 140734277360608 140060962053136 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4295] ppid=4284 vsize=1051252 CPUtime=0
/proc/4287/task/4295/stat : 4295 (java) S 4284 4284 1745 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 115408901 1076482048 123839 18446744073709551615 4194304 4228012 140734277360608 140060961000656 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4296] ppid=4284 vsize=1051252 CPUtime=0
/proc/4287/task/4296/stat : 4296 (java) S 4284 4284 1745 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 115408901 1076482048 123839 18446744073709551615 4194304 4228012 140734277360608 140060959948160 140061068158539 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 5.36
Current children cumulated vsize (KiB) 1060420

[startup+12.7006 s]
/proc/loadavg: 1.17 1.03 0.92 2/77 4297
/proc/meminfo: memFree=9588/1022884 swapFree=0/0
[pid=4284] ppid=4283 vsize=9168 CPUtime=0
/proc/4284/stat : 4284 (p2cudf-basic-1.) S 4283 4284 1745 0 -1 4202496 455 290 2 2 0 0 0 0 20 0 1 0 115408861 9388032 331 18446744073709551615 4194304 5129932 140734861675264 140734861673408 140027703104606 0 65536 16781316 65538 0 0 0 17 0 0 0 2 0 0
/proc/4284/statm: 2292 331 280 229 0 52 0
[pid=4287] ppid=4284 vsize=1052280 CPUtime=11.52
/proc/4287/stat : 4287 (java) S 4284 4284 1745 0 -1 4202496 153121 0 20 0 1098 54 0 0 20 0 11 0 115408867 1077534720 147404 18446744073709551615 4194304 4228012 140734277360608 140734277351632 140061068144245 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 7 0 0
/proc/4287/statm: 263070 147404 2381 9 0 250420 0
[pid=4287/tid=4288] ppid=4284 vsize=1052280 CPUtime=6.45
/proc/4287/task/4288/stat : 4288 (java) R 4284 4284 1745 0 -1 4202560 47769 0 8 0 623 22 0 0 20 0 11 0 115408875 1077534720 147404 18446744073709551615 4194304 4228012 140734277360608 140061074678072 140060972910065 0 4 0 16800975 0 0 0 -1 0 0 0 87 0 0
[pid=4287/tid=4289] ppid=4284 vsize=1052280 CPUtime=1.78
/proc/4287/task/4289/stat : 4289 (java) S 4284 4284 1745 0 -1 4202560 83996 0 0 0 155 23 0 0 20 0 11 0 115408892 1077534720 147404 18446744073709551615 4194304 4228012 140734277360608 140060967316608 140061068158539 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4290] ppid=4284 vsize=1052280 CPUtime=0
/proc/4287/task/4290/stat : 4290 (java) S 4284 4284 1745 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 115408893 1077534720 147404 18446744073709551615 4194304 4228012 140734277360608 140060966262800 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4291] ppid=4284 vsize=1052280 CPUtime=0
/proc/4287/task/4291/stat : 4291 (java) S 4284 4284 1745 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 115408893 1077534720 147404 18446744073709551615 4194304 4228012 140734277360608 140060965210016 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4292] ppid=4284 vsize=1052280 CPUtime=0
/proc/4287/task/4292/stat : 4292 (java) S 4284 4284 1745 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 115408901 1077534720 147404 18446744073709551615 4194304 4228012 140734277360608 140060964158448 140061068166176 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4293] ppid=4284 vsize=1052280 CPUtime=1.61
/proc/4287/task/4293/stat : 4293 (java) S 4284 4284 1745 0 -1 4202560 10434 0 0 0 157 4 0 0 20 0 11 0 115408901 1077534720 147404 18446744073709551615 4194304 4228012 140734277360608 140060963105808 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4294] ppid=4284 vsize=1052280 CPUtime=1.64
/proc/4287/task/4294/stat : 4294 (java) S 4284 4284 1745 0 -1 4202560 9635 0 0 0 160 4 0 0 20 0 11 0 115408901 1077534720 147404 18446744073709551615 4194304 4228012 140734277360608 140060962053136 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4295] ppid=4284 vsize=1052280 CPUtime=0
/proc/4287/task/4295/stat : 4295 (java) S 4284 4284 1745 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 115408901 1077534720 147404 18446744073709551615 4194304 4228012 140734277360608 140060961000656 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4296] ppid=4284 vsize=1052280 CPUtime=0
/proc/4287/task/4296/stat : 4296 (java) S 4284 4284 1745 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 115408901 1077534720 147404 18446744073709551615 4194304 4228012 140734277360608 140060959948160 140061068158539 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4297] ppid=4284 vsize=1052280 CPUtime=0
/proc/4287/task/4297/stat : 4297 (java) S 4284 4284 1745 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 115409876 1077534720 147404 18446744073709551615 4194304 4228012 140734277360608 140060958754656 140061068158539 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 11.52
Current children cumulated vsize (KiB) 1061448

[startup+25.5006 s]
/proc/loadavg: 1.13 1.03 0.92 2/77 4297
/proc/meminfo: memFree=10084/1022884 swapFree=0/0
[pid=4284] ppid=4283 vsize=9168 CPUtime=0
/proc/4284/stat : 4284 (p2cudf-basic-1.) S 4283 4284 1745 0 -1 4202496 455 290 2 2 0 0 0 0 20 0 1 0 115408861 9388032 331 18446744073709551615 4194304 5129932 140734861675264 140734861673408 140027703104606 0 65536 16781316 65538 0 0 0 17 0 0 0 2 0 0
/proc/4284/statm: 2292 331 280 229 0 52 0
[pid=4287] ppid=4284 vsize=1052280 CPUtime=24.15
/proc/4287/stat : 4287 (java) S 4284 4284 1745 0 -1 4202496 161202 0 20 0 2357 58 0 0 20 0 11 0 115408867 1077534720 155485 18446744073709551615 4194304 4228012 140734277360608 140734277351632 140061068144245 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 7 0 0
/proc/4287/statm: 263070 155485 2393 9 0 250420 0
[pid=4287/tid=4288] ppid=4284 vsize=1052280 CPUtime=17.5
/proc/4287/task/4288/stat : 4288 (java) R 4284 4284 1745 0 -1 4202560 47771 0 8 0 1728 22 0 0 20 0 11 0 115408875 1077534720 155485 18446744073709551615 4194304 4228012 140734277360608 140061074677816 140060972689534 0 4 0 16800975 0 0 0 -1 0 0 0 87 0 0
[pid=4287/tid=4289] ppid=4284 vsize=1052280 CPUtime=3.3
/proc/4287/task/4289/stat : 4289 (java) S 4284 4284 1745 0 -1 4202560 92070 0 0 0 303 27 0 0 20 0 11 0 115408892 1077534720 155485 18446744073709551615 4194304 4228012 140734277360608 140060967316608 140061068158539 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4290] ppid=4284 vsize=1052280 CPUtime=0
/proc/4287/task/4290/stat : 4290 (java) S 4284 4284 1745 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 115408893 1077534720 155485 18446744073709551615 4194304 4228012 140734277360608 140060966262800 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4291] ppid=4284 vsize=1052280 CPUtime=0
/proc/4287/task/4291/stat : 4291 (java) S 4284 4284 1745 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 115408893 1077534720 155485 18446744073709551615 4194304 4228012 140734277360608 140060965210016 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4292] ppid=4284 vsize=1052280 CPUtime=0
/proc/4287/task/4292/stat : 4292 (java) S 4284 4284 1745 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 115408901 1077534720 155485 18446744073709551615 4194304 4228012 140734277360608 140060964158448 140061068166176 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4293] ppid=4284 vsize=1052280 CPUtime=1.64
/proc/4287/task/4293/stat : 4293 (java) S 4284 4284 1745 0 -1 4202560 10438 0 0 0 160 4 0 0 20 0 11 0 115408901 1077534720 155485 18446744073709551615 4194304 4228012 140734277360608 140060963105808 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4294] ppid=4284 vsize=1052280 CPUtime=1.67
/proc/4287/task/4294/stat : 4294 (java) S 4284 4284 1745 0 -1 4202560 9636 0 0 0 163 4 0 0 20 0 11 0 115408901 1077534720 155485 18446744073709551615 4194304 4228012 140734277360608 140060962053136 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4295] ppid=4284 vsize=1052280 CPUtime=0
/proc/4287/task/4295/stat : 4295 (java) S 4284 4284 1745 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 115408901 1077534720 155485 18446744073709551615 4194304 4228012 140734277360608 140060961000656 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4296] ppid=4284 vsize=1052280 CPUtime=0
/proc/4287/task/4296/stat : 4296 (java) S 4284 4284 1745 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 115408901 1077534720 155485 18446744073709551615 4194304 4228012 140734277360608 140060959948160 140061068158539 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4297] ppid=4284 vsize=1052280 CPUtime=0
/proc/4287/task/4297/stat : 4297 (java) S 4284 4284 1745 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 115409876 1077534720 155485 18446744073709551615 4194304 4228012 140734277360608 140060958754656 140061068158539 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 24.15
Current children cumulated vsize (KiB) 1061448

[startup+51.1006 s]
/proc/loadavg: 1.15 1.04 0.93 2/77 4297
/proc/meminfo: memFree=10208/1022884 swapFree=0/0
[pid=4284] ppid=4283 vsize=9168 CPUtime=0
/proc/4284/stat : 4284 (p2cudf-basic-1.) S 4283 4284 1745 0 -1 4202496 455 290 2 2 0 0 0 0 20 0 1 0 115408861 9388032 331 18446744073709551615 4194304 5129932 140734861675264 140734861673408 140027703104606 0 65536 16781316 65538 0 0 0 17 0 0 0 2 0 0
/proc/4284/statm: 2292 331 280 229 0 52 0
[pid=4287] ppid=4284 vsize=1052280 CPUtime=49.47
/proc/4287/stat : 4287 (java) S 4284 4284 1745 0 -1 4202496 161909 0 20 0 4889 58 0 0 20 0 11 0 115408867 1077534720 156188 18446744073709551615 4194304 4228012 140734277360608 140734277351632 140061068144245 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 7 0 0
/proc/4287/statm: 263070 156188 2393 9 0 250420 0
[pid=4287/tid=4288] ppid=4284 vsize=1052280 CPUtime=40.29
/proc/4287/task/4288/stat : 4288 (java) S 4284 4284 1745 0 -1 4202560 47771 0 8 0 4007 22 0 0 20 0 11 0 115408875 1077534720 156188 18446744073709551615 4194304 4228012 140734277360608 140061074677616 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 87 0 0
[pid=4287/tid=4289] ppid=4284 vsize=1052280 CPUtime=5.79
/proc/4287/task/4289/stat : 4289 (java) R 4284 4284 1745 0 -1 4202560 92774 0 0 0 552 27 0 0 20 0 11 0 115408892 1077534720 156188 18446744073709551615 4194304 4228012 140734277360608 140060967316016 140061052506533 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4290] ppid=4284 vsize=1052280 CPUtime=0
/proc/4287/task/4290/stat : 4290 (java) S 4284 4284 1745 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 115408893 1077534720 156188 18446744073709551615 4194304 4228012 140734277360608 140060966262800 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4291] ppid=4284 vsize=1052280 CPUtime=0
/proc/4287/task/4291/stat : 4291 (java) S 4284 4284 1745 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 115408893 1077534720 156188 18446744073709551615 4194304 4228012 140734277360608 140060965210016 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4292] ppid=4284 vsize=1052280 CPUtime=0
/proc/4287/task/4292/stat : 4292 (java) S 4284 4284 1745 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 115408901 1077534720 156188 18446744073709551615 4194304 4228012 140734277360608 140060964158448 140061068166176 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4293] ppid=4284 vsize=1052280 CPUtime=1.66
/proc/4287/task/4293/stat : 4293 (java) S 4284 4284 1745 0 -1 4202560 10438 0 0 0 162 4 0 0 20 0 11 0 115408901 1077534720 156188 18446744073709551615 4194304 4228012 140734277360608 140060963105808 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4294] ppid=4284 vsize=1052280 CPUtime=1.68
/proc/4287/task/4294/stat : 4294 (java) S 4284 4284 1745 0 -1 4202560 9636 0 0 0 164 4 0 0 20 0 11 0 115408901 1077534720 156188 18446744073709551615 4194304 4228012 140734277360608 140060962053136 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4295] ppid=4284 vsize=1052280 CPUtime=0
/proc/4287/task/4295/stat : 4295 (java) S 4284 4284 1745 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 115408901 1077534720 156188 18446744073709551615 4194304 4228012 140734277360608 140060961000656 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4296] ppid=4284 vsize=1052280 CPUtime=0.02
/proc/4287/task/4296/stat : 4296 (java) S 4284 4284 1745 0 -1 4202560 4 0 0 0 0 2 0 0 20 0 11 0 115408901 1077534720 156188 18446744073709551615 4194304 4228012 140734277360608 140060959948160 140061068158539 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4297] ppid=4284 vsize=1052280 CPUtime=0
/proc/4287/task/4297/stat : 4297 (java) S 4284 4284 1745 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 115409876 1077534720 156188 18446744073709551615 4194304 4228012 140734277360608 140060958754656 140061068158539 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 49.47
Current children cumulated vsize (KiB) 1061448

[startup+102.301 s]
/proc/loadavg: 1.06 1.03 0.93 2/77 4297
/proc/meminfo: memFree=9504/1022884 swapFree=0/0
[pid=4284] ppid=4283 vsize=9168 CPUtime=0
/proc/4284/stat : 4284 (p2cudf-basic-1.) S 4283 4284 1745 0 -1 4202496 455 290 2 2 0 0 0 0 20 0 1 0 115408861 9388032 331 18446744073709551615 4194304 5129932 140734861675264 140734861673408 140027703104606 0 65536 16781316 65538 0 0 0 17 0 0 0 2 0 0
/proc/4284/statm: 2292 331 280 229 0 52 0
[pid=4287] ppid=4284 vsize=1052280 CPUtime=100.14
/proc/4287/stat : 4287 (java) S 4284 4284 1745 0 -1 4202496 163682 0 20 0 9955 59 0 0 20 0 11 0 115408867 1077534720 157957 18446744073709551615 4194304 4228012 140734277360608 140734277351632 140061068144245 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 7 0 0
/proc/4287/statm: 263070 157957 2393 9 0 250420 0
[pid=4287/tid=4288] ppid=4284 vsize=1052280 CPUtime=87.92
/proc/4287/task/4288/stat : 4288 (java) S 4284 4284 1745 0 -1 4202560 47771 0 8 0 8770 22 0 0 20 0 11 0 115408875 1077534720 157957 18446744073709551615 4194304 4228012 140734277360608 140061074677616 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 87 0 0
[pid=4287/tid=4289] ppid=4284 vsize=1052280 CPUtime=8.79
/proc/4287/task/4289/stat : 4289 (java) R 4284 4284 1745 0 -1 4202560 94544 0 0 0 851 28 0 0 20 0 11 0 115408892 1077534720 157957 18446744073709551615 4194304 4228012 140734277360608 140060967316016 140061052506533 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4290] ppid=4284 vsize=1052280 CPUtime=0
/proc/4287/task/4290/stat : 4290 (java) S 4284 4284 1745 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 115408893 1077534720 157957 18446744073709551615 4194304 4228012 140734277360608 140060966262800 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4291] ppid=4284 vsize=1052280 CPUtime=0
/proc/4287/task/4291/stat : 4291 (java) S 4284 4284 1745 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 115408893 1077534720 157957 18446744073709551615 4194304 4228012 140734277360608 140060965210016 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4292] ppid=4284 vsize=1052280 CPUtime=0
/proc/4287/task/4292/stat : 4292 (java) S 4284 4284 1745 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 115408901 1077534720 157957 18446744073709551615 4194304 4228012 140734277360608 140060964158448 140061068166176 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4293] ppid=4284 vsize=1052280 CPUtime=1.66
/proc/4287/task/4293/stat : 4293 (java) S 4284 4284 1745 0 -1 4202560 10438 0 0 0 162 4 0 0 20 0 11 0 115408901 1077534720 157957 18446744073709551615 4194304 4228012 140734277360608 140060963105808 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4294] ppid=4284 vsize=1052280 CPUtime=1.68
/proc/4287/task/4294/stat : 4294 (java) S 4284 4284 1745 0 -1 4202560 9636 0 0 0 164 4 0 0 20 0 11 0 115408901 1077534720 157957 18446744073709551615 4194304 4228012 140734277360608 140060962053136 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4295] ppid=4284 vsize=1052280 CPUtime=0
/proc/4287/task/4295/stat : 4295 (java) S 4284 4284 1745 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 115408901 1077534720 157957 18446744073709551615 4194304 4228012 140734277360608 140060961000656 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4296] ppid=4284 vsize=1052280 CPUtime=0.05
/proc/4287/task/4296/stat : 4296 (java) S 4284 4284 1745 0 -1 4202560 7 0 0 0 2 3 0 0 20 0 11 0 115408901 1077534720 157957 18446744073709551615 4194304 4228012 140734277360608 140060959948160 140061068158539 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4297] ppid=4284 vsize=1052280 CPUtime=0
/proc/4287/task/4297/stat : 4297 (java) S 4284 4284 1745 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 115409876 1077534720 157957 18446744073709551615 4194304 4228012 140734277360608 140060958754656 140061068158539 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 100.14
Current children cumulated vsize (KiB) 1061448

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

[startup+102.408 s]
/proc/loadavg: 1.06 1.03 0.93 2/77 4297
/proc/meminfo: memFree=9504/1022884 swapFree=0/0
[pid=4284] ppid=4283 vsize=9168 CPUtime=0
/proc/4284/stat : 4284 (p2cudf-basic-1.) S 4283 4284 1745 0 -1 4202496 455 290 2 2 0 0 0 0 20 0 1 0 115408861 9388032 331 18446744073709551615 4194304 5129932 140734861675264 140734861673408 140027703104606 0 65536 16781316 65538 0 0 0 17 0 0 0 2 0 0
/proc/4284/statm: 2292 331 280 229 0 52 0
[pid=4287] ppid=4284 vsize=1052280 CPUtime=100.24
/proc/4287/stat : 4287 (java) S 4284 4284 1745 0 -1 4202496 163682 0 20 0 9965 59 0 0 20 0 11 0 115408867 1077534720 157957 18446744073709551615 4194304 4228012 140734277360608 140734277351632 140061068144245 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 7 0 0
/proc/4287/statm: 263070 157957 2393 9 0 250420 0
[pid=4287/tid=4288] ppid=4284 vsize=1052280 CPUtime=87.92
/proc/4287/task/4288/stat : 4288 (java) S 4284 4284 1745 0 -1 4202560 47771 0 8 0 8770 22 0 0 20 0 11 0 115408875 1077534720 157957 18446744073709551615 4194304 4228012 140734277360608 140061074677616 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 87 0 0
[pid=4287/tid=4289] ppid=4284 vsize=1052280 CPUtime=8.89
/proc/4287/task/4289/stat : 4289 (java) R 4284 4284 1745 0 -1 4202560 94544 0 0 0 861 28 0 0 20 0 11 0 115408892 1077534720 157957 18446744073709551615 4194304 4228012 140734277360608 140060967316016 140061052506503 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4290] ppid=4284 vsize=1052280 CPUtime=0
/proc/4287/task/4290/stat : 4290 (java) S 4284 4284 1745 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 115408893 1077534720 157957 18446744073709551615 4194304 4228012 140734277360608 140060966262800 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4291] ppid=4284 vsize=1052280 CPUtime=0
/proc/4287/task/4291/stat : 4291 (java) S 4284 4284 1745 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 115408893 1077534720 157957 18446744073709551615 4194304 4228012 140734277360608 140060965210016 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4292] ppid=4284 vsize=1052280 CPUtime=0
/proc/4287/task/4292/stat : 4292 (java) S 4284 4284 1745 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 115408901 1077534720 157957 18446744073709551615 4194304 4228012 140734277360608 140060964158448 140061068166176 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4293] ppid=4284 vsize=1052280 CPUtime=1.66
/proc/4287/task/4293/stat : 4293 (java) S 4284 4284 1745 0 -1 4202560 10438 0 0 0 162 4 0 0 20 0 11 0 115408901 1077534720 157957 18446744073709551615 4194304 4228012 140734277360608 140060963105808 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4294] ppid=4284 vsize=1052280 CPUtime=1.68
/proc/4287/task/4294/stat : 4294 (java) S 4284 4284 1745 0 -1 4202560 9636 0 0 0 164 4 0 0 20 0 11 0 115408901 1077534720 157957 18446744073709551615 4194304 4228012 140734277360608 140060962053136 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4295] ppid=4284 vsize=1052280 CPUtime=0
/proc/4287/task/4295/stat : 4295 (java) S 4284 4284 1745 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 115408901 1077534720 157957 18446744073709551615 4194304 4228012 140734277360608 140060961000656 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4296] ppid=4284 vsize=1052280 CPUtime=0.05
/proc/4287/task/4296/stat : 4296 (java) S 4284 4284 1745 0 -1 4202560 7 0 0 0 2 3 0 0 20 0 11 0 115408901 1077534720 157957 18446744073709551615 4194304 4228012 140734277360608 140060959948160 140061068158539 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4297] ppid=4284 vsize=1052280 CPUtime=0
/proc/4287/task/4297/stat : 4297 (java) S 4284 4284 1745 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 115409876 1077534720 157957 18446744073709551615 4194304 4228012 140734277360608 140060958754656 140061068158539 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 100.24
Current children cumulated vsize (KiB) 1061448

[startup+128.001 s]
/proc/loadavg: 1.04 1.03 0.93 2/77 4297
/proc/meminfo: memFree=10272/1022884 swapFree=0/0
[pid=4284] ppid=4283 vsize=9168 CPUtime=0
/proc/4284/stat : 4284 (p2cudf-basic-1.) S 4283 4284 1745 0 -1 4202496 455 290 2 2 0 0 0 0 20 0 1 0 115408861 9388032 331 18446744073709551615 4194304 5129932 140734861675264 140734861673408 140027703104606 0 65536 16781316 65538 0 0 0 17 0 0 0 2 0 0
/proc/4284/statm: 2292 331 280 229 0 52 0
[pid=4287] ppid=4284 vsize=1052280 CPUtime=125.55
/proc/4287/stat : 4287 (java) S 4284 4284 1745 0 -1 4202496 165575 0 20 0 12495 60 0 0 20 0 11 0 115408867 1077534720 159846 18446744073709551615 4194304 4228012 140734277360608 140734277351632 140061068144245 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 7 0 0
/proc/4287/statm: 263070 159846 2393 9 0 250420 0
[pid=4287/tid=4288] ppid=4284 vsize=1052280 CPUtime=111.13
/proc/4287/task/4288/stat : 4288 (java) R 4284 4284 1745 0 -1 4202560 47771 0 8 0 11091 22 0 0 20 0 11 0 115408875 1077534720 159846 18446744073709551615 4194304 4228012 140734277360608 140061074677816 140060973378504 0 4 0 16800975 0 0 0 -1 0 0 0 87 0 0
[pid=4287/tid=4289] ppid=4284 vsize=1052280 CPUtime=10.95
/proc/4287/task/4289/stat : 4289 (java) S 4284 4284 1745 0 -1 4202560 96434 0 0 0 1066 29 0 0 20 0 11 0 115408892 1077534720 159846 18446744073709551615 4194304 4228012 140734277360608 140060967316608 140061068158539 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4290] ppid=4284 vsize=1052280 CPUtime=0
/proc/4287/task/4290/stat : 4290 (java) S 4284 4284 1745 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 115408893 1077534720 159846 18446744073709551615 4194304 4228012 140734277360608 140060966262800 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4291] ppid=4284 vsize=1052280 CPUtime=0
/proc/4287/task/4291/stat : 4291 (java) S 4284 4284 1745 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 115408893 1077534720 159846 18446744073709551615 4194304 4228012 140734277360608 140060965210016 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4292] ppid=4284 vsize=1052280 CPUtime=0
/proc/4287/task/4292/stat : 4292 (java) S 4284 4284 1745 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 115408901 1077534720 159846 18446744073709551615 4194304 4228012 140734277360608 140060964158448 140061068166176 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4293] ppid=4284 vsize=1052280 CPUtime=1.68
/proc/4287/task/4293/stat : 4293 (java) S 4284 4284 1745 0 -1 4202560 10438 0 0 0 164 4 0 0 20 0 11 0 115408901 1077534720 159846 18446744073709551615 4194304 4228012 140734277360608 140060963105808 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4294] ppid=4284 vsize=1052280 CPUtime=1.7
/proc/4287/task/4294/stat : 4294 (java) S 4284 4284 1745 0 -1 4202560 9636 0 0 0 166 4 0 0 20 0 11 0 115408901 1077534720 159846 18446744073709551615 4194304 4228012 140734277360608 140060962053136 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4295] ppid=4284 vsize=1052280 CPUtime=0
/proc/4287/task/4295/stat : 4295 (java) S 4284 4284 1745 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 115408901 1077534720 159846 18446744073709551615 4194304 4228012 140734277360608 140060961000656 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4296] ppid=4284 vsize=1052280 CPUtime=0.05
/proc/4287/task/4296/stat : 4296 (java) S 4284 4284 1745 0 -1 4202560 10 0 0 0 2 3 0 0 20 0 11 0 115408901 1077534720 159846 18446744073709551615 4194304 4228012 140734277360608 140060959948160 140061068158539 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4297] ppid=4284 vsize=1052280 CPUtime=0
/proc/4287/task/4297/stat : 4297 (java) S 4284 4284 1745 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 115409876 1077534720 159846 18446744073709551615 4194304 4228012 140734277360608 140060958754656 140061068158539 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 125.55
Current children cumulated vsize (KiB) 1061448

[startup+140.801 s]
/proc/loadavg: 1.03 1.03 0.93 2/77 4297
/proc/meminfo: memFree=10272/1022884 swapFree=0/0
[pid=4284] ppid=4283 vsize=9168 CPUtime=0
/proc/4284/stat : 4284 (p2cudf-basic-1.) S 4283 4284 1745 0 -1 4202496 455 290 2 2 0 0 0 0 20 0 1 0 115408861 9388032 331 18446744073709551615 4194304 5129932 140734861675264 140734861673408 140027703104606 0 65536 16781316 65538 0 0 0 17 0 0 0 2 0 0
/proc/4284/statm: 2292 331 280 229 0 52 0
[pid=4287] ppid=4284 vsize=1052280 CPUtime=138.22
/proc/4287/stat : 4287 (java) S 4284 4284 1745 0 -1 4202496 165579 0 20 0 13762 60 0 0 20 0 11 0 115408867 1077534720 159846 18446744073709551615 4194304 4228012 140734277360608 140734277351632 140061068144245 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 7 0 0
/proc/4287/statm: 263070 159846 2393 9 0 250420 0
[pid=4287/tid=4288] ppid=4284 vsize=1052280 CPUtime=123.05
/proc/4287/task/4288/stat : 4288 (java) R 4284 4284 1745 0 -1 4202560 47771 0 8 0 12283 22 0 0 20 0 11 0 115408875 1077534720 159846 18446744073709551615 4194304 4228012 140734277360608 140061074677816 140060972909901 0 4 0 16800975 0 0 0 -1 0 0 0 87 0 0
[pid=4287/tid=4289] ppid=4284 vsize=1052280 CPUtime=11.69
/proc/4287/task/4289/stat : 4289 (java) S 4284 4284 1745 0 -1 4202560 96437 0 0 0 1140 29 0 0 20 0 11 0 115408892 1077534720 159846 18446744073709551615 4194304 4228012 140734277360608 140060967316608 140061068158539 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4290] ppid=4284 vsize=1052280 CPUtime=0
/proc/4287/task/4290/stat : 4290 (java) S 4284 4284 1745 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 115408893 1077534720 159846 18446744073709551615 4194304 4228012 140734277360608 140060966262800 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4291] ppid=4284 vsize=1052280 CPUtime=0
/proc/4287/task/4291/stat : 4291 (java) S 4284 4284 1745 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 115408893 1077534720 159846 18446744073709551615 4194304 4228012 140734277360608 140060965210016 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4292] ppid=4284 vsize=1052280 CPUtime=0
/proc/4287/task/4292/stat : 4292 (java) S 4284 4284 1745 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 115408901 1077534720 159846 18446744073709551615 4194304 4228012 140734277360608 140060964158448 140061068166176 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4293] ppid=4284 vsize=1052280 CPUtime=1.68
/proc/4287/task/4293/stat : 4293 (java) S 4284 4284 1745 0 -1 4202560 10438 0 0 0 164 4 0 0 20 0 11 0 115408901 1077534720 159846 18446744073709551615 4194304 4228012 140734277360608 140060963105808 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4294] ppid=4284 vsize=1052280 CPUtime=1.7
/proc/4287/task/4294/stat : 4294 (java) S 4284 4284 1745 0 -1 4202560 9636 0 0 0 166 4 0 0 20 0 11 0 115408901 1077534720 159846 18446744073709551615 4194304 4228012 140734277360608 140060962053136 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4295] ppid=4284 vsize=1052280 CPUtime=0
/proc/4287/task/4295/stat : 4295 (java) S 4284 4284 1745 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 115408901 1077534720 159846 18446744073709551615 4194304 4228012 140734277360608 140060961000656 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4296] ppid=4284 vsize=1052280 CPUtime=0.06
/proc/4287/task/4296/stat : 4296 (java) S 4284 4284 1745 0 -1 4202560 11 0 0 0 3 3 0 0 20 0 11 0 115408901 1077534720 159846 18446744073709551615 4194304 4228012 140734277360608 140060959948160 140061068158539 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4297] ppid=4284 vsize=1052280 CPUtime=0
/proc/4287/task/4297/stat : 4297 (java) S 4284 4284 1745 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 115409876 1077534720 159846 18446744073709551615 4194304 4228012 140734277360608 140060958754656 140061068158539 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 138.22
Current children cumulated vsize (KiB) 1061448

[startup+147.201 s]
/proc/loadavg: 1.03 1.03 0.93 2/77 4297
/proc/meminfo: memFree=10272/1022884 swapFree=0/0
[pid=4284] ppid=4283 vsize=9168 CPUtime=0
/proc/4284/stat : 4284 (p2cudf-basic-1.) S 4283 4284 1745 0 -1 4202496 455 290 2 2 0 0 0 0 20 0 1 0 115408861 9388032 331 18446744073709551615 4194304 5129932 140734861675264 140734861673408 140027703104606 0 65536 16781316 65538 0 0 0 17 0 0 0 2 0 0
/proc/4284/statm: 2292 331 280 229 0 52 0
[pid=4287] ppid=4284 vsize=1052280 CPUtime=144.56
/proc/4287/stat : 4287 (java) S 4284 4284 1745 0 -1 4202496 165579 0 20 0 14396 60 0 0 20 0 11 0 115408867 1077534720 159846 18446744073709551615 4194304 4228012 140734277360608 140734277351632 140061068144245 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 7 0 0
/proc/4287/statm: 263070 159846 2393 9 0 250420 0
[pid=4287/tid=4288] ppid=4284 vsize=1052280 CPUtime=129.39
/proc/4287/task/4288/stat : 4288 (java) R 4284 4284 1745 0 -1 4202560 47771 0 8 0 12917 22 0 0 20 0 11 0 115408875 1077534720 159846 18446744073709551615 4194304 4228012 140734277360608 140061074677816 140060972673341 0 4 0 16800975 0 0 0 -1 0 0 0 87 0 0
[pid=4287/tid=4289] ppid=4284 vsize=1052280 CPUtime=11.69
/proc/4287/task/4289/stat : 4289 (java) S 4284 4284 1745 0 -1 4202560 96437 0 0 0 1140 29 0 0 20 0 11 0 115408892 1077534720 159846 18446744073709551615 4194304 4228012 140734277360608 140060967316608 140061068158539 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4290] ppid=4284 vsize=1052280 CPUtime=0
/proc/4287/task/4290/stat : 4290 (java) S 4284 4284 1745 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 115408893 1077534720 159846 18446744073709551615 4194304 4228012 140734277360608 140060966262800 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4291] ppid=4284 vsize=1052280 CPUtime=0
/proc/4287/task/4291/stat : 4291 (java) S 4284 4284 1745 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 115408893 1077534720 159846 18446744073709551615 4194304 4228012 140734277360608 140060965210016 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4292] ppid=4284 vsize=1052280 CPUtime=0
/proc/4287/task/4292/stat : 4292 (java) S 4284 4284 1745 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 115408901 1077534720 159846 18446744073709551615 4194304 4228012 140734277360608 140060964158448 140061068166176 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4293] ppid=4284 vsize=1052280 CPUtime=1.68
/proc/4287/task/4293/stat : 4293 (java) S 4284 4284 1745 0 -1 4202560 10438 0 0 0 164 4 0 0 20 0 11 0 115408901 1077534720 159846 18446744073709551615 4194304 4228012 140734277360608 140060963105808 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4294] ppid=4284 vsize=1052280 CPUtime=1.7
/proc/4287/task/4294/stat : 4294 (java) S 4284 4284 1745 0 -1 4202560 9636 0 0 0 166 4 0 0 20 0 11 0 115408901 1077534720 159846 18446744073709551615 4194304 4228012 140734277360608 140060962053136 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4295] ppid=4284 vsize=1052280 CPUtime=0
/proc/4287/task/4295/stat : 4295 (java) S 4284 4284 1745 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 115408901 1077534720 159846 18446744073709551615 4194304 4228012 140734277360608 140060961000656 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4296] ppid=4284 vsize=1052280 CPUtime=0.06
/proc/4287/task/4296/stat : 4296 (java) S 4284 4284 1745 0 -1 4202560 11 0 0 0 3 3 0 0 20 0 11 0 115408901 1077534720 159846 18446744073709551615 4194304 4228012 140734277360608 140060959948160 140061068158539 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4297] ppid=4284 vsize=1052280 CPUtime=0
/proc/4287/task/4297/stat : 4297 (java) S 4284 4284 1745 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 115409876 1077534720 159846 18446744073709551615 4194304 4228012 140734277360608 140060958754656 140061068158539 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 144.56
Current children cumulated vsize (KiB) 1061448

[startup+148.801 s]
/proc/loadavg: 1.03 1.03 0.93 2/77 4297
/proc/meminfo: memFree=10272/1022884 swapFree=0/0
[pid=4284] ppid=4283 vsize=9168 CPUtime=0
/proc/4284/stat : 4284 (p2cudf-basic-1.) S 4283 4284 1745 0 -1 4202496 455 290 2 2 0 0 0 0 20 0 1 0 115408861 9388032 331 18446744073709551615 4194304 5129932 140734861675264 140734861673408 140027703104606 0 65536 16781316 65538 0 0 0 17 0 0 0 2 0 0
/proc/4284/statm: 2292 331 280 229 0 52 0
[pid=4287] ppid=4284 vsize=1052280 CPUtime=146.14
/proc/4287/stat : 4287 (java) S 4284 4284 1745 0 -1 4202496 166248 0 20 0 14554 60 0 0 20 0 11 0 115408867 1077534720 160515 18446744073709551615 4194304 4228012 140734277360608 140734277351632 140061068144245 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 7 0 0
/proc/4287/statm: 263070 160515 2393 9 0 250420 0
[pid=4287/tid=4288] ppid=4284 vsize=1052280 CPUtime=130.2
/proc/4287/task/4288/stat : 4288 (java) R 4284 4284 1745 0 -1 4202560 47771 0 8 0 12998 22 0 0 20 0 11 0 115408875 1077534720 160515 18446744073709551615 4194304 4228012 140734277360608 140061074677816 140060972649401 0 4 0 16800975 0 0 0 -1 0 0 0 87 0 0
[pid=4287/tid=4289] ppid=4284 vsize=1052280 CPUtime=12.46
/proc/4287/task/4289/stat : 4289 (java) S 4284 4284 1745 0 -1 4202560 97106 0 0 0 1217 29 0 0 20 0 11 0 115408892 1077534720 160515 18446744073709551615 4194304 4228012 140734277360608 140060967316608 140061068158539 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4290] ppid=4284 vsize=1052280 CPUtime=0
/proc/4287/task/4290/stat : 4290 (java) S 4284 4284 1745 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 115408893 1077534720 160515 18446744073709551615 4194304 4228012 140734277360608 140060966262800 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4291] ppid=4284 vsize=1052280 CPUtime=0
/proc/4287/task/4291/stat : 4291 (java) S 4284 4284 1745 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 115408893 1077534720 160515 18446744073709551615 4194304 4228012 140734277360608 140060965210016 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4292] ppid=4284 vsize=1052280 CPUtime=0
/proc/4287/task/4292/stat : 4292 (java) S 4284 4284 1745 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 115408901 1077534720 160515 18446744073709551615 4194304 4228012 140734277360608 140060964158448 140061068166176 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4293] ppid=4284 vsize=1052280 CPUtime=1.68
/proc/4287/task/4293/stat : 4293 (java) S 4284 4284 1745 0 -1 4202560 10438 0 0 0 164 4 0 0 20 0 11 0 115408901 1077534720 160515 18446744073709551615 4194304 4228012 140734277360608 140060963105808 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4294] ppid=4284 vsize=1052280 CPUtime=1.7
/proc/4287/task/4294/stat : 4294 (java) S 4284 4284 1745 0 -1 4202560 9636 0 0 0 166 4 0 0 20 0 11 0 115408901 1077534720 160515 18446744073709551615 4194304 4228012 140734277360608 140060962053136 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4295] ppid=4284 vsize=1052280 CPUtime=0
/proc/4287/task/4295/stat : 4295 (java) S 4284 4284 1745 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 115408901 1077534720 160515 18446744073709551615 4194304 4228012 140734277360608 140060961000656 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4296] ppid=4284 vsize=1052280 CPUtime=0.06
/proc/4287/task/4296/stat : 4296 (java) S 4284 4284 1745 0 -1 4202560 11 0 0 0 3 3 0 0 20 0 11 0 115408901 1077534720 160515 18446744073709551615 4194304 4228012 140734277360608 140060959948160 140061068158539 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4297] ppid=4284 vsize=1052280 CPUtime=0
/proc/4287/task/4297/stat : 4297 (java) S 4284 4284 1745 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 115409876 1077534720 160515 18446744073709551615 4194304 4228012 140734277360608 140060958754656 140061068158539 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 146.14
Current children cumulated vsize (KiB) 1061448

[startup+149.601 s]
/proc/loadavg: 1.03 1.02 0.93 2/77 4297
/proc/meminfo: memFree=9900/1022884 swapFree=0/0
[pid=4284] ppid=4283 vsize=9168 CPUtime=0
/proc/4284/stat : 4284 (p2cudf-basic-1.) S 4283 4284 1745 0 -1 4202496 455 290 2 2 0 0 0 0 20 0 1 0 115408861 9388032 331 18446744073709551615 4194304 5129932 140734861675264 140734861673408 140027703104606 0 65536 16781316 65538 0 0 0 17 0 0 0 2 0 0
/proc/4284/statm: 2292 331 280 229 0 52 0
[pid=4287] ppid=4284 vsize=1052280 CPUtime=146.93
/proc/4287/stat : 4287 (java) S 4284 4284 1745 0 -1 4202496 166248 0 20 0 14633 60 0 0 20 0 11 0 115408867 1077534720 160515 18446744073709551615 4194304 4228012 140734277360608 140734277351632 140061068144245 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 7 0 0
/proc/4287/statm: 263070 160515 2393 9 0 250420 0
[pid=4287/tid=4288] ppid=4284 vsize=1052280 CPUtime=131
/proc/4287/task/4288/stat : 4288 (java) R 4284 4284 1745 0 -1 4202560 47771 0 8 0 13078 22 0 0 20 0 11 0 115408875 1077534720 160515 18446744073709551615 4194304 4228012 140734277360608 140061074677816 140060972689452 0 4 0 16800975 0 0 0 -1 0 0 0 87 0 0
[pid=4287/tid=4289] ppid=4284 vsize=1052280 CPUtime=12.46
/proc/4287/task/4289/stat : 4289 (java) S 4284 4284 1745 0 -1 4202560 97106 0 0 0 1217 29 0 0 20 0 11 0 115408892 1077534720 160515 18446744073709551615 4194304 4228012 140734277360608 140060967316608 140061068158539 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4290] ppid=4284 vsize=1052280 CPUtime=0
/proc/4287/task/4290/stat : 4290 (java) S 4284 4284 1745 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 115408893 1077534720 160515 18446744073709551615 4194304 4228012 140734277360608 140060966262800 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4291] ppid=4284 vsize=1052280 CPUtime=0
/proc/4287/task/4291/stat : 4291 (java) S 4284 4284 1745 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 115408893 1077534720 160515 18446744073709551615 4194304 4228012 140734277360608 140060965210016 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4292] ppid=4284 vsize=1052280 CPUtime=0
/proc/4287/task/4292/stat : 4292 (java) S 4284 4284 1745 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 115408901 1077534720 160515 18446744073709551615 4194304 4228012 140734277360608 140060964158448 140061068166176 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4293] ppid=4284 vsize=1052280 CPUtime=1.68
/proc/4287/task/4293/stat : 4293 (java) S 4284 4284 1745 0 -1 4202560 10438 0 0 0 164 4 0 0 20 0 11 0 115408901 1077534720 160515 18446744073709551615 4194304 4228012 140734277360608 140060963105808 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4294] ppid=4284 vsize=1052280 CPUtime=1.7
/proc/4287/task/4294/stat : 4294 (java) S 4284 4284 1745 0 -1 4202560 9636 0 0 0 166 4 0 0 20 0 11 0 115408901 1077534720 160515 18446744073709551615 4194304 4228012 140734277360608 140060962053136 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4295] ppid=4284 vsize=1052280 CPUtime=0
/proc/4287/task/4295/stat : 4295 (java) S 4284 4284 1745 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 115408901 1077534720 160515 18446744073709551615 4194304 4228012 140734277360608 140060961000656 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4296] ppid=4284 vsize=1052280 CPUtime=0.06
/proc/4287/task/4296/stat : 4296 (java) S 4284 4284 1745 0 -1 4202560 11 0 0 0 3 3 0 0 20 0 11 0 115408901 1077534720 160515 18446744073709551615 4194304 4228012 140734277360608 140060959948160 140061068158539 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4297] ppid=4284 vsize=1052280 CPUtime=0
/proc/4287/task/4297/stat : 4297 (java) S 4284 4284 1745 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 115409876 1077534720 160515 18446744073709551615 4194304 4228012 140734277360608 140060958754656 140061068158539 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 146.93
Current children cumulated vsize (KiB) 1061448

[startup+150.401 s]
/proc/loadavg: 1.03 1.02 0.93 2/77 4297
/proc/meminfo: memFree=9900/1022884 swapFree=0/0
[pid=4284] ppid=4283 vsize=9168 CPUtime=0
/proc/4284/stat : 4284 (p2cudf-basic-1.) S 4283 4284 1745 0 -1 4202496 455 290 2 2 0 0 0 0 20 0 1 0 115408861 9388032 331 18446744073709551615 4194304 5129932 140734861675264 140734861673408 140027703104606 0 65536 16781316 65538 0 0 0 17 0 0 0 2 0 0
/proc/4284/statm: 2292 331 280 229 0 52 0
[pid=4287] ppid=4284 vsize=1053308 CPUtime=147.55
/proc/4287/stat : 4287 (java) S 4284 4284 1745 0 -1 4202496 166262 0 20 0 14695 60 0 0 20 0 11 0 115408867 1078587392 160527 18446744073709551615 4194304 4228012 140734277360608 140734277351632 140061068144245 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 7 0 0
/proc/4287/statm: 263327 160527 2393 9 0 250677 0
[pid=4287/tid=4288] ppid=4284 vsize=1053308 CPUtime=131.56
/proc/4287/task/4288/stat : 4288 (java) S 4284 4284 1745 0 -1 4202560 47779 0 8 0 13134 22 0 0 20 0 11 0 115408875 1078587392 160527 18446744073709551615 4194304 4228012 140734277360608 140061074678704 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 87 0 0
[pid=4287/tid=4289] ppid=4284 vsize=1053308 CPUtime=12.46
/proc/4287/task/4289/stat : 4289 (java) S 4284 4284 1745 0 -1 4202560 97106 0 0 0 1217 29 0 0 20 0 11 0 115408892 1078587392 160527 18446744073709551615 4194304 4228012 140734277360608 140060967316608 140061068158539 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4290] ppid=4284 vsize=1053308 CPUtime=0
/proc/4287/task/4290/stat : 4290 (java) S 4284 4284 1745 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 115408893 1078587392 160527 18446744073709551615 4194304 4228012 140734277360608 140060966262800 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4291] ppid=4284 vsize=1053308 CPUtime=0
/proc/4287/task/4291/stat : 4291 (java) S 4284 4284 1745 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 115408893 1078587392 160527 18446744073709551615 4194304 4228012 140734277360608 140060965210016 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4292] ppid=4284 vsize=1053308 CPUtime=0
/proc/4287/task/4292/stat : 4292 (java) S 4284 4284 1745 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 115408901 1078587392 160527 18446744073709551615 4194304 4228012 140734277360608 140060964158448 140061068166176 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4293] ppid=4284 vsize=1053308 CPUtime=1.7
/proc/4287/task/4293/stat : 4293 (java) S 4284 4284 1745 0 -1 4202560 10438 0 0 0 166 4 0 0 20 0 11 0 115408901 1078587392 160527 18446744073709551615 4194304 4228012 140734277360608 140060963105808 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4294] ppid=4284 vsize=1053308 CPUtime=1.73
/proc/4287/task/4294/stat : 4294 (java) S 4284 4284 1745 0 -1 4202560 9636 0 0 0 169 4 0 0 20 0 11 0 115408901 1078587392 160527 18446744073709551615 4194304 4228012 140734277360608 140060962053136 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4295] ppid=4284 vsize=1053308 CPUtime=0
/proc/4287/task/4295/stat : 4295 (java) S 4284 4284 1745 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 115408901 1078587392 160527 18446744073709551615 4194304 4228012 140734277360608 140060961000656 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4296] ppid=4284 vsize=1053308 CPUtime=0.06
/proc/4287/task/4296/stat : 4296 (java) S 4284 4284 1745 0 -1 4202560 11 0 0 0 3 3 0 0 20 0 11 0 115408901 1078587392 160527 18446744073709551615 4194304 4228012 140734277360608 140060959948160 140061068158539 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 147.55
Current children cumulated vsize (KiB) 1062476

[startup+150.806 s]
/proc/loadavg: 1.03 1.02 0.93 1/77 4298
/proc/meminfo: memFree=9652/1022884 swapFree=0/0
[pid=4284] ppid=4283 vsize=9168 CPUtime=0
/proc/4284/stat : 4284 (p2cudf-basic-1.) S 4283 4284 1745 0 -1 4202496 455 290 2 2 0 0 0 0 20 0 1 0 115408861 9388032 331 18446744073709551615 4194304 5129932 140734861675264 140734861673408 140027703104606 0 65536 16781316 65538 0 0 0 17 0 0 0 2 0 0
/proc/4284/statm: 2292 331 280 229 0 52 0
[pid=4287] ppid=4284 vsize=1053308 CPUtime=147.63
/proc/4287/stat : 4287 (java) S 4284 4284 1745 0 -1 4202496 166265 0 20 0 14699 64 0 0 20 0 11 0 115408867 1078587392 160530 18446744073709551615 4194304 4228012 140734277360608 140734277351632 140061068144245 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 7 0 0
/proc/4287/statm: 263327 160530 2393 9 0 250677 0
[pid=4287/tid=4288] ppid=4284 vsize=1053308 CPUtime=131.56
/proc/4287/task/4288/stat : 4288 (java) S 4284 4284 1745 0 -1 4202560 47779 0 8 0 13134 22 0 0 20 0 11 0 115408875 1078587392 160530 18446744073709551615 4194304 4228012 140734277360608 140061074678704 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 87 0 0
[pid=4287/tid=4289] ppid=4284 vsize=1053308 CPUtime=12.46
/proc/4287/task/4289/stat : 4289 (java) S 4284 4284 1745 0 -1 4202560 97106 0 0 0 1217 29 0 0 20 0 11 0 115408892 1078587392 160530 18446744073709551615 4194304 4228012 140734277360608 140060967316608 140061068158539 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4290] ppid=4284 vsize=1053308 CPUtime=0
/proc/4287/task/4290/stat : 4290 (java) S 4284 4284 1745 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 115408893 1078587392 160530 18446744073709551615 4194304 4228012 140734277360608 140060966262800 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4291] ppid=4284 vsize=1053308 CPUtime=0
/proc/4287/task/4291/stat : 4291 (java) S 4284 4284 1745 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 115408893 1078587392 160530 18446744073709551615 4194304 4228012 140734277360608 140060965210016 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4292] ppid=4284 vsize=1053308 CPUtime=0
/proc/4287/task/4292/stat : 4292 (java) S 4284 4284 1745 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 115408901 1078587392 160530 18446744073709551615 4194304 4228012 140734277360608 140060964158448 140061068166176 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4293] ppid=4284 vsize=1053308 CPUtime=1.71
/proc/4287/task/4293/stat : 4293 (java) S 4284 4284 1745 0 -1 4202560 10438 0 0 0 167 4 0 0 20 0 11 0 115408901 1078587392 160530 18446744073709551615 4194304 4228012 140734277360608 140060963105808 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4294] ppid=4284 vsize=1053308 CPUtime=1.73
/proc/4287/task/4294/stat : 4294 (java) S 4284 4284 1745 0 -1 4202560 9636 0 0 0 169 4 0 0 20 0 11 0 115408901 1078587392 160530 18446744073709551615 4194304 4228012 140734277360608 140060962053136 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4295] ppid=4284 vsize=1053308 CPUtime=0
/proc/4287/task/4295/stat : 4295 (java) S 4284 4284 1745 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 115408901 1078587392 160530 18446744073709551615 4194304 4228012 140734277360608 140060961000656 140061068157652 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4296] ppid=4284 vsize=1053308 CPUtime=0.06
/proc/4287/task/4296/stat : 4296 (java) S 4284 4284 1745 0 -1 4202560 11 0 0 0 3 3 0 0 20 0 11 0 115408901 1078587392 160530 18446744073709551615 4194304 4228012 140734277360608 140060959948160 140061068158539 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=4287/tid=4298] ppid=4284 vsize=1053308 CPUtime=0.05
/proc/4287/task/4298/stat : 4298 (java) R 4284 4284 1745 0 -1 4202560 9 0 0 0 2 3 0 0 20 0 11 0 115423883 1078587392 160530 18446744073709551615 4194304 4228012 140734277360608 140060957693120 140061068169517 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 147.63
Current children cumulated vsize (KiB) 1062476

Child status: 0
Real time (s): 150.88
CPU time (s): 147.713
CPU user time (s): 147.021
CPU system time (s): 0.692043
CPU usage (%): 97.9011
Max. virtual memory (cumulated for all children) (KiB): 1065632

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 147.021
system time used= 0.692043
maximum resident set size= 642152
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 167033
page faults= 24
swaps= 0
block input operations= 71152
block output operations= 432
messages sent= 0
messages received= 0
signals received= 0
voluntary context switches= 4326
involuntary context switches= 21696

runsolver used 0.49203 second user time and 0.80405 second system time

The end