runsolver Copyright (C) 2010 Olivier ROUSSEL

This is runsolver version 3.2.9a (svn: 651)

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

command line: runsolver -s SIGUSR1 -M 1124 -C 300 -d 10 -w /tmp/misc2012/2012-09-02-22:42/full/p2cudf-full-1.15/trendy-size/upgrade/difficult/rand794.cudf.log.runsolver /home/competition/p2cudf-full-1.15/p2cudf-full-1.15 /home/competition/data/upgrade/difficult/rand794.cudf /tmp/misc2012/2012-09-02-22:42/full/p2cudf-full-1.15/trendy-size/upgrade/difficult/rand794.cudf.result -count(removed),-sum(solution,installedsize),-notuptodate(solution),-unsat_recommends(solution),-count(new) 

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

[startup+0 s]
/proc/loadavg: 1.04 1.08 1.09 2/64 18783
/proc/meminfo: memFree=644720/1022884 swapFree=0/0
[pid=18783] ppid=18782 vsize=3152 CPUtime=0
/proc/18783/stat : 18783 (runsolver) R 18782 1745 1745 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 1 0 119935577 3227648 33 18446744073709551615 134512640 134586868 4287165632 4287163680 4151993392 0 0 16781316 24578 0 0 0 17 0 0 0 0 0 0
/proc/18783/statm: 788 33 0 19 0 73 0
Current StackSize limit: 8192 KiB


[startup+0.205325 s]
/proc/loadavg: 1.04 1.08 1.09 2/64 18783
/proc/meminfo: memFree=644720/1022884 swapFree=0/0
[pid=18783] ppid=18782 vsize=9168 CPUtime=0
/proc/18783/stat : 18783 (p2cudf-full-1.1) S 18782 18783 1745 0 -1 4202496 456 291 2 1 0 0 0 0 20 0 1 0 119935577 9388032 330 18446744073709551615 4194304 5129932 140734802736720 140734802734864 140464820835422 0 65536 16781316 65538 0 0 0 17 0 0 0 3 0 0
/proc/18783/statm: 2292 330 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+0.300309 s]
/proc/loadavg: 1.04 1.08 1.09 2/64 18783
/proc/meminfo: memFree=644720/1022884 swapFree=0/0
[pid=18783] ppid=18782 vsize=9168 CPUtime=0
/proc/18783/stat : 18783 (p2cudf-full-1.1) S 18782 18783 1745 0 -1 4202496 456 291 2 1 0 0 0 0 20 0 1 0 119935577 9388032 330 18446744073709551615 4194304 5129932 140734802736720 140734802734864 140464820835422 0 65536 16781316 65538 0 0 0 17 0 0 0 3 0 0
/proc/18783/statm: 2292 330 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+0.400295 s]
/proc/loadavg: 1.04 1.08 1.09 2/64 18783
/proc/meminfo: memFree=644720/1022884 swapFree=0/0
[pid=18783] ppid=18782 vsize=9168 CPUtime=0
/proc/18783/stat : 18783 (p2cudf-full-1.1) S 18782 18783 1745 0 -1 4202496 456 291 2 1 0 0 0 0 20 0 1 0 119935577 9388032 330 18446744073709551615 4194304 5129932 140734802736720 140734802734864 140464820835422 0 65536 16781316 65538 0 0 0 17 0 0 0 3 0 0
/proc/18783/statm: 2292 330 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+0.700229 s]
/proc/loadavg: 1.04 1.08 1.09 2/64 18783
/proc/meminfo: memFree=644720/1022884 swapFree=0/0
[pid=18783] ppid=18782 vsize=9168 CPUtime=0
/proc/18783/stat : 18783 (p2cudf-full-1.1) S 18782 18783 1745 0 -1 4202496 456 291 2 1 0 0 0 0 20 0 1 0 119935577 9388032 330 18446744073709551615 4194304 5129932 140734802736720 140734802734864 140464820835422 0 65536 16781316 65538 0 0 0 17 0 0 0 3 0 0
/proc/18783/statm: 2292 330 280 229 0 52 0
Current children cumulated CPU time (s) 0
Current children cumulated vsize (KiB) 9168

[startup+1.50071 s]
/proc/loadavg: 1.04 1.08 1.09 4/75 18795
/proc/meminfo: memFree=600728/1022884 swapFree=0/0
[pid=18783] ppid=18782 vsize=9168 CPUtime=0
/proc/18783/stat : 18783 (p2cudf-full-1.1) S 18782 18783 1745 0 -1 4202496 456 291 2 1 0 0 0 0 20 0 1 0 119935577 9388032 330 18446744073709551615 4194304 5129932 140734802736720 140734802734864 140464820835422 0 65536 16781316 65538 0 0 0 17 0 0 0 3 0 0
/proc/18783/statm: 2292 330 280 229 0 52 0
[pid=18786] ppid=18783 vsize=1043924 CPUtime=1.28
/proc/18786/stat : 18786 (java) S 18783 18783 1745 0 -1 4202496 27510 0 20 0 116 12 0 0 20 0 10 0 119935583 1068978176 24778 18446744073709551615 4194304 4228012 140734066289824 140734066280848 140168655613557 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 5 0 0
/proc/18786/statm: 260981 24778 2345 9 0 248331 0
[pid=18786/tid=18787] ppid=18783 vsize=1043924 CPUtime=0.61
/proc/18786/task/18787/stat : 18787 (java) R 18783 18783 1745 0 -1 4202560 12372 0 8 0 55 6 0 0 20 0 10 0 119935589 1068978176 24778 18446744073709551615 4194304 4228012 140734066289824 140168662139552 140168560052049 0 4 0 16800975 0 0 0 -1 0 0 0 10 0 0
[pid=18786/tid=18788] ppid=18783 vsize=1043924 CPUtime=0
/proc/18786/task/18788/stat : 18788 (java) S 18783 18783 1745 0 -1 4202560 4 0 0 0 0 0 0 0 20 0 10 0 119935600 1068978176 24778 18446744073709551615 4194304 4228012 140734066289824 140168554785920 140168655627851 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18789] ppid=18783 vsize=1043924 CPUtime=0
/proc/18786/task/18789/stat : 18789 (java) S 18783 18783 1745 0 -1 4202560 15 0 0 0 0 0 0 0 20 0 10 0 119935601 1068978176 24778 18446744073709551615 4194304 4228012 140734066289824 140168553732112 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18790] ppid=18783 vsize=1043924 CPUtime=0
/proc/18786/task/18790/stat : 18790 (java) S 18783 18783 1745 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 10 0 119935601 1068978176 24778 18446744073709551615 4194304 4228012 140734066289824 140168552679328 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18791] ppid=18783 vsize=1043924 CPUtime=0
/proc/18786/task/18791/stat : 18791 (java) S 18783 18783 1745 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 119935604 1068978176 24778 18446744073709551615 4194304 4228012 140734066289824 140168551627760 140168655635488 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18792] ppid=18783 vsize=1043924 CPUtime=0.33
/proc/18786/task/18792/stat : 18792 (java) R 18783 18783 1745 0 -1 4202560 7949 0 0 0 31 2 0 0 20 0 10 0 119935604 1068978176 24778 18446744073709551615 4194304 4228012 140734066289824 140168550560920 140168648513050 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18793] ppid=18783 vsize=1043924 CPUtime=0.3
/proc/18786/task/18793/stat : 18793 (java) R 18783 18783 1745 0 -1 4202560 5907 0 0 0 28 2 0 0 20 0 10 0 119935604 1068978176 24778 18446744073709551615 4194304 4228012 140734066289824 140168549507048 140168641765184 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18794] ppid=18783 vsize=1043924 CPUtime=0
/proc/18786/task/18794/stat : 18794 (java) S 18783 18783 1745 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 119935604 1068978176 24778 18446744073709551615 4194304 4228012 140734066289824 140168548469968 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18795] ppid=18783 vsize=1043924 CPUtime=0
/proc/18786/task/18795/stat : 18795 (java) S 18783 18783 1745 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 119935604 1068978176 24778 18446744073709551615 4194304 4228012 140734066289824 140168547417472 140168655627851 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 1.28
Current children cumulated vsize (KiB) 1053092

