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/trendy-size/upgrade/easy/rand813.cudf.log.runsolver /home/competition/p2cudf-full-1.15/p2cudf-full-1.15 /home/competition/data/upgrade/easy/rand813.cudf /tmp/misc2012/2012-09-02-22:42/full/p2cudf-full-1.15/trendy-size/upgrade/easy/rand813.cudf.result -count(removed),-sum(solution,installedsize),-notuptodate(solution),-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
Current StackSize limit: 8192 KiB


[startup+0 s]
/proc/loadavg: 1.55 1.68 1.39 2/59 19357
/proc/meminfo: memFree=468336/1022884 swapFree=0/0
[pid=19357] ppid=19356 vsize=9168 CPUtime=0
/proc/19357/stat : 19357 (p2cudf-full-1.1) S 19356 19357 1750 0 -1 4202496 425 0 0 0 0 0 0 0 20 0 1 0 119872059 9388032 326 18446744073709551615 4194304 5129932 140736505219072 140736505216744 139650191906592 0 0 16781316 65536 0 0 0 17 0 0 0 0 0 0
/proc/19357/statm: 2292 326 275 229 0 52 0

[startup+0.138062 s]
/proc/loadavg: 1.55 1.68 1.39 2/59 19357
/proc/meminfo: memFree=468336/1022884 swapFree=0/0
[pid=19357] ppid=19356 vsize=9168 CPUtime=0
/proc/19357/stat : 19357 (p2cudf-full-1.1) S 19356 19357 1750 0 -1 4202496 457 292 0 0 0 0 0 0 20 0 1 0 119872059 9388032 331 18446744073709551615 4194304 5129932 140736505219072 140736505217216 139650191762526 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/19357/statm: 2292 331 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+0.200317 s]
/proc/loadavg: 1.55 1.68 1.39 2/59 19357
/proc/meminfo: memFree=468336/1022884 swapFree=0/0
[pid=19357] ppid=19356 vsize=9168 CPUtime=0
/proc/19357/stat : 19357 (p2cudf-full-1.1) S 19356 19357 1750 0 -1 4202496 457 292 0 0 0 0 0 0 20 0 1 0 119872059 9388032 331 18446744073709551615 4194304 5129932 140736505219072 140736505217216 139650191762526 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/19357/statm: 2292 331 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+0.300305 s]
/proc/loadavg: 1.55 1.68 1.39 2/59 19357
/proc/meminfo: memFree=468336/1022884 swapFree=0/0
[pid=19357] ppid=19356 vsize=9168 CPUtime=0
/proc/19357/stat : 19357 (p2cudf-full-1.1) S 19356 19357 1750 0 -1 4202496 457 292 0 0 0 0 0 0 20 0 1 0 119872059 9388032 331 18446744073709551615 4194304 5129932 140736505219072 140736505217216 139650191762526 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/19357/statm: 2292 331 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+0.700225 s]
/proc/loadavg: 1.55 1.68 1.39 2/59 19357
/proc/meminfo: memFree=468336/1022884 swapFree=0/0
[pid=19357] ppid=19356 vsize=9168 CPUtime=0
/proc/19357/stat : 19357 (p2cudf-full-1.1) S 19356 19357 1750 0 -1 4202496 457 292 0 0 0 0 0 0 20 0 1 0 119872059 9388032 331 18446744073709551615 4194304 5129932 140736505219072 140736505217216 139650191762526 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/19357/statm: 2292 331 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+1.5007 s]
/proc/loadavg: 1.55 1.68 1.39 4/70 19369
/proc/meminfo: memFree=423848/1022884 swapFree=0/0
[pid=19357] ppid=19356 vsize=9168 CPUtime=0
/proc/19357/stat : 19357 (p2cudf-full-1.1) S 19356 19357 1750 0 -1 4202496 457 292 0 0 0 0 0 0 20 0 1 0 119872059 9388032 331 18446744073709551615 4194304 5129932 140736505219072 140736505217216 139650191762526 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/19357/statm: 2292 331 280 229 0 52 0
[pid=19360] ppid=19357 vsize=1048924 CPUtime=1.46
/proc/19360/stat : 19360 (java) S 19357 19357 1750 0 -1 4202496 32827 0 0 0 128 18 0 0 20 0 10 0 119872060 1074098176 29456 18446744073709551615 4194304 4228012 140735053991408 140735053982432 139801921109621 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/19360/statm: 262231 29456 2348 9 0 249581 0
[pid=19360/tid=19361] ppid=19357 vsize=1048924 CPUtime=0.68
/proc/19360/task/19361/stat : 19361 (java) R 19357 19357 1750 0 -1 4202560 14284 0 0 0 58 10 0 0 20 0 10 0 119872061 1074098176 29456 18446744073709551615 4194304 4228012 140735053991408 139801927635616 139801825065644 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19362] ppid=19357 vsize=1048924 CPUtime=0
/proc/19360/task/19362/stat : 19362 (java) S 19357 19357 1750 0 -1 4202560 4 0 0 0 0 0 0 0 20 0 10 0 119872063 1074098176 29456 18446744073709551615 4194304 4228012 140735053991408 139801820281984 139801921123915 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19363] ppid=19357 vsize=1048924 CPUtime=0
/proc/19360/task/19363/stat : 19363 (java) S 19357 19357 1750 0 -1 4202560 15 0 0 0 0 0 0 0 20 0 10 0 119872064 1074098176 29456 18446744073709551615 4194304 4228012 140735053991408 139801819228176 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19364] ppid=19357 vsize=1048924 CPUtime=0
/proc/19360/task/19364/stat : 19364 (java) S 19357 19357 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 10 0 119872064 1074098176 29456 18446744073709551615 4194304 4228012 140735053991408 139801818175392 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19365] ppid=19357 vsize=1048924 CPUtime=0
/proc/19360/task/19365/stat : 19365 (java) S 19357 19357 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 119872068 1074098176 29456 18446744073709551615 4194304 4228012 140735053991408 139801817123824 139801921131552 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19366] ppid=19357 vsize=1048924 CPUtime=0.39
/proc/19360/task/19366/stat : 19366 (java) R 19357 19357 1750 0 -1 4202560 8311 0 0 0 36 3 0 0 20 0 10 0 119872068 1074098176 29456 18446744073709551615 4194304 4228012 140735053991408 139801816058984 139801904701440 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19367] ppid=19357 vsize=1048924 CPUtime=0.36
/proc/19360/task/19367/stat : 19367 (java) R 19357 19357 1750 0 -1 4202560 8940 0 0 0 32 4 0 0 20 0 10 0 119872068 1074098176 29456 18446744073709551615 4194304 4228012 140735053991408 139801815003288 139801908446339 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19368] ppid=19357 vsize=1048924 CPUtime=0
/proc/19360/task/19368/stat : 19368 (java) S 19357 19357 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 119872068 1074098176 29456 18446744073709551615 4194304 4228012 140735053991408 139801813966032 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19369] ppid=19357 vsize=1048924 CPUtime=0
/proc/19360/task/19369/stat : 19369 (java) S 19357 19357 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 119872068 1074098176 29456 18446744073709551615 4194304 4228012 140735053991408 139801812913536 139801921123915 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 1.46
Current children cumulated vsize (KiB) 1058092

