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

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


[startup+0 s]
/proc/loadavg: 1.00 0.97 0.71 2/65 9925
/proc/meminfo: memFree=517468/1022884 swapFree=0/0
[pid=9925] ppid=9924 vsize=3152 CPUtime=0
/proc/9925/stat : 9925 (runsolver) D 9924 9925 1745 0 -1 4202560 74 0 0 0 0 0 0 0 20 0 1 0 117159720 3227648 96 18446744073709551615 134512640 134586868 4287343680 4287341728 4151911472 0 0 16781316 24578 0 0 0 17 0 0 0 0 0 0
/proc/9925/statm: 788 96 64 19 0 73 0

[startup+0.114973 s]
/proc/loadavg: 1.00 0.97 0.71 2/65 9925
/proc/meminfo: memFree=517468/1022884 swapFree=0/0
[pid=9925] ppid=9924 vsize=9168 CPUtime=0
/proc/9925/stat : 9925 (p2cudf-full-1.1) D 9924 9925 1745 0 -1 4202496 437 292 0 0 0 0 0 0 20 0 1 0 117159720 9388032 328 18446744073709551615 4194304 5129932 140735590458016 140735590455944 140449240240245 0 0 16781316 65536 0 0 0 17 0 0 0 10 0 0
/proc/9925/statm: 2292 328 278 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+0.200318 s]
/proc/loadavg: 1.00 0.97 0.71 2/65 9925
/proc/meminfo: memFree=517468/1022884 swapFree=0/0
[pid=9925] ppid=9924 vsize=9168 CPUtime=0
/proc/9925/stat : 9925 (p2cudf-full-1.1) S 9924 9925 1745 0 -1 4202496 454 292 0 0 0 0 0 0 20 0 1 0 117159720 9388032 330 18446744073709551615 4194304 5129932 140735590458016 140735590456160 140449240097886 0 65536 16781316 65538 0 0 0 17 0 0 0 11 0 0
/proc/9925/statm: 2292 330 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+0.300365 s]
/proc/loadavg: 1.00 0.97 0.71 2/65 9925
/proc/meminfo: memFree=517468/1022884 swapFree=0/0
[pid=9925] ppid=9924 vsize=9168 CPUtime=0
/proc/9925/stat : 9925 (p2cudf-full-1.1) S 9924 9925 1745 0 -1 4202496 454 292 0 0 0 0 0 0 20 0 1 0 117159720 9388032 330 18446744073709551615 4194304 5129932 140735590458016 140735590456160 140449240097886 0 65536 16781316 65538 0 0 0 17 0 0 0 11 0 0
/proc/9925/statm: 2292 330 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+0.700343 s]
/proc/loadavg: 1.00 0.97 0.71 2/65 9925
/proc/meminfo: memFree=517468/1022884 swapFree=0/0
[pid=9925] ppid=9924 vsize=9168 CPUtime=0
/proc/9925/stat : 9925 (p2cudf-full-1.1) S 9924 9925 1745 0 -1 4202496 454 292 0 0 0 0 0 0 20 0 1 0 117159720 9388032 330 18446744073709551615 4194304 5129932 140735590458016 140735590456160 140449240097886 0 65536 16781316 65538 0 0 0 17 0 0 0 11 0 0
/proc/9925/statm: 2292 330 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+1.50048 s]
/proc/loadavg: 1.00 0.97 0.71 2/69 9930
/proc/meminfo: memFree=501060/1022884 swapFree=0/0
[pid=9925] ppid=9924 vsize=9168 CPUtime=0
/proc/9925/stat : 9925 (p2cudf-full-1.1) S 9924 9925 1745 0 -1 4202496 454 292 0 0 0 0 0 0 20 0 1 0 117159720 9388032 330 18446744073709551615 4194304 5129932 140735590458016 140735590456160 140449240097886 0 65536 16781316 65538 0 0 0 17 0 0 0 11 0 0
/proc/9925/statm: 2292 330 280 229 0 52 0
[pid=9928] ppid=9925 vsize=949688 CPUtime=0.08
/proc/9928/stat : 9928 (java) S 9925 9925 1745 0 -1 4202496 3642 0 92 0 6 2 0 0 20 0 10 0 117159732 972480512 3402 18446744073709551615 4194304 4228012 140735972068192 140735972059216 140159578840693 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 25 0 0
/proc/9928/statm: 237422 3402 1823 9 0 224797 0
[pid=9928/tid=9929] ppid=9925 vsize=949688 CPUtime=0.06
/proc/9928/task/9929/stat : 9929 (java) D 9925 9925 1745 0 -1 4202560 2368 0 52 0 5 1 0 0 20 0 10 0 117159759 972480512 3402 18446744073709551615 4194304 4228012 140735972068192 140159585373536 140159578866061 0 4 0 16800975 0 0 0 -1 0 0 0 101 0 0
[pid=9928/tid=9930] ppid=9925 vsize=949688 CPUtime=0
/proc/9928/task/9930/stat : 9930 (java) S 9925 9925 1745 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 117159826 972480512 3402 18446744073709551615 4194304 4228012 140735972068192 140159478013056 140159578854987 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 0.08
Current children cumulated vsize (KiB) 958856

[startup+3.10058 s]
/proc/loadavg: 1.00 0.97 0.71 1/76 9937
/proc/meminfo: memFree=494184/1022884 swapFree=0/0
[pid=9925] ppid=9924 vsize=9168 CPUtime=0
/proc/9925/stat : 9925 (p2cudf-full-1.1) S 9924 9925 1745 0 -1 4202496 454 292 0 0 0 0 0 0 20 0 1 0 117159720 9388032 330 18446744073709551615 4194304 5129932 140735590458016 140735590456160 140449240097886 0 65536 16781316 65538 0 0 0 17 0 0 0 11 0 0
/proc/9925/statm: 2292 330 280 229 0 52 0
[pid=9928] ppid=9925 vsize=967124 CPUtime=0.77
/proc/9928/stat : 9928 (java) S 9925 9925 1745 0 -1 4202496 16306 0 109 0 68 9 0 0 20 0 10 0 117159732 990334976 15210 18446744073709551615 4194304 4228012 140735972068192 140735972059216 140159578840693 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 25 0 0
/proc/9928/statm: 241781 15210 2344 9 0 229131 0
[pid=9928/tid=9929] ppid=9925 vsize=967124 CPUtime=0.4
/proc/9928/task/9929/stat : 9929 (java) R 9925 9925 1745 0 -1 4202560 9580 0 59 0 34 6 0 0 20 0 10 0 117159759 990334976 15210 18446744073709551615 4194304 4228012 140735972068192 140159585366688 140159482886509 0 4 0 16800975 0 0 0 -1 0 0 0 195 0 0
[pid=9928/tid=9930] ppid=9925 vsize=967124 CPUtime=0
/proc/9928/task/9930/stat : 9930 (java) S 9925 9925 1745 0 -1 4202560 4 0 0 0 0 0 0 0 20 0 10 0 117159826 990334976 15210 18446744073709551615 4194304 4228012 140735972068192 140159478013056 140159578854987 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9931] ppid=9925 vsize=967124 CPUtime=0
/proc/9928/task/9931/stat : 9931 (java) S 9925 9925 1745 0 -1 4202560 15 0 0 0 0 0 0 0 20 0 10 0 117159834 990334976 15210 18446744073709551615 4194304 4228012 140735972068192 140159476959248 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9932] ppid=9925 vsize=967124 CPUtime=0
/proc/9928/task/9932/stat : 9932 (java) S 9925 9925 1745 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 10 0 117159834 990334976 15210 18446744073709551615 4194304 4228012 140735972068192 140159475906464 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9933] ppid=9925 vsize=967124 CPUtime=0
/proc/9928/task/9933/stat : 9933 (java) S 9925 9925 1745 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 117159865 990334976 15210 18446744073709551615 4194304 4228012 140735972068192 140159474854896 140159578862624 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9934] ppid=9925 vsize=967124 CPUtime=0.16
/proc/9928/task/9934/stat : 9934 (java) R 9925 9925 1745 0 -1 4202560 2829 0 11 0 16 0 0 0 20 0 10 0 117159865 990334976 15210 18446744073709551615 4194304 4228012 140735972068192 140159473788072 140159561680462 0 4 0 16800975 0 0 0 -1 0 0 0 18 0 0
[pid=9928/tid=9935] ppid=9925 vsize=967124 CPUtime=0.17
/proc/9928/task/9935/stat : 9935 (java) R 9925 9925 1745 0 -1 4202560 2644 0 0 0 17 0 0 0 20 0 10 0 117159865 990334976 15210 18446744073709551615 4194304 4228012 140735972068192 140159472735512 140159571418532 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9936] ppid=9925 vsize=967124 CPUtime=0
/proc/9928/task/9936/stat : 9936 (java) S 9925 9925 1745 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 117159865 990334976 15210 18446744073709551615 4194304 4228012 140735972068192 140159471697104 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9937] ppid=9925 vsize=967124 CPUtime=0
/proc/9928/task/9937/stat : 9937 (java) S 9925 9925 1745 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 117159865 990334976 15210 18446744073709551615 4194304 4228012 140735972068192 140159470644608 140159578854987 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 0.77
Current children cumulated vsize (KiB) 976292
heavy processes:

[startup+6.30061 s]
/proc/loadavg: 1.00 0.97 0.71 4/76 9937
/proc/meminfo: memFree=128756/1022884 swapFree=0/0
[pid=9925] ppid=9924 vsize=9168 CPUtime=0
/proc/9925/stat : 9925 (p2cudf-full-1.1) S 9924 9925 1745 0 -1 4202496 454 292 0 0 0 0 0 0 20 0 1 0 117159720 9388032 330 18446744073709551615 4194304 5129932 140735590458016 140735590456160 140449240097886 0 65536 16781316 65538 0 0 0 17 0 0 0 11 0 0
/proc/9925/statm: 2292 330 280 229 0 52 0
[pid=9928] ppid=9925 vsize=1052632 CPUtime=3.85
/proc/9928/stat : 9928 (java) S 9925 9925 1745 0 -1 4202496 107767 0 110 0 346 39 0 0 20 0 10 0 117159732 1077895168 102896 18446744073709551615 4194304 4228012 140735972068192 140735972059216 140159578840693 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 25 0 0
/proc/9928/statm: 263158 102896 2367 9 0 250508 0
[pid=9928/tid=9929] ppid=9925 vsize=1052632 CPUtime=2.06
/proc/9928/task/9929/stat : 9929 (java) S 9925 9925 1745 0 -1 4202560 47358 0 59 0 186 20 0 0 20 0 10 0 117159759 1077895168 102896 18446744073709551615 4194304 4228012 140735972068192 140159585374688 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 202 0 0
[pid=9928/tid=9930] ppid=9925 vsize=1052632 CPUtime=0.89
/proc/9928/task/9930/stat : 9930 (java) R 9925 9925 1745 0 -1 4202560 41693 0 1 0 77 12 0 0 20 0 10 0 117159826 1077895168 102896 18446744073709551615 4194304 4228012 140735972068192 140159478012432 140159562964265 0 0 0 16800975 0 0 0 -1 0 0 0 1 0 0
[pid=9928/tid=9931] ppid=9925 vsize=1052632 CPUtime=0
/proc/9928/task/9931/stat : 9931 (java) S 9925 9925 1745 0 -1 4202560 15 0 0 0 0 0 0 0 20 0 10 0 117159834 1077895168 102896 18446744073709551615 4194304 4228012 140735972068192 140159476959248 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9932] ppid=9925 vsize=1052632 CPUtime=0
/proc/9928/task/9932/stat : 9932 (java) S 9925 9925 1745 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 10 0 117159834 1077895168 102896 18446744073709551615 4194304 4228012 140735972068192 140159475906464 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 1 0 0
[pid=9928/tid=9933] ppid=9925 vsize=1052632 CPUtime=0
/proc/9928/task/9933/stat : 9933 (java) S 9925 9925 1745 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 117159865 1077895168 102896 18446744073709551615 4194304 4228012 140735972068192 140159474854896 140159578862624 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9934] ppid=9925 vsize=1052632 CPUtime=0.42
/proc/9928/task/9934/stat : 9934 (java) S 9925 9925 1745 0 -1 4202560 10571 0 11 0 38 4 0 0 20 0 10 0 117159865 1077895168 102896 18446744073709551615 4194304 4228012 140735972068192 140159473802256 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 18 0 0
[pid=9928/tid=9935] ppid=9925 vsize=1052632 CPUtime=0.45
/proc/9928/task/9935/stat : 9935 (java) S 9925 9925 1745 0 -1 4202560 6892 0 0 0 44 1 0 0 20 0 10 0 117159865 1077895168 102896 18446744073709551615 4194304 4228012 140735972068192 140159472749584 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9936] ppid=9925 vsize=1052632 CPUtime=0
/proc/9928/task/9936/stat : 9936 (java) S 9925 9925 1745 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 117159865 1077895168 102896 18446744073709551615 4194304 4228012 140735972068192 140159471697104 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9937] ppid=9925 vsize=1052632 CPUtime=0
/proc/9928/task/9937/stat : 9937 (java) S 9925 9925 1745 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 117159865 1077895168 102896 18446744073709551615 4194304 4228012 140735972068192 140159470644608 140159578854987 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 3.85
Current children cumulated vsize (KiB) 1061800
heavy processes:

[startup+12.7006 s]
/proc/loadavg: 1.00 0.97 0.72 4/76 9937
/proc/meminfo: memFree=9684/1022884 swapFree=0/0
[pid=9925] ppid=9924 vsize=9168 CPUtime=0
/proc/9925/stat : 9925 (p2cudf-full-1.1) S 9924 9925 1745 0 -1 4202496 454 292 0 0 0 0 0 0 20 0 1 0 117159720 9388032 330 18446744073709551615 4194304 5129932 140735590458016 140735590456160 140449240097886 0 65536 16781316 65538 0 0 0 17 0 0 0 11 0 0
/proc/9925/statm: 2292 330 280 229 0 52 0
[pid=9928] ppid=9925 vsize=1033600 CPUtime=9.75
/proc/9928/stat : 9928 (java) S 9925 9925 1745 0 -1 4202496 159846 0 111 0 917 58 0 0 20 0 10 0 117159732 1058406400 145693 18446744073709551615 4194304 4228012 140735972068192 140735972059216 140159578840693 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 25 0 0
/proc/9928/statm: 258400 145693 2375 9 0 245750 0
[pid=9928/tid=9929] ppid=9925 vsize=1033600 CPUtime=4.6
/proc/9928/task/9929/stat : 9929 (java) R 9925 9925 1745 0 -1 4202560 47664 0 60 0 438 22 0 0 20 0 10 0 117159759 1058406400 145693 18446744073709551615 4194304 4228012 140735972068192 140159585373080 140159483734789 0 4 0 16800975 0 0 0 -1 0 0 0 230 0 0
[pid=9928/tid=9930] ppid=9925 vsize=1033600 CPUtime=1.71
/proc/9928/task/9930/stat : 9930 (java) S 9925 9925 1745 0 -1 4202560 81360 0 1 0 147 24 0 0 20 0 10 0 117159826 1058406400 145693 18446744073709551615 4194304 4228012 140735972068192 140159478013056 140159578854987 0 0 0 16800975 0 0 0 -1 0 0 0 1 0 0
[pid=9928/tid=9931] ppid=9925 vsize=1033600 CPUtime=0
/proc/9928/task/9931/stat : 9931 (java) S 9925 9925 1745 0 -1 4202560 15 0 0 0 0 0 0 0 20 0 10 0 117159834 1058406400 145693 18446744073709551615 4194304 4228012 140735972068192 140159476959248 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9932] ppid=9925 vsize=1033600 CPUtime=0
/proc/9928/task/9932/stat : 9932 (java) S 9925 9925 1745 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 10 0 117159834 1058406400 145693 18446744073709551615 4194304 4228012 140735972068192 140159475906464 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 1 0 0
[pid=9928/tid=9933] ppid=9925 vsize=1033600 CPUtime=0
/proc/9928/task/9933/stat : 9933 (java) S 9925 9925 1745 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 117159865 1058406400 145693 18446744073709551615 4194304 4228012 140735972068192 140159474854896 140159578862624 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9934] ppid=9925 vsize=1033600 CPUtime=1.69
/proc/9928/task/9934/stat : 9934 (java) R 9925 9925 1745 0 -1 4202560 18329 0 11 0 162 7 0 0 20 0 10 0 117159865 1058406400 145693 18446744073709551615 4194304 4228012 140735972068192 140159473788472 140159560748728 0 4 0 16800975 0 0 0 -1 0 0 0 18 0 0
[pid=9928/tid=9935] ppid=9925 vsize=1033600 CPUtime=1.7
/proc/9928/task/9935/stat : 9935 (java) R 9925 9925 1745 0 -1 4202560 11240 0 0 0 168 2 0 0 20 0 10 0 117159865 1058406400 145693 18446744073709551615 4194304 4228012 140735972068192 140159472749328 140159566179291 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9936] ppid=9925 vsize=1033600 CPUtime=0
/proc/9928/task/9936/stat : 9936 (java) S 9925 9925 1745 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 117159865 1058406400 145693 18446744073709551615 4194304 4228012 140735972068192 140159471697104 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9937] ppid=9925 vsize=1033600 CPUtime=0
/proc/9928/task/9937/stat : 9937 (java) S 9925 9925 1745 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 117159865 1058406400 145693 18446744073709551615 4194304 4228012 140735972068192 140159470644608 140159578854987 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 9.75
Current children cumulated vsize (KiB) 1042768
heavy processes:

[startup+25.5097 s]
/proc/loadavg: 1.13 1.00 0.73 2/77 9938
/proc/meminfo: memFree=9596/1022884 swapFree=0/0
[pid=9925] ppid=9924 vsize=9168 CPUtime=0
/proc/9925/stat : 9925 (p2cudf-full-1.1) S 9924 9925 1745 0 -1 4202496 454 292 0 0 0 0 0 0 20 0 1 0 117159720 9388032 330 18446744073709551615 4194304 5129932 140735590458016 140735590456160 140449240097886 0 65536 16781316 65538 0 0 0 17 0 0 0 11 0 0
/proc/9925/statm: 2292 330 280 229 0 52 0
[pid=9928] ppid=9925 vsize=1034628 CPUtime=22.08
/proc/9928/stat : 9928 (java) S 9925 9925 1745 0 -1 4202496 178780 0 119 0 2144 64 0 0 20 0 11 0 117159732 1059459072 164030 18446744073709551615 4194304 4228012 140735972068192 140735972059216 140159578840693 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 25 0 0
/proc/9928/statm: 258657 164030 2392 9 0 246007 0
[pid=9928/tid=9929] ppid=9925 vsize=1034628 CPUtime=13.85
/proc/9928/task/9929/stat : 9929 (java) R 9925 9925 1745 0 -1 4202560 47749 0 60 0 1363 22 0 0 20 0 11 0 117159759 1059459072 164030 18446744073709551615 4194304 4228012 140735972068192 140159585374392 140159483196876 0 4 0 16800975 0 0 0 -1 0 0 0 245 0 0
[pid=9928/tid=9930] ppid=9925 vsize=1034628 CPUtime=3.3
/proc/9928/task/9930/stat : 9930 (java) S 9925 9925 1745 0 -1 4202560 100103 0 7 0 300 30 0 0 20 0 11 0 117159826 1059459072 164030 18446744073709551615 4194304 4228012 140735972068192 140159478013056 140159578854987 0 0 0 16800975 0 0 0 -1 0 0 0 11 0 0
[pid=9928/tid=9931] ppid=9925 vsize=1034628 CPUtime=0
/proc/9928/task/9931/stat : 9931 (java) S 9925 9925 1745 0 -1 4202560 15 0 0 0 0 0 0 0 20 0 11 0 117159834 1059459072 164030 18446744073709551615 4194304 4228012 140735972068192 140159476959248 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9932] ppid=9925 vsize=1034628 CPUtime=0
/proc/9928/task/9932/stat : 9932 (java) S 9925 9925 1745 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 117159834 1059459072 164030 18446744073709551615 4194304 4228012 140735972068192 140159475906464 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 1 0 0
[pid=9928/tid=9933] ppid=9925 vsize=1034628 CPUtime=0
/proc/9928/task/9933/stat : 9933 (java) S 9925 9925 1745 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 117159865 1059459072 164030 18446744073709551615 4194304 4228012 140735972068192 140159474854896 140159578862624 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9934] ppid=9925 vsize=1034628 CPUtime=2.48
/proc/9928/task/9934/stat : 9934 (java) S 9925 9925 1745 0 -1 4202560 18394 0 11 0 241 7 0 0 20 0 11 0 117159865 1059459072 164030 18446744073709551615 4194304 4228012 140735972068192 140159473802256 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 24 0 0
[pid=9928/tid=9935] ppid=9925 vsize=1034628 CPUtime=2.39
/proc/9928/task/9935/stat : 9935 (java) S 9925 9925 1745 0 -1 4202560 11268 0 2 0 237 2 0 0 20 0 11 0 117159865 1059459072 164030 18446744073709551615 4194304 4228012 140735972068192 140159472749584 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 7 0 0
[pid=9928/tid=9936] ppid=9925 vsize=1034628 CPUtime=0
/proc/9928/task/9936/stat : 9936 (java) S 9925 9925 1745 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 117159865 1059459072 164030 18446744073709551615 4194304 4228012 140735972068192 140159471697104 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9937] ppid=9925 vsize=1034628 CPUtime=0.01
/proc/9928/task/9937/stat : 9937 (java) S 9925 9925 1745 0 -1 4202560 8 0 0 0 0 1 0 0 20 0 11 0 117159865 1059459072 164030 18446744073709551615 4194304 4228012 140735972068192 140159470644608 140159578854987 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9938] ppid=9925 vsize=1034628 CPUtime=0
/proc/9928/task/9938/stat : 9938 (java) S 9925 9925 1745 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 117161151 1059459072 164030 18446744073709551615 4194304 4228012 140735972068192 140159469451104 140159578854987 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 22.08
Current children cumulated vsize (KiB) 1043796

