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 3.68945 seconds.
    local lower bound updated to 0.279914
    local upper bound updated to 0.550623

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.662489
    local lower bound updated to 0.662303

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.662303
    local lower bound updated to 0.662303
The Dual step takes 0.0529936 (S)
upper bound updated to 0.662303
*** OUTER ITERATION 1 ***

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 100.024 seconds.
    local lower bound updated to 0.351241
    local upper bound updated to 0.55295

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 10.723 seconds.
    local lower bound updated to 0.550217
    local upper bound updated to 0.550623

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 4.49134 seconds.
    local lower bound updated to 0.550623
    local upper bound updated to 0.550623
The Primal step takes 115.243 (S)
lower bound updated to 0.550623

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.625097
    local lower bound updated to 0.612694

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 54.5741 seconds.
    local lower bound updated to 0.408766
    local upper bound updated to 0.565936

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 38.1405 seconds.
    local lower bound updated to 0.551488
    local upper bound updated to 0.556273

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 25.6526 seconds.
    local lower bound updated to 0.554519
    local upper bound updated to 0.555016

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 31.1312 seconds.
    local lower bound updated to 0.554921
    local upper bound updated to 0.554977

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 22.4375 seconds.
    local lower bound updated to 0.554977
    local upper bound updated to 0.554977
The Primal step takes 171.947 (S)
lower bound updated to 0.554977

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.608319
    local lower bound updated to 0.579931

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.592241
    local lower bound updated to 0.585647

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 100.021 seconds.
    local lower bound updated to 0.468028
    local upper bound updated to 0.585647

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 22.8156 seconds.
    local lower bound updated to 0.553423
    local upper bound updated to 0.564587

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 45.4861 seconds.
    local lower bound updated to 0.555979
    local upper bound updated to 0.563866

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 28.2172 seconds.
    local lower bound updated to 0.555979
    local upper bound updated to 0.563536

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 71.8306 seconds.
    local lower bound updated to 0.55838
    local upper bound updated to 0.5605

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 76.6314 seconds.
    local lower bound updated to 0.55838
    local upper bound updated to 0.560239

    ++ RESTRICTED PRIMAL ITERATION 7 ++
One worst-case parameter optimization takes 100.016 seconds.
    local lower bound updated to 0.55838
    local upper bound updated to 0.55957

    ++ RESTRICTED PRIMAL ITERATION 8 ++
One worst-case parameter optimization takes 100.013 seconds.
    local lower bound updated to 0.55838
    local upper bound updated to 0.559355

    ++ RESTRICTED PRIMAL ITERATION 9 ++
One worst-case parameter optimization takes 58.4697 seconds.
    local lower bound updated to 0.558739
    local upper bound updated to 0.559306

    ++ RESTRICTED PRIMAL ITERATION 10 ++
One worst-case parameter optimization takes 100.014 seconds.
    local lower bound updated to 0.558739
    local upper bound updated to 0.559219

    ++ RESTRICTED PRIMAL ITERATION 11 ++
One worst-case parameter optimization takes 86.5636 seconds.
    local lower bound updated to 0.558966
    local upper bound updated to 0.559199

    ++ RESTRICTED PRIMAL ITERATION 12 ++
One worst-case parameter optimization takes 100.016 seconds.
    local lower bound updated to 0.558997
    local upper bound updated to 0.559192

    ++ RESTRICTED PRIMAL ITERATION 13 ++
One worst-case parameter optimization takes 100.018 seconds.
    local lower bound updated to 0.558997
    local upper bound updated to 0.559173

    ++ RESTRICTED PRIMAL ITERATION 14 ++
One worst-case parameter optimization takes 74.655 seconds.
    local lower bound updated to 0.559147
    local upper bound updated to 0.559169

    ++ RESTRICTED PRIMAL ITERATION 15 ++
One worst-case parameter optimization takes 73.585 seconds.
    local lower bound updated to 0.559169
    local upper bound updated to 0.559169