[startup+3.10076 s]
/proc/loadavg: 1.04 1.08 1.09 4/75 18795
/proc/meminfo: memFree=496568/1022884 swapFree=0/0
[pid=18783] ppid=18782 vsize=9168 CPUtime=0
/proc/18783/stat : 18783 (p2cudf-full-1.1) S 18782 18783 1745 0 -1 4202496 456 291 2 1 0 0 0 0 20 0 1 0 119935577 9388032 330 18446744073709551615 4194304 5129932 140734802736720 140734802734864 140464820835422 0 65536 16781316 65538 0 0 0 17 0 0 0 3 0 0
/proc/18783/statm: 2292 330 280 229 0 52 0
[pid=18786] ppid=18783 vsize=1051240 CPUtime=2.85
/proc/18786/stat : 18786 (java) S 18783 18783 1745 0 -1 4202496 76298 0 20 0 257 28 0 0 20 0 10 0 119935583 1076469760 71221 18446744073709551615 4194304 4228012 140734066289824 140734066280848 140168655613557 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 5 0 0
/proc/18786/statm: 262810 71221 2365 9 0 250160 0
[pid=18786/tid=18787] ppid=18783 vsize=1051240 CPUtime=1.35
/proc/18786/task/18787/stat : 18787 (java) R 18783 18783 1745 0 -1 4202560 47407 0 8 0 118 17 0 0 20 0 10 0 119935589 1076469760 71221 18446744073709551615 4194304 4228012 140734066289824 140168662139584 140168560052120 0 4 0 16800975 0 0 0 -1 0 0 0 11 0 0
[pid=18786/tid=18788] ppid=18783 vsize=1051240 CPUtime=0.17
/proc/18786/task/18788/stat : 18788 (java) S 18783 18783 1745 0 -1 4202560 7974 0 0 0 15 2 0 0 20 0 10 0 119935600 1076469760 71221 18446744073709551615 4194304 4228012 140734066289824 140168554785920 140168655627851 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18789] ppid=18783 vsize=1051240 CPUtime=0
/proc/18786/task/18789/stat : 18789 (java) S 18783 18783 1745 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 10 0 119935601 1076469760 71221 18446744073709551615 4194304 4228012 140734066289824 140168553732112 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18790] ppid=18783 vsize=1051240 CPUtime=0
/proc/18786/task/18790/stat : 18790 (java) S 18783 18783 1745 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 10 0 119935601 1076469760 71221 18446744073709551615 4194304 4228012 140734066289824 140168552679328 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18791] ppid=18783 vsize=1051240 CPUtime=0
/proc/18786/task/18791/stat : 18791 (java) S 18783 18783 1745 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 119935604 1076469760 71221 18446744073709551615 4194304 4228012 140734066289824 140168551627760 140168655635488 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18792] ppid=18783 vsize=1051240 CPUtime=0.69
/proc/18786/task/18792/stat : 18792 (java) S 18783 18783 1745 0 -1 4202560 9697 0 0 0 66 3 0 0 20 0 10 0 119935604 1076469760 71221 18446744073709551615 4194304 4228012 140734066289824 140168550575120 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18793] ppid=18783 vsize=1051240 CPUtime=0.62
/proc/18786/task/18793/stat : 18793 (java) S 18783 18783 1745 0 -1 4202560 9938 0 0 0 56 6 0 0 20 0 10 0 119935604 1076469760 71221 18446744073709551615 4194304 4228012 140734066289824 140168549522448 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18794] ppid=18783 vsize=1051240 CPUtime=0
/proc/18786/task/18794/stat : 18794 (java) S 18783 18783 1745 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 119935604 1076469760 71221 18446744073709551615 4194304 4228012 140734066289824 140168548469968 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18795] ppid=18783 vsize=1051240 CPUtime=0
/proc/18786/task/18795/stat : 18795 (java) S 18783 18783 1745 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 119935604 1076469760 71221 18446744073709551615 4194304 4228012 140734066289824 140168547417472 140168655627851 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 2.85
Current children cumulated vsize (KiB) 1060408

[startup+6.3007 s]
/proc/loadavg: 1.04 1.08 1.09 1/75 18795
/proc/meminfo: memFree=210128/1022884 swapFree=0/0
[pid=18783] ppid=18782 vsize=9168 CPUtime=0
/proc/18783/stat : 18783 (p2cudf-full-1.1) S 18782 18783 1745 0 -1 4202496 456 291 2 1 0 0 0 0 20 0 1 0 119935577 9388032 330 18446744073709551615 4194304 5129932 140734802736720 140734802734864 140464820835422 0 65536 16781316 65538 0 0 0 17 0 0 0 3 0 0
/proc/18783/statm: 2292 330 280 229 0 52 0
[pid=18786] ppid=18783 vsize=1035096 CPUtime=5.92
/proc/18786/stat : 18786 (java) S 18783 18783 1745 0 -1 4202496 121721 0 20 0 551 41 0 0 20 0 10 0 119935583 1059938304 113122 18446744073709551615 4194304 4228012 140734066289824 140734066280848 140168655613557 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 5 0 0
/proc/18786/statm: 258774 113122 2367 9 0 246124 0
[pid=18786/tid=18787] ppid=18783 vsize=1035096 CPUtime=3.22
/proc/18786/task/18787/stat : 18787 (java) R 18783 18783 1745 0 -1 4202560 47410 0 8 0 302 20 0 0 20 0 10 0 119935589 1059938304 113122 18446744073709551615 4194304 4228012 140734066289824 140168662139584 140168559956080 0 4 0 16800975 0 0 0 -1 0 0 0 21 0 0
[pid=18786/tid=18788] ppid=18783 vsize=1035096 CPUtime=1.28
/proc/18786/task/18788/stat : 18788 (java) S 18783 18783 1745 0 -1 4202560 53380 0 0 0 117 11 0 0 20 0 10 0 119935600 1059938304 113122 18446744073709551615 4194304 4228012 140734066289824 140168554785920 140168655627851 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18789] ppid=18783 vsize=1035096 CPUtime=0
/proc/18786/task/18789/stat : 18789 (java) S 18783 18783 1745 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 10 0 119935601 1059938304 113122 18446744073709551615 4194304 4228012 140734066289824 140168553732112 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18790] ppid=18783 vsize=1035096 CPUtime=0
/proc/18786/task/18790/stat : 18790 (java) S 18783 18783 1745 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 10 0 119935601 1059938304 113122 18446744073709551615 4194304 4228012 140734066289824 140168552679328 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18791] ppid=18783 vsize=1035096 CPUtime=0
/proc/18786/task/18791/stat : 18791 (java) S 18783 18783 1745 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 119935604 1059938304 113122 18446744073709551615 4194304 4228012 140734066289824 140168551627760 140168655635488 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18792] ppid=18783 vsize=1035096 CPUtime=0.72
/proc/18786/task/18792/stat : 18792 (java) S 18783 18783 1745 0 -1 4202560 9707 0 0 0 69 3 0 0 20 0 10 0 119935604 1059938304 113122 18446744073709551615 4194304 4228012 140734066289824 140168550575120 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18793] ppid=18783 vsize=1035096 CPUtime=0.66
/proc/18786/task/18793/stat : 18793 (java) S 18783 18783 1745 0 -1 4202560 9941 0 0 0 60 6 0 0 20 0 10 0 119935604 1059938304 113122 18446744073709551615 4194304 4228012 140734066289824 140168549522448 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18794] ppid=18783 vsize=1035096 CPUtime=0
/proc/18786/task/18794/stat : 18794 (java) S 18783 18783 1745 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 119935604 1059938304 113122 18446744073709551615 4194304 4228012 140734066289824 140168548469968 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18795] ppid=18783 vsize=1035096 CPUtime=0
/proc/18786/task/18795/stat : 18795 (java) S 18783 18783 1745 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 119935604 1059938304 113122 18446744073709551615 4194304 4228012 140734066289824 140168547417472 140168655627851 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 5.92
Current children cumulated vsize (KiB) 1044264

