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 300 -d 10 -w /tmp/misc2012/2012-09-02-22:42/full/p2cudf-full-1.15/dist-upgrade/upgrade/difficult/rand411.cudf.log.runsolver /home/competition/p2cudf-full-1.15/p2cudf-full-1.15 /home/competition/data/upgrade/difficult/rand411.cudf /tmp/misc2012/2012-09-02-22:42/full/p2cudf-full-1.15/dist-upgrade/upgrade/difficult/rand411.cudf.result -notuptodate(solution),-aligned(solution,source,sourceversion),-unsat_recommends(solution),-count(new) 

Enforcing CPUTime limit (soft limit, will send signal-name then SIGKILL): 300 seconds
Enforcing CPUTime limit (hard limit, will send SIGXCPU): 330 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

[startup+0 s]
/proc/loadavg: 1.16 1.15 1.05 2/59 15284
/proc/meminfo: memFree=741996/1022884 swapFree=0/0
[pid=15284] ppid=15283 vsize=3152 CPUtime=0
/proc/15284/stat : 15284 (runsolver) R 15283 1750 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 1 0 118727227 3227648 33 18446744073709551615 134512640 134586868 4293343312 4293341360 4151616560 0 0 16781316 24578 0 0 0 17 0 0 0 0 0 0
/proc/15284/statm: 788 33 0 19 0 73 0
Current StackSize limit: 8192 KiB


[startup+0.191287 s]
/proc/loadavg: 1.16 1.15 1.05 2/59 15284
/proc/meminfo: memFree=741996/1022884 swapFree=0/0
[pid=15284] ppid=15283 vsize=9168 CPUtime=0
/proc/15284/stat : 15284 (p2cudf-full-1.1) S 15283 15284 1750 0 -1 4202496 456 291 0 0 0 0 0 0 20 0 1 0 118727227 9388032 330 18446744073709551615 4194304 5129932 140733837365344 140733837363488 139970633696350 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/15284/statm: 2292 330 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.16 1.15 1.05 2/59 15284
/proc/meminfo: memFree=741996/1022884 swapFree=0/0
[pid=15284] ppid=15283 vsize=9168 CPUtime=0
/proc/15284/stat : 15284 (p2cudf-full-1.1) S 15283 15284 1750 0 -1 4202496 456 291 0 0 0 0 0 0 20 0 1 0 118727227 9388032 330 18446744073709551615 4194304 5129932 140733837365344 140733837363488 139970633696350 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/15284/statm: 2292 330 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+0.300393 s]
/proc/loadavg: 1.16 1.15 1.05 2/59 15284
/proc/meminfo: memFree=741996/1022884 swapFree=0/0
[pid=15284] ppid=15283 vsize=9168 CPUtime=0
/proc/15284/stat : 15284 (p2cudf-full-1.1) S 15283 15284 1750 0 -1 4202496 456 291 0 0 0 0 0 0 20 0 1 0 118727227 9388032 330 18446744073709551615 4194304 5129932 140733837365344 140733837363488 139970633696350 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/15284/statm: 2292 330 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+0.700299 s]
/proc/loadavg: 1.16 1.15 1.05 2/59 15284
/proc/meminfo: memFree=741996/1022884 swapFree=0/0
[pid=15284] ppid=15283 vsize=9168 CPUtime=0
/proc/15284/stat : 15284 (p2cudf-full-1.1) S 15283 15284 1750 0 -1 4202496 456 291 0 0 0 0 0 0 20 0 1 0 118727227 9388032 330 18446744073709551615 4194304 5129932 140733837365344 140733837363488 139970633696350 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/15284/statm: 2292 330 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+1.5008 s]
/proc/loadavg: 1.16 1.15 1.05 4/70 15296
/proc/meminfo: memFree=723300/1022884 swapFree=0/0
[pid=15284] ppid=15283 vsize=9168 CPUtime=0
/proc/15284/stat : 15284 (p2cudf-full-1.1) S 15283 15284 1750 0 -1 4202496 456 291 0 0 0 0 0 0 20 0 1 0 118727227 9388032 330 18446744073709551615 4194304 5129932 140733837365344 140733837363488 139970633696350 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/15284/statm: 2292 330 280 229 0 52 0
[pid=15287] ppid=15284 vsize=960740 CPUtime=0.68
/proc/15287/stat : 15287 (java) S 15284 15284 1750 0 -1 4202496 10197 0 23 0 59 9 0 0 20 0 10 0 118727230 983797760 8670 18446744073709551615 4194304 4228012 140737472867088 140737472858112 140226024078965 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 10 0 0
/proc/15287/statm: 240185 8670 2329 9 0 227535 0
[pid=15287/tid=15288] ppid=15284 vsize=960740 CPUtime=0.38
/proc/15287/task/15288/stat : 15288 (java) R 15284 15284 1750 0 -1 4202560 4919 0 11 0 34 4 0 0 20 0 10 0 118727241 983797760 8670 18446744073709551615 4194304 4228012 140737472867088 140226030604896 140225928431355 0 4 0 16800975 0 0 0 -1 0 0 0 69 0 0
[pid=15287/tid=15289] ppid=15284 vsize=960740 CPUtime=0
/proc/15287/task/15289/stat : 15289 (java) S 15284 15284 1750 0 -1 4202560 3 0 0 0 0 0 0 0 20 0 10 0 118727258 983797760 8670 18446744073709551615 4194304 4228012 140737472867088 140225923251328 140226024093259 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15290] ppid=15284 vsize=960740 CPUtime=0
/proc/15287/task/15290/stat : 15290 (java) S 15284 15284 1750 0 -1 4202560 15 0 0 0 0 0 0 0 20 0 10 0 118727261 983797760 8670 18446744073709551615 4194304 4228012 140737472867088 140225922197520 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15291] ppid=15284 vsize=960740 CPUtime=0
/proc/15287/task/15291/stat : 15291 (java) S 15284 15284 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 10 0 118727261 983797760 8670 18446744073709551615 4194304 4228012 140737472867088 140225921144736 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15292] ppid=15284 vsize=960740 CPUtime=0
/proc/15287/task/15292/stat : 15292 (java) S 15284 15284 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 118727274 983797760 8670 18446744073709551615 4194304 4228012 140737472867088 140225920093168 140226024100896 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15293] ppid=15284 vsize=960740 CPUtime=0.13
/proc/15287/task/15293/stat : 15293 (java) R 15284 15284 1750 0 -1 4202560 1897 0 0 0 12 1 0 0 20 0 10 0 118727274 983797760 8670 18446744073709551615 4194304 4228012 140737472867088 140225919040272 140226010230626 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15294] ppid=15284 vsize=960740 CPUtime=0.14
/proc/15287/task/15294/stat : 15294 (java) R 15284 15284 1750 0 -1 4202560 2102 0 0 0 12 2 0 0 20 0 10 0 118727274 983797760 8670 18446744073709551615 4194304 4228012 140737472867088 140225917975656 140226007221705 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15295] ppid=15284 vsize=960740 CPUtime=0
/proc/15287/task/15295/stat : 15295 (java) S 15284 15284 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 118727274 983797760 8670 18446744073709551615 4194304 4228012 140737472867088 140225916935376 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15296] ppid=15284 vsize=960740 CPUtime=0
/proc/15287/task/15296/stat : 15296 (java) S 15284 15284 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 118727274 983797760 8670 18446744073709551615 4194304 4228012 140737472867088 140225915882880 140226024093259 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 0.68
Current children cumulated vsize (KiB) 969908

