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/3363.cudf.caixa.log.runsolver ./p2cudf-trendy-1.12 /home/misc2010/data/misc4/caixa//3363.cudf /home/misc2010/tmp/201103031013/p2cudf-trendy-1.12/3363.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.78 1.72 1.55 5/34 1469 /proc/meminfo: memFree=294096/1048576 swapFree=0/0 [pid=1468] ppid=1467 vsize=2564 CPUtime=0 /proc/1468/stat : 1468 (p2cudf-trendy-1) R 1467 1468 29493 34817 29493 4202496 355 0 0 0 0 0 0 0 25 0 1 0 75909007 2625536 269 1283457024 134512640 135304128 4291931984 18446744073709551615 4294960130 0 65538 4 65536 0 0 0 17 0 0 0 0 /proc/1468/statm: 641 269 230 194 0 28 0 [pid=1469] ppid=1468 vsize=2564 CPUtime=0 /proc/1469/stat : 1469 (p2cudf-trendy-1) R 1468 1468 29493 34817 29493 4202560 0 0 0 0 0 0 0 0 25 0 1 0 75909008 2625536 39 1283457024 134512640 135304128 4291931984 18446744073709551615 4294960130 0 65538 4 65536 0 0 0 17 0 0 0 0 /proc/1469/statm: 641 39 0 194 0 28 0 [startup+0.205752 s] /proc/loadavg: 1.78 1.72 1.55 5/34 1469 /proc/meminfo: memFree=294096/1048576 swapFree=0/0 [pid=1468] ppid=1467 vsize=2564 CPUtime=0 /proc/1468/stat : 1468 (p2cudf-trendy-1) S 1467 1468 29493 34817 29493 4202496 372 0 0 0 0 0 0 0 25 0 1 0 75909007 2625536 269 1283457024 134512640 135304128 4291931984 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/1468/statm: 641 269 230 194 0 28 0 [pid=1469] ppid=1468 vsize=2568 CPUtime=0.02 /proc/1469/stat : 1469 (p2cudf) S 1468 1468 29493 34817 29493 4202496 389 3012 0 1 0 0 2 0 25 0 1 0 75909008 2629632 279 1283457024 134512640 135304128 4290690576 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/1469/statm: 642 279 239 194 0 29 0 Current children cumulated CPU time (s) 0.02 Current children cumulated vsize (KiB) 5132 [startup+0.305761 s] /proc/loadavg: 1.78 1.72 1.55 5/34 1469 /proc/meminfo: memFree=294096/1048576 swapFree=0/0 [pid=1468] ppid=1467 vsize=2564 CPUtime=0 /proc/1468/stat : 1468 (p2cudf-trendy-1) S 1467 1468 29493 34817 29493 4202496 372 0 0 0 0 0 0 0 25 0 1 0 75909007 2625536 269 1283457024 134512640 135304128 4291931984 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/1468/statm: 641 269 230 194 0 28 0 [pid=1469] ppid=1468 vsize=2568 CPUtime=0.02 /proc/1469/stat : 1469 (p2cudf) S 1468 1468 29493 34817 29493 4202496 389 3012 0 1 0 0 2 0 25 0 1 0 75909008 2629632 279 1283457024 134512640 135304128 4290690576 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/1469/statm: 642 279 239 194 0 29 0 Current children cumulated CPU time (s) 0.02 Current children cumulated vsize (KiB) 5132 [startup+0.405788 s] /proc/loadavg: 1.78 1.72 1.55 5/34 1469 /proc/meminfo: memFree=294096/1048576 swapFree=0/0 [pid=1468] ppid=1467 vsize=2564 CPUtime=0 /proc/1468/stat : 1468 (p2cudf-trendy-1) S 1467 1468 29493 34817 29493 4202496 372 0 0 0 0 0 0 0 25 0 1 0 75909007 2625536 269 1283457024 134512640 135304128 4291931984 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/1468/statm: 641 269 230 194 0 28 0 [pid=1469] ppid=1468 vsize=2568 CPUtime=0.02 /proc/1469/stat : 1469 (p2cudf) S 1468 1468 29493 34817 29493 4202496 389 3012 0 1 0 0 2 0 25 0 1 0 75909008 2629632 279 1283457024 134512640 135304128 4290690576 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/1469/statm: 642 279 239 194 0 29 0 Current children cumulated CPU time (s) 0.02 Current children cumulated vsize (KiB) 5132 [startup+0.705859 s] /proc/loadavg: 1.78 1.72 1.55 5/34 1469 /proc/meminfo: memFree=294096/1048576 swapFree=0/0 [pid=1468] ppid=1467 vsize=2564 CPUtime=0 /proc/1468/stat : 1468 (p2cudf-trendy-1) S 1467 1468 29493 34817 29493 4202496 372 0 0 0 0 0 0 0 25 0 1 0 75909007 2625536 269 1283457024 134512640 135304128 4291931984 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/1468/statm: 641 269 230 194 0 28 0 [pid=1469] ppid=1468 vsize=2568 CPUtime=0.02 /proc/1469/stat : 1469 (p2cudf) S 1468 1468 29493 34817 29493 4202496 389 3012 0 1 0 0 2 0 25 0 1 0 75909008 2629632 279 1283457024 134512640 135304128 4290690576 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/1469/statm: 642 279 239 194 0 29 0 Current children cumulated CPU time (s) 0.02 Current children cumulated vsize (KiB) 5132 [startup+1.50604 s] /proc/loadavg: 1.78 1.72 1.55 3/45 1491 /proc/meminfo: memFree=246312/1048576 swapFree=0/0 [pid=1468] ppid=1467 vsize=2564 CPUtime=0 /proc/1468/stat : 1468 (p2cudf-trendy-1) S 1467 1468 29493 34817 29493 4202496 372 0 0 0 0 0 0 0 25 0 1 0 75909007 2625536 269 1283457024 134512640 135304128 4291931984 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/1468/statm: 641 269 230 194 0 28 0 [pid=1469] ppid=1468 vsize=2568 CPUtime=0.02 /proc/1469/stat : 1469 (p2cudf) S 1468 1468 29493 34817 29493 4202496 389 3012 0 1 0 0 2 0 25 0 1 0 75909008 2629632 279 1283457024 134512640 135304128 4290690576 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/1469/statm: 642 279 239 194 0 29 0 [pid=1482] ppid=1469 vsize=884992 CPUtime=1.47 /proc/1482/stat : 1482 (java) S 1469 1468 29493 34817 29493 4202496 18474 0 1 0 141 6 0 0 25 0 10 0 75909011 906231808 14621 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/1482/statm: 221248 14621 1725 10 0 218339 0 [pid=1482/tid=1483] ppid=1469 vsize=884992 CPUtime=0.63 /proc/1482/task/1483/stat : 1483 (java) R 1469 1468 29493 34817 29493 4202560 6099 0 1 0 61 2 0 0 25 0 10 0 75909012 906231808 14621 1283457024 134512640 134550932 4289520528 18446744073709551615 4095581422 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=1482/tid=1484] ppid=1469 vsize=884992 CPUtime=0 /proc/1482/task/1484/stat : 1484 (java) S 1469 1468 29493 34817 29493 4202560 7 0 0 0 0 0 0 0 15 0 10 0 75909013 906231808 14621 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 0 0 16800975 18446612133396263168 0 0 -1 0 0 0 0 [pid=1482/tid=1485] ppid=1469 vsize=884992 CPUtime=0 /proc/1482/task/1485/stat : 1485 (java) S 1469 1468 29493 34817 29493 4202560 8 0 0 0 0 0 0 0 25 0 10 0 75909013 906231808 14621 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0 [pid=1482/tid=1486] ppid=1469 vsize=884992 CPUtime=0 /proc/1482/task/1486/stat : 1486 (java) S 1469 1468 29493 34817 29493 4202560 4 0 0 0 0 0 0 0 25 0 10 0 75909014 906231808 14621 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0 [pid=1482/tid=1487] ppid=1469 vsize=884992 CPUtime=0 /proc/1482/task/1487/stat : 1487 (java) S 1469 1468 29493 34817 29493 4202560 1 0 0 0 0 0 0 0 25 0 10 0 75909016 906231808 14621 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0 [pid=1482/tid=1488] ppid=1469 vsize=884992 CPUtime=0.54 /proc/1482/task/1488/stat : 1488 (java) R 1469 1468 29493 34817 29493 4202560 8275 0 0 0 52 2 0 0 21 0 10 0 75909016 906231808 14621 1283457024 134512640 134550932 4289520528 18446744073709551615 4151826022 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=1482/tid=1489] ppid=1469 vsize=884992 CPUtime=0.27 /proc/1482/task/1489/stat : 1489 (java) R 1469 1468 29493 34817 29493 4202560 3018 0 0 0 27 0 0 0 24 0 10 0 75909016 906231808 14621 1283457024 134512640 134550932 4289520528 18446744073709551615 4153529620 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=1482/tid=1490] ppid=1469 vsize=884992 CPUtime=0 /proc/1482/task/1490/stat : 1490 (java) S 1469 1468 29493 34817 29493 4202560 1 0 0 0 0 0 0 0 25 0 10 0 75909016 906231808 14621 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0 [pid=1482/tid=1491] ppid=1469 vsize=884992 CPUtime=0 /proc/1482/task/1491/stat : 1491 (java) S 1469 1468 29493 34817 29493 4202560 2 0 0 0 0 0 0 0 15 0 10 0 75909016 906231808 14621 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 1.49 Current children cumulated vsize (KiB) 890124 [startup+3.10643 s] /proc/loadavg: 1.78 1.72 1.55 4/45 1491 /proc/meminfo: memFree=193116/1048576 swapFree=0/0 [pid=1468] ppid=1467 vsize=2564 CPUtime=0 /proc/1468/stat : 1468 (p2cudf-trendy-1) S 1467 1468 29493 34817 29493 4202496 372 0 0 0 0 0 0 0 25 0 1 0 75909007 2625536 269 1283457024 134512640 135304128 4291931984 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/1468/statm: 641 269 230 194 0 28 0 [pid=1469] ppid=1468 vsize=2568 CPUtime=0.02 /proc/1469/stat : 1469 (p2cudf) S 1468 1468 29493 34817 29493 4202496 389 3012 0 1 0 0 2 0 25 0 1 0 75909008 2629632 279 1283457024 134512640 135304128 4290690576 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/1469/statm: 642 279 239 194 0 29 0 [pid=1482] ppid=1469 vsize=888424 CPUtime=3.07 /proc/1482/stat : 1482 (java) S 1469 1468 29493 34817 29493 4202496 50466 0 1 0 285 22 0 0 25 0 10 0 75909011 909746176 44242 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/1482/statm: 222106 44242 1743 10 0 219197 0 [pid=1482/tid=1483] ppid=1469 vsize=888424 CPUtime=1.36 /proc/1482/task/1483/stat : 1483 (java) R 1469 1468 29493 34817 29493 4202560 34665 0 1 0 120 16 0 0 25 0 10 0 75909012 909746176 44242 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=1482/tid=1484] ppid=1469 vsize=888424 CPUtime=0 /proc/1482/task/1484/stat : 1484 (java) S 1469 1468 29493 34817 29493 4202560 7 0 0 0 0 0 0 0 15 0 10 0 75909013 909746176 44242 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 0 0 16800975 18446612133396263168 0 0 -1 0 0 0 0 [pid=1482/tid=1485] ppid=1469 vsize=888424 CPUtime=0 /proc/1482/task/1485/stat : 1485 (java) S 1469 1468 29493 34817 29493 4202560 8 0 0 0 0 0 0 0 25 0 10 0 75909013 909746176 44242 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0 [pid=1482/tid=1486] ppid=1469 vsize=888424 CPUtime=0 /proc/1482/task/1486/stat : 1486 (java) S 1469 1468 29493 34817 29493 4202560 4 0 0 0 0 0 0 0 25 0 10 0 75909014 909746176 44242 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0 [pid=1482/tid=1487] ppid=1469 vsize=888424 CPUtime=0 /proc/1482/task/1487/stat : 1487 (java) S 1469 1468 29493 34817 29493 4202560 1 0 0 0 0 0 0 0 25 0 10 0 75909016 909746176 44242 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0 [pid=1482/tid=1488] ppid=1469 vsize=888424 CPUtime=0.95 /proc/1482/task/1488/stat : 1488 (java) S 1469 1468 29493 34817 29493 4202560 10749 0 0 0 93 2 0 0 22 0 10 0 75909016 909746176 44242 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0 [pid=1482/tid=1489] ppid=1469 vsize=888424 CPUtime=0.72 /proc/1482/task/1489/stat : 1489 (java) R 1469 1468 29493 34817 29493 4202560 3970 0 0 0 70 2 0 0 23 0 10 0 75909016 909746176 44242 1283457024 134512640 134550932 4289520528 18446744073709551615 4151829559 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=1482/tid=1490] ppid=1469 vsize=888424 CPUtime=0 /proc/1482/task/1490/stat : 1490 (java) S 1469 1468 29493 34817 29493 4202560 1 0 0 0 0 0 0 0 25 0 10 0 75909016 909746176 44242 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0 [pid=1482/tid=1491] ppid=1469 vsize=888424 CPUtime=0 /proc/1482/task/1491/stat : 1491 (java) S 1469 1468 29493 34817 29493 4202560 2 0 0 0 0 0 0 0 15 0 10 0 75909016 909746176 44242 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 3.09 Current children cumulated vsize (KiB) 893556 Solver just ended. Dumping a history of the last processes samples [startup+3.30923 s] /proc/loadavg: 1.78 1.72 1.55 4/45 1491 /proc/meminfo: memFree=193116/1048576 swapFree=0/0 [pid=1468] ppid=1467 vsize=2564 CPUtime=0 /proc/1468/stat : 1468 (p2cudf-trendy-1) S 1467 1468 29493 34817 29493 4202496 372 0 0 0 0 0 0 0 25 0 1 0 75909007 2625536 269 1283457024 134512640 135304128 4291931984 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/1468/statm: 641 269 230 194 0 28 0 [pid=1469] ppid=1468 vsize=2568 CPUtime=0.02 /proc/1469/stat : 1469 (p2cudf) S 1468 1468 29493 34817 29493 4202496 389 3012 0 1 0 0 2 0 25 0 1 0 75909008 2629632 279 1283457024 134512640 135304128 4290690576 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/1469/statm: 642 279 239 194 0 29 0 [pid=1482] ppid=1469 vsize=888424 CPUtime=3.26 /proc/1482/stat : 1482 (java) S 1469 1468 29493 34817 29493 4202496 59553 0 1 0 302 24 0 0 25 0 10 0 75909011 909746176 53329 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/1482/statm: 222106 53329 1745 10 0 219197 0 [pid=1482/tid=1483] ppid=1469 vsize=888424 CPUtime=1.46 /proc/1482/task/1483/stat : 1483 (java) R 1469 1468 29493 34817 29493 4202560 43746 0 1 0 128 18 0 0 25 0 10 0 75909012 909746176 53329 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=1482/tid=1484] ppid=1469 vsize=888424 CPUtime=0 /proc/1482/task/1484/stat : 1484 (java) S 1469 1468 29493 34817 29493 4202560 7 0 0 0 0 0 0 0 15 0 10 0 75909013 909746176 53329 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 0 0 16800975 18446612133396263168 0 0 -1 0 0 0 0 [pid=1482/tid=1485] ppid=1469 vsize=888424 CPUtime=0 /proc/1482/task/1485/stat : 1485 (java) S 1469 1468 29493 34817 29493 4202560 8 0 0 0 0 0 0 0 25 0 10 0 75909013 909746176 53329 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0 [pid=1482/tid=1486] ppid=1469 vsize=888424 CPUtime=0 /proc/1482/task/1486/stat : 1486 (java) S 1469 1468 29493 34817 29493 4202560 4 0 0 0 0 0 0 0 25 0 10 0 75909014 909746176 53329 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0 [pid=1482/tid=1487] ppid=1469 vsize=888424 CPUtime=0 /proc/1482/task/1487/stat : 1487 (java) S 1469 1468 29493 34817 29493 4202560 1 0 0 0 0 0 0 0 25 0 10 0 75909016 909746176 53329 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0 [pid=1482/tid=1488] ppid=1469 vsize=888424 CPUtime=0.98 /proc/1482/task/1488/stat : 1488 (java) S 1469 1468 29493 34817 29493 4202560 10749 0 0 0 96 2 0 0 15 0 10 0 75909016 909746176 53329 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0 [pid=1482/tid=1489] ppid=1469 vsize=888424 CPUtime=0.79 /proc/1482/task/1489/stat : 1489 (java) R 1469 1468 29493 34817 29493 4202560 3976 0 0 0 77 2 0 0 23 0 10 0 75909016 909746176 53329 1283457024 134512640 134550932 4289520528 18446744073709551615 4149217228 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=1482/tid=1490] ppid=1469 vsize=888424 CPUtime=0 /proc/1482/task/1490/stat : 1490 (java) S 1469 1468 29493 34817 29493 4202560 1 0 0 0 0 0 0 0 25 0 10 0 75909016 909746176 53329 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0 [pid=1482/tid=1491] ppid=1469 vsize=888424 CPUtime=0 /proc/1482/task/1491/stat : 1491 (java) S 1469 1468 29493 34817 29493 4202560 2 0 0 0 0 0 0 0 15 0 10 0 75909016 909746176 53329 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 3.28 Current children cumulated vsize (KiB) 893556 [startup+4.1267 s] /proc/loadavg: 1.87 1.74 1.56 4/45 1491 /proc/meminfo: memFree=86724/1048576 swapFree=0/0 [pid=1468] ppid=1467 vsize=2564 CPUtime=0 /proc/1468/stat : 1468 (p2cudf-trendy-1) S 1467 1468 29493 34817 29493 4202496 372 0 0 0 0 0 0 0 25 0 1 0 75909007 2625536 269 1283457024 134512640 135304128 4291931984 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/1468/statm: 641 269 230 194 0 28 0 [pid=1469] ppid=1468 vsize=2568 CPUtime=0.02 /proc/1469/stat : 1469 (p2cudf) S 1468 1468 29493 34817 29493 4202496 389 3012 0 1 0 0 2 0 25 0 1 0 75909008 2629632 279 1283457024 134512640 135304128 4290690576 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/1469/statm: 642 279 239 194 0 29 0 [pid=1482] ppid=1469 vsize=888424 CPUtime=4.09 /proc/1482/stat : 1482 (java) S 1469 1468 29493 34817 29493 4202496 70987 0 1 0 379 30 0 0 25 0 10 0 75909011 909746176 64763 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/1482/statm: 222106 64763 1753 10 0 219197 0 [pid=1482/tid=1483] ppid=1469 vsize=888424 CPUtime=1.71 /proc/1482/task/1483/stat : 1483 (java) R 1469 1468 29493 34817 29493 4202560 50195 0 1 0 149 22 0 0 25 0 10 0 75909012 909746176 64763 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=1482/tid=1484] ppid=1469 vsize=888424 CPUtime=0.1 /proc/1482/task/1484/stat : 1484 (java) R 1469 1468 29493 34817 29493 4202560 4949 0 0 0 8 2 0 0 15 0 10 0 75909013 909746176 64763 1283457024 134512640 134550932 4289520528 18446744073709551615 4149469560 0 0 0 16800975 0 0 0 -1 0 0 0 0 [pid=1482/tid=1485] ppid=1469 vsize=888424 CPUtime=0 /proc/1482/task/1485/stat : 1485 (java) S 1469 1468 29493 34817 29493 4202560 8 0 0 0 0 0 0 0 25 0 10 0 75909013 909746176 64763 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0 [pid=1482/tid=1486] ppid=1469 vsize=888424 CPUtime=0 /proc/1482/task/1486/stat : 1486 (java) S 1469 1468 29493 34817 29493 4202560 4 0 0 0 0 0 0 0 25 0 10 0 75909014 909746176 64763 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0 [pid=1482/tid=1487] ppid=1469 vsize=888424 CPUtime=0 /proc/1482/task/1487/stat : 1487 (java) S 1469 1468 29493 34817 29493 4202560 1 0 0 0 0 0 0 0 25 0 10 0 75909016 909746176 64763 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0 [pid=1482/tid=1488] ppid=1469 vsize=888424 CPUtime=1.32 /proc/1482/task/1488/stat : 1488 (java) S 1469 1468 29493 34817 29493 4202560 10773 0 0 0 130 2 0 0 15 0 10 0 75909016 909746176 64763 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0 [pid=1482/tid=1489] ppid=1469 vsize=888424 CPUtime=0.93 /proc/1482/task/1489/stat : 1489 (java) S 1469 1468 29493 34817 29493 4202560 3995 0 0 0 91 2 0 0 23 0 10 0 75909016 909746176 64763 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0 [pid=1482/tid=1490] ppid=1469 vsize=888424 CPUtime=0 /proc/1482/task/1490/stat : 1490 (java) S 1469 1468 29493 34817 29493 4202560 1 0 0 0 0 0 0 0 25 0 10 0 75909016 909746176 64763 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0 [pid=1482/tid=1491] ppid=1469 vsize=888424 CPUtime=0 /proc/1482/task/1491/stat : 1491 (java) R 1469 1468 29493 34817 29493 4202560 2 0 0 0 0 0 0 0 15 0 10 0 75909016 909746176 64763 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 4.11 Current children cumulated vsize (KiB) 893556 [startup+4.50592 s] /proc/loadavg: 1.87 1.74 1.56 1/46 1492 /proc/meminfo: memFree=5784/1048576 swapFree=0/0 [pid=1468] ppid=1467 vsize=2564 CPUtime=0 /proc/1468/stat : 1468 (p2cudf-trendy-1) S 1467 1468 29493 34817 29493 4202496 372 0 0 0 0 0 0 0 25 0 1 0 75909007 2625536 269 1283457024 134512640 135304128 4291931984 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/1468/statm: 641 269 230 194 0 28 0 [pid=1469] ppid=1468 vsize=2568 CPUtime=0.02 /proc/1469/stat : 1469 (p2cudf) S 1468 1468 29493 34817 29493 4202496 389 3012 0 1 0 0 2 0 25 0 1 0 75909008 2629632 279 1283457024 134512640 135304128 4290690576 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/1469/statm: 642 279 239 194 0 29 0 [pid=1482] ppid=1469 vsize=888748 CPUtime=4.4 /proc/1482/stat : 1482 (java) S 1469 1468 29493 34817 29493 4202496 80436 0 1 0 410 30 0 0 25 0 11 0 75909011 910077952 74212 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/1482/statm: 222187 74212 1763 10 0 219278 0 [pid=1482/tid=1483] ppid=1469 vsize=888748 CPUtime=1.8 /proc/1482/task/1483/stat : 1483 (java) S 1469 1468 29493 34817 29493 4202560 50203 0 1 0 158 22 0 0 25 0 11 0 75909012 910077952 74212 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0 [pid=1482/tid=1484] ppid=1469 vsize=888748 CPUtime=0.32 /proc/1482/task/1484/stat : 1484 (java) S 1469 1468 29493 34817 29493 4202560 14372 0 0 0 30 2 0 0 16 0 11 0 75909013 910077952 74212 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 0 0 16800975 18446612133396263168 0 0 -1 0 0 0 0 [pid=1482/tid=1485] ppid=1469 vsize=888748 CPUtime=0 /proc/1482/task/1485/stat : 1485 (java) S 1469 1468 29493 34817 29493 4202560 8 0 0 0 0 0 0 0 18 0 11 0 75909013 910077952 74212 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0 [pid=1482/tid=1486] ppid=1469 vsize=888748 CPUtime=0 /proc/1482/task/1486/stat : 1486 (java) S 1469 1468 29493 34817 29493 4202560 6 0 0 0 0 0 0 0 18 0 11 0 75909014 910077952 74212 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0 [pid=1482/tid=1487] ppid=1469 vsize=888748 CPUtime=0 /proc/1482/task/1487/stat : 1487 (java) S 1469 1468 29493 34817 29493 4202560 1 0 0 0 0 0 0 0 25 0 11 0 75909016 910077952 74212 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0 [pid=1482/tid=1488] ppid=1469 vsize=888748 CPUtime=1.32 /proc/1482/task/1488/stat : 1488 (java) S 1469 1468 29493 34817 29493 4202560 10773 0 0 0 130 2 0 0 15 0 11 0 75909016 910077952 74212 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0 [pid=1482/tid=1489] ppid=1469 vsize=888748 CPUtime=0.94 /proc/1482/task/1489/stat : 1489 (java) S 1469 1468 29493 34817 29493 4202560 4007 0 0 0 92 2 0 0 18 0 11 0 75909016 910077952 74212 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0 [pid=1482/tid=1490] ppid=1469 vsize=888748 CPUtime=0 /proc/1482/task/1490/stat : 1490 (java) S 1469 1468 29493 34817 29493 4202560 1 0 0 0 0 0 0 0 25 0 11 0 75909016 910077952 74212 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0 [pid=1482/tid=1491] ppid=1469 vsize=888748 CPUtime=0 /proc/1482/task/1491/stat : 1491 (java) S 1469 1468 29493 34817 29493 4202560 2 0 0 0 0 0 0 0 15 0 11 0 75909016 910077952 74212 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0 [pid=1482/tid=1492] ppid=1469 vsize=888748 CPUtime=0 /proc/1482/task/1492/stat : 1492 (java) S 1469 1468 29493 34817 29493 4202560 4 0 0 0 0 0 0 0 25 0 11 0 75909453 910077952 74212 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 4.42 Current children cumulated vsize (KiB) 893880 [startup+4.90594 s] /proc/loadavg: 1.87 1.74 1.56 1/46 1492 /proc/meminfo: memFree=5784/1048576 swapFree=0/0 [pid=1468] ppid=1467 vsize=2564 CPUtime=0 /proc/1468/stat : 1468 (p2cudf-trendy-1) S 1467 1468 29493 34817 29493 4202496 372 0 0 0 0 0 0 0 25 0 1 0 75909007 2625536 269 1283457024 134512640 135304128 4291931984 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/1468/statm: 641 269 230 194 0 28 0 [pid=1469] ppid=1468 vsize=2568 CPUtime=0.02 /proc/1469/stat : 1469 (p2cudf) S 1468 1468 29493 34817 29493 4202496 389 3012 0 1 0 0 2 0 25 0 1 0 75909008 2629632 279 1283457024 134512640 135304128 4290690576 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/1469/statm: 642 279 239 194 0 29 0 [pid=1482] ppid=1469 vsize=888748 CPUtime=4.4 /proc/1482/stat : 1482 (java) S 1469 1468 29493 34817 29493 4202496 80436 0 1 0 410 30 0 0 25 0 11 0 75909011 910077952 74212 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/1482/statm: 222187 74212 1763 10 0 219278 0 [pid=1482/tid=1483] ppid=1469 vsize=888748 CPUtime=1.8 /proc/1482/task/1483/stat : 1483 (java) S 1469 1468 29493 34817 29493 4202560 50203 0 1 0 158 22 0 0 25 0 11 0 75909012 910077952 74212 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0 [pid=1482/tid=1484] ppid=1469 vsize=888748 CPUtime=0.32 /proc/1482/task/1484/stat : 1484 (java) S 1469 1468 29493 34817 29493 4202560 14372 0 0 0 30 2 0 0 16 0 11 0 75909013 910077952 74212 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 0 0 16800975 18446612133396263168 0 0 -1 0 0 0 0 [pid=1482/tid=1485] ppid=1469 vsize=888748 CPUtime=0 /proc/1482/task/1485/stat : 1485 (java) S 1469 1468 29493 34817 29493 4202560 8 0 0 0 0 0 0 0 18 0 11 0 75909013 910077952 74212 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0 [pid=1482/tid=1486] ppid=1469 vsize=888748 CPUtime=0 /proc/1482/task/1486/stat : 1486 (java) S 1469 1468 29493 34817 29493 4202560 6 0 0 0 0 0 0 0 18 0 11 0 75909014 910077952 74212 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0 [pid=1482/tid=1487] ppid=1469 vsize=888748 CPUtime=0 /proc/1482/task/1487/stat : 1487 (java) S 1469 1468 29493 34817 29493 4202560 1 0 0 0 0 0 0 0 25 0 11 0 75909016 910077952 74212 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0 [pid=1482/tid=1488] ppid=1469 vsize=888748 CPUtime=1.32 /proc/1482/task/1488/stat : 1488 (java) S 1469 1468 29493 34817 29493 4202560 10773 0 0 0 130 2 0 0 15 0 11 0 75909016 910077952 74212 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0 [pid=1482/tid=1489] ppid=1469 vsize=888748 CPUtime=0.94 /proc/1482/task/1489/stat : 1489 (java) S 1469 1468 29493 34817 29493 4202560 4007 0 0 0 92 2 0 0 18 0 11 0 75909016 910077952 74212 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0 [pid=1482/tid=1490] ppid=1469 vsize=888748 CPUtime=0 /proc/1482/task/1490/stat : 1490 (java) S 1469 1468 29493 34817 29493 4202560 1 0 0 0 0 0 0 0 25 0 11 0 75909016 910077952 74212 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0 [pid=1482/tid=1491] ppid=1469 vsize=888748 CPUtime=0 /proc/1482/task/1491/stat : 1491 (java) S 1469 1468 29493 34817 29493 4202560 2 0 0 0 0 0 0 0 15 0 11 0 75909016 910077952 74212 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0 [pid=1482/tid=1492] ppid=1469 vsize=888748 CPUtime=0 /proc/1482/task/1492/stat : 1492 (java) S 1469 1468 29493 34817 29493 4202560 4 0 0 0 0 0 0 0 25 0 11 0 75909453 910077952 74212 1283457024 134512640 134550932 4289520528 18446744073709551615 4294960130 0 4 0 16800975 18446612133396263168 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 4.42 Current children cumulated vsize (KiB) 893880 Child status: 0 Real time (s): 5.00428 CPU time (s): 4.46428 CPU user time (s): 4.12826 CPU system time (s): 0.336021 CPU usage (%): 89.2093 Max. virtual memory (cumulated for all children) (KiB): 895100 getrusage(RUSAGE_CHILDREN,...) data: user time used= 4.12826 system time used= 0.336021 maximum resident set size= 0 integral shared memory size= 0 integral unshared data size= 0 integral unshared stack size= 0 page reclaims= 84236 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= 402 involuntary context switches= 387 runsolver used 0 second user time and 0 second system time The end