[startup+12.7007 s]
/proc/loadavg: 1.19 1.11 1.10 3/75 18795
/proc/meminfo: memFree=37520/1022884 swapFree=0/0
[pid=18783] ppid=18782 vsize=9168 CPUtime=0
/proc/18783/stat : 18783 (p2cudf-full-1.1) S 18782 18783 1745 0 -1 4202496 456 291 2 1 0 0 0 0 20 0 1 0 119935577 9388032 330 18446744073709551615 4194304 5129932 140734802736720 140734802734864 140464820835422 0 65536 16781316 65538 0 0 0 17 0 0 0 3 0 0
/proc/18783/statm: 2292 330 280 229 0 52 0
[pid=18786] ppid=18783 vsize=1038240 CPUtime=12.23
/proc/18786/stat : 18786 (java) S 18783 18783 1745 0 -1 4202496 153811 0 20 0 1167 56 0 0 20 0 10 0 119935583 1063157760 144800 18446744073709551615 4194304 4228012 140734066289824 140734066280848 140168655613557 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 5 0 0
/proc/18786/statm: 259560 144800 2375 9 0 246910 0
[pid=18786/tid=18787] ppid=18783 vsize=1038240 CPUtime=6.01
/proc/18786/task/18787/stat : 18787 (java) R 18783 18783 1745 0 -1 4202560 47731 0 8 0 580 21 0 0 20 0 10 0 119935589 1063157760 144800 18446744073709551615 4194304 4228012 140734066289824 140168662146928 140168622935408 0 4 0 16800975 0 0 0 -1 0 0 0 21 0 0
[pid=18786/tid=18788] ppid=18783 vsize=1038240 CPUtime=2.15
/proc/18786/task/18788/stat : 18788 (java) S 18783 18783 1745 0 -1 4202560 83680 0 0 0 191 24 0 0 20 0 10 0 119935600 1063157760 144800 18446744073709551615 4194304 4228012 140734066289824 140168554785920 140168655627851 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18789] ppid=18783 vsize=1038240 CPUtime=0
/proc/18786/task/18789/stat : 18789 (java) S 18783 18783 1745 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 10 0 119935601 1063157760 144800 18446744073709551615 4194304 4228012 140734066289824 140168553732112 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18790] ppid=18783 vsize=1038240 CPUtime=0
/proc/18786/task/18790/stat : 18790 (java) S 18783 18783 1745 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 10 0 119935601 1063157760 144800 18446744073709551615 4194304 4228012 140734066289824 140168552679328 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18791] ppid=18783 vsize=1038240 CPUtime=0
/proc/18786/task/18791/stat : 18791 (java) S 18783 18783 1745 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 119935604 1063157760 144800 18446744073709551615 4194304 4228012 140734066289824 140168551627760 140168655635488 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18792] ppid=18783 vsize=1038240 CPUtime=2.1
/proc/18786/task/18792/stat : 18792 (java) S 18783 18783 1745 0 -1 4202560 11015 0 0 0 206 4 0 0 20 0 10 0 119935604 1063157760 144800 18446744073709551615 4194304 4228012 140734066289824 140168550575120 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18793] ppid=18783 vsize=1038240 CPUtime=1.93
/proc/18786/task/18793/stat : 18793 (java) S 18783 18783 1745 0 -1 4202560 10102 0 0 0 187 6 0 0 20 0 10 0 119935604 1063157760 144800 18446744073709551615 4194304 4228012 140734066289824 140168549522448 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18794] ppid=18783 vsize=1038240 CPUtime=0
/proc/18786/task/18794/stat : 18794 (java) S 18783 18783 1745 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 119935604 1063157760 144800 18446744073709551615 4194304 4228012 140734066289824 140168548469968 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18795] ppid=18783 vsize=1038240 CPUtime=0
/proc/18786/task/18795/stat : 18795 (java) S 18783 18783 1745 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 119935604 1063157760 144800 18446744073709551615 4194304 4228012 140734066289824 140168547417472 140168655627851 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 12.23
Current children cumulated vsize (KiB) 1047408