[startup+3.10078 s]
/proc/loadavg: 1.22 1.16 1.05 4/70 15296
/proc/meminfo: memFree=640716/1022884 swapFree=0/0
[pid=15284] ppid=15283 vsize=9168 CPUtime=0
/proc/15284/stat : 15284 (p2cudf-full-1.1) S 15283 15284 1750 0 -1 4202496 456 291 0 0 0 0 0 0 20 0 1 0 118727227 9388032 330 18446744073709551615 4194304 5129932 140733837365344 140733837363488 139970633696350 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/15284/statm: 2292 330 280 229 0 52 0
[pid=15287] ppid=15284 vsize=1051348 CPUtime=2.26
/proc/15287/stat : 15287 (java) S 15284 15284 1750 0 -1 4202496 48020 0 23 0 200 26 0 0 20 0 10 0 118727230 1076580352 42775 18446744073709551615 4194304 4228012 140737472867088 140737472858112 140226024078965 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 10 0 0
/proc/15287/statm: 262837 42775 2345 9 0 250187 0
[pid=15287/tid=15288] ppid=15284 vsize=1051348 CPUtime=0.99
/proc/15287/task/15288/stat : 15288 (java) R 15284 15284 1750 0 -1 4202560 28968 0 11 0 85 14 0 0 20 0 10 0 118727241 1076580352 42775 18446744073709551615 4194304 4228012 140737472867088 140226030604992 140225928463223 0 4 0 16800975 0 0 0 -1 0 0 0 69 0 0
[pid=15287/tid=15289] ppid=15284 vsize=1051348 CPUtime=0
/proc/15287/task/15289/stat : 15289 (java) S 15284 15284 1750 0 -1 4202560 3 0 0 0 0 0 0 0 20 0 10 0 118727258 1076580352 42775 18446744073709551615 4194304 4228012 140737472867088 140225923251328 140226024093259 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15290] ppid=15284 vsize=1051348 CPUtime=0
/proc/15287/task/15290/stat : 15290 (java) S 15284 15284 1750 0 -1 4202560 15 0 0 0 0 0 0 0 20 0 10 0 118727261 1076580352 42775 18446744073709551615 4194304 4228012 140737472867088 140225922197520 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15291] ppid=15284 vsize=1051348 CPUtime=0
/proc/15287/task/15291/stat : 15291 (java) S 15284 15284 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 10 0 118727261 1076580352 42775 18446744073709551615 4194304 4228012 140737472867088 140225921144736 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15292] ppid=15284 vsize=1051348 CPUtime=0
/proc/15287/task/15292/stat : 15292 (java) S 15284 15284 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 118727274 1076580352 42775 18446744073709551615 4194304 4228012 140737472867088 140225920093168 140226024100896 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15293] ppid=15284 vsize=1051348 CPUtime=0.6
/proc/15287/task/15293/stat : 15293 (java) S 15284 15284 1750 0 -1 4202560 10074 0 0 0 55 5 0 0 20 0 10 0 118727274 1076580352 42775 18446744073709551615 4194304 4228012 140737472867088 140225919040528 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15294] ppid=15284 vsize=1051348 CPUtime=0.64
/proc/15287/task/15294/stat : 15294 (java) S 15284 15284 1750 0 -1 4202560 7699 0 0 0 60 4 0 0 20 0 10 0 118727274 1076580352 42775 18446744073709551615 4194304 4228012 140737472867088 140225917987856 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15295] ppid=15284 vsize=1051348 CPUtime=0
/proc/15287/task/15295/stat : 15295 (java) S 15284 15284 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 118727274 1076580352 42775 18446744073709551615 4194304 4228012 140737472867088 140225916935376 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15296] ppid=15284 vsize=1051348 CPUtime=0
/proc/15287/task/15296/stat : 15296 (java) S 15284 15284 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 118727274 1076580352 42775 18446744073709551615 4194304 4228012 140737472867088 140225915882880 140226024093259 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 2.26
Current children cumulated vsize (KiB) 1060516
heavy processes:

[startup+6.30086 s]
/proc/loadavg: 1.22 1.16 1.05 2/70 15296
/proc/meminfo: memFree=341132/1022884 swapFree=0/0
[pid=15284] ppid=15283 vsize=9168 CPUtime=0
/proc/15284/stat : 15284 (p2cudf-full-1.1) S 15283 15284 1750 0 -1 4202496 456 291 0 0 0 0 0 0 20 0 1 0 118727227 9388032 330 18446744073709551615 4194304 5129932 140733837365344 140733837363488 139970633696350 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/15284/statm: 2292 330 280 229 0 52 0
[pid=15287] ppid=15284 vsize=1048044 CPUtime=5.38
/proc/15287/stat : 15287 (java) S 15284 15284 1750 0 -1 4202496 114343 0 23 0 487 51 0 0 20 0 10 0 118727230 1073197056 108418 18446744073709551615 4194304 4228012 140737472867088 140737472858112 140226024078965 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 10 0 0
/proc/15287/statm: 262011 108418 2368 9 0 249361 0
[pid=15287/tid=15288] ppid=15284 vsize=1048044 CPUtime=2.87
/proc/15287/task/15288/stat : 15288 (java) R 15284 15284 1750 0 -1 4202560 47401 0 11 0 262 25 0 0 20 0 10 0 118727241 1073197056 108418 18446744073709551615 4194304 4228012 140737472867088 140226030604992 140225928498617 0 4 0 16800975 0 0 0 -1 0 0 0 71 0 0
[pid=15287/tid=15289] ppid=15284 vsize=1048044 CPUtime=1.16
/proc/15287/task/15289/stat : 15289 (java) S 15284 15284 1750 0 -1 4202560 47876 0 0 0 100 16 0 0 20 0 10 0 118727258 1073197056 108418 18446744073709551615 4194304 4228012 140737472867088 140225923251328 140226024093259 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15290] ppid=15284 vsize=1048044 CPUtime=0
/proc/15287/task/15290/stat : 15290 (java) S 15284 15284 1750 0 -1 4202560 15 0 0 0 0 0 0 0 20 0 10 0 118727261 1073197056 108418 18446744073709551615 4194304 4228012 140737472867088 140225922197520 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15291] ppid=15284 vsize=1048044 CPUtime=0
/proc/15287/task/15291/stat : 15291 (java) S 15284 15284 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 10 0 118727261 1073197056 108418 18446744073709551615 4194304 4228012 140737472867088 140225921144736 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15292] ppid=15284 vsize=1048044 CPUtime=0
/proc/15287/task/15292/stat : 15292 (java) S 15284 15284 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 118727274 1073197056 108418 18446744073709551615 4194304 4228012 140737472867088 140225920093168 140226024100896 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15293] ppid=15284 vsize=1048044 CPUtime=0.63
/proc/15287/task/15293/stat : 15293 (java) S 15284 15284 1750 0 -1 4202560 10074 0 0 0 58 5 0 0 20 0 10 0 118727274 1073197056 108418 18446744073709551615 4194304 4228012 140737472867088 140225919040528 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15294] ppid=15284 vsize=1048044 CPUtime=0.69
/proc/15287/task/15294/stat : 15294 (java) S 15284 15284 1750 0 -1 4202560 7712 0 0 0 65 4 0 0 20 0 10 0 118727274 1073197056 108418 18446744073709551615 4194304 4228012 140737472867088 140225917987856 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15295] ppid=15284 vsize=1048044 CPUtime=0
/proc/15287/task/15295/stat : 15295 (java) S 15284 15284 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 118727274 1073197056 108418 18446744073709551615 4194304 4228012 140737472867088 140225916935376 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15296] ppid=15284 vsize=1048044 CPUtime=0
/proc/15287/task/15296/stat : 15296 (java) S 15284 15284 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 118727274 1073197056 108418 18446744073709551615 4194304 4228012 140737472867088 140225915882880 140226024093259 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 5.38
Current children cumulated vsize (KiB) 1057212