The Primal step takes 1138.4 (S)
lower bound updated to 0.559169

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.58319
    local lower bound updated to 0.56091

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.577535
    local lower bound updated to 0.571638

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.576656
    local lower bound updated to 0.5719

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 100.02 seconds.
    local lower bound updated to 0.499122
    local upper bound updated to 0.5719

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 29.4239 seconds.
    local lower bound updated to 0.534481
    local upper bound updated to 0.56644

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 100.021 seconds.
    local lower bound updated to 0.558728
    local upper bound updated to 0.565026

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 100.019 seconds.
    local lower bound updated to 0.558728
    local upper bound updated to 0.564389

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 100.021 seconds.
    local lower bound updated to 0.563919
    local upper bound updated to 0.564199

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 100.018 seconds.
    local lower bound updated to 0.563919
    local upper bound updated to 0.564106

    ++ RESTRICTED PRIMAL ITERATION 7 ++
One worst-case parameter optimization takes 100.019 seconds.
    local lower bound updated to 0.563919
    local upper bound updated to 0.564057

    ++ RESTRICTED PRIMAL ITERATION 8 ++
One worst-case parameter optimization takes 100.017 seconds.
    local lower bound updated to 0.563919
    local upper bound updated to 0.564034

    ++ RESTRICTED PRIMAL ITERATION 9 ++
One worst-case parameter optimization takes 100.016 seconds.
    local lower bound updated to 0.563919
    local upper bound updated to 0.564002

    ++ RESTRICTED PRIMAL ITERATION 10 ++
One worst-case parameter optimization takes 100.021 seconds.
    local lower bound updated to 0.563919
    local upper bound updated to 0.563988

    ++ RESTRICTED PRIMAL ITERATION 11 ++
One worst-case parameter optimization takes 100.018 seconds.
    local lower bound updated to 0.563919
    local upper bound updated to 0.563978

    ++ RESTRICTED PRIMAL ITERATION 12 ++
One worst-case parameter optimization takes 100.017 seconds.
    local lower bound updated to 0.563978
    local upper bound updated to 0.563978
The Primal step takes 1129.68 (S)
lower bound updated to 0.563978

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.581001
    local lower bound updated to 0.564487

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.564854
    local lower bound updated to 0.564495

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 100.024 seconds.
    local lower bound updated to 0.509893
    local upper bound updated to 0.564495

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 100.025 seconds.
    local lower bound updated to 0.564457
    local upper bound updated to 0.564494

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 100.024 seconds.
    local lower bound updated to 0.564494
    local upper bound updated to 0.564494
The Primal step takes 300.087 (S)
lower bound updated to 0.564494

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.581651
    local lower bound updated to 0.564494

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 100.025 seconds.
    local lower bound updated to 0.509893
    local upper bound updated to 0.564494

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 100.022 seconds.
    local lower bound updated to 0.564494
    local upper bound updated to 0.564494
