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.187303 seconds.
    local lower bound updated to 0.337434
    local upper bound updated to 0.586878

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.626025
    local lower bound updated to 0.620564

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 1.17081 seconds.
    local lower bound updated to 0.419706
    local upper bound updated to 0.590448

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.359061 seconds.
    local lower bound updated to 0.58197
    local upper bound updated to 0.584527

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 0.332061 seconds.
    local lower bound updated to 0.584182
    local upper bound updated to 0.584358

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 0.253119 seconds.
    local lower bound updated to 0.584358
    local upper bound updated to 0.584358
The Primal step takes 2.12159 (S)
lower bound updated to 0.584358

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.606807
    local lower bound updated to 0.598989

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.606807
    local lower bound updated to 0.599685

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.60053
    local lower bound updated to 0.600014

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 2.93778 seconds.
    local lower bound updated to 0.506064
    local upper bound updated to 0.59342

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 1.48441 seconds.
    local lower bound updated to 0.586911
    local upper bound updated to 0.590909

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 1.49509 seconds.
    local lower bound updated to 0.586911
    local upper bound updated to 0.5902

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 1.88476 seconds.
    local lower bound updated to 0.586911
    local upper bound updated to 0.588883

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.601522
    local lower bound updated to 0.588883

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.597073
    local lower bound updated to 0.59552

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.596064
    local lower bound updated to 0.595532

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 8.34212 seconds.
    local lower bound updated to 0.526884
    local upper bound updated to 0.59396

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 1.78053 seconds.
    local lower bound updated to 0.56792
    local upper bound updated to 0.592187

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 3.17475 seconds.
    local lower bound updated to 0.586868
    local upper bound updated to 0.591818

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 12.6265 seconds.
    local lower bound updated to 0.58872
    local upper bound updated to 0.591698

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 6.94921 seconds.
    local lower bound updated to 0.590096
    local upper bound updated to 0.59154

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 3.93705 seconds.
    local lower bound updated to 0.590096
    local upper bound updated to 0.59154

    ++ RESTRICTED PRIMAL ITERATION 7 ++
One worst-case parameter optimization takes 10.2952 seconds.
    local lower bound updated to 0.590846
    local upper bound updated to 0.591478

    ++ RESTRICTED PRIMAL ITERATION 8 ++
One worst-case parameter optimization takes 6.2769 seconds.
    local lower bound updated to 0.590948
    local upper bound updated to 0.591237

    ++ RESTRICTED PRIMAL ITERATION 9 ++
One worst-case parameter optimization takes 11.999 seconds.
    local lower bound updated to 0.591052
    local upper bound updated to 0.59123

    ++ RESTRICTED PRIMAL ITERATION 10 ++
One worst-case parameter optimization takes 7.2396 seconds.
    local lower bound updated to 0.59123
    local upper bound updated to 0.59123
The Primal step takes 72.6551 (S)
lower bound updated to 0.59123

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.610589
    local lower bound updated to 0.59123

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.595649
    local lower bound updated to 0.591401

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.595649
    local lower bound updated to 0.592748

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 10.3782 seconds.
    local lower bound updated to 0.540391
    local upper bound updated to 0.592741

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 6.18274 seconds.
    local lower bound updated to 0.590776
    local upper bound updated to 0.592367

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 9.22343 seconds.
    local lower bound updated to 0.591156
    local upper bound updated to 0.592361

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 8.78681 seconds.
    local lower bound updated to 0.591865
    local upper bound updated to 0.592217

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 7.53174 seconds.
    local lower bound updated to 0.591865
    local upper bound updated to 0.592178

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 7.74567 seconds.
    local lower bound updated to 0.591934
    local upper bound updated to 0.592174

    ++ RESTRICTED PRIMAL ITERATION 7 ++
One worst-case parameter optimization takes 8.70799 seconds.
    local lower bound updated to 0.592113
    local upper bound updated to 0.592171

    ++ RESTRICTED PRIMAL ITERATION 8 ++
One worst-case parameter optimization takes 9.82397 seconds.
    local lower bound updated to 0.592165
    local upper bound updated to 0.592171
