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.0429193 seconds.
    local lower bound updated to 0.253765
    local upper bound updated to 0.474329

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.682175
    local lower bound updated to 0.679631

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.218959 seconds.
    local lower bound updated to 0.315408
    local upper bound updated to 0.474997

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.0632172 seconds.
    local lower bound updated to 0.47413
    local upper bound updated to 0.474329

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.584957
    local lower bound updated to 0.474508

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.506299
    local lower bound updated to 0.480132

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.488992
    local lower bound updated to 0.485423

    ++ RESTRICTED DUAL ITERATION 4 ++
    local upper bound updated to 0.488992
    local lower bound updated to 0.486317

    ++ RESTRICTED DUAL ITERATION 5 ++
    local upper bound updated to 0.486317
    local lower bound updated to 0.486317
The Dual step takes 0.155103 (S)
upper bound updated to 0.486317
*** OUTER ITERATION 2 ***

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.390718 seconds.
    local lower bound updated to 0.401136
    local upper bound updated to 0.484289

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.132803 seconds.
    local lower bound updated to 0.482823
    local upper bound updated to 0.48388

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.578012
    local lower bound updated to 0.48388

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.498763
    local lower bound updated to 0.484482

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.487859
    local lower bound updated to 0.484526

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.330884 seconds.
    local lower bound updated to 0.411448
    local upper bound updated to 0.484526

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.0949274 seconds.
    local lower bound updated to 0.475814
    local upper bound updated to 0.484042

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 0.323386 seconds.
    local lower bound updated to 0.482602
    local upper bound updated to 0.48388

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.556925
    local lower bound updated to 0.48388

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.489445
    local lower bound updated to 0.483947

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.448058 seconds.
    local lower bound updated to 0.417057
    local upper bound updated to 0.483947

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.34882 seconds.
    local lower bound updated to 0.482585
    local upper bound updated to 0.48388

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.5506
    local lower bound updated to 0.48388

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.406123 seconds.
    local lower bound updated to 0.417057
    local upper bound updated to 0.48388

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.16785 seconds.
    local lower bound updated to 0.48388
    local upper bound updated to 0.48388
The time obtain the optimal randomized assortment is 4.32565 (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_208012.log"
The computation time limit for a lower bound is 85994
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 996 rows, 982 columns and 3000 nonzeros
Model fingerprint: 0xc4e6f083
Variable types: 941 continuous, 41 integer (41 binary)
Coefficient statistics:
  Matrix range     [9e-03, 1e+00]
  Objective range  [1e+00, 1e+00]
  Bounds range     [1e+00, 1e+00]
  RHS range        [2e-01, 1e+00]
Presolve removed 442 rows and 722 columns
Presolve time: 0.01s
Presolved: 554 rows, 260 columns, 2074 nonzeros
Variable types: 222 continuous, 38 integer (38 binary)
Found heuristic solution: objective 0.5896103
Found heuristic solution: objective 0.5311665

Root relaxation: objective 4.053521e-01, 103 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.40535    0   12    0.53117    0.40535  23.7%     -    0s
     0     0    0.44328    0   12    0.53117    0.44328  16.5%     -    0s
H    0     0                       0.4965724    0.44328  10.7%     -    0s
     0     0    0.44328    0   12    0.49657    0.44328  10.7%     -    0s
     0     0    0.45479    0   12    0.49657    0.45479  8.41%     -    0s
H    0     0                       0.4844201    0.45479  6.12%     -    0s
     0     0    0.45490    0   13    0.48442    0.45490  6.09%     -    0s
H    0     0                       0.4838802    0.46569  3.76%     -    0s
     0     0    0.46569    0   16    0.48388    0.46569  3.76%     -    0s
     0     0    0.46701    0   16    0.48388    0.46701  3.49%     -    0s
     0     0    0.47182    0   14    0.48388    0.47182  2.49%     -    0s
     0     0    0.47386    0   17    0.48388    0.47386  2.07%     -    0s

Cutting planes:
  Implied bound: 63
  MIR: 16
  Flow cover: 41
  RLT: 11
  Relax-and-lift: 28

Explored 1 nodes (669 simplex iterations) in 0.16 seconds (0.05 work units)
Thread count was 4 (of 48 available processors)

Solution count 5: 0.48388 0.48442 0.496572 ... 0.58961

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

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

        Job resource usage summary 

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

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