[startup+3.10076 s]
/proc/loadavg: 1.55 1.68 1.39 4/70 19369
/proc/meminfo: memFree=320308/1022884 swapFree=0/0
[pid=19357] ppid=19356 vsize=9168 CPUtime=0
/proc/19357/stat : 19357 (p2cudf-full-1.1) S 19356 19357 1750 0 -1 4202496 457 292 0 0 0 0 0 0 20 0 1 0 119872059 9388032 331 18446744073709551615 4194304 5129932 140736505219072 140736505217216 139650191762526 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/19357/statm: 2292 331 280 229 0 52 0
[pid=19360] ppid=19357 vsize=1049128 CPUtime=3.04
/proc/19360/stat : 19360 (java) S 19357 19357 1750 0 -1 4202496 76214 0 0 0 268 36 0 0 20 0 10 0 119872060 1074307072 71078 18446744073709551615 4194304 4228012 140735053991408 140735053982432 139801921109621 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/19360/statm: 262282 71078 2368 9 0 249632 0
[pid=19360/tid=19361] ppid=19357 vsize=1049128 CPUtime=1.5
/proc/19360/task/19361/stat : 19361 (java) R 19357 19357 1750 0 -1 4202560 47419 0 0 0 128 22 0 0 20 0 10 0 119872061 1074307072 71078 18446744073709551615 4194304 4228012 140735053991408 139801927635648 139801825549414 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19362] ppid=19357 vsize=1049128 CPUtime=0.17
/proc/19360/task/19362/stat : 19362 (java) S 19357 19357 1750 0 -1 4202560 7955 0 0 0 13 4 0 0 20 0 10 0 119872063 1074307072 71078 18446744073709551615 4194304 4228012 140735053991408 139801820281984 139801921123915 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19363] ppid=19357 vsize=1049128 CPUtime=0
/proc/19360/task/19363/stat : 19363 (java) S 19357 19357 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 10 0 119872064 1074307072 71078 18446744073709551615 4194304 4228012 140735053991408 139801819228176 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19364] ppid=19357 vsize=1049128 CPUtime=0
/proc/19360/task/19364/stat : 19364 (java) S 19357 19357 1750 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 10 0 119872064 1074307072 71078 18446744073709551615 4194304 4228012 140735053991408 139801818175392 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19365] ppid=19357 vsize=1049128 CPUtime=0
/proc/19360/task/19365/stat : 19365 (java) S 19357 19357 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 119872068 1074307072 71078 18446744073709551615 4194304 4228012 140735053991408 139801817123824 139801921131552 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19366] ppid=19357 vsize=1049128 CPUtime=0.71
/proc/19360/task/19366/stat : 19366 (java) S 19357 19357 1750 0 -1 4202560 8744 0 0 0 68 3 0 0 20 0 10 0 119872068 1074307072 71078 18446744073709551615 4194304 4228012 140735053991408 139801816071184 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19367] ppid=19357 vsize=1049128 CPUtime=0.64
/proc/19360/task/19367/stat : 19367 (java) S 19357 19357 1750 0 -1 4202560 10805 0 0 0 58 6 0 0 20 0 10 0 119872068 1074307072 71078 18446744073709551615 4194304 4228012 140735053991408 139801815018512 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19368] ppid=19357 vsize=1049128 CPUtime=0
/proc/19360/task/19368/stat : 19368 (java) S 19357 19357 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 119872068 1074307072 71078 18446744073709551615 4194304 4228012 140735053991408 139801813966032 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19369] ppid=19357 vsize=1049128 CPUtime=0
/proc/19360/task/19369/stat : 19369 (java) S 19357 19357 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 119872068 1074307072 71078 18446744073709551615 4194304 4228012 140735053991408 139801812913536 139801921123915 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 3.04
Current children cumulated vsize (KiB) 1058296

[startup+6.30075 s]
/proc/loadavg: 1.50 1.66 1.39 2/70 19369
/proc/meminfo: memFree=31264/1022884 swapFree=0/0
[pid=19357] ppid=19356 vsize=9168 CPUtime=0
/proc/19357/stat : 19357 (p2cudf-full-1.1) S 19356 19357 1750 0 -1 4202496 457 292 0 0 0 0 0 0 20 0 1 0 119872059 9388032 331 18446744073709551615 4194304 5129932 140736505219072 140736505217216 139650191762526 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/19357/statm: 2292 331 280 229 0 52 0
[pid=19360] ppid=19357 vsize=1040108 CPUtime=6.18
/proc/19360/stat : 19360 (java) S 19357 19357 1750 0 -1 4202496 113714 0 0 0 566 52 0 0 20 0 10 0 119872060 1065070592 106251 18446744073709551615 4194304 4228012 140735053991408 140735053982432 139801921109621 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/19360/statm: 260027 106251 2371 9 0 247377 0
[pid=19360/tid=19361] ppid=19357 vsize=1040108 CPUtime=3.24
/proc/19360/task/19361/stat : 19361 (java) R 19357 19357 1750 0 -1 4202560 47489 0 0 0 300 24 0 0 20 0 10 0 119872061 1065070592 106251 18446744073709551615 4194304 4228012 140735053991408 139801927643944 139801825559451 0 4 0 16800975 0 0 0 -1 0 0 0 2 0 0
[pid=19360/tid=19362] ppid=19357 vsize=1040108 CPUtime=1.07
/proc/19360/task/19362/stat : 19362 (java) S 19357 19357 1750 0 -1 4202560 45256 0 0 0 90 17 0 0 20 0 10 0 119872063 1065070592 106251 18446744073709551615 4194304 4228012 140735053991408 139801820281984 139801921123915 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19363] ppid=19357 vsize=1040108 CPUtime=0
/proc/19360/task/19363/stat : 19363 (java) S 19357 19357 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 10 0 119872064 1065070592 106251 18446744073709551615 4194304 4228012 140735053991408 139801819228176 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19364] ppid=19357 vsize=1040108 CPUtime=0
/proc/19360/task/19364/stat : 19364 (java) S 19357 19357 1750 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 10 0 119872064 1065070592 106251 18446744073709551615 4194304 4228012 140735053991408 139801818175392 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19365] ppid=19357 vsize=1040108 CPUtime=0
/proc/19360/task/19365/stat : 19365 (java) S 19357 19357 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 119872068 1065070592 106251 18446744073709551615 4194304 4228012 140735053991408 139801817123824 139801921131552 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19366] ppid=19357 vsize=1040108 CPUtime=0.95
/proc/19360/task/19366/stat : 19366 (java) S 19357 19357 1750 0 -1 4202560 8817 0 0 0 92 3 0 0 20 0 10 0 119872068 1065070592 106251 18446744073709551615 4194304 4228012 140735053991408 139801816071184 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19367] ppid=19357 vsize=1040108 CPUtime=0.88
/proc/19360/task/19367/stat : 19367 (java) R 19357 19357 1750 0 -1 4202560 10861 0 0 0 82 6 0 0 20 0 10 0 119872068 1065070592 106251 18446744073709551615 4194304 4228012 140735053991408 139801815009672 139801907616699 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19368] ppid=19357 vsize=1040108 CPUtime=0
/proc/19360/task/19368/stat : 19368 (java) S 19357 19357 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 119872068 1065070592 106251 18446744073709551615 4194304 4228012 140735053991408 139801813966032 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19369] ppid=19357 vsize=1040108 CPUtime=0
/proc/19360/task/19369/stat : 19369 (java) S 19357 19357 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 119872068 1065070592 106251 18446744073709551615 4194304 4228012 140735053991408 139801812913536 139801921123915 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 6.18
Current children cumulated vsize (KiB) 1049276

