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: /home/misc2010/bin/runsolver -s SIGUSR1 -M 1124 -C 290 -d 10 -w /home/misc2010/tmp/201012061533/p2cudf-paranoid-1.9/rand95e48b.cudf.difficult.log.runsolver ./p2cudf-paranoid-1.9 /home/misc2010/data/2010/difficult//rand95e48b.cudf /home/misc2010/tmp/201012061533/p2cudf-paranoid-1.9/rand95e48b.cudf.difficult.result Enforcing CPUTime limit (soft limit, will send signal-name then SIGKILL): 290 seconds Enforcing CPUTime limit (hard limit, will send SIGXCPU): 320 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.42 1.31 1.22 6/48 29700 /proc/meminfo: memFree=641604/1048576 swapFree=2078744/2097144 [pid=29697] ppid=29696 vsize=2568 CPUtime=0 /proc/29697/stat : 29697 (p2cudf-paranoid) S 29696 29697 2059 34821 2220 4202496 378 0 0 0 0 0 0 0 25 0 1 0 876517337 2629632 273 1283457024 134512640 135304128 4286687808 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/29697/statm: 642 273 233 194 0 28 0 [pid=29698] ppid=29697 vsize=2568 CPUtime=0 /proc/29698/stat : 29698 (p2cudf) R 29697 29697 2059 34821 2220 4202496 348 0 0 0 0 0 0 0 25 0 1 0 876517337 2629632 274 1283457024 134512640 135304128 4293757184 18446744073709551615 4294960130 0 65538 4 65536 0 0 0 17 0 0 0 0 /proc/29698/statm: 642 274 234 194 0 28 0 [pid=29699] ppid=29698 vsize=2568 CPUtime=0 /proc/29699/stat : 29699 (p2cudf) R 29698 29697 2059 34821 2220 4202560 92 0 0 0 0 0 0 0 25 0 1 0 876517338 2629632 116 1283457024 134512640 135304128 4293757184 18446744073709551615 4294960130 0 65538 0 65538 0 0 0 17 0 0 0 0 /proc/29699/statm: 642 116 75 194 0 28 0 [pid=29700] ppid=29699 vsize=2568 CPUtime=0 /proc/29700/stat : 29700 (p2cudf) R 29699 29697 2059 34821 2220 4202560 0 0 0 0 0 0 0 0 25 0 1 0 876517338 2629632 41 1283457024 134512640 135304128 4293757184 18446744073709551615 4294960130 0 65538 0 65538 0 0 0 17 0 0 0 0 /proc/29700/statm: 642 41 0 194 0 28 0 [startup+0.193741 s] /proc/loadavg: 1.42 1.31 1.22 6/48 29700 /proc/meminfo: memFree=641604/1048576 swapFree=2078744/2097144 [pid=29697] ppid=29696 vsize=2568 CPUtime=0 /proc/29697/stat : 29697 (p2cudf-paranoid) S 29696 29697 2059 34821 2220 4202496 378 0 0 0 0 0 0 0 25 0 1 0 876517337 2629632 273 1283457024 134512640 135304128 4286687808 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/29697/statm: 642 273 233 194 0 28 0 [pid=29698] ppid=29697 vsize=2572 CPUtime=0.03 /proc/29698/stat : 29698 (p2cudf) S 29697 29697 2059 34821 2220 4202496 392 2879 0 1 0 0 2 1 25 0 1 0 876517337 2633728 282 1283457024 134512640 135304128 4293757184 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/29698/statm: 643 282 241 194 0 29 0 Current children cumulated CPU time (s) 0.03 Current children cumulated vsize (KiB) 5140 [startup+0.203735 s] /proc/loadavg: 1.42 1.31 1.22 6/48 29700 /proc/meminfo: memFree=641604/1048576 swapFree=2078744/2097144 [pid=29697] ppid=29696 vsize=2568 CPUtime=0 /proc/29697/stat : 29697 (p2cudf-paranoid) S 29696 29697 2059 34821 2220 4202496 378 0 0 0 0 0 0 0 25 0 1 0 876517337 2629632 273 1283457024 134512640 135304128 4286687808 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/29697/statm: 642 273 233 194 0 28 0 [pid=29698] ppid=29697 vsize=2572 CPUtime=0.03 /proc/29698/stat : 29698 (p2cudf) S 29697 29697 2059 34821 2220 4202496 392 2879 0 1 0 0 2 1 25 0 1 0 876517337 2633728 282 1283457024 134512640 135304128 4293757184 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/29698/statm: 643 282 241 194 0 29 0 Current children cumulated CPU time (s) 0.03 Current children cumulated vsize (KiB) 5140 [startup+0.313771 s] /proc/loadavg: 1.42 1.31 1.22 6/48 29700 /proc/meminfo: memFree=641604/1048576 swapFree=2078744/2097144 [pid=29697] ppid=29696 vsize=2568 CPUtime=0 /proc/29697/stat : 29697 (p2cudf-paranoid) S 29696 29697 2059 34821 2220 4202496 378 0 0 0 0 0 0 0 25 0 1 0 876517337 2629632 273 1283457024 134512640 135304128 4286687808 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/29697/statm: 642 273 233 194 0 28 0 [pid=29698] ppid=29697 vsize=2572 CPUtime=0.03 /proc/29698/stat : 29698 (p2cudf) S 29697 29697 2059 34821 2220 4202496 392 2879 0 1 0 0 2 1 25 0 1 0 876517337 2633728 282 1283457024 134512640 135304128 4293757184 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/29698/statm: 643 282 241 194 0 29 0 Current children cumulated CPU time (s) 0.03 Current children cumulated vsize (KiB) 5140 [startup+0.704667 s] /proc/loadavg: 1.42 1.31 1.22 6/48 29700 /proc/meminfo: memFree=641604/1048576 swapFree=2078744/2097144 [pid=29697] ppid=29696 vsize=2568 CPUtime=0 /proc/29697/stat : 29697 (p2cudf-paranoid) S 29696 29697 2059 34821 2220 4202496 378 0 0 0 0 0 0 0 25 0 1 0 876517337 2629632 273 1283457024 134512640 135304128 4286687808 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/29697/statm: 642 273 233 194 0 28 0 [pid=29698] ppid=29697 vsize=2572 CPUtime=0.03 /proc/29698/stat : 29698 (p2cudf) S 29697 29697 2059 34821 2220 4202496 392 2879 0 1 0 0 2 1 25 0 1 0 876517337 2633728 282 1283457024 134512640 135304128 4293757184 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/29698/statm: 643 282 241 194 0 29 0 Current children cumulated CPU time (s) 0.03 Current children cumulated vsize (KiB) 5140 [startup+1.50478 s] /proc/loadavg: 1.42 1.31 1.22 4/57 29720 /proc/meminfo: memFree=598788/1048576 swapFree=2078744/2097144 [pid=29697] ppid=29696 vsize=2568 CPUtime=0 /proc/29697/stat : 29697 (p2cudf-paranoid) S 29696 29697 2059 34821 2220 4202496 378 0 0 0 0 0 0 0 25 0 1 0 876517337 2629632 273 1283457024 134512640 135304128 4286687808 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/29697/statm: 642 273 233 194 0 28 0 [pid=29698] ppid=29697 vsize=2572 CPUtime=0.03 /proc/29698/stat : 29698 (p2cudf) S 29697 29697 2059 34821 2220 4202496 392 2879 0 1 0 0 2 1 25 0 1 0 876517337 2633728 282 1283457024 134512640 135304128 4293757184 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/29698/statm: 643 282 241 194 0 29 0 [pid=29711] ppid=29698 vsize=870696 CPUtime=1.43 /proc/29711/stat : 29711 (java) S 29698 29697 2059 34821 2220 4202496 16667 0 1 0 139 4 0 0 25 0 10 0 876517342 891592704 14498 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/29711/statm: 217674 14498 1741 10 0 214764 0 [pid=29711/tid=29712] ppid=29698 vsize=870696 CPUtime=0.66 /proc/29711/task/29712/stat : 29712 (java) R 29698 29697 2059 34821 2220 4202560 9460 0 1 0 64 2 0 0 25 0 10 0 876517343 891592704 14498 1283457024 134512640 134550932 4292257328 18446744073709551615 4095901239 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=29711/tid=29713] ppid=29698 vsize=870696 CPUtime=0 /proc/29711/task/29713/stat : 29713 (java) S 29698 29697 2059 34821 2220 4202560 5 0 0 0 0 0 0 0 18 0 10 0 876517344 891592704 14498 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 0 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29714] ppid=29698 vsize=870696 CPUtime=0 /proc/29711/task/29714/stat : 29714 (java) S 29698 29697 2059 34821 2220 4202560 9 0 0 0 0 0 0 0 25 0 10 0 876517345 891592704 14498 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29715] ppid=29698 vsize=870696 CPUtime=0 /proc/29711/task/29715/stat : 29715 (java) S 29698 29697 2059 34821 2220 4202560 4 0 0 0 0 0 0 0 25 0 10 0 876517345 891592704 14498 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29716] ppid=29698 vsize=870696 CPUtime=0 /proc/29711/task/29716/stat : 29716 (java) S 29698 29697 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 10 0 876517347 891592704 14498 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29717] ppid=29698 vsize=870696 CPUtime=0.27 /proc/29711/task/29717/stat : 29717 (java) R 29698 29697 2059 34821 2220 4202560 2619 0 0 0 27 0 0 0 25 0 10 0 876517348 891592704 14498 1283457024 134512640 134550932 4292257328 18446744073709551615 4150357930 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=29711/tid=29718] ppid=29698 vsize=870696 CPUtime=0.48 /proc/29711/task/29718/stat : 29718 (java) S 29698 29697 2059 34821 2220 4202560 3475 0 0 0 47 1 0 0 19 0 10 0 876517348 891592704 14498 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29719] ppid=29698 vsize=870696 CPUtime=0 /proc/29711/task/29719/stat : 29719 (java) S 29698 29697 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 10 0 876517348 891592704 14498 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29720] ppid=29698 vsize=870696 CPUtime=0 /proc/29711/task/29720/stat : 29720 (java) S 29698 29697 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 15 0 10 0 876517348 891592704 14498 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 1.46 Current children cumulated vsize (KiB) 875836 [startup+3.10599 s] /proc/loadavg: 1.42 1.31 1.22 2/57 29720 /proc/meminfo: memFree=457256/1048576 swapFree=2078744/2097144 [pid=29697] ppid=29696 vsize=2568 CPUtime=0 /proc/29697/stat : 29697 (p2cudf-paranoid) S 29696 29697 2059 34821 2220 4202496 378 0 0 0 0 0 0 0 25 0 1 0 876517337 2629632 273 1283457024 134512640 135304128 4286687808 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/29697/statm: 642 273 233 194 0 28 0 [pid=29698] ppid=29697 vsize=2572 CPUtime=0.03 /proc/29698/stat : 29698 (p2cudf) S 29697 29697 2059 34821 2220 4202496 392 2879 0 1 0 0 2 1 25 0 1 0 876517337 2633728 282 1283457024 134512640 135304128 4293757184 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/29698/statm: 643 282 241 194 0 29 0 [pid=29711] ppid=29698 vsize=874764 CPUtime=3 /proc/29711/stat : 29711 (java) S 29698 29697 2059 34821 2220 4202496 58319 0 1 0 282 18 0 0 25 0 10 0 876517342 895758336 55572 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/29711/statm: 218691 55572 1762 10 0 215781 0 [pid=29711/tid=29712] ppid=29698 vsize=874764 CPUtime=1.52 /proc/29711/task/29712/stat : 29712 (java) R 29698 29697 2059 34821 2220 4202560 49698 0 1 0 138 14 0 0 25 0 10 0 876517343 895758336 55572 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=29711/tid=29713] ppid=29698 vsize=874764 CPUtime=0 /proc/29711/task/29713/stat : 29713 (java) S 29698 29697 2059 34821 2220 4202560 5 0 0 0 0 0 0 0 18 0 10 0 876517344 895758336 55572 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 0 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29714] ppid=29698 vsize=874764 CPUtime=0 /proc/29711/task/29714/stat : 29714 (java) S 29698 29697 2059 34821 2220 4202560 9 0 0 0 0 0 0 0 25 0 10 0 876517345 895758336 55572 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29715] ppid=29698 vsize=874764 CPUtime=0 /proc/29711/task/29715/stat : 29715 (java) S 29698 29697 2059 34821 2220 4202560 4 0 0 0 0 0 0 0 25 0 10 0 876517345 895758336 55572 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29716] ppid=29698 vsize=874764 CPUtime=0 /proc/29711/task/29716/stat : 29716 (java) S 29698 29697 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 10 0 876517347 895758336 55572 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29717] ppid=29698 vsize=874764 CPUtime=0.98 /proc/29711/task/29717/stat : 29717 (java) R 29698 29697 2059 34821 2220 4202560 4033 0 0 0 96 2 0 0 17 0 10 0 876517348 895758336 55572 1283457024 134512640 134550932 4292257328 18446744073709551615 4150357095 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=29711/tid=29718] ppid=29698 vsize=874764 CPUtime=0.48 /proc/29711/task/29718/stat : 29718 (java) S 29698 29697 2059 34821 2220 4202560 3475 0 0 0 47 1 0 0 19 0 10 0 876517348 895758336 55572 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29719] ppid=29698 vsize=874764 CPUtime=0 /proc/29711/task/29719/stat : 29719 (java) S 29698 29697 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 10 0 876517348 895758336 55572 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29720] ppid=29698 vsize=874764 CPUtime=0 /proc/29711/task/29720/stat : 29720 (java) S 29698 29697 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 15 0 10 0 876517348 895758336 55572 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 3.03 Current children cumulated vsize (KiB) 879904 [startup+6.30654 s] /proc/loadavg: 1.39 1.30 1.21 4/59 29734 /proc/meminfo: memFree=356216/1048576 swapFree=2078744/2097144 [pid=29697] ppid=29696 vsize=2568 CPUtime=0 /proc/29697/stat : 29697 (p2cudf-paranoid) S 29696 29697 2059 34821 2220 4202496 378 0 0 0 0 0 0 0 25 0 1 0 876517337 2629632 273 1283457024 134512640 135304128 4286687808 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/29697/statm: 642 273 233 194 0 28 0 [pid=29698] ppid=29697 vsize=2572 CPUtime=0.03 /proc/29698/stat : 29698 (p2cudf) S 29697 29697 2059 34821 2220 4202496 392 2879 0 1 0 0 2 1 25 0 1 0 876517337 2633728 282 1283457024 134512640 135304128 4293757184 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/29698/statm: 643 282 241 194 0 29 0 [pid=29711] ppid=29698 vsize=873940 CPUtime=6.19 /proc/29711/stat : 29711 (java) S 29698 29697 2059 34821 2220 4202496 72911 0 1 0 600 19 0 0 25 0 11 0 876517342 894914560 69697 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/29711/statm: 218485 69697 1792 10 0 215575 0 [pid=29711/tid=29712] ppid=29698 vsize=873940 CPUtime=3.48 /proc/29711/task/29712/stat : 29712 (java) R 29698 29697 2059 34821 2220 4202560 50447 0 1 0 334 14 0 0 25 0 11 0 876517343 894914560 69697 1283457024 134512640 134550932 4292257328 18446744073709551615 4095911666 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=29711/tid=29713] ppid=29698 vsize=873940 CPUtime=0.3 /proc/29711/task/29713/stat : 29713 (java) S 29698 29697 2059 34821 2220 4202560 13587 0 0 0 30 0 0 0 16 0 11 0 876517344 894914560 69697 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 0 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29714] ppid=29698 vsize=873940 CPUtime=0 /proc/29711/task/29714/stat : 29714 (java) S 29698 29697 2059 34821 2220 4202560 9 0 0 0 0 0 0 0 18 0 11 0 876517345 894914560 69697 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29715] ppid=29698 vsize=873940 CPUtime=0 /proc/29711/task/29715/stat : 29715 (java) S 29698 29697 2059 34821 2220 4202560 6 0 0 0 0 0 0 0 18 0 11 0 876517345 894914560 69697 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29716] ppid=29698 vsize=873940 CPUtime=0 /proc/29711/task/29716/stat : 29716 (java) S 29698 29697 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 11 0 876517347 894914560 69697 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29717] ppid=29698 vsize=873940 CPUtime=1.88 /proc/29711/task/29717/stat : 29717 (java) S 29698 29697 2059 34821 2220 4202560 4272 0 0 0 186 2 0 0 15 0 11 0 876517348 894914560 69697 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29718] ppid=29698 vsize=873940 CPUtime=0.48 /proc/29711/task/29718/stat : 29718 (java) S 29698 29697 2059 34821 2220 4202560 3475 0 0 0 47 1 0 0 19 0 11 0 876517348 894914560 69697 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29719] ppid=29698 vsize=873940 CPUtime=0 /proc/29711/task/29719/stat : 29719 (java) S 29698 29697 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 11 0 876517348 894914560 69697 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29720] ppid=29698 vsize=873940 CPUtime=0 /proc/29711/task/29720/stat : 29720 (java) S 29698 29697 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 15 0 11 0 876517348 894914560 69697 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29734] ppid=29698 vsize=873940 CPUtime=0 /proc/29711/task/29734/stat : 29734 (java) S 29698 29697 2059 34821 2220 4202560 0 0 0 0 0 0 0 0 25 0 11 0 876517867 894914560 69697 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 6.22 Current children cumulated vsize (KiB) 879080 Solver just ended. Dumping a history of the last processes samples [startup+6.41655 s] /proc/loadavg: 1.39 1.30 1.21 4/59 29734 /proc/meminfo: memFree=356216/1048576 swapFree=2078744/2097144 [pid=29697] ppid=29696 vsize=2568 CPUtime=0 /proc/29697/stat : 29697 (p2cudf-paranoid) S 29696 29697 2059 34821 2220 4202496 378 0 0 0 0 0 0 0 25 0 1 0 876517337 2629632 273 1283457024 134512640 135304128 4286687808 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/29697/statm: 642 273 233 194 0 28 0 [pid=29698] ppid=29697 vsize=2572 CPUtime=0.03 /proc/29698/stat : 29698 (p2cudf) S 29697 29697 2059 34821 2220 4202496 392 2879 0 1 0 0 2 1 25 0 1 0 876517337 2633728 282 1283457024 134512640 135304128 4293757184 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/29698/statm: 643 282 241 194 0 29 0 [pid=29711] ppid=29698 vsize=872012 CPUtime=6.29 /proc/29711/stat : 29711 (java) S 29698 29697 2059 34821 2220 4202496 73009 0 1 0 610 19 0 0 25 0 11 0 876517342 892940288 69343 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/29711/statm: 218003 69343 1793 10 0 215093 0 [pid=29711/tid=29712] ppid=29698 vsize=872012 CPUtime=3.53 /proc/29711/task/29712/stat : 29712 (java) R 29698 29697 2059 34821 2220 4202560 50447 0 1 0 339 14 0 0 25 0 11 0 876517343 892940288 69343 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=29711/tid=29713] ppid=29698 vsize=872012 CPUtime=0.34 /proc/29711/task/29713/stat : 29713 (java) R 29698 29697 2059 34821 2220 4202560 13681 0 0 0 34 0 0 0 15 0 11 0 876517344 892940288 69343 1283457024 134512640 134550932 4292257328 18446744073709551615 4150371848 0 0 0 16800975 0 0 0 -1 0 0 0 0 [pid=29711/tid=29714] ppid=29698 vsize=872012 CPUtime=0 /proc/29711/task/29714/stat : 29714 (java) S 29698 29697 2059 34821 2220 4202560 9 0 0 0 0 0 0 0 18 0 11 0 876517345 892940288 69343 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29715] ppid=29698 vsize=872012 CPUtime=0 /proc/29711/task/29715/stat : 29715 (java) S 29698 29697 2059 34821 2220 4202560 6 0 0 0 0 0 0 0 18 0 11 0 876517345 892940288 69343 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29716] ppid=29698 vsize=872012 CPUtime=0 /proc/29711/task/29716/stat : 29716 (java) S 29698 29697 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 11 0 876517347 892940288 69343 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29717] ppid=29698 vsize=872012 CPUtime=1.9 /proc/29711/task/29717/stat : 29717 (java) S 29698 29697 2059 34821 2220 4202560 4276 0 0 0 188 2 0 0 15 0 11 0 876517348 892940288 69343 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29718] ppid=29698 vsize=872012 CPUtime=0.48 /proc/29711/task/29718/stat : 29718 (java) S 29698 29697 2059 34821 2220 4202560 3475 0 0 0 47 1 0 0 19 0 11 0 876517348 892940288 69343 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29719] ppid=29698 vsize=872012 CPUtime=0 /proc/29711/task/29719/stat : 29719 (java) S 29698 29697 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 11 0 876517348 892940288 69343 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29720] ppid=29698 vsize=872012 CPUtime=0 /proc/29711/task/29720/stat : 29720 (java) S 29698 29697 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 15 0 11 0 876517348 892940288 69343 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29734] ppid=29698 vsize=872012 CPUtime=0 /proc/29711/task/29734/stat : 29734 (java) S 29698 29697 2059 34821 2220 4202560 0 0 0 0 0 0 0 0 25 0 11 0 876517867 892940288 69343 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 6.32 Current children cumulated vsize (KiB) 877152 [startup+9.60727 s] /proc/loadavg: 1.39 1.30 1.21 2/58 29734 /proc/meminfo: memFree=329564/1048576 swapFree=2078744/2097144 [pid=29697] ppid=29696 vsize=2568 CPUtime=0 /proc/29697/stat : 29697 (p2cudf-paranoid) S 29696 29697 2059 34821 2220 4202496 378 0 0 0 0 0 0 0 25 0 1 0 876517337 2629632 273 1283457024 134512640 135304128 4286687808 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/29697/statm: 642 273 233 194 0 28 0 [pid=29698] ppid=29697 vsize=2572 CPUtime=0.03 /proc/29698/stat : 29698 (p2cudf) S 29697 29697 2059 34821 2220 4202496 392 2879 0 1 0 0 2 1 25 0 1 0 876517337 2633728 282 1283457024 134512640 135304128 4293757184 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/29698/statm: 643 282 241 194 0 29 0 [pid=29711] ppid=29698 vsize=872012 CPUtime=9.47 /proc/29711/stat : 29711 (java) S 29698 29697 2059 34821 2220 4202496 79975 0 1 0 926 21 0 0 25 0 11 0 876517342 892940288 76309 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/29711/statm: 218003 76309 1793 10 0 215093 0 [pid=29711/tid=29712] ppid=29698 vsize=872012 CPUtime=6.18 /proc/29711/task/29712/stat : 29712 (java) R 29698 29697 2059 34821 2220 4202560 50447 0 1 0 604 14 0 0 25 0 11 0 876517343 892940288 76309 1283457024 134512640 134550932 4292257328 18446744073709551615 4096439079 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=29711/tid=29713] ppid=29698 vsize=872012 CPUtime=0.82 /proc/29711/task/29713/stat : 29713 (java) S 29698 29697 2059 34821 2220 4202560 20647 0 0 0 80 2 0 0 16 0 11 0 876517344 892940288 76309 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 0 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29714] ppid=29698 vsize=872012 CPUtime=0 /proc/29711/task/29714/stat : 29714 (java) S 29698 29697 2059 34821 2220 4202560 9 0 0 0 0 0 0 0 18 0 11 0 876517345 892940288 76309 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29715] ppid=29698 vsize=872012 CPUtime=0 /proc/29711/task/29715/stat : 29715 (java) S 29698 29697 2059 34821 2220 4202560 6 0 0 0 0 0 0 0 18 0 11 0 876517345 892940288 76309 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29716] ppid=29698 vsize=872012 CPUtime=0 /proc/29711/task/29716/stat : 29716 (java) S 29698 29697 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 11 0 876517347 892940288 76309 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29717] ppid=29698 vsize=872012 CPUtime=1.95 /proc/29711/task/29717/stat : 29717 (java) S 29698 29697 2059 34821 2220 4202560 4276 0 0 0 193 2 0 0 16 0 11 0 876517348 892940288 76309 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29718] ppid=29698 vsize=872012 CPUtime=0.48 /proc/29711/task/29718/stat : 29718 (java) S 29698 29697 2059 34821 2220 4202560 3475 0 0 0 47 1 0 0 19 0 11 0 876517348 892940288 76309 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29719] ppid=29698 vsize=872012 CPUtime=0 /proc/29711/task/29719/stat : 29719 (java) S 29698 29697 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 11 0 876517348 892940288 76309 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29720] ppid=29698 vsize=872012 CPUtime=0 /proc/29711/task/29720/stat : 29720 (java) S 29698 29697 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 15 0 11 0 876517348 892940288 76309 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 9.5 Current children cumulated vsize (KiB) 877152 [startup+11.1076 s] /proc/loadavg: 1.36 1.30 1.21 3/58 29735 /proc/meminfo: memFree=329564/1048576 swapFree=2078744/2097144 [pid=29697] ppid=29696 vsize=2568 CPUtime=0 /proc/29697/stat : 29697 (p2cudf-paranoid) S 29696 29697 2059 34821 2220 4202496 378 0 0 0 0 0 0 0 25 0 1 0 876517337 2629632 273 1283457024 134512640 135304128 4286687808 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/29697/statm: 642 273 233 194 0 28 0 [pid=29698] ppid=29697 vsize=2572 CPUtime=0.03 /proc/29698/stat : 29698 (p2cudf) S 29697 29697 2059 34821 2220 4202496 392 2879 0 1 0 0 2 1 25 0 1 0 876517337 2633728 282 1283457024 134512640 135304128 4293757184 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/29698/statm: 643 282 241 194 0 29 0 [pid=29711] ppid=29698 vsize=872012 CPUtime=10.97 /proc/29711/stat : 29711 (java) S 29698 29697 2059 34821 2220 4202496 80098 0 1 0 1076 21 0 0 25 0 11 0 876517342 892940288 76432 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/29711/statm: 218003 76432 1793 10 0 215093 0 [pid=29711/tid=29712] ppid=29698 vsize=872012 CPUtime=7.44 /proc/29711/task/29712/stat : 29712 (java) R 29698 29697 2059 34821 2220 4202560 50447 0 1 0 730 14 0 0 25 0 11 0 876517343 892940288 76432 1283457024 134512640 134550932 4292257328 18446744073709551615 4096466394 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=29711/tid=29713] ppid=29698 vsize=872012 CPUtime=1.04 /proc/29711/task/29713/stat : 29713 (java) S 29698 29697 2059 34821 2220 4202560 20770 0 0 0 102 2 0 0 16 0 11 0 876517344 892940288 76432 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 0 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29714] ppid=29698 vsize=872012 CPUtime=0 /proc/29711/task/29714/stat : 29714 (java) S 29698 29697 2059 34821 2220 4202560 9 0 0 0 0 0 0 0 18 0 11 0 876517345 892940288 76432 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29715] ppid=29698 vsize=872012 CPUtime=0 /proc/29711/task/29715/stat : 29715 (java) S 29698 29697 2059 34821 2220 4202560 6 0 0 0 0 0 0 0 15 0 11 0 876517345 892940288 76432 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29716] ppid=29698 vsize=872012 CPUtime=0 /proc/29711/task/29716/stat : 29716 (java) S 29698 29697 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 11 0 876517347 892940288 76432 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29717] ppid=29698 vsize=872012 CPUtime=1.98 /proc/29711/task/29717/stat : 29717 (java) S 29698 29697 2059 34821 2220 4202560 4276 0 0 0 196 2 0 0 16 0 11 0 876517348 892940288 76432 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29718] ppid=29698 vsize=872012 CPUtime=0.48 /proc/29711/task/29718/stat : 29718 (java) S 29698 29697 2059 34821 2220 4202560 3475 0 0 0 47 1 0 0 19 0 11 0 876517348 892940288 76432 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29719] ppid=29698 vsize=872012 CPUtime=0 /proc/29711/task/29719/stat : 29719 (java) S 29698 29697 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 11 0 876517348 892940288 76432 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29720] ppid=29698 vsize=872012 CPUtime=0 /proc/29711/task/29720/stat : 29720 (java) S 29698 29697 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 15 0 11 0 876517348 892940288 76432 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29735] ppid=29698 vsize=872012 CPUtime=0 /proc/29711/task/29735/stat : 29735 (java) S 29698 29697 2059 34821 2220 4202560 0 0 0 0 0 0 0 0 25 0 11 0 876518287 892940288 76432 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 11 Current children cumulated vsize (KiB) 877152 [startup+11.5044 s] /proc/loadavg: 1.36 1.30 1.21 3/58 29735 /proc/meminfo: memFree=329564/1048576 swapFree=2078744/2097144 [pid=29697] ppid=29696 vsize=2568 CPUtime=0 /proc/29697/stat : 29697 (p2cudf-paranoid) S 29696 29697 2059 34821 2220 4202496 378 0 0 0 0 0 0 0 25 0 1 0 876517337 2629632 273 1283457024 134512640 135304128 4286687808 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/29697/statm: 642 273 233 194 0 28 0 [pid=29698] ppid=29697 vsize=2572 CPUtime=0.03 /proc/29698/stat : 29698 (p2cudf) S 29697 29697 2059 34821 2220 4202496 392 2879 0 1 0 0 2 1 25 0 1 0 876517337 2633728 282 1283457024 134512640 135304128 4293757184 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/29698/statm: 643 282 241 194 0 29 0 [pid=29711] ppid=29698 vsize=872012 CPUtime=11.09 /proc/29711/stat : 29711 (java) S 29698 29697 2059 34821 2220 4202496 80104 0 1 0 1088 21 0 0 25 0 11 0 876517342 892940288 76438 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/29711/statm: 218003 76438 1793 10 0 215093 0 [pid=29711/tid=29712] ppid=29698 vsize=872012 CPUtime=7.52 /proc/29711/task/29712/stat : 29712 (java) S 29698 29697 2059 34821 2220 4202560 50453 0 1 0 738 14 0 0 25 0 11 0 876517343 892940288 76438 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29713] ppid=29698 vsize=872012 CPUtime=1.04 /proc/29711/task/29713/stat : 29713 (java) S 29698 29697 2059 34821 2220 4202560 20770 0 0 0 102 2 0 0 16 0 11 0 876517344 892940288 76438 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 0 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29714] ppid=29698 vsize=872012 CPUtime=0 /proc/29711/task/29714/stat : 29714 (java) S 29698 29697 2059 34821 2220 4202560 9 0 0 0 0 0 0 0 18 0 11 0 876517345 892940288 76438 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29715] ppid=29698 vsize=872012 CPUtime=0 /proc/29711/task/29715/stat : 29715 (java) S 29698 29697 2059 34821 2220 4202560 6 0 0 0 0 0 0 0 15 0 11 0 876517345 892940288 76438 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29716] ppid=29698 vsize=872012 CPUtime=0 /proc/29711/task/29716/stat : 29716 (java) S 29698 29697 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 11 0 876517347 892940288 76438 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29717] ppid=29698 vsize=872012 CPUtime=2.01 /proc/29711/task/29717/stat : 29717 (java) S 29698 29697 2059 34821 2220 4202560 4276 0 0 0 199 2 0 0 16 0 11 0 876517348 892940288 76438 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29718] ppid=29698 vsize=872012 CPUtime=0.48 /proc/29711/task/29718/stat : 29718 (java) S 29698 29697 2059 34821 2220 4202560 3475 0 0 0 47 1 0 0 19 0 11 0 876517348 892940288 76438 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29719] ppid=29698 vsize=872012 CPUtime=0 /proc/29711/task/29719/stat : 29719 (java) S 29698 29697 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 11 0 876517348 892940288 76438 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29720] ppid=29698 vsize=872012 CPUtime=0 /proc/29711/task/29720/stat : 29720 (java) S 29698 29697 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 15 0 11 0 876517348 892940288 76438 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 11.12 Current children cumulated vsize (KiB) 877152 [startup+11.7045 s] /proc/loadavg: 1.36 1.30 1.21 3/58 29735 /proc/meminfo: memFree=329564/1048576 swapFree=2078744/2097144 [pid=29697] ppid=29696 vsize=2568 CPUtime=0 /proc/29697/stat : 29697 (p2cudf-paranoid) S 29696 29697 2059 34821 2220 4202496 378 0 0 0 0 0 0 0 25 0 1 0 876517337 2629632 273 1283457024 134512640 135304128 4286687808 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/29697/statm: 642 273 233 194 0 28 0 [pid=29698] ppid=29697 vsize=2572 CPUtime=0.03 /proc/29698/stat : 29698 (p2cudf) S 29697 29697 2059 34821 2220 4202496 392 2879 0 1 0 0 2 1 25 0 1 0 876517337 2633728 282 1283457024 134512640 135304128 4293757184 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/29698/statm: 643 282 241 194 0 29 0 [pid=29711] ppid=29698 vsize=872012 CPUtime=11.09 /proc/29711/stat : 29711 (java) S 29698 29697 2059 34821 2220 4202496 80104 0 1 0 1088 21 0 0 25 0 11 0 876517342 892940288 76438 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/29711/statm: 218003 76438 1793 10 0 215093 0 [pid=29711/tid=29712] ppid=29698 vsize=872012 CPUtime=7.52 /proc/29711/task/29712/stat : 29712 (java) S 29698 29697 2059 34821 2220 4202560 50453 0 1 0 738 14 0 0 25 0 11 0 876517343 892940288 76438 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29713] ppid=29698 vsize=872012 CPUtime=1.04 /proc/29711/task/29713/stat : 29713 (java) S 29698 29697 2059 34821 2220 4202560 20770 0 0 0 102 2 0 0 16 0 11 0 876517344 892940288 76438 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 0 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29714] ppid=29698 vsize=872012 CPUtime=0 /proc/29711/task/29714/stat : 29714 (java) S 29698 29697 2059 34821 2220 4202560 9 0 0 0 0 0 0 0 18 0 11 0 876517345 892940288 76438 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29715] ppid=29698 vsize=872012 CPUtime=0 /proc/29711/task/29715/stat : 29715 (java) S 29698 29697 2059 34821 2220 4202560 6 0 0 0 0 0 0 0 15 0 11 0 876517345 892940288 76438 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29716] ppid=29698 vsize=872012 CPUtime=0 /proc/29711/task/29716/stat : 29716 (java) S 29698 29697 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 11 0 876517347 892940288 76438 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29717] ppid=29698 vsize=872012 CPUtime=2.01 /proc/29711/task/29717/stat : 29717 (java) S 29698 29697 2059 34821 2220 4202560 4276 0 0 0 199 2 0 0 16 0 11 0 876517348 892940288 76438 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29718] ppid=29698 vsize=872012 CPUtime=0.48 /proc/29711/task/29718/stat : 29718 (java) S 29698 29697 2059 34821 2220 4202560 3475 0 0 0 47 1 0 0 19 0 11 0 876517348 892940288 76438 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29719] ppid=29698 vsize=872012 CPUtime=0 /proc/29711/task/29719/stat : 29719 (java) S 29698 29697 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 11 0 876517348 892940288 76438 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29720] ppid=29698 vsize=872012 CPUtime=0 /proc/29711/task/29720/stat : 29720 (java) S 29698 29697 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 15 0 11 0 876517348 892940288 76438 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 11.12 Current children cumulated vsize (KiB) 877152 [startup+11.8044 s] /proc/loadavg: 1.36 1.30 1.21 3/58 29735 /proc/meminfo: memFree=329564/1048576 swapFree=2078744/2097144 [pid=29697] ppid=29696 vsize=2568 CPUtime=0 /proc/29697/stat : 29697 (p2cudf-paranoid) S 29696 29697 2059 34821 2220 4202496 378 0 0 0 0 0 0 0 25 0 1 0 876517337 2629632 273 1283457024 134512640 135304128 4286687808 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/29697/statm: 642 273 233 194 0 28 0 [pid=29698] ppid=29697 vsize=2572 CPUtime=0.03 /proc/29698/stat : 29698 (p2cudf) S 29697 29697 2059 34821 2220 4202496 392 2879 0 1 0 0 2 1 25 0 1 0 876517337 2633728 282 1283457024 134512640 135304128 4293757184 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/29698/statm: 643 282 241 194 0 29 0 [pid=29711] ppid=29698 vsize=872012 CPUtime=11.15 /proc/29711/stat : 29711 (java) S 29698 29697 2059 34821 2220 4202496 80106 0 1 0 1091 24 0 0 25 0 10 0 876517342 892940288 76440 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/29711/statm: 218003 76440 1793 10 0 215093 0 [pid=29711/tid=29712] ppid=29698 vsize=872012 CPUtime=7.52 /proc/29711/task/29712/stat : 29712 (java) S 29698 29697 2059 34821 2220 4202560 50453 0 1 0 738 14 0 0 20 0 10 0 876517343 892940288 76440 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29713] ppid=29698 vsize=872012 CPUtime=1.04 /proc/29711/task/29713/stat : 29713 (java) S 29698 29697 2059 34821 2220 4202560 20770 0 0 0 102 2 0 0 16 0 10 0 876517344 892940288 76440 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 0 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29714] ppid=29698 vsize=872012 CPUtime=0 /proc/29711/task/29714/stat : 29714 (java) S 29698 29697 2059 34821 2220 4202560 9 0 0 0 0 0 0 0 18 0 10 0 876517345 892940288 76440 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29715] ppid=29698 vsize=872012 CPUtime=0 /proc/29711/task/29715/stat : 29715 (java) S 29698 29697 2059 34821 2220 4202560 6 0 0 0 0 0 0 0 15 0 10 0 876517345 892940288 76440 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29716] ppid=29698 vsize=872012 CPUtime=0 /proc/29711/task/29716/stat : 29716 (java) S 29698 29697 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 10 0 876517347 892940288 76440 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29717] ppid=29698 vsize=872012 CPUtime=2.02 /proc/29711/task/29717/stat : 29717 (java) S 29698 29697 2059 34821 2220 4202560 4276 0 0 0 200 2 0 0 15 0 10 0 876517348 892940288 76440 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29718] ppid=29698 vsize=872012 CPUtime=0.48 /proc/29711/task/29718/stat : 29718 (java) S 29698 29697 2059 34821 2220 4202560 3475 0 0 0 47 1 0 0 19 0 10 0 876517348 892940288 76440 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29719] ppid=29698 vsize=872012 CPUtime=0 /proc/29711/task/29719/stat : 29719 (java) S 29698 29697 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 10 0 876517348 892940288 76440 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 [pid=29711/tid=29720] ppid=29698 vsize=872012 CPUtime=0 /proc/29711/task/29720/stat : 29720 (java) S 29698 29697 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 15 0 10 0 876517348 892940288 76440 1283457024 134512640 134550932 4292257328 18446744073709551615 4294960130 0 4 0 16800975 18446612133395920000 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 11.18 Current children cumulated vsize (KiB) 877152 Child status: 0 Real time (s): 11.8499 CPU time (s): 11.2127 CPU user time (s): 10.9327 CPU system time (s): 0.280017 CPU usage (%): 94.6231 Max. virtual memory (cumulated for all children) (KiB): 879904 getrusage(RUSAGE_CHILDREN,...) data: user time used= 10.9327 system time used= 0.280017 maximum resident set size= 0 integral shared memory size= 0 integral unshared data size= 0 integral unshared stack size= 0 page reclaims= 83780 page faults= 2 swaps= 0 block input operations= 0 block output operations= 0 messages sent= 0 messages received= 0 signals received= 0 voluntary context switches= 1188 involuntary context switches= 1212 runsolver used 0 second user time and 0 second system time The end