runsolver Copyright (C) 2010 Olivier ROUSSEL

This is runsolver version 3.2.9a (svn: 651)

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

command line: runsolver -s SIGUSR1 -M 1124 -C 150 -d 10 -w /tmp/misc2012/2012-09-02-17:21/basic/p2cudf-basic-1.15/paranoid-size/real/56ae4afa-0b33-11df-8a2b-00163e1d94dc.cudf.log.runsolver /home/competition/p2cudf-basic-1.15/p2cudf-basic-1.15 /home/competition/data/real/56ae4afa-0b33-11df-8a2b-00163e1d94dc.cudf /tmp/misc2012/2012-09-02-17:21/basic/p2cudf-basic-1.15/paranoid-size/real/56ae4afa-0b33-11df-8a2b-00163e1d94dc.cudf.result -count(removed),-sum(solution,installedsize),-count(changed) 

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


[startup+0 s]
/proc/loadavg: 0.97 1.08 1.00 2/60 22287
/proc/meminfo: memFree=560308/1022884 swapFree=0/0
[pid=22287] ppid=22286 vsize=9168 CPUtime=0
/proc/22287/stat : 22287 (p2cudf-basic-1.) S 22286 22287 1733 0 -1 4202496 424 0 0 0 0 0 0 0 20 0 1 0 115477707 9388032 325 18446744073709551615 4194304 5129932 140733759192256 140733759189928 140705059944224 0 0 16781316 65536 0 0 0 17 0 0 0 0 0 0
/proc/22287/statm: 2292 325 275 229 0 52 0

[startup+0.114085 s]
/proc/loadavg: 0.97 1.08 1.00 2/60 22287
/proc/meminfo: memFree=560308/1022884 swapFree=0/0
[pid=22287] ppid=22286 vsize=9172 CPUtime=0
/proc/22287/stat : 22287 (p2cudf-basic-1.) S 22286 22287 1733 0 -1 4202496 459 293 0 0 0 0 0 0 20 0 1 0 115477707 9392128 331 18446744073709551615 4194304 5129932 140733759192256 140733759190400 140705059800158 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/22287/statm: 2293 331 280 229 0 53 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9172

[startup+0.200318 s]
/proc/loadavg: 0.97 1.08 1.00 2/60 22287
/proc/meminfo: memFree=560308/1022884 swapFree=0/0
[pid=22287] ppid=22286 vsize=9172 CPUtime=0
/proc/22287/stat : 22287 (p2cudf-basic-1.) S 22286 22287 1733 0 -1 4202496 459 293 0 0 0 0 0 0 20 0 1 0 115477707 9392128 331 18446744073709551615 4194304 5129932 140733759192256 140733759190400 140705059800158 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/22287/statm: 2293 331 280 229 0 53 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9172

[startup+0.300291 s]
/proc/loadavg: 0.97 1.08 1.00 2/60 22287
/proc/meminfo: memFree=560308/1022884 swapFree=0/0
[pid=22287] ppid=22286 vsize=9172 CPUtime=0
/proc/22287/stat : 22287 (p2cudf-basic-1.) S 22286 22287 1733 0 -1 4202496 459 293 0 0 0 0 0 0 20 0 1 0 115477707 9392128 331 18446744073709551615 4194304 5129932 140733759192256 140733759190400 140705059800158 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/22287/statm: 2293 331 280 229 0 53 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9172

[startup+0.70024 s]
/proc/loadavg: 0.97 1.08 1.00 2/60 22287
/proc/meminfo: memFree=560308/1022884 swapFree=0/0
[pid=22287] ppid=22286 vsize=9172 CPUtime=0
/proc/22287/stat : 22287 (p2cudf-basic-1.) S 22286 22287 1733 0 -1 4202496 459 293 0 0 0 0 0 0 20 0 1 0 115477707 9392128 331 18446744073709551615 4194304 5129932 140733759192256 140733759190400 140705059800158 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/22287/statm: 2293 331 280 229 0 53 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9172

[startup+1.50094 s]
/proc/loadavg: 1.13 1.11 1.01 3/71 22299
/proc/meminfo: memFree=521276/1022884 swapFree=0/0
[pid=22287] ppid=22286 vsize=9172 CPUtime=0
/proc/22287/stat : 22287 (p2cudf-basic-1.) S 22286 22287 1733 0 -1 4202496 459 293 0 0 0 0 0 0 20 0 1 0 115477707 9392128 331 18446744073709551615 4194304 5129932 140733759192256 140733759190400 140705059800158 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/22287/statm: 2293 331 280 229 0 53 0
[pid=22290] ppid=22287 vsize=1040376 CPUtime=1.44
/proc/22290/stat : 22290 (java) S 22287 22287 1733 0 -1 4202496 28270 0 0 0 128 16 0 0 20 0 10 0 115477708 1065345024 25246 18446744073709551615 4194304 4228012 140734413051856 140734413042880 140258816040565 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22290/statm: 260094 25246 2343 9 0 247444 0
[pid=22290/tid=22291] ppid=22287 vsize=1040376 CPUtime=0.68
/proc/22290/task/22291/stat : 22291 (java) R 22287 22287 1733 0 -1 4202560 12046 0 0 0 60 8 0 0 20 0 10 0 115477709 1065345024 25246 18446744073709551615 4194304 4228012 140734413051856 140258822566560 140258720479509 0 4 0 16800975 0 0 0 -1 0 0 0 3 0 0
[pid=22290/tid=22292] ppid=22287 vsize=1040376 CPUtime=0
/proc/22290/task/22292/stat : 22292 (java) S 22287 22287 1733 0 -1 4202560 3 0 0 0 0 0 0 0 20 0 10 0 115477712 1065345024 25246 18446744073709551615 4194304 4228012 140734413051856 140258715212928 140258816054859 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22293] ppid=22287 vsize=1040376 CPUtime=0
/proc/22290/task/22293/stat : 22293 (java) S 22287 22287 1733 0 -1 4202560 15 0 0 0 0 0 0 0 20 0 10 0 115477713 1065345024 25246 18446744073709551615 4194304 4228012 140734413051856 140258714159120 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22294] ppid=22287 vsize=1040376 CPUtime=0
/proc/22290/task/22294/stat : 22294 (java) S 22287 22287 1733 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 10 0 115477713 1065345024 25246 18446744073709551615 4194304 4228012 140734413051856 140258713106336 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22295] ppid=22287 vsize=1040376 CPUtime=0
/proc/22290/task/22295/stat : 22295 (java) S 22287 22287 1733 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 115477716 1065345024 25246 18446744073709551615 4194304 4228012 140734413051856 140258712054768 140258816062496 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22296] ppid=22287 vsize=1040376 CPUtime=0.35
/proc/22290/task/22296/stat : 22296 (java) R 22287 22287 1733 0 -1 4202560 6768 0 0 0 31 4 0 0 20 0 10 0 115477716 1065345024 25246 18446744073709551615 4194304 4228012 140734413051856 140258710986024 140258808618399 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22297] ppid=22287 vsize=1040376 CPUtime=0.37
/proc/22290/task/22297/stat : 22297 (java) R 22287 22287 1733 0 -1 4202560 8168 0 0 0 34 3 0 0 20 0 10 0 115477716 1065345024 25246 18446744073709551615 4194304 4228012 140734413051856 140258709934568 140258802554576 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22298] ppid=22287 vsize=1040376 CPUtime=0
/proc/22290/task/22298/stat : 22298 (java) S 22287 22287 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 115477717 1065345024 25246 18446744073709551615 4194304 4228012 140734413051856 140258708896976 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22299] ppid=22287 vsize=1040376 CPUtime=0
/proc/22290/task/22299/stat : 22299 (java) S 22287 22287 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 115477717 1065345024 25246 18446744073709551615 4194304 4228012 140734413051856 140258707844480 140258816054859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 1.44
Current children cumulated vsize (KiB) 1049548