[startup+12.7009 s]
/proc/loadavg: 1.62 1.69 1.40 3/71 19370
/proc/meminfo: memFree=10268/1022884 swapFree=0/0
[pid=19357] ppid=19356 vsize=9168 CPUtime=0
/proc/19357/stat : 19357 (p2cudf-full-1.1) S 19356 19357 1750 0 -1 4202496 457 292 0 0 0 0 0 0 20 0 1 0 119872059 9388032 331 18446744073709551615 4194304 5129932 140736505219072 140736505217216 139650191762526 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/19357/statm: 2292 331 280 229 0 52 0
[pid=19360] ppid=19357 vsize=1041136 CPUtime=12.48
/proc/19360/stat : 19360 (java) S 19357 19357 1750 0 -1 4202496 122298 0 0 0 1189 59 0 0 20 0 11 0 119872060 1066123264 114835 18446744073709551615 4194304 4228012 140735053991408 140735053982432 139801921109621 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/19360/statm: 260284 114835 2380 9 0 247634 0
[pid=19360/tid=19361] ppid=19357 vsize=1041136 CPUtime=6.38
/proc/19360/task/19361/stat : 19361 (java) R 19357 19357 1750 0 -1 4202560 47808 0 0 0 613 25 0 0 20 0 11 0 119872061 1066123264 114835 18446744073709551615 4194304 4228012 140735053991408 139801927642952 139801826544296 0 4 0 16800975 0 0 0 -1 0 0 0 2 0 0
[pid=19360/tid=19362] ppid=19357 vsize=1041136 CPUtime=1.32
/proc/19360/task/19362/stat : 19362 (java) S 19357 19357 1750 0 -1 4202560 53197 0 0 0 110 22 0 0 20 0 11 0 119872063 1066123264 114835 18446744073709551615 4194304 4228012 140735053991408 139801820281984 139801921123915 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19363] ppid=19357 vsize=1041136 CPUtime=0
/proc/19360/task/19363/stat : 19363 (java) S 19357 19357 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 119872064 1066123264 114835 18446744073709551615 4194304 4228012 140735053991408 139801819228176 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19364] ppid=19357 vsize=1041136 CPUtime=0
/proc/19360/task/19364/stat : 19364 (java) S 19357 19357 1750 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 119872064 1066123264 114835 18446744073709551615 4194304 4228012 140735053991408 139801818175392 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19365] ppid=19357 vsize=1041136 CPUtime=0
/proc/19360/task/19365/stat : 19365 (java) S 19357 19357 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 119872068 1066123264 114835 18446744073709551615 4194304 4228012 140735053991408 139801817123824 139801921131552 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19366] ppid=19357 vsize=1041136 CPUtime=2.35
/proc/19360/task/19366/stat : 19366 (java) S 19357 19357 1750 0 -1 4202560 9021 0 0 0 231 4 0 0 20 0 11 0 119872068 1066123264 114835 18446744073709551615 4194304 4228012 140735053991408 139801816071184 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19367] ppid=19357 vsize=1041136 CPUtime=2.39
/proc/19360/task/19367/stat : 19367 (java) S 19357 19357 1750 0 -1 4202560 10975 0 0 0 233 6 0 0 20 0 11 0 119872068 1066123264 114835 18446744073709551615 4194304 4228012 140735053991408 139801815018512 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19368] ppid=19357 vsize=1041136 CPUtime=0
/proc/19360/task/19368/stat : 19368 (java) S 19357 19357 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 119872068 1066123264 114835 18446744073709551615 4194304 4228012 140735053991408 139801813966032 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19369] ppid=19357 vsize=1041136 CPUtime=0
/proc/19360/task/19369/stat : 19369 (java) S 19357 19357 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 119872068 1066123264 114835 18446744073709551615 4194304 4228012 140735053991408 139801812913536 139801921123915 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19370] ppid=19357 vsize=1041136 CPUtime=0
/proc/19360/task/19370/stat : 19370 (java) S 19357 19357 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 119873086 1066123264 114835 18446744073709551615 4194304 4228012 140735053991408 139801811715936 139801921123915 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 12.48
Current children cumulated vsize (KiB) 1050304

[startup+25.5008 s]
/proc/loadavg: 1.48 1.65 1.39 2/71 19370
/proc/meminfo: memFree=10268/1022884 swapFree=0/0
[pid=19357] ppid=19356 vsize=9168 CPUtime=0
/proc/19357/stat : 19357 (p2cudf-full-1.1) S 19356 19357 1750 0 -1 4202496 457 292 0 0 0 0 0 0 20 0 1 0 119872059 9388032 331 18446744073709551615 4194304 5129932 140736505219072 140736505217216 139650191762526 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/19357/statm: 2292 331 280 229 0 52 0
[pid=19360] ppid=19357 vsize=1041136 CPUtime=25.1
/proc/19360/stat : 19360 (java) S 19357 19357 1750 0 -1 4202496 122304 0 0 0 2451 59 0 0 20 0 11 0 119872060 1066123264 114841 18446744073709551615 4194304 4228012 140735053991408 140735053982432 139801921109621 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/19360/statm: 260284 114841 2381 9 0 247634 0
[pid=19360/tid=19361] ppid=19357 vsize=1041136 CPUtime=18.91
/proc/19360/task/19361/stat : 19361 (java) R 19357 19357 1750 0 -1 4202560 47810 0 0 0 1866 25 0 0 20 0 11 0 119872061 1066123264 114841 18446744073709551615 4194304 4228012 140735053991408 139801927643160 139801826544296 0 4 0 16800975 0 0 0 -1 0 0 0 2 0 0
[pid=19360/tid=19362] ppid=19357 vsize=1041136 CPUtime=1.32
/proc/19360/task/19362/stat : 19362 (java) S 19357 19357 1750 0 -1 4202560 53197 0 0 0 110 22 0 0 20 0 11 0 119872063 1066123264 114841 18446744073709551615 4194304 4228012 140735053991408 139801820281984 139801921123915 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19363] ppid=19357 vsize=1041136 CPUtime=0
/proc/19360/task/19363/stat : 19363 (java) S 19357 19357 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 119872064 1066123264 114841 18446744073709551615 4194304 4228012 140735053991408 139801819228176 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19364] ppid=19357 vsize=1041136 CPUtime=0
/proc/19360/task/19364/stat : 19364 (java) S 19357 19357 1750 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 119872064 1066123264 114841 18446744073709551615 4194304 4228012 140735053991408 139801818175392 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19365] ppid=19357 vsize=1041136 CPUtime=0
/proc/19360/task/19365/stat : 19365 (java) S 19357 19357 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 119872068 1066123264 114841 18446744073709551615 4194304 4228012 140735053991408 139801817123824 139801921131552 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19366] ppid=19357 vsize=1041136 CPUtime=2.4
/proc/19360/task/19366/stat : 19366 (java) S 19357 19357 1750 0 -1 4202560 9023 0 0 0 236 4 0 0 20 0 11 0 119872068 1066123264 114841 18446744073709551615 4194304 4228012 140735053991408 139801816071184 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19367] ppid=19357 vsize=1041136 CPUtime=2.42
/proc/19360/task/19367/stat : 19367 (java) S 19357 19357 1750 0 -1 4202560 10977 0 0 0 236 6 0 0 20 0 11 0 119872068 1066123264 114841 18446744073709551615 4194304 4228012 140735053991408 139801815018512 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19368] ppid=19357 vsize=1041136 CPUtime=0
/proc/19360/task/19368/stat : 19368 (java) S 19357 19357 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 119872068 1066123264 114841 18446744073709551615 4194304 4228012 140735053991408 139801813966032 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19369] ppid=19357 vsize=1041136 CPUtime=0.01
/proc/19360/task/19369/stat : 19369 (java) S 19357 19357 1750 0 -1 4202560 0 0 0 0 0 1 0 0 20 0 11 0 119872068 1066123264 114841 18446744073709551615 4194304 4228012 140735053991408 139801812913536 139801921123915 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19370] ppid=19357 vsize=1041136 CPUtime=0
/proc/19360/task/19370/stat : 19370 (java) S 19357 19357 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 119873086 1066123264 114841 18446744073709551615 4194304 4228012 140735053991408 139801811715936 139801921123915 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 25.1
Current children cumulated vsize (KiB) 1050304

