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/201108241238/p2cudf-trendy-1.13/e69a0e36-9ef1-11df-9d4a-00163e46d37a.cudf.dudf-real.log.runsolver ./p2cudf-trendy-1.13 /home/misc2010/data/2011/dudf-real//e69a0e36-9ef1-11df-9d4a-00163e46d37a.cudf /home/misc2010/tmp/201108241238/p2cudf-trendy-1.13/e69a0e36-9ef1-11df-9d4a-00163e46d37a.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.10 1.08 1.09 5/35 1650 /proc/meminfo: memFree=296196/1048576 swapFree=0/0 [pid=1648] ppid=1647 vsize=2564 CPUtime=0 /proc/1648/stat : 1648 (p2cudf-trendy-1) S 1647 1648 1511 34817 1511 4202496 372 0 0 0 0 0 0 0 18 0 1 0 5202899 2625536 269 1283457024 134512640 135304128 4294594960 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/1648/statm: 641 269 230 194 0 28 0 [pid=1649] ppid=1648 vsize=2564 CPUtime=0 /proc/1649/stat : 1649 (p2cudf) R 1648 1648 1511 34817 1511 4202496 345 0 0 0 0 0 0 0 25 0 1 0 5202899 2625536 271 1283457024 134512640 135304128 4289740000 18446744073709551615 4294960130 0 65538 4 65536 0 0 0 17 0 0 0 0 /proc/1649/statm: 641 271 231 194 0 28 0 [pid=1650] ppid=1649 vsize=2564 CPUtime=0 /proc/1650/stat : 1650 (p2cudf) R 1649 1648 1511 34817 1511 4202560 0 0 0 0 0 0 0 0 25 0 1 0 5202900 2625536 40 1283457024 134512640 135304128 4289740000 18446744073709551615 4294960130 0 65538 4 65536 0 0 0 17 0 0 0 0 /proc/1650/statm: 641 40 0 194 0 28 0 [startup+0.165837 s] /proc/loadavg: 1.10 1.08 1.09 5/35 1650 /proc/meminfo: memFree=296196/1048576 swapFree=0/0 [pid=1648] ppid=1647 vsize=2564 CPUtime=0 /proc/1648/stat : 1648 (p2cudf-trendy-1) S 1647 1648 1511 34817 1511 4202496 372 0 0 0 0 0 0 0 18 0 1 0 5202899 2625536 269 1283457024 134512640 135304128 4294594960 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/1648/statm: 641 269 230 194 0 28 0 [pid=1649] ppid=1648 vsize=2568 CPUtime=0.03 /proc/1649/stat : 1649 (p2cudf) S 1648 1648 1511 34817 1511 4202496 391 3012 0 1 0 0 1 2 25 0 1 0 5202899 2629632 280 1283457024 134512640 135304128 4289740000 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/1649/statm: 642 280 239 194 0 29 0 Current children cumulated CPU time (s) 0.03 Current children cumulated vsize (KiB) 5132 [startup+0.205832 s] /proc/loadavg: 1.10 1.08 1.09 5/35 1650 /proc/meminfo: memFree=296196/1048576 swapFree=0/0 [pid=1648] ppid=1647 vsize=2564 CPUtime=0 /proc/1648/stat : 1648 (p2cudf-trendy-1) S 1647 1648 1511 34817 1511 4202496 372 0 0 0 0 0 0 0 18 0 1 0 5202899 2625536 269 1283457024 134512640 135304128 4294594960 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/1648/statm: 641 269 230 194 0 28 0 [pid=1649] ppid=1648 vsize=2568 CPUtime=0.03 /proc/1649/stat : 1649 (p2cudf) S 1648 1648 1511 34817 1511 4202496 391 3012 0 1 0 0 1 2 25 0 1 0 5202899 2629632 280 1283457024 134512640 135304128 4289740000 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/1649/statm: 642 280 239 194 0 29 0 Current children cumulated CPU time (s) 0.03 Current children cumulated vsize (KiB) 5132 [startup+0.305842 s] /proc/loadavg: 1.10 1.08 1.09 5/35 1650 /proc/meminfo: memFree=296196/1048576 swapFree=0/0 [pid=1648] ppid=1647 vsize=2564 CPUtime=0 /proc/1648/stat : 1648 (p2cudf-trendy-1) S 1647 1648 1511 34817 1511 4202496 372 0 0 0 0 0 0 0 18 0 1 0 5202899 2625536 269 1283457024 134512640 135304128 4294594960 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/1648/statm: 641 269 230 194 0 28 0 [pid=1649] ppid=1648 vsize=2568 CPUtime=0.03 /proc/1649/stat : 1649 (p2cudf) S 1648 1648 1511 34817 1511 4202496 391 3012 0 1 0 0 1 2 25 0 1 0 5202899 2629632 280 1283457024 134512640 135304128 4289740000 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/1649/statm: 642 280 239 194 0 29 0 Current children cumulated CPU time (s) 0.03 Current children cumulated vsize (KiB) 5132 [startup+0.705906 s] /proc/loadavg: 1.10 1.08 1.09 5/35 1650 /proc/meminfo: memFree=296196/1048576 swapFree=0/0 [pid=1648] ppid=1647 vsize=2564 CPUtime=0 /proc/1648/stat : 1648 (p2cudf-trendy-1) S 1647 1648 1511 34817 1511 4202496 372 0 0 0 0 0 0 0 18 0 1 0 5202899 2625536 269 1283457024 134512640 135304128 4294594960 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/1648/statm: 641 269 230 194 0 28 0 [pid=1649] ppid=1648 vsize=2568 CPUtime=0.03 /proc/1649/stat : 1649 (p2cudf) S 1648 1648 1511 34817 1511 4202496 391 3012 0 1 0 0 1 2 25 0 1 0 5202899 2629632 280 1283457024 134512640 135304128 4289740000 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/1649/statm: 642 280 239 194 0 29 0 Current children cumulated CPU time (s) 0.03 Current children cumulated vsize (KiB) 5132 [startup+1.506 s] /proc/loadavg: 1.10 1.08 1.09 3/45 1671 /proc/meminfo: memFree=242972/1048576 swapFree=0/0 [pid=1648] ppid=1647 vsize=2564 CPUtime=0 /proc/1648/stat : 1648 (p2cudf-trendy-1) S 1647 1648 1511 34817 1511 4202496 372 0 0 0 0 0 0 0 18 0 1 0 5202899 2625536 269 1283457024 134512640 135304128 4294594960 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/1648/statm: 641 269 230 194 0 28 0 [pid=1649] ppid=1648 vsize=2568 CPUtime=0.03 /proc/1649/stat : 1649 (p2cudf) S 1648 1648 1511 34817 1511 4202496 391 3012 0 1 0 0 1 2 25 0 1 0 5202899 2629632 280 1283457024 134512640 135304128 4289740000 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/1649/statm: 642 280 239 194 0 29 0 [pid=1662] ppid=1649 vsize=885216 CPUtime=1.47 /proc/1662/stat : 1662 (java) S 1649 1648 1511 34817 1511 4202496 22245 0 1 0 137 10 0 0 25 0 10 0 5202903 906461184 18739 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/1662/statm: 221304 18739 1724 10 0 218395 0 [pid=1662/tid=1663] ppid=1649 vsize=885216 CPUtime=0.8 /proc/1662/task/1663/stat : 1663 (java) R 1649 1648 1511 34817 1511 4202560 10606 0 1 0 72 8 0 0 25 0 10 0 5202903 906461184 18739 1283457024 134512640 134550932 4289932208 18446744073709551615 4095519624 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=1662/tid=1664] ppid=1649 vsize=885216 CPUtime=0 /proc/1662/task/1664/stat : 1664 (java) S 1649 1648 1511 34817 1511 4202560 7 0 0 0 0 0 0 0 18 0 10 0 5202905 906461184 18739 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 0 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1665] ppid=1649 vsize=885216 CPUtime=0 /proc/1662/task/1665/stat : 1665 (java) S 1649 1648 1511 34817 1511 4202560 8 0 0 0 0 0 0 0 25 0 10 0 5202905 906461184 18739 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1666] ppid=1649 vsize=885216 CPUtime=0 /proc/1662/task/1666/stat : 1666 (java) S 1649 1648 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 10 0 5202905 906461184 18739 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1667] ppid=1649 vsize=885216 CPUtime=0 /proc/1662/task/1667/stat : 1667 (java) S 1649 1648 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 5202908 906461184 18739 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1668] ppid=1649 vsize=885216 CPUtime=0.44 /proc/1662/task/1668/stat : 1668 (java) R 1649 1648 1511 34817 1511 4202560 8432 0 0 0 42 2 0 0 25 0 10 0 5202908 906461184 18739 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=1662/tid=1669] ppid=1649 vsize=885216 CPUtime=0.21 /proc/1662/task/1669/stat : 1669 (java) R 1649 1648 1511 34817 1511 4202560 2129 0 0 0 21 0 0 0 18 0 10 0 5202908 906461184 18739 1283457024 134512640 134550932 4289932208 18446744073709551615 4152472211 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=1662/tid=1670] ppid=1649 vsize=885216 CPUtime=0 /proc/1662/task/1670/stat : 1670 (java) S 1649 1648 1511 34817 1511 4202560 0 0 0 0 0 0 0 0 25 0 10 0 5202908 906461184 18739 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1671] ppid=1649 vsize=885216 CPUtime=0 /proc/1662/task/1671/stat : 1671 (java) S 1649 1648 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 15 0 10 0 5202908 906461184 18739 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 1.5 Current children cumulated vsize (KiB) 890348 [startup+3.10629 s] /proc/loadavg: 1.10 1.08 1.09 2/45 1671 /proc/meminfo: memFree=149104/1048576 swapFree=0/0 [pid=1648] ppid=1647 vsize=2564 CPUtime=0 /proc/1648/stat : 1648 (p2cudf-trendy-1) S 1647 1648 1511 34817 1511 4202496 372 0 0 0 0 0 0 0 18 0 1 0 5202899 2625536 269 1283457024 134512640 135304128 4294594960 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/1648/statm: 641 269 230 194 0 28 0 [pid=1649] ppid=1648 vsize=2568 CPUtime=0.03 /proc/1649/stat : 1649 (p2cudf) S 1648 1648 1511 34817 1511 4202496 391 3012 0 1 0 0 1 2 25 0 1 0 5202899 2629632 280 1283457024 134512640 135304128 4289740000 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/1649/statm: 642 280 239 194 0 29 0 [pid=1662] ppid=1649 vsize=882012 CPUtime=3.07 /proc/1662/stat : 1662 (java) S 1649 1648 1511 34817 1511 4202496 74307 0 1 0 277 30 0 0 25 0 10 0 5202903 903180288 70196 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/1662/statm: 220503 70196 1743 10 0 217594 0 [pid=1662/tid=1663] ppid=1649 vsize=882012 CPUtime=1.7 /proc/1662/task/1663/stat : 1663 (java) R 1649 1648 1511 34817 1511 4202560 50091 0 1 0 145 25 0 0 25 0 10 0 5202903 903180288 70196 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=1662/tid=1664] ppid=1649 vsize=882012 CPUtime=0.25 /proc/1662/task/1664/stat : 1664 (java) S 1649 1648 1511 34817 1511 4202560 12286 0 0 0 23 2 0 0 16 0 10 0 5202905 903180288 70196 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 0 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1665] ppid=1649 vsize=882012 CPUtime=0 /proc/1662/task/1665/stat : 1665 (java) S 1649 1648 1511 34817 1511 4202560 8 0 0 0 0 0 0 0 18 0 10 0 5202905 903180288 70196 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1666] ppid=1649 vsize=882012 CPUtime=0 /proc/1662/task/1666/stat : 1666 (java) S 1649 1648 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 10 0 5202905 903180288 70196 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1667] ppid=1649 vsize=882012 CPUtime=0 /proc/1662/task/1667/stat : 1667 (java) S 1649 1648 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 5202908 903180288 70196 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1668] ppid=1649 vsize=882012 CPUtime=0.7 /proc/1662/task/1668/stat : 1668 (java) R 1649 1648 1511 34817 1511 4202560 8530 0 0 0 68 2 0 0 16 0 10 0 5202908 903180288 70196 1283457024 134512640 134550932 4289932208 18446744073709551615 4150100244 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=1662/tid=1669] ppid=1649 vsize=882012 CPUtime=0.39 /proc/1662/task/1669/stat : 1669 (java) S 1649 1648 1511 34817 1511 4202560 2327 0 0 0 39 0 0 0 16 0 10 0 5202908 903180288 70196 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1670] ppid=1649 vsize=882012 CPUtime=0 /proc/1662/task/1670/stat : 1670 (java) S 1649 1648 1511 34817 1511 4202560 0 0 0 0 0 0 0 0 25 0 10 0 5202908 903180288 70196 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1671] ppid=1649 vsize=882012 CPUtime=0 /proc/1662/task/1671/stat : 1671 (java) S 1649 1648 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 15 0 10 0 5202908 903180288 70196 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 3.1 Current children cumulated vsize (KiB) 887144 [startup+6.30746 s] /proc/loadavg: 1.26 1.11 1.10 3/45 1671 /proc/meminfo: memFree=5208/1048576 swapFree=0/0 [pid=1648] ppid=1647 vsize=2564 CPUtime=0 /proc/1648/stat : 1648 (p2cudf-trendy-1) S 1647 1648 1511 34817 1511 4202496 372 0 0 0 0 0 0 0 18 0 1 0 5202899 2625536 269 1283457024 134512640 135304128 4294594960 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/1648/statm: 641 269 230 194 0 28 0 [pid=1649] ppid=1648 vsize=2568 CPUtime=0.03 /proc/1649/stat : 1649 (p2cudf) S 1648 1648 1511 34817 1511 4202496 391 3012 0 1 0 0 1 2 25 0 1 0 5202899 2629632 280 1283457024 134512640 135304128 4289740000 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/1649/statm: 642 280 239 194 0 29 0 [pid=1662] ppid=1649 vsize=882368 CPUtime=6.26 /proc/1662/stat : 1662 (java) S 1649 1648 1511 34817 1511 4202496 88119 0 1 0 593 33 0 0 25 0 11 0 5202903 903544832 82212 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/1662/statm: 220592 82212 1774 10 0 217683 0 [pid=1662/tid=1663] ppid=1649 vsize=882368 CPUtime=2.97 /proc/1662/task/1663/stat : 1663 (java) R 1649 1648 1511 34817 1511 4202560 50271 0 1 0 272 25 0 0 25 0 11 0 5202903 903544832 82212 1283457024 134512640 134550932 4289932208 18446744073709551615 4096318367 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=1662/tid=1664] ppid=1649 vsize=882368 CPUtime=0.54 /proc/1662/task/1664/stat : 1664 (java) S 1649 1648 1511 34817 1511 4202560 23865 0 0 0 50 4 0 0 16 0 11 0 5202905 903544832 82212 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 0 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1665] ppid=1649 vsize=882368 CPUtime=0 /proc/1662/task/1665/stat : 1665 (java) S 1649 1648 1511 34817 1511 4202560 8 0 0 0 0 0 0 0 18 0 11 0 5202905 903544832 82212 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1666] ppid=1649 vsize=882368 CPUtime=0 /proc/1662/task/1666/stat : 1666 (java) S 1649 1648 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 5202905 903544832 82212 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1667] ppid=1649 vsize=882368 CPUtime=0 /proc/1662/task/1667/stat : 1667 (java) S 1649 1648 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 5202908 903544832 82212 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1668] ppid=1649 vsize=882368 CPUtime=2.32 /proc/1662/task/1668/stat : 1668 (java) S 1649 1648 1511 34817 1511 4202560 10579 0 0 0 230 2 0 0 15 0 11 0 5202908 903544832 82212 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1669] ppid=1649 vsize=882368 CPUtime=0.39 /proc/1662/task/1669/stat : 1669 (java) S 1649 1648 1511 34817 1511 4202560 2327 0 0 0 39 0 0 0 16 0 11 0 5202908 903544832 82212 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1670] ppid=1649 vsize=882368 CPUtime=0 /proc/1662/task/1670/stat : 1670 (java) S 1649 1648 1511 34817 1511 4202560 0 0 0 0 0 0 0 0 25 0 11 0 5202908 903544832 82212 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1671] ppid=1649 vsize=882368 CPUtime=0 /proc/1662/task/1671/stat : 1671 (java) S 1649 1648 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 15 0 11 0 5202908 903544832 82212 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 6.29 Current children cumulated vsize (KiB) 887500 [startup+12.7099 s] /proc/loadavg: 1.23 1.11 1.10 3/46 1672 /proc/meminfo: memFree=7084/1048576 swapFree=0/0 [pid=1648] ppid=1647 vsize=2564 CPUtime=0 /proc/1648/stat : 1648 (p2cudf-trendy-1) S 1647 1648 1511 34817 1511 4202496 372 0 0 0 0 0 0 0 18 0 1 0 5202899 2625536 269 1283457024 134512640 135304128 4294594960 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/1648/statm: 641 269 230 194 0 28 0 [pid=1649] ppid=1648 vsize=2568 CPUtime=0.03 /proc/1649/stat : 1649 (p2cudf) S 1648 1648 1511 34817 1511 4202496 391 3012 0 1 0 0 1 2 25 0 1 0 5202899 2629632 280 1283457024 134512640 135304128 4289740000 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/1649/statm: 642 280 239 194 0 29 0 [pid=1662] ppid=1649 vsize=880660 CPUtime=12.66 /proc/1662/stat : 1662 (java) S 1649 1648 1511 34817 1511 4202496 88173 0 1 0 1233 33 0 0 25 0 11 0 5202903 901795840 81868 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/1662/statm: 220165 81868 1782 10 0 217256 0 [pid=1662/tid=1663] ppid=1649 vsize=880660 CPUtime=9.04 /proc/1662/task/1663/stat : 1663 (java) R 1649 1648 1511 34817 1511 4202560 50284 0 1 0 879 25 0 0 25 0 11 0 5202903 901795840 81868 1283457024 134512640 134550932 4289932208 18446744073709551615 4096499340 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=1662/tid=1664] ppid=1649 vsize=880660 CPUtime=0.54 /proc/1662/task/1664/stat : 1664 (java) S 1649 1648 1511 34817 1511 4202560 23865 0 0 0 50 4 0 0 16 0 11 0 5202905 901795840 81868 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 0 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1665] ppid=1649 vsize=880660 CPUtime=0 /proc/1662/task/1665/stat : 1665 (java) S 1649 1648 1511 34817 1511 4202560 8 0 0 0 0 0 0 0 18 0 11 0 5202905 901795840 81868 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1666] ppid=1649 vsize=880660 CPUtime=0 /proc/1662/task/1666/stat : 1666 (java) S 1649 1648 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 5202905 901795840 81868 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1667] ppid=1649 vsize=880660 CPUtime=0 /proc/1662/task/1667/stat : 1667 (java) S 1649 1648 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 5202908 901795840 81868 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1668] ppid=1649 vsize=880660 CPUtime=2.66 /proc/1662/task/1668/stat : 1668 (java) S 1649 1648 1511 34817 1511 4202560 10620 0 0 0 264 2 0 0 15 0 11 0 5202908 901795840 81868 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1669] ppid=1649 vsize=880660 CPUtime=0.39 /proc/1662/task/1669/stat : 1669 (java) S 1649 1648 1511 34817 1511 4202560 2327 0 0 0 39 0 0 0 16 0 11 0 5202908 901795840 81868 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1670] ppid=1649 vsize=880660 CPUtime=0 /proc/1662/task/1670/stat : 1670 (java) S 1649 1648 1511 34817 1511 4202560 0 0 0 0 0 0 0 0 25 0 11 0 5202908 901795840 81868 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1671] ppid=1649 vsize=880660 CPUtime=0 /proc/1662/task/1671/stat : 1671 (java) S 1649 1648 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 15 0 11 0 5202908 901795840 81868 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1672] ppid=1649 vsize=880660 CPUtime=0 /proc/1662/task/1672/stat : 1672 (java) S 1649 1648 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 11 0 5203462 901795840 81868 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 12.69 Current children cumulated vsize (KiB) 885792 [startup+25.5036 s] /proc/loadavg: 1.18 1.11 1.10 2/46 1672 /proc/meminfo: memFree=5636/1048576 swapFree=0/0 [pid=1648] ppid=1647 vsize=2564 CPUtime=0 /proc/1648/stat : 1648 (p2cudf-trendy-1) S 1647 1648 1511 34817 1511 4202496 372 0 0 0 0 0 0 0 18 0 1 0 5202899 2625536 269 1283457024 134512640 135304128 4294594960 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/1648/statm: 641 269 230 194 0 28 0 [pid=1649] ppid=1648 vsize=2568 CPUtime=0.03 /proc/1649/stat : 1649 (p2cudf) S 1648 1648 1511 34817 1511 4202496 391 3012 0 1 0 0 1 2 25 0 1 0 5202899 2629632 280 1283457024 134512640 135304128 4289740000 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/1649/statm: 642 280 239 194 0 29 0 [pid=1662] ppid=1649 vsize=880660 CPUtime=25.44 /proc/1662/stat : 1662 (java) S 1649 1648 1511 34817 1511 4202496 96697 0 1 0 2508 36 0 0 25 0 11 0 5202903 901795840 90392 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/1662/statm: 220165 90392 1788 10 0 217256 0 [pid=1662/tid=1663] ppid=1649 vsize=880660 CPUtime=21.21 /proc/1662/task/1663/stat : 1663 (java) R 1649 1648 1511 34817 1511 4202560 50286 0 1 0 2095 26 0 0 25 0 11 0 5202903 901795840 90392 1283457024 134512640 134550932 4289932208 18446744073709551615 4096318579 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=1662/tid=1664] ppid=1649 vsize=880660 CPUtime=0.92 /proc/1662/task/1664/stat : 1664 (java) S 1649 1648 1511 34817 1511 4202560 32365 0 0 0 86 6 0 0 15 0 11 0 5202905 901795840 90392 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 0 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1665] ppid=1649 vsize=880660 CPUtime=0 /proc/1662/task/1665/stat : 1665 (java) S 1649 1648 1511 34817 1511 4202560 8 0 0 0 0 0 0 0 18 0 11 0 5202905 901795840 90392 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1666] ppid=1649 vsize=880660 CPUtime=0 /proc/1662/task/1666/stat : 1666 (java) S 1649 1648 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 5202905 901795840 90392 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1667] ppid=1649 vsize=880660 CPUtime=0 /proc/1662/task/1667/stat : 1667 (java) S 1649 1648 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 5202908 901795840 90392 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1668] ppid=1649 vsize=880660 CPUtime=2.89 /proc/1662/task/1668/stat : 1668 (java) S 1649 1648 1511 34817 1511 4202560 10642 0 0 0 287 2 0 0 15 0 11 0 5202908 901795840 90392 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1669] ppid=1649 vsize=880660 CPUtime=0.39 /proc/1662/task/1669/stat : 1669 (java) S 1649 1648 1511 34817 1511 4202560 2327 0 0 0 39 0 0 0 16 0 11 0 5202908 901795840 90392 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1670] ppid=1649 vsize=880660 CPUtime=0 /proc/1662/task/1670/stat : 1670 (java) S 1649 1648 1511 34817 1511 4202560 0 0 0 0 0 0 0 0 25 0 11 0 5202908 901795840 90392 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1671] ppid=1649 vsize=880660 CPUtime=0 /proc/1662/task/1671/stat : 1671 (java) S 1649 1648 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 15 0 11 0 5202908 901795840 90392 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1672] ppid=1649 vsize=880660 CPUtime=0 /proc/1662/task/1672/stat : 1672 (java) S 1649 1648 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 11 0 5203462 901795840 90392 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 25.47 Current children cumulated vsize (KiB) 885792 Solver just ended. Dumping a history of the last processes samples [startup+27.1041 s] /proc/loadavg: 1.18 1.11 1.10 2/46 1672 /proc/meminfo: memFree=5636/1048576 swapFree=0/0 [pid=1648] ppid=1647 vsize=2564 CPUtime=0 /proc/1648/stat : 1648 (p2cudf-trendy-1) S 1647 1648 1511 34817 1511 4202496 372 0 0 0 0 0 0 0 18 0 1 0 5202899 2625536 269 1283457024 134512640 135304128 4294594960 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/1648/statm: 641 269 230 194 0 28 0 [pid=1649] ppid=1648 vsize=2568 CPUtime=0.03 /proc/1649/stat : 1649 (p2cudf) S 1648 1648 1511 34817 1511 4202496 391 3012 0 1 0 0 1 2 25 0 1 0 5202899 2629632 280 1283457024 134512640 135304128 4289740000 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/1649/statm: 642 280 239 194 0 29 0 [pid=1662] ppid=1649 vsize=880660 CPUtime=27.04 /proc/1662/stat : 1662 (java) S 1649 1648 1511 34817 1511 4202496 96697 0 1 0 2668 36 0 0 25 0 11 0 5202903 901795840 90392 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/1662/statm: 220165 90392 1788 10 0 217256 0 [pid=1662/tid=1663] ppid=1649 vsize=880660 CPUtime=22.81 /proc/1662/task/1663/stat : 1663 (java) R 1649 1648 1511 34817 1511 4202560 50286 0 1 0 2255 26 0 0 25 0 11 0 5202903 901795840 90392 1283457024 134512640 134550932 4289932208 18446744073709551615 4096311935 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=1662/tid=1664] ppid=1649 vsize=880660 CPUtime=0.92 /proc/1662/task/1664/stat : 1664 (java) S 1649 1648 1511 34817 1511 4202560 32365 0 0 0 86 6 0 0 15 0 11 0 5202905 901795840 90392 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 0 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1665] ppid=1649 vsize=880660 CPUtime=0 /proc/1662/task/1665/stat : 1665 (java) S 1649 1648 1511 34817 1511 4202560 8 0 0 0 0 0 0 0 18 0 11 0 5202905 901795840 90392 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1666] ppid=1649 vsize=880660 CPUtime=0 /proc/1662/task/1666/stat : 1666 (java) S 1649 1648 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 5202905 901795840 90392 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1667] ppid=1649 vsize=880660 CPUtime=0 /proc/1662/task/1667/stat : 1667 (java) S 1649 1648 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 5202908 901795840 90392 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1668] ppid=1649 vsize=880660 CPUtime=2.89 /proc/1662/task/1668/stat : 1668 (java) S 1649 1648 1511 34817 1511 4202560 10642 0 0 0 287 2 0 0 15 0 11 0 5202908 901795840 90392 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1669] ppid=1649 vsize=880660 CPUtime=0.39 /proc/1662/task/1669/stat : 1669 (java) S 1649 1648 1511 34817 1511 4202560 2327 0 0 0 39 0 0 0 16 0 11 0 5202908 901795840 90392 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1670] ppid=1649 vsize=880660 CPUtime=0 /proc/1662/task/1670/stat : 1670 (java) S 1649 1648 1511 34817 1511 4202560 0 0 0 0 0 0 0 0 25 0 11 0 5202908 901795840 90392 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1671] ppid=1649 vsize=880660 CPUtime=0 /proc/1662/task/1671/stat : 1671 (java) S 1649 1648 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 15 0 11 0 5202908 901795840 90392 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1672] ppid=1649 vsize=880660 CPUtime=0 /proc/1662/task/1672/stat : 1672 (java) S 1649 1648 1511 34817 1511 4202560 4 0 0 0 0 0 0 0 25 0 11 0 5203462 901795840 90392 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 27.07 Current children cumulated vsize (KiB) 885792 [startup+27.8956 s] /proc/loadavg: 1.18 1.11 1.10 2/46 1672 /proc/meminfo: memFree=5636/1048576 swapFree=0/0 [pid=1648] ppid=1647 vsize=2564 CPUtime=0 /proc/1648/stat : 1648 (p2cudf-trendy-1) S 1647 1648 1511 34817 1511 4202496 372 0 0 0 0 0 0 0 18 0 1 0 5202899 2625536 269 1283457024 134512640 135304128 4294594960 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/1648/statm: 641 269 230 194 0 28 0 [pid=1649] ppid=1648 vsize=2568 CPUtime=0.03 /proc/1649/stat : 1649 (p2cudf) S 1648 1648 1511 34817 1511 4202496 391 3012 0 1 0 0 1 2 25 0 1 0 5202899 2629632 280 1283457024 134512640 135304128 4289740000 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/1649/statm: 642 280 239 194 0 29 0 [pid=1662] ppid=1649 vsize=880984 CPUtime=27.78 /proc/1662/stat : 1662 (java) S 1649 1648 1511 34817 1511 4202496 96710 0 1 0 2742 36 0 0 25 0 11 0 5202903 902127616 90405 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/1662/statm: 220246 90405 1789 10 0 217337 0 [pid=1662/tid=1663] ppid=1649 vsize=880984 CPUtime=23.52 /proc/1662/task/1663/stat : 1663 (java) S 1649 1648 1511 34817 1511 4202560 50294 0 1 0 2326 26 0 0 25 0 11 0 5202903 902127616 90405 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1664] ppid=1649 vsize=880984 CPUtime=0.92 /proc/1662/task/1664/stat : 1664 (java) S 1649 1648 1511 34817 1511 4202560 32365 0 0 0 86 6 0 0 16 0 11 0 5202905 902127616 90405 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 0 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1665] ppid=1649 vsize=880984 CPUtime=0 /proc/1662/task/1665/stat : 1665 (java) S 1649 1648 1511 34817 1511 4202560 8 0 0 0 0 0 0 0 18 0 11 0 5202905 902127616 90405 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1666] ppid=1649 vsize=880984 CPUtime=0 /proc/1662/task/1666/stat : 1666 (java) S 1649 1648 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 5202905 902127616 90405 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1667] ppid=1649 vsize=880984 CPUtime=0 /proc/1662/task/1667/stat : 1667 (java) S 1649 1648 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 5202908 902127616 90405 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1668] ppid=1649 vsize=880984 CPUtime=2.92 /proc/1662/task/1668/stat : 1668 (java) S 1649 1648 1511 34817 1511 4202560 10642 0 0 0 290 2 0 0 16 0 11 0 5202908 902127616 90405 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1669] ppid=1649 vsize=880984 CPUtime=0.39 /proc/1662/task/1669/stat : 1669 (java) S 1649 1648 1511 34817 1511 4202560 2327 0 0 0 39 0 0 0 16 0 11 0 5202908 902127616 90405 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1670] ppid=1649 vsize=880984 CPUtime=0 /proc/1662/task/1670/stat : 1670 (java) S 1649 1648 1511 34817 1511 4202560 0 0 0 0 0 0 0 0 25 0 11 0 5202908 902127616 90405 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1671] ppid=1649 vsize=880984 CPUtime=0 /proc/1662/task/1671/stat : 1671 (java) S 1649 1648 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 15 0 11 0 5202908 902127616 90405 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 27.81 Current children cumulated vsize (KiB) 886116 [startup+28.2075 s] /proc/loadavg: 1.18 1.11 1.10 2/46 1672 /proc/meminfo: memFree=5636/1048576 swapFree=0/0 [pid=1648] ppid=1647 vsize=2564 CPUtime=0 /proc/1648/stat : 1648 (p2cudf-trendy-1) S 1647 1648 1511 34817 1511 4202496 372 0 0 0 0 0 0 0 18 0 1 0 5202899 2625536 269 1283457024 134512640 135304128 4294594960 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/1648/statm: 641 269 230 194 0 28 0 [pid=1649] ppid=1648 vsize=2568 CPUtime=0.03 /proc/1649/stat : 1649 (p2cudf) S 1648 1648 1511 34817 1511 4202496 391 3012 0 1 0 0 1 2 25 0 1 0 5202899 2629632 280 1283457024 134512640 135304128 4289740000 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/1649/statm: 642 280 239 194 0 29 0 [pid=1662] ppid=1649 vsize=880984 CPUtime=27.78 /proc/1662/stat : 1662 (java) S 1649 1648 1511 34817 1511 4202496 96710 0 1 0 2742 36 0 0 25 0 11 0 5202903 902127616 90405 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/1662/statm: 220246 90405 1789 10 0 217337 0 [pid=1662/tid=1663] ppid=1649 vsize=880984 CPUtime=23.52 /proc/1662/task/1663/stat : 1663 (java) S 1649 1648 1511 34817 1511 4202560 50294 0 1 0 2326 26 0 0 25 0 11 0 5202903 902127616 90405 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1664] ppid=1649 vsize=880984 CPUtime=0.92 /proc/1662/task/1664/stat : 1664 (java) S 1649 1648 1511 34817 1511 4202560 32365 0 0 0 86 6 0 0 16 0 11 0 5202905 902127616 90405 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 0 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1665] ppid=1649 vsize=880984 CPUtime=0 /proc/1662/task/1665/stat : 1665 (java) S 1649 1648 1511 34817 1511 4202560 8 0 0 0 0 0 0 0 18 0 11 0 5202905 902127616 90405 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1666] ppid=1649 vsize=880984 CPUtime=0 /proc/1662/task/1666/stat : 1666 (java) S 1649 1648 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 5202905 902127616 90405 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1667] ppid=1649 vsize=880984 CPUtime=0 /proc/1662/task/1667/stat : 1667 (java) S 1649 1648 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 5202908 902127616 90405 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1668] ppid=1649 vsize=880984 CPUtime=2.92 /proc/1662/task/1668/stat : 1668 (java) S 1649 1648 1511 34817 1511 4202560 10642 0 0 0 290 2 0 0 16 0 11 0 5202908 902127616 90405 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1669] ppid=1649 vsize=880984 CPUtime=0.39 /proc/1662/task/1669/stat : 1669 (java) S 1649 1648 1511 34817 1511 4202560 2327 0 0 0 39 0 0 0 16 0 11 0 5202908 902127616 90405 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1670] ppid=1649 vsize=880984 CPUtime=0 /proc/1662/task/1670/stat : 1670 (java) S 1649 1648 1511 34817 1511 4202560 0 0 0 0 0 0 0 0 25 0 11 0 5202908 902127616 90405 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1671] ppid=1649 vsize=880984 CPUtime=0 /proc/1662/task/1671/stat : 1671 (java) S 1649 1648 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 15 0 11 0 5202908 902127616 90405 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 27.81 Current children cumulated vsize (KiB) 886116 [startup+28.4076 s] /proc/loadavg: 1.18 1.11 1.10 2/46 1673 /proc/meminfo: memFree=5636/1048576 swapFree=0/0 [pid=1648] ppid=1647 vsize=2564 CPUtime=0 /proc/1648/stat : 1648 (p2cudf-trendy-1) S 1647 1648 1511 34817 1511 4202496 372 0 0 0 0 0 0 0 18 0 1 0 5202899 2625536 269 1283457024 134512640 135304128 4294594960 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/1648/statm: 641 269 230 194 0 28 0 [pid=1649] ppid=1648 vsize=2568 CPUtime=0.03 /proc/1649/stat : 1649 (p2cudf) S 1648 1648 1511 34817 1511 4202496 391 3012 0 1 0 0 1 2 25 0 1 0 5202899 2629632 280 1283457024 134512640 135304128 4289740000 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/1649/statm: 642 280 239 194 0 29 0 [pid=1662] ppid=1649 vsize=880984 CPUtime=27.84 /proc/1662/stat : 1662 (java) S 1649 1648 1511 34817 1511 4202496 96712 0 1 0 2746 38 0 0 25 0 11 0 5202903 902127616 90407 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/1662/statm: 220246 90407 1789 10 0 217337 0 [pid=1662/tid=1663] ppid=1649 vsize=880984 CPUtime=23.52 /proc/1662/task/1663/stat : 1663 (java) S 1649 1648 1511 34817 1511 4202560 50294 0 1 0 2326 26 0 0 25 0 11 0 5202903 902127616 90407 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1664] ppid=1649 vsize=880984 CPUtime=0.92 /proc/1662/task/1664/stat : 1664 (java) S 1649 1648 1511 34817 1511 4202560 32365 0 0 0 86 6 0 0 16 0 11 0 5202905 902127616 90407 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 0 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1665] ppid=1649 vsize=880984 CPUtime=0 /proc/1662/task/1665/stat : 1665 (java) S 1649 1648 1511 34817 1511 4202560 8 0 0 0 0 0 0 0 18 0 11 0 5202905 902127616 90407 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1666] ppid=1649 vsize=880984 CPUtime=0 /proc/1662/task/1666/stat : 1666 (java) S 1649 1648 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 5202905 902127616 90407 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1667] ppid=1649 vsize=880984 CPUtime=0 /proc/1662/task/1667/stat : 1667 (java) S 1649 1648 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 5202908 902127616 90407 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1668] ppid=1649 vsize=880984 CPUtime=2.93 /proc/1662/task/1668/stat : 1668 (java) S 1649 1648 1511 34817 1511 4202560 10642 0 0 0 291 2 0 0 16 0 11 0 5202908 902127616 90407 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1669] ppid=1649 vsize=880984 CPUtime=0.39 /proc/1662/task/1669/stat : 1669 (java) S 1649 1648 1511 34817 1511 4202560 2327 0 0 0 39 0 0 0 16 0 11 0 5202908 902127616 90407 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1670] ppid=1649 vsize=880984 CPUtime=0 /proc/1662/task/1670/stat : 1670 (java) S 1649 1648 1511 34817 1511 4202560 0 0 0 0 0 0 0 0 25 0 11 0 5202908 902127616 90407 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1671] ppid=1649 vsize=880984 CPUtime=0 /proc/1662/task/1671/stat : 1671 (java) S 1649 1648 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 15 0 11 0 5202908 902127616 90407 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1673] ppid=1649 vsize=880984 CPUtime=0.04 /proc/1662/task/1673/stat : 1673 (java) R 1649 1648 1511 34817 1511 4202560 6 0 0 0 2 2 0 0 20 0 11 0 5205684 902127616 90407 1283457024 134512640 134550932 4289932208 18446744073709551615 4095220488 0 4 0 16800975 0 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 27.87 Current children cumulated vsize (KiB) 886116 [startup+28.5077 s] /proc/loadavg: 1.18 1.11 1.10 2/46 1673 /proc/meminfo: memFree=5636/1048576 swapFree=0/0 [pid=1648] ppid=1647 vsize=2564 CPUtime=0 /proc/1648/stat : 1648 (p2cudf-trendy-1) S 1647 1648 1511 34817 1511 4202496 372 0 0 0 0 0 0 0 18 0 1 0 5202899 2625536 269 1283457024 134512640 135304128 4294594960 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/1648/statm: 641 269 230 194 0 28 0 [pid=1649] ppid=1648 vsize=2568 CPUtime=0.03 /proc/1649/stat : 1649 (p2cudf) S 1648 1648 1511 34817 1511 4202496 391 3012 0 1 0 0 1 2 25 0 1 0 5202899 2629632 280 1283457024 134512640 135304128 4289740000 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/1649/statm: 642 280 239 194 0 29 0 [pid=1662] ppid=1649 vsize=880984 CPUtime=27.94 /proc/1662/stat : 1662 (java) S 1649 1648 1511 34817 1511 4202496 96712 0 1 0 2754 40 0 0 25 0 11 0 5202903 902127616 90407 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/1662/statm: 220246 90407 1789 10 0 217337 0 [pid=1662/tid=1663] ppid=1649 vsize=880984 CPUtime=23.52 /proc/1662/task/1663/stat : 1663 (java) S 1649 1648 1511 34817 1511 4202560 50294 0 1 0 2326 26 0 0 25 0 11 0 5202903 902127616 90407 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1664] ppid=1649 vsize=880984 CPUtime=0.92 /proc/1662/task/1664/stat : 1664 (java) S 1649 1648 1511 34817 1511 4202560 32365 0 0 0 86 6 0 0 16 0 11 0 5202905 902127616 90407 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 0 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1665] ppid=1649 vsize=880984 CPUtime=0 /proc/1662/task/1665/stat : 1665 (java) S 1649 1648 1511 34817 1511 4202560 8 0 0 0 0 0 0 0 18 0 11 0 5202905 902127616 90407 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1666] ppid=1649 vsize=880984 CPUtime=0 /proc/1662/task/1666/stat : 1666 (java) S 1649 1648 1511 34817 1511 4202560 6 0 0 0 0 0 0 0 18 0 11 0 5202905 902127616 90407 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1667] ppid=1649 vsize=880984 CPUtime=0 /proc/1662/task/1667/stat : 1667 (java) S 1649 1648 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 11 0 5202908 902127616 90407 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1668] ppid=1649 vsize=880984 CPUtime=2.98 /proc/1662/task/1668/stat : 1668 (java) S 1649 1648 1511 34817 1511 4202560 10642 0 0 0 296 2 0 0 15 0 11 0 5202908 902127616 90407 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1669] ppid=1649 vsize=880984 CPUtime=0.39 /proc/1662/task/1669/stat : 1669 (java) S 1649 1648 1511 34817 1511 4202560 2327 0 0 0 39 0 0 0 16 0 11 0 5202908 902127616 90407 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1670] ppid=1649 vsize=880984 CPUtime=0 /proc/1662/task/1670/stat : 1670 (java) S 1649 1648 1511 34817 1511 4202560 0 0 0 0 0 0 0 0 25 0 11 0 5202908 902127616 90407 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1671] ppid=1649 vsize=880984 CPUtime=0 /proc/1662/task/1671/stat : 1671 (java) S 1649 1648 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 15 0 11 0 5202908 902127616 90407 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 18446612132974982976 0 0 -1 0 0 0 0 [pid=1662/tid=1673] ppid=1649 vsize=880984 CPUtime=0.09 /proc/1662/task/1673/stat : 1673 (java) R 1649 1648 1511 34817 1511 4202560 6 0 0 0 5 4 0 0 20 0 11 0 5205684 902127616 90407 1283457024 134512640 134550932 4289932208 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 27.97 Current children cumulated vsize (KiB) 886116 Child status: 0 Real time (s): 28.5783 CPU time (s): 28.0498 CPU user time (s): 27.5697 CPU system time (s): 0.48003 CPU usage (%): 98.1507 Max. virtual memory (cumulated for all children) (KiB): 891160 getrusage(RUSAGE_CHILDREN,...) data: user time used= 27.5697 system time used= 0.48003 maximum resident set size= 0 integral shared memory size= 0 integral unshared data size= 0 integral unshared stack size= 0 page reclaims= 100509 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= 1496 involuntary context switches= 1724 runsolver used 0 second user time and 0 second system time The end