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/201103031013/p2cudf-trendy-1.12/4047.cudf.caixa.log.runsolver ./p2cudf-trendy-1.12 /home/misc2010/data/misc4/caixa//4047.cudf /home/misc2010/tmp/201103031013/p2cudf-trendy-1.12/4047.cudf.caixa.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.49 1.63 1.67 5/35 879 /proc/meminfo: memFree=292008/1048576 swapFree=0/0 [pid=877] ppid=876 vsize=2568 CPUtime=0 /proc/877/stat : 877 (p2cudf-trendy-1) S 876 877 29493 34817 29493 4202496 374 0 0 0 0 0 0 0 18 0 1 0 76146676 2629632 270 1283457024 134512640 135304128 4289252544 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/877/statm: 642 270 230 194 0 29 0 [pid=878] ppid=877 vsize=2568 CPUtime=0 /proc/878/stat : 878 (p2cudf) R 877 877 29493 34817 29493 4202496 346 0 0 0 0 0 0 0 25 0 1 0 76146676 2629632 272 1283457024 134512640 135304128 4289918288 18446744073709551615 4294960130 0 65538 4 65536 0 0 0 17 0 0 0 0 /proc/878/statm: 642 272 231 194 0 29 0 [pid=879] ppid=878 vsize=2568 CPUtime=0 /proc/879/stat : 879 (p2cudf) R 878 877 29493 34817 29493 4202560 0 0 0 0 0 0 0 0 25 0 1 0 76146676 2629632 41 1283457024 134512640 135304128 4289918288 18446744073709551615 4294960130 0 65538 4 65536 0 0 0 17 0 0 0 0 /proc/879/statm: 642 41 0 194 0 29 0 [startup+0.105785 s] /proc/loadavg: 1.49 1.63 1.67 5/35 879 /proc/meminfo: memFree=292008/1048576 swapFree=0/0 [pid=877] ppid=876 vsize=2568 CPUtime=0 /proc/877/stat : 877 (p2cudf-trendy-1) S 876 877 29493 34817 29493 4202496 374 0 0 0 0 0 0 0 18 0 1 0 76146676 2629632 270 1283457024 134512640 135304128 4289252544 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/877/statm: 642 270 230 194 0 29 0 [pid=878] ppid=877 vsize=2572 CPUtime=0.03 /proc/878/stat : 878 (p2cudf) S 877 877 29493 34817 29493 4202496 393 3013 0 1 0 0 2 1 25 0 1 0 76146676 2633728 281 1283457024 134512640 135304128 4289918288 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/878/statm: 643 281 239 194 0 30 0 Current children cumulated CPU time (s) 0.03 Current children cumulated vsize (KiB) 5140 [startup+0.205777 s] /proc/loadavg: 1.49 1.63 1.67 5/35 879 /proc/meminfo: memFree=292008/1048576 swapFree=0/0 [pid=877] ppid=876 vsize=2568 CPUtime=0 /proc/877/stat : 877 (p2cudf-trendy-1) S 876 877 29493 34817 29493 4202496 374 0 0 0 0 0 0 0 18 0 1 0 76146676 2629632 270 1283457024 134512640 135304128 4289252544 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/877/statm: 642 270 230 194 0 29 0 [pid=878] ppid=877 vsize=2572 CPUtime=0.03 /proc/878/stat : 878 (p2cudf) S 877 877 29493 34817 29493 4202496 393 3013 0 1 0 0 2 1 25 0 1 0 76146676 2633728 281 1283457024 134512640 135304128 4289918288 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/878/statm: 643 281 239 194 0 30 0 Current children cumulated CPU time (s) 0.03 Current children cumulated vsize (KiB) 5140 [startup+0.305794 s] /proc/loadavg: 1.49 1.63 1.67 5/35 879 /proc/meminfo: memFree=292008/1048576 swapFree=0/0 [pid=877] ppid=876 vsize=2568 CPUtime=0 /proc/877/stat : 877 (p2cudf-trendy-1) S 876 877 29493 34817 29493 4202496 374 0 0 0 0 0 0 0 18 0 1 0 76146676 2629632 270 1283457024 134512640 135304128 4289252544 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/877/statm: 642 270 230 194 0 29 0 [pid=878] ppid=877 vsize=2572 CPUtime=0.03 /proc/878/stat : 878 (p2cudf) S 877 877 29493 34817 29493 4202496 393 3013 0 1 0 0 2 1 25 0 1 0 76146676 2633728 281 1283457024 134512640 135304128 4289918288 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/878/statm: 643 281 239 194 0 30 0 Current children cumulated CPU time (s) 0.03 Current children cumulated vsize (KiB) 5140 [startup+0.705889 s] /proc/loadavg: 1.49 1.63 1.67 5/35 879 /proc/meminfo: memFree=292008/1048576 swapFree=0/0 [pid=877] ppid=876 vsize=2568 CPUtime=0 /proc/877/stat : 877 (p2cudf-trendy-1) S 876 877 29493 34817 29493 4202496 374 0 0 0 0 0 0 0 18 0 1 0 76146676 2629632 270 1283457024 134512640 135304128 4289252544 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/877/statm: 642 270 230 194 0 29 0 [pid=878] ppid=877 vsize=2572 CPUtime=0.03 /proc/878/stat : 878 (p2cudf) S 877 877 29493 34817 29493 4202496 393 3013 0 1 0 0 2 1 25 0 1 0 76146676 2633728 281 1283457024 134512640 135304128 4289918288 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/878/statm: 643 281 239 194 0 30 0 Current children cumulated CPU time (s) 0.03 Current children cumulated vsize (KiB) 5140 [startup+1.50606 s] /proc/loadavg: 1.69 1.67 1.68 5/45 900 /proc/meminfo: memFree=245356/1048576 swapFree=0/0 [pid=877] ppid=876 vsize=2568 CPUtime=0 /proc/877/stat : 877 (p2cudf-trendy-1) S 876 877 29493 34817 29493 4202496 374 0 0 0 0 0 0 0 18 0 1 0 76146676 2629632 270 1283457024 134512640 135304128 4289252544 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/877/statm: 642 270 230 194 0 29 0 [pid=878] ppid=877 vsize=2572 CPUtime=0.03 /proc/878/stat : 878 (p2cudf) S 877 877 29493 34817 29493 4202496 393 3013 0 1 0 0 2 1 25 0 1 0 76146676 2633728 281 1283457024 134512640 135304128 4289918288 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/878/statm: 643 281 239 194 0 30 0 [pid=891] ppid=878 vsize=887700 CPUtime=1.47 /proc/891/stat : 891 (java) S 878 877 29493 34817 29493 4202496 21408 0 1 0 134 13 0 0 25 0 10 0 76146679 909004800 16789 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/891/statm: 221925 16789 1730 10 0 219016 0 [pid=891/tid=892] ppid=878 vsize=887700 CPUtime=0.75 /proc/891/task/892/stat : 892 (java) R 878 877 29493 34817 29493 4202560 8309 0 1 0 68 7 0 0 25 0 10 0 76146680 909004800 16789 1283457024 134512640 134550932 4292906704 18446744073709551615 4095588224 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=891/tid=893] ppid=878 vsize=887700 CPUtime=0 /proc/891/task/893/stat : 893 (java) S 878 877 29493 34817 29493 4202560 6 0 0 0 0 0 0 0 15 0 10 0 76146682 909004800 16789 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 0 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=894] ppid=878 vsize=887700 CPUtime=0 /proc/891/task/894/stat : 894 (java) S 878 877 29493 34817 29493 4202560 9 0 0 0 0 0 0 0 25 0 10 0 76146682 909004800 16789 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=895] ppid=878 vsize=887700 CPUtime=0 /proc/891/task/895/stat : 895 (java) S 878 877 29493 34817 29493 4202560 4 0 0 0 0 0 0 0 25 0 10 0 76146682 909004800 16789 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=896] ppid=878 vsize=887700 CPUtime=0 /proc/891/task/896/stat : 896 (java) S 878 877 29493 34817 29493 4202560 1 0 0 0 0 0 0 0 25 0 10 0 76146685 909004800 16789 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=897] ppid=878 vsize=887700 CPUtime=0.36 /proc/891/task/897/stat : 897 (java) S 878 877 29493 34817 29493 4202560 6750 0 0 0 35 1 0 0 21 0 10 0 76146685 909004800 16789 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=898] ppid=878 vsize=887700 CPUtime=0.34 /proc/891/task/898/stat : 898 (java) R 878 877 29493 34817 29493 4202560 5268 0 0 0 31 3 0 0 25 0 10 0 76146685 909004800 16789 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=891/tid=899] ppid=878 vsize=887700 CPUtime=0 /proc/891/task/899/stat : 899 (java) S 878 877 29493 34817 29493 4202560 1 0 0 0 0 0 0 0 25 0 10 0 76146685 909004800 16789 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=900] ppid=878 vsize=887700 CPUtime=0 /proc/891/task/900/stat : 900 (java) S 878 877 29493 34817 29493 4202560 2 0 0 0 0 0 0 0 15 0 10 0 76146685 909004800 16789 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 1.5 Current children cumulated vsize (KiB) 892840 [startup+3.10643 s] /proc/loadavg: 1.69 1.67 1.68 3/45 900 /proc/meminfo: memFree=223780/1048576 swapFree=0/0 [pid=877] ppid=876 vsize=2568 CPUtime=0 /proc/877/stat : 877 (p2cudf-trendy-1) S 876 877 29493 34817 29493 4202496 374 0 0 0 0 0 0 0 18 0 1 0 76146676 2629632 270 1283457024 134512640 135304128 4289252544 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/877/statm: 642 270 230 194 0 29 0 [pid=878] ppid=877 vsize=2572 CPUtime=0.03 /proc/878/stat : 878 (p2cudf) S 877 877 29493 34817 29493 4202496 393 3013 0 1 0 0 2 1 25 0 1 0 76146676 2633728 281 1283457024 134512640 135304128 4289918288 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/878/statm: 643 281 239 194 0 30 0 [pid=891] ppid=878 vsize=884572 CPUtime=3.07 /proc/891/stat : 891 (java) S 878 877 29493 34817 29493 4202496 63250 0 1 0 277 30 0 0 25 0 10 0 76146679 905801728 56345 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/891/statm: 221143 56345 1744 10 0 218234 0 [pid=891/tid=892] ppid=878 vsize=884572 CPUtime=1.61 /proc/891/task/892/stat : 892 (java) R 878 877 29493 34817 29493 4202560 47800 0 1 0 138 23 0 0 25 0 10 0 76146680 905801728 56345 1283457024 134512640 134550932 4292906704 18446744073709551615 4095600339 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=891/tid=893] ppid=878 vsize=884572 CPUtime=0 /proc/891/task/893/stat : 893 (java) S 878 877 29493 34817 29493 4202560 6 0 0 0 0 0 0 0 15 0 10 0 76146682 905801728 56345 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 0 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=894] ppid=878 vsize=884572 CPUtime=0 /proc/891/task/894/stat : 894 (java) S 878 877 29493 34817 29493 4202560 9 0 0 0 0 0 0 0 25 0 10 0 76146682 905801728 56345 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=895] ppid=878 vsize=884572 CPUtime=0 /proc/891/task/895/stat : 895 (java) S 878 877 29493 34817 29493 4202560 4 0 0 0 0 0 0 0 25 0 10 0 76146682 905801728 56345 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=896] ppid=878 vsize=884572 CPUtime=0 /proc/891/task/896/stat : 896 (java) S 878 877 29493 34817 29493 4202560 1 0 0 0 0 0 0 0 25 0 10 0 76146685 905801728 56345 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=897] ppid=878 vsize=884572 CPUtime=0.82 /proc/891/task/897/stat : 897 (java) S 878 877 29493 34817 29493 4202560 8956 0 0 0 80 2 0 0 18 0 10 0 76146685 905801728 56345 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=898] ppid=878 vsize=884572 CPUtime=0.62 /proc/891/task/898/stat : 898 (java) S 878 877 29493 34817 29493 4202560 5413 0 0 0 58 4 0 0 19 0 10 0 76146685 905801728 56345 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=899] ppid=878 vsize=884572 CPUtime=0 /proc/891/task/899/stat : 899 (java) S 878 877 29493 34817 29493 4202560 1 0 0 0 0 0 0 0 25 0 10 0 76146685 905801728 56345 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=900] ppid=878 vsize=884572 CPUtime=0 /proc/891/task/900/stat : 900 (java) S 878 877 29493 34817 29493 4202560 2 0 0 0 0 0 0 0 15 0 10 0 76146685 905801728 56345 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 3.1 Current children cumulated vsize (KiB) 889712 [startup+6.30733 s] /proc/loadavg: 1.69 1.67 1.68 2/46 901 /proc/meminfo: memFree=5816/1048576 swapFree=0/0 [pid=877] ppid=876 vsize=2568 CPUtime=0 /proc/877/stat : 877 (p2cudf-trendy-1) S 876 877 29493 34817 29493 4202496 374 0 0 0 0 0 0 0 18 0 1 0 76146676 2629632 270 1283457024 134512640 135304128 4289252544 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/877/statm: 642 270 230 194 0 29 0 [pid=878] ppid=877 vsize=2572 CPUtime=0.03 /proc/878/stat : 878 (p2cudf) S 877 877 29493 34817 29493 4202496 393 3013 0 1 0 0 2 1 25 0 1 0 76146676 2633728 281 1283457024 134512640 135304128 4289918288 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/878/statm: 643 281 239 194 0 30 0 [pid=891] ppid=878 vsize=885672 CPUtime=6.27 /proc/891/stat : 891 (java) S 878 877 29493 34817 29493 4202496 84873 0 1 0 596 31 0 0 25 0 11 0 76146679 906928128 76602 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/891/statm: 221418 76602 1780 10 0 218509 0 [pid=891/tid=892] ppid=878 vsize=885672 CPUtime=3.07 /proc/891/task/892/stat : 892 (java) R 878 877 29493 34817 29493 4202560 50257 0 1 0 284 23 0 0 25 0 11 0 76146680 906928128 76602 1283457024 134512640 134550932 4292906704 18446744073709551615 4096715212 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=891/tid=893] ppid=878 vsize=885672 CPUtime=0.39 /proc/891/task/893/stat : 893 (java) S 878 877 29493 34817 29493 4202560 17419 0 0 0 38 1 0 0 15 0 11 0 76146682 906928128 76602 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 0 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=894] ppid=878 vsize=885672 CPUtime=0 /proc/891/task/894/stat : 894 (java) S 878 877 29493 34817 29493 4202560 9 0 0 0 0 0 0 0 18 0 11 0 76146682 906928128 76602 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=895] ppid=878 vsize=885672 CPUtime=0 /proc/891/task/895/stat : 895 (java) S 878 877 29493 34817 29493 4202560 6 0 0 0 0 0 0 0 18 0 11 0 76146682 906928128 76602 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=896] ppid=878 vsize=885672 CPUtime=0 /proc/891/task/896/stat : 896 (java) S 878 877 29493 34817 29493 4202560 1 0 0 0 0 0 0 0 25 0 11 0 76146685 906928128 76602 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=897] ppid=878 vsize=885672 CPUtime=1.27 /proc/891/task/897/stat : 897 (java) S 878 877 29493 34817 29493 4202560 10581 0 0 0 125 2 0 0 16 0 11 0 76146685 906928128 76602 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=898] ppid=878 vsize=885672 CPUtime=1.51 /proc/891/task/898/stat : 898 (java) S 878 877 29493 34817 29493 4202560 5535 0 0 0 147 4 0 0 15 0 11 0 76146685 906928128 76602 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=899] ppid=878 vsize=885672 CPUtime=0 /proc/891/task/899/stat : 899 (java) S 878 877 29493 34817 29493 4202560 1 0 0 0 0 0 0 0 25 0 11 0 76146685 906928128 76602 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=900] ppid=878 vsize=885672 CPUtime=0 /proc/891/task/900/stat : 900 (java) S 878 877 29493 34817 29493 4202560 2 0 0 0 0 0 0 0 15 0 11 0 76146685 906928128 76602 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=901] ppid=878 vsize=885672 CPUtime=0 /proc/891/task/901/stat : 901 (java) S 878 877 29493 34817 29493 4202560 4 0 0 0 0 0 0 0 25 0 11 0 76147173 906928128 76602 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 6.3 Current children cumulated vsize (KiB) 890812 Solver just ended. Dumping a history of the last processes samples [startup+6.40738 s] /proc/loadavg: 1.69 1.67 1.68 2/46 901 /proc/meminfo: memFree=5816/1048576 swapFree=0/0 [pid=877] ppid=876 vsize=2568 CPUtime=0 /proc/877/stat : 877 (p2cudf-trendy-1) S 876 877 29493 34817 29493 4202496 374 0 0 0 0 0 0 0 18 0 1 0 76146676 2629632 270 1283457024 134512640 135304128 4289252544 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/877/statm: 642 270 230 194 0 29 0 [pid=878] ppid=877 vsize=2572 CPUtime=0.03 /proc/878/stat : 878 (p2cudf) S 877 877 29493 34817 29493 4202496 393 3013 0 1 0 0 2 1 25 0 1 0 76146676 2633728 281 1283457024 134512640 135304128 4289918288 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/878/statm: 643 281 239 194 0 30 0 [pid=891] ppid=878 vsize=885672 CPUtime=6.37 /proc/891/stat : 891 (java) S 878 877 29493 34817 29493 4202496 84878 0 1 0 606 31 0 0 25 0 11 0 76146679 906928128 76607 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/891/statm: 221418 76607 1780 10 0 218509 0 [pid=891/tid=892] ppid=878 vsize=885672 CPUtime=3.15 /proc/891/task/892/stat : 892 (java) R 878 877 29493 34817 29493 4202560 50261 0 1 0 292 23 0 0 25 0 11 0 76146680 906928128 76607 1283457024 134512640 134550932 4292906704 18446744073709551615 4095576840 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=891/tid=893] ppid=878 vsize=885672 CPUtime=0.39 /proc/891/task/893/stat : 893 (java) S 878 877 29493 34817 29493 4202560 17419 0 0 0 38 1 0 0 15 0 11 0 76146682 906928128 76607 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 0 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=894] ppid=878 vsize=885672 CPUtime=0 /proc/891/task/894/stat : 894 (java) S 878 877 29493 34817 29493 4202560 9 0 0 0 0 0 0 0 18 0 11 0 76146682 906928128 76607 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=895] ppid=878 vsize=885672 CPUtime=0 /proc/891/task/895/stat : 895 (java) S 878 877 29493 34817 29493 4202560 6 0 0 0 0 0 0 0 18 0 11 0 76146682 906928128 76607 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=896] ppid=878 vsize=885672 CPUtime=0 /proc/891/task/896/stat : 896 (java) S 878 877 29493 34817 29493 4202560 1 0 0 0 0 0 0 0 25 0 11 0 76146685 906928128 76607 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=897] ppid=878 vsize=885672 CPUtime=1.27 /proc/891/task/897/stat : 897 (java) S 878 877 29493 34817 29493 4202560 10581 0 0 0 125 2 0 0 16 0 11 0 76146685 906928128 76607 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=898] ppid=878 vsize=885672 CPUtime=1.53 /proc/891/task/898/stat : 898 (java) S 878 877 29493 34817 29493 4202560 5536 0 0 0 149 4 0 0 15 0 11 0 76146685 906928128 76607 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=899] ppid=878 vsize=885672 CPUtime=0 /proc/891/task/899/stat : 899 (java) S 878 877 29493 34817 29493 4202560 1 0 0 0 0 0 0 0 25 0 11 0 76146685 906928128 76607 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=900] ppid=878 vsize=885672 CPUtime=0 /proc/891/task/900/stat : 900 (java) S 878 877 29493 34817 29493 4202560 2 0 0 0 0 0 0 0 15 0 11 0 76146685 906928128 76607 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=901] ppid=878 vsize=885672 CPUtime=0 /proc/891/task/901/stat : 901 (java) S 878 877 29493 34817 29493 4202560 4 0 0 0 0 0 0 0 25 0 11 0 76147173 906928128 76607 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 6.4 Current children cumulated vsize (KiB) 890812 [startup+6.80612 s] /proc/loadavg: 1.64 1.66 1.68 1/47 902 /proc/meminfo: memFree=5684/1048576 swapFree=0/0 [pid=877] ppid=876 vsize=2568 CPUtime=0 /proc/877/stat : 877 (p2cudf-trendy-1) S 876 877 29493 34817 29493 4202496 374 0 0 0 0 0 0 0 18 0 1 0 76146676 2629632 270 1283457024 134512640 135304128 4289252544 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/877/statm: 642 270 230 194 0 29 0 [pid=878] ppid=877 vsize=2572 CPUtime=0.03 /proc/878/stat : 878 (p2cudf) S 877 877 29493 34817 29493 4202496 393 3013 0 1 0 0 2 1 25 0 1 0 76146676 2633728 281 1283457024 134512640 135304128 4289918288 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/878/statm: 643 281 239 194 0 30 0 [pid=891] ppid=878 vsize=885136 CPUtime=6.37 /proc/891/stat : 891 (java) S 878 877 29493 34817 29493 4202496 84886 0 1 0 606 31 0 0 25 0 12 0 76146679 906379264 76432 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/891/statm: 221284 76432 1780 10 0 218375 0 [pid=891/tid=892] ppid=878 vsize=885136 CPUtime=3.15 /proc/891/task/892/stat : 892 (java) S 878 877 29493 34817 29493 4202560 50265 0 1 0 292 23 0 0 25 0 12 0 76146680 906379264 76432 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=893] ppid=878 vsize=885136 CPUtime=0.39 /proc/891/task/893/stat : 893 (java) S 878 877 29493 34817 29493 4202560 17419 0 0 0 38 1 0 0 16 0 12 0 76146682 906379264 76432 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 0 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=894] ppid=878 vsize=885136 CPUtime=0 /proc/891/task/894/stat : 894 (java) S 878 877 29493 34817 29493 4202560 9 0 0 0 0 0 0 0 18 0 12 0 76146682 906379264 76432 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=895] ppid=878 vsize=885136 CPUtime=0 /proc/891/task/895/stat : 895 (java) S 878 877 29493 34817 29493 4202560 6 0 0 0 0 0 0 0 18 0 12 0 76146682 906379264 76432 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=896] ppid=878 vsize=885136 CPUtime=0 /proc/891/task/896/stat : 896 (java) S 878 877 29493 34817 29493 4202560 1 0 0 0 0 0 0 0 25 0 12 0 76146685 906379264 76432 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=897] ppid=878 vsize=885136 CPUtime=1.27 /proc/891/task/897/stat : 897 (java) S 878 877 29493 34817 29493 4202560 10581 0 0 0 125 2 0 0 16 0 12 0 76146685 906379264 76432 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=898] ppid=878 vsize=885136 CPUtime=1.53 /proc/891/task/898/stat : 898 (java) S 878 877 29493 34817 29493 4202560 5536 0 0 0 149 4 0 0 15 0 12 0 76146685 906379264 76432 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=899] ppid=878 vsize=885136 CPUtime=0 /proc/891/task/899/stat : 899 (java) S 878 877 29493 34817 29493 4202560 1 0 0 0 0 0 0 0 25 0 12 0 76146685 906379264 76432 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=900] ppid=878 vsize=885136 CPUtime=0 /proc/891/task/900/stat : 900 (java) S 878 877 29493 34817 29493 4202560 2 0 0 0 0 0 0 0 15 0 12 0 76146685 906379264 76432 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=901] ppid=878 vsize=885136 CPUtime=0 /proc/891/task/901/stat : 901 (java) S 878 877 29493 34817 29493 4202560 4 0 0 0 0 0 0 0 25 0 12 0 76147173 906379264 76432 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=902] ppid=878 vsize=885136 CPUtime=0 /proc/891/task/902/stat : 902 (java) S 878 877 29493 34817 29493 4202560 4 0 0 0 0 0 0 0 25 0 12 0 76147317 906379264 76432 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 6.4 Current children cumulated vsize (KiB) 890276 [startup+7.00617 s] /proc/loadavg: 1.64 1.66 1.68 1/47 902 /proc/meminfo: memFree=5684/1048576 swapFree=0/0 [pid=877] ppid=876 vsize=2568 CPUtime=0 /proc/877/stat : 877 (p2cudf-trendy-1) S 876 877 29493 34817 29493 4202496 374 0 0 0 0 0 0 0 18 0 1 0 76146676 2629632 270 1283457024 134512640 135304128 4289252544 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/877/statm: 642 270 230 194 0 29 0 [pid=878] ppid=877 vsize=2572 CPUtime=0.03 /proc/878/stat : 878 (p2cudf) S 877 877 29493 34817 29493 4202496 393 3013 0 1 0 0 2 1 25 0 1 0 76146676 2633728 281 1283457024 134512640 135304128 4289918288 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/878/statm: 643 281 239 194 0 30 0 [pid=891] ppid=878 vsize=885136 CPUtime=6.46 /proc/891/stat : 891 (java) S 878 877 29493 34817 29493 4202496 84890 0 1 0 613 33 0 0 25 0 12 0 76146679 906379264 76436 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/891/statm: 221284 76436 1780 10 0 218375 0 [pid=891/tid=892] ppid=878 vsize=885136 CPUtime=3.15 /proc/891/task/892/stat : 892 (java) S 878 877 29493 34817 29493 4202560 50265 0 1 0 292 23 0 0 25 0 12 0 76146680 906379264 76436 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=893] ppid=878 vsize=885136 CPUtime=0.39 /proc/891/task/893/stat : 893 (java) S 878 877 29493 34817 29493 4202560 17419 0 0 0 38 1 0 0 16 0 12 0 76146682 906379264 76436 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 0 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=894] ppid=878 vsize=885136 CPUtime=0 /proc/891/task/894/stat : 894 (java) S 878 877 29493 34817 29493 4202560 9 0 0 0 0 0 0 0 18 0 12 0 76146682 906379264 76436 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=895] ppid=878 vsize=885136 CPUtime=0 /proc/891/task/895/stat : 895 (java) S 878 877 29493 34817 29493 4202560 6 0 0 0 0 0 0 0 18 0 12 0 76146682 906379264 76436 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=896] ppid=878 vsize=885136 CPUtime=0 /proc/891/task/896/stat : 896 (java) S 878 877 29493 34817 29493 4202560 1 0 0 0 0 0 0 0 25 0 12 0 76146685 906379264 76436 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=897] ppid=878 vsize=885136 CPUtime=1.27 /proc/891/task/897/stat : 897 (java) S 878 877 29493 34817 29493 4202560 10581 0 0 0 125 2 0 0 16 0 12 0 76146685 906379264 76436 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=898] ppid=878 vsize=885136 CPUtime=1.55 /proc/891/task/898/stat : 898 (java) S 878 877 29493 34817 29493 4202560 5539 0 0 0 151 4 0 0 16 0 12 0 76146685 906379264 76436 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=899] ppid=878 vsize=885136 CPUtime=0 /proc/891/task/899/stat : 899 (java) S 878 877 29493 34817 29493 4202560 1 0 0 0 0 0 0 0 25 0 12 0 76146685 906379264 76436 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=900] ppid=878 vsize=885136 CPUtime=0 /proc/891/task/900/stat : 900 (java) S 878 877 29493 34817 29493 4202560 2 0 0 0 0 0 0 0 15 0 12 0 76146685 906379264 76436 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=901] ppid=878 vsize=885136 CPUtime=0 /proc/891/task/901/stat : 901 (java) S 878 877 29493 34817 29493 4202560 4 0 0 0 0 0 0 0 25 0 12 0 76147173 906379264 76436 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=902] ppid=878 vsize=885136 CPUtime=0.08 /proc/891/task/902/stat : 902 (java) R 878 877 29493 34817 29493 4202560 5 0 0 0 6 2 0 0 21 0 12 0 76147317 906379264 76436 1283457024 134512640 134550932 4292906704 18446744073709551615 4095572012 0 4 0 16800975 0 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 6.49 Current children cumulated vsize (KiB) 890276 [startup+7.10613 s] /proc/loadavg: 1.64 1.66 1.68 1/47 902 /proc/meminfo: memFree=5684/1048576 swapFree=0/0 [pid=877] ppid=876 vsize=2568 CPUtime=0 /proc/877/stat : 877 (p2cudf-trendy-1) S 876 877 29493 34817 29493 4202496 374 0 0 0 0 0 0 0 18 0 1 0 76146676 2629632 270 1283457024 134512640 135304128 4289252544 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/877/statm: 642 270 230 194 0 29 0 [pid=878] ppid=877 vsize=2572 CPUtime=0.03 /proc/878/stat : 878 (p2cudf) S 877 877 29493 34817 29493 4202496 393 3013 0 1 0 0 2 1 25 0 1 0 76146676 2633728 281 1283457024 134512640 135304128 4289918288 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/878/statm: 643 281 239 194 0 30 0 [pid=891] ppid=878 vsize=885136 CPUtime=6.55 /proc/891/stat : 891 (java) S 878 877 29493 34817 29493 4202496 84897 0 1 0 618 37 0 0 25 0 11 0 76146679 906379264 76443 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/891/statm: 221284 76443 1781 10 0 218375 0 [pid=891/tid=892] ppid=878 vsize=885136 CPUtime=3.15 /proc/891/task/892/stat : 892 (java) S 878 877 29493 34817 29493 4202560 50265 0 1 0 292 23 0 0 19 0 11 0 76146680 906379264 76443 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=893] ppid=878 vsize=885136 CPUtime=0.39 /proc/891/task/893/stat : 893 (java) S 878 877 29493 34817 29493 4202560 17419 0 0 0 38 1 0 0 16 0 11 0 76146682 906379264 76443 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 0 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=894] ppid=878 vsize=885136 CPUtime=0 /proc/891/task/894/stat : 894 (java) S 878 877 29493 34817 29493 4202560 9 0 0 0 0 0 0 0 18 0 11 0 76146682 906379264 76443 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=895] ppid=878 vsize=885136 CPUtime=0 /proc/891/task/895/stat : 895 (java) S 878 877 29493 34817 29493 4202560 6 0 0 0 0 0 0 0 18 0 11 0 76146682 906379264 76443 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=896] ppid=878 vsize=885136 CPUtime=0 /proc/891/task/896/stat : 896 (java) S 878 877 29493 34817 29493 4202560 1 0 0 0 0 0 0 0 25 0 11 0 76146685 906379264 76443 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=897] ppid=878 vsize=885136 CPUtime=1.27 /proc/891/task/897/stat : 897 (java) S 878 877 29493 34817 29493 4202560 10581 0 0 0 125 2 0 0 16 0 11 0 76146685 906379264 76443 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=898] ppid=878 vsize=885136 CPUtime=1.58 /proc/891/task/898/stat : 898 (java) S 878 877 29493 34817 29493 4202560 5545 0 0 0 154 4 0 0 15 0 11 0 76146685 906379264 76443 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=899] ppid=878 vsize=885136 CPUtime=0 /proc/891/task/899/stat : 899 (java) S 878 877 29493 34817 29493 4202560 1 0 0 0 0 0 0 0 25 0 11 0 76146685 906379264 76443 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=900] ppid=878 vsize=885136 CPUtime=0 /proc/891/task/900/stat : 900 (java) S 878 877 29493 34817 29493 4202560 2 0 0 0 0 0 0 0 15 0 11 0 76146685 906379264 76443 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 [pid=891/tid=901] ppid=878 vsize=885136 CPUtime=0 /proc/891/task/901/stat : 901 (java) S 878 877 29493 34817 29493 4202560 4 0 0 0 0 0 0 0 25 0 11 0 76147173 906379264 76443 1283457024 134512640 134550932 4292906704 18446744073709551615 4294960130 0 4 0 16800975 18446612133396264960 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 6.58 Current children cumulated vsize (KiB) 890276 Child status: 0 Real time (s): 7.17457 CPU time (s): 6.62041 CPU user time (s): 6.20439 CPU system time (s): 0.416026 CPU usage (%): 92.2761 Max. virtual memory (cumulated for all children) (KiB): 895436 getrusage(RUSAGE_CHILDREN,...) data: user time used= 6.20439 system time used= 0.416026 maximum resident set size= 0 integral shared memory size= 0 integral unshared data size= 0 integral unshared stack size= 0 page reclaims= 88697 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= 783 involuntary context switches= 789 runsolver used 0 second user time and 0 second system time The end