[startup+51.1008 s]
/proc/loadavg: 1.32 1.60 1.38 2/71 19370
/proc/meminfo: memFree=10400/1022884 swapFree=0/0
[pid=19357] ppid=19356 vsize=9168 CPUtime=0
/proc/19357/stat : 19357 (p2cudf-full-1.1) S 19356 19357 1750 0 -1 4202496 457 292 0 0 0 0 0 0 20 0 1 0 119872059 9388032 331 18446744073709551615 4194304 5129932 140736505219072 140736505217216 139650191762526 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/19357/statm: 2292 331 280 229 0 52 0
[pid=19360] ppid=19357 vsize=1041136 CPUtime=50.24
/proc/19360/stat : 19360 (java) S 19357 19357 1750 0 -1 4202496 133066 0 5 0 4962 62 0 0 20 0 11 0 119872060 1066123264 125604 18446744073709551615 4194304 4228012 140735053991408 140735053982432 139801921109621 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/19360/statm: 260284 125604 2393 9 0 247634 0
[pid=19360/tid=19361] ppid=19357 vsize=1041136 CPUtime=42.14
/proc/19360/task/19361/stat : 19361 (java) R 19357 19357 1750 0 -1 4202560 47811 0 0 0 4189 25 0 0 20 0 11 0 119872061 1066123264 125604 18446744073709551615 4194304 4228012 140735053991408 139801927643112 139801826544096 0 4 0 16800975 0 0 0 -1 0 0 0 2 0 0
[pid=19360/tid=19362] ppid=19357 vsize=1041136 CPUtime=3.11
/proc/19360/task/19362/stat : 19362 (java) S 19357 19357 1750 0 -1 4202560 63954 0 5 0 287 24 0 0 20 0 11 0 119872063 1066123264 125604 18446744073709551615 4194304 4228012 140735053991408 139801820281984 139801921123915 0 0 0 16800975 0 0 0 -1 0 0 0 5 0 0
[pid=19360/tid=19363] ppid=19357 vsize=1041136 CPUtime=0
/proc/19360/task/19363/stat : 19363 (java) S 19357 19357 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 119872064 1066123264 125604 18446744073709551615 4194304 4228012 140735053991408 139801819228176 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19364] ppid=19357 vsize=1041136 CPUtime=0
/proc/19360/task/19364/stat : 19364 (java) S 19357 19357 1750 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 119872064 1066123264 125604 18446744073709551615 4194304 4228012 140735053991408 139801818175392 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19365] ppid=19357 vsize=1041136 CPUtime=0
/proc/19360/task/19365/stat : 19365 (java) S 19357 19357 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 119872068 1066123264 125604 18446744073709551615 4194304 4228012 140735053991408 139801817123824 139801921131552 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19366] ppid=19357 vsize=1041136 CPUtime=2.44
/proc/19360/task/19366/stat : 19366 (java) S 19357 19357 1750 0 -1 4202560 9024 0 0 0 240 4 0 0 20 0 11 0 119872068 1066123264 125604 18446744073709551615 4194304 4228012 140735053991408 139801816071184 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19367] ppid=19357 vsize=1041136 CPUtime=2.47
/proc/19360/task/19367/stat : 19367 (java) S 19357 19357 1750 0 -1 4202560 10977 0 0 0 241 6 0 0 20 0 11 0 119872068 1066123264 125604 18446744073709551615 4194304 4228012 140735053991408 139801815018512 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19368] ppid=19357 vsize=1041136 CPUtime=0
/proc/19360/task/19368/stat : 19368 (java) S 19357 19357 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 119872068 1066123264 125604 18446744073709551615 4194304 4228012 140735053991408 139801813966032 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19369] ppid=19357 vsize=1041136 CPUtime=0.02
/proc/19360/task/19369/stat : 19369 (java) S 19357 19357 1750 0 -1 4202560 3 0 0 0 0 2 0 0 20 0 11 0 119872068 1066123264 125604 18446744073709551615 4194304 4228012 140735053991408 139801812913536 139801921123915 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19370] ppid=19357 vsize=1041136 CPUtime=0
/proc/19360/task/19370/stat : 19370 (java) S 19357 19357 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 119873086 1066123264 125604 18446744073709551615 4194304 4228012 140735053991408 139801811715936 139801921123915 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 50.24
Current children cumulated vsize (KiB) 1050304

