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.202649 seconds.
    local lower bound updated to 0.173373
    local upper bound updated to 0.311488

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.450292
    local lower bound updated to 0.417325

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.359238 seconds.
    local lower bound updated to 0.18299
    local upper bound updated to 0.314656

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.767918 seconds.
    local lower bound updated to 0.307981
    local upper bound updated to 0.308913

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.3597
    local lower bound updated to 0.314273

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.344698
    local lower bound updated to 0.33377

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.702819 seconds.
    local lower bound updated to 0.227108
    local upper bound updated to 0.328093

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 1.22486 seconds.
    local lower bound updated to 0.322156
    local upper bound updated to 0.325141

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 0.977688 seconds.
    local lower bound updated to 0.322156
    local upper bound updated to 0.322831

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 0.642117 seconds.
    local lower bound updated to 0.322156
    local upper bound updated to 0.322343

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 1.31673 seconds.
    local lower bound updated to 0.322156
    local upper bound updated to 0.322322

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 1.66608 seconds.
    local lower bound updated to 0.322322
    local upper bound updated to 0.322322
The Primal step takes 6.5454 (S)
lower bound updated to 0.322322

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.348269
    local lower bound updated to 0.322322

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.348269
    local lower bound updated to 0.322322

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.348154
    local lower bound updated to 0.326123

    ++ RESTRICTED DUAL ITERATION 4 ++
    local upper bound updated to 0.336877
    local lower bound updated to 0.326701

    ++ RESTRICTED DUAL ITERATION 5 ++
    local upper bound updated to 0.331475
    local lower bound updated to 0.329762

    ++ RESTRICTED DUAL ITERATION 6 ++
    local upper bound updated to 0.331475
    local lower bound updated to 0.329945

    ++ RESTRICTED DUAL ITERATION 7 ++
    local upper bound updated to 0.331058
    local lower bound updated to 0.329978

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 2.50182 seconds.
    local lower bound updated to 0.273487
    local upper bound updated to 0.326881

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 2.07863 seconds.
    local lower bound updated to 0.305976
    local upper bound updated to 0.32607

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 1.96718 seconds.
    local lower bound updated to 0.31384
    local upper bound updated to 0.324344

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 1.60932 seconds.
    local lower bound updated to 0.319546
    local upper bound updated to 0.323858

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 6.10927 seconds.
    local lower bound updated to 0.321447
    local upper bound updated to 0.323354

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 5.46248 seconds.
    local lower bound updated to 0.322198
    local upper bound updated to 0.322862

    ++ RESTRICTED PRIMAL ITERATION 7 ++
One worst-case parameter optimization takes 4.13885 seconds.
    local lower bound updated to 0.32224
    local upper bound updated to 0.322799

    ++ RESTRICTED PRIMAL ITERATION 8 ++
One worst-case parameter optimization takes 5.81432 seconds.
    local lower bound updated to 0.32224
    local upper bound updated to 0.322769

    ++ RESTRICTED PRIMAL ITERATION 9 ++
One worst-case parameter optimization takes 4.49765 seconds.
    local lower bound updated to 0.322284
    local upper bound updated to 0.322723

    ++ RESTRICTED PRIMAL ITERATION 10 ++
One worst-case parameter optimization takes 8.6593 seconds.
    local lower bound updated to 0.322321
    local upper bound updated to 0.322719

    ++ RESTRICTED PRIMAL ITERATION 11 ++
One worst-case parameter optimization takes 3.50165 seconds.
    local lower bound updated to 0.322371
    local upper bound updated to 0.322712

    ++ RESTRICTED PRIMAL ITERATION 12 ++
One worst-case parameter optimization takes 3.75482 seconds.
    local lower bound updated to 0.322532
    local upper bound updated to 0.322694

    ++ RESTRICTED PRIMAL ITERATION 13 ++
One worst-case parameter optimization takes 4.18319 seconds.
    local lower bound updated to 0.322613
    local upper bound updated to 0.322689

    ++ RESTRICTED PRIMAL ITERATION 14 ++
One worst-case parameter optimization takes 4.59861 seconds.
    local lower bound updated to 0.322615
    local upper bound updated to 0.322682

    ++ RESTRICTED PRIMAL ITERATION 15 ++
One worst-case parameter optimization takes 3.86575 seconds.
    local lower bound updated to 0.32264
    local upper bound updated to 0.322681

    ++ RESTRICTED PRIMAL ITERATION 16 ++
One worst-case parameter optimization takes 6.52957 seconds.
    local lower bound updated to 0.322681
    local upper bound updated to 0.322681