The time obtain the optimal randomized assortment is 3077.61 (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_17_4_100.000000_108918.log"
The computation time limit for a lower bound is 82897
The model output flag is 1
Gurobi Optimizer version 9.5.1 build v9.5.1rc2 (linux64)
Thread count: 128 physical cores, 256 logical processors, using up to 4 threads
Optimize a model with 2410 rows, 1842 columns and 8043 nonzeros
Model fingerprint: 0xd9e89d3d
Variable types: 1777 continuous, 65 integer (65 binary)
Coefficient statistics:
  Matrix range     [1e-05, 1e+00]
  Objective range  [1e+00, 1e+00]
  Bounds range     [1e+00, 1e+00]
  RHS range        [6e-01, 1e+00]
Presolve removed 509 rows and 963 columns
Presolve time: 0.02s
Presolved: 1901 rows, 879 columns, 7289 nonzeros
Variable types: 816 continuous, 63 integer (63 binary)
Found heuristic solution: objective 0.7138553
Found heuristic solution: objective 0.6873828
Found heuristic solution: objective 0.6735169
Found heuristic solution: objective 0.6469756

Root relaxation: objective 4.039147e-01, 197 iterations, 0.00 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.40391    0   24    0.64698    0.40391  37.6%     -    0s
H    0     0                       0.6010046    0.40391  32.8%     -    0s
     0     0    0.40811    0   27    0.60100    0.40811  32.1%     -    0s
     0     0    0.40815    0   27    0.60100    0.40815  32.1%     -    0s
     0     0    0.44840    0   29    0.60100    0.44840  25.4%     -    0s
H    0     0                       0.6005811    0.44840  25.3%     -    0s
     0     0    0.44850    0   29    0.60058    0.44850  25.3%     -    0s
     0     0    0.45903    0   29    0.60058    0.45903  23.6%     -    0s
H    0     0                       0.5838759    0.45903  21.4%     -    0s
     0     0    0.45927    0   30    0.58388    0.45927  21.3%     -    0s
     0     0    0.46857    0   27    0.58388    0.46857  19.7%     -    0s
     0     0    0.46953    0   29    0.58388    0.46953  19.6%     -    0s
H    0     0                       0.5748228    0.46953  18.3%     -    0s
     0     0    0.47222    0   30    0.57482    0.47222  17.8%     -    0s
H    0     0                       0.5645394    0.47222  16.4%     -    2s
     0     2    0.47222    0   30    0.56454    0.47222  16.4%     -    2s
H  716   302                       0.5644937    0.49175  12.9%  30.5    4s
   999   430    0.51548    9   18    0.56449    0.49657  12.0%  29.7    6s
  2129   791    0.52091   11   30    0.56449    0.50342  10.8%  28.9   10s
  2694   865    0.54746   24   13    0.56449    0.50792  10.0%  33.3   15s
  4282   909    0.54543   24   15    0.56449    0.51662  8.48%  36.5   21s
  5513  1118    0.54210   22   16    0.56449    0.52030  7.83%  36.5   25s
  7033  1364    0.53429   25   14    0.56449    0.52296  7.36%  36.6   30s
  8043  1649     cutoff   24         0.56449    0.52424  7.13%  36.2   36s
  9237  1784    0.54681   24   15    0.56449    0.52618  6.79%  36.1   40s
 10552  1945    0.54201   24   15    0.56449    0.52777  6.51%  35.8   46s
 11852  2117     cutoff   26         0.56449    0.52858  6.36%  35.6   50s
 13332  2269    0.55003   28   16    0.56449    0.52998  6.11%  35.4   56s
 14819  2305    0.55858   27    8    0.56449    0.53119  5.90%  35.2   60s
 16456  2398    0.56214   26   14    0.56449    0.53246  5.68%  35.2   65s
 18024  2484    0.54946   25   12    0.56449    0.53367  5.46%  35.0   71s
 19936  2549    0.55141   27   15    0.56449    0.53473  5.27%  34.8   75s
H21605  2569                       0.5644937    0.53558  5.12%  34.7   79s
H21652  2569                       0.5644937    0.53571  5.10%  34.7   79s
 21887  2569     cutoff   30         0.56449    0.53594  5.06%  34.7   81s
 23402  2607    0.54703   25   17    0.56449    0.53690  4.89%  34.7   86s
 25128  2618    0.54865   23   15    0.56449    0.53792  4.71%  34.7   90s
 27103  2573    0.55536   28   10    0.56449    0.53911  4.50%  34.5   95s
 28681  2500     cutoff   29         0.56449    0.53996  4.35%  34.5  100s
 29564  2466    0.56081   26   12    0.56449    0.54049  4.25%  34.5  105s
 31315  2353     cutoff   28         0.56449    0.54142  4.09%  34.3  110s
 33440  2234    0.56200   28   12    0.56449    0.54276  3.85%  34.2  116s
 35202  2043    0.56351   26   18    0.56449    0.54414  3.61%  34.0  120s
 36774  1910     cutoff   27         0.56449    0.54527  3.41%  33.9  125s
 38785  1623    0.56131   27   13    0.56449    0.54652  3.18%  33.8  131s
 40344  1415     cutoff   30         0.56449    0.54808  2.91%  33.7  135s
 42064  1056    0.55785   26   10    0.56449    0.55033  2.51%  33.5  140s
 43985   646     cutoff   29         0.56449    0.55364  1.92%  33.3  145s

Cutting planes:
  Implied bound: 211
  MIR: 170
  Flow cover: 423
  RLT: 58
  Relax-and-lift: 78

Explored 45497 nodes (1499301 simplex iterations) in 146.59 seconds (166.92 work units)
Thread count was 4 (of 256 available processors)

Solution count 10: 0.564494 0.564494 0.564494 ... 0.673517

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

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

        Job resource usage summary 

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

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