[startup+3.10082 s]
/proc/loadavg: 1.13 1.11 1.01 4/71 22299
/proc/meminfo: memFree=431376/1022884 swapFree=0/0
[pid=22287] ppid=22286 vsize=9172 CPUtime=0
/proc/22287/stat : 22287 (p2cudf-basic-1.) S 22286 22287 1733 0 -1 4202496 459 293 0 0 0 0 0 0 20 0 1 0 115477707 9392128 331 18446744073709551615 4194304 5129932 140733759192256 140733759190400 140705059800158 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/22287/statm: 2293 331 280 229 0 53 0
[pid=22290] ppid=22287 vsize=1045968 CPUtime=3.02
/proc/22290/stat : 22290 (java) S 22287 22287 1733 0 -1 4202496 77456 0 0 0 264 38 0 0 20 0 10 0 115477708 1071071232 71622 18446744073709551615 4194304 4228012 140734413051856 140734413042880 140258816040565 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22290/statm: 261492 71622 2363 9 0 248842 0
[pid=22290/tid=22291] ppid=22287 vsize=1045968 CPUtime=1.41
/proc/22290/task/22291/stat : 22291 (java) R 22287 22287 1733 0 -1 4202560 47437 0 0 0 117 24 0 0 20 0 10 0 115477709 1071071232 71622 18446744073709551615 4194304 4228012 140734413051856 140258822566592 140258720436576 0 4 0 16800975 0 0 0 -1 0 0 0 3 0 0
[pid=22290/tid=22292] ppid=22287 vsize=1045968 CPUtime=0.18
/proc/22290/task/22292/stat : 22292 (java) S 22287 22287 1733 0 -1 4202560 8255 0 0 0 16 2 0 0 20 0 10 0 115477712 1071071232 71622 18446744073709551615 4194304 4228012 140734413051856 140258715212928 140258816054859 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22293] ppid=22287 vsize=1045968 CPUtime=0
/proc/22290/task/22293/stat : 22293 (java) S 22287 22287 1733 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 10 0 115477713 1071071232 71622 18446744073709551615 4194304 4228012 140734413051856 140258714159120 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22294] ppid=22287 vsize=1045968 CPUtime=0
/proc/22290/task/22294/stat : 22294 (java) S 22287 22287 1733 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 10 0 115477713 1071071232 71622 18446744073709551615 4194304 4228012 140734413051856 140258713106336 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22295] ppid=22287 vsize=1045968 CPUtime=0
/proc/22290/task/22295/stat : 22295 (java) S 22287 22287 1733 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 115477716 1071071232 71622 18446744073709551615 4194304 4228012 140734413051856 140258712054768 140258816062496 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22296] ppid=22287 vsize=1045968 CPUtime=0.67
/proc/22290/task/22296/stat : 22296 (java) S 22287 22287 1733 0 -1 4202560 9345 0 0 0 61 6 0 0 20 0 10 0 115477716 1071071232 71622 18446744073709551615 4194304 4228012 140734413051856 140258711002128 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22297] ppid=22287 vsize=1045968 CPUtime=0.73
/proc/22290/task/22297/stat : 22297 (java) S 22287 22287 1733 0 -1 4202560 11131 0 0 0 69 4 0 0 20 0 10 0 115477716 1071071232 71622 18446744073709551615 4194304 4228012 140734413051856 140258709949456 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22298] ppid=22287 vsize=1045968 CPUtime=0
/proc/22290/task/22298/stat : 22298 (java) S 22287 22287 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 115477717 1071071232 71622 18446744073709551615 4194304 4228012 140734413051856 140258708896976 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22299] ppid=22287 vsize=1045968 CPUtime=0
/proc/22290/task/22299/stat : 22299 (java) S 22287 22287 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 115477717 1071071232 71622 18446744073709551615 4194304 4228012 140734413051856 140258707844480 140258816054859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 3.02
Current children cumulated vsize (KiB) 1055140

[startup+6.30056 s]
/proc/loadavg: 1.13 1.11 1.01 2/71 22299
/proc/meminfo: memFree=108356/1022884 swapFree=0/0
[pid=22287] ppid=22286 vsize=9172 CPUtime=0
/proc/22287/stat : 22287 (p2cudf-basic-1.) S 22286 22287 1733 0 -1 4202496 459 293 0 0 0 0 0 0 20 0 1 0 115477707 9392128 331 18446744073709551615 4194304 5129932 140733759192256 140733759190400 140705059800158 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/22287/statm: 2293 331 280 229 0 53 0
[pid=22290] ppid=22287 vsize=1046996 CPUtime=6.15
/proc/22290/stat : 22290 (java) S 22287 22287 1733 0 -1 4202496 116282 0 0 0 560 55 0 0 20 0 11 0 115477708 1072123904 110048 18446744073709551615 4194304 4228012 140734413051856 140734413042880 140258816040565 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22290/statm: 261749 110048 2375 9 0 249099 0
[pid=22290/tid=22291] ppid=22287 vsize=1046996 CPUtime=3.29
/proc/22290/task/22291/stat : 22291 (java) R 22287 22287 1733 0 -1 4202560 47792 0 0 0 300 29 0 0 20 0 11 0 115477709 1072123904 110048 18446744073709551615 4194304 4228012 140734413051856 140258822574344 140258816055989 0 4 0 16800975 0 0 0 -1 0 0 0 6 0 0
[pid=22290/tid=22292] ppid=22287 vsize=1046996 CPUtime=0.99
/proc/22290/task/22292/stat : 22292 (java) S 22287 22287 1733 0 -1 4202560 46636 0 0 0 85 14 0 0 20 0 11 0 115477712 1072123904 110048 18446744073709551615 4194304 4228012 140734413051856 140258715212928 140258816054859 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22293] ppid=22287 vsize=1046996 CPUtime=0
/proc/22290/task/22293/stat : 22293 (java) S 22287 22287 1733 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 115477713 1072123904 110048 18446744073709551615 4194304 4228012 140734413051856 140258714159120 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22294] ppid=22287 vsize=1046996 CPUtime=0
/proc/22290/task/22294/stat : 22294 (java) S 22287 22287 1733 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 115477713 1072123904 110048 18446744073709551615 4194304 4228012 140734413051856 140258713106336 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22295] ppid=22287 vsize=1046996 CPUtime=0
/proc/22290/task/22295/stat : 22295 (java) S 22287 22287 1733 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 115477716 1072123904 110048 18446744073709551615 4194304 4228012 140734413051856 140258712054768 140258816062496 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22296] ppid=22287 vsize=1046996 CPUtime=0.87
/proc/22290/task/22296/stat : 22296 (java) S 22287 22287 1733 0 -1 4202560 9372 0 0 0 81 6 0 0 20 0 11 0 115477716 1072123904 110048 18446744073709551615 4194304 4228012 140734413051856 140258711001960 140258816064748 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22297] ppid=22287 vsize=1046996 CPUtime=0.96
/proc/22290/task/22297/stat : 22297 (java) R 22287 22287 1733 0 -1 4202560 11188 0 0 0 92 4 0 0 20 0 11 0 115477716 1072123904 110048 18446744073709551615 4194304 4228012 140734413051856 140258709949200 140258803396957 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22298] ppid=22287 vsize=1046996 CPUtime=0
/proc/22290/task/22298/stat : 22298 (java) S 22287 22287 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 115477717 1072123904 110048 18446744073709551615 4194304 4228012 140734413051856 140258708896976 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22299] ppid=22287 vsize=1046996 CPUtime=0
/proc/22290/task/22299/stat : 22299 (java) S 22287 22287 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 115477717 1072123904 110048 18446744073709551615 4194304 4228012 140734413051856 140258707844480 140258816054859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 6.15
Current children cumulated vsize (KiB) 1056168