[startup+25.5051 s]
/proc/loadavg: 1.28 1.14 1.11 2/76 18796
/proc/meminfo: memFree=36768/1022884 swapFree=0/0
[pid=18783] ppid=18782 vsize=9168 CPUtime=0
/proc/18783/stat : 18783 (p2cudf-full-1.1) S 18782 18783 1745 0 -1 4202496 456 291 2 1 0 0 0 0 20 0 1 0 119935577 9388032 330 18446744073709551615 4194304 5129932 140734802736720 140734802734864 140464820835422 0 65536 16781316 65538 0 0 0 17 0 0 0 3 0 0
/proc/18783/statm: 2292 330 280 229 0 52 0
[pid=18786] ppid=18783 vsize=1039268 CPUtime=24.86
/proc/18786/stat : 18786 (java) S 18783 18783 1745 0 -1 4202496 153947 0 20 0 2428 58 0 0 20 0 11 0 119935583 1064210432 144936 18446744073709551615 4194304 4228012 140734066289824 140734066280848 140168655613557 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 5 0 0
/proc/18786/statm: 259817 144936 2381 9 0 247167 0
[pid=18786/tid=18787] ppid=18783 vsize=1039268 CPUtime=17.48
/proc/18786/task/18787/stat : 18787 (java) R 18783 18783 1745 0 -1 4202560 47802 0 8 0 1726 22 0 0 20 0 11 0 119935589 1064210432 144936 18446744073709551615 4194304 4228012 140734066289824 140168662147080 140168560788771 0 4 0 16800975 0 0 0 -1 0 0 0 21 0 0
[pid=18786/tid=18788] ppid=18783 vsize=1039268 CPUtime=2.18
/proc/18786/task/18788/stat : 18788 (java) S 18783 18783 1745 0 -1 4202560 83681 0 0 0 193 25 0 0 20 0 11 0 119935600 1064210432 144936 18446744073709551615 4194304 4228012 140734066289824 140168554785920 140168655627851 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18789] ppid=18783 vsize=1039268 CPUtime=0
/proc/18786/task/18789/stat : 18789 (java) S 18783 18783 1745 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 119935601 1064210432 144936 18446744073709551615 4194304 4228012 140734066289824 140168553732112 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18790] ppid=18783 vsize=1039268 CPUtime=0
/proc/18786/task/18790/stat : 18790 (java) S 18783 18783 1745 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 119935601 1064210432 144936 18446744073709551615 4194304 4228012 140734066289824 140168552679328 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18791] ppid=18783 vsize=1039268 CPUtime=0
/proc/18786/task/18791/stat : 18791 (java) S 18783 18783 1745 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 119935604 1064210432 144936 18446744073709551615 4194304 4228012 140734066289824 140168551627760 140168655635488 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18792] ppid=18783 vsize=1039268 CPUtime=2.68
/proc/18786/task/18792/stat : 18792 (java) S 18783 18783 1745 0 -1 4202560 11044 0 0 0 264 4 0 0 20 0 11 0 119935604 1064210432 144936 18446744073709551615 4194304 4228012 140734066289824 140168550575120 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18793] ppid=18783 vsize=1039268 CPUtime=2.47
/proc/18786/task/18793/stat : 18793 (java) S 18783 18783 1745 0 -1 4202560 10131 0 0 0 241 6 0 0 20 0 11 0 119935604 1064210432 144936 18446744073709551615 4194304 4228012 140734066289824 140168549522448 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18794] ppid=18783 vsize=1039268 CPUtime=0
/proc/18786/task/18794/stat : 18794 (java) S 18783 18783 1745 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 119935604 1064210432 144936 18446744073709551615 4194304 4228012 140734066289824 140168548469968 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18795] ppid=18783 vsize=1039268 CPUtime=0.01
/proc/18786/task/18795/stat : 18795 (java) S 18783 18783 1745 0 -1 4202560 1 0 0 0 0 1 0 0 20 0 11 0 119935604 1064210432 144936 18446744073709551615 4194304 4228012 140734066289824 140168547417472 140168655627851 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18796] ppid=18783 vsize=1039268 CPUtime=0
/proc/18786/task/18796/stat : 18796 (java) S 18783 18783 1745 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 119936902 1064210432 144936 18446744073709551615 4194304 4228012 140734066289824 140168546223968 140168655627851 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 24.86
Current children cumulated vsize (KiB) 1048436

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

[startup+25.7008 s]
/proc/loadavg: 1.28 1.14 1.11 2/76 18796
/proc/meminfo: memFree=36768/1022884 swapFree=0/0
[pid=18783] ppid=18782 vsize=9168 CPUtime=0
/proc/18783/stat : 18783 (p2cudf-full-1.1) S 18782 18783 1745 0 -1 4202496 456 291 2 1 0 0 0 0 20 0 1 0 119935577 9388032 330 18446744073709551615 4194304 5129932 140734802736720 140734802734864 140464820835422 0 65536 16781316 65538 0 0 0 17 0 0 0 3 0 0
/proc/18783/statm: 2292 330 280 229 0 52 0
[pid=18786] ppid=18783 vsize=1039268 CPUtime=25.05
/proc/18786/stat : 18786 (java) S 18783 18783 1745 0 -1 4202496 153948 0 20 0 2447 58 0 0 20 0 11 0 119935583 1064210432 144937 18446744073709551615 4194304 4228012 140734066289824 140734066280848 140168655613557 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 5 0 0
/proc/18786/statm: 259817 144937 2381 9 0 247167 0
[pid=18786/tid=18787] ppid=18783 vsize=1039268 CPUtime=17.68
/proc/18786/task/18787/stat : 18787 (java) R 18783 18783 1745 0 -1 4202560 47803 0 8 0 1746 22 0 0 20 0 11 0 119935589 1064210432 144937 18446744073709551615 4194304 4228012 140734066289824 140168662146952 140168560981032 0 4 0 16800975 0 0 0 -1 0 0 0 21 0 0
[pid=18786/tid=18788] ppid=18783 vsize=1039268 CPUtime=2.18
/proc/18786/task/18788/stat : 18788 (java) S 18783 18783 1745 0 -1 4202560 83681 0 0 0 193 25 0 0 20 0 11 0 119935600 1064210432 144937 18446744073709551615 4194304 4228012 140734066289824 140168554785920 140168655627851 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18789] ppid=18783 vsize=1039268 CPUtime=0
/proc/18786/task/18789/stat : 18789 (java) S 18783 18783 1745 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 119935601 1064210432 144937 18446744073709551615 4194304 4228012 140734066289824 140168553732112 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18790] ppid=18783 vsize=1039268 CPUtime=0
/proc/18786/task/18790/stat : 18790 (java) S 18783 18783 1745 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 119935601 1064210432 144937 18446744073709551615 4194304 4228012 140734066289824 140168552679328 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18791] ppid=18783 vsize=1039268 CPUtime=0
/proc/18786/task/18791/stat : 18791 (java) S 18783 18783 1745 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 119935604 1064210432 144937 18446744073709551615 4194304 4228012 140734066289824 140168551627760 140168655635488 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18792] ppid=18783 vsize=1039268 CPUtime=2.69
/proc/18786/task/18792/stat : 18792 (java) S 18783 18783 1745 0 -1 4202560 11044 0 0 0 265 4 0 0 20 0 11 0 119935604 1064210432 144937 18446744073709551615 4194304 4228012 140734066289824 140168550575120 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18793] ppid=18783 vsize=1039268 CPUtime=2.47
/proc/18786/task/18793/stat : 18793 (java) S 18783 18783 1745 0 -1 4202560 10131 0 0 0 241 6 0 0 20 0 11 0 119935604 1064210432 144937 18446744073709551615 4194304 4228012 140734066289824 140168549522448 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18794] ppid=18783 vsize=1039268 CPUtime=0
/proc/18786/task/18794/stat : 18794 (java) S 18783 18783 1745 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 119935604 1064210432 144937 18446744073709551615 4194304 4228012 140734066289824 140168548469968 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18795] ppid=18783 vsize=1039268 CPUtime=0.01
/proc/18786/task/18795/stat : 18795 (java) S 18783 18783 1745 0 -1 4202560 1 0 0 0 0 1 0 0 20 0 11 0 119935604 1064210432 144937 18446744073709551615 4194304 4228012 140734066289824 140168547417472 140168655627851 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18796] ppid=18783 vsize=1039268 CPUtime=0
/proc/18786/task/18796/stat : 18796 (java) S 18783 18783 1745 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 119936902 1064210432 144937 18446744073709551615 4194304 4228012 140734066289824 140168546223968 140168655627851 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 25.05
Current children cumulated vsize (KiB) 1048436