[startup+102.301 s]
/proc/loadavg: 1.14 1.50 1.36 2/71 19370
/proc/meminfo: memFree=10404/1022884 swapFree=0/0
[pid=19357] ppid=19356 vsize=9168 CPUtime=0
/proc/19357/stat : 19357 (p2cudf-full-1.1) S 19356 19357 1750 0 -1 4202496 457 292 0 0 0 0 0 0 20 0 1 0 119872059 9388032 331 18446744073709551615 4194304 5129932 140736505219072 140736505217216 139650191762526 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/19357/statm: 2292 331 280 229 0 52 0
[pid=19360] ppid=19357 vsize=1041136 CPUtime=100.72
/proc/19360/stat : 19360 (java) S 19357 19357 1750 0 -1 4202496 134804 0 5 0 10009 63 0 0 20 0 11 0 119872060 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 140735053982432 139801921109621 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/19360/statm: 260284 127335 2393 9 0 247634 0
[pid=19360/tid=19361] ppid=19357 vsize=1041136 CPUtime=90.49
/proc/19360/task/19361/stat : 19361 (java) R 19357 19357 1750 0 -1 4202560 47811 0 0 0 9023 26 0 0 20 0 11 0 119872061 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801927634848 139801826560754 0 4 0 16800975 0 0 0 -1 0 0 0 2 0 0
[pid=19360/tid=19362] ppid=19357 vsize=1041136 CPUtime=4.9
/proc/19360/task/19362/stat : 19362 (java) S 19357 19357 1750 0 -1 4202560 65686 0 5 0 465 25 0 0 20 0 11 0 119872063 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801820281984 139801921123915 0 0 0 16800975 0 0 0 -1 0 0 0 5 0 0
[pid=19360/tid=19363] ppid=19357 vsize=1041136 CPUtime=0
/proc/19360/task/19363/stat : 19363 (java) S 19357 19357 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 119872064 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801819228176 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19364] ppid=19357 vsize=1041136 CPUtime=0
/proc/19360/task/19364/stat : 19364 (java) S 19357 19357 1750 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 119872064 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801818175392 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19365] ppid=19357 vsize=1041136 CPUtime=0
/proc/19360/task/19365/stat : 19365 (java) S 19357 19357 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 119872068 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801817123824 139801921131552 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19366] ppid=19357 vsize=1041136 CPUtime=2.6
/proc/19360/task/19366/stat : 19366 (java) S 19357 19357 1750 0 -1 4202560 9024 0 0 0 256 4 0 0 20 0 11 0 119872068 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801816071184 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19367] ppid=19357 vsize=1041136 CPUtime=2.63
/proc/19360/task/19367/stat : 19367 (java) S 19357 19357 1750 0 -1 4202560 10977 0 0 0 256 7 0 0 20 0 11 0 119872068 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801815018512 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19368] ppid=19357 vsize=1041136 CPUtime=0
/proc/19360/task/19368/stat : 19368 (java) S 19357 19357 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 119872068 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801813966032 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19369] ppid=19357 vsize=1041136 CPUtime=0.05
/proc/19360/task/19369/stat : 19369 (java) S 19357 19357 1750 0 -1 4202560 9 0 0 0 0 5 0 0 20 0 11 0 119872068 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801812913536 139801921123915 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19370] ppid=19357 vsize=1041136 CPUtime=0
/proc/19360/task/19370/stat : 19370 (java) S 19357 19357 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 119873086 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801811715936 139801921123915 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 100.72
Current children cumulated vsize (KiB) 1050304

[startup+162.301 s]
/proc/loadavg: 1.05 1.41 1.33 2/71 19370
/proc/meminfo: memFree=9784/1022884 swapFree=0/0
[pid=19357] ppid=19356 vsize=9168 CPUtime=0
/proc/19357/stat : 19357 (p2cudf-full-1.1) S 19356 19357 1750 0 -1 4202496 457 292 0 0 0 0 0 0 20 0 1 0 119872059 9388032 331 18446744073709551615 4194304 5129932 140736505219072 140736505217216 139650191762526 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/19357/statm: 2292 331 280 229 0 52 0
[pid=19360] ppid=19357 vsize=1041136 CPUtime=159.89
/proc/19360/stat : 19360 (java) S 19357 19357 1750 0 -1 4202496 134809 0 5 0 15926 63 0 0 20 0 11 0 119872060 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 140735053982432 139801921109621 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/19360/statm: 260284 127335 2393 9 0 247634 0
[pid=19360/tid=19361] ppid=19357 vsize=1041136 CPUtime=146.31
/proc/19360/task/19361/stat : 19361 (java) R 19357 19357 1750 0 -1 4202560 47811 0 0 0 14605 26 0 0 20 0 11 0 119872061 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801927643208 139801826560617 0 4 0 16800975 0 0 0 -1 0 0 0 3 0 0
[pid=19360/tid=19362] ppid=19357 vsize=1041136 CPUtime=8.23
/proc/19360/task/19362/stat : 19362 (java) S 19357 19357 1750 0 -1 4202560 65688 0 5 0 798 25 0 0 20 0 11 0 119872063 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801820281984 139801921123915 0 0 0 16800975 0 0 0 -1 0 0 0 5 0 0
[pid=19360/tid=19363] ppid=19357 vsize=1041136 CPUtime=0
/proc/19360/task/19363/stat : 19363 (java) S 19357 19357 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 119872064 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801819228176 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19364] ppid=19357 vsize=1041136 CPUtime=0
/proc/19360/task/19364/stat : 19364 (java) S 19357 19357 1750 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 119872064 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801818175392 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19365] ppid=19357 vsize=1041136 CPUtime=0
/proc/19360/task/19365/stat : 19365 (java) S 19357 19357 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 119872068 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801817123824 139801921131552 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19366] ppid=19357 vsize=1041136 CPUtime=2.6
/proc/19360/task/19366/stat : 19366 (java) S 19357 19357 1750 0 -1 4202560 9024 0 0 0 256 4 0 0 20 0 11 0 119872068 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801816071184 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19367] ppid=19357 vsize=1041136 CPUtime=2.63
/proc/19360/task/19367/stat : 19367 (java) S 19357 19357 1750 0 -1 4202560 10977 0 0 0 256 7 0 0 20 0 11 0 119872068 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801815018512 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19368] ppid=19357 vsize=1041136 CPUtime=0
/proc/19360/task/19368/stat : 19368 (java) S 19357 19357 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 119872068 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801813966032 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19369] ppid=19357 vsize=1041136 CPUtime=0.08
/proc/19360/task/19369/stat : 19369 (java) S 19357 19357 1750 0 -1 4202560 12 0 0 0 0 8 0 0 20 0 11 0 119872068 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801812913536 139801921123915 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19370] ppid=19357 vsize=1041136 CPUtime=0
/proc/19360/task/19370/stat : 19370 (java) S 19357 19357 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 119873086 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801811715936 139801921123915 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 159.89
Current children cumulated vsize (KiB) 1050304

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