[startup+12.7006 s]
/proc/loadavg: 1.11 1.11 1.01 2/72 22300
/proc/meminfo: memFree=45356/1022884 swapFree=0/0
[pid=22287] ppid=22286 vsize=9172 CPUtime=0
/proc/22287/stat : 22287 (p2cudf-basic-1.) S 22286 22287 1733 0 -1 4202496 459 293 0 0 0 0 0 0 20 0 1 0 115477707 9392128 331 18446744073709551615 4194304 5129932 140733759192256 140733759190400 140705059800158 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/22287/statm: 2293 331 280 229 0 53 0
[pid=22290] ppid=22287 vsize=1046996 CPUtime=12.48
/proc/22290/stat : 22290 (java) S 22287 22287 1733 0 -1 4202496 131697 0 0 0 1189 59 0 0 20 0 11 0 115477708 1072123904 125463 18446744073709551615 4194304 4228012 140734413051856 140734413042880 140258816040565 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22290/statm: 261749 125463 2390 9 0 249099 0
[pid=22290/tid=22291] ppid=22287 vsize=1046996 CPUtime=5.97
/proc/22290/task/22291/stat : 22291 (java) R 22287 22287 1733 0 -1 4202560 47808 0 0 0 568 29 0 0 20 0 11 0 115477709 1072123904 125463 18446744073709551615 4194304 4228012 140734413051856 140258822574040 140258720992198 0 4 0 16800975 0 0 0 -1 0 0 0 6 0 0
[pid=22290/tid=22292] ppid=22287 vsize=1046996 CPUtime=4.12
/proc/22290/task/22292/stat : 22292 (java) S 22287 22287 1733 0 -1 4202560 61874 0 0 0 394 18 0 0 20 0 11 0 115477712 1072123904 125463 18446744073709551615 4194304 4228012 140734413051856 140258715212928 140258816054859 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22293] ppid=22287 vsize=1046996 CPUtime=0
/proc/22290/task/22293/stat : 22293 (java) S 22287 22287 1733 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 115477713 1072123904 125463 18446744073709551615 4194304 4228012 140734413051856 140258714159120 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22294] ppid=22287 vsize=1046996 CPUtime=0
/proc/22290/task/22294/stat : 22294 (java) S 22287 22287 1733 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 115477713 1072123904 125463 18446744073709551615 4194304 4228012 140734413051856 140258713106336 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22295] ppid=22287 vsize=1046996 CPUtime=0
/proc/22290/task/22295/stat : 22295 (java) S 22287 22287 1733 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 115477716 1072123904 125463 18446744073709551615 4194304 4228012 140734413051856 140258712054768 140258816062496 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22296] ppid=22287 vsize=1046996 CPUtime=1.06
/proc/22290/task/22296/stat : 22296 (java) S 22287 22287 1733 0 -1 4202560 9392 0 0 0 100 6 0 0 20 0 11 0 115477716 1072123904 125463 18446744073709551615 4194304 4228012 140734413051856 140258711002128 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22297] ppid=22287 vsize=1046996 CPUtime=1.29
/proc/22290/task/22297/stat : 22297 (java) S 22287 22287 1733 0 -1 4202560 11329 0 0 0 125 4 0 0 20 0 11 0 115477716 1072123904 125463 18446744073709551615 4194304 4228012 140734413051856 140258709949456 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22298] ppid=22287 vsize=1046996 CPUtime=0
/proc/22290/task/22298/stat : 22298 (java) S 22287 22287 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 115477717 1072123904 125463 18446744073709551615 4194304 4228012 140734413051856 140258708896976 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22299] ppid=22287 vsize=1046996 CPUtime=0
/proc/22290/task/22299/stat : 22299 (java) S 22287 22287 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 115477717 1072123904 125463 18446744073709551615 4194304 4228012 140734413051856 140258707844480 140258816054859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22300] ppid=22287 vsize=1046996 CPUtime=0
/proc/22290/task/22300/stat : 22300 (java) S 22287 22287 1733 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 115478328 1072123904 125463 18446744073709551615 4194304 4228012 140734413051856 140258706638688 140258816054859 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) 1056168

[startup+25.5006 s]
/proc/loadavg: 1.09 1.11 1.01 2/71 22300
/proc/meminfo: memFree=45240/1022884 swapFree=0/0
[pid=22287] ppid=22286 vsize=9172 CPUtime=0
/proc/22287/stat : 22287 (p2cudf-basic-1.) S 22286 22287 1733 0 -1 4202496 459 293 0 0 0 0 0 0 20 0 1 0 115477707 9392128 331 18446744073709551615 4194304 5129932 140733759192256 140733759190400 140705059800158 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/22287/statm: 2293 331 280 229 0 53 0
[pid=22290] ppid=22287 vsize=1038716 CPUtime=25.15
/proc/22290/stat : 22290 (java) S 22287 22287 1733 0 -1 4202496 135840 0 0 0 2454 61 0 0 20 0 11 0 115477708 1063645184 125068 18446744073709551615 4194304 4228012 140734413051856 140734413042880 140258816040565 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22290/statm: 259679 125068 2390 9 0 247029 0
[pid=22290/tid=22291] ppid=22287 vsize=1038716 CPUtime=14.17
/proc/22290/task/22291/stat : 22291 (java) R 22287 22287 1733 0 -1 4202560 47808 0 0 0 1388 29 0 0 20 0 11 0 115477709 1063645184 125068 18446744073709551615 4194304 4228012 140734413051856 140258822574040 140258781180101 0 4 0 16800975 0 0 0 -1 0 0 0 6 0 0
[pid=22290/tid=22292] ppid=22287 vsize=1038716 CPUtime=8.01
/proc/22290/task/22292/stat : 22292 (java) S 22287 22287 1733 0 -1 4202560 65961 0 0 0 781 20 0 0 20 0 11 0 115477712 1063645184 125068 18446744073709551615 4194304 4228012 140734413051856 140258715212928 140258816054859 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22293] ppid=22287 vsize=1038716 CPUtime=0
/proc/22290/task/22293/stat : 22293 (java) S 22287 22287 1733 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 115477713 1063645184 125068 18446744073709551615 4194304 4228012 140734413051856 140258714159120 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22294] ppid=22287 vsize=1038716 CPUtime=0
/proc/22290/task/22294/stat : 22294 (java) S 22287 22287 1733 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 115477713 1063645184 125068 18446744073709551615 4194304 4228012 140734413051856 140258713106336 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22295] ppid=22287 vsize=1038716 CPUtime=0
/proc/22290/task/22295/stat : 22295 (java) S 22287 22287 1733 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 115477716 1063645184 125068 18446744073709551615 4194304 4228012 140734413051856 140258712054768 140258816062496 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22296] ppid=22287 vsize=1038716 CPUtime=1.56
/proc/22290/task/22296/stat : 22296 (java) S 22287 22287 1733 0 -1 4202560 9448 0 0 0 150 6 0 0 20 0 11 0 115477716 1063645184 125068 18446744073709551615 4194304 4228012 140734413051856 140258711002128 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22297] ppid=22287 vsize=1038716 CPUtime=1.36
/proc/22290/task/22297/stat : 22297 (java) S 22287 22287 1733 0 -1 4202560 11329 0 0 0 132 4 0 0 20 0 11 0 115477716 1063645184 125068 18446744073709551615 4194304 4228012 140734413051856 140258709949456 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22298] ppid=22287 vsize=1038716 CPUtime=0
/proc/22290/task/22298/stat : 22298 (java) S 22287 22287 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 115477717 1063645184 125068 18446744073709551615 4194304 4228012 140734413051856 140258708896976 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22299] ppid=22287 vsize=1038716 CPUtime=0
/proc/22290/task/22299/stat : 22299 (java) S 22287 22287 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 115477717 1063645184 125068 18446744073709551615 4194304 4228012 140734413051856 140258707844480 140258816054859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22300] ppid=22287 vsize=1038716 CPUtime=0
/proc/22290/task/22300/stat : 22300 (java) S 22287 22287 1733 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 115478328 1063645184 125068 18446744073709551615 4194304 4228012 140734413051856 140258706638688 140258816054859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 25.15
Current children cumulated vsize (KiB) 1047888

[startup+51.1006 s]
/proc/loadavg: 1.06 1.10 1.01 2/71 22300
/proc/meminfo: memFree=42636/1022884 swapFree=0/0
[pid=22287] ppid=22286 vsize=9172 CPUtime=0
/proc/22287/stat : 22287 (p2cudf-basic-1.) S 22286 22287 1733 0 -1 4202496 459 293 0 0 0 0 0 0 20 0 1 0 115477707 9392128 331 18446744073709551615 4194304 5129932 140733759192256 140733759190400 140705059800158 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/22287/statm: 2293 331 280 229 0 53 0
[pid=22290] ppid=22287 vsize=1038716 CPUtime=50.48
/proc/22290/stat : 22290 (java) S 22287 22287 1733 0 -1 4202496 136538 0 0 0 4986 62 0 0 20 0 11 0 115477708 1063645184 125762 18446744073709551615 4194304 4228012 140734413051856 140734413042880 140258816040565 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22290/statm: 259679 125762 2391 9 0 247029 0
[pid=22290/tid=22291] ppid=22287 vsize=1038716 CPUtime=33.81
/proc/22290/task/22291/stat : 22291 (java) R 22287 22287 1733 0 -1 4202560 47809 0 0 0 3352 29 0 0 20 0 11 0 115477709 1063645184 125762 18446744073709551615 4194304 4228012 140734413051856 140258822574040 140258720381976 0 4 0 16800975 0 0 0 -1 0 0 0 7 0 0
[pid=22290/tid=22292] ppid=22287 vsize=1038716 CPUtime=13.66
/proc/22290/task/22292/stat : 22292 (java) S 22287 22287 1733 0 -1 4202560 66655 0 0 0 1346 20 0 0 20 0 11 0 115477712 1063645184 125762 18446744073709551615 4194304 4228012 140734413051856 140258715212928 140258816054859 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22293] ppid=22287 vsize=1038716 CPUtime=0
/proc/22290/task/22293/stat : 22293 (java) S 22287 22287 1733 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 115477713 1063645184 125762 18446744073709551615 4194304 4228012 140734413051856 140258714159120 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22294] ppid=22287 vsize=1038716 CPUtime=0
/proc/22290/task/22294/stat : 22294 (java) S 22287 22287 1733 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 115477713 1063645184 125762 18446744073709551615 4194304 4228012 140734413051856 140258713106336 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22295] ppid=22287 vsize=1038716 CPUtime=0
/proc/22290/task/22295/stat : 22295 (java) S 22287 22287 1733 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 115477716 1063645184 125762 18446744073709551615 4194304 4228012 140734413051856 140258712054768 140258816062496 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22296] ppid=22287 vsize=1038716 CPUtime=1.56
/proc/22290/task/22296/stat : 22296 (java) S 22287 22287 1733 0 -1 4202560 9448 0 0 0 150 6 0 0 20 0 11 0 115477716 1063645184 125762 18446744073709551615 4194304 4228012 140734413051856 140258711002128 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22297] ppid=22287 vsize=1038716 CPUtime=1.38
/proc/22290/task/22297/stat : 22297 (java) S 22287 22287 1733 0 -1 4202560 11329 0 0 0 134 4 0 0 20 0 11 0 115477716 1063645184 125762 18446744073709551615 4194304 4228012 140734413051856 140258709949456 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22298] ppid=22287 vsize=1038716 CPUtime=0
/proc/22290/task/22298/stat : 22298 (java) S 22287 22287 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 115477717 1063645184 125762 18446744073709551615 4194304 4228012 140734413051856 140258708896976 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22299] ppid=22287 vsize=1038716 CPUtime=0.02
/proc/22290/task/22299/stat : 22299 (java) S 22287 22287 1733 0 -1 4202560 3 0 0 0 0 2 0 0 20 0 11 0 115477717 1063645184 125762 18446744073709551615 4194304 4228012 140734413051856 140258707844480 140258816054859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22300] ppid=22287 vsize=1038716 CPUtime=0
/proc/22290/task/22300/stat : 22300 (java) S 22287 22287 1733 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 115478328 1063645184 125762 18446744073709551615 4194304 4228012 140734413051856 140258706638688 140258816054859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 50.48
Current children cumulated vsize (KiB) 1047888

