Set parameter TokenServer to value "gurobi.cc.ic.ac.uk"

********************************
*** COLUMN GENERATION SCHEME ***
********************************

*** OUTER ITERATION 0 ***

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.479249 seconds.
    local lower bound updated to 0.181223
    local upper bound updated to 0.298005

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 1.118 seconds.
    local lower bound updated to 0.297841
    local upper bound updated to 0.297841
The Primal step takes 1.59985 (S)
lower bound updated to 0.297841

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.374341
    local lower bound updated to 0.362474

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.374341
    local lower bound updated to 0.373171

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.374341
    local lower bound updated to 0.373977

    ++ RESTRICTED DUAL ITERATION 4 ++
    local upper bound updated to 0.373977
    local lower bound updated to 0.373977
The Dual step takes 0.171149 (S)
upper bound updated to 0.373977
*** OUTER ITERATION 1 ***

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.851537 seconds.
    local lower bound updated to 0.216998
    local upper bound updated to 0.336407

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 3.12952 seconds.
    local lower bound updated to 0.283536
    local upper bound updated to 0.320549

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 11.612 seconds.
    local lower bound updated to 0.305215
    local upper bound updated to 0.310103

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 6.54217 seconds.
    local lower bound updated to 0.305215
    local upper bound updated to 0.309107

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 14.2914 seconds.
    local lower bound updated to 0.305215
    local upper bound updated to 0.308084

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 12.7444 seconds.
    local lower bound updated to 0.305215
    local upper bound updated to 0.307491

    ++ RESTRICTED PRIMAL ITERATION 7 ++
One worst-case parameter optimization takes 14.3378 seconds.
    local lower bound updated to 0.305642
    local upper bound updated to 0.306247

    ++ RESTRICTED PRIMAL ITERATION 8 ++
One worst-case parameter optimization takes 10.9808 seconds.
    local lower bound updated to 0.306247
    local upper bound updated to 0.306247
The Primal step takes 74.513 (S)
lower bound updated to 0.306247

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.339904
    local lower bound updated to 0.321417

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.338654
    local lower bound updated to 0.329316

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.329316
    local lower bound updated to 0.329316
The Dual step takes 0.558933 (S)
upper bound updated to 0.329316
*** OUTER ITERATION 2 ***

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 2.91316 seconds.
    local lower bound updated to 0.250655
    local upper bound updated to 0.329316

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.8389 seconds.
    local lower bound updated to 0.250655
    local upper bound updated to 0.32109

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 5.99541 seconds.
    local lower bound updated to 0.307715
    local upper bound updated to 0.318192

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 26.5863 seconds.
    local lower bound updated to 0.315709
    local upper bound updated to 0.317201

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 24.9992 seconds.
    local lower bound updated to 0.315709
    local upper bound updated to 0.316747

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 16.9255 seconds.
    local lower bound updated to 0.315709
    local upper bound updated to 0.316268

    ++ RESTRICTED PRIMAL ITERATION 7 ++
One worst-case parameter optimization takes 25.9495 seconds.
    local lower bound updated to 0.315709
    local upper bound updated to 0.316122

    ++ RESTRICTED PRIMAL ITERATION 8 ++
One worst-case parameter optimization takes 27.4229 seconds.
    local lower bound updated to 0.315709
    local upper bound updated to 0.315976

    ++ RESTRICTED PRIMAL ITERATION 9 ++
One worst-case parameter optimization takes 26.5753 seconds.
    local lower bound updated to 0.315709
    local upper bound updated to 0.315967

    ++ RESTRICTED PRIMAL ITERATION 10 ++
One worst-case parameter optimization takes 24.778 seconds.
    local lower bound updated to 0.315709
    local upper bound updated to 0.31596

    ++ RESTRICTED PRIMAL ITERATION 11 ++
One worst-case parameter optimization takes 25.7242 seconds.
    local lower bound updated to 0.315805
    local upper bound updated to 0.315929

    ++ RESTRICTED PRIMAL ITERATION 12 ++
One worst-case parameter optimization takes 23.95 seconds.
    local lower bound updated to 0.315805
    local upper bound updated to 0.315929

    ++ RESTRICTED PRIMAL ITERATION 13 ++
One worst-case parameter optimization takes 21.0529 seconds.
    local lower bound updated to 0.315929
    local upper bound updated to 0.315929
The Primal step takes 253.77 (S)
lower bound updated to 0.315929

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.352847
    local lower bound updated to 0.320667

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.335067
    local lower bound updated to 0.32369

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.333582
    local lower bound updated to 0.32387

    ++ RESTRICTED DUAL ITERATION 4 ++
    local upper bound updated to 0.326686
    local lower bound updated to 0.323947

    ++ RESTRICTED DUAL ITERATION 5 ++
    local upper bound updated to 0.323947
    local lower bound updated to 0.323947
