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.0602569 seconds.
    local lower bound updated to 0.326224
    local upper bound updated to 0.641273

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.706537
    local lower bound updated to 0.691376

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.0502443 seconds.
    local lower bound updated to 0.385057
    local upper bound updated to 0.635036

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.0974832 seconds.
    local lower bound updated to 0.633086
    local upper bound updated to 0.63458

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.691014
    local lower bound updated to 0.682405

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.683412
    local lower bound updated to 0.682484

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.301751 seconds.
    local lower bound updated to 0.484737
    local upper bound updated to 0.682484

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.312279 seconds.
    local lower bound updated to 0.56211
    local upper bound updated to 0.635565

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 0.188028 seconds.
    local lower bound updated to 0.633177
    local upper bound updated to 0.63458

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.661431
    local lower bound updated to 0.63458

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.635342
    local lower bound updated to 0.634727

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.331747 seconds.
    local lower bound updated to 0.505414
    local upper bound updated to 0.634727

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.232632 seconds.
    local lower bound updated to 0.633179
    local upper bound updated to 0.63458

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.657524
    local lower bound updated to 0.63458

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.336602 seconds.
    local lower bound updated to 0.505414
    local upper bound updated to 0.63458

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.122151 seconds.
    local lower bound updated to 0.63458
    local upper bound updated to 0.63458
The time obtain the optimal randomized assortment is 2.6916 (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_11_4_200.000000_207412.log"
The computation time limit for a lower bound is 85996
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 720 rows, 700 columns and 2173 nonzeros
Model fingerprint: 0x54736142
Variable types: 659 continuous, 41 integer (41 binary)
Coefficient statistics:
  Matrix range     [2e-03, 1e+00]
  Objective range  [1e+00, 1e+00]
  Bounds range     [1e+00, 1e+00]
  RHS range        [3e-01, 1e+00]
Presolve removed 272 rows and 486 columns
Presolve time: 0.01s
Presolved: 448 rows, 214 columns, 1602 nonzeros
Variable types: 177 continuous, 37 integer (37 binary)
Found heuristic solution: objective 0.6802566
Found heuristic solution: objective 0.6701578

Root relaxation: objective 6.054350e-01, 97 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.60544    0    6    0.67016    0.60544  9.66%     -    0s
H    0     0                       0.6668276    0.60544  9.21%     -    0s
     0     0    0.60675    0    9    0.66683    0.60675  9.01%     -    0s
H    0     0                       0.6510876    0.60675  6.81%     -    0s
     0     0    0.61446    0   12    0.65109    0.61446  5.63%     -    0s
H    0     0                       0.6445888    0.61446  4.67%     -    0s
H    0     0                       0.6445821    0.61451  4.67%     -    0s
     0     0    0.61768    0   13    0.64458    0.61768  4.17%     -    0s
H    0     0                       0.6367181    0.61768  2.99%     -    0s
     0     0    0.62463    0    9    0.63672    0.62463  1.90%     -    0s
H    0     0                       0.6351792    0.62463  1.66%     -    0s
     0     0    0.62847    0    9    0.63518    0.62847  1.06%     -    0s
     0     0    0.62963    0    9    0.63518    0.62963  0.87%     -    0s
     0     0    0.63200    0    9    0.63518    0.63200  0.50%     -    0s
H    0     0                       0.6349094    0.63418  0.12%     -    0s
H    0     0                       0.6345799    0.63418  0.06%     -    0s

Cutting planes:
  Implied bound: 46
  MIR: 6
  Flow cover: 23
  RLT: 9
  Relax-and-lift: 21

Explored 1 nodes (600 simplex iterations) in 0.30 seconds (0.03 work units)
Thread count was 4 (of 40 available processors)

Solution count 10: 0.63458 0.634909 0.635179 ... 0.680257

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

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

        Job resource usage summary 

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

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