The Primal step takes 68.4144 (S)
lower bound updated to 0.592165

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.608889
    local lower bound updated to 0.592171

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.594496
    local lower bound updated to 0.592232

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 9.8532 seconds.
    local lower bound updated to 0.545884
    local upper bound updated to 0.592232

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 10.8423 seconds.
    local lower bound updated to 0.592144
    local upper bound updated to 0.592228

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.611551
    local lower bound updated to 0.592228

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 9.48798 seconds.
    local lower bound updated to 0.545884
    local upper bound updated to 0.592228

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 11.0399 seconds.
    local lower bound updated to 0.592228
    local upper bound updated to 0.592228
The time obtain the optimal randomized assortment is 214.365 (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_13_4_60.000000_62814.log"
The computation time limit for a lower bound is 85783
The model output flag is 1
Gurobi Optimizer version 9.5.1 build v9.5.1rc2 (linux64)
Thread count: 24 physical cores, 48 logical processors, using up to 4 threads
Optimize a model with 1464 rows, 1282 columns and 4570 nonzeros
Model fingerprint: 0xa580cf32
Variable types: 1233 continuous, 49 integer (49 binary)
Coefficient statistics:
  Matrix range     [3e-03, 1e+00]
  Objective range  [1e+00, 1e+00]
  Bounds range     [1e+00, 1e+00]
  RHS range        [5e-01, 1e+00]
Presolve removed 450 rows and 838 columns
Presolve time: 0.01s
Presolved: 1014 rows, 444 columns, 3874 nonzeros
Variable types: 398 continuous, 46 integer (46 binary)
Found heuristic solution: objective 0.6417084
Found heuristic solution: objective 0.6377897

Root relaxation: objective 3.497391e-01, 122 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.34974    0   21    0.63779    0.34974  45.2%     -    0s
H    0     0                       0.6358363    0.34974  45.0%     -    0s
H    0     0                       0.6240350    0.34974  44.0%     -    0s
     0     0    0.40163    0   22    0.62403    0.40163  35.6%     -    0s
     0     0    0.45405    0   23    0.62403    0.45405  27.2%     -    0s
     0     0    0.45407    0   23    0.62403    0.45407  27.2%     -    0s
     0     0    0.48697    0   22    0.62403    0.48697  22.0%     -    0s
H    0     0                       0.6219228    0.48697  21.7%     -    0s
     0     0    0.48874    0   22    0.62192    0.48874  21.4%     -    0s
H    0     0                       0.6209582    0.49274  20.6%     -    0s
     0     0    0.49274    0   21    0.62096    0.49274  20.6%     -    0s
H    0     0                       0.6028773    0.49274  18.3%     -    0s
     0     0    0.49429    0   21    0.60288    0.49429  18.0%     -    0s
     0     0    0.49574    0   21    0.60288    0.49574  17.8%     -    0s
H    0     0                       0.6006997    0.49574  17.5%     -    0s
     0     2    0.49574    0   21    0.60070    0.49574  17.5%     -    0s
H  109    82                       0.6000214    0.50979  15.0%  26.1    1s
H  200   121                       0.5999420    0.52342  12.8%  20.1    1s
H  230   121                       0.5948099    0.52526  11.7%  20.3    1s
H  240   154                       0.5922281    0.52526  11.3%  20.7    1s
H  304   172                       0.5922281    0.52526  11.3%  19.8    1s
H 1457   322                       0.5922281    0.54850  7.38%  16.8    2s
  3080   454    0.56680    8   10    0.59223    0.55762  5.84%  15.0    5s
  7180   479     cutoff   14         0.59223    0.57325  3.20%  13.3   10s

Cutting planes:
  Gomory: 1
  Implied bound: 177
  MIR: 80
  Flow cover: 176
  RLT: 11
  Relax-and-lift: 80

Explored 9882 nodes (124066 simplex iterations) in 11.89 seconds (7.98 work units)
Thread count was 4 (of 48 available processors)

Solution count 10: 0.592228 0.592228 0.59481 ... 0.624035

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

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

        Job resource usage summary 

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

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