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.532667 seconds.
    local lower bound updated to 0.313081
    local upper bound updated to 0.602895

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.650916
    local lower bound updated to 0.619527

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.646955
    local lower bound updated to 0.638412

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.641888
    local lower bound updated to 0.640213

    ++ RESTRICTED DUAL ITERATION 4 ++
    local upper bound updated to 0.640751
    local lower bound updated to 0.640632

    ++ RESTRICTED DUAL ITERATION 5 ++
    local upper bound updated to 0.640632
    local lower bound updated to 0.640632
The Dual step takes 0.205974 (S)
upper bound updated to 0.640632
*** OUTER ITERATION 1 ***

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 2.96284 seconds.
    local lower bound updated to 0.471463
    local upper bound updated to 0.615118

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 3.6689 seconds.
    local lower bound updated to 0.590993
    local upper bound updated to 0.609449

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 4.61302 seconds.
    local lower bound updated to 0.595384
    local upper bound updated to 0.607162

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 1.88849 seconds.
    local lower bound updated to 0.600085
    local upper bound updated to 0.60324

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 0.831823 seconds.
    local lower bound updated to 0.601845
    local upper bound updated to 0.602767

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 1.33768 seconds.
    local lower bound updated to 0.602367
    local upper bound updated to 0.602561

    ++ RESTRICTED PRIMAL ITERATION 7 ++
One worst-case parameter optimization takes 1.51862 seconds.
    local lower bound updated to 0.602561
    local upper bound updated to 0.602561
The Primal step takes 16.8399 (S)
lower bound updated to 0.602561

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.623724
    local lower bound updated to 0.605381

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.623724
    local lower bound updated to 0.612137

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.619346
    local lower bound updated to 0.614453

    ++ RESTRICTED DUAL ITERATION 4 ++
    local upper bound updated to 0.619346
    local lower bound updated to 0.615259

    ++ RESTRICTED DUAL ITERATION 5 ++
    local upper bound updated to 0.618401
    local lower bound updated to 0.615498

    ++ RESTRICTED DUAL ITERATION 6 ++
    local upper bound updated to 0.61782
    local lower bound updated to 0.615773

    ++ RESTRICTED DUAL ITERATION 7 ++
    local upper bound updated to 0.616257
    local lower bound updated to 0.615842

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 60.0182 seconds.
    local lower bound updated to 0.546148
    local upper bound updated to 0.612326

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 1.47166 seconds.
    local lower bound updated to 0.546148
    local upper bound updated to 0.608802

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 5.90435 seconds.
    local lower bound updated to 0.592121
    local upper bound updated to 0.606119

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 15.4449 seconds.
    local lower bound updated to 0.594645
    local upper bound updated to 0.605877

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 10.4912 seconds.
    local lower bound updated to 0.603024
    local upper bound updated to 0.605428

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 5.73803 seconds.
    local lower bound updated to 0.603167
    local upper bound updated to 0.605081

    ++ RESTRICTED PRIMAL ITERATION 7 ++
One worst-case parameter optimization takes 5.62433 seconds.
    local lower bound updated to 0.603167
    local upper bound updated to 0.604366

    ++ RESTRICTED PRIMAL ITERATION 8 ++
One worst-case parameter optimization takes 8.13151 seconds.
    local lower bound updated to 0.604231
    local upper bound updated to 0.604346

    ++ RESTRICTED PRIMAL ITERATION 9 ++
One worst-case parameter optimization takes 8.70638 seconds.
    local lower bound updated to 0.604346
    local upper bound updated to 0.604346
The Primal step takes 121.579 (S)
lower bound updated to 0.604346

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.61225
    local lower bound updated to 0.604346

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.607542
    local lower bound updated to 0.60447

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.605706
    local lower bound updated to 0.604627

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 60.0167 seconds.
    local lower bound updated to 0.553551
    local upper bound updated to 0.604627

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 24.2108 seconds.
    local lower bound updated to 0.603861
    local upper bound updated to 0.604604

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 21.1838 seconds.
    local lower bound updated to 0.604319
    local upper bound updated to 0.604594

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 20.5185 seconds.
    local lower bound updated to 0.604467
    local upper bound updated to 0.604592

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.610501
    local lower bound updated to 0.604592

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 45.8536 seconds.
    local lower bound updated to 0.553551
    local upper bound updated to 0.604592

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 23.5574 seconds.
    local lower bound updated to 0.604592
    local upper bound updated to 0.604592
The time obtain the optimal randomized assortment is 364.313 (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_69716.log"
The computation time limit for a lower bound is 85633
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 2640 rows, 2138 columns and 8419 nonzeros
Model fingerprint: 0x622fe3d1
Variable types: 2081 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 705 rows and 1297 columns
Presolve time: 0.02s
Presolved: 1935 rows, 841 columns, 7413 nonzeros
Variable types: 786 continuous, 55 integer (55 binary)
Found heuristic solution: objective 0.7193410
Found heuristic solution: objective 0.6969484
Found heuristic solution: objective 0.6703056

Root relaxation: objective 4.380306e-01, 267 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.43803    0   17    0.67031    0.43803  34.7%     -    0s
H    0     0                       0.6416186    0.43803  31.7%     -    0s
H    0     0                       0.6408673    0.45362  29.2%     -    0s
     0     0    0.45388    0   26    0.64087    0.45388  29.2%     -    0s
     0     0    0.45389    0   25    0.64087    0.45389  29.2%     -    0s
H    0     0                       0.6368826    0.45389  28.7%     -    0s
     0     0    0.49998    0   25    0.63688    0.49998  21.5%     -    0s
     0     0    0.50019    0   27    0.63688    0.50019  21.5%     -    0s
     0     0    0.52231    0   29    0.63688    0.52231  18.0%     -    0s
     0     0    0.52286    0   28    0.63688    0.52286  17.9%     -    0s
H    0     0                       0.6288690    0.52286  16.9%     -    0s
     0     0    0.52865    0   24    0.62887    0.52865  15.9%     -    0s
H    0     0                       0.6109742    0.52865  13.5%     -    0s
     0     0    0.53078    0   24    0.61097    0.53078  13.1%     -    0s
     0     0    0.53185    0   25    0.61097    0.53185  12.9%     -    0s
H    0     0                       0.6050973    0.53185  12.1%     -    1s
     0     2    0.53185    0   25    0.60510    0.53185  12.1%     -    2s
H  304   102                       0.6045916    0.55353  8.45%  25.3    2s
H  429   158                       0.6045916    0.55353  8.45%  24.5    2s
H  909   277                       0.6045916    0.56194  7.05%  23.5    3s
H 1064   300                       0.6045916    0.56451  6.63%  22.4    4s
  1389   341    0.59221    8    6    0.60459    0.56732  6.16%  21.9    5s
H 1766   378                       0.6045916    0.56954  5.80%  21.1    7s
  2454   464     cutoff    9         0.60459    0.57290  5.24%  20.9   10s
  5698   589    0.59790   18    4    0.60459    0.58257  3.64%  19.0   15s
  9225   288     cutoff   15         0.60459    0.59226  2.04%  18.5   20s

Cutting planes:
  Gomory: 2
  Implied bound: 287
  MIR: 82
  Flow cover: 252
  RLT: 42
  Relax-and-lift: 135

Explored 10887 nodes (198680 simplex iterations) in 20.73 seconds (15.12 work units)
Thread count was 4 (of 48 available processors)

Solution count 10: 0.604592 0.604592 0.604592 ... 0.670306

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

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

        Job resource usage summary 

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

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