[startup+32.1102 s]
/proc/loadavg: 1.26 1.14 1.11 2/76 18796
/proc/meminfo: memFree=36768/1022884 swapFree=0/0
[pid=18783] ppid=18782 vsize=9168 CPUtime=0
/proc/18783/stat : 18783 (p2cudf-full-1.1) S 18782 18783 1745 0 -1 4202496 456 291 2 1 0 0 0 0 20 0 1 0 119935577 9388032 330 18446744073709551615 4194304 5129932 140734802736720 140734802734864 140464820835422 0 65536 16781316 65538 0 0 0 17 0 0 0 3 0 0
/proc/18783/statm: 2292 330 280 229 0 52 0
[pid=18786] ppid=18783 vsize=1039268 CPUtime=31.37
/proc/18786/stat : 18786 (java) S 18783 18783 1745 0 -1 4202496 153982 0 20 0 3079 58 0 0 20 0 11 0 119935583 1064210432 144968 18446744073709551615 4194304 4228012 140734066289824 140734066280848 140168655613557 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 5 0 0
/proc/18786/statm: 259817 144968 2392 9 0 247167 0
[pid=18786/tid=18787] ppid=18783 vsize=1039268 CPUtime=22.77
/proc/18786/task/18787/stat : 18787 (java) S 18783 18783 1745 0 -1 4202560 47803 0 8 0 2255 22 0 0 20 0 11 0 119935589 1064210432 144968 18446744073709551615 4194304 4228012 140734066289824 140168662146944 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 21 0 0
[pid=18786/tid=18788] ppid=18783 vsize=1039268 CPUtime=3.36
/proc/18786/task/18788/stat : 18788 (java) R 18783 18783 1745 0 -1 4202560 83712 0 0 0 310 26 0 0 20 0 11 0 119935600 1064210432 144968 18446744073709551615 4194304 4228012 140734066289824 140168554784880 140168639922065 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18789] ppid=18783 vsize=1039268 CPUtime=0
/proc/18786/task/18789/stat : 18789 (java) S 18783 18783 1745 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 119935601 1064210432 144968 18446744073709551615 4194304 4228012 140734066289824 140168553732112 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18790] ppid=18783 vsize=1039268 CPUtime=0
/proc/18786/task/18790/stat : 18790 (java) S 18783 18783 1745 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 119935601 1064210432 144968 18446744073709551615 4194304 4228012 140734066289824 140168552679328 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18791] ppid=18783 vsize=1039268 CPUtime=0
/proc/18786/task/18791/stat : 18791 (java) S 18783 18783 1745 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 119935604 1064210432 144968 18446744073709551615 4194304 4228012 140734066289824 140168551627760 140168655635488 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18792] ppid=18783 vsize=1039268 CPUtime=2.7
/proc/18786/task/18792/stat : 18792 (java) S 18783 18783 1745 0 -1 4202560 11044 0 0 0 266 4 0 0 20 0 11 0 119935604 1064210432 144968 18446744073709551615 4194304 4228012 140734066289824 140168550575120 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18793] ppid=18783 vsize=1039268 CPUtime=2.5
/proc/18786/task/18793/stat : 18793 (java) S 18783 18783 1745 0 -1 4202560 10131 0 0 0 244 6 0 0 20 0 11 0 119935604 1064210432 144968 18446744073709551615 4194304 4228012 140734066289824 140168549522448 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18794] ppid=18783 vsize=1039268 CPUtime=0
/proc/18786/task/18794/stat : 18794 (java) S 18783 18783 1745 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 119935604 1064210432 144968 18446744073709551615 4194304 4228012 140734066289824 140168548469968 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18795] ppid=18783 vsize=1039268 CPUtime=0.02
/proc/18786/task/18795/stat : 18795 (java) S 18783 18783 1745 0 -1 4202560 4 0 0 0 0 2 0 0 20 0 11 0 119935604 1064210432 144968 18446744073709551615 4194304 4228012 140734066289824 140168547417472 140168655627851 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18796] ppid=18783 vsize=1039268 CPUtime=0
/proc/18786/task/18796/stat : 18796 (java) S 18783 18783 1745 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 119936902 1064210432 144968 18446744073709551615 4194304 4228012 140734066289824 140168546223968 140168655627851 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 31.37
Current children cumulated vsize (KiB) 1048436

[startup+38.5008 s]
/proc/loadavg: 1.24 1.13 1.11 2/76 18796
/proc/meminfo: memFree=10116/1022884 swapFree=0/0
[pid=18783] ppid=18782 vsize=9168 CPUtime=0
/proc/18783/stat : 18783 (p2cudf-full-1.1) S 18782 18783 1745 0 -1 4202496 456 291 2 1 0 0 0 0 20 0 1 0 119935577 9388032 330 18446744073709551615 4194304 5129932 140734802736720 140734802734864 140464820835422 0 65536 16781316 65538 0 0 0 17 0 0 0 3 0 0
/proc/18783/statm: 2292 330 280 229 0 52 0
[pid=18786] ppid=18783 vsize=1039268 CPUtime=37.66
/proc/18786/stat : 18786 (java) S 18783 18783 1745 0 -1 4202496 164384 0 20 0 3702 64 0 0 20 0 11 0 119935583 1064210432 155366 18446744073709551615 4194304 4228012 140734066289824 140734066280848 140168655613557 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 5 0 0
/proc/18786/statm: 259817 155366 2393 9 0 247167 0
[pid=18786/tid=18787] ppid=18783 vsize=1039268 CPUtime=28.84
/proc/18786/task/18787/stat : 18787 (java) R 18783 18783 1745 0 -1 4202560 47803 0 8 0 2862 22 0 0 20 0 11 0 119935589 1064210432 155366 18446744073709551615 4194304 4228012 140734066289824 140168662147080 140168560742620 0 4 0 16800975 0 0 0 -1 0 0 0 21 0 0
[pid=18786/tid=18788] ppid=18783 vsize=1039268 CPUtime=3.56
/proc/18786/task/18788/stat : 18788 (java) S 18783 18783 1745 0 -1 4202560 94111 0 0 0 325 31 0 0 20 0 11 0 119935600 1064210432 155366 18446744073709551615 4194304 4228012 140734066289824 140168554785920 140168655627851 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18789] ppid=18783 vsize=1039268 CPUtime=0
/proc/18786/task/18789/stat : 18789 (java) S 18783 18783 1745 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 119935601 1064210432 155366 18446744073709551615 4194304 4228012 140734066289824 140168553732112 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18790] ppid=18783 vsize=1039268 CPUtime=0
/proc/18786/task/18790/stat : 18790 (java) S 18783 18783 1745 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 119935601 1064210432 155366 18446744073709551615 4194304 4228012 140734066289824 140168552679328 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18791] ppid=18783 vsize=1039268 CPUtime=0
/proc/18786/task/18791/stat : 18791 (java) S 18783 18783 1745 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 119935604 1064210432 155366 18446744073709551615 4194304 4228012 140734066289824 140168551627760 140168655635488 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18792] ppid=18783 vsize=1039268 CPUtime=2.71
/proc/18786/task/18792/stat : 18792 (java) S 18783 18783 1745 0 -1 4202560 11044 0 0 0 267 4 0 0 20 0 11 0 119935604 1064210432 155366 18446744073709551615 4194304 4228012 140734066289824 140168550575120 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18793] ppid=18783 vsize=1039268 CPUtime=2.5
/proc/18786/task/18793/stat : 18793 (java) S 18783 18783 1745 0 -1 4202560 10131 0 0 0 244 6 0 0 20 0 11 0 119935604 1064210432 155366 18446744073709551615 4194304 4228012 140734066289824 140168549522448 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18794] ppid=18783 vsize=1039268 CPUtime=0
/proc/18786/task/18794/stat : 18794 (java) S 18783 18783 1745 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 119935604 1064210432 155366 18446744073709551615 4194304 4228012 140734066289824 140168548469968 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18795] ppid=18783 vsize=1039268 CPUtime=0.02
/proc/18786/task/18795/stat : 18795 (java) S 18783 18783 1745 0 -1 4202560 7 0 0 0 0 2 0 0 20 0 11 0 119935604 1064210432 155366 18446744073709551615 4194304 4228012 140734066289824 140168547417472 140168655627851 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18796] ppid=18783 vsize=1039268 CPUtime=0
/proc/18786/task/18796/stat : 18796 (java) S 18783 18783 1745 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 119936902 1064210432 155366 18446744073709551615 4194304 4228012 140734066289824 140168546223968 140168655627851 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 37.66
Current children cumulated vsize (KiB) 1048436