The Dual step takes 4.45902 (S)
upper bound updated to 0.323947
*** OUTER ITERATION 3 ***

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 13.5993 seconds.
    local lower bound updated to 0.268481
    local upper bound updated to 0.323947

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 5.91487 seconds.
    local lower bound updated to 0.288825
    local upper bound updated to 0.321339

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 13.4245 seconds.
    local lower bound updated to 0.316488
    local upper bound updated to 0.321224

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 15.8417 seconds.
    local lower bound updated to 0.317676
    local upper bound updated to 0.320814

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 25.4218 seconds.
    local lower bound updated to 0.318619
    local upper bound updated to 0.320585

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 29.3533 seconds.
    local lower bound updated to 0.319385
    local upper bound updated to 0.320461

    ++ RESTRICTED PRIMAL ITERATION 7 ++
One worst-case parameter optimization takes 23.9552 seconds.
    local lower bound updated to 0.319385
    local upper bound updated to 0.320365

    ++ RESTRICTED PRIMAL ITERATION 8 ++
One worst-case parameter optimization takes 29.4458 seconds.
    local lower bound updated to 0.319442
    local upper bound updated to 0.32019

    ++ RESTRICTED PRIMAL ITERATION 9 ++
One worst-case parameter optimization takes 24.6996 seconds.
    local lower bound updated to 0.319599
    local upper bound updated to 0.320159

    ++ RESTRICTED PRIMAL ITERATION 10 ++
One worst-case parameter optimization takes 24.0816 seconds.
    local lower bound updated to 0.319599
    local upper bound updated to 0.320083

    ++ RESTRICTED PRIMAL ITERATION 11 ++
One worst-case parameter optimization takes 40.9451 seconds.
    local lower bound updated to 0.319957
    local upper bound updated to 0.320075

    ++ RESTRICTED PRIMAL ITERATION 12 ++
One worst-case parameter optimization takes 39.5471 seconds.
    local lower bound updated to 0.320003
    local upper bound updated to 0.320068

    ++ RESTRICTED PRIMAL ITERATION 13 ++
One worst-case parameter optimization takes 47.5564 seconds.
    local lower bound updated to 0.320033
    local upper bound updated to 0.320067

    ++ RESTRICTED PRIMAL ITERATION 14 ++
One worst-case parameter optimization takes 30.3271 seconds.
    local lower bound updated to 0.320033
    local upper bound updated to 0.320056

    ++ RESTRICTED PRIMAL ITERATION 15 ++
One worst-case parameter optimization takes 44.3797 seconds.
    local lower bound updated to 0.320039
    local upper bound updated to 0.320055

    ++ RESTRICTED PRIMAL ITERATION 16 ++
One worst-case parameter optimization takes 39.5323 seconds.
    local lower bound updated to 0.320039
    local upper bound updated to 0.320052

    ++ RESTRICTED PRIMAL ITERATION 17 ++
One worst-case parameter optimization takes 42.1095 seconds.
    local lower bound updated to 0.320052
    local upper bound updated to 0.320052
The Primal step takes 490.255 (S)
lower bound updated to 0.320052

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.338597
    local lower bound updated to 0.320063

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.338597
    local lower bound updated to 0.320845

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.322352
    local lower bound updated to 0.320924

    ++ RESTRICTED DUAL ITERATION 4 ++
    local upper bound updated to 0.321713
    local lower bound updated to 0.320974

    ++ RESTRICTED DUAL ITERATION 5 ++
    local upper bound updated to 0.320974
    local lower bound updated to 0.320974
The Dual step takes 20.2384 (S)
upper bound updated to 0.320974
*** OUTER ITERATION 4 ***

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 10.6058 seconds.
    local lower bound updated to 0.279857
    local upper bound updated to 0.320974

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 31.1481 seconds.
    local lower bound updated to 0.314809
    local upper bound updated to 0.320832

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 34.6027 seconds.
    local lower bound updated to 0.319983
    local upper bound updated to 0.320741

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 60.0327 seconds.
    local lower bound updated to 0.320252
    local upper bound updated to 0.320682

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 36.7726 seconds.
    local lower bound updated to 0.320485
    local upper bound updated to 0.320649

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 60.0449 seconds.
    local lower bound updated to 0.320485
    local upper bound updated to 0.320644

    ++ RESTRICTED PRIMAL ITERATION 7 ++
One worst-case parameter optimization takes 60.0286 seconds.
    local lower bound updated to 0.320565
    local upper bound updated to 0.320643

    ++ RESTRICTED PRIMAL ITERATION 8 ++
One worst-case parameter optimization takes 60.0375 seconds.
    local lower bound updated to 0.320635
    local upper bound updated to 0.320643
The Primal step takes 353.35 (S)
lower bound updated to 0.320635

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.334342
    local lower bound updated to 0.320643

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.320643
    local lower bound updated to 0.320643