The Primal step takes 69.3588 (S)
lower bound updated to 0.322681

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.356208
    local lower bound updated to 0.322681

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.339929
    local lower bound updated to 0.323111

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.326411
    local lower bound updated to 0.323229

    ++ RESTRICTED DUAL ITERATION 4 ++
    local upper bound updated to 0.326411
    local lower bound updated to 0.324418

    ++ RESTRICTED DUAL ITERATION 5 ++
    local upper bound updated to 0.325843
    local lower bound updated to 0.324496

    ++ RESTRICTED DUAL ITERATION 6 ++
    local upper bound updated to 0.325843
    local lower bound updated to 0.324511

    ++ RESTRICTED DUAL ITERATION 7 ++
    local upper bound updated to 0.324511
    local lower bound updated to 0.324511
The Dual step takes 18.443 (S)
upper bound updated to 0.324511
*** OUTER ITERATION 4 ***

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 7.50807 seconds.
    local lower bound updated to 0.283196
    local upper bound updated to 0.324511

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 4.62342 seconds.
    local lower bound updated to 0.31926
    local upper bound updated to 0.324274

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 14.5483 seconds.
    local lower bound updated to 0.322438
    local upper bound updated to 0.324234

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 11.6725 seconds.
    local lower bound updated to 0.323038
    local upper bound updated to 0.324016

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 9.917 seconds.
    local lower bound updated to 0.323246
    local upper bound updated to 0.323983

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 7.68133 seconds.
    local lower bound updated to 0.323246
    local upper bound updated to 0.323825

    ++ RESTRICTED PRIMAL ITERATION 7 ++
One worst-case parameter optimization takes 8.91621 seconds.
    local lower bound updated to 0.323246
    local upper bound updated to 0.323808

    ++ RESTRICTED PRIMAL ITERATION 8 ++
One worst-case parameter optimization takes 9.31911 seconds.
    local lower bound updated to 0.323246
    local upper bound updated to 0.323743

    ++ RESTRICTED PRIMAL ITERATION 9 ++
One worst-case parameter optimization takes 10.51 seconds.
    local lower bound updated to 0.323246
    local upper bound updated to 0.323729

    ++ RESTRICTED PRIMAL ITERATION 10 ++
One worst-case parameter optimization takes 9.28155 seconds.
    local lower bound updated to 0.323246
    local upper bound updated to 0.32368

    ++ RESTRICTED PRIMAL ITERATION 11 ++
One worst-case parameter optimization takes 13.6337 seconds.
    local lower bound updated to 0.32349
    local upper bound updated to 0.323658

    ++ RESTRICTED PRIMAL ITERATION 12 ++
One worst-case parameter optimization takes 8.42274 seconds.
    local lower bound updated to 0.323546
    local upper bound updated to 0.323643

    ++ RESTRICTED PRIMAL ITERATION 13 ++
One worst-case parameter optimization takes 9.04893 seconds.
    local lower bound updated to 0.323569
    local upper bound updated to 0.323642

    ++ RESTRICTED PRIMAL ITERATION 14 ++
One worst-case parameter optimization takes 9.90943 seconds.
    local lower bound updated to 0.323615
    local upper bound updated to 0.32364

    ++ RESTRICTED PRIMAL ITERATION 15 ++
One worst-case parameter optimization takes 8.93725 seconds.
    local lower bound updated to 0.323618
    local upper bound updated to 0.323639

    ++ RESTRICTED PRIMAL ITERATION 16 ++
One worst-case parameter optimization takes 10.7794 seconds.
    local lower bound updated to 0.323635
    local upper bound updated to 0.323639
The Primal step takes 154.828 (S)
lower bound updated to 0.323635

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.348445
    local lower bound updated to 0.323666

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.327609
    local lower bound updated to 0.323801

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.325596
    local lower bound updated to 0.323807

    ++ RESTRICTED DUAL ITERATION 4 ++
    local upper bound updated to 0.325596
    local lower bound updated to 0.32381

    ++ RESTRICTED DUAL ITERATION 5 ++
    local upper bound updated to 0.325596
    local lower bound updated to 0.323892

    ++ RESTRICTED DUAL ITERATION 6 ++
    local upper bound updated to 0.323892
    local lower bound updated to 0.323892
The Dual step takes 30.6632 (S)
upper bound updated to 0.323892
*** OUTER ITERATION 5 ***

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 5.68703 seconds.
    local lower bound updated to 0.283197
    local upper bound updated to 0.323892

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 20.2118 seconds.
    local lower bound updated to 0.322877
    local upper bound updated to 0.323877

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 19.744 seconds.
    local lower bound updated to 0.323243
    local upper bound updated to 0.323867

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 22.7899 seconds.
    local lower bound updated to 0.323572
    local upper bound updated to 0.323855

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 21.5525 seconds.
    local lower bound updated to 0.323666
    local upper bound updated to 0.323852

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 17.9234 seconds.
    local lower bound updated to 0.323666
    local upper bound updated to 0.323847

    ++ RESTRICTED PRIMAL ITERATION 7 ++