[startup+41.7007 s]
/proc/loadavg: 1.22 1.13 1.11 2/76 18796
/proc/meminfo: memFree=10116/1022884 swapFree=0/0
[pid=18783] ppid=18782 vsize=9168 CPUtime=0
/proc/18783/stat : 18783 (p2cudf-full-1.1) S 18782 18783 1745 0 -1 4202496 456 291 2 1 0 0 0 0 20 0 1 0 119935577 9388032 330 18446744073709551615 4194304 5129932 140734802736720 140734802734864 140464820835422 0 65536 16781316 65538 0 0 0 17 0 0 0 3 0 0
/proc/18783/statm: 2292 330 280 229 0 52 0
[pid=18786] ppid=18783 vsize=1039268 CPUtime=40.81
/proc/18786/stat : 18786 (java) S 18783 18783 1745 0 -1 4202496 164388 0 20 0 4017 64 0 0 20 0 11 0 119935583 1064210432 155370 18446744073709551615 4194304 4228012 140734066289824 140734066280848 140168655613557 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 5 0 0
/proc/18786/statm: 259817 155370 2393 9 0 247167 0
[pid=18786/tid=18787] ppid=18783 vsize=1039268 CPUtime=31.94
/proc/18786/task/18787/stat : 18787 (java) R 18783 18783 1745 0 -1 4202560 47803 0 8 0 3172 22 0 0 20 0 11 0 119935589 1064210432 155370 18446744073709551615 4194304 4228012 140734066289824 140168662145416 140168560971498 0 4 0 16800975 0 0 0 -1 0 0 0 21 0 0
[pid=18786/tid=18788] ppid=18783 vsize=1039268 CPUtime=3.56
/proc/18786/task/18788/stat : 18788 (java) S 18783 18783 1745 0 -1 4202560 94111 0 0 0 325 31 0 0 20 0 11 0 119935600 1064210432 155370 18446744073709551615 4194304 4228012 140734066289824 140168554785920 140168655627851 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18789] ppid=18783 vsize=1039268 CPUtime=0
/proc/18786/task/18789/stat : 18789 (java) S 18783 18783 1745 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 119935601 1064210432 155370 18446744073709551615 4194304 4228012 140734066289824 140168553732112 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18790] ppid=18783 vsize=1039268 CPUtime=0
/proc/18786/task/18790/stat : 18790 (java) S 18783 18783 1745 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 119935601 1064210432 155370 18446744073709551615 4194304 4228012 140734066289824 140168552679328 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18791] ppid=18783 vsize=1039268 CPUtime=0
/proc/18786/task/18791/stat : 18791 (java) S 18783 18783 1745 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 119935604 1064210432 155370 18446744073709551615 4194304 4228012 140734066289824 140168551627760 140168655635488 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18792] ppid=18783 vsize=1039268 CPUtime=2.74
/proc/18786/task/18792/stat : 18792 (java) S 18783 18783 1745 0 -1 4202560 11048 0 0 0 270 4 0 0 20 0 11 0 119935604 1064210432 155370 18446744073709551615 4194304 4228012 140734066289824 140168550575120 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18793] ppid=18783 vsize=1039268 CPUtime=2.5
/proc/18786/task/18793/stat : 18793 (java) S 18783 18783 1745 0 -1 4202560 10131 0 0 0 244 6 0 0 20 0 11 0 119935604 1064210432 155370 18446744073709551615 4194304 4228012 140734066289824 140168549522448 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18794] ppid=18783 vsize=1039268 CPUtime=0
/proc/18786/task/18794/stat : 18794 (java) S 18783 18783 1745 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 119935604 1064210432 155370 18446744073709551615 4194304 4228012 140734066289824 140168548469968 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18795] ppid=18783 vsize=1039268 CPUtime=0.02
/proc/18786/task/18795/stat : 18795 (java) S 18783 18783 1745 0 -1 4202560 7 0 0 0 0 2 0 0 20 0 11 0 119935604 1064210432 155370 18446744073709551615 4194304 4228012 140734066289824 140168547417472 140168655627851 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18796] ppid=18783 vsize=1039268 CPUtime=0
/proc/18786/task/18796/stat : 18796 (java) S 18783 18783 1745 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 119936902 1064210432 155370 18446744073709551615 4194304 4228012 140734066289824 140168546223968 140168655627851 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 40.81
Current children cumulated vsize (KiB) 1048436

[startup+42.5008 s]
/proc/loadavg: 1.22 1.13 1.11 2/76 18796
/proc/meminfo: memFree=10116/1022884 swapFree=0/0
[pid=18783] ppid=18782 vsize=9168 CPUtime=0
/proc/18783/stat : 18783 (p2cudf-full-1.1) S 18782 18783 1745 0 -1 4202496 456 291 2 1 0 0 0 0 20 0 1 0 119935577 9388032 330 18446744073709551615 4194304 5129932 140734802736720 140734802734864 140464820835422 0 65536 16781316 65538 0 0 0 17 0 0 0 3 0 0
/proc/18783/statm: 2292 330 280 229 0 52 0
[pid=18786] ppid=18783 vsize=1039268 CPUtime=41.6
/proc/18786/stat : 18786 (java) S 18783 18783 1745 0 -1 4202496 164389 0 20 0 4096 64 0 0 20 0 11 0 119935583 1064210432 155371 18446744073709551615 4194304 4228012 140734066289824 140734066280848 140168655613557 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 5 0 0
/proc/18786/statm: 259817 155371 2393 9 0 247167 0
[pid=18786/tid=18787] ppid=18783 vsize=1039268 CPUtime=32.73
/proc/18786/task/18787/stat : 18787 (java) R 18783 18783 1745 0 -1 4202560 47804 0 8 0 3251 22 0 0 20 0 11 0 119935589 1064210432 155371 18446744073709551615 4194304 4228012 140734066289824 140168662138784 140168560979053 0 4 0 16800975 0 0 0 -1 0 0 0 21 0 0
[pid=18786/tid=18788] ppid=18783 vsize=1039268 CPUtime=3.56
/proc/18786/task/18788/stat : 18788 (java) S 18783 18783 1745 0 -1 4202560 94111 0 0 0 325 31 0 0 20 0 11 0 119935600 1064210432 155371 18446744073709551615 4194304 4228012 140734066289824 140168554785920 140168655627851 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18789] ppid=18783 vsize=1039268 CPUtime=0
/proc/18786/task/18789/stat : 18789 (java) S 18783 18783 1745 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 119935601 1064210432 155371 18446744073709551615 4194304 4228012 140734066289824 140168553732112 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18790] ppid=18783 vsize=1039268 CPUtime=0
/proc/18786/task/18790/stat : 18790 (java) S 18783 18783 1745 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 119935601 1064210432 155371 18446744073709551615 4194304 4228012 140734066289824 140168552679328 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18791] ppid=18783 vsize=1039268 CPUtime=0
/proc/18786/task/18791/stat : 18791 (java) S 18783 18783 1745 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 119935604 1064210432 155371 18446744073709551615 4194304 4228012 140734066289824 140168551627760 140168655635488 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18792] ppid=18783 vsize=1039268 CPUtime=2.74
/proc/18786/task/18792/stat : 18792 (java) S 18783 18783 1745 0 -1 4202560 11048 0 0 0 270 4 0 0 20 0 11 0 119935604 1064210432 155371 18446744073709551615 4194304 4228012 140734066289824 140168550575120 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18793] ppid=18783 vsize=1039268 CPUtime=2.5
/proc/18786/task/18793/stat : 18793 (java) S 18783 18783 1745 0 -1 4202560 10131 0 0 0 244 6 0 0 20 0 11 0 119935604 1064210432 155371 18446744073709551615 4194304 4228012 140734066289824 140168549522448 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18794] ppid=18783 vsize=1039268 CPUtime=0
/proc/18786/task/18794/stat : 18794 (java) S 18783 18783 1745 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 119935604 1064210432 155371 18446744073709551615 4194304 4228012 140734066289824 140168548469968 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18795] ppid=18783 vsize=1039268 CPUtime=0.02
/proc/18786/task/18795/stat : 18795 (java) S 18783 18783 1745 0 -1 4202560 7 0 0 0 0 2 0 0 20 0 11 0 119935604 1064210432 155371 18446744073709551615 4194304 4228012 140734066289824 140168547417472 140168655627851 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18796] ppid=18783 vsize=1039268 CPUtime=0
/proc/18786/task/18796/stat : 18796 (java) S 18783 18783 1745 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 119936902 1064210432 155371 18446744073709551615 4194304 4228012 140734066289824 140168546223968 140168655627851 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 41.6
Current children cumulated vsize (KiB) 1048436