[startup+102.301 s]
/proc/loadavg: 1.02 1.08 1.00 2/71 22300
/proc/meminfo: memFree=39908/1022884 swapFree=0/0
[pid=22287] ppid=22286 vsize=9172 CPUtime=0
/proc/22287/stat : 22287 (p2cudf-basic-1.) S 22286 22287 1733 0 -1 4202496 459 293 0 0 0 0 0 0 20 0 1 0 115477707 9392128 331 18446744073709551615 4194304 5129932 140733759192256 140733759190400 140705059800158 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/22287/statm: 2293 331 280 229 0 53 0
[pid=22290] ppid=22287 vsize=1038716 CPUtime=101.13
/proc/22290/stat : 22290 (java) S 22287 22287 1733 0 -1 4202496 137155 0 0 0 10051 62 0 0 20 0 11 0 115477708 1063645184 126375 18446744073709551615 4194304 4228012 140734413051856 140734413042880 140258816040565 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22290/statm: 259679 126375 2391 9 0 247029 0
[pid=22290/tid=22291] ppid=22287 vsize=1038716 CPUtime=76.74
/proc/22290/task/22291/stat : 22291 (java) S 22287 22287 1733 0 -1 4202560 47809 0 0 0 7645 29 0 0 20 0 11 0 115477709 1063645184 126375 18446744073709551615 4194304 4228012 140734413051856 140258822573840 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 7 0 0
[pid=22290/tid=22292] ppid=22287 vsize=1038716 CPUtime=21.36
/proc/22290/task/22292/stat : 22292 (java) R 22287 22287 1733 0 -1 4202560 67269 0 0 0 2115 21 0 0 20 0 11 0 115477712 1063645184 126375 18446744073709551615 4194304 4228012 140734413051856 140258715211888 140258801860146 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22293] ppid=22287 vsize=1038716 CPUtime=0
/proc/22290/task/22293/stat : 22293 (java) S 22287 22287 1733 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 115477713 1063645184 126375 18446744073709551615 4194304 4228012 140734413051856 140258714159120 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22294] ppid=22287 vsize=1038716 CPUtime=0
/proc/22290/task/22294/stat : 22294 (java) S 22287 22287 1733 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 115477713 1063645184 126375 18446744073709551615 4194304 4228012 140734413051856 140258713106336 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22295] ppid=22287 vsize=1038716 CPUtime=0
/proc/22290/task/22295/stat : 22295 (java) S 22287 22287 1733 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 115477716 1063645184 126375 18446744073709551615 4194304 4228012 140734413051856 140258712054768 140258816062496 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22296] ppid=22287 vsize=1038716 CPUtime=1.56
/proc/22290/task/22296/stat : 22296 (java) S 22287 22287 1733 0 -1 4202560 9448 0 0 0 150 6 0 0 20 0 11 0 115477716 1063645184 126375 18446744073709551615 4194304 4228012 140734413051856 140258711002128 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22297] ppid=22287 vsize=1038716 CPUtime=1.38
/proc/22290/task/22297/stat : 22297 (java) S 22287 22287 1733 0 -1 4202560 11329 0 0 0 134 4 0 0 20 0 11 0 115477716 1063645184 126375 18446744073709551615 4194304 4228012 140734413051856 140258709949456 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22298] ppid=22287 vsize=1038716 CPUtime=0
/proc/22290/task/22298/stat : 22298 (java) S 22287 22287 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 115477717 1063645184 126375 18446744073709551615 4194304 4228012 140734413051856 140258708896976 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22299] ppid=22287 vsize=1038716 CPUtime=0.04
/proc/22290/task/22299/stat : 22299 (java) S 22287 22287 1733 0 -1 4202560 6 0 0 0 0 4 0 0 20 0 11 0 115477717 1063645184 126375 18446744073709551615 4194304 4228012 140734413051856 140258707844480 140258816054859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22300] ppid=22287 vsize=1038716 CPUtime=0
/proc/22290/task/22300/stat : 22300 (java) S 22287 22287 1733 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 115478328 1063645184 126375 18446744073709551615 4194304 4228012 140734413051856 140258706638688 140258816054859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 101.13
Current children cumulated vsize (KiB) 1047888

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

[startup+102.405 s]
/proc/loadavg: 1.02 1.08 1.00 2/71 22300
/proc/meminfo: memFree=39908/1022884 swapFree=0/0
[pid=22287] ppid=22286 vsize=9172 CPUtime=0
/proc/22287/stat : 22287 (p2cudf-basic-1.) S 22286 22287 1733 0 -1 4202496 459 293 0 0 0 0 0 0 20 0 1 0 115477707 9392128 331 18446744073709551615 4194304 5129932 140733759192256 140733759190400 140705059800158 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/22287/statm: 2293 331 280 229 0 53 0
[pid=22290] ppid=22287 vsize=1038716 CPUtime=101.23
/proc/22290/stat : 22290 (java) S 22287 22287 1733 0 -1 4202496 137155 0 0 0 10061 62 0 0 20 0 11 0 115477708 1063645184 126375 18446744073709551615 4194304 4228012 140734413051856 140734413042880 140258816040565 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22290/statm: 259679 126375 2391 9 0 247029 0
[pid=22290/tid=22291] ppid=22287 vsize=1038716 CPUtime=76.83
/proc/22290/task/22291/stat : 22291 (java) R 22287 22287 1733 0 -1 4202560 47809 0 0 0 7654 29 0 0 20 0 11 0 115477709 1063645184 126375 18446744073709551615 4194304 4228012 140734413051856 140258822574040 140258720931568 0 4 0 16800975 0 0 0 -1 0 0 0 7 0 0
[pid=22290/tid=22292] ppid=22287 vsize=1038716 CPUtime=21.37
/proc/22290/task/22292/stat : 22292 (java) S 22287 22287 1733 0 -1 4202560 67269 0 0 0 2116 21 0 0 20 0 11 0 115477712 1063645184 126375 18446744073709551615 4194304 4228012 140734413051856 140258715212928 140258816054859 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22293] ppid=22287 vsize=1038716 CPUtime=0
/proc/22290/task/22293/stat : 22293 (java) S 22287 22287 1733 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 115477713 1063645184 126375 18446744073709551615 4194304 4228012 140734413051856 140258714159120 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22294] ppid=22287 vsize=1038716 CPUtime=0
/proc/22290/task/22294/stat : 22294 (java) S 22287 22287 1733 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 115477713 1063645184 126375 18446744073709551615 4194304 4228012 140734413051856 140258713106336 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22295] ppid=22287 vsize=1038716 CPUtime=0
/proc/22290/task/22295/stat : 22295 (java) S 22287 22287 1733 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 115477716 1063645184 126375 18446744073709551615 4194304 4228012 140734413051856 140258712054768 140258816062496 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22296] ppid=22287 vsize=1038716 CPUtime=1.56
/proc/22290/task/22296/stat : 22296 (java) S 22287 22287 1733 0 -1 4202560 9448 0 0 0 150 6 0 0 20 0 11 0 115477716 1063645184 126375 18446744073709551615 4194304 4228012 140734413051856 140258711002128 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22297] ppid=22287 vsize=1038716 CPUtime=1.38
/proc/22290/task/22297/stat : 22297 (java) S 22287 22287 1733 0 -1 4202560 11329 0 0 0 134 4 0 0 20 0 11 0 115477716 1063645184 126375 18446744073709551615 4194304 4228012 140734413051856 140258709949456 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22298] ppid=22287 vsize=1038716 CPUtime=0
/proc/22290/task/22298/stat : 22298 (java) S 22287 22287 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 115477717 1063645184 126375 18446744073709551615 4194304 4228012 140734413051856 140258708896976 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22299] ppid=22287 vsize=1038716 CPUtime=0.04
/proc/22290/task/22299/stat : 22299 (java) S 22287 22287 1733 0 -1 4202560 6 0 0 0 0 4 0 0 20 0 11 0 115477717 1063645184 126375 18446744073709551615 4194304 4228012 140734413051856 140258707844480 140258816054859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22300] ppid=22287 vsize=1038716 CPUtime=0
/proc/22290/task/22300/stat : 22300 (java) S 22287 22287 1733 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 115478328 1063645184 126375 18446744073709551615 4194304 4228012 140734413051856 140258706638688 140258816054859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 101.23
Current children cumulated vsize (KiB) 1047888