[startup+166.401 s]
/proc/loadavg: 1.04 1.40 1.33 2/71 19370
/proc/meminfo: memFree=9784/1022884 swapFree=0/0
[pid=19357] ppid=19356 vsize=9168 CPUtime=0
/proc/19357/stat : 19357 (p2cudf-full-1.1) S 19356 19357 1750 0 -1 4202496 457 292 0 0 0 0 0 0 20 0 1 0 119872059 9388032 331 18446744073709551615 4194304 5129932 140736505219072 140736505217216 139650191762526 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/19357/statm: 2292 331 280 229 0 52 0
[pid=19360] ppid=19357 vsize=1041136 CPUtime=163.93
/proc/19360/stat : 19360 (java) S 19357 19357 1750 0 -1 4202496 134809 0 5 0 16330 63 0 0 20 0 11 0 119872060 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 140735053982432 139801921109621 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/19360/statm: 260284 127335 2393 9 0 247634 0
[pid=19360/tid=19361] ppid=19357 vsize=1041136 CPUtime=150.35
/proc/19360/task/19361/stat : 19361 (java) R 19357 19357 1750 0 -1 4202560 47811 0 0 0 15009 26 0 0 20 0 11 0 119872061 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801927643208 139801826544096 0 4 0 16800975 0 0 0 -1 0 0 0 3 0 0
[pid=19360/tid=19362] ppid=19357 vsize=1041136 CPUtime=8.23
/proc/19360/task/19362/stat : 19362 (java) S 19357 19357 1750 0 -1 4202560 65688 0 5 0 798 25 0 0 20 0 11 0 119872063 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801820281984 139801921123915 0 0 0 16800975 0 0 0 -1 0 0 0 5 0 0
[pid=19360/tid=19363] ppid=19357 vsize=1041136 CPUtime=0
/proc/19360/task/19363/stat : 19363 (java) S 19357 19357 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 119872064 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801819228176 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19364] ppid=19357 vsize=1041136 CPUtime=0
/proc/19360/task/19364/stat : 19364 (java) S 19357 19357 1750 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 119872064 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801818175392 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19365] ppid=19357 vsize=1041136 CPUtime=0
/proc/19360/task/19365/stat : 19365 (java) S 19357 19357 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 119872068 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801817123824 139801921131552 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19366] ppid=19357 vsize=1041136 CPUtime=2.6
/proc/19360/task/19366/stat : 19366 (java) S 19357 19357 1750 0 -1 4202560 9024 0 0 0 256 4 0 0 20 0 11 0 119872068 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801816071184 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19367] ppid=19357 vsize=1041136 CPUtime=2.63
/proc/19360/task/19367/stat : 19367 (java) S 19357 19357 1750 0 -1 4202560 10977 0 0 0 256 7 0 0 20 0 11 0 119872068 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801815018512 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19368] ppid=19357 vsize=1041136 CPUtime=0
/proc/19360/task/19368/stat : 19368 (java) S 19357 19357 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 119872068 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801813966032 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19369] ppid=19357 vsize=1041136 CPUtime=0.09
/proc/19360/task/19369/stat : 19369 (java) S 19357 19357 1750 0 -1 4202560 12 0 0 0 0 9 0 0 20 0 11 0 119872068 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801812913536 139801921123915 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19370] ppid=19357 vsize=1041136 CPUtime=0
/proc/19360/task/19370/stat : 19370 (java) S 19357 19357 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 119873086 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801811715936 139801921123915 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 163.93
Current children cumulated vsize (KiB) 1050304

[startup+169.601 s]
/proc/loadavg: 1.04 1.40 1.33 2/71 19370
/proc/meminfo: memFree=9784/1022884 swapFree=0/0
[pid=19357] ppid=19356 vsize=9168 CPUtime=0
/proc/19357/stat : 19357 (p2cudf-full-1.1) S 19356 19357 1750 0 -1 4202496 457 292 0 0 0 0 0 0 20 0 1 0 119872059 9388032 331 18446744073709551615 4194304 5129932 140736505219072 140736505217216 139650191762526 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/19357/statm: 2292 331 280 229 0 52 0
[pid=19360] ppid=19357 vsize=1041136 CPUtime=167.09
/proc/19360/stat : 19360 (java) S 19357 19357 1750 0 -1 4202496 134809 0 5 0 16646 63 0 0 20 0 11 0 119872060 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 140735053982432 139801921109621 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/19360/statm: 260284 127335 2393 9 0 247634 0
[pid=19360/tid=19361] ppid=19357 vsize=1041136 CPUtime=153.5
/proc/19360/task/19361/stat : 19361 (java) R 19357 19357 1750 0 -1 4202560 47811 0 0 0 15324 26 0 0 20 0 11 0 119872061 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801927643208 139801826575231 0 4 0 16800975 0 0 0 -1 0 0 0 3 0 0
[pid=19360/tid=19362] ppid=19357 vsize=1041136 CPUtime=8.23
/proc/19360/task/19362/stat : 19362 (java) S 19357 19357 1750 0 -1 4202560 65688 0 5 0 798 25 0 0 20 0 11 0 119872063 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801820281984 139801921123915 0 0 0 16800975 0 0 0 -1 0 0 0 5 0 0
[pid=19360/tid=19363] ppid=19357 vsize=1041136 CPUtime=0
/proc/19360/task/19363/stat : 19363 (java) S 19357 19357 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 119872064 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801819228176 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19364] ppid=19357 vsize=1041136 CPUtime=0
/proc/19360/task/19364/stat : 19364 (java) S 19357 19357 1750 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 119872064 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801818175392 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19365] ppid=19357 vsize=1041136 CPUtime=0
/proc/19360/task/19365/stat : 19365 (java) S 19357 19357 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 119872068 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801817123824 139801921131552 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19366] ppid=19357 vsize=1041136 CPUtime=2.6
/proc/19360/task/19366/stat : 19366 (java) S 19357 19357 1750 0 -1 4202560 9024 0 0 0 256 4 0 0 20 0 11 0 119872068 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801816071184 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19367] ppid=19357 vsize=1041136 CPUtime=2.63
/proc/19360/task/19367/stat : 19367 (java) S 19357 19357 1750 0 -1 4202560 10977 0 0 0 256 7 0 0 20 0 11 0 119872068 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801815018512 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19368] ppid=19357 vsize=1041136 CPUtime=0
/proc/19360/task/19368/stat : 19368 (java) S 19357 19357 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 119872068 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801813966032 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19369] ppid=19357 vsize=1041136 CPUtime=0.09
/proc/19360/task/19369/stat : 19369 (java) S 19357 19357 1750 0 -1 4202560 12 0 0 0 0 9 0 0 20 0 11 0 119872068 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801812913536 139801921123915 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19370] ppid=19357 vsize=1041136 CPUtime=0
/proc/19360/task/19370/stat : 19370 (java) S 19357 19357 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 119873086 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801811715936 139801921123915 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 167.09
Current children cumulated vsize (KiB) 1050304

[startup+171.201 s]
/proc/loadavg: 1.04 1.40 1.33 2/71 19370
/proc/meminfo: memFree=9784/1022884 swapFree=0/0
[pid=19357] ppid=19356 vsize=9168 CPUtime=0
/proc/19357/stat : 19357 (p2cudf-full-1.1) S 19356 19357 1750 0 -1 4202496 457 292 0 0 0 0 0 0 20 0 1 0 119872059 9388032 331 18446744073709551615 4194304 5129932 140736505219072 140736505217216 139650191762526 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/19357/statm: 2292 331 280 229 0 52 0
[pid=19360] ppid=19357 vsize=1041136 CPUtime=168.67
/proc/19360/stat : 19360 (java) S 19357 19357 1750 0 -1 4202496 134812 0 5 0 16804 63 0 0 20 0 11 0 119872060 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 140735053982432 139801921109621 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/19360/statm: 260284 127335 2393 9 0 247634 0
[pid=19360/tid=19361] ppid=19357 vsize=1041136 CPUtime=155.08
/proc/19360/task/19361/stat : 19361 (java) R 19357 19357 1750 0 -1 4202560 47811 0 0 0 15482 26 0 0 20 0 11 0 119872061 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801927643208 139801826560704 0 4 0 16800975 0 0 0 -1 0 0 0 3 0 0
[pid=19360/tid=19362] ppid=19357 vsize=1041136 CPUtime=8.23
/proc/19360/task/19362/stat : 19362 (java) S 19357 19357 1750 0 -1 4202560 65688 0 5 0 798 25 0 0 20 0 11 0 119872063 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801820281984 139801921123915 0 0 0 16800975 0 0 0 -1 0 0 0 5 0 0
[pid=19360/tid=19363] ppid=19357 vsize=1041136 CPUtime=0
/proc/19360/task/19363/stat : 19363 (java) S 19357 19357 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 119872064 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801819228176 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19364] ppid=19357 vsize=1041136 CPUtime=0
/proc/19360/task/19364/stat : 19364 (java) S 19357 19357 1750 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 119872064 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801818175392 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19365] ppid=19357 vsize=1041136 CPUtime=0
/proc/19360/task/19365/stat : 19365 (java) S 19357 19357 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 119872068 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801817123824 139801921131552 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19366] ppid=19357 vsize=1041136 CPUtime=2.6
/proc/19360/task/19366/stat : 19366 (java) S 19357 19357 1750 0 -1 4202560 9024 0 0 0 256 4 0 0 20 0 11 0 119872068 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801816071184 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19367] ppid=19357 vsize=1041136 CPUtime=2.63
/proc/19360/task/19367/stat : 19367 (java) S 19357 19357 1750 0 -1 4202560 10977 0 0 0 256 7 0 0 20 0 11 0 119872068 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801815018512 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19368] ppid=19357 vsize=1041136 CPUtime=0
/proc/19360/task/19368/stat : 19368 (java) S 19357 19357 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 119872068 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801813966032 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19369] ppid=19357 vsize=1041136 CPUtime=0.09
/proc/19360/task/19369/stat : 19369 (java) S 19357 19357 1750 0 -1 4202560 15 0 0 0 0 9 0 0 20 0 11 0 119872068 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801812913536 139801921123915 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19370] ppid=19357 vsize=1041136 CPUtime=0
/proc/19360/task/19370/stat : 19370 (java) S 19357 19357 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 119873086 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801811715936 139801921123915 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 168.67
Current children cumulated vsize (KiB) 1050304