[startup+12.7008 s]
/proc/loadavg: 1.35 1.19 1.06 4/70 15296
/proc/meminfo: memFree=136904/1022884 swapFree=0/0
[pid=15284] ppid=15283 vsize=9168 CPUtime=0
/proc/15284/stat : 15284 (p2cudf-full-1.1) S 15283 15284 1750 0 -1 4202496 456 291 0 0 0 0 0 0 20 0 1 0 118727227 9388032 330 18446744073709551615 4194304 5129932 140733837365344 140733837363488 139970633696350 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/15284/statm: 2292 330 280 229 0 52 0
[pid=15287] ppid=15284 vsize=1048044 CPUtime=11.59
/proc/15287/stat : 15287 (java) S 15284 15284 1750 0 -1 4202496 151816 0 23 0 1095 64 0 0 20 0 10 0 118727230 1073197056 144548 18446744073709551615 4194304 4228012 140737472867088 140737472858112 140226024078965 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 10 0 0
/proc/15287/statm: 262011 144548 2376 9 0 249361 0
[pid=15287/tid=15288] ppid=15284 vsize=1048044 CPUtime=5.81
/proc/15287/task/15288/stat : 15288 (java) R 15284 15284 1750 0 -1 4202560 47707 0 11 0 553 28 0 0 20 0 10 0 118727241 1073197056 144548 18446744073709551615 4194304 4228012 140737472867088 140226030613120 140225928936996 0 4 0 16800975 0 0 0 -1 0 0 0 87 0 0
[pid=15287/tid=15289] ppid=15284 vsize=1048044 CPUtime=2.1
/proc/15287/task/15289/stat : 15289 (java) S 15284 15284 1750 0 -1 4202560 81363 0 0 0 187 23 0 0 20 0 10 0 118727258 1073197056 144548 18446744073709551615 4194304 4228012 140737472867088 140225923251328 140226024093259 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15290] ppid=15284 vsize=1048044 CPUtime=0
/proc/15287/task/15290/stat : 15290 (java) S 15284 15284 1750 0 -1 4202560 15 0 0 0 0 0 0 0 20 0 10 0 118727261 1073197056 144548 18446744073709551615 4194304 4228012 140737472867088 140225922197520 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15291] ppid=15284 vsize=1048044 CPUtime=0
/proc/15287/task/15291/stat : 15291 (java) S 15284 15284 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 10 0 118727261 1073197056 144548 18446744073709551615 4194304 4228012 140737472867088 140225921144736 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15292] ppid=15284 vsize=1048044 CPUtime=0
/proc/15287/task/15292/stat : 15292 (java) S 15284 15284 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 118727274 1073197056 144548 18446744073709551615 4194304 4228012 140737472867088 140225920093168 140226024100896 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15293] ppid=15284 vsize=1048044 CPUtime=1.84
/proc/15287/task/15293/stat : 15293 (java) R 15284 15284 1750 0 -1 4202560 13659 0 0 0 177 7 0 0 20 0 10 0 118727274 1073197056 144548 18446744073709551615 4194304 4228012 140737472867088 140225919025880 140226010227344 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15294] ppid=15284 vsize=1048044 CPUtime=1.8
/proc/15287/task/15294/stat : 15294 (java) R 15284 15284 1750 0 -1 4202560 7807 0 0 0 176 4 0 0 20 0 10 0 118727274 1073197056 144548 18446744073709551615 4194304 4228012 140737472867088 140225917987600 140226005693696 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15295] ppid=15284 vsize=1048044 CPUtime=0
/proc/15287/task/15295/stat : 15295 (java) S 15284 15284 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 118727274 1073197056 144548 18446744073709551615 4194304 4228012 140737472867088 140225916935376 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15296] ppid=15284 vsize=1048044 CPUtime=0
/proc/15287/task/15296/stat : 15296 (java) S 15284 15284 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 118727274 1073197056 144548 18446744073709551615 4194304 4228012 140737472867088 140225915882880 140226024093259 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 11.59
Current children cumulated vsize (KiB) 1057212

[startup+25.5009 s]
/proc/loadavg: 1.52 1.23 1.08 2/71 15297
/proc/meminfo: memFree=53568/1022884 swapFree=0/0
[pid=15284] ppid=15283 vsize=9168 CPUtime=0
/proc/15284/stat : 15284 (p2cudf-full-1.1) S 15283 15284 1750 0 -1 4202496 456 291 0 0 0 0 0 0 20 0 1 0 118727227 9388032 330 18446744073709551615 4194304 5129932 140733837365344 140733837363488 139970633696350 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/15284/statm: 2292 330 280 229 0 52 0
[pid=15287] ppid=15284 vsize=1050156 CPUtime=24.13
/proc/15287/stat : 15287 (java) S 15284 15284 1750 0 -1 4202496 173483 0 23 0 2338 75 0 0 20 0 11 0 118727230 1075359744 164157 18446744073709551615 4194304 4228012 140737472867088 140737472858112 140226024078965 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 10 0 0
/proc/15287/statm: 262539 164157 2393 9 0 249889 0
[pid=15287/tid=15288] ppid=15284 vsize=1050156 CPUtime=14.78
/proc/15287/task/15288/stat : 15288 (java) R 15284 15284 1750 0 -1 4202560 47793 0 11 0 1450 28 0 0 20 0 11 0 118727241 1075359744 164157 18446744073709551615 4194304 4228012 140737472867088 140226030612664 140225928626840 0 4 0 16800975 0 0 0 -1 0 0 0 95 0 0
[pid=15287/tid=15289] ppid=15284 vsize=1050156 CPUtime=3.62
/proc/15287/task/15289/stat : 15289 (java) S 15284 15284 1750 0 -1 4202560 99933 0 0 0 330 32 0 0 20 0 11 0 118727258 1075359744 164157 18446744073709551615 4194304 4228012 140737472867088 140225923251328 140226024093259 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15290] ppid=15284 vsize=1050156 CPUtime=0
/proc/15287/task/15290/stat : 15290 (java) S 15284 15284 1750 0 -1 4202560 15 0 0 0 0 0 0 0 20 0 11 0 118727261 1075359744 164157 18446744073709551615 4194304 4228012 140737472867088 140225922197520 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15291] ppid=15284 vsize=1050156 CPUtime=0
/proc/15287/task/15291/stat : 15291 (java) S 15284 15284 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 118727261 1075359744 164157 18446744073709551615 4194304 4228012 140737472867088 140225921144736 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15292] ppid=15284 vsize=1050156 CPUtime=0
/proc/15287/task/15292/stat : 15292 (java) S 15284 15284 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 118727274 1075359744 164157 18446744073709551615 4194304 4228012 140737472867088 140225920093168 140226024100896 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15293] ppid=15284 vsize=1050156 CPUtime=2.86
/proc/15287/task/15293/stat : 15293 (java) S 15284 15284 1750 0 -1 4202560 14889 0 0 0 278 8 0 0 20 0 11 0 118727274 1075359744 164157 18446744073709551615 4194304 4228012 140737472867088 140225919040528 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15294] ppid=15284 vsize=1050156 CPUtime=2.83
/proc/15287/task/15294/stat : 15294 (java) S 15284 15284 1750 0 -1 4202560 9582 0 0 0 277 6 0 0 20 0 11 0 118727274 1075359744 164157 18446744073709551615 4194304 4228012 140737472867088 140225917987856 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15295] ppid=15284 vsize=1050156 CPUtime=0
/proc/15287/task/15295/stat : 15295 (java) S 15284 15284 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 118727274 1075359744 164157 18446744073709551615 4194304 4228012 140737472867088 140225916935376 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15296] ppid=15284 vsize=1050156 CPUtime=0.01
/proc/15287/task/15296/stat : 15296 (java) S 15284 15284 1750 0 -1 4202560 1 0 0 0 1 0 0 0 20 0 11 0 118727274 1075359744 164157 18446744073709551615 4194304 4228012 140737472867088 140225915882880 140226024093259 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15297] ppid=15284 vsize=1050156 CPUtime=0
/proc/15287/task/15297/stat : 15297 (java) S 15284 15284 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 118728717 1075359744 164157 18446744073709551615 4194304 4228012 140737472867088 140225914685280 140226024093259 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 24.13
Current children cumulated vsize (KiB) 1059324