[startup+51.1008 s]
/proc/loadavg: 1.09 1.00 0.73 2/77 9938
/proc/meminfo: memFree=9736/1022884 swapFree=0/0
[pid=9925] ppid=9924 vsize=9168 CPUtime=0
/proc/9925/stat : 9925 (p2cudf-full-1.1) S 9924 9925 1745 0 -1 4202496 454 292 0 0 0 0 0 0 20 0 1 0 117159720 9388032 330 18446744073709551615 4194304 5129932 140735590458016 140735590456160 140449240097886 0 65536 16781316 65538 0 0 0 17 0 0 0 11 0 0
/proc/9925/statm: 2292 330 280 229 0 52 0
[pid=9928] ppid=9925 vsize=1034628 CPUtime=47.28
/proc/9928/stat : 9928 (java) S 9925 9925 1745 0 -1 4202496 185764 0 119 0 4662 66 0 0 20 0 11 0 117159732 1059459072 171011 18446744073709551615 4194304 4228012 140735972068192 140735972059216 140159578840693 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 25 0 0
/proc/9928/statm: 258657 171011 2392 9 0 246007 0
[pid=9928/tid=9929] ppid=9925 vsize=1034628 CPUtime=34.59
/proc/9928/task/9929/stat : 9929 (java) R 9925 9925 1745 0 -1 4202560 47750 0 60 0 3437 22 0 0 20 0 11 0 117159759 1059459072 171011 18446744073709551615 4194304 4228012 140735972068192 140159585374184 140159483977663 0 4 0 16800975 0 0 0 -1 0 0 0 245 0 0
[pid=9928/tid=9930] ppid=9925 vsize=1034628 CPUtime=7.53
/proc/9928/task/9930/stat : 9930 (java) S 9925 9925 1745 0 -1 4202560 107079 0 7 0 721 32 0 0 20 0 11 0 117159826 1059459072 171011 18446744073709551615 4194304 4228012 140735972068192 140159478013056 140159578854987 0 0 0 16800975 0 0 0 -1 0 0 0 11 0 0
[pid=9928/tid=9931] ppid=9925 vsize=1034628 CPUtime=0
/proc/9928/task/9931/stat : 9931 (java) S 9925 9925 1745 0 -1 4202560 15 0 0 0 0 0 0 0 20 0 11 0 117159834 1059459072 171011 18446744073709551615 4194304 4228012 140735972068192 140159476959248 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9932] ppid=9925 vsize=1034628 CPUtime=0
/proc/9928/task/9932/stat : 9932 (java) S 9925 9925 1745 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 117159834 1059459072 171011 18446744073709551615 4194304 4228012 140735972068192 140159475906464 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 1 0 0
[pid=9928/tid=9933] ppid=9925 vsize=1034628 CPUtime=0
/proc/9928/task/9933/stat : 9933 (java) S 9925 9925 1745 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 117159865 1059459072 171011 18446744073709551615 4194304 4228012 140735972068192 140159474854896 140159578862624 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9934] ppid=9925 vsize=1034628 CPUtime=2.59
/proc/9928/task/9934/stat : 9934 (java) S 9925 9925 1745 0 -1 4202560 18397 0 11 0 252 7 0 0 20 0 11 0 117159865 1059459072 171011 18446744073709551615 4194304 4228012 140735972068192 140159473802256 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 24 0 0
[pid=9928/tid=9935] ppid=9925 vsize=1034628 CPUtime=2.5
/proc/9928/task/9935/stat : 9935 (java) S 9925 9925 1745 0 -1 4202560 11269 0 2 0 248 2 0 0 20 0 11 0 117159865 1059459072 171011 18446744073709551615 4194304 4228012 140735972068192 140159472749584 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 7 0 0
[pid=9928/tid=9936] ppid=9925 vsize=1034628 CPUtime=0
/proc/9928/task/9936/stat : 9936 (java) S 9925 9925 1745 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 117159865 1059459072 171011 18446744073709551615 4194304 4228012 140735972068192 140159471697104 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9937] ppid=9925 vsize=1034628 CPUtime=0.02
/proc/9928/task/9937/stat : 9937 (java) S 9925 9925 1745 0 -1 4202560 11 0 0 0 0 2 0 0 20 0 11 0 117159865 1059459072 171011 18446744073709551615 4194304 4228012 140735972068192 140159470644608 140159578854987 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9938] ppid=9925 vsize=1034628 CPUtime=0
/proc/9928/task/9938/stat : 9938 (java) S 9925 9925 1745 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 117161151 1059459072 171011 18446744073709551615 4194304 4228012 140735972068192 140159469451104 140159578854987 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 47.28
Current children cumulated vsize (KiB) 1043796

[startup+102.301 s]
/proc/loadavg: 1.10 1.02 0.75 2/77 9938
/proc/meminfo: memFree=10124/1022884 swapFree=0/0
[pid=9925] ppid=9924 vsize=9168 CPUtime=0
/proc/9925/stat : 9925 (p2cudf-full-1.1) S 9924 9925 1745 0 -1 4202496 454 292 0 0 0 0 0 0 20 0 1 0 117159720 9388032 330 18446744073709551615 4194304 5129932 140735590458016 140735590456160 140449240097886 0 65536 16781316 65538 0 0 0 17 0 0 0 11 0 0
/proc/9925/statm: 2292 330 280 229 0 52 0
[pid=9928] ppid=9925 vsize=1034628 CPUtime=97.73
/proc/9928/stat : 9928 (java) S 9925 9925 1745 0 -1 4202496 193162 0 119 0 9705 68 0 0 20 0 11 0 117159732 1059459072 178404 18446744073709551615 4194304 4228012 140735972068192 140735972059216 140159578840693 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 25 0 0
/proc/9928/statm: 258657 178404 2392 9 0 246007 0
[pid=9928/tid=9929] ppid=9925 vsize=1034628 CPUtime=79.82
/proc/9928/task/9929/stat : 9929 (java) R 9925 9925 1745 0 -1 4202560 47750 0 60 0 7960 22 0 0 20 0 11 0 117159759 1059459072 178404 18446744073709551615 4194304 4228012 140735972068192 140159585374184 140159484355533 0 4 0 16800975 0 0 0 -1 0 0 0 245 0 0
[pid=9928/tid=9930] ppid=9925 vsize=1034628 CPUtime=12.72
/proc/9928/task/9930/stat : 9930 (java) S 9925 9925 1745 0 -1 4202560 114474 0 7 0 1238 34 0 0 20 0 11 0 117159826 1059459072 178404 18446744073709551615 4194304 4228012 140735972068192 140159478013056 140159578854987 0 0 0 16800975 0 0 0 -1 0 0 0 11 0 0
[pid=9928/tid=9931] ppid=9925 vsize=1034628 CPUtime=0
/proc/9928/task/9931/stat : 9931 (java) S 9925 9925 1745 0 -1 4202560 15 0 0 0 0 0 0 0 20 0 11 0 117159834 1059459072 178404 18446744073709551615 4194304 4228012 140735972068192 140159476959248 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9932] ppid=9925 vsize=1034628 CPUtime=0
/proc/9928/task/9932/stat : 9932 (java) S 9925 9925 1745 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 117159834 1059459072 178404 18446744073709551615 4194304 4228012 140735972068192 140159475906464 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 1 0 0
[pid=9928/tid=9933] ppid=9925 vsize=1034628 CPUtime=0
/proc/9928/task/9933/stat : 9933 (java) S 9925 9925 1745 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 117159865 1059459072 178404 18446744073709551615 4194304 4228012 140735972068192 140159474854896 140159578862624 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9934] ppid=9925 vsize=1034628 CPUtime=2.59
/proc/9928/task/9934/stat : 9934 (java) S 9925 9925 1745 0 -1 4202560 18397 0 11 0 252 7 0 0 20 0 11 0 117159865 1059459072 178404 18446744073709551615 4194304 4228012 140735972068192 140159473802256 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 24 0 0
[pid=9928/tid=9935] ppid=9925 vsize=1034628 CPUtime=2.5
/proc/9928/task/9935/stat : 9935 (java) S 9925 9925 1745 0 -1 4202560 11269 0 2 0 248 2 0 0 20 0 11 0 117159865 1059459072 178404 18446744073709551615 4194304 4228012 140735972068192 140159472749584 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 7 0 0
[pid=9928/tid=9936] ppid=9925 vsize=1034628 CPUtime=0
/proc/9928/task/9936/stat : 9936 (java) S 9925 9925 1745 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 117159865 1059459072 178404 18446744073709551615 4194304 4228012 140735972068192 140159471697104 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9937] ppid=9925 vsize=1034628 CPUtime=0.06
/proc/9928/task/9937/stat : 9937 (java) S 9925 9925 1745 0 -1 4202560 14 0 0 0 2 4 0 0 20 0 11 0 117159865 1059459072 178404 18446744073709551615 4194304 4228012 140735972068192 140159470644608 140159578854987 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9938] ppid=9925 vsize=1034628 CPUtime=0
/proc/9928/task/9938/stat : 9938 (java) S 9925 9925 1745 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 117161151 1059459072 178404 18446744073709551615 4194304 4228012 140735972068192 140159469451104 140159578854987 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 97.73
Current children cumulated vsize (KiB) 1043796