[startup+128.001 s]
/proc/loadavg: 1.01 1.07 1.00 2/71 22300
/proc/meminfo: memFree=37056/1022884 swapFree=0/0
[pid=22287] ppid=22286 vsize=9172 CPUtime=0
/proc/22287/stat : 22287 (p2cudf-basic-1.) S 22286 22287 1733 0 -1 4202496 459 293 0 0 0 0 0 0 20 0 1 0 115477707 9392128 331 18446744073709551615 4194304 5129932 140733759192256 140733759190400 140705059800158 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/22287/statm: 2293 331 280 229 0 53 0
[pid=22290] ppid=22287 vsize=1038716 CPUtime=126.54
/proc/22290/stat : 22290 (java) S 22287 22287 1733 0 -1 4202496 137875 0 0 0 12592 62 0 0 20 0 11 0 115477708 1063645184 127091 18446744073709551615 4194304 4228012 140734413051856 140734413042880 140258816040565 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22290/statm: 259679 127091 2391 9 0 247029 0
[pid=22290/tid=22291] ppid=22287 vsize=1038716 CPUtime=99.78
/proc/22290/task/22291/stat : 22291 (java) R 22287 22287 1733 0 -1 4202560 47809 0 0 0 9949 29 0 0 20 0 11 0 115477709 1063645184 127091 18446744073709551615 4194304 4228012 140734413051856 140258822574040 140258720381650 0 4 0 16800975 0 0 0 -1 0 0 0 8 0 0
[pid=22290/tid=22292] ppid=22287 vsize=1038716 CPUtime=23.71
/proc/22290/task/22292/stat : 22292 (java) S 22287 22287 1733 0 -1 4202560 67986 0 0 0 2350 21 0 0 20 0 11 0 115477712 1063645184 127091 18446744073709551615 4194304 4228012 140734413051856 140258715212928 140258816054859 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22293] ppid=22287 vsize=1038716 CPUtime=0
/proc/22290/task/22293/stat : 22293 (java) S 22287 22287 1733 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 115477713 1063645184 127091 18446744073709551615 4194304 4228012 140734413051856 140258714159120 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22294] ppid=22287 vsize=1038716 CPUtime=0
/proc/22290/task/22294/stat : 22294 (java) S 22287 22287 1733 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 115477713 1063645184 127091 18446744073709551615 4194304 4228012 140734413051856 140258713106336 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22295] ppid=22287 vsize=1038716 CPUtime=0
/proc/22290/task/22295/stat : 22295 (java) S 22287 22287 1733 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 115477716 1063645184 127091 18446744073709551615 4194304 4228012 140734413051856 140258712054768 140258816062496 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22296] ppid=22287 vsize=1038716 CPUtime=1.56
/proc/22290/task/22296/stat : 22296 (java) S 22287 22287 1733 0 -1 4202560 9448 0 0 0 150 6 0 0 20 0 11 0 115477716 1063645184 127091 18446744073709551615 4194304 4228012 140734413051856 140258711002128 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22297] ppid=22287 vsize=1038716 CPUtime=1.38
/proc/22290/task/22297/stat : 22297 (java) S 22287 22287 1733 0 -1 4202560 11329 0 0 0 134 4 0 0 20 0 11 0 115477716 1063645184 127091 18446744073709551615 4194304 4228012 140734413051856 140258709949456 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22298] ppid=22287 vsize=1038716 CPUtime=0
/proc/22290/task/22298/stat : 22298 (java) S 22287 22287 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 115477717 1063645184 127091 18446744073709551615 4194304 4228012 140734413051856 140258708896976 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22299] ppid=22287 vsize=1038716 CPUtime=0.05
/proc/22290/task/22299/stat : 22299 (java) S 22287 22287 1733 0 -1 4202560 9 0 0 0 0 5 0 0 20 0 11 0 115477717 1063645184 127091 18446744073709551615 4194304 4228012 140734413051856 140258707844480 140258816054859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22300] ppid=22287 vsize=1038716 CPUtime=0
/proc/22290/task/22300/stat : 22300 (java) S 22287 22287 1733 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 115478328 1063645184 127091 18446744073709551615 4194304 4228012 140734413051856 140258706638688 140258816054859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 126.54
Current children cumulated vsize (KiB) 1047888

[startup+134.401 s]
/proc/loadavg: 1.01 1.07 1.00 2/71 22300
/proc/meminfo: memFree=33460/1022884 swapFree=0/0
[pid=22287] ppid=22286 vsize=9172 CPUtime=0
/proc/22287/stat : 22287 (p2cudf-basic-1.) S 22286 22287 1733 0 -1 4202496 459 293 0 0 0 0 0 0 20 0 1 0 115477707 9392128 331 18446744073709551615 4194304 5129932 140733759192256 140733759190400 140705059800158 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/22287/statm: 2293 331 280 229 0 53 0
[pid=22290] ppid=22287 vsize=1038716 CPUtime=132.88
/proc/22290/stat : 22290 (java) S 22287 22287 1733 0 -1 4202496 138744 0 0 0 13226 62 0 0 20 0 11 0 115477708 1063645184 127960 18446744073709551615 4194304 4228012 140734413051856 140734413042880 140258816040565 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22290/statm: 259679 127960 2391 9 0 247029 0
[pid=22290/tid=22291] ppid=22287 vsize=1038716 CPUtime=105.12
/proc/22290/task/22291/stat : 22291 (java) R 22287 22287 1733 0 -1 4202560 47809 0 0 0 10483 29 0 0 20 0 11 0 115477709 1063645184 127960 18446744073709551615 4194304 4228012 140734413051856 140258822574040 140258720957274 0 4 0 16800975 0 0 0 -1 0 0 0 8 0 0
[pid=22290/tid=22292] ppid=22287 vsize=1038716 CPUtime=24.71
/proc/22290/task/22292/stat : 22292 (java) S 22287 22287 1733 0 -1 4202560 68855 0 0 0 2450 21 0 0 20 0 11 0 115477712 1063645184 127960 18446744073709551615 4194304 4228012 140734413051856 140258715212928 140258816054859 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22293] ppid=22287 vsize=1038716 CPUtime=0
/proc/22290/task/22293/stat : 22293 (java) S 22287 22287 1733 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 115477713 1063645184 127960 18446744073709551615 4194304 4228012 140734413051856 140258714159120 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22294] ppid=22287 vsize=1038716 CPUtime=0
/proc/22290/task/22294/stat : 22294 (java) S 22287 22287 1733 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 115477713 1063645184 127960 18446744073709551615 4194304 4228012 140734413051856 140258713106336 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22295] ppid=22287 vsize=1038716 CPUtime=0
/proc/22290/task/22295/stat : 22295 (java) S 22287 22287 1733 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 115477716 1063645184 127960 18446744073709551615 4194304 4228012 140734413051856 140258712054768 140258816062496 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22296] ppid=22287 vsize=1038716 CPUtime=1.56
/proc/22290/task/22296/stat : 22296 (java) S 22287 22287 1733 0 -1 4202560 9448 0 0 0 150 6 0 0 20 0 11 0 115477716 1063645184 127960 18446744073709551615 4194304 4228012 140734413051856 140258711002128 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22297] ppid=22287 vsize=1038716 CPUtime=1.38
/proc/22290/task/22297/stat : 22297 (java) S 22287 22287 1733 0 -1 4202560 11329 0 0 0 134 4 0 0 20 0 11 0 115477716 1063645184 127960 18446744073709551615 4194304 4228012 140734413051856 140258709949456 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22298] ppid=22287 vsize=1038716 CPUtime=0
/proc/22290/task/22298/stat : 22298 (java) S 22287 22287 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 115477717 1063645184 127960 18446744073709551615 4194304 4228012 140734413051856 140258708896976 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22299] ppid=22287 vsize=1038716 CPUtime=0.05
/proc/22290/task/22299/stat : 22299 (java) S 22287 22287 1733 0 -1 4202560 9 0 0 0 0 5 0 0 20 0 11 0 115477717 1063645184 127960 18446744073709551615 4194304 4228012 140734413051856 140258707844480 140258816054859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22300] ppid=22287 vsize=1038716 CPUtime=0
/proc/22290/task/22300/stat : 22300 (java) S 22287 22287 1733 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 115478328 1063645184 127960 18446744073709551615 4194304 4228012 140734413051856 140258706638688 140258816054859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 132.88
Current children cumulated vsize (KiB) 1047888