[startup+51.1008 s]
/proc/loadavg: 1.34 1.21 1.08 2/71 15297
/proc/meminfo: memFree=19840/1022884 swapFree=0/0
[pid=15284] ppid=15283 vsize=9168 CPUtime=0
/proc/15284/stat : 15284 (p2cudf-full-1.1) S 15283 15284 1750 0 -1 4202496 456 291 0 0 0 0 0 0 20 0 1 0 118727227 9388032 330 18446744073709551615 4194304 5129932 140733837365344 140733837363488 139970633696350 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/15284/statm: 2292 330 280 229 0 52 0
[pid=15287] ppid=15284 vsize=1050156 CPUtime=49.39
/proc/15287/stat : 15287 (java) S 15284 15284 1750 0 -1 4202496 181866 0 23 0 4861 78 0 0 20 0 11 0 118727230 1075359744 172536 18446744073709551615 4194304 4228012 140737472867088 140737472858112 140226024078965 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 10 0 0
/proc/15287/statm: 262539 172536 2393 9 0 249889 0
[pid=15287/tid=15288] ppid=15284 vsize=1050156 CPUtime=36.28
/proc/15287/task/15288/stat : 15288 (java) R 15284 15284 1750 0 -1 4202560 47794 0 11 0 3600 28 0 0 20 0 11 0 118727241 1075359744 172536 18446744073709551615 4194304 4228012 140737472867088 140226030612456 140225929509403 0 4 0 16800975 0 0 0 -1 0 0 0 95 0 0
[pid=15287/tid=15289] ppid=15284 vsize=1050156 CPUtime=7.23
/proc/15287/task/15289/stat : 15289 (java) S 15284 15284 1750 0 -1 4202560 108309 0 0 0 689 34 0 0 20 0 11 0 118727258 1075359744 172536 18446744073709551615 4194304 4228012 140737472867088 140225923251328 140226024093259 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15290] ppid=15284 vsize=1050156 CPUtime=0
/proc/15287/task/15290/stat : 15290 (java) S 15284 15284 1750 0 -1 4202560 15 0 0 0 0 0 0 0 20 0 11 0 118727261 1075359744 172536 18446744073709551615 4194304 4228012 140737472867088 140225922197520 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15291] ppid=15284 vsize=1050156 CPUtime=0
/proc/15287/task/15291/stat : 15291 (java) S 15284 15284 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 118727261 1075359744 172536 18446744073709551615 4194304 4228012 140737472867088 140225921144736 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15292] ppid=15284 vsize=1050156 CPUtime=0
/proc/15287/task/15292/stat : 15292 (java) S 15284 15284 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 118727274 1075359744 172536 18446744073709551615 4194304 4228012 140737472867088 140225920093168 140226024100896 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15293] ppid=15284 vsize=1050156 CPUtime=2.92
/proc/15287/task/15293/stat : 15293 (java) S 15284 15284 1750 0 -1 4202560 14890 0 0 0 284 8 0 0 20 0 11 0 118727274 1075359744 172536 18446744073709551615 4194304 4228012 140737472867088 140225919040528 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15294] ppid=15284 vsize=1050156 CPUtime=2.89
/proc/15287/task/15294/stat : 15294 (java) S 15284 15284 1750 0 -1 4202560 9584 0 0 0 283 6 0 0 20 0 11 0 118727274 1075359744 172536 18446744073709551615 4194304 4228012 140737472867088 140225917987856 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15295] ppid=15284 vsize=1050156 CPUtime=0
/proc/15287/task/15295/stat : 15295 (java) S 15284 15284 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 118727274 1075359744 172536 18446744073709551615 4194304 4228012 140737472867088 140225916935376 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15296] ppid=15284 vsize=1050156 CPUtime=0.03
/proc/15287/task/15296/stat : 15296 (java) S 15284 15284 1750 0 -1 4202560 4 0 0 0 3 0 0 0 20 0 11 0 118727274 1075359744 172536 18446744073709551615 4194304 4228012 140737472867088 140225915882880 140226024093259 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15297] ppid=15284 vsize=1050156 CPUtime=0
/proc/15287/task/15297/stat : 15297 (java) S 15284 15284 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 118728717 1075359744 172536 18446744073709551615 4194304 4228012 140737472867088 140225914685280 140226024093259 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 49.39
Current children cumulated vsize (KiB) 1059324

[startup+102.301 s]
/proc/loadavg: 1.14 1.17 1.07 2/71 15297
/proc/meminfo: memFree=10260/1022884 swapFree=0/0
[pid=15284] ppid=15283 vsize=9168 CPUtime=0
/proc/15284/stat : 15284 (p2cudf-full-1.1) S 15283 15284 1750 0 -1 4202496 456 291 0 0 0 0 0 0 20 0 1 0 118727227 9388032 330 18446744073709551615 4194304 5129932 140733837365344 140733837363488 139970633696350 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/15284/statm: 2292 330 280 229 0 52 0
[pid=15287] ppid=15284 vsize=1050156 CPUtime=99.84
/proc/15287/stat : 15287 (java) S 15284 15284 1750 0 -1 4202496 187607 0 23 0 9905 79 0 0 20 0 11 0 118727230 1075359744 178273 18446744073709551615 4194304 4228012 140737472867088 140737472858112 140226024078965 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 10 0 0
/proc/15287/statm: 262539 178273 2393 9 0 249889 0
[pid=15287/tid=15288] ppid=15284 vsize=1050156 CPUtime=81.58
/proc/15287/task/15288/stat : 15288 (java) R 15284 15284 1750 0 -1 4202560 47794 0 11 0 8130 28 0 0 20 0 11 0 118727241 1075359744 178273 18446744073709551615 4194304 4228012 140737472867088 140226030612456 140225929584124 0 4 0 16800975 0 0 0 -1 0 0 0 95 0 0
[pid=15287/tid=15289] ppid=15284 vsize=1050156 CPUtime=12.36
/proc/15287/task/15289/stat : 15289 (java) S 15284 15284 1750 0 -1 4202560 114047 0 0 0 1201 35 0 0 20 0 11 0 118727258 1075359744 178273 18446744073709551615 4194304 4228012 140737472867088 140225923251328 140226024093259 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15290] ppid=15284 vsize=1050156 CPUtime=0
/proc/15287/task/15290/stat : 15290 (java) S 15284 15284 1750 0 -1 4202560 15 0 0 0 0 0 0 0 20 0 11 0 118727261 1075359744 178273 18446744073709551615 4194304 4228012 140737472867088 140225922197520 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15291] ppid=15284 vsize=1050156 CPUtime=0
/proc/15287/task/15291/stat : 15291 (java) S 15284 15284 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 118727261 1075359744 178273 18446744073709551615 4194304 4228012 140737472867088 140225921144736 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15292] ppid=15284 vsize=1050156 CPUtime=0
/proc/15287/task/15292/stat : 15292 (java) S 15284 15284 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 118727274 1075359744 178273 18446744073709551615 4194304 4228012 140737472867088 140225920093168 140226024100896 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15293] ppid=15284 vsize=1050156 CPUtime=2.92
/proc/15287/task/15293/stat : 15293 (java) S 15284 15284 1750 0 -1 4202560 14890 0 0 0 284 8 0 0 20 0 11 0 118727274 1075359744 178273 18446744073709551615 4194304 4228012 140737472867088 140225919040528 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15294] ppid=15284 vsize=1050156 CPUtime=2.89
/proc/15287/task/15294/stat : 15294 (java) S 15284 15284 1750 0 -1 4202560 9584 0 0 0 283 6 0 0 20 0 11 0 118727274 1075359744 178273 18446744073709551615 4194304 4228012 140737472867088 140225917987856 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15295] ppid=15284 vsize=1050156 CPUtime=0
/proc/15287/task/15295/stat : 15295 (java) S 15284 15284 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 118727274 1075359744 178273 18446744073709551615 4194304 4228012 140737472867088 140225916935376 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15296] ppid=15284 vsize=1050156 CPUtime=0.05
/proc/15287/task/15296/stat : 15296 (java) S 15284 15284 1750 0 -1 4202560 7 0 0 0 5 0 0 0 20 0 11 0 118727274 1075359744 178273 18446744073709551615 4194304 4228012 140737472867088 140225915882880 140226024093259 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15297] ppid=15284 vsize=1050156 CPUtime=0
/proc/15287/task/15297/stat : 15297 (java) S 15284 15284 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 118728717 1075359744 178273 18446744073709551615 4194304 4228012 140737472867088 140225914685280 140226024093259 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 99.84
Current children cumulated vsize (KiB) 1059324