[startup+162.301 s]
/proc/loadavg: 1.04 1.01 0.76 2/77 9938
/proc/meminfo: memFree=10040/1022884 swapFree=0/0
[pid=9925] ppid=9924 vsize=9168 CPUtime=0
/proc/9925/stat : 9925 (p2cudf-full-1.1) S 9924 9925 1745 0 -1 4202496 454 292 0 0 0 0 0 0 20 0 1 0 117159720 9388032 330 18446744073709551615 4194304 5129932 140735590458016 140735590456160 140449240097886 0 65536 16781316 65538 0 0 0 17 0 0 0 11 0 0
/proc/9925/statm: 2292 330 280 229 0 52 0
[pid=9928] ppid=9925 vsize=1034628 CPUtime=156.84
/proc/9928/stat : 9928 (java) S 9925 9925 1745 0 -1 4202496 200961 0 119 0 15614 70 0 0 20 0 11 0 117159732 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140735972059216 140159578840693 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 25 0 0
/proc/9928/statm: 258657 186195 2392 9 0 246007 0
[pid=9928/tid=9929] ppid=9925 vsize=1034628 CPUtime=133.58
/proc/9928/task/9929/stat : 9929 (java) R 9925 9925 1745 0 -1 4202560 47750 0 60 0 13336 22 0 0 20 0 11 0 117159759 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159585374184 140159484476864 0 4 0 16800975 0 0 0 -1 0 0 0 245 0 0
[pid=9928/tid=9930] ppid=9925 vsize=1034628 CPUtime=18.03
/proc/9928/task/9930/stat : 9930 (java) S 9925 9925 1745 0 -1 4202560 122267 0 7 0 1767 36 0 0 20 0 11 0 117159826 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159478013056 140159578854987 0 0 0 16800975 0 0 0 -1 0 0 0 11 0 0
[pid=9928/tid=9931] ppid=9925 vsize=1034628 CPUtime=0
/proc/9928/task/9931/stat : 9931 (java) S 9925 9925 1745 0 -1 4202560 15 0 0 0 0 0 0 0 20 0 11 0 117159834 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159476959248 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9932] ppid=9925 vsize=1034628 CPUtime=0
/proc/9928/task/9932/stat : 9932 (java) S 9925 9925 1745 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 117159834 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159475906464 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 1 0 0
[pid=9928/tid=9933] ppid=9925 vsize=1034628 CPUtime=0
/proc/9928/task/9933/stat : 9933 (java) S 9925 9925 1745 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 117159865 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159474854896 140159578862624 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9934] ppid=9925 vsize=1034628 CPUtime=2.6
/proc/9928/task/9934/stat : 9934 (java) S 9925 9925 1745 0 -1 4202560 18397 0 11 0 253 7 0 0 20 0 11 0 117159865 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159473802256 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 24 0 0
[pid=9928/tid=9935] ppid=9925 vsize=1034628 CPUtime=2.5
/proc/9928/task/9935/stat : 9935 (java) S 9925 9925 1745 0 -1 4202560 11269 0 2 0 248 2 0 0 20 0 11 0 117159865 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159472749584 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 7 0 0
[pid=9928/tid=9936] ppid=9925 vsize=1034628 CPUtime=0
/proc/9928/task/9936/stat : 9936 (java) S 9925 9925 1745 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 117159865 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159471697104 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9937] ppid=9925 vsize=1034628 CPUtime=0.08
/proc/9928/task/9937/stat : 9937 (java) S 9925 9925 1745 0 -1 4202560 20 0 0 0 2 6 0 0 20 0 11 0 117159865 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159470644608 140159578854987 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9938] ppid=9925 vsize=1034628 CPUtime=0
/proc/9928/task/9938/stat : 9938 (java) S 9925 9925 1745 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 117161151 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159469451104 140159578854987 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 156.84
Current children cumulated vsize (KiB) 1043796

[startup+222.301 s]
/proc/loadavg: 1.01 1.00 0.77 2/77 9938
/proc/meminfo: memFree=9916/1022884 swapFree=0/0
[pid=9925] ppid=9924 vsize=9168 CPUtime=0
/proc/9925/stat : 9925 (p2cudf-full-1.1) S 9924 9925 1745 0 -1 4202496 454 292 0 0 0 0 0 0 20 0 1 0 117159720 9388032 330 18446744073709551615 4194304 5129932 140735590458016 140735590456160 140449240097886 0 65536 16781316 65538 0 0 0 17 0 0 0 11 0 0
/proc/9925/statm: 2292 330 280 229 0 52 0
[pid=9928] ppid=9925 vsize=1034628 CPUtime=216.16
/proc/9928/stat : 9928 (java) S 9925 9925 1745 0 -1 4202496 200968 0 119 0 21546 70 0 0 20 0 11 0 117159732 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140735972059216 140159578840693 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 25 0 0
/proc/9928/statm: 258657 186195 2392 9 0 246007 0
[pid=9928/tid=9929] ppid=9925 vsize=1034628 CPUtime=188.35
/proc/9928/task/9929/stat : 9929 (java) R 9925 9925 1745 0 -1 4202560 47750 0 60 0 18813 22 0 0 20 0 11 0 117159759 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159585374184 140159483977731 0 4 0 16800975 0 0 0 -1 0 0 0 245 0 0
[pid=9928/tid=9930] ppid=9925 vsize=1034628 CPUtime=22.54
/proc/9928/task/9930/stat : 9930 (java) S 9925 9925 1745 0 -1 4202560 122268 0 7 0 2218 36 0 0 20 0 11 0 117159826 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159478013056 140159578854987 0 0 0 16800975 0 0 0 -1 0 0 0 11 0 0
[pid=9928/tid=9931] ppid=9925 vsize=1034628 CPUtime=0
/proc/9928/task/9931/stat : 9931 (java) S 9925 9925 1745 0 -1 4202560 15 0 0 0 0 0 0 0 20 0 11 0 117159834 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159476959248 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9932] ppid=9925 vsize=1034628 CPUtime=0
/proc/9928/task/9932/stat : 9932 (java) S 9925 9925 1745 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 117159834 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159475906464 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 1 0 0
[pid=9928/tid=9933] ppid=9925 vsize=1034628 CPUtime=0
/proc/9928/task/9933/stat : 9933 (java) S 9925 9925 1745 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 117159865 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159474854896 140159578862624 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9934] ppid=9925 vsize=1034628 CPUtime=2.6
/proc/9928/task/9934/stat : 9934 (java) S 9925 9925 1745 0 -1 4202560 18397 0 11 0 253 7 0 0 20 0 11 0 117159865 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159473802256 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 24 0 0
[pid=9928/tid=9935] ppid=9925 vsize=1034628 CPUtime=2.5
/proc/9928/task/9935/stat : 9935 (java) S 9925 9925 1745 0 -1 4202560 11269 0 2 0 248 2 0 0 20 0 11 0 117159865 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159472749584 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 7 0 0
[pid=9928/tid=9936] ppid=9925 vsize=1034628 CPUtime=0
/proc/9928/task/9936/stat : 9936 (java) S 9925 9925 1745 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 117159865 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159471697104 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9937] ppid=9925 vsize=1034628 CPUtime=0.12
/proc/9928/task/9937/stat : 9937 (java) S 9925 9925 1745 0 -1 4202560 26 0 0 0 4 8 0 0 20 0 11 0 117159865 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159470644608 140159578854987 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9938] ppid=9925 vsize=1034628 CPUtime=0
/proc/9928/task/9938/stat : 9938 (java) S 9925 9925 1745 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 117161151 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159469451104 140159578854987 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 216.16
Current children cumulated vsize (KiB) 1043796

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

