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/rand908403.cudf.difficult.log.runsolver ./p2cudf-paranoid-1.9 /home/misc2010/data/2010/difficult//rand908403.cudf /home/misc2010/tmp/201012061533/p2cudf-paranoid-1.9/rand908403.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.31 1.17 1.16 6/47 28674 /proc/meminfo: memFree=647560/1048576 swapFree=2078780/2097144 [pid=28672] ppid=28671 vsize=2572 CPUtime=0 /proc/28672/stat : 28672 (p2cudf-paranoid) S 28671 28672 2059 34821 2220 4202496 377 0 0 0 0 0 0 0 23 0 1 0 876454112 2633728 272 1283457024 134512640 135304128 4290920000 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/28672/statm: 643 272 233 194 0 29 0 [pid=28673] ppid=28672 vsize=2572 CPUtime=0 /proc/28673/stat : 28673 (p2cudf) R 28672 28672 2059 34821 2220 4202496 349 0 0 0 0 0 0 0 25 0 1 0 876454112 2633728 275 1283457024 134512640 135304128 4288365536 18446744073709551615 4294960130 0 65538 4 65536 0 0 0 17 0 0 0 0 /proc/28673/statm: 643 275 234 194 0 29 0 [pid=28674] ppid=28673 vsize=2572 CPUtime=0 /proc/28674/stat : 28674 (p2cudf) R 28673 28672 2059 34821 2220 4202560 0 0 0 0 0 0 0 0 25 0 1 0 876454112 2633728 41 1283457024 134512640 135304128 4288365536 18446744073709551615 4294960130 0 65538 4 65536 0 0 0 17 0 0 0 0 /proc/28674/statm: 643 41 0 194 0 29 0 [startup+0.138714 s] /proc/loadavg: 1.31 1.17 1.16 6/47 28674 /proc/meminfo: memFree=647560/1048576 swapFree=2078780/2097144 [pid=28672] ppid=28671 vsize=2572 CPUtime=0 /proc/28672/stat : 28672 (p2cudf-paranoid) S 28671 28672 2059 34821 2220 4202496 377 0 0 0 0 0 0 0 23 0 1 0 876454112 2633728 272 1283457024 134512640 135304128 4290920000 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/28672/statm: 643 272 233 194 0 29 0 [pid=28673] ppid=28672 vsize=2576 CPUtime=0.03 /proc/28673/stat : 28673 (p2cudf) S 28672 28672 2059 34821 2220 4202496 394 2993 0 1 0 0 2 1 25 0 1 0 876454112 2637824 283 1283457024 134512640 135304128 4288365536 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/28673/statm: 644 283 241 194 0 30 0 Current children cumulated CPU time (s) 0.03 Current children cumulated vsize (KiB) 5148 [startup+0.20874 s] /proc/loadavg: 1.31 1.17 1.16 6/47 28674 /proc/meminfo: memFree=647560/1048576 swapFree=2078780/2097144 [pid=28672] ppid=28671 vsize=2572 CPUtime=0 /proc/28672/stat : 28672 (p2cudf-paranoid) S 28671 28672 2059 34821 2220 4202496 377 0 0 0 0 0 0 0 23 0 1 0 876454112 2633728 272 1283457024 134512640 135304128 4290920000 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/28672/statm: 643 272 233 194 0 29 0 [pid=28673] ppid=28672 vsize=2576 CPUtime=0.03 /proc/28673/stat : 28673 (p2cudf) S 28672 28672 2059 34821 2220 4202496 394 2993 0 1 0 0 2 1 25 0 1 0 876454112 2637824 283 1283457024 134512640 135304128 4288365536 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/28673/statm: 644 283 241 194 0 30 0 Current children cumulated CPU time (s) 0.03 Current children cumulated vsize (KiB) 5148 [startup+0.308756 s] /proc/loadavg: 1.31 1.17 1.16 6/47 28674 /proc/meminfo: memFree=647560/1048576 swapFree=2078780/2097144 [pid=28672] ppid=28671 vsize=2572 CPUtime=0 /proc/28672/stat : 28672 (p2cudf-paranoid) S 28671 28672 2059 34821 2220 4202496 377 0 0 0 0 0 0 0 23 0 1 0 876454112 2633728 272 1283457024 134512640 135304128 4290920000 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/28672/statm: 643 272 233 194 0 29 0 [pid=28673] ppid=28672 vsize=2576 CPUtime=0.03 /proc/28673/stat : 28673 (p2cudf) S 28672 28672 2059 34821 2220 4202496 394 2993 0 1 0 0 2 1 25 0 1 0 876454112 2637824 283 1283457024 134512640 135304128 4288365536 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/28673/statm: 644 283 241 194 0 30 0 Current children cumulated CPU time (s) 0.03 Current children cumulated vsize (KiB) 5148 [startup+0.711828 s] /proc/loadavg: 1.31 1.17 1.16 6/47 28674 /proc/meminfo: memFree=647560/1048576 swapFree=2078780/2097144 [pid=28672] ppid=28671 vsize=2572 CPUtime=0 /proc/28672/stat : 28672 (p2cudf-paranoid) S 28671 28672 2059 34821 2220 4202496 377 0 0 0 0 0 0 0 23 0 1 0 876454112 2633728 272 1283457024 134512640 135304128 4290920000 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/28672/statm: 643 272 233 194 0 29 0 [pid=28673] ppid=28672 vsize=2576 CPUtime=0.03 /proc/28673/stat : 28673 (p2cudf) S 28672 28672 2059 34821 2220 4202496 394 2993 0 1 0 0 2 1 25 0 1 0 876454112 2637824 283 1283457024 134512640 135304128 4288365536 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/28673/statm: 644 283 241 194 0 30 0 Current children cumulated CPU time (s) 0.03 Current children cumulated vsize (KiB) 5148 [startup+1.51207 s] /proc/loadavg: 1.31 1.17 1.16 5/57 28695 /proc/meminfo: memFree=608660/1048576 swapFree=2078780/2097144 [pid=28672] ppid=28671 vsize=2572 CPUtime=0 /proc/28672/stat : 28672 (p2cudf-paranoid) S 28671 28672 2059 34821 2220 4202496 377 0 0 0 0 0 0 0 23 0 1 0 876454112 2633728 272 1283457024 134512640 135304128 4290920000 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/28672/statm: 643 272 233 194 0 29 0 [pid=28673] ppid=28672 vsize=2576 CPUtime=0.03 /proc/28673/stat : 28673 (p2cudf) S 28672 28672 2059 34821 2220 4202496 394 2993 0 1 0 0 2 1 25 0 1 0 876454112 2637824 283 1283457024 134512640 135304128 4288365536 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/28673/statm: 644 283 241 194 0 30 0 [pid=28686] ppid=28673 vsize=879164 CPUtime=1.45 /proc/28686/stat : 28686 (java) S 28673 28672 2059 34821 2220 4202496 18434 0 1 0 136 9 0 0 25 0 10 0 876454115 900263936 15894 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/28686/statm: 219791 15894 1741 10 0 216881 0 [pid=28686/tid=28687] ppid=28673 vsize=879164 CPUtime=0.65 /proc/28686/task/28687/stat : 28687 (java) R 28673 28672 2059 34821 2220 4202560 9418 0 1 0 60 5 0 0 25 0 10 0 876454116 900263936 15894 1283457024 134512640 134550932 4290825424 18446744073709551615 4149669264 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=28686/tid=28688] ppid=28673 vsize=879164 CPUtime=0 /proc/28686/task/28688/stat : 28688 (java) S 28673 28672 2059 34821 2220 4202560 5 0 0 0 0 0 0 0 17 0 10 0 876454118 900263936 15894 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 0 0 16800975 18446612132680194816 0 0 -1 0 0 0 0 [pid=28686/tid=28689] ppid=28673 vsize=879164 CPUtime=0 /proc/28686/task/28689/stat : 28689 (java) S 28673 28672 2059 34821 2220 4202560 9 0 0 0 0 0 0 0 25 0 10 0 876454118 900263936 15894 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 4 0 16800975 18446612132680194816 0 0 -1 0 0 0 0 [pid=28686/tid=28690] ppid=28673 vsize=879164 CPUtime=0 /proc/28686/task/28690/stat : 28690 (java) S 28673 28672 2059 34821 2220 4202560 4 0 0 0 0 0 0 0 25 0 10 0 876454118 900263936 15894 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 4 0 16800975 18446612132680194816 0 0 -1 0 0 0 0 [pid=28686/tid=28691] ppid=28673 vsize=879164 CPUtime=0 /proc/28686/task/28691/stat : 28691 (java) S 28673 28672 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 10 0 876454121 900263936 15894 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 4 0 16800975 18446612132680194816 0 0 -1 0 0 0 0 [pid=28686/tid=28692] ppid=28673 vsize=879164 CPUtime=0.28 /proc/28686/task/28692/stat : 28692 (java) R 28673 28672 2059 34821 2220 4202560 4025 0 0 0 28 0 0 0 25 0 10 0 876454121 900263936 15894 1283457024 134512640 134550932 4290825424 18446744073709551615 4150447213 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=28686/tid=28693] ppid=28673 vsize=879164 CPUtime=0.5 /proc/28686/task/28693/stat : 28693 (java) R 28673 28672 2059 34821 2220 4202560 3877 0 0 0 48 2 0 0 21 0 10 0 876454121 900263936 15894 1283457024 134512640 134550932 4290825424 18446744073709551615 4150447207 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=28686/tid=28694] ppid=28673 vsize=879164 CPUtime=0 /proc/28686/task/28694/stat : 28694 (java) S 28673 28672 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 10 0 876454121 900263936 15894 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 4 0 16800975 18446612132680194816 0 0 -1 0 0 0 0 [pid=28686/tid=28695] ppid=28673 vsize=879164 CPUtime=0 /proc/28686/task/28695/stat : 28695 (java) S 28673 28672 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 15 0 10 0 876454121 900263936 15894 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 4 0 16800975 18446612132680194816 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 1.48 Current children cumulated vsize (KiB) 884312 [startup+3.1128 s] /proc/loadavg: 1.45 1.20 1.17 2/57 28695 /proc/meminfo: memFree=546404/1048576 swapFree=2078780/2097144 [pid=28672] ppid=28671 vsize=2572 CPUtime=0 /proc/28672/stat : 28672 (p2cudf-paranoid) S 28671 28672 2059 34821 2220 4202496 377 0 0 0 0 0 0 0 23 0 1 0 876454112 2633728 272 1283457024 134512640 135304128 4290920000 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/28672/statm: 643 272 233 194 0 29 0 [pid=28673] ppid=28672 vsize=2576 CPUtime=0.03 /proc/28673/stat : 28673 (p2cudf) S 28672 28672 2059 34821 2220 4202496 394 2993 0 1 0 0 2 1 25 0 1 0 876454112 2637824 283 1283457024 134512640 135304128 4288365536 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/28673/statm: 644 283 241 194 0 30 0 [pid=28686] ppid=28673 vsize=883240 CPUtime=3.02 /proc/28686/stat : 28686 (java) S 28673 28672 2059 34821 2220 4202496 59313 0 1 0 268 34 0 0 25 0 10 0 876454115 904437760 54402 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/28686/statm: 220810 54402 1744 10 0 217900 0 [pid=28686/tid=28687] ppid=28673 vsize=883240 CPUtime=1.55 /proc/28686/task/28687/stat : 28687 (java) R 28673 28672 2059 34821 2220 4202560 46219 0 1 0 128 27 0 0 25 0 10 0 876454116 904437760 54402 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=28686/tid=28688] ppid=28673 vsize=883240 CPUtime=0 /proc/28686/task/28688/stat : 28688 (java) S 28673 28672 2059 34821 2220 4202560 5 0 0 0 0 0 0 0 16 0 10 0 876454118 904437760 54402 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 0 0 16800975 18446612132680194816 0 0 -1 0 0 0 0 [pid=28686/tid=28689] ppid=28673 vsize=883240 CPUtime=0 /proc/28686/task/28689/stat : 28689 (java) S 28673 28672 2059 34821 2220 4202560 9 0 0 0 0 0 0 0 25 0 10 0 876454118 904437760 54402 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 4 0 16800975 18446612132680194816 0 0 -1 0 0 0 0 [pid=28686/tid=28690] ppid=28673 vsize=883240 CPUtime=0 /proc/28686/task/28690/stat : 28690 (java) S 28673 28672 2059 34821 2220 4202560 4 0 0 0 0 0 0 0 25 0 10 0 876454118 904437760 54402 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 4 0 16800975 18446612132680194816 0 0 -1 0 0 0 0 [pid=28686/tid=28691] ppid=28673 vsize=883240 CPUtime=0 /proc/28686/task/28691/stat : 28691 (java) S 28673 28672 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 10 0 876454121 904437760 54402 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 4 0 16800975 18446612132680194816 0 0 -1 0 0 0 0 [pid=28686/tid=28692] ppid=28673 vsize=883240 CPUtime=0.72 /proc/28686/task/28692/stat : 28692 (java) R 28673 28672 2059 34821 2220 4202560 6969 0 0 0 69 3 0 0 18 0 10 0 876454121 904437760 54402 1283457024 134512640 134550932 4290825424 18446744073709551615 4152050187 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=28686/tid=28693] ppid=28673 vsize=883240 CPUtime=0.72 /proc/28686/task/28693/stat : 28693 (java) S 28673 28672 2059 34821 2220 4202560 5011 0 0 0 70 2 0 0 21 0 10 0 876454121 904437760 54402 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 4 0 16800975 18446612132680194816 0 0 -1 0 0 0 0 [pid=28686/tid=28694] ppid=28673 vsize=883240 CPUtime=0 /proc/28686/task/28694/stat : 28694 (java) S 28673 28672 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 10 0 876454121 904437760 54402 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 4 0 16800975 18446612132680194816 0 0 -1 0 0 0 0 [pid=28686/tid=28695] ppid=28673 vsize=883240 CPUtime=0 /proc/28686/task/28695/stat : 28695 (java) S 28673 28672 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 15 0 10 0 876454121 904437760 54402 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 4 0 16800975 18446612132680194816 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 3.05 Current children cumulated vsize (KiB) 888388 [startup+6.307 s] /proc/loadavg: 1.45 1.20 1.17 4/58 28702 /proc/meminfo: memFree=351176/1048576 swapFree=2078780/2097144 [pid=28672] ppid=28671 vsize=2572 CPUtime=0 /proc/28672/stat : 28672 (p2cudf-paranoid) S 28671 28672 2059 34821 2220 4202496 377 0 0 0 0 0 0 0 23 0 1 0 876454112 2633728 272 1283457024 134512640 135304128 4290920000 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/28672/statm: 643 272 233 194 0 29 0 [pid=28673] ppid=28672 vsize=2576 CPUtime=0.03 /proc/28673/stat : 28673 (p2cudf) S 28672 28672 2059 34821 2220 4202496 394 2993 0 1 0 0 2 1 25 0 1 0 876454112 2637824 283 1283457024 134512640 135304128 4288365536 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/28673/statm: 644 283 241 194 0 30 0 [pid=28686] ppid=28673 vsize=885220 CPUtime=5.99 /proc/28686/stat : 28686 (java) S 28673 28672 2059 34821 2220 4202496 78907 0 1 0 559 40 0 0 25 0 11 0 876454115 906465280 72517 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/28686/statm: 221305 72517 1792 10 0 218395 0 [pid=28686/tid=28687] ppid=28673 vsize=885220 CPUtime=2.78 /proc/28686/task/28687/stat : 28687 (java) S 28673 28672 2059 34821 2220 4202560 50455 0 1 0 250 28 0 0 25 0 11 0 876454116 906465280 72517 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 4 0 16800975 18446612132680194816 0 0 -1 0 0 0 0 [pid=28686/tid=28688] ppid=28673 vsize=885220 CPUtime=0.32 /proc/28686/task/28688/stat : 28688 (java) S 28673 28672 2059 34821 2220 4202560 13564 0 0 0 28 4 0 0 16 0 11 0 876454118 906465280 72517 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 0 0 16800975 18446612132680194816 0 0 -1 0 0 0 0 [pid=28686/tid=28689] ppid=28673 vsize=885220 CPUtime=0 /proc/28686/task/28689/stat : 28689 (java) S 28673 28672 2059 34821 2220 4202560 10 0 0 0 0 0 0 0 18 0 11 0 876454118 906465280 72517 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 4 0 16800975 18446612132680194816 0 0 -1 0 0 0 0 [pid=28686/tid=28690] ppid=28673 vsize=885220 CPUtime=0 /proc/28686/task/28690/stat : 28690 (java) S 28673 28672 2059 34821 2220 4202560 6 0 0 0 0 0 0 0 18 0 11 0 876454118 906465280 72517 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 4 0 16800975 18446612132680194816 0 0 -1 0 0 0 0 [pid=28686/tid=28691] ppid=28673 vsize=885220 CPUtime=0 /proc/28686/task/28691/stat : 28691 (java) S 28673 28672 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 11 0 876454121 906465280 72517 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 4 0 16800975 18446612132680194816 0 0 -1 0 0 0 0 [pid=28686/tid=28692] ppid=28673 vsize=885220 CPUtime=2.14 /proc/28686/task/28692/stat : 28692 (java) S 28673 28672 2059 34821 2220 4202560 8745 0 0 0 211 3 0 0 15 0 11 0 876454121 906465280 72517 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 4 0 16800975 18446612132680194816 0 0 -1 0 0 0 0 [pid=28686/tid=28693] ppid=28673 vsize=885220 CPUtime=0.72 /proc/28686/task/28693/stat : 28693 (java) S 28673 28672 2059 34821 2220 4202560 5011 0 0 0 70 2 0 0 21 0 11 0 876454121 906465280 72517 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 4 0 16800975 18446612132680194816 0 0 -1 0 0 0 0 [pid=28686/tid=28694] ppid=28673 vsize=885220 CPUtime=0 /proc/28686/task/28694/stat : 28694 (java) S 28673 28672 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 11 0 876454121 906465280 72517 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 4 0 16800975 18446612132680194816 0 0 -1 0 0 0 0 [pid=28686/tid=28695] ppid=28673 vsize=885220 CPUtime=0 /proc/28686/task/28695/stat : 28695 (java) S 28673 28672 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 15 0 11 0 876454121 906465280 72517 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 4 0 16800975 18446612132680194816 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 6.02 Current children cumulated vsize (KiB) 890368 Solver just ended. Dumping a history of the last processes samples [startup+6.40705 s] /proc/loadavg: 1.45 1.20 1.17 4/58 28702 /proc/meminfo: memFree=351176/1048576 swapFree=2078780/2097144 [pid=28672] ppid=28671 vsize=2572 CPUtime=0 /proc/28672/stat : 28672 (p2cudf-paranoid) S 28671 28672 2059 34821 2220 4202496 377 0 0 0 0 0 0 0 23 0 1 0 876454112 2633728 272 1283457024 134512640 135304128 4290920000 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/28672/statm: 643 272 233 194 0 29 0 [pid=28673] ppid=28672 vsize=2576 CPUtime=0.03 /proc/28673/stat : 28673 (p2cudf) S 28672 28672 2059 34821 2220 4202496 394 2993 0 1 0 0 2 1 25 0 1 0 876454112 2637824 283 1283457024 134512640 135304128 4288365536 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/28673/statm: 644 283 241 194 0 30 0 [pid=28686] ppid=28673 vsize=883440 CPUtime=5.99 /proc/28686/stat : 28686 (java) S 28673 28672 2059 34821 2220 4202496 78907 0 1 0 559 40 0 0 25 0 11 0 876454115 904642560 72104 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/28686/statm: 220860 72104 1792 10 0 217950 0 [pid=28686/tid=28687] ppid=28673 vsize=883440 CPUtime=2.78 /proc/28686/task/28687/stat : 28687 (java) S 28673 28672 2059 34821 2220 4202560 50455 0 1 0 250 28 0 0 25 0 11 0 876454116 904642560 72104 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 4 0 16800975 18446612132680194816 0 0 -1 0 0 0 0 [pid=28686/tid=28688] ppid=28673 vsize=883440 CPUtime=0.32 /proc/28686/task/28688/stat : 28688 (java) S 28673 28672 2059 34821 2220 4202560 13564 0 0 0 28 4 0 0 16 0 11 0 876454118 904642560 72104 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 0 0 16800975 18446612132680194816 0 0 -1 0 0 0 0 [pid=28686/tid=28689] ppid=28673 vsize=883440 CPUtime=0 /proc/28686/task/28689/stat : 28689 (java) S 28673 28672 2059 34821 2220 4202560 10 0 0 0 0 0 0 0 18 0 11 0 876454118 904642560 72104 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 4 0 16800975 18446612132680194816 0 0 -1 0 0 0 0 [pid=28686/tid=28690] ppid=28673 vsize=883440 CPUtime=0 /proc/28686/task/28690/stat : 28690 (java) S 28673 28672 2059 34821 2220 4202560 6 0 0 0 0 0 0 0 18 0 11 0 876454118 904642560 72104 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 4 0 16800975 18446612132680194816 0 0 -1 0 0 0 0 [pid=28686/tid=28691] ppid=28673 vsize=883440 CPUtime=0 /proc/28686/task/28691/stat : 28691 (java) S 28673 28672 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 11 0 876454121 904642560 72104 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 4 0 16800975 18446612132680194816 0 0 -1 0 0 0 0 [pid=28686/tid=28692] ppid=28673 vsize=883440 CPUtime=2.14 /proc/28686/task/28692/stat : 28692 (java) S 28673 28672 2059 34821 2220 4202560 8745 0 0 0 211 3 0 0 15 0 11 0 876454121 904642560 72104 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 4 0 16800975 18446612132680194816 0 0 -1 0 0 0 0 [pid=28686/tid=28693] ppid=28673 vsize=883440 CPUtime=0.72 /proc/28686/task/28693/stat : 28693 (java) S 28673 28672 2059 34821 2220 4202560 5011 0 0 0 70 2 0 0 21 0 11 0 876454121 904642560 72104 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 4 0 16800975 18446612132680194816 0 0 -1 0 0 0 0 [pid=28686/tid=28694] ppid=28673 vsize=883440 CPUtime=0 /proc/28686/task/28694/stat : 28694 (java) S 28673 28672 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 11 0 876454121 904642560 72104 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 4 0 16800975 18446612132680194816 0 0 -1 0 0 0 0 [pid=28686/tid=28695] ppid=28673 vsize=883440 CPUtime=0 /proc/28686/task/28695/stat : 28695 (java) S 28673 28672 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 15 0 11 0 876454121 904642560 72104 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 4 0 16800975 18446612132680194816 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 6.02 Current children cumulated vsize (KiB) 888588 [startup+6.60905 s] /proc/loadavg: 1.45 1.20 1.17 2/58 28708 /proc/meminfo: memFree=352168/1048576 swapFree=2078780/2097144 [pid=28672] ppid=28671 vsize=2572 CPUtime=0 /proc/28672/stat : 28672 (p2cudf-paranoid) S 28671 28672 2059 34821 2220 4202496 377 0 0 0 0 0 0 0 23 0 1 0 876454112 2633728 272 1283457024 134512640 135304128 4290920000 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/28672/statm: 643 272 233 194 0 29 0 [pid=28673] ppid=28672 vsize=2576 CPUtime=0.03 /proc/28673/stat : 28673 (p2cudf) S 28672 28672 2059 34821 2220 4202496 394 2993 0 1 0 0 2 1 25 0 1 0 876454112 2637824 283 1283457024 134512640 135304128 4288365536 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/28673/statm: 644 283 241 194 0 30 0 [pid=28686] ppid=28673 vsize=883440 CPUtime=5.99 /proc/28686/stat : 28686 (java) S 28673 28672 2059 34821 2220 4202496 78908 0 1 0 559 40 0 0 25 0 11 0 876454115 904642560 72105 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/28686/statm: 220860 72105 1792 10 0 217950 0 [pid=28686/tid=28687] ppid=28673 vsize=883440 CPUtime=2.78 /proc/28686/task/28687/stat : 28687 (java) S 28673 28672 2059 34821 2220 4202560 50455 0 1 0 250 28 0 0 25 0 11 0 876454116 904642560 72105 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 4 0 16800975 18446612132680194816 0 0 -1 0 0 0 0 [pid=28686/tid=28688] ppid=28673 vsize=883440 CPUtime=0.32 /proc/28686/task/28688/stat : 28688 (java) S 28673 28672 2059 34821 2220 4202560 13564 0 0 0 28 4 0 0 16 0 11 0 876454118 904642560 72105 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 0 0 16800975 18446612132680194816 0 0 -1 0 0 0 0 [pid=28686/tid=28689] ppid=28673 vsize=883440 CPUtime=0 /proc/28686/task/28689/stat : 28689 (java) S 28673 28672 2059 34821 2220 4202560 10 0 0 0 0 0 0 0 18 0 11 0 876454118 904642560 72105 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 4 0 16800975 18446612132680194816 0 0 -1 0 0 0 0 [pid=28686/tid=28690] ppid=28673 vsize=883440 CPUtime=0 /proc/28686/task/28690/stat : 28690 (java) S 28673 28672 2059 34821 2220 4202560 6 0 0 0 0 0 0 0 18 0 11 0 876454118 904642560 72105 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 4 0 16800975 18446612132680194816 0 0 -1 0 0 0 0 [pid=28686/tid=28691] ppid=28673 vsize=883440 CPUtime=0 /proc/28686/task/28691/stat : 28691 (java) S 28673 28672 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 11 0 876454121 904642560 72105 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 4 0 16800975 18446612132680194816 0 0 -1 0 0 0 0 [pid=28686/tid=28692] ppid=28673 vsize=883440 CPUtime=2.14 /proc/28686/task/28692/stat : 28692 (java) S 28673 28672 2059 34821 2220 4202560 8745 0 0 0 211 3 0 0 15 0 11 0 876454121 904642560 72105 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 4 0 16800975 18446612132680194816 0 0 -1 0 0 0 0 [pid=28686/tid=28693] ppid=28673 vsize=883440 CPUtime=0.72 /proc/28686/task/28693/stat : 28693 (java) S 28673 28672 2059 34821 2220 4202560 5011 0 0 0 70 2 0 0 21 0 11 0 876454121 904642560 72105 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 4 0 16800975 18446612132680194816 0 0 -1 0 0 0 0 [pid=28686/tid=28694] ppid=28673 vsize=883440 CPUtime=0 /proc/28686/task/28694/stat : 28694 (java) S 28673 28672 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 11 0 876454121 904642560 72105 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 4 0 16800975 18446612132680194816 0 0 -1 0 0 0 0 [pid=28686/tid=28695] ppid=28673 vsize=883440 CPUtime=0 /proc/28686/task/28695/stat : 28695 (java) S 28673 28672 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 15 0 11 0 876454121 904642560 72105 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 4 0 16800975 18446612132680194816 0 0 -1 0 0 0 0 [pid=28686/tid=28708] ppid=28673 vsize=883440 CPUtime=0 /proc/28686/task/28708/stat : 28708 (java) R 28673 28672 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 20 0 11 0 876454721 904642560 72105 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 6.02 Current children cumulated vsize (KiB) 888588 [startup+6.70305 s] /proc/loadavg: 1.45 1.20 1.17 2/58 28708 /proc/meminfo: memFree=352168/1048576 swapFree=2078780/2097144 [pid=28672] ppid=28671 vsize=2572 CPUtime=0 /proc/28672/stat : 28672 (p2cudf-paranoid) S 28671 28672 2059 34821 2220 4202496 377 0 0 0 0 0 0 0 23 0 1 0 876454112 2633728 272 1283457024 134512640 135304128 4290920000 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/28672/statm: 643 272 233 194 0 29 0 [pid=28673] ppid=28672 vsize=2576 CPUtime=0.03 /proc/28673/stat : 28673 (p2cudf) S 28672 28672 2059 34821 2220 4202496 394 2993 0 1 0 0 2 1 25 0 1 0 876454112 2637824 283 1283457024 134512640 135304128 4288365536 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/28673/statm: 644 283 241 194 0 30 0 [pid=28686] ppid=28673 vsize=883440 CPUtime=6.05 /proc/28686/stat : 28686 (java) S 28673 28672 2059 34821 2220 4202496 78909 0 1 0 563 42 0 0 25 0 10 0 876454115 904642560 72106 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/28686/statm: 220860 72106 1792 10 0 217950 0 [pid=28686/tid=28687] ppid=28673 vsize=883440 CPUtime=2.78 /proc/28686/task/28687/stat : 28687 (java) S 28673 28672 2059 34821 2220 4202560 50455 0 1 0 250 28 0 0 20 0 10 0 876454116 904642560 72106 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 4 0 16800975 18446612132680194816 0 0 -1 0 0 0 0 [pid=28686/tid=28688] ppid=28673 vsize=883440 CPUtime=0.32 /proc/28686/task/28688/stat : 28688 (java) S 28673 28672 2059 34821 2220 4202560 13564 0 0 0 28 4 0 0 16 0 10 0 876454118 904642560 72106 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 0 0 16800975 18446612132680194816 0 0 -1 0 0 0 0 [pid=28686/tid=28689] ppid=28673 vsize=883440 CPUtime=0 /proc/28686/task/28689/stat : 28689 (java) S 28673 28672 2059 34821 2220 4202560 10 0 0 0 0 0 0 0 18 0 10 0 876454118 904642560 72106 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 4 0 16800975 18446612132680194816 0 0 -1 0 0 0 0 [pid=28686/tid=28690] ppid=28673 vsize=883440 CPUtime=0 /proc/28686/task/28690/stat : 28690 (java) S 28673 28672 2059 34821 2220 4202560 6 0 0 0 0 0 0 0 18 0 10 0 876454118 904642560 72106 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 4 0 16800975 18446612132680194816 0 0 -1 0 0 0 0 [pid=28686/tid=28691] ppid=28673 vsize=883440 CPUtime=0 /proc/28686/task/28691/stat : 28691 (java) S 28673 28672 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 10 0 876454121 904642560 72106 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 4 0 16800975 18446612132680194816 0 0 -1 0 0 0 0 [pid=28686/tid=28692] ppid=28673 vsize=883440 CPUtime=2.14 /proc/28686/task/28692/stat : 28692 (java) S 28673 28672 2059 34821 2220 4202560 8745 0 0 0 211 3 0 0 15 0 10 0 876454121 904642560 72106 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 4 0 16800975 18446612132680194816 0 0 -1 0 0 0 0 [pid=28686/tid=28693] ppid=28673 vsize=883440 CPUtime=0.72 /proc/28686/task/28693/stat : 28693 (java) S 28673 28672 2059 34821 2220 4202560 5011 0 0 0 70 2 0 0 21 0 10 0 876454121 904642560 72106 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 4 0 16800975 18446612132680194816 0 0 -1 0 0 0 0 [pid=28686/tid=28694] ppid=28673 vsize=883440 CPUtime=0 /proc/28686/task/28694/stat : 28694 (java) S 28673 28672 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 25 0 10 0 876454121 904642560 72106 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 4 0 16800975 18446612132680194816 0 0 -1 0 0 0 0 [pid=28686/tid=28695] ppid=28673 vsize=883440 CPUtime=0 /proc/28686/task/28695/stat : 28695 (java) S 28673 28672 2059 34821 2220 4202560 1 0 0 0 0 0 0 0 15 0 10 0 876454121 904642560 72106 1283457024 134512640 134550932 4290825424 18446744073709551615 4294960130 0 4 0 16800975 18446612132680194816 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 6.08 Current children cumulated vsize (KiB) 888588 Child status: 0 Real time (s): 6.73546 CPU time (s): 6.10838 CPU user time (s): 5.65635 CPU system time (s): 0.452028 CPU usage (%): 90.6899 Max. virtual memory (cumulated for all children) (KiB): 892132 getrusage(RUSAGE_CHILDREN,...) data: user time used= 5.65635 system time used= 0.452028 maximum resident set size= 0 integral shared memory size= 0 integral unshared data size= 0 integral unshared stack size= 0 page reclaims= 82696 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= 960 involuntary context switches= 928 runsolver used 0.008 second user time and 0 second system time The end