[startup+162.301 s]
/proc/loadavg: 1.05 1.14 1.06 2/71 15297
/proc/meminfo: memFree=9972/1022884 swapFree=0/0
[pid=15284] ppid=15283 vsize=9168 CPUtime=0
/proc/15284/stat : 15284 (p2cudf-full-1.1) S 15283 15284 1750 0 -1 4202496 456 291 0 0 0 0 0 0 20 0 1 0 118727227 9388032 330 18446744073709551615 4194304 5129932 140733837365344 140733837363488 139970633696350 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/15284/statm: 2292 330 280 229 0 52 0
[pid=15287] ppid=15284 vsize=1050156 CPUtime=159.07
/proc/15287/stat : 15287 (java) S 15284 15284 1750 0 -1 4202496 195837 0 23 0 15825 82 0 0 20 0 11 0 118727230 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140737472858112 140226024078965 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 10 0 0
/proc/15287/statm: 262539 186495 2393 9 0 249889 0
[pid=15287/tid=15288] ppid=15284 vsize=1050156 CPUtime=135.74
/proc/15287/task/15288/stat : 15288 (java) R 15284 15284 1750 0 -1 4202560 47794 0 11 0 13546 28 0 0 20 0 11 0 118727241 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140226030612456 140225929498525 0 4 0 16800975 0 0 0 -1 0 0 0 95 0 0
[pid=15287/tid=15289] ppid=15284 vsize=1050156 CPUtime=17.4
/proc/15287/task/15289/stat : 15289 (java) S 15284 15284 1750 0 -1 4202560 122271 0 0 0 1702 38 0 0 20 0 11 0 118727258 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225923251328 140226024093259 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15290] ppid=15284 vsize=1050156 CPUtime=0
/proc/15287/task/15290/stat : 15290 (java) S 15284 15284 1750 0 -1 4202560 15 0 0 0 0 0 0 0 20 0 11 0 118727261 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225922197520 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15291] ppid=15284 vsize=1050156 CPUtime=0
/proc/15287/task/15291/stat : 15291 (java) S 15284 15284 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 118727261 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225921144736 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15292] ppid=15284 vsize=1050156 CPUtime=0
/proc/15287/task/15292/stat : 15292 (java) S 15284 15284 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 118727274 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225920093168 140226024100896 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15293] ppid=15284 vsize=1050156 CPUtime=2.92
/proc/15287/task/15293/stat : 15293 (java) S 15284 15284 1750 0 -1 4202560 14890 0 0 0 284 8 0 0 20 0 11 0 118727274 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225919040528 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15294] ppid=15284 vsize=1050156 CPUtime=2.89
/proc/15287/task/15294/stat : 15294 (java) S 15284 15284 1750 0 -1 4202560 9584 0 0 0 283 6 0 0 20 0 11 0 118727274 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225917987856 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15295] ppid=15284 vsize=1050156 CPUtime=0
/proc/15287/task/15295/stat : 15295 (java) S 15284 15284 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 118727274 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225916935376 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15296] ppid=15284 vsize=1050156 CPUtime=0.08
/proc/15287/task/15296/stat : 15296 (java) S 15284 15284 1750 0 -1 4202560 13 0 0 0 8 0 0 0 20 0 11 0 118727274 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225915882880 140226024093259 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15297] ppid=15284 vsize=1050156 CPUtime=0
/proc/15287/task/15297/stat : 15297 (java) S 15284 15284 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 118728717 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225914685280 140226024093259 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 159.07
Current children cumulated vsize (KiB) 1059324

[startup+222.304 s]
/proc/loadavg: 1.08 1.13 1.06 2/71 15297
/proc/meminfo: memFree=9724/1022884 swapFree=0/0
[pid=15284] ppid=15283 vsize=9168 CPUtime=0
/proc/15284/stat : 15284 (p2cudf-full-1.1) S 15283 15284 1750 0 -1 4202496 456 291 0 0 0 0 0 0 20 0 1 0 118727227 9388032 330 18446744073709551615 4194304 5129932 140733837365344 140733837363488 139970633696350 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/15284/statm: 2292 330 280 229 0 52 0
[pid=15287] ppid=15284 vsize=1050156 CPUtime=218.43
/proc/15287/stat : 15287 (java) S 15284 15284 1750 0 -1 4202496 195845 0 23 0 21761 82 0 0 20 0 11 0 118727230 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140737472858112 140226024078965 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 10 0 0
/proc/15287/statm: 262539 186495 2393 9 0 249889 0
[pid=15287/tid=15288] ppid=15284 vsize=1050156 CPUtime=190.73
/proc/15287/task/15288/stat : 15288 (java) R 15284 15284 1750 0 -1 4202560 47794 0 11 0 19045 28 0 0 20 0 11 0 118727241 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140226030612456 140225929618140 0 4 0 16800975 0 0 0 -1 0 0 0 95 0 0
[pid=15287/tid=15289] ppid=15284 vsize=1050156 CPUtime=21.74
/proc/15287/task/15289/stat : 15289 (java) S 15284 15284 1750 0 -1 4202560 122273 0 0 0 2136 38 0 0 20 0 11 0 118727258 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225923251328 140226024093259 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15290] ppid=15284 vsize=1050156 CPUtime=0
/proc/15287/task/15290/stat : 15290 (java) S 15284 15284 1750 0 -1 4202560 15 0 0 0 0 0 0 0 20 0 11 0 118727261 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225922197520 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15291] ppid=15284 vsize=1050156 CPUtime=0
/proc/15287/task/15291/stat : 15291 (java) S 15284 15284 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 118727261 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225921144736 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15292] ppid=15284 vsize=1050156 CPUtime=0
/proc/15287/task/15292/stat : 15292 (java) S 15284 15284 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 118727274 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225920093168 140226024100896 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15293] ppid=15284 vsize=1050156 CPUtime=2.92
/proc/15287/task/15293/stat : 15293 (java) S 15284 15284 1750 0 -1 4202560 14890 0 0 0 284 8 0 0 20 0 11 0 118727274 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225919040528 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15294] ppid=15284 vsize=1050156 CPUtime=2.89
/proc/15287/task/15294/stat : 15294 (java) S 15284 15284 1750 0 -1 4202560 9584 0 0 0 283 6 0 0 20 0 11 0 118727274 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225917987856 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15295] ppid=15284 vsize=1050156 CPUtime=0
/proc/15287/task/15295/stat : 15295 (java) S 15284 15284 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 118727274 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225916935376 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15296] ppid=15284 vsize=1050156 CPUtime=0.11
/proc/15287/task/15296/stat : 15296 (java) S 15284 15284 1750 0 -1 4202560 19 0 0 0 11 0 0 0 20 0 11 0 118727274 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225915882880 140226024093259 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15297] ppid=15284 vsize=1050156 CPUtime=0
/proc/15287/task/15297/stat : 15297 (java) S 15284 15284 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 118728717 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225914685280 140226024093259 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 218.43
Current children cumulated vsize (KiB) 1059324

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