[startup+224.101 s]
/proc/loadavg: 1.01 1.00 0.77 2/77 9938
/proc/meminfo: memFree=9916/1022884 swapFree=0/0
[pid=9925] ppid=9924 vsize=9168 CPUtime=0
/proc/9925/stat : 9925 (p2cudf-full-1.1) S 9924 9925 1745 0 -1 4202496 454 292 0 0 0 0 0 0 20 0 1 0 117159720 9388032 330 18446744073709551615 4194304 5129932 140735590458016 140735590456160 140449240097886 0 65536 16781316 65538 0 0 0 17 0 0 0 11 0 0
/proc/9925/statm: 2292 330 280 229 0 52 0
[pid=9928] ppid=9925 vsize=1034628 CPUtime=217.94
/proc/9928/stat : 9928 (java) S 9925 9925 1745 0 -1 4202496 200968 0 119 0 21724 70 0 0 20 0 11 0 117159732 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140735972059216 140159578840693 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 25 0 0
/proc/9928/statm: 258657 186195 2392 9 0 246007 0
[pid=9928/tid=9929] ppid=9925 vsize=1034628 CPUtime=190.13
/proc/9928/task/9929/stat : 9929 (java) R 9925 9925 1745 0 -1 4202560 47750 0 60 0 18991 22 0 0 20 0 11 0 117159759 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159585374184 140159484355293 0 4 0 16800975 0 0 0 -1 0 0 0 245 0 0
[pid=9928/tid=9930] ppid=9925 vsize=1034628 CPUtime=22.54
/proc/9928/task/9930/stat : 9930 (java) S 9925 9925 1745 0 -1 4202560 122268 0 7 0 2218 36 0 0 20 0 11 0 117159826 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159478013056 140159578854987 0 0 0 16800975 0 0 0 -1 0 0 0 11 0 0
[pid=9928/tid=9931] ppid=9925 vsize=1034628 CPUtime=0
/proc/9928/task/9931/stat : 9931 (java) S 9925 9925 1745 0 -1 4202560 15 0 0 0 0 0 0 0 20 0 11 0 117159834 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159476959248 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9932] ppid=9925 vsize=1034628 CPUtime=0
/proc/9928/task/9932/stat : 9932 (java) S 9925 9925 1745 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 117159834 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159475906464 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 1 0 0
[pid=9928/tid=9933] ppid=9925 vsize=1034628 CPUtime=0
/proc/9928/task/9933/stat : 9933 (java) S 9925 9925 1745 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 117159865 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159474854896 140159578862624 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9934] ppid=9925 vsize=1034628 CPUtime=2.6
/proc/9928/task/9934/stat : 9934 (java) S 9925 9925 1745 0 -1 4202560 18397 0 11 0 253 7 0 0 20 0 11 0 117159865 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159473802256 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 24 0 0
[pid=9928/tid=9935] ppid=9925 vsize=1034628 CPUtime=2.5
/proc/9928/task/9935/stat : 9935 (java) S 9925 9925 1745 0 -1 4202560 11269 0 2 0 248 2 0 0 20 0 11 0 117159865 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159472749584 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 7 0 0
[pid=9928/tid=9936] ppid=9925 vsize=1034628 CPUtime=0
/proc/9928/task/9936/stat : 9936 (java) S 9925 9925 1745 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 117159865 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159471697104 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9937] ppid=9925 vsize=1034628 CPUtime=0.12
/proc/9928/task/9937/stat : 9937 (java) S 9925 9925 1745 0 -1 4202560 26 0 0 0 4 8 0 0 20 0 11 0 117159865 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159470644608 140159578854987 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9938] ppid=9925 vsize=1034628 CPUtime=0
/proc/9928/task/9938/stat : 9938 (java) S 9925 9925 1745 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 117161151 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159469451104 140159578854987 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 217.94
Current children cumulated vsize (KiB) 1043796

[startup+227.301 s]
/proc/loadavg: 1.17 1.04 0.78 2/77 9938
/proc/meminfo: memFree=9916/1022884 swapFree=0/0
[pid=9925] ppid=9924 vsize=9168 CPUtime=0
/proc/9925/stat : 9925 (p2cudf-full-1.1) S 9924 9925 1745 0 -1 4202496 454 292 0 0 0 0 0 0 20 0 1 0 117159720 9388032 330 18446744073709551615 4194304 5129932 140735590458016 140735590456160 140449240097886 0 65536 16781316 65538 0 0 0 17 0 0 0 11 0 0
/proc/9925/statm: 2292 330 280 229 0 52 0
[pid=9928] ppid=9925 vsize=1034628 CPUtime=221.1
/proc/9928/stat : 9928 (java) S 9925 9925 1745 0 -1 4202496 200968 0 119 0 22040 70 0 0 20 0 11 0 117159732 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140735972059216 140159578840693 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 25 0 0
/proc/9928/statm: 258657 186195 2392 9 0 246007 0
[pid=9928/tid=9929] ppid=9925 vsize=1034628 CPUtime=193.3
/proc/9928/task/9929/stat : 9929 (java) R 9925 9925 1745 0 -1 4202560 47750 0 60 0 19308 22 0 0 20 0 11 0 117159759 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159585374184 140159483977663 0 4 0 16800975 0 0 0 -1 0 0 0 245 0 0
[pid=9928/tid=9930] ppid=9925 vsize=1034628 CPUtime=22.54
/proc/9928/task/9930/stat : 9930 (java) S 9925 9925 1745 0 -1 4202560 122268 0 7 0 2218 36 0 0 20 0 11 0 117159826 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159478013056 140159578854987 0 0 0 16800975 0 0 0 -1 0 0 0 11 0 0
[pid=9928/tid=9931] ppid=9925 vsize=1034628 CPUtime=0
/proc/9928/task/9931/stat : 9931 (java) S 9925 9925 1745 0 -1 4202560 15 0 0 0 0 0 0 0 20 0 11 0 117159834 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159476959248 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9932] ppid=9925 vsize=1034628 CPUtime=0
/proc/9928/task/9932/stat : 9932 (java) S 9925 9925 1745 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 117159834 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159475906464 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 1 0 0
[pid=9928/tid=9933] ppid=9925 vsize=1034628 CPUtime=0
/proc/9928/task/9933/stat : 9933 (java) S 9925 9925 1745 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 117159865 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159474854896 140159578862624 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9934] ppid=9925 vsize=1034628 CPUtime=2.6
/proc/9928/task/9934/stat : 9934 (java) S 9925 9925 1745 0 -1 4202560 18397 0 11 0 253 7 0 0 20 0 11 0 117159865 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159473802256 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 24 0 0
[pid=9928/tid=9935] ppid=9925 vsize=1034628 CPUtime=2.5
/proc/9928/task/9935/stat : 9935 (java) S 9925 9925 1745 0 -1 4202560 11269 0 2 0 248 2 0 0 20 0 11 0 117159865 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159472749584 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 7 0 0
[pid=9928/tid=9936] ppid=9925 vsize=1034628 CPUtime=0
/proc/9928/task/9936/stat : 9936 (java) S 9925 9925 1745 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 117159865 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159471697104 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9937] ppid=9925 vsize=1034628 CPUtime=0.12
/proc/9928/task/9937/stat : 9937 (java) S 9925 9925 1745 0 -1 4202560 26 0 0 0 4 8 0 0 20 0 11 0 117159865 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159470644608 140159578854987 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9938] ppid=9925 vsize=1034628 CPUtime=0
/proc/9928/task/9938/stat : 9938 (java) S 9925 9925 1745 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 117161151 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159469451104 140159578854987 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 221.1
Current children cumulated vsize (KiB) 1043796

