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/install/rand446.cudf.log.runsolver /home/competition/p2cudf-full-1.15/p2cudf-full-1.15 /home/competition/data/install/rand446.cudf /tmp/misc2012/2012-09-02-22:42/full/p2cudf-full-1.15/trendy-size/install/rand446.cudf.result -count(removed),-sum(solution,installedsize),-notuptodate(solution),-unsat_recommends(solution),-count(new) Enforcing CPUTime limit (soft limit, will send signal-name then SIGKILL): 300 seconds Enforcing CPUTime limit (hard limit, will send SIGXCPU): 330 seconds Enforcing VSIZE limit (soft limit, will send signal-name then SIGKILL): 1150976 KiB Enforcing VSIZE limit (hard limit, stack expansion will fail with SIGSEGV, brk() and mmap() will return ENOMEM): 1202176 KiB Current StackSize limit: 8192 KiB [startup+0 s] /proc/loadavg: 1.20 1.07 1.02 2/59 2789 /proc/meminfo: memFree=612924/1022884 swapFree=0/0 [pid=2789] ppid=2788 vsize=9168 CPUtime=0 /proc/2789/stat : 2789 (p2cudf-full-1.1) S 2788 2789 1733 0 -1 4202496 426 0 0 0 0 0 0 0 20 0 1 0 119799998 9388032 326 18446744073709551615 4194304 5129932 140735565507280 140735565504952 139779561461536 0 0 16781316 65536 0 0 0 17 0 0 0 0 0 0 /proc/2789/statm: 2292 326 275 229 0 52 0 [startup+0.128842 s] /proc/loadavg: 1.20 1.07 1.02 2/59 2789 /proc/meminfo: memFree=612924/1022884 swapFree=0/0 [pid=2789] ppid=2788 vsize=9168 CPUtime=0 /proc/2789/stat : 2789 (p2cudf-full-1.1) S 2788 2789 1733 0 -1 4202496 456 291 0 0 0 0 0 0 20 0 1 0 119799998 9388032 331 18446744073709551615 4194304 5129932 140735565507280 140735565505424 139779561317470 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0 /proc/2789/statm: 2292 331 280 229 0 52 0 Current children cumulated CPU time (s) 0 Current children cumulated vsize (KiB) 9168 [startup+0.200312 s] /proc/loadavg: 1.20 1.07 1.02 2/59 2789 /proc/meminfo: memFree=612924/1022884 swapFree=0/0 [pid=2789] ppid=2788 vsize=9168 CPUtime=0 /proc/2789/stat : 2789 (p2cudf-full-1.1) S 2788 2789 1733 0 -1 4202496 456 291 0 0 0 0 0 0 20 0 1 0 119799998 9388032 331 18446744073709551615 4194304 5129932 140735565507280 140735565505424 139779561317470 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0 /proc/2789/statm: 2292 331 280 229 0 52 0 Current children cumulated CPU time (s) 0 Current children cumulated vsize (KiB) 9168 [startup+0.3003 s] /proc/loadavg: 1.20 1.07 1.02 2/59 2789 /proc/meminfo: memFree=612924/1022884 swapFree=0/0 [pid=2789] ppid=2788 vsize=9168 CPUtime=0 /proc/2789/stat : 2789 (p2cudf-full-1.1) S 2788 2789 1733 0 -1 4202496 456 291 0 0 0 0 0 0 20 0 1 0 119799998 9388032 331 18446744073709551615 4194304 5129932 140735565507280 140735565505424 139779561317470 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0 /proc/2789/statm: 2292 331 280 229 0 52 0 Current children cumulated CPU time (s) 0 Current children cumulated vsize (KiB) 9168 [startup+0.70022 s] /proc/loadavg: 1.20 1.07 1.02 2/59 2789 /proc/meminfo: memFree=612924/1022884 swapFree=0/0 [pid=2789] ppid=2788 vsize=9168 CPUtime=0 /proc/2789/stat : 2789 (p2cudf-full-1.1) S 2788 2789 1733 0 -1 4202496 456 291 0 0 0 0 0 0 20 0 1 0 119799998 9388032 331 18446744073709551615 4194304 5129932 140735565507280 140735565505424 139779561317470 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0 /proc/2789/statm: 2292 331 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.20 1.07 1.02 4/70 2801 /proc/meminfo: memFree=561368/1022884 swapFree=0/0 [pid=2789] ppid=2788 vsize=9168 CPUtime=0 /proc/2789/stat : 2789 (p2cudf-full-1.1) S 2788 2789 1733 0 -1 4202496 456 291 0 0 0 0 0 0 20 0 1 0 119799998 9388032 331 18446744073709551615 4194304 5129932 140735565507280 140735565505424 139779561317470 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0 /proc/2789/statm: 2292 331 280 229 0 52 0 [pid=2792] ppid=2789 vsize=1051840 CPUtime=1.45 /proc/2792/stat : 2792 (java) S 2789 2789 1733 0 -1 4202496 34332 0 0 0 135 10 0 0 20 0 10 0 119799999 1077084160 30499 18446744073709551615 4194304 4228012 140736308150208 140736308141232 139863948201589 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0 /proc/2792/statm: 262960 30499 2345 9 0 250310 0 [pid=2792/tid=2793] ppid=2789 vsize=1051840 CPUtime=0.66 /proc/2792/task/2793/stat : 2793 (java) R 2789 2789 1733 0 -1 4202560 14836 0 0 0 62 4 0 0 20 0 10 0 119800000 1077084160 30499 18446744073709551615 4194304 4228012 140736308150208 139863954727584 139863852247266 0 4 0 16800975 0 0 0 -1 0 0 0 2 0 0 [pid=2792/tid=2794] ppid=2789 vsize=1051840 CPUtime=0 /proc/2792/task/2794/stat : 2794 (java) S 2789 2789 1733 0 -1 4202560 4 0 0 0 0 0 0 0 20 0 10 0 119800002 1077084160 30499 18446744073709551615 4194304 4228012 140736308150208 139863847373952 139863948215883 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2795] ppid=2789 vsize=1051840 CPUtime=0 /proc/2792/task/2795/stat : 2795 (java) S 2789 2789 1733 0 -1 4202560 15 0 0 0 0 0 0 0 20 0 10 0 119800003 1077084160 30499 18446744073709551615 4194304 4228012 140736308150208 139863846320144 139863948214996 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2796] ppid=2789 vsize=1051840 CPUtime=0 /proc/2792/task/2796/stat : 2796 (java) S 2789 2789 1733 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 10 0 119800003 1077084160 30499 18446744073709551615 4194304 4228012 140736308150208 139863845267360 139863948214996 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2797] ppid=2789 vsize=1051840 CPUtime=0 /proc/2792/task/2797/stat : 2797 (java) S 2789 2789 1733 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 119800006 1077084160 30499 18446744073709551615 4194304 4228012 140736308150208 139863844215792 139863948223520 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2798] ppid=2789 vsize=1051840 CPUtime=0.39 /proc/2792/task/2798/stat : 2798 (java) R 2789 2789 1733 0 -1 4202560 8961 0 0 0 36 3 0 0 20 0 10 0 119800006 1077084160 30499 18446744073709551615 4194304 4228012 140736308150208 139863843150952 139863931050042 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2799] ppid=2789 vsize=1051840 CPUtime=0.37 /proc/2792/task/2799/stat : 2799 (java) R 2789 2789 1733 0 -1 4202560 9245 0 0 0 35 2 0 0 20 0 10 0 119800006 1077084160 30499 18446744073709551615 4194304 4228012 140736308150208 139863842096696 139863931308160 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2800] ppid=2789 vsize=1051840 CPUtime=0 /proc/2792/task/2800/stat : 2800 (java) S 2789 2789 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 119800006 1077084160 30499 18446744073709551615 4194304 4228012 140736308150208 139863841058000 139863948214996 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2801] ppid=2789 vsize=1051840 CPUtime=0 /proc/2792/task/2801/stat : 2801 (java) S 2789 2789 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 119800007 1077084160 30499 18446744073709551615 4194304 4228012 140736308150208 139863840005504 139863948215883 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 Current children cumulated CPU time (s) 1.45 Current children cumulated vsize (KiB) 1061008 [startup+3.10073 s] /proc/loadavg: 1.20 1.07 1.02 4/70 2801 /proc/meminfo: memFree=456464/1022884 swapFree=0/0 [pid=2789] ppid=2788 vsize=9168 CPUtime=0 /proc/2789/stat : 2789 (p2cudf-full-1.1) S 2788 2789 1733 0 -1 4202496 456 291 0 0 0 0 0 0 20 0 1 0 119799998 9388032 331 18446744073709551615 4194304 5129932 140735565507280 140735565505424 139779561317470 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0 /proc/2789/statm: 2292 331 280 229 0 52 0 [pid=2792] ppid=2789 vsize=1052044 CPUtime=3.03 /proc/2792/stat : 2792 (java) S 2789 2789 1733 0 -1 4202496 76833 0 0 0 278 25 0 0 20 0 10 0 119799999 1077293056 71752 18446744073709551615 4194304 4228012 140736308150208 140736308141232 139863948201589 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0 /proc/2792/statm: 263011 71752 2366 9 0 250361 0 [pid=2792/tid=2793] ppid=2789 vsize=1052044 CPUtime=1.54 /proc/2792/task/2793/stat : 2793 (java) S 2789 2789 1733 0 -1 4202560 47418 0 0 0 139 15 0 0 20 0 10 0 119800000 1077293056 71752 18446744073709551615 4194304 4228012 140736308150208 139863954735632 139863948214996 0 4 0 16800975 0 0 0 -1 0 0 0 2 0 0 [pid=2792/tid=2794] ppid=2789 vsize=1052044 CPUtime=0.17 /proc/2792/task/2794/stat : 2794 (java) R 2789 2789 1733 0 -1 4202560 8363 0 0 0 13 4 0 0 20 0 10 0 119800002 1077293056 71752 18446744073709551615 4194304 4228012 140736308150208 139863847373328 139863931739994 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2795] ppid=2789 vsize=1052044 CPUtime=0 /proc/2792/task/2795/stat : 2795 (java) S 2789 2789 1733 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 10 0 119800003 1077293056 71752 18446744073709551615 4194304 4228012 140736308150208 139863846320144 139863948214996 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2796] ppid=2789 vsize=1052044 CPUtime=0 /proc/2792/task/2796/stat : 2796 (java) S 2789 2789 1733 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 10 0 119800003 1077293056 71752 18446744073709551615 4194304 4228012 140736308150208 139863845267360 139863948214996 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2797] ppid=2789 vsize=1052044 CPUtime=0 /proc/2792/task/2797/stat : 2797 (java) S 2789 2789 1733 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 119800006 1077293056 71752 18446744073709551615 4194304 4228012 140736308150208 139863844215792 139863948223520 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2798] ppid=2789 vsize=1052044 CPUtime=0.68 /proc/2792/task/2798/stat : 2798 (java) S 2789 2789 1733 0 -1 4202560 9391 0 0 0 65 3 0 0 20 0 10 0 119800006 1077293056 71752 18446744073709551615 4194304 4228012 140736308150208 139863843163152 139863948214996 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2799] ppid=2789 vsize=1052044 CPUtime=0.62 /proc/2792/task/2799/stat : 2799 (java) S 2789 2789 1733 0 -1 4202560 10371 0 0 0 60 2 0 0 20 0 10 0 119800006 1077293056 71752 18446744073709551615 4194304 4228012 140736308150208 139863842110480 139863948214996 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2800] ppid=2789 vsize=1052044 CPUtime=0 /proc/2792/task/2800/stat : 2800 (java) S 2789 2789 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 119800006 1077293056 71752 18446744073709551615 4194304 4228012 140736308150208 139863841058000 139863948214996 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2801] ppid=2789 vsize=1052044 CPUtime=0 /proc/2792/task/2801/stat : 2801 (java) S 2789 2789 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 119800007 1077293056 71752 18446744073709551615 4194304 4228012 140736308150208 139863840005504 139863948215883 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 Current children cumulated CPU time (s) 3.03 Current children cumulated vsize (KiB) 1061212 [startup+6.30074 s] /proc/loadavg: 1.18 1.07 1.02 3/70 2801 /proc/meminfo: memFree=177588/1022884 swapFree=0/0 [pid=2789] ppid=2788 vsize=9168 CPUtime=0 /proc/2789/stat : 2789 (p2cudf-full-1.1) S 2788 2789 1733 0 -1 4202496 456 291 0 0 0 0 0 0 20 0 1 0 119799998 9388032 331 18446744073709551615 4194304 5129932 140735565507280 140735565505424 139779561317470 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0 /proc/2789/statm: 2292 331 280 229 0 52 0 [pid=2792] ppid=2789 vsize=1035900 CPUtime=6.18 /proc/2792/stat : 2792 (java) S 2789 2789 1733 0 -1 4202496 128346 0 0 0 574 44 0 0 20 0 10 0 119799999 1060761600 119609 18446744073709551615 4194304 4228012 140736308150208 140736308141232 139863948201589 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0 /proc/2792/statm: 258975 119609 2367 9 0 246325 0 [pid=2792/tid=2793] ppid=2789 vsize=1035900 CPUtime=3.29 /proc/2792/task/2793/stat : 2793 (java) S 2789 2789 1733 0 -1 4202560 47420 0 0 0 310 19 0 0 20 0 10 0 119800000 1060761600 119609 18446744073709551615 4194304 4228012 140736308150208 139863954735776 139863948214996 0 4 0 16800975 0 0 0 -1 0 0 0 3 0 0 [pid=2792/tid=2794] ppid=2789 vsize=1035900 CPUtime=1.48 /proc/2792/task/2794/stat : 2794 (java) R 2789 2789 1733 0 -1 4202560 59870 0 0 0 130 18 0 0 20 0 10 0 119800002 1060761600 119609 18446744073709551615 4194304 4228012 140736308150208 139863847373328 139863932325161 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2795] ppid=2789 vsize=1035900 CPUtime=0 /proc/2792/task/2795/stat : 2795 (java) S 2789 2789 1733 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 10 0 119800003 1060761600 119609 18446744073709551615 4194304 4228012 140736308150208 139863846320144 139863948214996 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2796] ppid=2789 vsize=1035900 CPUtime=0 /proc/2792/task/2796/stat : 2796 (java) S 2789 2789 1733 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 10 0 119800003 1060761600 119609 18446744073709551615 4194304 4228012 140736308150208 139863845267360 139863948214996 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2797] ppid=2789 vsize=1035900 CPUtime=0 /proc/2792/task/2797/stat : 2797 (java) S 2789 2789 1733 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 119800006 1060761600 119609 18446744073709551615 4194304 4228012 140736308150208 139863844215792 139863948223520 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2798] ppid=2789 vsize=1035900 CPUtime=0.71 /proc/2792/task/2798/stat : 2798 (java) S 2789 2789 1733 0 -1 4202560 9391 0 0 0 68 3 0 0 20 0 10 0 119800006 1060761600 119609 18446744073709551615 4194304 4228012 140736308150208 139863843163152 139863948214996 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2799] ppid=2789 vsize=1035900 CPUtime=0.66 /proc/2792/task/2799/stat : 2799 (java) S 2789 2789 1733 0 -1 4202560 10374 0 0 0 64 2 0 0 20 0 10 0 119800006 1060761600 119609 18446744073709551615 4194304 4228012 140736308150208 139863842110480 139863948214996 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2800] ppid=2789 vsize=1035900 CPUtime=0 /proc/2792/task/2800/stat : 2800 (java) S 2789 2789 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 119800006 1060761600 119609 18446744073709551615 4194304 4228012 140736308150208 139863841058000 139863948214996 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2801] ppid=2789 vsize=1035900 CPUtime=0 /proc/2792/task/2801/stat : 2801 (java) S 2789 2789 1733 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 119800007 1060761600 119609 18446744073709551615 4194304 4228012 140736308150208 139863840005504 139863948215883 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 Current children cumulated CPU time (s) 6.18 Current children cumulated vsize (KiB) 1045068 [startup+12.7008 s] /proc/loadavg: 1.24 1.09 1.02 4/70 2801 /proc/meminfo: memFree=10104/1022884 swapFree=0/0 [pid=2789] ppid=2788 vsize=9168 CPUtime=0 /proc/2789/stat : 2789 (p2cudf-full-1.1) S 2788 2789 1733 0 -1 4202496 456 291 0 0 0 0 0 0 20 0 1 0 119799998 9388032 331 18446744073709551615 4194304 5129932 140735565507280 140735565505424 139779561317470 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0 /proc/2789/statm: 2292 331 280 229 0 52 0 [pid=2792] ppid=2789 vsize=1052712 CPUtime=12.45 /proc/2792/stat : 2792 (java) S 2789 2789 1733 0 -1 4202496 156779 0 0 0 1188 57 0 0 20 0 10 0 119799999 1077977088 148032 18446744073709551615 4194304 4228012 140736308150208 140736308141232 139863948201589 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0 /proc/2792/statm: 263178 148032 2374 9 0 250528 0 [pid=2792/tid=2793] ppid=2789 vsize=1052712 CPUtime=5.91 /proc/2792/task/2793/stat : 2793 (java) R 2789 2789 1733 0 -1 4202560 47725 0 0 0 570 21 0 0 20 0 10 0 119800000 1077977088 148032 18446744073709551615 4194304 4228012 140736308150208 139863954735352 139863852237029 0 4 0 16800975 0 0 0 -1 0 0 0 4 0 0 [pid=2792/tid=2794] ppid=2789 vsize=1052712 CPUtime=2.16 /proc/2792/task/2794/stat : 2794 (java) S 2789 2789 1733 0 -1 4202560 83667 0 0 0 189 27 0 0 20 0 10 0 119800002 1077977088 148032 18446744073709551615 4194304 4228012 140736308150208 139863847373952 139863948215883 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2795] ppid=2789 vsize=1052712 CPUtime=0 /proc/2792/task/2795/stat : 2795 (java) S 2789 2789 1733 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 10 0 119800003 1077977088 148032 18446744073709551615 4194304 4228012 140736308150208 139863846320144 139863948214996 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2796] ppid=2789 vsize=1052712 CPUtime=0 /proc/2792/task/2796/stat : 2796 (java) S 2789 2789 1733 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 10 0 119800003 1077977088 148032 18446744073709551615 4194304 4228012 140736308150208 139863845267360 139863948214996 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2797] ppid=2789 vsize=1052712 CPUtime=0 /proc/2792/task/2797/stat : 2797 (java) S 2789 2789 1733 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 119800006 1077977088 148032 18446744073709551615 4194304 4228012 140736308150208 139863844215792 139863948223520 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2798] ppid=2789 vsize=1052712 CPUtime=2.14 /proc/2792/task/2798/stat : 2798 (java) R 2789 2789 1733 0 -1 4202560 13557 0 0 0 208 6 0 0 20 0 10 0 119800006 1077977088 148032 18446744073709551615 4194304 4228012 140736308150208 139863843148856 139863932504951 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2799] ppid=2789 vsize=1052712 CPUtime=2.21 /proc/2792/task/2799/stat : 2799 (java) R 2789 2789 1733 0 -1 4202560 10533 0 0 0 218 3 0 0 20 0 10 0 119800006 1077977088 148032 18446744073709551615 4194304 4228012 140736308150208 139863842110224 139863933863307 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2800] ppid=2789 vsize=1052712 CPUtime=0 /proc/2792/task/2800/stat : 2800 (java) S 2789 2789 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 119800006 1077977088 148032 18446744073709551615 4194304 4228012 140736308150208 139863841058000 139863948214996 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2801] ppid=2789 vsize=1052712 CPUtime=0 /proc/2792/task/2801/stat : 2801 (java) S 2789 2789 1733 0 -1 4202560 7 0 0 0 0 0 0 0 20 0 10 0 119800007 1077977088 148032 18446744073709551615 4194304 4228012 140736308150208 139863840005504 139863948215883 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 Current children cumulated CPU time (s) 12.45 Current children cumulated vsize (KiB) 1061880 Solver just ended. Dumping a history of the last processes samples [startup+12.801 s] /proc/loadavg: 1.24 1.09 1.02 4/70 2801 /proc/meminfo: memFree=10104/1022884 swapFree=0/0 [pid=2789] ppid=2788 vsize=9168 CPUtime=0 /proc/2789/stat : 2789 (p2cudf-full-1.1) S 2788 2789 1733 0 -1 4202496 456 291 0 0 0 0 0 0 20 0 1 0 119799998 9388032 331 18446744073709551615 4194304 5129932 140735565507280 140735565505424 139779561317470 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0 /proc/2789/statm: 2292 331 280 229 0 52 0 [pid=2792] ppid=2789 vsize=1052712 CPUtime=12.55 /proc/2792/stat : 2792 (java) S 2789 2789 1733 0 -1 4202496 156779 0 0 0 1198 57 0 0 20 0 10 0 119799999 1077977088 148032 18446744073709551615 4194304 4228012 140736308150208 140736308141232 139863948201589 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0 /proc/2792/statm: 263178 148032 2374 9 0 250528 0 [pid=2792/tid=2793] ppid=2789 vsize=1052712 CPUtime=5.94 /proc/2792/task/2793/stat : 2793 (java) R 2789 2789 1733 0 -1 4202560 47725 0 0 0 573 21 0 0 20 0 10 0 119800000 1077977088 148032 18446744073709551615 4194304 4228012 140736308150208 139863954735352 139863852939740 0 4 0 16800975 0 0 0 -1 0 0 0 4 0 0 [pid=2792/tid=2794] ppid=2789 vsize=1052712 CPUtime=2.16 /proc/2792/task/2794/stat : 2794 (java) S 2789 2789 1733 0 -1 4202560 83667 0 0 0 189 27 0 0 20 0 10 0 119800002 1077977088 148032 18446744073709551615 4194304 4228012 140736308150208 139863847373952 139863948215883 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2795] ppid=2789 vsize=1052712 CPUtime=0 /proc/2792/task/2795/stat : 2795 (java) S 2789 2789 1733 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 10 0 119800003 1077977088 148032 18446744073709551615 4194304 4228012 140736308150208 139863846320144 139863948214996 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2796] ppid=2789 vsize=1052712 CPUtime=0 /proc/2792/task/2796/stat : 2796 (java) S 2789 2789 1733 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 10 0 119800003 1077977088 148032 18446744073709551615 4194304 4228012 140736308150208 139863845267360 139863948214996 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2797] ppid=2789 vsize=1052712 CPUtime=0 /proc/2792/task/2797/stat : 2797 (java) S 2789 2789 1733 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 10 0 119800006 1077977088 148032 18446744073709551615 4194304 4228012 140736308150208 139863844215792 139863948223520 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2798] ppid=2789 vsize=1052712 CPUtime=2.17 /proc/2792/task/2798/stat : 2798 (java) R 2789 2789 1733 0 -1 4202560 13557 0 0 0 211 6 0 0 20 0 10 0 119800006 1077977088 148032 18446744073709551615 4194304 4228012 140736308150208 139863843148856 139863932506092 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2799] ppid=2789 vsize=1052712 CPUtime=2.24 /proc/2792/task/2799/stat : 2799 (java) R 2789 2789 1733 0 -1 4202560 10533 0 0 0 221 3 0 0 20 0 10 0 119800006 1077977088 148032 18446744073709551615 4194304 4228012 140736308150208 139863842110224 139863933870408 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2800] ppid=2789 vsize=1052712 CPUtime=0 /proc/2792/task/2800/stat : 2800 (java) S 2789 2789 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 10 0 119800006 1077977088 148032 18446744073709551615 4194304 4228012 140736308150208 139863841058000 139863948214996 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2801] ppid=2789 vsize=1052712 CPUtime=0 /proc/2792/task/2801/stat : 2801 (java) S 2789 2789 1733 0 -1 4202560 7 0 0 0 0 0 0 0 20 0 10 0 119800007 1077977088 148032 18446744073709551615 4194304 4228012 140736308150208 139863840005504 139863948215883 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 Current children cumulated CPU time (s) 12.55 Current children cumulated vsize (KiB) 1061880 [startup+19.2006 s] /proc/loadavg: 1.35 1.12 1.03 2/71 2802 /proc/meminfo: memFree=31672/1022884 swapFree=0/0 [pid=2789] ppid=2788 vsize=9168 CPUtime=0 /proc/2789/stat : 2789 (p2cudf-full-1.1) S 2788 2789 1733 0 -1 4202496 456 291 0 0 0 0 0 0 20 0 1 0 119799998 9388032 331 18446744073709551615 4194304 5129932 140735565507280 140735565505424 139779561317470 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0 /proc/2789/statm: 2292 331 280 229 0 52 0 [pid=2792] ppid=2789 vsize=1034716 CPUtime=18.86 /proc/2792/stat : 2792 (java) S 2789 2789 1733 0 -1 4202496 158949 0 0 0 1825 61 0 0 20 0 11 0 119799999 1059549184 143627 18446744073709551615 4194304 4228012 140736308150208 140736308141232 139863948201589 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0 /proc/2792/statm: 258679 143627 2381 9 0 246029 0 [pid=2792/tid=2793] ppid=2789 vsize=1034716 CPUtime=10.94 /proc/2792/task/2793/stat : 2793 (java) R 2789 2789 1733 0 -1 4202560 47806 0 0 0 1072 22 0 0 20 0 11 0 119800000 1059549184 143627 18446744073709551615 4194304 4228012 140736308150208 139863954733160 139863853624661 0 4 0 16800975 0 0 0 -1 0 0 0 4 0 0 [pid=2792/tid=2794] ppid=2789 vsize=1034716 CPUtime=2.18 /proc/2792/task/2794/stat : 2794 (java) S 2789 2789 1733 0 -1 4202560 83668 0 0 0 190 28 0 0 20 0 11 0 119800002 1059549184 143627 18446744073709551615 4194304 4228012 140736308150208 139863847373952 139863948215883 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2795] ppid=2789 vsize=1034716 CPUtime=0 /proc/2792/task/2795/stat : 2795 (java) S 2789 2789 1733 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 119800003 1059549184 143627 18446744073709551615 4194304 4228012 140736308150208 139863846320144 139863948214996 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2796] ppid=2789 vsize=1034716 CPUtime=0 /proc/2792/task/2796/stat : 2796 (java) S 2789 2789 1733 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 119800003 1059549184 143627 18446744073709551615 4194304 4228012 140736308150208 139863845267360 139863948214996 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2797] ppid=2789 vsize=1034716 CPUtime=0 /proc/2792/task/2797/stat : 2797 (java) S 2789 2789 1733 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 119800006 1059549184 143627 18446744073709551615 4194304 4228012 140736308150208 139863844215792 139863948223520 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2798] ppid=2789 vsize=1034716 CPUtime=2.79 /proc/2792/task/2798/stat : 2798 (java) S 2789 2789 1733 0 -1 4202560 13596 0 0 0 273 6 0 0 20 0 11 0 119800006 1059549184 143627 18446744073709551615 4194304 4228012 140736308150208 139863843163152 139863948214996 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2799] ppid=2789 vsize=1034716 CPUtime=2.9 /proc/2792/task/2799/stat : 2799 (java) S 2789 2789 1733 0 -1 4202560 12576 0 0 0 286 4 0 0 20 0 11 0 119800006 1059549184 143627 18446744073709551615 4194304 4228012 140736308150208 139863842110480 139863948214996 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2800] ppid=2789 vsize=1034716 CPUtime=0 /proc/2792/task/2800/stat : 2800 (java) S 2789 2789 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 119800006 1059549184 143627 18446744073709551615 4194304 4228012 140736308150208 139863841058000 139863948214996 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2801] ppid=2789 vsize=1034716 CPUtime=0.02 /proc/2792/task/2801/stat : 2801 (java) S 2789 2789 1733 0 -1 4202560 7 0 0 0 0 2 0 0 20 0 11 0 119800007 1059549184 143627 18446744073709551615 4194304 4228012 140736308150208 139863840005504 139863948215883 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2802] ppid=2789 vsize=1034716 CPUtime=0 /proc/2792/task/2802/stat : 2802 (java) S 2789 2789 1733 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 119801392 1059549184 143627 18446744073709551615 4194304 4228012 140736308150208 139863838799712 139863948215883 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 Current children cumulated CPU time (s) 18.86 Current children cumulated vsize (KiB) 1043884 [startup+20.8006 s] /proc/loadavg: 1.35 1.12 1.03 2/71 2802 /proc/meminfo: memFree=31672/1022884 swapFree=0/0 [pid=2789] ppid=2788 vsize=9168 CPUtime=0 /proc/2789/stat : 2789 (p2cudf-full-1.1) S 2788 2789 1733 0 -1 4202496 456 291 0 0 0 0 0 0 20 0 1 0 119799998 9388032 331 18446744073709551615 4194304 5129932 140735565507280 140735565505424 139779561317470 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0 /proc/2789/statm: 2292 331 280 229 0 52 0 [pid=2792] ppid=2789 vsize=1034716 CPUtime=20.44 /proc/2792/stat : 2792 (java) S 2789 2789 1733 0 -1 4202496 158949 0 0 0 1983 61 0 0 20 0 11 0 119799999 1059549184 143627 18446744073709551615 4194304 4228012 140736308150208 140736308141232 139863948201589 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0 /proc/2792/statm: 258679 143627 2381 9 0 246029 0 [pid=2792/tid=2793] ppid=2789 vsize=1034716 CPUtime=12.52 /proc/2792/task/2793/stat : 2793 (java) R 2789 2789 1733 0 -1 4202560 47806 0 0 0 1230 22 0 0 20 0 11 0 119800000 1059549184 143627 18446744073709551615 4194304 4228012 140736308150208 139863954726816 139863853662437 0 4 0 16800975 0 0 0 -1 0 0 0 4 0 0 [pid=2792/tid=2794] ppid=2789 vsize=1034716 CPUtime=2.18 /proc/2792/task/2794/stat : 2794 (java) S 2789 2789 1733 0 -1 4202560 83668 0 0 0 190 28 0 0 20 0 11 0 119800002 1059549184 143627 18446744073709551615 4194304 4228012 140736308150208 139863847373952 139863948215883 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2795] ppid=2789 vsize=1034716 CPUtime=0 /proc/2792/task/2795/stat : 2795 (java) S 2789 2789 1733 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 119800003 1059549184 143627 18446744073709551615 4194304 4228012 140736308150208 139863846320144 139863948214996 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2796] ppid=2789 vsize=1034716 CPUtime=0 /proc/2792/task/2796/stat : 2796 (java) S 2789 2789 1733 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 119800003 1059549184 143627 18446744073709551615 4194304 4228012 140736308150208 139863845267360 139863948214996 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2797] ppid=2789 vsize=1034716 CPUtime=0 /proc/2792/task/2797/stat : 2797 (java) S 2789 2789 1733 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 119800006 1059549184 143627 18446744073709551615 4194304 4228012 140736308150208 139863844215792 139863948223520 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2798] ppid=2789 vsize=1034716 CPUtime=2.79 /proc/2792/task/2798/stat : 2798 (java) S 2789 2789 1733 0 -1 4202560 13596 0 0 0 273 6 0 0 20 0 11 0 119800006 1059549184 143627 18446744073709551615 4194304 4228012 140736308150208 139863843163152 139863948214996 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2799] ppid=2789 vsize=1034716 CPUtime=2.9 /proc/2792/task/2799/stat : 2799 (java) S 2789 2789 1733 0 -1 4202560 12576 0 0 0 286 4 0 0 20 0 11 0 119800006 1059549184 143627 18446744073709551615 4194304 4228012 140736308150208 139863842110480 139863948214996 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2800] ppid=2789 vsize=1034716 CPUtime=0 /proc/2792/task/2800/stat : 2800 (java) S 2789 2789 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 119800006 1059549184 143627 18446744073709551615 4194304 4228012 140736308150208 139863841058000 139863948214996 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2801] ppid=2789 vsize=1034716 CPUtime=0.02 /proc/2792/task/2801/stat : 2801 (java) S 2789 2789 1733 0 -1 4202560 7 0 0 0 0 2 0 0 20 0 11 0 119800007 1059549184 143627 18446744073709551615 4194304 4228012 140736308150208 139863840005504 139863948215883 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2802] ppid=2789 vsize=1034716 CPUtime=0 /proc/2792/task/2802/stat : 2802 (java) S 2789 2789 1733 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 119801392 1059549184 143627 18446744073709551615 4194304 4228012 140736308150208 139863838799712 139863948215883 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 Current children cumulated CPU time (s) 20.44 Current children cumulated vsize (KiB) 1043884 [startup+21.6006 s] /proc/loadavg: 1.35 1.12 1.03 2/71 2802 /proc/meminfo: memFree=31672/1022884 swapFree=0/0 [pid=2789] ppid=2788 vsize=9168 CPUtime=0 /proc/2789/stat : 2789 (p2cudf-full-1.1) S 2788 2789 1733 0 -1 4202496 456 291 0 0 0 0 0 0 20 0 1 0 119799998 9388032 331 18446744073709551615 4194304 5129932 140735565507280 140735565505424 139779561317470 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0 /proc/2789/statm: 2292 331 280 229 0 52 0 [pid=2792] ppid=2789 vsize=1034716 CPUtime=21.23 /proc/2792/stat : 2792 (java) S 2789 2789 1733 0 -1 4202496 158949 0 0 0 2062 61 0 0 20 0 11 0 119799999 1059549184 143627 18446744073709551615 4194304 4228012 140736308150208 140736308141232 139863948201589 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0 /proc/2792/statm: 258679 143627 2381 9 0 246029 0 [pid=2792/tid=2793] ppid=2789 vsize=1034716 CPUtime=13.3 /proc/2792/task/2793/stat : 2793 (java) R 2789 2789 1733 0 -1 4202560 47806 0 0 0 1308 22 0 0 20 0 11 0 119800000 1059549184 143627 18446744073709551615 4194304 4228012 140736308150208 139863954734904 139863853662865 0 4 0 16800975 0 0 0 -1 0 0 0 4 0 0 [pid=2792/tid=2794] ppid=2789 vsize=1034716 CPUtime=2.18 /proc/2792/task/2794/stat : 2794 (java) S 2789 2789 1733 0 -1 4202560 83668 0 0 0 190 28 0 0 20 0 11 0 119800002 1059549184 143627 18446744073709551615 4194304 4228012 140736308150208 139863847373952 139863948215883 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2795] ppid=2789 vsize=1034716 CPUtime=0 /proc/2792/task/2795/stat : 2795 (java) S 2789 2789 1733 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 119800003 1059549184 143627 18446744073709551615 4194304 4228012 140736308150208 139863846320144 139863948214996 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2796] ppid=2789 vsize=1034716 CPUtime=0 /proc/2792/task/2796/stat : 2796 (java) S 2789 2789 1733 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 119800003 1059549184 143627 18446744073709551615 4194304 4228012 140736308150208 139863845267360 139863948214996 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2797] ppid=2789 vsize=1034716 CPUtime=0 /proc/2792/task/2797/stat : 2797 (java) S 2789 2789 1733 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 119800006 1059549184 143627 18446744073709551615 4194304 4228012 140736308150208 139863844215792 139863948223520 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2798] ppid=2789 vsize=1034716 CPUtime=2.8 /proc/2792/task/2798/stat : 2798 (java) S 2789 2789 1733 0 -1 4202560 13596 0 0 0 274 6 0 0 20 0 11 0 119800006 1059549184 143627 18446744073709551615 4194304 4228012 140736308150208 139863843163152 139863948214996 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2799] ppid=2789 vsize=1034716 CPUtime=2.9 /proc/2792/task/2799/stat : 2799 (java) S 2789 2789 1733 0 -1 4202560 12576 0 0 0 286 4 0 0 20 0 11 0 119800006 1059549184 143627 18446744073709551615 4194304 4228012 140736308150208 139863842110480 139863948214996 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2800] ppid=2789 vsize=1034716 CPUtime=0 /proc/2792/task/2800/stat : 2800 (java) S 2789 2789 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 119800006 1059549184 143627 18446744073709551615 4194304 4228012 140736308150208 139863841058000 139863948214996 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2801] ppid=2789 vsize=1034716 CPUtime=0.02 /proc/2792/task/2801/stat : 2801 (java) S 2789 2789 1733 0 -1 4202560 7 0 0 0 0 2 0 0 20 0 11 0 119800007 1059549184 143627 18446744073709551615 4194304 4228012 140736308150208 139863840005504 139863948215883 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2802] ppid=2789 vsize=1034716 CPUtime=0 /proc/2792/task/2802/stat : 2802 (java) S 2789 2789 1733 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 119801392 1059549184 143627 18446744073709551615 4194304 4228012 140736308150208 139863838799712 139863948215883 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 Current children cumulated CPU time (s) 21.23 Current children cumulated vsize (KiB) 1043884 [startup+22.0008 s] /proc/loadavg: 1.35 1.12 1.03 1/71 2803 /proc/meminfo: memFree=31672/1022884 swapFree=0/0 [pid=2789] ppid=2788 vsize=9168 CPUtime=0 /proc/2789/stat : 2789 (p2cudf-full-1.1) S 2788 2789 1733 0 -1 4202496 456 291 0 0 0 0 0 0 20 0 1 0 119799998 9388032 331 18446744073709551615 4194304 5129932 140735565507280 140735565505424 139779561317470 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0 /proc/2789/statm: 2292 331 280 229 0 52 0 [pid=2792] ppid=2789 vsize=1035744 CPUtime=21.44 /proc/2792/stat : 2792 (java) S 2789 2789 1733 0 -1 4202496 158964 0 0 0 2083 61 0 0 20 0 11 0 119799999 1060601856 143640 18446744073709551615 4194304 4228012 140736308150208 140736308141232 139863948201589 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0 /proc/2792/statm: 258936 143640 2381 9 0 246286 0 [pid=2792/tid=2793] ppid=2789 vsize=1035744 CPUtime=13.48 /proc/2792/task/2793/stat : 2793 (java) S 2789 2789 1733 0 -1 4202560 47815 0 0 0 1326 22 0 0 20 0 11 0 119800000 1060601856 143640 18446744073709551615 4194304 4228012 140736308150208 139863954736048 139863948214996 0 4 0 16800975 0 0 0 -1 0 0 0 4 0 0 [pid=2792/tid=2794] ppid=2789 vsize=1035744 CPUtime=2.18 /proc/2792/task/2794/stat : 2794 (java) S 2789 2789 1733 0 -1 4202560 83668 0 0 0 190 28 0 0 20 0 11 0 119800002 1060601856 143640 18446744073709551615 4194304 4228012 140736308150208 139863847373952 139863948215883 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2795] ppid=2789 vsize=1035744 CPUtime=0 /proc/2792/task/2795/stat : 2795 (java) S 2789 2789 1733 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 119800003 1060601856 143640 18446744073709551615 4194304 4228012 140736308150208 139863846320144 139863948214996 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2796] ppid=2789 vsize=1035744 CPUtime=0 /proc/2792/task/2796/stat : 2796 (java) S 2789 2789 1733 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 119800003 1060601856 143640 18446744073709551615 4194304 4228012 140736308150208 139863845267360 139863948214996 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2797] ppid=2789 vsize=1035744 CPUtime=0 /proc/2792/task/2797/stat : 2797 (java) S 2789 2789 1733 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 119800006 1060601856 143640 18446744073709551615 4194304 4228012 140736308150208 139863844215792 139863948223520 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2798] ppid=2789 vsize=1035744 CPUtime=2.82 /proc/2792/task/2798/stat : 2798 (java) S 2789 2789 1733 0 -1 4202560 13596 0 0 0 276 6 0 0 20 0 11 0 119800006 1060601856 143640 18446744073709551615 4194304 4228012 140736308150208 139863843163152 139863948214996 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2799] ppid=2789 vsize=1035744 CPUtime=2.91 /proc/2792/task/2799/stat : 2799 (java) S 2789 2789 1733 0 -1 4202560 12576 0 0 0 287 4 0 0 20 0 11 0 119800006 1060601856 143640 18446744073709551615 4194304 4228012 140736308150208 139863842110480 139863948214996 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2800] ppid=2789 vsize=1035744 CPUtime=0 /proc/2792/task/2800/stat : 2800 (java) S 2789 2789 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 119800006 1060601856 143640 18446744073709551615 4194304 4228012 140736308150208 139863841058000 139863948214996 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2801] ppid=2789 vsize=1035744 CPUtime=0.02 /proc/2792/task/2801/stat : 2801 (java) S 2789 2789 1733 0 -1 4202560 7 0 0 0 0 2 0 0 20 0 11 0 119800007 1060601856 143640 18446744073709551615 4194304 4228012 140736308150208 139863840005504 139863948215883 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2803] ppid=2789 vsize=1035744 CPUtime=0 /proc/2792/task/2803/stat : 2803 (java) S 2789 2789 1733 0 -1 4202560 6 0 0 0 0 0 0 0 20 0 11 0 119802178 1060601856 143640 18446744073709551615 4194304 4228012 140736308150208 139863837747376 139863948215883 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 Current children cumulated CPU time (s) 21.44 Current children cumulated vsize (KiB) 1044912 [startup+22.403 s] /proc/loadavg: 1.35 1.12 1.03 1/71 2803 /proc/meminfo: memFree=31672/1022884 swapFree=0/0 [pid=2789] ppid=2788 vsize=9168 CPUtime=0 /proc/2789/stat : 2789 (p2cudf-full-1.1) S 2788 2789 1733 0 -1 4202496 456 291 0 0 0 0 0 0 20 0 1 0 119799998 9388032 331 18446744073709551615 4194304 5129932 140735565507280 140735565505424 139779561317470 0 65536 16781316 65538 0 0 0 17 0 0 0 0 0 0 /proc/2789/statm: 2292 331 280 229 0 52 0 [pid=2792] ppid=2789 vsize=1035744 CPUtime=21.53 /proc/2792/stat : 2792 (java) S 2789 2789 1733 0 -1 4202496 158966 0 0 0 2090 63 0 0 20 0 11 0 119799999 1060601856 143642 18446744073709551615 4194304 4228012 140736308150208 140736308141232 139863948201589 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 0 0 /proc/2792/statm: 258936 143642 2381 9 0 246286 0 [pid=2792/tid=2793] ppid=2789 vsize=1035744 CPUtime=13.48 /proc/2792/task/2793/stat : 2793 (java) S 2789 2789 1733 0 -1 4202560 47815 0 0 0 1326 22 0 0 20 0 11 0 119800000 1060601856 143642 18446744073709551615 4194304 4228012 140736308150208 139863954736048 139863948214996 0 4 0 16800975 0 0 0 -1 0 0 0 4 0 0 [pid=2792/tid=2794] ppid=2789 vsize=1035744 CPUtime=2.18 /proc/2792/task/2794/stat : 2794 (java) S 2789 2789 1733 0 -1 4202560 83668 0 0 0 190 28 0 0 20 0 11 0 119800002 1060601856 143642 18446744073709551615 4194304 4228012 140736308150208 139863847373952 139863948215883 0 0 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2795] ppid=2789 vsize=1035744 CPUtime=0 /proc/2792/task/2795/stat : 2795 (java) S 2789 2789 1733 0 -1 4202560 16 0 0 0 0 0 0 0 20 0 11 0 119800003 1060601856 143642 18446744073709551615 4194304 4228012 140736308150208 139863846320144 139863948214996 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2796] ppid=2789 vsize=1035744 CPUtime=0 /proc/2792/task/2796/stat : 2796 (java) S 2789 2789 1733 0 -1 4202560 9 0 0 0 0 0 0 0 20 0 11 0 119800003 1060601856 143642 18446744073709551615 4194304 4228012 140736308150208 139863845267360 139863948214996 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2797] ppid=2789 vsize=1035744 CPUtime=0 /proc/2792/task/2797/stat : 2797 (java) S 2789 2789 1733 0 -1 4202560 1 0 0 0 0 0 0 0 20 0 11 0 119800006 1060601856 143642 18446744073709551615 4194304 4228012 140736308150208 139863844215792 139863948223520 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2798] ppid=2789 vsize=1035744 CPUtime=2.82 /proc/2792/task/2798/stat : 2798 (java) S 2789 2789 1733 0 -1 4202560 13596 0 0 0 276 6 0 0 20 0 11 0 119800006 1060601856 143642 18446744073709551615 4194304 4228012 140736308150208 139863843163152 139863948214996 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2799] ppid=2789 vsize=1035744 CPUtime=2.93 /proc/2792/task/2799/stat : 2799 (java) S 2789 2789 1733 0 -1 4202560 12576 0 0 0 289 4 0 0 20 0 11 0 119800006 1060601856 143642 18446744073709551615 4194304 4228012 140736308150208 139863842110480 139863948214996 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2800] ppid=2789 vsize=1035744 CPUtime=0 /proc/2792/task/2800/stat : 2800 (java) S 2789 2789 1733 0 -1 4202560 0 0 0 0 0 0 0 0 20 0 11 0 119800006 1060601856 143642 18446744073709551615 4194304 4228012 140736308150208 139863841058000 139863948214996 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2801] ppid=2789 vsize=1035744 CPUtime=0.02 /proc/2792/task/2801/stat : 2801 (java) S 2789 2789 1733 0 -1 4202560 7 0 0 0 0 2 0 0 20 0 11 0 119800007 1060601856 143642 18446744073709551615 4194304 4228012 140736308150208 139863840005504 139863948215883 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 [pid=2792/tid=2803] ppid=2789 vsize=1035744 CPUtime=0.08 /proc/2792/task/2803/stat : 2803 (java) R 2789 2789 1733 0 -1 4202560 8 0 0 0 6 2 0 0 20 0 11 0 119802178 1060601856 143642 18446744073709551615 4194304 4228012 140736308150208 139863837738176 139863852197441 0 4 0 16800975 0 0 0 -1 0 0 0 0 0 0 Current children cumulated CPU time (s) 21.53 Current children cumulated vsize (KiB) 1044912 Child status: 0 Real time (s): 22.4683 CPU time (s): 21.6173 CPU user time (s): 20.9493 CPU system time (s): 0.668041 CPU usage (%): 96.2125 Max. virtual memory (cumulated for all children) (KiB): 1062908 getrusage(RUSAGE_CHILDREN,...) data: user time used= 20.9493 system time used= 0.668041 maximum resident set size= 596708 integral shared memory size= 0 integral unshared data size= 0 integral unshared stack size= 0 page reclaims= 159737 page faults= 0 swaps= 0 block input operations= 68424 block output operations= 256 messages sent= 0 messages received= 0 signals received= 0 voluntary context switches= 1349 involuntary context switches= 5159 runsolver used 0.076004 second user time and 0.152009 second system time The end