[startup+224.001 s]
/proc/loadavg: 1.08 1.13 1.06 2/71 15297
/proc/meminfo: memFree=9724/1022884 swapFree=0/0
[pid=15284] ppid=15283 vsize=9168 CPUtime=0
/proc/15284/stat : 15284 (p2cudf-full-1.1) S 15283 15284 1750 0 -1 4202496 456 291 0 0 0 0 0 0 20 0 1 0 118727227 9388032 330 18446744073709551615 4194304 5129932 140733837365344 140733837363488 139970633696350 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/15284/statm: 2292 330 280 229 0 52 0
[pid=15287] ppid=15284 vsize=1050156 CPUtime=220.11
/proc/15287/stat : 15287 (java) S 15284 15284 1750 0 -1 4202496 195845 0 23 0 21929 82 0 0 20 0 11 0 118727230 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140737472858112 140226024078965 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 10 0 0
/proc/15287/statm: 262539 186495 2393 9 0 249889 0
[pid=15287/tid=15288] ppid=15284 vsize=1050156 CPUtime=192.4
/proc/15287/task/15288/stat : 15288 (java) R 15284 15284 1750 0 -1 4202560 47794 0 11 0 19212 28 0 0 20 0 11 0 118727241 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140226030612456 140225929509627 0 4 0 16800975 0 0 0 -1 0 0 0 95 0 0
[pid=15287/tid=15289] ppid=15284 vsize=1050156 CPUtime=21.74
/proc/15287/task/15289/stat : 15289 (java) S 15284 15284 1750 0 -1 4202560 122273 0 0 0 2136 38 0 0 20 0 11 0 118727258 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225923251328 140226024093259 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15290] ppid=15284 vsize=1050156 CPUtime=0
/proc/15287/task/15290/stat : 15290 (java) S 15284 15284 1750 0 -1 4202560 15 0 0 0 0 0 0 0 20 0 11 0 118727261 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225922197520 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15291] ppid=15284 vsize=1050156 CPUtime=0
/proc/15287/task/15291/stat : 15291 (java) S 15284 15284 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 118727261 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225921144736 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15292] ppid=15284 vsize=1050156 CPUtime=0
/proc/15287/task/15292/stat : 15292 (java) S 15284 15284 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 118727274 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225920093168 140226024100896 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15293] ppid=15284 vsize=1050156 CPUtime=2.92
/proc/15287/task/15293/stat : 15293 (java) S 15284 15284 1750 0 -1 4202560 14890 0 0 0 284 8 0 0 20 0 11 0 118727274 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225919040528 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15294] ppid=15284 vsize=1050156 CPUtime=2.89
/proc/15287/task/15294/stat : 15294 (java) S 15284 15284 1750 0 -1 4202560 9584 0 0 0 283 6 0 0 20 0 11 0 118727274 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225917987856 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15295] ppid=15284 vsize=1050156 CPUtime=0
/proc/15287/task/15295/stat : 15295 (java) S 15284 15284 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 118727274 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225916935376 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15296] ppid=15284 vsize=1050156 CPUtime=0.11
/proc/15287/task/15296/stat : 15296 (java) S 15284 15284 1750 0 -1 4202560 19 0 0 0 11 0 0 0 20 0 11 0 118727274 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225915882880 140226024093259 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15297] ppid=15284 vsize=1050156 CPUtime=0
/proc/15287/task/15297/stat : 15297 (java) S 15284 15284 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 118728717 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225914685280 140226024093259 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 220.11
Current children cumulated vsize (KiB) 1059324

[startup+230.401 s]
/proc/loadavg: 1.07 1.12 1.06 2/71 15297
/proc/meminfo: memFree=9724/1022884 swapFree=0/0
[pid=15284] ppid=15283 vsize=9168 CPUtime=0
/proc/15284/stat : 15284 (p2cudf-full-1.1) S 15283 15284 1750 0 -1 4202496 456 291 0 0 0 0 0 0 20 0 1 0 118727227 9388032 330 18446744073709551615 4194304 5129932 140733837365344 140733837363488 139970633696350 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/15284/statm: 2292 330 280 229 0 52 0
[pid=15287] ppid=15284 vsize=1050156 CPUtime=226.45
/proc/15287/stat : 15287 (java) S 15284 15284 1750 0 -1 4202496 195845 0 23 0 22563 82 0 0 20 0 11 0 118727230 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140737472858112 140226024078965 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 10 0 0
/proc/15287/statm: 262539 186495 2393 9 0 249889 0
[pid=15287/tid=15288] ppid=15284 vsize=1050156 CPUtime=198.29
/proc/15287/task/15288/stat : 15288 (java) S 15284 15284 1750 0 -1 4202560 47794 0 11 0 19801 28 0 0 20 0 11 0 118727241 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140226030612176 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 95 0 0
[pid=15287/tid=15289] ppid=15284 vsize=1050156 CPUtime=22.2
/proc/15287/task/15289/stat : 15289 (java) R 15284 15284 1750 0 -1 4202560 122273 0 0 0 2182 38 0 0 20 0 11 0 118727258 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225923250256 140226010949760 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15290] ppid=15284 vsize=1050156 CPUtime=0
/proc/15287/task/15290/stat : 15290 (java) S 15284 15284 1750 0 -1 4202560 15 0 0 0 0 0 0 0 20 0 11 0 118727261 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225922197520 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15291] ppid=15284 vsize=1050156 CPUtime=0
/proc/15287/task/15291/stat : 15291 (java) S 15284 15284 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 118727261 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225921144736 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15292] ppid=15284 vsize=1050156 CPUtime=0
/proc/15287/task/15292/stat : 15292 (java) S 15284 15284 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 118727274 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225920093168 140226024100896 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15293] ppid=15284 vsize=1050156 CPUtime=2.92
/proc/15287/task/15293/stat : 15293 (java) S 15284 15284 1750 0 -1 4202560 14890 0 0 0 284 8 0 0 20 0 11 0 118727274 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225919040528 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15294] ppid=15284 vsize=1050156 CPUtime=2.89
/proc/15287/task/15294/stat : 15294 (java) S 15284 15284 1750 0 -1 4202560 9584 0 0 0 283 6 0 0 20 0 11 0 118727274 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225917987856 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15295] ppid=15284 vsize=1050156 CPUtime=0
/proc/15287/task/15295/stat : 15295 (java) S 15284 15284 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 118727274 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225916935376 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15296] ppid=15284 vsize=1050156 CPUtime=0.12
/proc/15287/task/15296/stat : 15296 (java) S 15284 15284 1750 0 -1 4202560 19 0 0 0 12 0 0 0 20 0 11 0 118727274 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225915882880 140226024093259 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15297] ppid=15284 vsize=1050156 CPUtime=0
/proc/15287/task/15297/stat : 15297 (java) S 15284 15284 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 118728717 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225914685280 140226024093259 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 226.45
Current children cumulated vsize (KiB) 1059324

