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/201108251442/p2cudf-paranoid-1.13/d023d256-3477-11e0-bdb2-00163e3d3b7c.cudf.dudf-real.log.runsolver ./p2cudf-paranoid-1.13 /home/misc2010/data/2011/dudf-real//d023d256-3477-11e0-bdb2-00163e3d3b7c.cudf /home/misc2010/tmp/201108251442/p2cudf-paranoid-1.13/d023d256-3477-11e0-bdb2-00163e3d3b7c.cudf.dudf-real.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.69 1.52 1.36 5/34 28406 /proc/meminfo: memFree=270516/1048576 swapFree=0/0 [pid=28405] ppid=28404 vsize=2564 CPUtime=0 /proc/28405/stat : 28405 (p2cudf-paranoid) R 28404 28405 4778 34817 4778 4202496 356 0 0 0 0 0 0 0 25 0 1 0 11236999 2625536 269 1283457024 134512640 135304128 4290850304 18446744073709551615 4294960130 0 65538 4 65536 0 0 0 17 0 0 0 0 /proc/28405/statm: 641 269 230 194 0 28 0 [pid=28406] ppid=28405 vsize=2564 CPUtime=0 /proc/28406/stat : 28406 (p2cudf-paranoid) R 28405 28405 4778 34817 4778 4202560 0 0 0 0 0 0 0 0 25 0 1 0 11236999 2625536 39 1283457024 134512640 135304128 4290850304 18446744073709551615 4294960130 0 65538 4 65536 0 0 0 17 0 0 0 0 /proc/28406/statm: 641 39 0 194 0 28 0 [startup+0.117899 s] /proc/loadavg: 1.69 1.52 1.36 5/34 28406 /proc/meminfo: memFree=270516/1048576 swapFree=0/0 [pid=28405] ppid=28404 vsize=2564 CPUtime=0 /proc/28405/stat : 28405 (p2cudf-paranoid) S 28404 28405 4778 34817 4778 4202496 373 0 0 0 0 0 0 0 25 0 1 0 11236999 2625536 269 1283457024 134512640 135304128 4290850304 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/28405/statm: 641 269 230 194 0 28 0 [pid=28406] ppid=28405 vsize=2576 CPUtime=0.02 /proc/28406/stat : 28406 (p2cudf) S 28405 28405 4778 34817 4778 4202496 390 3016 0 1 0 0 0 2 25 0 1 0 11236999 2637824 280 1283457024 134512640 135304128 4287173264 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/28406/statm: 644 280 239 194 0 31 0 Current children cumulated CPU time (s) 0.02 Current children cumulated vsize (KiB) 5140 [startup+0.207915 s] /proc/loadavg: 1.69 1.52 1.36 5/34 28406 /proc/meminfo: memFree=270516/1048576 swapFree=0/0 [pid=28405] ppid=28404 vsize=2564 CPUtime=0 /proc/28405/stat : 28405 (p2cudf-paranoid) S 28404 28405 4778 34817 4778 4202496 373 0 0 0 0 0 0 0 25 0 1 0 11236999 2625536 269 1283457024 134512640 135304128 4290850304 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/28405/statm: 641 269 230 194 0 28 0 [pid=28406] ppid=28405 vsize=2576 CPUtime=0.02 /proc/28406/stat : 28406 (p2cudf) S 28405 28405 4778 34817 4778 4202496 390 3016 0 1 0 0 0 2 25 0 1 0 11236999 2637824 280 1283457024 134512640 135304128 4287173264 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/28406/statm: 644 280 239 194 0 31 0 Current children cumulated CPU time (s) 0.02 Current children cumulated vsize (KiB) 5140 [startup+0.30793 s] /proc/loadavg: 1.69 1.52 1.36 5/34 28406 /proc/meminfo: memFree=270516/1048576 swapFree=0/0 [pid=28405] ppid=28404 vsize=2564 CPUtime=0 /proc/28405/stat : 28405 (p2cudf-paranoid) S 28404 28405 4778 34817 4778 4202496 373 0 0 0 0 0 0 0 25 0 1 0 11236999 2625536 269 1283457024 134512640 135304128 4290850304 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/28405/statm: 641 269 230 194 0 28 0 [pid=28406] ppid=28405 vsize=2576 CPUtime=0.02 /proc/28406/stat : 28406 (p2cudf) S 28405 28405 4778 34817 4778 4202496 390 3016 0 1 0 0 0 2 25 0 1 0 11236999 2637824 280 1283457024 134512640 135304128 4287173264 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/28406/statm: 644 280 239 194 0 31 0 Current children cumulated CPU time (s) 0.02 Current children cumulated vsize (KiB) 5140 [startup+0.708041 s] /proc/loadavg: 1.69 1.52 1.36 5/34 28406 /proc/meminfo: memFree=270516/1048576 swapFree=0/0 [pid=28405] ppid=28404 vsize=2564 CPUtime=0 /proc/28405/stat : 28405 (p2cudf-paranoid) S 28404 28405 4778 34817 4778 4202496 373 0 0 0 0 0 0 0 25 0 1 0 11236999 2625536 269 1283457024 134512640 135304128 4290850304 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/28405/statm: 641 269 230 194 0 28 0 [pid=28406] ppid=28405 vsize=2576 CPUtime=0.02 /proc/28406/stat : 28406 (p2cudf) S 28405 28405 4778 34817 4778 4202496 390 3016 0 1 0 0 0 2 25 0 1 0 11236999 2637824 280 1283457024 134512640 135304128 4287173264 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/28406/statm: 644 280 239 194 0 31 0 Current children cumulated CPU time (s) 0.02 Current children cumulated vsize (KiB) 5140 [startup+1.50825 s] /proc/loadavg: 1.69 1.52 1.36 3/45 28428 /proc/meminfo: memFree=218020/1048576 swapFree=0/0 [pid=28405] ppid=28404 vsize=2564 CPUtime=0 /proc/28405/stat : 28405 (p2cudf-paranoid) S 28404 28405 4778 34817 4778 4202496 373 0 0 0 0 0 0 0 25 0 1 0 11236999 2625536 269 1283457024 134512640 135304128 4290850304 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/28405/statm: 641 269 230 194 0 28 0 [pid=28406] ppid=28405 vsize=2576 CPUtime=0.02 /proc/28406/stat : 28406 (p2cudf) S 28405 28405 4778 34817 4778 4202496 390 3016 0 1 0 0 0 2 25 0 1 0 11236999 2637824 280 1283457024 134512640 135304128 4287173264 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/28406/statm: 644 280 239 194 0 31 0 [pid=28419] ppid=28406 vsize=869528 CPUtime=1.48 /proc/28419/stat : 28419 (java) S 28406 28405 4778 34817 4778 4202496 30790 0 1 0 138 10 0 0 25 0 10 0 11237002 890396672 28422 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/28419/statm: 217382 28422 1723 10 0 214473 0 [pid=28419/tid=28420] ppid=28406 vsize=869528 CPUtime=0.9 /proc/28419/task/28420/stat : 28420 (java) R 28406 28405 4778 34817 4778 4202560 23807 0 1 0 82 8 0 0 25 0 10 0 11237003 890396672 28422 1283457024 134512640 134550932 4289725328 18446744073709551615 4095680155 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=28419/tid=28421] ppid=28406 vsize=869528 CPUtime=0 /proc/28419/task/28421/stat : 28421 (java) S 28406 28405 4778 34817 4778 4202560 7 0 0 0 0 0 0 0 15 0 10 0 11237004 890396672 28422 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 0 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=28419/tid=28422] ppid=28406 vsize=869528 CPUtime=0 /proc/28419/task/28422/stat : 28422 (java) S 28406 28405 4778 34817 4778 4202560 8 0 0 0 0 0 0 0 25 0 10 0 11237005 890396672 28422 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=28419/tid=28423] ppid=28406 vsize=869528 CPUtime=0 /proc/28419/task/28423/stat : 28423 (java) S 28406 28405 4778 34817 4778 4202560 4 0 0 0 0 0 0 0 25 0 10 0 11237005 890396672 28422 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=28419/tid=28424] ppid=28406 vsize=869528 CPUtime=0 /proc/28419/task/28424/stat : 28424 (java) S 28406 28405 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 10 0 11237007 890396672 28422 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=28419/tid=28425] ppid=28406 vsize=869528 CPUtime=0.12 /proc/28419/task/28425/stat : 28425 (java) S 28406 28405 4778 34817 4778 4202560 749 0 0 0 12 0 0 0 19 0 10 0 11237007 890396672 28422 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=28419/tid=28426] ppid=28406 vsize=869528 CPUtime=0.43 /proc/28419/task/28426/stat : 28426 (java) R 28406 28405 4778 34817 4778 4202560 5151 0 0 0 43 0 0 0 25 0 10 0 11237008 890396672 28422 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=28419/tid=28427] ppid=28406 vsize=869528 CPUtime=0 /proc/28419/task/28427/stat : 28427 (java) S 28406 28405 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 10 0 11237008 890396672 28422 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=28419/tid=28428] ppid=28406 vsize=869528 CPUtime=0 /proc/28419/task/28428/stat : 28428 (java) S 28406 28405 4778 34817 4778 4202560 2 0 0 0 0 0 0 0 15 0 10 0 11237008 890396672 28422 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 1.5 Current children cumulated vsize (KiB) 874668 [startup+3.10985 s] /proc/loadavg: 1.72 1.53 1.37 4/45 28428 /proc/meminfo: memFree=101212/1048576 swapFree=0/0 [pid=28405] ppid=28404 vsize=2564 CPUtime=0 /proc/28405/stat : 28405 (p2cudf-paranoid) S 28404 28405 4778 34817 4778 4202496 373 0 0 0 0 0 0 0 25 0 1 0 11236999 2625536 269 1283457024 134512640 135304128 4290850304 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/28405/statm: 641 269 230 194 0 28 0 [pid=28406] ppid=28405 vsize=2576 CPUtime=0.02 /proc/28406/stat : 28406 (p2cudf) S 28405 28405 4778 34817 4778 4202496 390 3016 0 1 0 0 0 2 25 0 1 0 11236999 2637824 280 1283457024 134512640 135304128 4287173264 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/28406/statm: 644 280 239 194 0 31 0 [pid=28419] ppid=28406 vsize=872040 CPUtime=3.07 /proc/28419/stat : 28419 (java) S 28406 28405 4778 34817 4778 4202496 53126 0 1 0 287 20 0 0 25 0 10 0 11237002 892968960 50063 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/28419/statm: 218010 50063 1745 10 0 215101 0 [pid=28419/tid=28420] ppid=28406 vsize=872040 CPUtime=1.65 /proc/28419/task/28420/stat : 28420 (java) R 28406 28405 4778 34817 4778 4202560 44826 0 1 0 148 17 0 0 25 0 10 0 11237003 892968960 50063 1283457024 134512640 134550932 4289725328 18446744073709551615 4095373293 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=28419/tid=28421] ppid=28406 vsize=872040 CPUtime=0 /proc/28419/task/28421/stat : 28421 (java) S 28406 28405 4778 34817 4778 4202560 7 0 0 0 0 0 0 0 15 0 10 0 11237004 892968960 50063 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 0 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=28419/tid=28422] ppid=28406 vsize=872040 CPUtime=0 /proc/28419/task/28422/stat : 28422 (java) S 28406 28405 4778 34817 4778 4202560 8 0 0 0 0 0 0 0 25 0 10 0 11237005 892968960 50063 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=28419/tid=28423] ppid=28406 vsize=872040 CPUtime=0 /proc/28419/task/28423/stat : 28423 (java) S 28406 28405 4778 34817 4778 4202560 4 0 0 0 0 0 0 0 25 0 10 0 11237005 892968960 50063 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=28419/tid=28424] ppid=28406 vsize=872040 CPUtime=0 /proc/28419/task/28424/stat : 28424 (java) S 28406 28405 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 10 0 11237007 892968960 50063 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=28419/tid=28425] ppid=28406 vsize=872040 CPUtime=0.76 /proc/28419/task/28425/stat : 28425 (java) R 28406 28405 4778 34817 4778 4202560 2021 0 0 0 75 1 0 0 16 0 10 0 11237007 892968960 50063 1283457024 134512640 134550932 4289725328 18446744073709551615 4152611260 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=28419/tid=28426] ppid=28406 vsize=872040 CPUtime=0.62 /proc/28419/task/28426/stat : 28426 (java) R 28406 28405 4778 34817 4778 4202560 5196 0 0 0 62 0 0 0 24 0 10 0 11237008 892968960 50063 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=28419/tid=28427] ppid=28406 vsize=872040 CPUtime=0 /proc/28419/task/28427/stat : 28427 (java) S 28406 28405 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 10 0 11237008 892968960 50063 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=28419/tid=28428] ppid=28406 vsize=872040 CPUtime=0 /proc/28419/task/28428/stat : 28428 (java) S 28406 28405 4778 34817 4778 4202560 2 0 0 0 0 0 0 0 15 0 10 0 11237008 892968960 50063 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 3.09 Current children cumulated vsize (KiB) 877180 Solver just ended. Dumping a history of the last processes samples [startup+3.2798 s] /proc/loadavg: 1.72 1.53 1.37 4/45 28428 /proc/meminfo: memFree=101212/1048576 swapFree=0/0 [pid=28405] ppid=28404 vsize=2564 CPUtime=0 /proc/28405/stat : 28405 (p2cudf-paranoid) S 28404 28405 4778 34817 4778 4202496 373 0 0 0 0 0 0 0 25 0 1 0 11236999 2625536 269 1283457024 134512640 135304128 4290850304 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/28405/statm: 641 269 230 194 0 28 0 [pid=28406] ppid=28405 vsize=2576 CPUtime=0.02 /proc/28406/stat : 28406 (p2cudf) S 28405 28405 4778 34817 4778 4202496 390 3016 0 1 0 0 0 2 25 0 1 0 11236999 2637824 280 1283457024 134512640 135304128 4287173264 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/28406/statm: 644 280 239 194 0 31 0 [pid=28419] ppid=28406 vsize=869252 CPUtime=3.2 /proc/28419/stat : 28419 (java) S 28406 28405 4778 34817 4778 4202496 54320 0 1 0 298 22 0 0 25 0 10 0 11237002 890114048 50791 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/28419/statm: 217313 50791 1745 10 0 214404 0 [pid=28419/tid=28420] ppid=28406 vsize=869252 CPUtime=1.73 /proc/28419/task/28420/stat : 28420 (java) R 28406 28405 4778 34817 4778 4202560 45997 0 1 0 154 19 0 0 25 0 10 0 11237003 890114048 50791 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=28419/tid=28421] ppid=28406 vsize=869252 CPUtime=0 /proc/28419/task/28421/stat : 28421 (java) S 28406 28405 4778 34817 4778 4202560 7 0 0 0 0 0 0 0 15 0 10 0 11237004 890114048 50791 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 0 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=28419/tid=28422] ppid=28406 vsize=869252 CPUtime=0 /proc/28419/task/28422/stat : 28422 (java) S 28406 28405 4778 34817 4778 4202560 8 0 0 0 0 0 0 0 25 0 10 0 11237005 890114048 50791 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=28419/tid=28423] ppid=28406 vsize=869252 CPUtime=0 /proc/28419/task/28423/stat : 28423 (java) S 28406 28405 4778 34817 4778 4202560 4 0 0 0 0 0 0 0 25 0 10 0 11237005 890114048 50791 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=28419/tid=28424] ppid=28406 vsize=869252 CPUtime=0 /proc/28419/task/28424/stat : 28424 (java) S 28406 28405 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 10 0 11237007 890114048 50791 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=28419/tid=28425] ppid=28406 vsize=869252 CPUtime=0.77 /proc/28419/task/28425/stat : 28425 (java) S 28406 28405 4778 34817 4778 4202560 2044 0 0 0 76 1 0 0 16 0 10 0 11237007 890114048 50791 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=28419/tid=28426] ppid=28406 vsize=869252 CPUtime=0.67 /proc/28419/task/28426/stat : 28426 (java) R 28406 28405 4778 34817 4778 4202560 5196 0 0 0 67 0 0 0 23 0 10 0 11237008 890114048 50791 1283457024 134512640 134550932 4289725328 18446744073709551615 4153455445 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=28419/tid=28427] ppid=28406 vsize=869252 CPUtime=0 /proc/28419/task/28427/stat : 28427 (java) S 28406 28405 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 10 0 11237008 890114048 50791 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=28419/tid=28428] ppid=28406 vsize=869252 CPUtime=0 /proc/28419/task/28428/stat : 28428 (java) S 28406 28405 4778 34817 4778 4202560 2 0 0 0 0 0 0 0 15 0 10 0 11237008 890114048 50791 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 3.22 Current children cumulated vsize (KiB) 874392 [startup+4.01002 s] /proc/loadavg: 1.72 1.53 1.37 3/45 28428 /proc/meminfo: memFree=72072/1048576 swapFree=0/0 [pid=28405] ppid=28404 vsize=2564 CPUtime=0 /proc/28405/stat : 28405 (p2cudf-paranoid) S 28404 28405 4778 34817 4778 4202496 373 0 0 0 0 0 0 0 25 0 1 0 11236999 2625536 269 1283457024 134512640 135304128 4290850304 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/28405/statm: 641 269 230 194 0 28 0 [pid=28406] ppid=28405 vsize=2576 CPUtime=0.02 /proc/28406/stat : 28406 (p2cudf) S 28405 28405 4778 34817 4778 4202496 390 3016 0 1 0 0 0 2 25 0 1 0 11236999 2637824 280 1283457024 134512640 135304128 4287173264 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/28406/statm: 644 280 239 194 0 31 0 [pid=28419] ppid=28406 vsize=869252 CPUtime=3.93 /proc/28419/stat : 28419 (java) S 28406 28405 4778 34817 4778 4202496 69306 0 1 0 367 26 0 0 25 0 10 0 11237002 890114048 65777 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/28419/statm: 217313 65777 1761 10 0 214404 0 [pid=28419/tid=28420] ppid=28406 vsize=869252 CPUtime=2.01 /proc/28419/task/28420/stat : 28420 (java) R 28406 28405 4778 34817 4778 4202560 50237 0 1 0 181 20 0 0 25 0 10 0 11237003 890114048 65777 1283457024 134512640 134550932 4289725328 18446744073709551615 4096126555 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=28419/tid=28421] ppid=28406 vsize=869252 CPUtime=0.26 /proc/28419/task/28421/stat : 28421 (java) S 28406 28405 4778 34817 4778 4202560 10717 0 0 0 24 2 0 0 16 0 10 0 11237004 890114048 65777 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 0 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=28419/tid=28422] ppid=28406 vsize=869252 CPUtime=0 /proc/28419/task/28422/stat : 28422 (java) S 28406 28405 4778 34817 4778 4202560 8 0 0 0 0 0 0 0 18 0 10 0 11237005 890114048 65777 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=28419/tid=28423] ppid=28406 vsize=869252 CPUtime=0 /proc/28419/task/28423/stat : 28423 (java) S 28406 28405 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 18 0 10 0 11237005 890114048 65777 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=28419/tid=28424] ppid=28406 vsize=869252 CPUtime=0 /proc/28419/task/28424/stat : 28424 (java) S 28406 28405 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 10 0 11237007 890114048 65777 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=28419/tid=28425] ppid=28406 vsize=869252 CPUtime=0.82 /proc/28419/task/28425/stat : 28425 (java) S 28406 28405 4778 34817 4778 4202560 2049 0 0 0 81 1 0 0 15 0 10 0 11237007 890114048 65777 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=28419/tid=28426] ppid=28406 vsize=869252 CPUtime=0.8 /proc/28419/task/28426/stat : 28426 (java) S 28406 28405 4778 34817 4778 4202560 5225 0 0 0 80 0 0 0 22 0 10 0 11237008 890114048 65777 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=28419/tid=28427] ppid=28406 vsize=869252 CPUtime=0 /proc/28419/task/28427/stat : 28427 (java) S 28406 28405 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 10 0 11237008 890114048 65777 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=28419/tid=28428] ppid=28406 vsize=869252 CPUtime=0 /proc/28419/task/28428/stat : 28428 (java) S 28406 28405 4778 34817 4778 4202560 2 0 0 0 0 0 0 0 15 0 10 0 11237008 890114048 65777 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 3.95 Current children cumulated vsize (KiB) 874392 [startup+4.80611 s] /proc/loadavg: 1.72 1.53 1.37 4/46 28429 /proc/meminfo: memFree=13296/1048576 swapFree=0/0 [pid=28405] ppid=28404 vsize=2564 CPUtime=0 /proc/28405/stat : 28405 (p2cudf-paranoid) S 28404 28405 4778 34817 4778 4202496 373 0 0 0 0 0 0 0 25 0 1 0 11236999 2625536 269 1283457024 134512640 135304128 4290850304 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/28405/statm: 641 269 230 194 0 28 0 [pid=28406] ppid=28405 vsize=2576 CPUtime=0.02 /proc/28406/stat : 28406 (p2cudf) S 28405 28405 4778 34817 4778 4202496 390 3016 0 1 0 0 0 2 25 0 1 0 11236999 2637824 280 1283457024 134512640 135304128 4287173264 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/28406/statm: 644 280 239 194 0 31 0 [pid=28419] ppid=28406 vsize=869900 CPUtime=4.38 /proc/28419/stat : 28419 (java) S 28406 28405 4778 34817 4778 4202496 69386 0 1 0 412 26 0 0 25 0 11 0 11237002 890777600 65857 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/28419/statm: 217475 65857 1773 10 0 214566 0 [pid=28419/tid=28420] ppid=28406 vsize=869900 CPUtime=2.18 /proc/28419/task/28420/stat : 28420 (java) S 28406 28405 4778 34817 4778 4202560 50270 0 1 0 198 20 0 0 25 0 11 0 11237003 890777600 65857 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=28419/tid=28421] ppid=28406 vsize=869900 CPUtime=0.26 /proc/28419/task/28421/stat : 28421 (java) S 28406 28405 4778 34817 4778 4202560 10717 0 0 0 24 2 0 0 16 0 11 0 11237004 890777600 65857 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 0 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=28419/tid=28422] ppid=28406 vsize=869900 CPUtime=0 /proc/28419/task/28422/stat : 28422 (java) S 28406 28405 4778 34817 4778 4202560 8 0 0 0 0 0 0 0 18 0 11 0 11237005 890777600 65857 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=28419/tid=28423] ppid=28406 vsize=869900 CPUtime=0 /proc/28419/task/28423/stat : 28423 (java) S 28406 28405 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 18 0 11 0 11237005 890777600 65857 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=28419/tid=28424] ppid=28406 vsize=869900 CPUtime=0 /proc/28419/task/28424/stat : 28424 (java) S 28406 28405 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 11237007 890777600 65857 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=28419/tid=28425] ppid=28406 vsize=869900 CPUtime=0.9 /proc/28419/task/28425/stat : 28425 (java) S 28406 28405 4778 34817 4778 4202560 2056 0 0 0 89 1 0 0 16 0 11 0 11237007 890777600 65857 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=28419/tid=28426] ppid=28406 vsize=869900 CPUtime=1 /proc/28419/task/28426/stat : 28426 (java) S 28406 28405 4778 34817 4778 4202560 5256 0 0 0 100 0 0 0 22 0 11 0 11237008 890777600 65857 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=28419/tid=28427] ppid=28406 vsize=869900 CPUtime=0 /proc/28419/task/28427/stat : 28427 (java) S 28406 28405 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 11237008 890777600 65857 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=28419/tid=28428] ppid=28406 vsize=869900 CPUtime=0 /proc/28419/task/28428/stat : 28428 (java) S 28406 28405 4778 34817 4778 4202560 2 0 0 0 0 0 0 0 15 0 11 0 11237008 890777600 65857 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 4.4 Current children cumulated vsize (KiB) 875040 [startup+5.01427 s] /proc/loadavg: 1.72 1.53 1.37 4/46 28429 /proc/meminfo: memFree=13296/1048576 swapFree=0/0 [pid=28405] ppid=28404 vsize=2564 CPUtime=0 /proc/28405/stat : 28405 (p2cudf-paranoid) S 28404 28405 4778 34817 4778 4202496 373 0 0 0 0 0 0 0 25 0 1 0 11236999 2625536 269 1283457024 134512640 135304128 4290850304 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/28405/statm: 641 269 230 194 0 28 0 [pid=28406] ppid=28405 vsize=2576 CPUtime=0.02 /proc/28406/stat : 28406 (p2cudf) S 28405 28405 4778 34817 4778 4202496 390 3016 0 1 0 0 0 2 25 0 1 0 11236999 2637824 280 1283457024 134512640 135304128 4287173264 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/28406/statm: 644 280 239 194 0 31 0 [pid=28419] ppid=28406 vsize=869900 CPUtime=4.43 /proc/28419/stat : 28419 (java) S 28406 28405 4778 34817 4778 4202496 69389 0 1 0 417 26 0 0 25 0 11 0 11237002 890777600 65860 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/28419/statm: 217475 65860 1773 10 0 214566 0 [pid=28419/tid=28420] ppid=28406 vsize=869900 CPUtime=2.18 /proc/28419/task/28420/stat : 28420 (java) S 28406 28405 4778 34817 4778 4202560 50270 0 1 0 198 20 0 0 25 0 11 0 11237003 890777600 65860 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=28419/tid=28421] ppid=28406 vsize=869900 CPUtime=0.26 /proc/28419/task/28421/stat : 28421 (java) S 28406 28405 4778 34817 4778 4202560 10717 0 0 0 24 2 0 0 16 0 11 0 11237004 890777600 65860 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 0 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=28419/tid=28422] ppid=28406 vsize=869900 CPUtime=0 /proc/28419/task/28422/stat : 28422 (java) S 28406 28405 4778 34817 4778 4202560 8 0 0 0 0 0 0 0 18 0 11 0 11237005 890777600 65860 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=28419/tid=28423] ppid=28406 vsize=869900 CPUtime=0 /proc/28419/task/28423/stat : 28423 (java) S 28406 28405 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 18 0 11 0 11237005 890777600 65860 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=28419/tid=28424] ppid=28406 vsize=869900 CPUtime=0 /proc/28419/task/28424/stat : 28424 (java) S 28406 28405 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 11237007 890777600 65860 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=28419/tid=28425] ppid=28406 vsize=869900 CPUtime=0.9 /proc/28419/task/28425/stat : 28425 (java) S 28406 28405 4778 34817 4778 4202560 2056 0 0 0 89 1 0 0 16 0 11 0 11237007 890777600 65860 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=28419/tid=28426] ppid=28406 vsize=869900 CPUtime=1.02 /proc/28419/task/28426/stat : 28426 (java) S 28406 28405 4778 34817 4778 4202560 5258 0 0 0 102 0 0 0 16 0 11 0 11237008 890777600 65860 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=28419/tid=28427] ppid=28406 vsize=869900 CPUtime=0 /proc/28419/task/28427/stat : 28427 (java) S 28406 28405 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 11237008 890777600 65860 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=28419/tid=28428] ppid=28406 vsize=869900 CPUtime=0 /proc/28419/task/28428/stat : 28428 (java) S 28406 28405 4778 34817 4778 4202560 2 0 0 0 0 0 0 0 15 0 11 0 11237008 890777600 65860 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 4.45 Current children cumulated vsize (KiB) 875040 [startup+5.11429 s] /proc/loadavg: 1.72 1.53 1.37 4/46 28429 /proc/meminfo: memFree=13296/1048576 swapFree=0/0 [pid=28405] ppid=28404 vsize=2564 CPUtime=0 /proc/28405/stat : 28405 (p2cudf-paranoid) S 28404 28405 4778 34817 4778 4202496 373 0 0 0 0 0 0 0 25 0 1 0 11236999 2625536 269 1283457024 134512640 135304128 4290850304 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/28405/statm: 641 269 230 194 0 28 0 [pid=28406] ppid=28405 vsize=2576 CPUtime=0.02 /proc/28406/stat : 28406 (p2cudf) S 28405 28405 4778 34817 4778 4202496 390 3016 0 1 0 0 0 2 25 0 1 0 11236999 2637824 280 1283457024 134512640 135304128 4287173264 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/28406/statm: 644 280 239 194 0 31 0 [pid=28419] ppid=28406 vsize=869900 CPUtime=4.52 /proc/28419/stat : 28419 (java) S 28406 28405 4778 34817 4778 4202496 69396 0 1 0 424 28 0 0 25 0 11 0 11237002 890777600 65867 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/28419/statm: 217475 65867 1773 10 0 214566 0 [pid=28419/tid=28420] ppid=28406 vsize=869900 CPUtime=2.18 /proc/28419/task/28420/stat : 28420 (java) S 28406 28405 4778 34817 4778 4202560 50270 0 1 0 198 20 0 0 25 0 11 0 11237003 890777600 65867 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=28419/tid=28421] ppid=28406 vsize=869900 CPUtime=0.26 /proc/28419/task/28421/stat : 28421 (java) S 28406 28405 4778 34817 4778 4202560 10717 0 0 0 24 2 0 0 16 0 11 0 11237004 890777600 65867 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 0 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=28419/tid=28422] ppid=28406 vsize=869900 CPUtime=0 /proc/28419/task/28422/stat : 28422 (java) S 28406 28405 4778 34817 4778 4202560 8 0 0 0 0 0 0 0 18 0 11 0 11237005 890777600 65867 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=28419/tid=28423] ppid=28406 vsize=869900 CPUtime=0 /proc/28419/task/28423/stat : 28423 (java) S 28406 28405 4778 34817 4778 4202560 6 0 0 0 0 0 0 0 18 0 11 0 11237005 890777600 65867 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=28419/tid=28424] ppid=28406 vsize=869900 CPUtime=0 /proc/28419/task/28424/stat : 28424 (java) S 28406 28405 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 11237007 890777600 65867 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=28419/tid=28425] ppid=28406 vsize=869900 CPUtime=0.9 /proc/28419/task/28425/stat : 28425 (java) S 28406 28405 4778 34817 4778 4202560 2056 0 0 0 89 1 0 0 16 0 11 0 11237007 890777600 65867 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=28419/tid=28426] ppid=28406 vsize=869900 CPUtime=1.06 /proc/28419/task/28426/stat : 28426 (java) R 28406 28405 4778 34817 4778 4202560 5264 0 0 0 106 0 0 0 16 0 11 0 11237008 890777600 65867 1283457024 134512640 134550932 4289725328 18446744073709551615 4152075761 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=28419/tid=28427] ppid=28406 vsize=869900 CPUtime=0 /proc/28419/task/28427/stat : 28427 (java) S 28406 28405 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 11 0 11237008 890777600 65867 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=28419/tid=28428] ppid=28406 vsize=869900 CPUtime=0 /proc/28419/task/28428/stat : 28428 (java) S 28406 28405 4778 34817 4778 4202560 2 0 0 0 0 0 0 0 15 0 11 0 11237008 890777600 65867 1283457024 134512640 134550932 4289725328 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 4.54 Current children cumulated vsize (KiB) 875040 Child status: 0 Real time (s): 5.19944 CPU time (s): 4.59629 CPU user time (s): 4.25627 CPU system time (s): 0.340021 CPU usage (%): 88.3997 Max. virtual memory (cumulated for all children) (KiB): 877180 getrusage(RUSAGE_CHILDREN,...) data: user time used= 4.25627 system time used= 0.340021 maximum resident set size= 0 integral shared memory size= 0 integral unshared data size= 0 integral unshared stack size= 0 page reclaims= 73199 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= 618 involuntary context switches= 597 runsolver used 0 second user time and 0 second system time The end