[startup+230.501 s]
/proc/loadavg: 1.16 1.04 0.79 2/77 9938
/proc/meminfo: memFree=9916/1022884 swapFree=0/0
[pid=9925] ppid=9924 vsize=9168 CPUtime=0
/proc/9925/stat : 9925 (p2cudf-full-1.1) S 9924 9925 1745 0 -1 4202496 454 292 0 0 0 0 0 0 20 0 1 0 117159720 9388032 330 18446744073709551615 4194304 5129932 140735590458016 140735590456160 140449240097886 0 65536 16781316 65538 0 0 0 17 0 0 0 11 0 0
/proc/9925/statm: 2292 330 280 229 0 52 0
[pid=9928] ppid=9925 vsize=1034628 CPUtime=224.27
/proc/9928/stat : 9928 (java) S 9925 9925 1745 0 -1 4202496 200969 0 119 0 22357 70 0 0 20 0 11 0 117159732 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140735972059216 140159578840693 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 25 0 0
/proc/9928/statm: 258657 186195 2392 9 0 246007 0
[pid=9928/tid=9929] ppid=9925 vsize=1034628 CPUtime=193.59
/proc/9928/task/9929/stat : 9929 (java) S 9925 9925 1745 0 -1 4202560 47750 0 60 0 19337 22 0 0 20 0 11 0 117159759 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159585373888 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 245 0 0
[pid=9928/tid=9930] ppid=9925 vsize=1034628 CPUtime=25.41
/proc/9928/task/9930/stat : 9930 (java) R 9925 9925 1745 0 -1 4202560 122269 0 7 0 2505 36 0 0 20 0 11 0 117159826 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159478012432 140159564654936 0 0 0 16800975 0 0 0 -1 0 0 0 11 0 0
[pid=9928/tid=9931] ppid=9925 vsize=1034628 CPUtime=0
/proc/9928/task/9931/stat : 9931 (java) S 9925 9925 1745 0 -1 4202560 15 0 0 0 0 0 0 0 20 0 11 0 117159834 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159476959248 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9932] ppid=9925 vsize=1034628 CPUtime=0
/proc/9928/task/9932/stat : 9932 (java) S 9925 9925 1745 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 117159834 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159475906464 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 1 0 0
[pid=9928/tid=9933] ppid=9925 vsize=1034628 CPUtime=0
/proc/9928/task/9933/stat : 9933 (java) S 9925 9925 1745 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 117159865 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159474854896 140159578862624 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9934] ppid=9925 vsize=1034628 CPUtime=2.6
/proc/9928/task/9934/stat : 9934 (java) S 9925 9925 1745 0 -1 4202560 18397 0 11 0 253 7 0 0 20 0 11 0 117159865 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159473802256 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 24 0 0
[pid=9928/tid=9935] ppid=9925 vsize=1034628 CPUtime=2.5
/proc/9928/task/9935/stat : 9935 (java) S 9925 9925 1745 0 -1 4202560 11269 0 2 0 248 2 0 0 20 0 11 0 117159865 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159472749584 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 7 0 0
[pid=9928/tid=9936] ppid=9925 vsize=1034628 CPUtime=0
/proc/9928/task/9936/stat : 9936 (java) S 9925 9925 1745 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 117159865 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159471697104 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9937] ppid=9925 vsize=1034628 CPUtime=0.12
/proc/9928/task/9937/stat : 9937 (java) S 9925 9925 1745 0 -1 4202560 26 0 0 0 4 8 0 0 20 0 11 0 117159865 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159470644608 140159578854987 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9938] ppid=9925 vsize=1034628 CPUtime=0
/proc/9928/task/9938/stat : 9938 (java) S 9925 9925 1745 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 117161151 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159469451104 140159578854987 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 224.27
Current children cumulated vsize (KiB) 1043796

[startup+232.101 s]
/proc/loadavg: 1.16 1.04 0.79 2/77 9938
/proc/meminfo: memFree=9916/1022884 swapFree=0/0
[pid=9925] ppid=9924 vsize=9168 CPUtime=0
/proc/9925/stat : 9925 (p2cudf-full-1.1) S 9924 9925 1745 0 -1 4202496 454 292 0 0 0 0 0 0 20 0 1 0 117159720 9388032 330 18446744073709551615 4194304 5129932 140735590458016 140735590456160 140449240097886 0 65536 16781316 65538 0 0 0 17 0 0 0 11 0 0
/proc/9925/statm: 2292 330 280 229 0 52 0
[pid=9928] ppid=9925 vsize=1034628 CPUtime=225.85
/proc/9928/stat : 9928 (java) S 9925 9925 1745 0 -1 4202496 200969 0 119 0 22515 70 0 0 20 0 11 0 117159732 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140735972059216 140159578840693 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 25 0 0
/proc/9928/statm: 258657 186195 2392 9 0 246007 0
[pid=9928/tid=9929] ppid=9925 vsize=1034628 CPUtime=193.59
/proc/9928/task/9929/stat : 9929 (java) S 9925 9925 1745 0 -1 4202560 47750 0 60 0 19337 22 0 0 20 0 11 0 117159759 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159585374992 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 245 0 0
[pid=9928/tid=9930] ppid=9925 vsize=1034628 CPUtime=26.99
/proc/9928/task/9930/stat : 9930 (java) R 9925 9925 1745 0 -1 4202560 122269 0 7 0 2663 36 0 0 20 0 11 0 117159826 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159478012432 140159563202981 0 0 0 16800975 0 0 0 -1 0 0 0 11 0 0
[pid=9928/tid=9931] ppid=9925 vsize=1034628 CPUtime=0
/proc/9928/task/9931/stat : 9931 (java) S 9925 9925 1745 0 -1 4202560 15 0 0 0 0 0 0 0 20 0 11 0 117159834 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159476959248 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9932] ppid=9925 vsize=1034628 CPUtime=0
/proc/9928/task/9932/stat : 9932 (java) S 9925 9925 1745 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 117159834 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159475906464 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 1 0 0
[pid=9928/tid=9933] ppid=9925 vsize=1034628 CPUtime=0
/proc/9928/task/9933/stat : 9933 (java) S 9925 9925 1745 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 117159865 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159474854896 140159578862624 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9934] ppid=9925 vsize=1034628 CPUtime=2.6
/proc/9928/task/9934/stat : 9934 (java) S 9925 9925 1745 0 -1 4202560 18397 0 11 0 253 7 0 0 20 0 11 0 117159865 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159473802256 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 24 0 0
[pid=9928/tid=9935] ppid=9925 vsize=1034628 CPUtime=2.5
/proc/9928/task/9935/stat : 9935 (java) S 9925 9925 1745 0 -1 4202560 11269 0 2 0 248 2 0 0 20 0 11 0 117159865 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159472734256 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 7 0 0
[pid=9928/tid=9936] ppid=9925 vsize=1034628 CPUtime=0
/proc/9928/task/9936/stat : 9936 (java) S 9925 9925 1745 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 117159865 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159471697104 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9937] ppid=9925 vsize=1034628 CPUtime=0.12
/proc/9928/task/9937/stat : 9937 (java) S 9925 9925 1745 0 -1 4202560 26 0 0 0 4 8 0 0 20 0 11 0 117159865 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159470644608 140159578854987 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9938] ppid=9925 vsize=1034628 CPUtime=0
/proc/9928/task/9938/stat : 9938 (java) S 9925 9925 1745 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 117161151 1059459072 186195 18446744073709551615 4194304 4228012 140735972068192 140159469451104 140159578854987 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 225.85
Current children cumulated vsize (KiB) 1043796