[startup+232.001 s]
/proc/loadavg: 1.07 1.12 1.06 2/71 15297
/proc/meminfo: memFree=9724/1022884 swapFree=0/0
[pid=15284] ppid=15283 vsize=9168 CPUtime=0
/proc/15284/stat : 15284 (p2cudf-full-1.1) S 15283 15284 1750 0 -1 4202496 456 291 0 0 0 0 0 0 20 0 1 0 118727227 9388032 330 18446744073709551615 4194304 5129932 140733837365344 140733837363488 139970633696350 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/15284/statm: 2292 330 280 229 0 52 0
[pid=15287] ppid=15284 vsize=1050156 CPUtime=228.03
/proc/15287/stat : 15287 (java) S 15284 15284 1750 0 -1 4202496 195845 0 23 0 22721 82 0 0 20 0 11 0 118727230 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140737472858112 140226024078965 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 10 0 0
/proc/15287/statm: 262539 186495 2393 9 0 249889 0
[pid=15287/tid=15288] ppid=15284 vsize=1050156 CPUtime=198.32
/proc/15287/task/15288/stat : 15288 (java) S 15284 15284 1750 0 -1 4202560 47794 0 11 0 19804 28 0 0 20 0 11 0 118727241 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140226030612176 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 95 0 0
[pid=15287/tid=15289] ppid=15284 vsize=1050156 CPUtime=23.75
/proc/15287/task/15289/stat : 15289 (java) R 15284 15284 1750 0 -1 4202560 122273 0 0 0 2337 38 0 0 20 0 11 0 118727258 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225923250704 140226008440575 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15290] ppid=15284 vsize=1050156 CPUtime=0
/proc/15287/task/15290/stat : 15290 (java) S 15284 15284 1750 0 -1 4202560 15 0 0 0 0 0 0 0 20 0 11 0 118727261 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225922197520 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15291] ppid=15284 vsize=1050156 CPUtime=0
/proc/15287/task/15291/stat : 15291 (java) S 15284 15284 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 118727261 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225921144736 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15292] ppid=15284 vsize=1050156 CPUtime=0
/proc/15287/task/15292/stat : 15292 (java) S 15284 15284 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 118727274 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225920093168 140226024100896 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15293] ppid=15284 vsize=1050156 CPUtime=2.92
/proc/15287/task/15293/stat : 15293 (java) S 15284 15284 1750 0 -1 4202560 14890 0 0 0 284 8 0 0 20 0 11 0 118727274 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225919040528 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15294] ppid=15284 vsize=1050156 CPUtime=2.89
/proc/15287/task/15294/stat : 15294 (java) S 15284 15284 1750 0 -1 4202560 9584 0 0 0 283 6 0 0 20 0 11 0 118727274 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225917987856 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15295] ppid=15284 vsize=1050156 CPUtime=0
/proc/15287/task/15295/stat : 15295 (java) S 15284 15284 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 118727274 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225916935376 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15296] ppid=15284 vsize=1050156 CPUtime=0.12
/proc/15287/task/15296/stat : 15296 (java) S 15284 15284 1750 0 -1 4202560 19 0 0 0 12 0 0 0 20 0 11 0 118727274 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225915882880 140226024093259 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15297] ppid=15284 vsize=1050156 CPUtime=0
/proc/15287/task/15297/stat : 15297 (java) S 15284 15284 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 118728717 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225914685280 140226024093259 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 228.03
Current children cumulated vsize (KiB) 1059324

[startup+233.601 s]
/proc/loadavg: 1.07 1.12 1.06 2/71 15297
/proc/meminfo: memFree=9724/1022884 swapFree=0/0
[pid=15284] ppid=15283 vsize=9168 CPUtime=0
/proc/15284/stat : 15284 (p2cudf-full-1.1) S 15283 15284 1750 0 -1 4202496 456 291 0 0 0 0 0 0 20 0 1 0 118727227 9388032 330 18446744073709551615 4194304 5129932 140733837365344 140733837363488 139970633696350 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/15284/statm: 2292 330 280 229 0 52 0
[pid=15287] ppid=15284 vsize=1050156 CPUtime=229.61
/proc/15287/stat : 15287 (java) S 15284 15284 1750 0 -1 4202496 195845 0 23 0 22879 82 0 0 20 0 11 0 118727230 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140737472858112 140226024078965 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 10 0 0
/proc/15287/statm: 262539 186495 2393 9 0 249889 0
[pid=15287/tid=15288] ppid=15284 vsize=1050156 CPUtime=198.32
/proc/15287/task/15288/stat : 15288 (java) S 15284 15284 1750 0 -1 4202560 47794 0 11 0 19804 28 0 0 20 0 11 0 118727241 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140226030613600 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 95 0 0
[pid=15287/tid=15289] ppid=15284 vsize=1050156 CPUtime=25.32
/proc/15287/task/15289/stat : 15289 (java) R 15284 15284 1750 0 -1 4202560 122273 0 0 0 2494 38 0 0 20 0 11 0 118727258 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225923250256 140226010949720 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15290] ppid=15284 vsize=1050156 CPUtime=0
/proc/15287/task/15290/stat : 15290 (java) S 15284 15284 1750 0 -1 4202560 15 0 0 0 0 0 0 0 20 0 11 0 118727261 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225922197520 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15291] ppid=15284 vsize=1050156 CPUtime=0
/proc/15287/task/15291/stat : 15291 (java) S 15284 15284 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 118727261 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225921144736 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15292] ppid=15284 vsize=1050156 CPUtime=0
/proc/15287/task/15292/stat : 15292 (java) S 15284 15284 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 118727274 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225920093168 140226024100896 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15293] ppid=15284 vsize=1050156 CPUtime=2.92
/proc/15287/task/15293/stat : 15293 (java) S 15284 15284 1750 0 -1 4202560 14890 0 0 0 284 8 0 0 20 0 11 0 118727274 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225919040528 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15294] ppid=15284 vsize=1050156 CPUtime=2.9
/proc/15287/task/15294/stat : 15294 (java) S 15284 15284 1750 0 -1 4202560 9584 0 0 0 284 6 0 0 20 0 11 0 118727274 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225917972528 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15295] ppid=15284 vsize=1050156 CPUtime=0
/proc/15287/task/15295/stat : 15295 (java) S 15284 15284 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 118727274 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225916935376 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15296] ppid=15284 vsize=1050156 CPUtime=0.12
/proc/15287/task/15296/stat : 15296 (java) S 15284 15284 1750 0 -1 4202560 19 0 0 0 12 0 0 0 20 0 11 0 118727274 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225915882880 140226024093259 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15297] ppid=15284 vsize=1050156 CPUtime=0
/proc/15287/task/15297/stat : 15297 (java) S 15284 15284 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 118728717 1075359744 186495 18446744073709551615 4194304 4228012 140737472867088 140225914685280 140226024093259 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 229.61
Current children cumulated vsize (KiB) 1059324

[startup+234.001 s]
/proc/loadavg: 1.07 1.12 1.06 2/71 15297
/proc/meminfo: memFree=9724/1022884 swapFree=0/0
[pid=15284] ppid=15283 vsize=9168 CPUtime=0
/proc/15284/stat : 15284 (p2cudf-full-1.1) S 15283 15284 1750 0 -1 4202496 456 291 0 0 0 0 0 0 20 0 1 0 118727227 9388032 330 18446744073709551615 4194304 5129932 140733837365344 140733837363488 139970633696350 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/15284/statm: 2292 330 280 229 0 52 0
[pid=15287] ppid=15284 vsize=1051184 CPUtime=229.97
/proc/15287/stat : 15287 (java) S 15284 15284 1750 0 -1 4202496 195856 0 23 0 22915 82 0 0 20 0 11 0 118727230 1076412416 186504 18446744073709551615 4194304 4228012 140737472867088 140737472858112 140226024078965 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 10 0 0
/proc/15287/statm: 262796 186504 2393 9 0 250146 0
[pid=15287/tid=15288] ppid=15284 vsize=1051184 CPUtime=198.32
/proc/15287/task/15288/stat : 15288 (java) S 15284 15284 1750 0 -1 4202560 47798 0 11 0 19804 28 0 0 20 0 11 0 118727241 1076412416 186504 18446744073709551615 4194304 4228012 140737472867088 140226030613824 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 95 0 0
[pid=15287/tid=15289] ppid=15284 vsize=1051184 CPUtime=25.66
/proc/15287/task/15289/stat : 15289 (java) S 15284 15284 1750 0 -1 4202560 122273 0 0 0 2528 38 0 0 20 0 11 0 118727258 1076412416 186504 18446744073709551615 4194304 4228012 140737472867088 140225923251328 140226024093259 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15290] ppid=15284 vsize=1051184 CPUtime=0
/proc/15287/task/15290/stat : 15290 (java) S 15284 15284 1750 0 -1 4202560 15 0 0 0 0 0 0 0 20 0 11 0 118727261 1076412416 186504 18446744073709551615 4194304 4228012 140737472867088 140225922197520 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15291] ppid=15284 vsize=1051184 CPUtime=0
/proc/15287/task/15291/stat : 15291 (java) S 15284 15284 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 118727261 1076412416 186504 18446744073709551615 4194304 4228012 140737472867088 140225921144736 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15292] ppid=15284 vsize=1051184 CPUtime=0
/proc/15287/task/15292/stat : 15292 (java) S 15284 15284 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 118727274 1076412416 186504 18446744073709551615 4194304 4228012 140737472867088 140225920093168 140226024100896 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15293] ppid=15284 vsize=1051184 CPUtime=2.92
/proc/15287/task/15293/stat : 15293 (java) S 15284 15284 1750 0 -1 4202560 14890 0 0 0 284 8 0 0 20 0 11 0 118727274 1076412416 186504 18446744073709551615 4194304 4228012 140737472867088 140225919040528 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15294] ppid=15284 vsize=1051184 CPUtime=2.91
/proc/15287/task/15294/stat : 15294 (java) S 15284 15284 1750 0 -1 4202560 9585 0 0 0 285 6 0 0 20 0 11 0 118727274 1076412416 186504 18446744073709551615 4194304 4228012 140737472867088 140225917987856 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15295] ppid=15284 vsize=1051184 CPUtime=0
/proc/15287/task/15295/stat : 15295 (java) S 15284 15284 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 118727274 1076412416 186504 18446744073709551615 4194304 4228012 140737472867088 140225916935376 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15296] ppid=15284 vsize=1051184 CPUtime=0.12
/proc/15287/task/15296/stat : 15296 (java) S 15284 15284 1750 0 -1 4202560 19 0 0 0 12 0 0 0 20 0 11 0 118727274 1076412416 186504 18446744073709551615 4194304 4228012 140737472867088 140225915882880 140226024093259 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 229.97
Current children cumulated vsize (KiB) 1060352