The Dual step takes 9.93532 (S)
upper bound updated to 0.320643
This is to get the final optimal randomized assortment

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 10.7555 seconds.
    local lower bound updated to 0.279857
    local upper bound updated to 0.320643

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 60.0184 seconds.
    local lower bound updated to 0.320643
    local upper bound updated to 0.320643
The time obtain the optimal randomized assortment is 1279.64 (S)
Now, the randomization optimization has been finished. We are checking the lower bound ....
Set parameter OutputFlag to value 1
Set parameter LogFile to value "/rds/general/user/zw1819/home/RAO/RAO_MC/FinalRun/RecFMResult/logFile_15_4_60.000000_66516.log"
The computation time limit for a lower bound is 84709
The model output flag is 1
Gurobi Optimizer version 9.5.1 build v9.5.1rc2 (linux64)
Thread count: 20 physical cores, 40 logical processors, using up to 4 threads
Optimize a model with 2480 rows, 2008 columns and 7976 nonzeros
Model fingerprint: 0x22aaf549
Variable types: 1951 continuous, 57 integer (57 binary)
Coefficient statistics:
  Matrix range     [2e-03, 1e+00]
  Objective range  [1e+00, 1e+00]
  Bounds range     [1e+00, 1e+00]
  RHS range        [4e-01, 1e+00]
Presolve removed 647 rows and 1209 columns
Presolve time: 0.04s
Presolved: 1833 rows, 799 columns, 7076 nonzeros
Variable types: 743 continuous, 56 integer (56 binary)
Found heuristic solution: objective 0.4011667
Found heuristic solution: objective 0.3694540

Root relaxation: objective 1.441265e-01, 224 iterations, 0.01 seconds (0.00 work units)

    Nodes    |    Current Node    |     Objective Bounds      |     Work
 Expl Unexpl |  Obj  Depth IntInf | Incumbent    BestBd   Gap | It/Node Time

     0     0    0.14413    0   20    0.36945    0.14413  61.0%     -    0s
H    0     0                       0.3207096    0.14413  55.1%     -    0s
     0     0    0.15937    0   27    0.32071    0.15937  50.3%     -    0s
     0     0    0.21162    0   29    0.32071    0.21162  34.0%     -    0s
     0     0    0.21173    0   30    0.32071    0.21173  34.0%     -    0s
     0     0    0.22381    0   26    0.32071    0.22381  30.2%     -    0s
     0     0    0.22437    0   26    0.32071    0.22437  30.0%     -    0s
     0     0    0.22873    0   28    0.32071    0.22873  28.7%     -    0s
     0     0    0.23080    0   25    0.32071    0.23080  28.0%     -    0s
     0     0    0.23226    0   26    0.32071    0.23226  27.6%     -    0s
H    0     0                       0.3206426    0.23226  27.6%     -    2s
     0     2    0.23226    0   26    0.32064    0.23226  27.6%     -    2s
   798   269     cutoff   11         0.32064    0.28154  12.2%  24.5    6s
H 1249   344                       0.3206426    0.28536  11.0%  23.1    8s
  1474   409     cutoff   17         0.32064    0.28756  10.3%  22.6   11s
  2030   496    0.29923   11   12    0.32064    0.28995  9.57%  22.1   15s
  2957   580    0.31898   13    8    0.32064    0.29465  8.11%  20.6   20s
  3902   671    0.30622   10   12    0.32064    0.29815  7.01%  20.2   25s
  5496   717    0.31311   13   26    0.32064    0.30105  6.11%  19.0   30s
  6257   704    0.30105   26   16    0.32064    0.30105  6.11%  20.7   35s
  7090   594    0.31006   25   12    0.32064    0.30105  6.11%  21.2   40s
  8391   495    0.32048   31    4    0.32064    0.30105  6.11%  21.5   46s
  9091   525 infeasible   34         0.32064    0.30192  5.84%  21.6   50s
 11093   484    0.31253   30   10    0.32064    0.30806  3.92%  21.4   56s
 12440   394    0.31945   34    6    0.32064    0.31089  3.04%  20.9   60s

Cutting planes:
  Implied bound: 228
  MIR: 132
  Flow cover: 350
  RLT: 52
  Relax-and-lift: 69

Explored 15030 nodes (300127 simplex iterations) in 64.32 seconds (36.67 work units)
Thread count was 4 (of 40 available processors)

Solution count 5: 0.320643 0.320643 0.32071 ... 0.401167

Optimal solution found (tolerance 1.00e-04)
Best objective 3.206426267426e-01, best bound 3.206426267426e-01, gap 0.0000%
The objective bound is 0.320643 while the objective upper bound is 0.320643

============================================

        Job resource usage summary 

                 Memory (GB)    NCPUs
 Requested  :        12             4
 Used       :         0 (peak)   3.70 (ave)

============================================