[startup+42.9008 s]
/proc/loadavg: 1.22 1.13 1.11 2/76 18796
/proc/meminfo: memFree=10116/1022884 swapFree=0/0
[pid=18783] ppid=18782 vsize=9168 CPUtime=0
/proc/18783/stat : 18783 (p2cudf-full-1.1) S 18782 18783 1745 0 -1 4202496 456 291 2 1 0 0 0 0 20 0 1 0 119935577 9388032 330 18446744073709551615 4194304 5129932 140734802736720 140734802734864 140464820835422 0 65536 16781316 65538 0 0 0 17 0 0 0 3 0 0
/proc/18783/statm: 2292 330 280 229 0 52 0
[pid=18786] ppid=18783 vsize=1040296 CPUtime=41.93
/proc/18786/stat : 18786 (java) S 18783 18783 1745 0 -1 4202496 164404 0 20 0 4129 64 0 0 20 0 11 0 119935583 1065263104 155384 18446744073709551615 4194304 4228012 140734066289824 140734066280848 140168655613557 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 5 0 0
/proc/18786/statm: 260074 155384 2393 9 0 247424 0
[pid=18786/tid=18787] ppid=18783 vsize=1040296 CPUtime=33.01
/proc/18786/task/18787/stat : 18787 (java) S 18783 18783 1745 0 -1 4202560 47812 0 8 0 3279 22 0 0 20 0 11 0 119935589 1065263104 155384 18446744073709551615 4194304 4228012 140734066289824 140168662148016 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 21 0 0
[pid=18786/tid=18788] ppid=18783 vsize=1040296 CPUtime=3.56
/proc/18786/task/18788/stat : 18788 (java) S 18783 18783 1745 0 -1 4202560 94111 0 0 0 325 31 0 0 20 0 11 0 119935600 1065263104 155384 18446744073709551615 4194304 4228012 140734066289824 140168554785920 140168655627851 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18789] ppid=18783 vsize=1040296 CPUtime=0
/proc/18786/task/18789/stat : 18789 (java) S 18783 18783 1745 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 119935601 1065263104 155384 18446744073709551615 4194304 4228012 140734066289824 140168553732112 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18790] ppid=18783 vsize=1040296 CPUtime=0
/proc/18786/task/18790/stat : 18790 (java) S 18783 18783 1745 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 119935601 1065263104 155384 18446744073709551615 4194304 4228012 140734066289824 140168552679328 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18791] ppid=18783 vsize=1040296 CPUtime=0
/proc/18786/task/18791/stat : 18791 (java) S 18783 18783 1745 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 119935604 1065263104 155384 18446744073709551615 4194304 4228012 140734066289824 140168551627760 140168655635488 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18792] ppid=18783 vsize=1040296 CPUtime=2.76
/proc/18786/task/18792/stat : 18792 (java) S 18783 18783 1745 0 -1 4202560 11048 0 0 0 272 4 0 0 20 0 11 0 119935604 1065263104 155384 18446744073709551615 4194304 4228012 140734066289824 140168550575120 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18793] ppid=18783 vsize=1040296 CPUtime=2.54
/proc/18786/task/18793/stat : 18793 (java) S 18783 18783 1745 0 -1 4202560 10132 0 0 0 248 6 0 0 20 0 11 0 119935604 1065263104 155384 18446744073709551615 4194304 4228012 140734066289824 140168549522448 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18794] ppid=18783 vsize=1040296 CPUtime=0
/proc/18786/task/18794/stat : 18794 (java) S 18783 18783 1745 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 119935604 1065263104 155384 18446744073709551615 4194304 4228012 140734066289824 140168548469968 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18795] ppid=18783 vsize=1040296 CPUtime=0.02
/proc/18786/task/18795/stat : 18795 (java) S 18783 18783 1745 0 -1 4202560 7 0 0 0 0 2 0 0 20 0 11 0 119935604 1065263104 155384 18446744073709551615 4194304 4228012 140734066289824 140168547417472 140168655627851 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 41.93
Current children cumulated vsize (KiB) 1049464