[startup+234.405 s]
/proc/loadavg: 1.07 1.12 1.06 1/71 15298
/proc/meminfo: memFree=9724/1022884 swapFree=0/0
[pid=15284] ppid=15283 vsize=9168 CPUtime=0
/proc/15284/stat : 15284 (p2cudf-full-1.1) S 15283 15284 1750 0 -1 4202496 456 291 0 0 0 0 0 0 20 0 1 0 118727227 9388032 330 18446744073709551615 4194304 5129932 140733837365344 140733837363488 139970633696350 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/15284/statm: 2292 330 280 229 0 52 0
[pid=15287] ppid=15284 vsize=1051184 CPUtime=229.97
/proc/15287/stat : 15287 (java) S 15284 15284 1750 0 -1 4202496 195856 0 23 0 22915 82 0 0 20 0 11 0 118727230 1076412416 186504 18446744073709551615 4194304 4228012 140737472867088 140737472858112 140226024078965 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 10 0 0
/proc/15287/statm: 262796 186504 2393 9 0 250146 0
[pid=15287/tid=15288] ppid=15284 vsize=1051184 CPUtime=198.32
/proc/15287/task/15288/stat : 15288 (java) S 15284 15284 1750 0 -1 4202560 47798 0 11 0 19804 28 0 0 20 0 11 0 118727241 1076412416 186504 18446744073709551615 4194304 4228012 140737472867088 140226030613824 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 95 0 0
[pid=15287/tid=15289] ppid=15284 vsize=1051184 CPUtime=25.66
/proc/15287/task/15289/stat : 15289 (java) S 15284 15284 1750 0 -1 4202560 122273 0 0 0 2528 38 0 0 20 0 11 0 118727258 1076412416 186504 18446744073709551615 4194304 4228012 140737472867088 140225923251328 140226024093259 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15290] ppid=15284 vsize=1051184 CPUtime=0
/proc/15287/task/15290/stat : 15290 (java) S 15284 15284 1750 0 -1 4202560 15 0 0 0 0 0 0 0 20 0 11 0 118727261 1076412416 186504 18446744073709551615 4194304 4228012 140737472867088 140225922197520 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15291] ppid=15284 vsize=1051184 CPUtime=0
/proc/15287/task/15291/stat : 15291 (java) S 15284 15284 1750 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 118727261 1076412416 186504 18446744073709551615 4194304 4228012 140737472867088 140225921144736 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15292] ppid=15284 vsize=1051184 CPUtime=0
/proc/15287/task/15292/stat : 15292 (java) S 15284 15284 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 118727274 1076412416 186504 18446744073709551615 4194304 4228012 140737472867088 140225920093168 140226024100896 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15293] ppid=15284 vsize=1051184 CPUtime=2.92
/proc/15287/task/15293/stat : 15293 (java) S 15284 15284 1750 0 -1 4202560 14890 0 0 0 284 8 0 0 20 0 11 0 118727274 1076412416 186504 18446744073709551615 4194304 4228012 140737472867088 140225919040528 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15294] ppid=15284 vsize=1051184 CPUtime=2.91
/proc/15287/task/15294/stat : 15294 (java) S 15284 15284 1750 0 -1 4202560 9585 0 0 0 285 6 0 0 20 0 11 0 118727274 1076412416 186504 18446744073709551615 4194304 4228012 140737472867088 140225917987856 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15295] ppid=15284 vsize=1051184 CPUtime=0
/proc/15287/task/15295/stat : 15295 (java) S 15284 15284 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 118727274 1076412416 186504 18446744073709551615 4194304 4228012 140737472867088 140225916935376 140226024092372 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15296] ppid=15284 vsize=1051184 CPUtime=0.12
/proc/15287/task/15296/stat : 15296 (java) S 15284 15284 1750 0 -1 4202560 19 0 0 0 12 0 0 0 20 0 11 0 118727274 1076412416 186504 18446744073709551615 4194304 4228012 140737472867088 140225915882880 140226024093259 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=15287/tid=15298] ppid=15284 vsize=1051184 CPUtime=0
/proc/15287/task/15298/stat : 15298 (java) S 15284 15284 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 118750622 1076412416 186504 18446744073709551615 4194304 4228012 140737472867088 140225913632944 140226024093259 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 229.97
Current children cumulated vsize (KiB) 1060352

[startup+234.501 s]
/proc/loadavg: 1.07 1.12 1.06 1/71 15298
/proc/meminfo: memFree=9724/1022884 swapFree=0/0
[pid=15284] ppid=15283 vsize=9168 CPUtime=0
/proc/15284/stat : 15284 (p2cudf-full-1.1) S 15283 15284 1750 0 -1 4202496 456 291 0 0 0 0 0 0 20 0 1 0 118727227 9388032 330 18446744073709551615 4194304 5129932 140733837365344 140733837363488 139970633696350 0 65536 16781316 65538 0 0 0 17 0 0 0 1 0 0
/proc/15284/statm: 2292 330 280 229 0 52 0
[pid=15287] ppid=15284 vsize=0 CPUtime=230.02
/proc/15287/stat : 15287 (java) Z 15284 15284 1750 0 -1 4202508 195866 0 23 0 22916 86 0 0 20 0 2 0 118727230 0 0 18446744073709551615 0 0 0 0 0 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 10 0 0
/proc/15287/statm: 0 0 0 0 0 0 0
[pid=15287/tid=15295] ppid=15284 vsize=0 CPUtime=0.05
/proc/15287/task/15295/stat : 15295 (java) R 15284 15284 1750 0 -1 4203588 0 0 0 0 0 5 0 0 20 0 2 0 118727274 0 0 18446744073709551615 0 0 0 0 0 0 4 0 16800975 18446744073709551615 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 230.02
Current children cumulated vsize (KiB) 9168

Child status: 1
Real time (s): 234.534
CPU time (s): 230.062
CPU user time (s): 229.174
CPU system time (s): 0.888055
CPU usage (%): 98.0933
Max. virtual memory (cumulated for all children) (KiB): 1063908

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 229.174
system time used= 0.888055
maximum resident set size= 746036
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 196626
page faults= 23
swaps= 0
block input operations= 77968
block output operations= 328
messages sent= 0
messages received= 0
signals received= 0
voluntary context switches= 6164
involuntary context switches= 33502

runsolver used 0.740046 second user time and 1.6401 second system time

The end