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.172183 seconds.
    local lower bound updated to 0.214544
    local upper bound updated to 0.373243

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.50932
    local lower bound updated to 0.485315

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.505457 seconds.
    local lower bound updated to 0.292885
    local upper bound updated to 0.393785

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.547298 seconds.
    local lower bound updated to 0.387103
    local upper bound updated to 0.390575

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 0.709641 seconds.
    local lower bound updated to 0.387813
    local upper bound updated to 0.390224

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.457124
    local lower bound updated to 0.390224

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.412016
    local lower bound updated to 0.396412

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.412016
    local lower bound updated to 0.396484

    ++ RESTRICTED DUAL ITERATION 4 ++
    local upper bound updated to 0.407849
    local lower bound updated to 0.401969

    ++ RESTRICTED DUAL ITERATION 5 ++
    local upper bound updated to 0.407849
    local lower bound updated to 0.402901

    ++ RESTRICTED DUAL ITERATION 6 ++
    local upper bound updated to 0.405066
    local lower bound updated to 0.403965

    ++ RESTRICTED DUAL ITERATION 7 ++
    local upper bound updated to 0.405066
    local lower bound updated to 0.404466

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 2.97789 seconds.
    local lower bound updated to 0.352514
    local upper bound updated to 0.400146

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.743455 seconds.
    local lower bound updated to 0.352514
    local upper bound updated to 0.398196

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 2.18693 seconds.
    local lower bound updated to 0.369975
    local upper bound updated to 0.398182

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 4.41905 seconds.
    local lower bound updated to 0.387687
    local upper bound updated to 0.397831

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 4.09719 seconds.
    local lower bound updated to 0.392898
    local upper bound updated to 0.397699

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 3.56093 seconds.
    local lower bound updated to 0.397127
    local upper bound updated to 0.397676

    ++ RESTRICTED PRIMAL ITERATION 7 ++
One worst-case parameter optimization takes 5.13178 seconds.
    local lower bound updated to 0.397127
    local upper bound updated to 0.397597

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.48381
    local lower bound updated to 0.397597

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.400435
    local lower bound updated to 0.397746

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.399254
    local lower bound updated to 0.39779

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 4.08458 seconds.
    local lower bound updated to 0.360886
    local upper bound updated to 0.39779

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 5.55615 seconds.
    local lower bound updated to 0.394345
    local upper bound updated to 0.397696

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 4.95689 seconds.
    local lower bound updated to 0.397644
    local upper bound updated to 0.397694

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.471902
    local lower bound updated to 0.397694

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 4.08184 seconds.
    local lower bound updated to 0.360886
    local upper bound updated to 0.397694

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 4.77792 seconds.
    local lower bound updated to 0.397694
    local upper bound updated to 0.397694
The time obtain the optimal randomized assortment is 60.5876 (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_200.000000_207414.log"
The computation time limit for a lower bound is 85937
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 1590 rows, 1394 columns and 4938 nonzeros
Model fingerprint: 0x853d6dca
Variable types: 1345 continuous, 49 integer (49 binary)
Coefficient statistics:
  Matrix range     [2e-04, 1e+00]
  Objective range  [1e+00, 1e+00]
  Bounds range     [1e+00, 1e+00]
  RHS range        [3e-01, 1e+00]
Presolve removed 462 rows and 908 columns
Presolve time: 0.02s
Presolved: 1128 rows, 486 columns, 4182 nonzeros
Variable types: 438 continuous, 48 integer (48 binary)
Found heuristic solution: objective 0.5097247
Found heuristic solution: objective 0.5094312

Root relaxation: objective 1.873213e-01, 155 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.18732    0   14    0.50943    0.18732  63.2%     -    0s
H    0     0                       0.4698728    0.18732  60.1%     -    0s
H    0     0                       0.4648507    0.19796  57.4%     -    0s
H    0     0                       0.4644521    0.19796  57.4%     -    0s
H    0     0                       0.4488561    0.19796  55.9%     -    0s
     0     0    0.21694    0   26    0.44886    0.21694  51.7%     -    0s
H    0     0                       0.4144541    0.21694  47.7%     -    0s
H    0     0                       0.4136160    0.21694  47.6%     -    0s
H    0     0                       0.3976940    0.27209  31.6%     -    0s
     0     0    0.27320    0   23    0.39769    0.27320  31.3%     -    0s
     0     0    0.28411    0   21    0.39769    0.28411  28.6%     -    0s
     0     0    0.29987    0   23    0.39769    0.29987  24.6%     -    0s
     0     0    0.30140    0   23    0.39769    0.30140  24.2%     -    0s
     0     0    0.30327    0   26    0.39769    0.30327  23.7%     -    0s
     0     0    0.30360    0   26    0.39769    0.30360  23.7%     -    0s
     0     0    0.30647    0   24    0.39769    0.30647  22.9%     -    0s
     0     2    0.30647    0   24    0.39769    0.30647  22.9%     -    1s

Cutting planes:
  Implied bound: 173
  MIR: 46
  Flow cover: 184
  RLT: 14
  Relax-and-lift: 75

Explored 1849 nodes (29266 simplex iterations) in 4.72 seconds (2.03 work units)
Thread count was 4 (of 40 available processors)

Solution count 9: 0.397694 0.413616 0.414454 ... 0.509725

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

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

        Job resource usage summary 

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

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