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.0867617 seconds.
    local lower bound updated to 0.285543
    local upper bound updated to 0.531466

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.640079
    local lower bound updated to 0.622643

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.128256 seconds.
    local lower bound updated to 0.311579
    local upper bound updated to 0.519623

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.12687 seconds.
    local lower bound updated to 0.514894
    local upper bound updated to 0.516624

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.558173
    local lower bound updated to 0.517894

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.527352
    local lower bound updated to 0.521016

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.522914
    local lower bound updated to 0.521693

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.375467 seconds.
    local lower bound updated to 0.41373
    local upper bound updated to 0.521016

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.324629 seconds.
    local lower bound updated to 0.514522
    local upper bound updated to 0.520477

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 0.376438 seconds.
    local lower bound updated to 0.517025
    local upper bound updated to 0.51754

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 0.314962 seconds.
    local lower bound updated to 0.517025
    local upper bound updated to 0.517338

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 0.406277 seconds.
    local lower bound updated to 0.517025
    local upper bound updated to 0.517296

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 0.391506 seconds.
    local lower bound updated to 0.517025
    local upper bound updated to 0.517274

    ++ RESTRICTED PRIMAL ITERATION 7 ++
One worst-case parameter optimization takes 0.297448 seconds.
    local lower bound updated to 0.517025
    local upper bound updated to 0.517075

    ++ RESTRICTED PRIMAL ITERATION 8 ++
One worst-case parameter optimization takes 0.443573 seconds.
    local lower bound updated to 0.517025
    local upper bound updated to 0.517072

    ++ RESTRICTED PRIMAL ITERATION 9 ++
One worst-case parameter optimization takes 0.47686 seconds.
    local lower bound updated to 0.517025
    local upper bound updated to 0.517051

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.537759
    local lower bound updated to 0.517051

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.537759
    local lower bound updated to 0.517284

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.494288 seconds.
    local lower bound updated to 0.423417
    local upper bound updated to 0.517284

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.619811 seconds.
    local lower bound updated to 0.516262
    local upper bound updated to 0.517051

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.53336
    local lower bound updated to 0.517051

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.381843 seconds.
    local lower bound updated to 0.423417
    local upper bound updated to 0.517051

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.335031 seconds.
    local lower bound updated to 0.517051
    local upper bound updated to 0.517051
The time obtain the optimal randomized assortment is 7.99417 (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_100.000000_107812.log"
The computation time limit for a lower bound is 85991
The model output flag is 1
Gurobi Optimizer version 9.5.1 build v9.5.1rc2 (linux64)
Thread count: 128 physical cores, 128 logical processors, using up to 4 threads
Optimize a model with 736 rows, 700 columns and 2201 nonzeros
Model fingerprint: 0x55ec34d3
Variable types: 659 continuous, 41 integer (41 binary)
Coefficient statistics:
  Matrix range     [1e-03, 1e+00]
  Objective range  [1e+00, 1e+00]
  Bounds range     [1e+00, 1e+00]
  RHS range        [4e-01, 1e+00]
Presolve removed 278 rows and 482 columns
Presolve time: 0.00s
Presolved: 458 rows, 218 columns, 1649 nonzeros
Variable types: 180 continuous, 38 integer (38 binary)
Found heuristic solution: objective 0.5961539

Root relaxation: objective 3.671802e-01, 81 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.36718    0   11    0.59615    0.36718  38.4%     -    0s
H    0     0                       0.5644953    0.36718  35.0%     -    0s
H    0     0                       0.5511791    0.36718  33.4%     -    0s
H    0     0                       0.5502348    0.38954  29.2%     -    0s
H    0     0                       0.5335393    0.38954  27.0%     -    0s
     0     0    0.40331    0   15    0.53354    0.40331  24.4%     -    0s
H    0     0                       0.5199734    0.40331  22.4%     -    0s
     0     0    0.40331    0   15    0.51997    0.40331  22.4%     -    0s
     0     0    0.43476    0   20    0.51997    0.43476  16.4%     -    0s
H    0     0                       0.5180983    0.43756  15.5%     -    0s
     0     0    0.44611    0   20    0.51810    0.44611  13.9%     -    0s
     0     0    0.46791    0   16    0.51810    0.46791  9.69%     -    0s
     0     0    0.46883    0   17    0.51810    0.46883  9.51%     -    0s
     0     0    0.47453    0   14    0.51810    0.47453  8.41%     -    0s
     0     0    0.47472    0   14    0.51810    0.47472  8.37%     -    0s
     0     0    0.47509    0   16    0.51810    0.47509  8.30%     -    0s
H    0     0                       0.5171707    0.47509  8.14%     -    0s
H    0     0                       0.5170513    0.47509  8.12%     -    0s
     0     2    0.47509    0   16    0.51705    0.47509  8.12%     -    0s

Cutting planes:
  Implied bound: 43
  MIR: 15
  Flow cover: 45
  RLT: 1
  Relax-and-lift: 20

Explored 72 nodes (1525 simplex iterations) in 0.47 seconds (0.11 work units)
Thread count was 4 (of 128 available processors)

Solution count 9: 0.517051 0.517171 0.518098 ... 0.596154

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

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

        Job resource usage summary 

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

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