[startup+43.3009 s]
/proc/loadavg: 1.22 1.13 1.11 1/76 18797
/proc/meminfo: memFree=9992/1022884 swapFree=0/0
[pid=18783] ppid=18782 vsize=9168 CPUtime=0
/proc/18783/stat : 18783 (p2cudf-full-1.1) S 18782 18783 1745 0 -1 4202496 456 291 2 1 0 0 0 0 20 0 1 0 119935577 9388032 330 18446744073709551615 4194304 5129932 140734802736720 140734802734864 140464820835422 0 65536 16781316 65538 0 0 0 17 0 0 0 3 0 0
/proc/18783/statm: 2292 330 280 229 0 52 0
[pid=18786] ppid=18783 vsize=1040296 CPUtime=41.93
/proc/18786/stat : 18786 (java) S 18783 18783 1745 0 -1 4202496 164404 0 20 0 4129 64 0 0 20 0 11 0 119935583 1065263104 155384 18446744073709551615 4194304 4228012 140734066289824 140734066280848 140168655613557 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 5 0 0
/proc/18786/statm: 260074 155384 2393 9 0 247424 0
[pid=18786/tid=18787] ppid=18783 vsize=1040296 CPUtime=33.01
/proc/18786/task/18787/stat : 18787 (java) S 18783 18783 1745 0 -1 4202560 47812 0 8 0 3279 22 0 0 20 0 11 0 119935589 1065263104 155384 18446744073709551615 4194304 4228012 140734066289824 140168662148016 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 21 0 0
[pid=18786/tid=18788] ppid=18783 vsize=1040296 CPUtime=3.56
/proc/18786/task/18788/stat : 18788 (java) S 18783 18783 1745 0 -1 4202560 94111 0 0 0 325 31 0 0 20 0 11 0 119935600 1065263104 155384 18446744073709551615 4194304 4228012 140734066289824 140168554785920 140168655627851 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18789] ppid=18783 vsize=1040296 CPUtime=0
/proc/18786/task/18789/stat : 18789 (java) S 18783 18783 1745 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 119935601 1065263104 155384 18446744073709551615 4194304 4228012 140734066289824 140168553732112 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18790] ppid=18783 vsize=1040296 CPUtime=0
/proc/18786/task/18790/stat : 18790 (java) S 18783 18783 1745 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 119935601 1065263104 155384 18446744073709551615 4194304 4228012 140734066289824 140168552679328 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18791] ppid=18783 vsize=1040296 CPUtime=0
/proc/18786/task/18791/stat : 18791 (java) S 18783 18783 1745 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 119935604 1065263104 155384 18446744073709551615 4194304 4228012 140734066289824 140168551627760 140168655635488 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18792] ppid=18783 vsize=1040296 CPUtime=2.76
/proc/18786/task/18792/stat : 18792 (java) S 18783 18783 1745 0 -1 4202560 11048 0 0 0 272 4 0 0 20 0 11 0 119935604 1065263104 155384 18446744073709551615 4194304 4228012 140734066289824 140168550575120 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18793] ppid=18783 vsize=1040296 CPUtime=2.54
/proc/18786/task/18793/stat : 18793 (java) S 18783 18783 1745 0 -1 4202560 10132 0 0 0 248 6 0 0 20 0 11 0 119935604 1065263104 155384 18446744073709551615 4194304 4228012 140734066289824 140168549522448 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18794] ppid=18783 vsize=1040296 CPUtime=0
/proc/18786/task/18794/stat : 18794 (java) S 18783 18783 1745 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 119935604 1065263104 155384 18446744073709551615 4194304 4228012 140734066289824 140168548469968 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18795] ppid=18783 vsize=1040296 CPUtime=0.02
/proc/18786/task/18795/stat : 18795 (java) S 18783 18783 1745 0 -1 4202560 7 0 0 0 0 2 0 0 20 0 11 0 119935604 1065263104 155384 18446744073709551615 4194304 4228012 140734066289824 140168547417472 140168655627851 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18797] ppid=18783 vsize=1040296 CPUtime=0
/proc/18786/task/18797/stat : 18797 (java) S 18783 18783 1745 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 119939858 1065263104 155384 18446744073709551615 4194304 4228012 140734066289824 140168545171632 140168655627851 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 41.93
Current children cumulated vsize (KiB) 1049464

[startup+43.401 s]
/proc/loadavg: 1.22 1.13 1.11 1/76 18797
/proc/meminfo: memFree=9992/1022884 swapFree=0/0
[pid=18783] ppid=18782 vsize=9168 CPUtime=0
/proc/18783/stat : 18783 (p2cudf-full-1.1) S 18782 18783 1745 0 -1 4202496 456 291 2 1 0 0 0 0 20 0 1 0 119935577 9388032 330 18446744073709551615 4194304 5129932 140734802736720 140734802734864 140464820835422 0 65536 16781316 65538 0 0 0 17 0 0 0 3 0 0
/proc/18783/statm: 2292 330 280 229 0 52 0
[pid=18786] ppid=18783 vsize=1040296 CPUtime=42.02
/proc/18786/stat : 18786 (java) S 18783 18783 1745 0 -1 4202496 164409 0 20 0 4135 67 0 0 20 0 11 0 119935583 1065263104 155389 18446744073709551615 4194304 4228012 140734066289824 140734066280848 140168655613557 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 5 0 0
/proc/18786/statm: 260074 155389 2393 9 0 247424 0
[pid=18786/tid=18787] ppid=18783 vsize=1040296 CPUtime=33.01
/proc/18786/task/18787/stat : 18787 (java) S 18783 18783 1745 0 -1 4202560 47812 0 8 0 3279 22 0 0 20 0 11 0 119935589 1065263104 155389 18446744073709551615 4194304 4228012 140734066289824 140168662148016 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 21 0 0
[pid=18786/tid=18788] ppid=18783 vsize=1040296 CPUtime=3.56
/proc/18786/task/18788/stat : 18788 (java) S 18783 18783 1745 0 -1 4202560 94111 0 0 0 325 31 0 0 20 0 11 0 119935600 1065263104 155389 18446744073709551615 4194304 4228012 140734066289824 140168554785920 140168655627851 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18789] ppid=18783 vsize=1040296 CPUtime=0
/proc/18786/task/18789/stat : 18789 (java) S 18783 18783 1745 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 119935601 1065263104 155389 18446744073709551615 4194304 4228012 140734066289824 140168553732112 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18790] ppid=18783 vsize=1040296 CPUtime=0
/proc/18786/task/18790/stat : 18790 (java) S 18783 18783 1745 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 119935601 1065263104 155389 18446744073709551615 4194304 4228012 140734066289824 140168552679328 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18791] ppid=18783 vsize=1040296 CPUtime=0
/proc/18786/task/18791/stat : 18791 (java) S 18783 18783 1745 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 119935604 1065263104 155389 18446744073709551615 4194304 4228012 140734066289824 140168551627760 140168655635488 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18792] ppid=18783 vsize=1040296 CPUtime=2.77
/proc/18786/task/18792/stat : 18792 (java) S 18783 18783 1745 0 -1 4202560 11048 0 0 0 273 4 0 0 20 0 11 0 119935604 1065263104 155389 18446744073709551615 4194304 4228012 140734066289824 140168550575120 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18793] ppid=18783 vsize=1040296 CPUtime=2.54
/proc/18786/task/18793/stat : 18793 (java) S 18783 18783 1745 0 -1 4202560 10134 0 0 0 248 6 0 0 20 0 11 0 119935604 1065263104 155389 18446744073709551615 4194304 4228012 140734066289824 140168549522448 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18794] ppid=18783 vsize=1040296 CPUtime=0
/proc/18786/task/18794/stat : 18794 (java) S 18783 18783 1745 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 119935604 1065263104 155389 18446744073709551615 4194304 4228012 140734066289824 140168548469968 140168655626964 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18795] ppid=18783 vsize=1040296 CPUtime=0.02
/proc/18786/task/18795/stat : 18795 (java) S 18783 18783 1745 0 -1 4202560 7 0 0 0 0 2 0 0 20 0 11 0 119935604 1065263104 155389 18446744073709551615 4194304 4228012 140734066289824 140168547417472 140168655627851 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
[pid=18786/tid=18797] ppid=18783 vsize=1040296 CPUtime=0.07
/proc/18786/task/18797/stat : 18797 (java) R 18783 18783 1745 0 -1 4202560 9 0 0 0 4 3 0 0 20 0 11 0 119939858 1065263104 155389 18446744073709551615 4194304 4228012 140734066289824 140168545162432 140168559777252 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0
Current children cumulated CPU time (s) 42.02
Current children cumulated vsize (KiB) 1049464

Child status: 0
Real time (s): 43.4819
CPU time (s): 42.1106
CPU user time (s): 41.3906
CPU system time (s): 0.720045
CPU usage (%): 96.8465
Max. virtual memory (cumulated for all children) (KiB): 1060880

getrusage(RUSAGE_CHILDREN,...) data:
user time used= 41.3906
system time used= 0.720045
maximum resident set size= 621588
integral shared memory size= 0
integral unshared data size= 0
integral unshared stack size= 0
page reclaims= 165178
page faults= 23
swaps= 0
block input operations= 70832
block output operations= 256
messages sent= 0
messages received= 0
signals received= 0
voluntary context switches= 2091
involuntary context switches= 7831

runsolver used 0.180011 second user time and 0.304019 second system time

The end