[startup+232.901 s]
/proc/loadavg: 1.16 1.04 0.79 2/77 9938
/proc/meminfo: memFree=9916/1022884 swapFree=0/0
[pid=9925] ppid=9924 vsize=9168 CPUtime=0
/proc/9925/stat : 9925 (p2cudf-full-1.1) S 9924 9925 1745 0 -1 4202496 454 292 0 0 0 0 0 0 20 0 1 0 117159720 9388032 330 18446744073709551615 4194304 5129932 140735590458016 140735590456160 140449240097886 0 65536 16781316 65538 0 0 0 17 0 0 0 11 0 0
/proc/9925/statm: 2292 330 280 229 0 52 0
[pid=9928] ppid=9925 vsize=1035656 CPUtime=226.25
/proc/9928/stat : 9928 (java) S 9925 9925 1745 0 -1 4202496 200981 0 119 0 22555 70 0 0 20 0 11 0 117159732 1060511744 186205 18446744073709551615 4194304 4228012 140735972068192 140735972059216 140159578840693 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 25 0 0
/proc/9928/statm: 258914 186205 2392 9 0 246264 0
[pid=9928/tid=9929] ppid=9925 vsize=1035656 CPUtime=193.59
/proc/9928/task/9929/stat : 9929 (java) S 9925 9925 1745 0 -1 4202560 47754 0 60 0 19337 22 0 0 20 0 11 0 117159759 1060511744 186205 18446744073709551615 4194304 4228012 140735972068192 140159585375552 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 246 0 0
[pid=9928/tid=9930] ppid=9925 vsize=1035656 CPUtime=27.38
/proc/9928/task/9930/stat : 9930 (java) S 9925 9925 1745 0 -1 4202560 122269 0 7 0 2702 36 0 0 20 0 11 0 117159826 1060511744 186205 18446744073709551615 4194304 4228012 140735972068192 140159478013056 140159578854987 0 0 0 16800975 0 0 0 -1 0 0 0 11 0 0
[pid=9928/tid=9931] ppid=9925 vsize=1035656 CPUtime=0
/proc/9928/task/9931/stat : 9931 (java) S 9925 9925 1745 0 -1 4202560 15 0 0 0 0 0 0 0 20 0 11 0 117159834 1060511744 186205 18446744073709551615 4194304 4228012 140735972068192 140159476959248 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9932] ppid=9925 vsize=1035656 CPUtime=0
/proc/9928/task/9932/stat : 9932 (java) S 9925 9925 1745 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 117159834 1060511744 186205 18446744073709551615 4194304 4228012 140735972068192 140159475906464 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 1 0 0
[pid=9928/tid=9933] ppid=9925 vsize=1035656 CPUtime=0
/proc/9928/task/9933/stat : 9933 (java) S 9925 9925 1745 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 117159865 1060511744 186205 18446744073709551615 4194304 4228012 140735972068192 140159474854896 140159578862624 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9934] ppid=9925 vsize=1035656 CPUtime=2.6
/proc/9928/task/9934/stat : 9934 (java) S 9925 9925 1745 0 -1 4202560 18397 0 11 0 253 7 0 0 20 0 11 0 117159865 1060511744 186205 18446744073709551615 4194304 4228012 140735972068192 140159473802256 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 24 0 0
[pid=9928/tid=9935] ppid=9925 vsize=1035656 CPUtime=2.51
/proc/9928/task/9935/stat : 9935 (java) S 9925 9925 1745 0 -1 4202560 11271 0 2 0 249 2 0 0 20 0 11 0 117159865 1060511744 186205 18446744073709551615 4194304 4228012 140735972068192 140159472749584 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 7 0 0
[pid=9928/tid=9936] ppid=9925 vsize=1035656 CPUtime=0
/proc/9928/task/9936/stat : 9936 (java) S 9925 9925 1745 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 117159865 1060511744 186205 18446744073709551615 4194304 4228012 140735972068192 140159471697104 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9937] ppid=9925 vsize=1035656 CPUtime=0.12
/proc/9928/task/9937/stat : 9937 (java) S 9925 9925 1745 0 -1 4202560 26 0 0 0 4 8 0 0 20 0 11 0 117159865 1060511744 186205 18446744073709551615 4194304 4228012 140735972068192 140159470644608 140159578854987 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 226.25
Current children cumulated vsize (KiB) 1044824

[startup+233.101 s]
/proc/loadavg: 1.16 1.04 0.79 2/77 9938
/proc/meminfo: memFree=9916/1022884 swapFree=0/0
[pid=9925] ppid=9924 vsize=9168 CPUtime=0
/proc/9925/stat : 9925 (p2cudf-full-1.1) S 9924 9925 1745 0 -1 4202496 454 292 0 0 0 0 0 0 20 0 1 0 117159720 9388032 330 18446744073709551615 4194304 5129932 140735590458016 140735590456160 140449240097886 0 65536 16781316 65538 0 0 0 17 0 0 0 11 0 0
/proc/9925/statm: 2292 330 280 229 0 52 0
[pid=9928] ppid=9925 vsize=1035656 CPUtime=226.25
/proc/9928/stat : 9928 (java) D 9925 9925 1745 0 -1 4202496 200989 0 119 0 22555 70 0 0 20 0 7 0 117159732 1060511744 186199 18446744073709551615 4194304 4228012 140735972068192 140735972059216 140159556056844 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 25 0 0
/proc/9928/statm: 258914 186199 2393 9 0 246264 0
[pid=9928/tid=9931] ppid=9925 vsize=1035656 CPUtime=0
/proc/9928/task/9931/stat : 9931 (java) S 9925 9925 1745 0 -1 4202560 15 0 0 0 0 0 0 0 20 0 7 0 117159834 1060511744 186199 18446744073709551615 4194304 4228012 140735972068192 140159476959248 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=9928/tid=9932] ppid=9925 vsize=1035656 CPUtime=0
/proc/9928/task/9932/stat : 9932 (java) S 9925 9925 1745 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 7 0 117159834 1060511744 186199 18446744073709551615 4194304 4228012 140735972068192 140159475906464 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 1 0 0
[pid=9928/tid=9934] ppid=9925 vsize=1035656 CPUtime=2.6
/proc/9928/task/9934/stat : 9934 (java) S 9925 9925 1745 0 -1 4202560 18397 0 11 0 253 7 0 0 20 0 7 0 117159865 1060511744 186199 18446744073709551615 4194304 4228012 140735972068192 140159473802256 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 24 0 0
[pid=9928/tid=9935] ppid=9925 vsize=1035656 CPUtime=2.51
/proc/9928/task/9935/stat : 9935 (java) S 9925 9925 1745 0 -1 4202560 11271 0 2 0 249 2 0 0 20 0 7 0 117159865 1060511744 186199 18446744073709551615 4194304 4228012 140735972068192 140159472749584 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 7 0 0
[pid=9928/tid=9936] ppid=9925 vsize=1035656 CPUtime=0
/proc/9928/task/9936/stat : 9936 (java) S 9925 9925 1745 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 7 0 117159865 1060511744 186199 18446744073709551615 4194304 4228012 140735972068192 140159471697104 140159578854100 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 226.25
Current children cumulated vsize (KiB) 1044824

Child status: 1
Real time (s): 233.182
CPU time (s): 226.33
CPU user time (s): 225.59
CPU system time (s): 0.740046
CPU usage (%): 97.0617
Max. virtual memory (cumulated for all children) (KiB): 1063544

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 225.59
system time used= 0.740046
maximum resident set size= 744848
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 201748
page faults= 122
swaps= 0
block input operations= 103672
block output operations= 408
messages sent= 0
messages received= 0
signals received= 0
voluntary context switches= 6637
involuntary context switches= 32910

runsolver used 0.896056 second user time and 1.6521 second system time

The end