[startup+140.801 s]
/proc/loadavg: 1.01 1.07 1.00 2/71 22300
/proc/meminfo: memFree=29120/1022884 swapFree=0/0
[pid=22287] ppid=22286 vsize=9172 CPUtime=0
/proc/22287/stat : 22287 (p2cudf-basic-1.) S 22286 22287 1733 0 -1 4202496 459 293 0 0 0 0 0 0 20 0 1 0 115477707 9392128 331 18446744073709551615 4194304 5129932 140733759192256 140733759190400 140705059800158 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/22287/statm: 2293 331 280 229 0 53 0
[pid=22290] ppid=22287 vsize=1038716 CPUtime=139.21
/proc/22290/stat : 22290 (java) S 22287 22287 1733 0 -1 4202496 139846 0 0 0 13859 62 0 0 20 0 11 0 115477708 1063645184 129059 18446744073709551615 4194304 4228012 140734413051856 140734413042880 140258816040565 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22290/statm: 259679 129059 2391 9 0 247029 0
[pid=22290/tid=22291] ppid=22287 vsize=1038716 CPUtime=110.95
/proc/22290/task/22291/stat : 22291 (java) R 22287 22287 1733 0 -1 4202560 47809 0 0 0 11066 29 0 0 20 0 11 0 115477709 1063645184 129059 18446744073709551615 4194304 4228012 140734413051856 140258822574040 140258721074768 0 4 0 16800975 0 0 0 -1 0 0 0 8 0 0
[pid=22290/tid=22292] ppid=22287 vsize=1038716 CPUtime=25.21
/proc/22290/task/22292/stat : 22292 (java) S 22287 22287 1733 0 -1 4202560 69954 0 0 0 2500 21 0 0 20 0 11 0 115477712 1063645184 129059 18446744073709551615 4194304 4228012 140734413051856 140258715212928 140258816054859 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22293] ppid=22287 vsize=1038716 CPUtime=0
/proc/22290/task/22293/stat : 22293 (java) S 22287 22287 1733 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 115477713 1063645184 129059 18446744073709551615 4194304 4228012 140734413051856 140258714159120 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22294] ppid=22287 vsize=1038716 CPUtime=0
/proc/22290/task/22294/stat : 22294 (java) S 22287 22287 1733 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 115477713 1063645184 129059 18446744073709551615 4194304 4228012 140734413051856 140258713106336 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22295] ppid=22287 vsize=1038716 CPUtime=0
/proc/22290/task/22295/stat : 22295 (java) S 22287 22287 1733 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 115477716 1063645184 129059 18446744073709551615 4194304 4228012 140734413051856 140258712054768 140258816062496 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22296] ppid=22287 vsize=1038716 CPUtime=1.56
/proc/22290/task/22296/stat : 22296 (java) S 22287 22287 1733 0 -1 4202560 9448 0 0 0 150 6 0 0 20 0 11 0 115477716 1063645184 129059 18446744073709551615 4194304 4228012 140734413051856 140258711002128 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22297] ppid=22287 vsize=1038716 CPUtime=1.38
/proc/22290/task/22297/stat : 22297 (java) S 22287 22287 1733 0 -1 4202560 11329 0 0 0 134 4 0 0 20 0 11 0 115477716 1063645184 129059 18446744073709551615 4194304 4228012 140734413051856 140258709949456 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22298] ppid=22287 vsize=1038716 CPUtime=0
/proc/22290/task/22298/stat : 22298 (java) S 22287 22287 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 115477717 1063645184 129059 18446744073709551615 4194304 4228012 140734413051856 140258708896976 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22299] ppid=22287 vsize=1038716 CPUtime=0.06
/proc/22290/task/22299/stat : 22299 (java) S 22287 22287 1733 0 -1 4202560 12 0 0 0 0 6 0 0 20 0 11 0 115477717 1063645184 129059 18446744073709551615 4194304 4228012 140734413051856 140258707844480 140258816054859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22300] ppid=22287 vsize=1038716 CPUtime=0
/proc/22290/task/22300/stat : 22300 (java) S 22287 22287 1733 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 115478328 1063645184 129059 18446744073709551615 4194304 4228012 140734413051856 140258706638688 140258816054859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 139.21
Current children cumulated vsize (KiB) 1047888

[startup+144.001 s]
/proc/loadavg: 1.01 1.07 1.00 2/71 22300
/proc/meminfo: memFree=29120/1022884 swapFree=0/0
[pid=22287] ppid=22286 vsize=9172 CPUtime=0
/proc/22287/stat : 22287 (p2cudf-basic-1.) S 22286 22287 1733 0 -1 4202496 459 293 0 0 0 0 0 0 20 0 1 0 115477707 9392128 331 18446744073709551615 4194304 5129932 140733759192256 140733759190400 140705059800158 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/22287/statm: 2293 331 280 229 0 53 0
[pid=22290] ppid=22287 vsize=1038716 CPUtime=142.38
/proc/22290/stat : 22290 (java) S 22287 22287 1733 0 -1 4202496 139847 0 0 0 14176 62 0 0 20 0 11 0 115477708 1063645184 129059 18446744073709551615 4194304 4228012 140734413051856 140734413042880 140258816040565 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22290/statm: 259679 129059 2391 9 0 247029 0
[pid=22290/tid=22291] ppid=22287 vsize=1038716 CPUtime=113.58
/proc/22290/task/22291/stat : 22291 (java) R 22287 22287 1733 0 -1 4202560 47809 0 0 0 11329 29 0 0 20 0 11 0 115477709 1063645184 129059 18446744073709551615 4194304 4228012 140734413051856 140258822574040 140258720957565 0 4 0 16800975 0 0 0 -1 0 0 0 8 0 0
[pid=22290/tid=22292] ppid=22287 vsize=1038716 CPUtime=25.75
/proc/22290/task/22292/stat : 22292 (java) S 22287 22287 1733 0 -1 4202560 69955 0 0 0 2554 21 0 0 20 0 11 0 115477712 1063645184 129059 18446744073709551615 4194304 4228012 140734413051856 140258715212928 140258816054859 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22293] ppid=22287 vsize=1038716 CPUtime=0
/proc/22290/task/22293/stat : 22293 (java) S 22287 22287 1733 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 115477713 1063645184 129059 18446744073709551615 4194304 4228012 140734413051856 140258714159120 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22294] ppid=22287 vsize=1038716 CPUtime=0
/proc/22290/task/22294/stat : 22294 (java) S 22287 22287 1733 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 115477713 1063645184 129059 18446744073709551615 4194304 4228012 140734413051856 140258713106336 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22295] ppid=22287 vsize=1038716 CPUtime=0
/proc/22290/task/22295/stat : 22295 (java) S 22287 22287 1733 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 115477716 1063645184 129059 18446744073709551615 4194304 4228012 140734413051856 140258712054768 140258816062496 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22296] ppid=22287 vsize=1038716 CPUtime=1.56
/proc/22290/task/22296/stat : 22296 (java) S 22287 22287 1733 0 -1 4202560 9448 0 0 0 150 6 0 0 20 0 11 0 115477716 1063645184 129059 18446744073709551615 4194304 4228012 140734413051856 140258711002128 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22297] ppid=22287 vsize=1038716 CPUtime=1.38
/proc/22290/task/22297/stat : 22297 (java) S 22287 22287 1733 0 -1 4202560 11329 0 0 0 134 4 0 0 20 0 11 0 115477716 1063645184 129059 18446744073709551615 4194304 4228012 140734413051856 140258709949456 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22298] ppid=22287 vsize=1038716 CPUtime=0
/proc/22290/task/22298/stat : 22298 (java) S 22287 22287 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 115477717 1063645184 129059 18446744073709551615 4194304 4228012 140734413051856 140258708896976 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22299] ppid=22287 vsize=1038716 CPUtime=0.06
/proc/22290/task/22299/stat : 22299 (java) S 22287 22287 1733 0 -1 4202560 12 0 0 0 0 6 0 0 20 0 11 0 115477717 1063645184 129059 18446744073709551615 4194304 4228012 140734413051856 140258707844480 140258816054859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22300] ppid=22287 vsize=1038716 CPUtime=0
/proc/22290/task/22300/stat : 22300 (java) S 22287 22287 1733 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 115478328 1063645184 129059 18446744073709551615 4194304 4228012 140734413051856 140258706638688 140258816054859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 142.38
Current children cumulated vsize (KiB) 1047888