[startup+172.001 s]
/proc/loadavg: 1.04 1.40 1.33 2/71 19370
/proc/meminfo: memFree=9784/1022884 swapFree=0/0
[pid=19357] ppid=19356 vsize=9168 CPUtime=0
/proc/19357/stat : 19357 (p2cudf-full-1.1) S 19356 19357 1750 0 -1 4202496 457 292 0 0 0 0 0 0 20 0 1 0 119872059 9388032 331 18446744073709551615 4194304 5129932 140736505219072 140736505217216 139650191762526 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/19357/statm: 2292 331 280 229 0 52 0
[pid=19360] ppid=19357 vsize=1041136 CPUtime=169.46
/proc/19360/stat : 19360 (java) S 19357 19357 1750 0 -1 4202496 134812 0 5 0 16883 63 0 0 20 0 11 0 119872060 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 140735053982432 139801921109621 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/19360/statm: 260284 127335 2393 9 0 247634 0
[pid=19360/tid=19361] ppid=19357 vsize=1041136 CPUtime=155.87
/proc/19360/task/19361/stat : 19361 (java) R 19357 19357 1750 0 -1 4202560 47811 0 0 0 15561 26 0 0 20 0 11 0 119872061 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801927643208 139801826544296 0 4 0 16800975 0 0 0 -1 0 0 0 3 0 0
[pid=19360/tid=19362] ppid=19357 vsize=1041136 CPUtime=8.23
/proc/19360/task/19362/stat : 19362 (java) S 19357 19357 1750 0 -1 4202560 65688 0 5 0 798 25 0 0 20 0 11 0 119872063 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801820281984 139801921123915 0 0 0 16800975 0 0 0 -1 0 0 0 5 0 0
[pid=19360/tid=19363] ppid=19357 vsize=1041136 CPUtime=0
/proc/19360/task/19363/stat : 19363 (java) S 19357 19357 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 119872064 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801819228176 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19364] ppid=19357 vsize=1041136 CPUtime=0
/proc/19360/task/19364/stat : 19364 (java) S 19357 19357 1750 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 119872064 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801818175392 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19365] ppid=19357 vsize=1041136 CPUtime=0
/proc/19360/task/19365/stat : 19365 (java) S 19357 19357 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 119872068 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801817123824 139801921131552 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19366] ppid=19357 vsize=1041136 CPUtime=2.6
/proc/19360/task/19366/stat : 19366 (java) S 19357 19357 1750 0 -1 4202560 9024 0 0 0 256 4 0 0 20 0 11 0 119872068 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801816071184 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19367] ppid=19357 vsize=1041136 CPUtime=2.63
/proc/19360/task/19367/stat : 19367 (java) S 19357 19357 1750 0 -1 4202560 10977 0 0 0 256 7 0 0 20 0 11 0 119872068 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801815018512 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19368] ppid=19357 vsize=1041136 CPUtime=0
/proc/19360/task/19368/stat : 19368 (java) S 19357 19357 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 119872068 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801813966032 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19369] ppid=19357 vsize=1041136 CPUtime=0.09
/proc/19360/task/19369/stat : 19369 (java) S 19357 19357 1750 0 -1 4202560 15 0 0 0 0 9 0 0 20 0 11 0 119872068 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801812913536 139801921123915 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19370] ppid=19357 vsize=1041136 CPUtime=0
/proc/19360/task/19370/stat : 19370 (java) S 19357 19357 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 119873086 1066123264 127335 18446744073709551615 4194304 4228012 140735053991408 139801811715936 139801921123915 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 169.46
Current children cumulated vsize (KiB) 1050304

