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.215017 seconds.
    local lower bound updated to 0.246011
    local upper bound updated to 0.488817

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.570258
    local lower bound updated to 0.554288

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.559347
    local lower bound updated to 0.558417

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.721276 seconds.
    local lower bound updated to 0.339004
    local upper bound updated to 0.50202

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 1.16934 seconds.
    local lower bound updated to 0.480042
    local upper bound updated to 0.490064

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 0.47055 seconds.
    local lower bound updated to 0.480042
    local upper bound updated to 0.482962

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.504671
    local lower bound updated to 0.500296

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.504671
    local lower bound updated to 0.500796

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.504671
    local lower bound updated to 0.501399

    ++ RESTRICTED DUAL ITERATION 4 ++
    local upper bound updated to 0.504671
    local lower bound updated to 0.501694

    ++ RESTRICTED DUAL ITERATION 5 ++
    local upper bound updated to 0.504091
    local lower bound updated to 0.501801

    ++ RESTRICTED DUAL ITERATION 6 ++
    local upper bound updated to 0.501801
    local lower bound updated to 0.501801
The Dual step takes 0.719597 (S)
upper bound updated to 0.501801
*** OUTER ITERATION 2 ***

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 7.1051 seconds.
    local lower bound updated to 0.402967
    local upper bound updated to 0.497986

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 1.84328 seconds.
    local lower bound updated to 0.466727
    local upper bound updated to 0.497207

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 9.09794 seconds.
    local lower bound updated to 0.488214
    local upper bound updated to 0.494255

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 5.28412 seconds.
    local lower bound updated to 0.488214
    local upper bound updated to 0.493467

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 10.3904 seconds.
    local lower bound updated to 0.488214
    local upper bound updated to 0.492222

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 2.91849 seconds.
    local lower bound updated to 0.488214
    local upper bound updated to 0.492005

    ++ RESTRICTED PRIMAL ITERATION 7 ++
One worst-case parameter optimization takes 4.2323 seconds.
    local lower bound updated to 0.489551
    local upper bound updated to 0.491646

    ++ RESTRICTED PRIMAL ITERATION 8 ++
One worst-case parameter optimization takes 3.7379 seconds.
    local lower bound updated to 0.489551
    local upper bound updated to 0.491224

    ++ RESTRICTED PRIMAL ITERATION 9 ++
One worst-case parameter optimization takes 9.66031 seconds.
    local lower bound updated to 0.489833
    local upper bound updated to 0.490658

    ++ RESTRICTED PRIMAL ITERATION 10 ++
One worst-case parameter optimization takes 7.50643 seconds.
    local lower bound updated to 0.490429
    local upper bound updated to 0.490624

    ++ RESTRICTED PRIMAL ITERATION 11 ++
One worst-case parameter optimization takes 7.84329 seconds.
    local lower bound updated to 0.490624
    local upper bound updated to 0.490624
The Primal step takes 69.663 (S)
lower bound updated to 0.490624

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.502434
    local lower bound updated to 0.490624

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.49468
    local lower bound updated to 0.490667

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 2.95223 seconds.
    local lower bound updated to 0.406199
    local upper bound updated to 0.490667

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 7.19711 seconds.
    local lower bound updated to 0.490013
    local upper bound updated to 0.490643

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 10.5228 seconds.
    local lower bound updated to 0.490543
    local upper bound updated to 0.490638

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.502629
    local lower bound updated to 0.490638

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 3.36191 seconds.
    local lower bound updated to 0.406199
    local upper bound updated to 0.490638

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 10.9033 seconds.
    local lower bound updated to 0.490638
    local upper bound updated to 0.490638
The time obtain the optimal randomized assortment is 125.434 (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_100.000000_106616.log"
The computation time limit for a lower bound is 85873
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 1680 rows, 1358 columns and 5350 nonzeros
Model fingerprint: 0xc7ab6822
Variable types: 1301 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        [1e-01, 1e+00]
Presolve removed 433 rows and 809 columns
Presolve time: 0.01s
Presolved: 1247 rows, 549 columns, 4747 nonzeros
Variable types: 494 continuous, 55 integer (55 binary)
Found heuristic solution: objective 0.5815286
Found heuristic solution: objective 0.5609277
Found heuristic solution: objective 0.5495076

Root relaxation: objective 4.420444e-01, 167 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.44204    0   17    0.54951    0.44204  19.6%     -    0s
H    0     0                       0.5416306    0.44204  18.4%     -    0s
     0     0    0.44217    0   20    0.54163    0.44217  18.4%     -    0s
H    0     0                       0.5193898    0.44217  14.9%     -    0s
     0     0    0.44568    0   22    0.51939    0.44568  14.2%     -    0s
H    0     0                       0.5136445    0.44568  13.2%     -    0s
H    0     0                       0.5076477    0.44569  12.2%     -    0s
     0     0    0.44645    0   22    0.50765    0.44645  12.1%     -    0s
H    0     0                       0.5064458    0.44645  11.8%     -    0s
H    0     0                       0.4915295    0.45066  8.31%     -    0s
     0     0    0.45066    0   24    0.49153    0.45066  8.31%     -    0s
     0     0    0.45145    0   22    0.49153    0.45145  8.15%     -    0s
     0     0    0.45274    0   25    0.49153    0.45274  7.89%     -    0s
     0     0    0.45296    0   24    0.49153    0.45296  7.85%     -    0s
     0     0    0.45314    0   24    0.49153    0.45314  7.81%     -    0s
H    0     0                       0.4906376    0.45314  7.64%     -    1s
     0     2    0.45314    0   24    0.49064    0.45314  7.64%     -    1s
  2373   297    0.48944   16    7    0.49064    0.47443  3.30%  19.5    5s
H 3038   291                       0.4906376    0.47623  2.94%  19.4    6s
  4976   110    0.48610    6   20    0.49064    0.48283  1.59%  18.9   10s

Cutting planes:
  Implied bound: 212
  MIR: 66
  Flow cover: 149
  RLT: 24
  Relax-and-lift: 104

Explored 5461 nodes (102988 simplex iterations) in 10.84 seconds (7.75 work units)
Thread count was 4 (of 48 available processors)

Solution count 10: 0.490638 0.490638 0.49153 ... 0.560928

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

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

        Job resource usage summary 

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

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