[startup+145.601 s]
/proc/loadavg: 1.01 1.07 1.00 2/71 22300
/proc/meminfo: memFree=29120/1022884 swapFree=0/0
[pid=22287] ppid=22286 vsize=9172 CPUtime=0
/proc/22287/stat : 22287 (p2cudf-basic-1.) S 22286 22287 1733 0 -1 4202496 459 293 0 0 0 0 0 0 20 0 1 0 115477707 9392128 331 18446744073709551615 4194304 5129932 140733759192256 140733759190400 140705059800158 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/22287/statm: 2293 331 280 229 0 53 0
[pid=22290] ppid=22287 vsize=1038716 CPUtime=143.96
/proc/22290/stat : 22290 (java) S 22287 22287 1733 0 -1 4202496 139847 0 0 0 14334 62 0 0 20 0 11 0 115477708 1063645184 129059 18446744073709551615 4194304 4228012 140734413051856 140734413042880 140258816040565 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22290/statm: 259679 129059 2391 9 0 247029 0
[pid=22290/tid=22291] ppid=22287 vsize=1038716 CPUtime=115.16
/proc/22290/task/22291/stat : 22291 (java) R 22287 22287 1733 0 -1 4202560 47809 0 0 0 11487 29 0 0 20 0 11 0 115477709 1063645184 129059 18446744073709551615 4194304 4228012 140734413051856 140258822574040 140258721075010 0 4 0 16800975 0 0 0 -1 0 0 0 8 0 0
[pid=22290/tid=22292] ppid=22287 vsize=1038716 CPUtime=25.75
/proc/22290/task/22292/stat : 22292 (java) S 22287 22287 1733 0 -1 4202560 69955 0 0 0 2554 21 0 0 20 0 11 0 115477712 1063645184 129059 18446744073709551615 4194304 4228012 140734413051856 140258715212928 140258816054859 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22293] ppid=22287 vsize=1038716 CPUtime=0
/proc/22290/task/22293/stat : 22293 (java) S 22287 22287 1733 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 115477713 1063645184 129059 18446744073709551615 4194304 4228012 140734413051856 140258714159120 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22294] ppid=22287 vsize=1038716 CPUtime=0
/proc/22290/task/22294/stat : 22294 (java) S 22287 22287 1733 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 115477713 1063645184 129059 18446744073709551615 4194304 4228012 140734413051856 140258713106336 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22295] ppid=22287 vsize=1038716 CPUtime=0
/proc/22290/task/22295/stat : 22295 (java) S 22287 22287 1733 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 115477716 1063645184 129059 18446744073709551615 4194304 4228012 140734413051856 140258712054768 140258816062496 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22296] ppid=22287 vsize=1038716 CPUtime=1.56
/proc/22290/task/22296/stat : 22296 (java) S 22287 22287 1733 0 -1 4202560 9448 0 0 0 150 6 0 0 20 0 11 0 115477716 1063645184 129059 18446744073709551615 4194304 4228012 140734413051856 140258711002128 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22297] ppid=22287 vsize=1038716 CPUtime=1.38
/proc/22290/task/22297/stat : 22297 (java) S 22287 22287 1733 0 -1 4202560 11329 0 0 0 134 4 0 0 20 0 11 0 115477716 1063645184 129059 18446744073709551615 4194304 4228012 140734413051856 140258709949456 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22298] ppid=22287 vsize=1038716 CPUtime=0
/proc/22290/task/22298/stat : 22298 (java) S 22287 22287 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 115477717 1063645184 129059 18446744073709551615 4194304 4228012 140734413051856 140258708896976 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22299] ppid=22287 vsize=1038716 CPUtime=0.06
/proc/22290/task/22299/stat : 22299 (java) S 22287 22287 1733 0 -1 4202560 12 0 0 0 0 6 0 0 20 0 11 0 115477717 1063645184 129059 18446744073709551615 4194304 4228012 140734413051856 140258707844480 140258816054859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22300] ppid=22287 vsize=1038716 CPUtime=0
/proc/22290/task/22300/stat : 22300 (java) S 22287 22287 1733 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 115478328 1063645184 129059 18446744073709551615 4194304 4228012 140734413051856 140258706638688 140258816054859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 143.96
Current children cumulated vsize (KiB) 1047888

[startup+146.404 s]
/proc/loadavg: 1.01 1.06 1.00 1/71 22301
/proc/meminfo: memFree=28988/1022884 swapFree=0/0
[pid=22287] ppid=22286 vsize=9172 CPUtime=0
/proc/22287/stat : 22287 (p2cudf-basic-1.) S 22286 22287 1733 0 -1 4202496 459 293 0 0 0 0 0 0 20 0 1 0 115477707 9392128 331 18446744073709551615 4194304 5129932 140733759192256 140733759190400 140705059800158 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/22287/statm: 2293 331 280 229 0 53 0
[pid=22290] ppid=22287 vsize=1039744 CPUtime=144.6
/proc/22290/stat : 22290 (java) S 22287 22287 1733 0 -1 4202496 139860 0 0 0 14398 62 0 0 20 0 11 0 115477708 1064697856 129070 18446744073709551615 4194304 4228012 140734413051856 140734413042880 140258816040565 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22290/statm: 259936 129070 2391 9 0 247286 0
[pid=22290/tid=22291] ppid=22287 vsize=1039744 CPUtime=115.78
/proc/22290/task/22291/stat : 22291 (java) S 22287 22287 1733 0 -1 4202560 47816 0 0 0 11549 29 0 0 20 0 11 0 115477709 1064697856 129070 18446744073709551615 4194304 4228012 140734413051856 140258822575024 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 8 0 0
[pid=22290/tid=22292] ppid=22287 vsize=1039744 CPUtime=25.75
/proc/22290/task/22292/stat : 22292 (java) S 22287 22287 1733 0 -1 4202560 69955 0 0 0 2554 21 0 0 20 0 11 0 115477712 1064697856 129070 18446744073709551615 4194304 4228012 140734413051856 140258715212928 140258816054859 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22293] ppid=22287 vsize=1039744 CPUtime=0
/proc/22290/task/22293/stat : 22293 (java) S 22287 22287 1733 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 115477713 1064697856 129070 18446744073709551615 4194304 4228012 140734413051856 140258714159120 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22294] ppid=22287 vsize=1039744 CPUtime=0
/proc/22290/task/22294/stat : 22294 (java) S 22287 22287 1733 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 115477713 1064697856 129070 18446744073709551615 4194304 4228012 140734413051856 140258713106336 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22295] ppid=22287 vsize=1039744 CPUtime=0
/proc/22290/task/22295/stat : 22295 (java) S 22287 22287 1733 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 115477716 1064697856 129070 18446744073709551615 4194304 4228012 140734413051856 140258712054768 140258816062496 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22296] ppid=22287 vsize=1039744 CPUtime=1.56
/proc/22290/task/22296/stat : 22296 (java) S 22287 22287 1733 0 -1 4202560 9448 0 0 0 150 6 0 0 20 0 11 0 115477716 1064697856 129070 18446744073709551615 4194304 4228012 140734413051856 140258711002128 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22297] ppid=22287 vsize=1039744 CPUtime=1.4
/proc/22290/task/22297/stat : 22297 (java) S 22287 22287 1733 0 -1 4202560 11329 0 0 0 136 4 0 0 20 0 11 0 115477716 1064697856 129070 18446744073709551615 4194304 4228012 140734413051856 140258709949456 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22298] ppid=22287 vsize=1039744 CPUtime=0
/proc/22290/task/22298/stat : 22298 (java) S 22287 22287 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 115477717 1064697856 129070 18446744073709551615 4194304 4228012 140734413051856 140258708896976 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22299] ppid=22287 vsize=1039744 CPUtime=0.06
/proc/22290/task/22299/stat : 22299 (java) S 22287 22287 1733 0 -1 4202560 12 0 0 0 0 6 0 0 20 0 11 0 115477717 1064697856 129070 18446744073709551615 4194304 4228012 140734413051856 140258707844480 140258816054859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22301] ppid=22287 vsize=1039744 CPUtime=0
/proc/22290/task/22301/stat : 22301 (java) S 22287 22287 1733 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 115492332 1064697856 129070 18446744073709551615 4194304 4228012 140734413051856 140258705586352 140258816054859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 144.6
Current children cumulated vsize (KiB) 1048916