[startup+172.805 s]
/proc/loadavg: 1.04 1.40 1.33 1/71 19371
/proc/meminfo: memFree=9784/1022884 swapFree=0/0
[pid=19357] ppid=19356 vsize=9168 CPUtime=0
/proc/19357/stat : 19357 (p2cudf-full-1.1) S 19356 19357 1750 0 -1 4202496 457 292 0 0 0 0 0 0 20 0 1 0 119872059 9388032 331 18446744073709551615 4194304 5129932 140736505219072 140736505217216 139650191762526 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/19357/statm: 2292 331 280 229 0 52 0
[pid=19360] ppid=19357 vsize=1042164 CPUtime=169.88
/proc/19360/stat : 19360 (java) S 19357 19357 1750 0 -1 4202496 134827 0 5 0 16925 63 0 0 20 0 11 0 119872060 1067175936 127347 18446744073709551615 4194304 4228012 140735053991408 140735053982432 139801921109621 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/19360/statm: 260541 127347 2393 9 0 247891 0
[pid=19360/tid=19361] ppid=19357 vsize=1042164 CPUtime=156.25
/proc/19360/task/19361/stat : 19361 (java) S 19357 19357 1750 0 -1 4202560 47820 0 0 0 15599 26 0 0 20 0 11 0 119872061 1067175936 127347 18446744073709551615 4194304 4228012 140735053991408 139801927644080 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 3 0 0
[pid=19360/tid=19362] ppid=19357 vsize=1042164 CPUtime=8.23
/proc/19360/task/19362/stat : 19362 (java) S 19357 19357 1750 0 -1 4202560 65688 0 5 0 798 25 0 0 20 0 11 0 119872063 1067175936 127347 18446744073709551615 4194304 4228012 140735053991408 139801820281984 139801921123915 0 0 0 16800975 0 0 0 -1 0 0 0 5 0 0
[pid=19360/tid=19363] ppid=19357 vsize=1042164 CPUtime=0
/proc/19360/task/19363/stat : 19363 (java) S 19357 19357 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 119872064 1067175936 127347 18446744073709551615 4194304 4228012 140735053991408 139801819228176 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19364] ppid=19357 vsize=1042164 CPUtime=0
/proc/19360/task/19364/stat : 19364 (java) S 19357 19357 1750 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 119872064 1067175936 127347 18446744073709551615 4194304 4228012 140735053991408 139801818175392 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19365] ppid=19357 vsize=1042164 CPUtime=0
/proc/19360/task/19365/stat : 19365 (java) S 19357 19357 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 119872068 1067175936 127347 18446744073709551615 4194304 4228012 140735053991408 139801817123824 139801921131552 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19366] ppid=19357 vsize=1042164 CPUtime=2.62
/proc/19360/task/19366/stat : 19366 (java) S 19357 19357 1750 0 -1 4202560 9024 0 0 0 258 4 0 0 20 0 11 0 119872068 1067175936 127347 18446744073709551615 4194304 4228012 140735053991408 139801816071184 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19367] ppid=19357 vsize=1042164 CPUtime=2.66
/proc/19360/task/19367/stat : 19367 (java) S 19357 19357 1750 0 -1 4202560 10977 0 0 0 259 7 0 0 20 0 11 0 119872068 1067175936 127347 18446744073709551615 4194304 4228012 140735053991408 139801815018512 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19368] ppid=19357 vsize=1042164 CPUtime=0
/proc/19360/task/19368/stat : 19368 (java) S 19357 19357 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 119872068 1067175936 127347 18446744073709551615 4194304 4228012 140735053991408 139801813966032 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19369] ppid=19357 vsize=1042164 CPUtime=0.09
/proc/19360/task/19369/stat : 19369 (java) S 19357 19357 1750 0 -1 4202560 15 0 0 0 0 9 0 0 20 0 11 0 119872068 1067175936 127347 18446744073709551615 4194304 4228012 140735053991408 139801812913536 139801921123915 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19371] ppid=19357 vsize=1042164 CPUtime=0
/proc/19360/task/19371/stat : 19371 (java) S 19357 19357 1750 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 119889300 1067175936 127347 18446744073709551615 4194304 4228012 140735053991408 139801810663600 139801921123915 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 169.88
Current children cumulated vsize (KiB) 1051332

[startup+173.001 s]
/proc/loadavg: 1.04 1.40 1.33 1/71 19371
/proc/meminfo: memFree=9784/1022884 swapFree=0/0
[pid=19357] ppid=19356 vsize=9168 CPUtime=0
/proc/19357/stat : 19357 (p2cudf-full-1.1) S 19356 19357 1750 0 -1 4202496 457 292 0 0 0 0 0 0 20 0 1 0 119872059 9388032 331 18446744073709551615 4194304 5129932 140736505219072 140736505217216 139650191762526 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/19357/statm: 2292 331 280 229 0 52 0
[pid=19360] ppid=19357 vsize=1042164 CPUtime=169.97
/proc/19360/stat : 19360 (java) S 19357 19357 1750 0 -1 4202496 134830 0 5 0 16931 66 0 0 20 0 11 0 119872060 1067175936 127350 18446744073709551615 4194304 4228012 140735053991408 140735053982432 139801921109621 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/19360/statm: 260541 127350 2393 9 0 247891 0
[pid=19360/tid=19361] ppid=19357 vsize=1042164 CPUtime=156.25
/proc/19360/task/19361/stat : 19361 (java) S 19357 19357 1750 0 -1 4202560 47820 0 0 0 15599 26 0 0 20 0 11 0 119872061 1067175936 127350 18446744073709551615 4194304 4228012 140735053991408 139801927644080 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 3 0 0
[pid=19360/tid=19362] ppid=19357 vsize=1042164 CPUtime=8.23
/proc/19360/task/19362/stat : 19362 (java) S 19357 19357 1750 0 -1 4202560 65688 0 5 0 798 25 0 0 20 0 11 0 119872063 1067175936 127350 18446744073709551615 4194304 4228012 140735053991408 139801820281984 139801921123915 0 0 0 16800975 0 0 0 -1 0 0 0 5 0 0
[pid=19360/tid=19363] ppid=19357 vsize=1042164 CPUtime=0
/proc/19360/task/19363/stat : 19363 (java) S 19357 19357 1750 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 119872064 1067175936 127350 18446744073709551615 4194304 4228012 140735053991408 139801819228176 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19364] ppid=19357 vsize=1042164 CPUtime=0
/proc/19360/task/19364/stat : 19364 (java) S 19357 19357 1750 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 119872064 1067175936 127350 18446744073709551615 4194304 4228012 140735053991408 139801818175392 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19365] ppid=19357 vsize=1042164 CPUtime=0
/proc/19360/task/19365/stat : 19365 (java) S 19357 19357 1750 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 119872068 1067175936 127350 18446744073709551615 4194304 4228012 140735053991408 139801817123824 139801921131552 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19366] ppid=19357 vsize=1042164 CPUtime=2.62
/proc/19360/task/19366/stat : 19366 (java) S 19357 19357 1750 0 -1 4202560 9024 0 0 0 258 4 0 0 20 0 11 0 119872068 1067175936 127350 18446744073709551615 4194304 4228012 140735053991408 139801816071184 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19367] ppid=19357 vsize=1042164 CPUtime=2.67
/proc/19360/task/19367/stat : 19367 (java) S 19357 19357 1750 0 -1 4202560 10977 0 0 0 260 7 0 0 20 0 11 0 119872068 1067175936 127350 18446744073709551615 4194304 4228012 140735053991408 139801815018512 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19368] ppid=19357 vsize=1042164 CPUtime=0
/proc/19360/task/19368/stat : 19368 (java) S 19357 19357 1750 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 119872068 1067175936 127350 18446744073709551615 4194304 4228012 140735053991408 139801813966032 139801921123028 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19369] ppid=19357 vsize=1042164 CPUtime=0.09
/proc/19360/task/19369/stat : 19369 (java) S 19357 19357 1750 0 -1 4202560 15 0 0 0 0 9 0 0 20 0 11 0 119872068 1067175936 127350 18446744073709551615 4194304 4228012 140735053991408 139801812913536 139801921123915 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=19360/tid=19371] ppid=19357 vsize=1042164 CPUtime=0.06
/proc/19360/task/19371/stat : 19371 (java) R 19357 19357 1750 0 -1 4202560 9 0 0 0 4 2 0 0 20 0 11 0 119889300 1067175936 127350 18446744073709551615 4194304 4228012 140735053991408 139801810654400 139801825155252 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 169.97
Current children cumulated vsize (KiB) 1051332

Child status: 0
Real time (s): 173.097
CPU time (s): 170.079
CPU user time (s): 169.355
CPU system time (s): 0.724045
CPU usage (%): 98.2561
Max. virtual memory (cumulated for all children) (KiB): 1058768

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 169.355
system time used= 0.724045
maximum resident set size= 509436
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 135602
page faults= 5
swaps= 0
block input operations= 42880
block output operations= 408
messages sent= 0
messages received= 0
signals received= 0
voluntary context switches= 4639
involuntary context switches= 25195

runsolver used 0.712044 second user time and 1.20408 second system time

The end