One worst-case parameter optimization takes 16.7179 seconds.
    local lower bound updated to 0.323723
    local upper bound updated to 0.323844

    ++ RESTRICTED PRIMAL ITERATION 8 ++
One worst-case parameter optimization takes 16.3328 seconds.
    local lower bound updated to 0.323747
    local upper bound updated to 0.323826

    ++ RESTRICTED PRIMAL ITERATION 9 ++
One worst-case parameter optimization takes 12.1813 seconds.
    local lower bound updated to 0.32376
    local upper bound updated to 0.323824

    ++ RESTRICTED PRIMAL ITERATION 10 ++
One worst-case parameter optimization takes 14.577 seconds.
    local lower bound updated to 0.32379
    local upper bound updated to 0.323823

    ++ RESTRICTED PRIMAL ITERATION 11 ++
One worst-case parameter optimization takes 14.2216 seconds.
    local lower bound updated to 0.323822
    local upper bound updated to 0.323823
The Primal step takes 182.055 (S)
lower bound updated to 0.323822

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.347711
    local lower bound updated to 0.323823

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.324628
    local lower bound updated to 0.323823

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 9.27025 seconds.
    local lower bound updated to 0.282811
    local upper bound updated to 0.323823

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 13.7331 seconds.
    local lower bound updated to 0.323821
    local upper bound updated to 0.323823
The time obtain the optimal randomized assortment is 512.654 (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_17_4_60.000000_63418.log"
The computation time limit for a lower bound is 85483
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 4738 rows, 3618 columns and 15671 nonzeros
Model fingerprint: 0x5e7cc382
Variable types: 3553 continuous, 65 integer (65 binary)
Coefficient statistics:
  Matrix range     [4e-05, 1e+00]
  Objective range  [1e+00, 1e+00]
  Bounds range     [1e+00, 1e+00]
  RHS range        [3e-01, 1e+00]
Presolve removed 1041 rows and 2007 columns
Presolve time: 0.06s
Presolved: 3697 rows, 1611 columns, 14346 nonzeros
Variable types: 1547 continuous, 64 integer (64 binary)
Found heuristic solution: objective 0.4629277
Found heuristic solution: objective 0.4306726
Found heuristic solution: objective 0.4186385

Root relaxation: objective 2.520404e-01, 379 iterations, 0.01 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.25204    0   22    0.41864    0.25204  39.8%     -    0s
H    0     0                       0.3731801    0.25204  32.5%     -    0s
H    0     0                       0.3672114    0.25204  31.4%     -    0s
H    0     0                       0.3556820    0.25204  29.1%     -    0s
H    0     0                       0.3555807    0.25844  27.3%     -    0s
     0     0    0.26145    0   23    0.35558    0.26145  26.5%     -    0s
H    0     0                       0.3554309    0.26145  26.4%     -    0s
     0     0    0.26145    0   23    0.35543    0.26145  26.4%     -    0s
     0     0    0.28798    0   32    0.35543    0.28798  19.0%     -    0s
H    0     0                       0.3362987    0.28798  14.4%     -    0s
     0     0    0.28798    0   32    0.33630    0.28798  14.4%     -    0s
     0     0    0.29433    0   32    0.33630    0.29433  12.5%     -    0s
H    0     0                       0.3281925    0.29619  9.75%     -    1s
     0     0    0.29619    0   30    0.32819    0.29619  9.75%     -    1s
     0     0    0.29848    0   29    0.32819    0.29848  9.05%     -    1s
     0     0    0.29868    0   32    0.32819    0.29868  8.99%     -    1s
     0     0    0.29929    0   30    0.32819    0.29929  8.81%     -    1s
H    0     0                       0.3255307    0.29929  8.06%     -    3s
     0     2    0.29929    0   30    0.32553    0.29929  8.06%     -    3s
*   82    72              20       0.3248074    0.30322  6.65%  55.8    4s
H  103    71                       0.3246761    0.30410  6.34%  49.0    4s
H  110    71                       0.3246454    0.30410  6.33%  47.9    4s
H  115    70                       0.3242295    0.30410  6.21%  49.1    4s
H  166    84                       0.3241180    0.30410  6.18%  59.0    4s
   392   114    0.32293   12   18    0.32412    0.31141  3.92%  61.1    5s
H  408   114                       0.3238225    0.31141  3.83%  59.7    5s
H 2087   192                       0.3238225    0.32123  0.80%  38.7    9s
  2091   186     cutoff   28         0.32382    0.32130  0.78%  38.6   10s

Cutting planes:
  Gomory: 2
  Implied bound: 655
  MIR: 110
  Flow cover: 425
  RLT: 85
  Relax-and-lift: 302

Explored 3183 nodes (105102 simplex iterations) in 12.37 seconds (9.22 work units)
Thread count was 4 (of 48 available processors)

Solution count 10: 0.323822 0.323822 0.324118 ... 0.336299

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

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

        Job resource usage summary 

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

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