Originally posted by: pankaichn
Problem still unsolved....I run another instance of my problem after setting MIPInterval parameter to 1. Although Cplex output the node log information for every node before it stops, but it still stops with a gap large than the default relative terminating gap tolerance 0.01%. Do I miss anything else?
Found incumbent of value 0.000000 after 0.00 sec. (0.70 ticks)
Tried aggregator 1 time.
MIP Presolve eliminated 13650 rows and 1 columns.
Reduced MIP has 12231 rows, 16380 columns, and 46247 nonzeros.
Reduced MIP has 4095 binaries, 0 generals, 0 SOSs, and 0 indicators.
Presolve time = 0.09 sec. (48.00 ticks)
Probing time = 0.02 sec. (2.68 ticks)
Tried aggregator 1 time.
Presolve time = 0.06 sec. (20.80 ticks)
Probing time = 0.02 sec. (2.68 ticks)
Clique table members: 1.
MIP emphasis: balance optimality and feasibility.
MIP search method: dynamic search.
Parallel mode: deterministic, using up to 4 threads.
Parallel mode: deterministic, using up to 2 threads for concurrent optimization.
Tried aggregator 1 time.
LP Presolve eliminated 1 rows and 2 columns.
Reduced LP has 12230 rows, 16378 columns, and 46244 nonzeros.
Presolve time = 0.05 sec. (10.23 ticks)
Initializing dual steep norms . . .
Iteration log . . .
Iteration: 1 Dual objective = 22689.013259
Iteration: 418 Dual objective = 12640.514456
Iteration: 809 Dual objective = 9515.030194
Iteration: 1284 Dual objective = 5149.843065
Iteration: 1576 Dual objective = 4719.754138
Iteration: 1879 Dual objective = 4545.142295
Iteration: 2128 Dual objective = 4384.332018
Iteration: 2420 Dual objective = 3971.446977
Iteration: 2763 Dual objective = 3822.199298
Iteration: 3109 Dual objective = 3707.202376
Iteration: 3501 Dual objective = 3601.113826
Iteration: 3783 Dual objective = 3554.482756
Iteration: 4053 Dual objective = 3536.551463
Iteration: 4327 Dual objective = 3524.646309
Reinitializing dual norms . . .
Initializing dual steep norms . . .
Dual simplex solved model.
Root relaxation solution time = 0.58 sec. (212.95 ticks)
Nodes Cuts/
Node Left Objective IInf Best Integer Best Bound ItCnt Gap
* 0+ 0 0.0000 25008.2979 4498 ---
Found incumbent of value 0.000000 after 1.03 sec. (308.13 ticks)
* 0+ 0 1452.1693 25008.2979 4498 ---
Found incumbent of value 1452.169260 after 1.03 sec. (308.44 ticks)
0 0 3521.9735 2052 1452.1693 3521.9735 4498 142.53%
* 0+ 0 2925.7177 3521.9735 8020 20.38%
Found incumbent of value 2925.717702 after 2.51 sec. (1100.56 ticks)
0 0 3257.7566 1768 2925.7177 Cuts: 3157 8020 11.35%
* 0+ 0 2932.0762 3257.7566 9765 11.11%
Found incumbent of value 2932.076241 after 3.67 sec. (1657.80 ticks)
0 0 3183.0420 1794 2932.0762 Cuts: 2493 9765 8.56%
* 0+ 0 2937.8891 3183.0420 10703 8.34%
Found incumbent of value 2937.889118 after 4.76 sec. (2152.64 ticks)
0 0 3160.3833 1810 2937.8891 Cuts: 1598 10703 7.57%
0 0 3147.7320 1806 2937.8891 Cuts: 1227 11477 7.14%
0 0 3138.5589 1802 2937.8891 Cuts: 1220 12147 6.83%
0 0 3131.7807 1831 2937.8891 Cuts: 1067 12652 6.60%
0 0 3127.1875 1910 2937.8891 Cuts: 831 13170 6.44%
* 0+ 0 2950.5075 3127.1875 13590 5.99%
Found incumbent of value 2950.507473 after 8.83 sec. (4055.73 ticks)
0 0 3124.4349 1828 2950.5075 Cuts: 722 13590 5.89%
0 0 3121.8646 1814 2950.5075 Cuts: 636 13915 5.81%
0 0 3119.4681 1810 2950.5075 Cuts: 511 14254 4.80%
0 0 3118.5662 1833 2950.5075 Cuts: 359 14464 4.80%
* 0+ 0 2950.8132 3092.0820 14464 4.79%
Found incumbent of value 2950.813151 after 12.84 sec. (5929.57 ticks)
0 2 3118.5662 1833 2950.8132 3072.3362 14464 4.12%
Elapsed time = 12.95 sec. (5950.44 ticks, tree = 0.01 MB, solutions = 7)
1 1 cutoff 2950.8132 3072.3362 14560 4.12%
2 2 3097.0704 1701 2950.8132 3072.3362 15364 4.12%
3 1 cutoff 2950.8132 3072.3362 15382 4.12%
4 2 3096.0935 1456 2950.8132 3072.3362 15437 4.12%
5 3 3081.5569 1309 2950.8132 3072.3362 15690 4.12%
6 4 3056.3125 1164 2950.8132 3072.3362 16046 4.12%
7 5 3005.6350 1163 2950.8132 3072.3362 16483 4.12%
8 6 2980.3903 1017 2950.8132 3072.3362 17001 4.12%
9 7 2979.0247 998 2950.8132 3072.3362 17100 4.12%
10 6 cutoff 2950.8132 3072.3362 17102 4.12%
Elapsed time = 13.48 sec. (6200.95 ticks, tree = 0.01 MB, solutions = 7)
11 5 cutoff 2950.8132 3072.3362 17156 4.12%
12 6 3020.0911 978 2950.8132 3072.3362 17358 4.12%
13 5 cutoff 2950.8132 3072.3362 17404 4.12%
14 6 2951.5013 948 2950.8132 3072.3362 17574 4.12%
15 5 cutoff 2950.8132 3072.3362 17969 4.12%
16 6 3013.6925 888 2950.8132 3020.0702 18067 2.35%
17 7 2972.6261 908 2950.8132 3020.0702 18170 2.35%
18 6 cutoff 2950.8132 3020.0702 18206 2.35%
19 7 2966.8219 865 2950.8132 3020.0702 18455 2.35%
20 8 3004.7813 825 2950.8132 3013.6796 18890 2.13%
Impl Bds: 107
Elapsed time = 13.98 sec. (6515.49 ticks, tree = 0.02 MB, solutions = 7)
21 9 2954.7865 620 2950.8132 3013.6796 19384 2.13%
22 8 cutoff 2950.8132 3013.6796 19404 2.13%
23 7 cutoff 2950.8132 3013.6796 19424 2.13%
24 8 2997.8354 600 2950.8132 3013.6796 19653 2.13%
25 7 cutoff 2950.8132 3013.6796 19680 2.13%
26 6 cutoff 2950.8132 3013.6796 19682 2.13%
27 5 cutoff 2950.8132 3013.6796 19805 2.13%
28 6 2990.8935 511 2950.8132 3013.6390 19869 2.13%
29 5 cutoff 2950.8132 3013.6390 20081 2.13%
30 4 cutoff 2950.8132 3013.6390 20083 2.13%
Elapsed time = 14.12 sec. (6565.61 ticks, tree = 0.01 MB, solutions = 7)
31 3 cutoff 2950.8132 3013.6390 20099 2.13%
32 4 2985.2284 554 2950.8132 3013.6390 20224 2.13%
33 5 2973.1480 489 2950.8132 3013.6390 20237 2.13%
34 6 2972.6284 419 2950.8132 3013.6390 20258 2.13%
35 7 2965.3475 389 2950.8132 3013.6390 20319 2.13%
36 8 2957.6890 445 2950.8132 3013.6390 20416 2.13%
37 9 2963.4447 367 2950.8132 3013.6390 20442 2.13%
38 10 2960.8057 453 2950.8132 2997.6522 20619 1.59%
39 9 cutoff 2950.8132 2997.6522 20670 1.59%
40 10 2984.7089 484 2950.8132 2997.6522 20691 1.59%
Elapsed time = 14.26 sec. (6638.53 ticks, tree = 0.02 MB, solutions = 7)
41 9 cutoff 2950.8132 2997.6522 20713 1.59%
42 10 2963.3093 351 2950.8132 2997.6522 20722 1.59%
43 11 2963.1640 395 2950.8132 2997.6522 20795 1.59%
44 12 2982.0698 570 2950.8132 2997.6522 20947 1.59%
45 11 cutoff 2950.8132 2997.6522 20950 1.59%
46 12 2957.8317 397 2950.8132 2997.6522 21058 1.59%
47 13 2960.5250 481 2950.8132 2997.6522 21265 1.59%
48 14 2976.5875 614 2950.8132 2997.6522 21389 1.59%
49 15 2963.1284 331 2950.8132 2997.6522 21405 1.59%
50 16 2955.0475 527 2950.8132 2997.6522 21487 1.59%
Elapsed time = 14.37 sec. (6678.82 ticks, tree = 0.01 MB, solutions = 7)
51 17 2975.8724 548 2950.8132 2997.6522 21548 1.59%
52 18 2961.9151 390 2950.8132 2997.6522 21623 1.59%
53 17 cutoff 2950.8132 2997.6522 21703 1.59%
54 18 2960.9923 366 2950.8132 2984.7043 21738 1.15%
Impl Bds: 22
55 19 2954.2654 460 2950.8132 2984.7043 21810 1.15%
56 20 2974.6039 606 2950.8132 2984.7043 21915 1.15%
57 19 cutoff 2950.8132 2984.7043 21993 1.15%
58 20 2960.7749 285 2950.8132 2984.7043 22028 1.15%
59 21 2953.3537 437 2950.8132 2984.7043 22057 1.15%
60 22 2974.3870 525 2950.8132 2984.7043 22088 1.15%
Elapsed time = 14.46 sec. (6700.93 ticks, tree = 0.04 MB, solutions = 7)
61 23 2955.2874 498 2950.8132 2984.7043 22230 1.15%
62 24 2957.7966 263 2950.8132 2984.7043 22270 1.15%
63 25 2952.3675 497 2950.8132 2984.7043 22348 1.15%
64 26 2973.4353 437 2950.8132 2984.7043 22401 1.15%
65 27 2954.3757 475 2950.8132 2984.7043 22425 1.15%
66 28 2957.1910 240 2950.8132 2984.7043 22448 1.15%
67 27 cutoff 2950.8132 2984.7043 22470 1.15%
68 28 2970.4570 415 2950.8132 2984.7043 22516 1.15%
69 29 2953.3896 535 2950.8132 2984.7043 22589 1.15%
70 30 2956.7566 232 2950.8132 2984.7043 22605 1.15%
//let's miss the lengthy output in the middle part...
Elapsed time = 30.16 sec. (11025.45 ticks, tree = 67.45 MB, solutions = 13)
2361 1451 2957.6176 149 2953.2090 2962.3810 60479 0.31%
2362 1452 2956.5583 161 2953.2090 2962.3810 60485 0.31%
2363 1451 cutoff 2953.2090 2962.3810 60486 0.31%
2364 1452 2958.8796 136 2953.2090 2962.3810 60501 0.31%
2365 1453 2956.8199 142 2953.2090 2962.3810 60519 0.31%
2366 1454 2955.7606 154 2953.2090 2962.3810 60562 0.31%
2367 1455 2956.6171 173 2953.2090 2962.3810 60578 0.31%
2368 1456 2958.5001 130 2953.2090 2962.3810 60591 0.31%
2369 1457 2956.1896 136 2953.2090 2962.3810 60606 0.31%
2370 1458 2955.1303 148 2953.2090 2962.3810 60618 0.31%
Elapsed time = 30.20 sec. (11047.02 ticks, tree = 67.47 MB, solutions = 13)
2371 1459 2955.5662 167 2953.2090 2962.3810 60630 0.31%
2372 1460 2957.6647 124 2953.2090 2962.3810 60642 0.31%
2373 1461 2955.8102 130 2953.2090 2962.3810 60651 0.31%
2374 1462 2954.4429 142 2953.2090 2962.3810 60661 0.31%
2375 1463 2954.9244 221 2953.2090 2962.3810 60713 0.31%
2376 1464 2956.9725 118 2953.2090 2962.3810 60718 0.31%
2377 1465 2955.1228 124 2953.2090 2962.3810 60728 0.31%
2378 1466 2953.7507 136 2953.2090 2962.3810 60733 0.31%
2379 1465 cutoff 2953.2090 2962.3810 60743 0.31%
2380 1466 2956.2251 112 2953.2090 2962.3810 60755 0.31%
Elapsed time = 30.22 sec. (11056.69 ticks, tree = 67.48 MB, solutions = 13)
2381 1467 2954.4306 118 2953.2090 2962.3810 60760 0.31%
2382 1468 2956.0370 106 2953.2090 2962.3810 60774 0.31%
2383 1469 2953.3910 112 2953.2090 2962.3810 60782 0.31%
2384 1470 2955.9079 100 2953.2090 2962.3810 60791 0.31%
2385 1469 cutoff 2953.2090 2962.3810 60802 0.31%
2386 1470 2955.0611 94 2953.2090 2962.3810 60814 0.31%
2387 1469 cutoff 2953.2090 2962.3810 60816 0.31%
2388 1470 2954.4870 88 2953.2090 2962.3810 60826 0.31%
2389 1471 2960.3309 149 2953.2090 2962.3810 60836 0.31%
2390 1472 2954.3817 82 2953.2090 2962.3810 60841 0.31%
Elapsed time = 30.22 sec. (11056.69 ticks, tree = 69.00 MB, solutions = 13)
2391 1473 2960.2931 143 2953.2090 2962.3810 60844 0.31%
2392 1473 2953.5463 78 2953.2090 2962.3810 60861 0.31%
2393 1474 2959.4954 136 2953.2090 2962.3810 60878 0.31%
2394 1473 cutoff 2953.2090 2962.3810 60884 0.31%
2395 1474 2958.8652 130 2953.2090 2962.3810 60899 0.31%
2396 1475 2960.7045 167 2953.2090 2962.3810 60915 0.31%
2397 1476 2957.8646 124 2953.2090 2962.3810 60923 0.31%
2398 1477 2959.6537 161 2953.2090 2962.3810 60935 0.31%
2399 1478 2957.1724 118 2953.2090 2962.3810 60940 0.31%
2400 1479 2959.0308 218 2953.2090 2962.3810 60993 0.31%
Elapsed time = 30.22 sec. (11056.69 ticks, tree = 69.00 MB, solutions = 13)
2401 1480 2956.4251 112 2953.2090 2962.3810 61005 0.31%
2402 1481 2959.0067 155 2953.2090 2962.3810 61014 0.31%
2403 1482 2956.2369 106 2953.2090 2962.3810 61022 0.31%
2404 1483 2957.2854 149 2953.2090 2962.3810 61034 0.31%
2405 1484 2956.1078 100 2953.2090 2962.3810 61043 0.31%
2406 1485 2957.1697 143 2953.2090 2962.3810 61051 0.31%
2407 1486 2955.2611 94 2953.2090 2962.3810 61063 0.31%
2408 1487 2956.3720 136 2953.2090 2962.3810 61092 0.31%
2409 1488 2954.6870 88 2953.2090 2962.3810 61102 0.31%
2410 1489 2955.7418 130 2953.2090 2962.3810 61115 0.31%
Elapsed time = 30.22 sec. (11056.69 ticks, tree = 69.00 MB, solutions = 13)
2411 1490 2954.5817 82 2953.2090 2962.3810 61120 0.31%
2412 1491 2954.7412 124 2953.2090 2962.3810 61131 0.31%
2413 1492 2954.0490 118 2953.2090 2962.3810 61137 0.31%
2414 1491 cutoff 2953.2090 2962.3810 61141 0.31%
2415 1492 2953.3713 130 2953.2090 2962.2708 61149 0.31%
2416 1491 cutoff 2953.2090 2962.2708 61157 0.31%
2417 1490 2953.3016 112 2953.2090 2962.2708 61169 0.31%
2418 1491 2953.7463 78 2953.2090 2962.2708 61186 0.31%
2419 1490 cutoff 2953.2090 2962.2708 61191 0.31%
2420 1491 2961.2397 181 2953.2090 2962.2708 61209 0.31%
Elapsed time = 30.64 sec. (11147.56 ticks, tree = 67.99 MB, solutions = 13)
2421 1492 2959.5459 161 2953.2090 2962.2708 61239 0.31%
2422 1493 2953.3939 72 2953.2090 2962.2708 61246 0.31%
2423 1492 cutoff 2953.2090 2962.2708 61247 0.31%
2424 1493 2960.1888 175 2953.2090 2962.2708 61264 0.31%
2425 1494 2958.8236 155 2953.2090 2962.2708 61282 0.31%
2426 1493 cutoff 2953.2090 2962.2708 61282 0.31%
2427 1494 2958.6770 185 2953.2090 2962.2708 61326 0.31%
2428 1495 2959.5637 231 2953.2090 2962.2708 61412 0.31%
2429 1496 2957.7728 149 2953.2090 2962.2708 61429 0.31%
2430 1495 cutoff 2953.2090 2962.2708 61430 0.31%
Elapsed time = 30.73 sec. (11208.72 ticks, tree = 68.00 MB, solutions = 13)
2431 1496 2957.6262 179 2953.2090 2962.2708 61442 0.31%
2432 1497 2959.5419 169 2953.2090 2962.2708 61451 0.31%
2433 1498 2956.0515 143 2953.2090 2962.2708 61464 0.31%
2434 1499 2960.2750 143 2953.2090 2962.2708 61472 0.31%
2435 1500 2955.9049 173 2953.2090 2962.2708 61484 0.31%
2436 1501 2957.8205 163 2953.2090 2962.2708 61495 0.31%
2437 1502 2955.2538 136 2953.2090 2962.2708 61520 0.31%
2438 1503 2959.2242 137 2953.2090 2962.2708 61532 0.31%
2439 1504 2955.8439 167 2953.2090 2962.2708 61542 0.31%
2440 1505 2957.7596 157 2953.2090 2962.2708 61550 0.31%
Elapsed time = 30.75 sec. (11218.36 ticks, tree = 68.01 MB, solutions = 13)
2441 1506 2954.6236 130 2953.2090 2962.2708 61564 0.31%
2442 1507 2958.4265 130 2953.2090 2962.2708 61585 0.31%
2443 1508 2955.8062 161 2953.2090 2962.2708 61588 0.31%
2444 1509 2957.7218 151 2953.2090 2962.2708 61591 0.31%
2445 1510 2953.6230 124 2953.2090 2962.2708 61596 0.31%
2446 1511 2957.7963 124 2953.2090 2962.2708 61608 0.31%
2447 1512 2955.6905 155 2953.2090 2962.2708 61616 0.31%
2448 1513 2957.6329 145 2953.2090 2962.2708 61625 0.31%
2449 1512 cutoff 2953.2090 2962.2708 61626 0.31%
2450 1513 2956.7957 118 2953.2090 2962.2708 61637 0.31%
Elapsed time = 30.76 sec. (11231.40 ticks, tree = 68.03 MB, solutions = 13)
2451 1514 2955.6016 149 2953.2090 2962.2708 61643 0.31%
2452 1515 2956.8352 138 2953.2090 2962.2708 61699 0.31%
2453 1514 cutoff 2953.2090 2962.2708 61700 0.31%
2454 1515 2956.1035 112 2953.2090 2962.2708 61706 0.31%
* 2455+ 1009 2953.2571 2962.1369 69522 0.30%
Found incumbent of value 2953.257146 after 34.68 sec. (12594.29 ticks)
* 2455+ 672 2953.2686 2962.1369 69522 0.30%
Found incumbent of value 2953.268609 after 35.30 sec. (12745.92 ticks)
* 2455+ 448 2953.4510 2962.1369 71136 0.29%
Found incumbent of value 2953.451010 after 40.89 sec. (14995.15 ticks)
* 2455+ 298 2953.6000 2961.2781 76086 0.26%
Found incumbent of value 2953.600019 after 47.22 sec. (18120.12 ticks)
Implied bound cuts applied: 1286
Flow cuts applied: 171
Mixed integer rounding cuts applied: 1499
Zero-half cuts applied: 186
Gomory fractional cuts applied: 54
Root node processing (before b&c):
Real time = 12.61 sec. (5858.01 ticks)
Parallel b&c, 4 threads:
Real time = 37.24 sec. (13609.60 ticks)
Sync time (average) = 0.00 sec.
Wait time (average) = 0.00 sec.
------------
Total (root+branch&cut) = 49.84 sec. (19467.61 ticks)
Solution Status
Optimal
Final No of Nodes
2455
Final No of Nodes Left
299
You see, it output every node information before the 2455th node, but it stops at the node 2455 with gap 0.26%. I also query the number of nodes and nodes left using (IloCplex::getNnodes()), which are shown in the last four lines.
#CPLEXOptimizers#DecisionOptimization