[startup+146.601 s]
/proc/loadavg: 1.01 1.06 1.00 1/71 22301
/proc/meminfo: memFree=28988/1022884 swapFree=0/0
[pid=22287] ppid=22286 vsize=9172 CPUtime=0
/proc/22287/stat : 22287 (p2cudf-basic-1.) S 22286 22287 1733 0 -1 4202496 459 293 0 0 0 0 0 0 20 0 1 0 115477707 9392128 331 18446744073709551615 4194304 5129932 140733759192256 140733759190400 140705059800158 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/22287/statm: 2293 331 280 229 0 53 0
[pid=22290] ppid=22287 vsize=1039744 CPUtime=144.6
/proc/22290/stat : 22290 (java) S 22287 22287 1733 0 -1 4202496 139860 0 0 0 14398 62 0 0 20 0 11 0 115477708 1064697856 129070 18446744073709551615 4194304 4228012 140734413051856 140734413042880 140258816040565 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22290/statm: 259936 129070 2391 9 0 247286 0
[pid=22290/tid=22291] ppid=22287 vsize=1039744 CPUtime=115.78
/proc/22290/task/22291/stat : 22291 (java) S 22287 22287 1733 0 -1 4202560 47816 0 0 0 11549 29 0 0 20 0 11 0 115477709 1064697856 129070 18446744073709551615 4194304 4228012 140734413051856 140258822575024 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 8 0 0
[pid=22290/tid=22292] ppid=22287 vsize=1039744 CPUtime=25.75
/proc/22290/task/22292/stat : 22292 (java) S 22287 22287 1733 0 -1 4202560 69955 0 0 0 2554 21 0 0 20 0 11 0 115477712 1064697856 129070 18446744073709551615 4194304 4228012 140734413051856 140258715212928 140258816054859 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22293] ppid=22287 vsize=1039744 CPUtime=0
/proc/22290/task/22293/stat : 22293 (java) S 22287 22287 1733 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 115477713 1064697856 129070 18446744073709551615 4194304 4228012 140734413051856 140258714159120 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22294] ppid=22287 vsize=1039744 CPUtime=0
/proc/22290/task/22294/stat : 22294 (java) S 22287 22287 1733 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 115477713 1064697856 129070 18446744073709551615 4194304 4228012 140734413051856 140258713106336 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22295] ppid=22287 vsize=1039744 CPUtime=0
/proc/22290/task/22295/stat : 22295 (java) S 22287 22287 1733 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 115477716 1064697856 129070 18446744073709551615 4194304 4228012 140734413051856 140258712054768 140258816062496 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22296] ppid=22287 vsize=1039744 CPUtime=1.56
/proc/22290/task/22296/stat : 22296 (java) S 22287 22287 1733 0 -1 4202560 9448 0 0 0 150 6 0 0 20 0 11 0 115477716 1064697856 129070 18446744073709551615 4194304 4228012 140734413051856 140258711002128 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22297] ppid=22287 vsize=1039744 CPUtime=1.4
/proc/22290/task/22297/stat : 22297 (java) S 22287 22287 1733 0 -1 4202560 11329 0 0 0 136 4 0 0 20 0 11 0 115477716 1064697856 129070 18446744073709551615 4194304 4228012 140734413051856 140258709949456 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22298] ppid=22287 vsize=1039744 CPUtime=0
/proc/22290/task/22298/stat : 22298 (java) S 22287 22287 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 115477717 1064697856 129070 18446744073709551615 4194304 4228012 140734413051856 140258708896976 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22299] ppid=22287 vsize=1039744 CPUtime=0.06
/proc/22290/task/22299/stat : 22299 (java) S 22287 22287 1733 0 -1 4202560 12 0 0 0 0 6 0 0 20 0 11 0 115477717 1064697856 129070 18446744073709551615 4194304 4228012 140734413051856 140258707844480 140258816054859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22301] ppid=22287 vsize=1039744 CPUtime=0
/proc/22290/task/22301/stat : 22301 (java) S 22287 22287 1733 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 115492332 1064697856 129070 18446744073709551615 4194304 4228012 140734413051856 140258705586352 140258816054859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 144.6
Current children cumulated vsize (KiB) 1048916

[startup+146.701 s]
/proc/loadavg: 1.01 1.06 1.00 1/71 22301
/proc/meminfo: memFree=28988/1022884 swapFree=0/0
[pid=22287] ppid=22286 vsize=9172 CPUtime=0
/proc/22287/stat : 22287 (p2cudf-basic-1.) S 22286 22287 1733 0 -1 4202496 459 293 0 0 0 0 0 0 20 0 1 0 115477707 9392128 331 18446744073709551615 4194304 5129932 140733759192256 140733759190400 140705059800158 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0
/proc/22287/statm: 2293 331 280 229 0 53 0
[pid=22290] ppid=22287 vsize=1039744 CPUtime=144.6
/proc/22290/stat : 22290 (java) S 22287 22287 1733 0 -1 4202496 139860 0 0 0 14398 62 0 0 20 0 11 0 115477708 1064697856 129070 18446744073709551615 4194304 4228012 140734413051856 140734413042880 140258816040565 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0
/proc/22290/statm: 259936 129070 2391 9 0 247286 0
[pid=22290/tid=22291] ppid=22287 vsize=1039744 CPUtime=115.78
/proc/22290/task/22291/stat : 22291 (java) S 22287 22287 1733 0 -1 4202560 47816 0 0 0 11549 29 0 0 20 0 11 0 115477709 1064697856 129070 18446744073709551615 4194304 4228012 140734413051856 140258822575024 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 8 0 0
[pid=22290/tid=22292] ppid=22287 vsize=1039744 CPUtime=25.75
/proc/22290/task/22292/stat : 22292 (java) S 22287 22287 1733 0 -1 4202560 69955 0 0 0 2554 21 0 0 20 0 11 0 115477712 1064697856 129070 18446744073709551615 4194304 4228012 140734413051856 140258715212928 140258816054859 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22293] ppid=22287 vsize=1039744 CPUtime=0
/proc/22290/task/22293/stat : 22293 (java) S 22287 22287 1733 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 115477713 1064697856 129070 18446744073709551615 4194304 4228012 140734413051856 140258714159120 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22294] ppid=22287 vsize=1039744 CPUtime=0
/proc/22290/task/22294/stat : 22294 (java) S 22287 22287 1733 0 -1 4202560 8 0 0 0 0 0 0 0 20 0 11 0 115477713 1064697856 129070 18446744073709551615 4194304 4228012 140734413051856 140258713106336 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22295] ppid=22287 vsize=1039744 CPUtime=0
/proc/22290/task/22295/stat : 22295 (java) S 22287 22287 1733 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 115477716 1064697856 129070 18446744073709551615 4194304 4228012 140734413051856 140258712054768 140258816062496 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22296] ppid=22287 vsize=1039744 CPUtime=1.56
/proc/22290/task/22296/stat : 22296 (java) S 22287 22287 1733 0 -1 4202560 9448 0 0 0 150 6 0 0 20 0 11 0 115477716 1064697856 129070 18446744073709551615 4194304 4228012 140734413051856 140258711002128 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22297] ppid=22287 vsize=1039744 CPUtime=1.4
/proc/22290/task/22297/stat : 22297 (java) S 22287 22287 1733 0 -1 4202560 11329 0 0 0 136 4 0 0 20 0 11 0 115477716 1064697856 129070 18446744073709551615 4194304 4228012 140734413051856 140258709949456 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22298] ppid=22287 vsize=1039744 CPUtime=0
/proc/22290/task/22298/stat : 22298 (java) S 22287 22287 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 115477717 1064697856 129070 18446744073709551615 4194304 4228012 140734413051856 140258708896976 140258816053972 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22299] ppid=22287 vsize=1039744 CPUtime=0.06
/proc/22290/task/22299/stat : 22299 (java) S 22287 22287 1733 0 -1 4202560 12 0 0 0 0 6 0 0 20 0 11 0 115477717 1064697856 129070 18446744073709551615 4194304 4228012 140734413051856 140258707844480 140258816054859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=22290/tid=22301] ppid=22287 vsize=1039744 CPUtime=0
/proc/22290/task/22301/stat : 22301 (java) S 22287 22287 1733 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 115492332 1064697856 129070 18446744073709551615 4194304 4228012 140734413051856 140258705586352 140258816054859 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 144.6
Current children cumulated vsize (KiB) 1048916

Child status: 0
Real time (s): 146.799
CPU time (s): 144.673
CPU user time (s): 144.001
CPU system time (s): 0.672042
CPU usage (%): 98.5515
Max. virtual memory (cumulated for all children) (KiB): 1059152

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 144.001
system time used= 0.672042
maximum resident set size= 516312
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 140634
page faults= 0
swaps= 0
block input operations= 44280
block output operations= 256
messages sent= 0
messages received= 0
signals received= 0
voluntary context switches= 4109
involuntary context switches= 21203

runsolver used 0.376023 second user time and 0.868054 second system time

The end