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.249289 seconds.
    local lower bound updated to 0.261816
    local upper bound updated to 0.521859

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.674608
    local lower bound updated to 0.618106

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.570095 seconds.
    local lower bound updated to 0.33165
    local upper bound updated to 0.557492

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 1.38959 seconds.
    local lower bound updated to 0.527768
    local upper bound updated to 0.531679

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 3.25461 seconds.
    local lower bound updated to 0.527768
    local upper bound updated to 0.530922

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 1.50043 seconds.
    local lower bound updated to 0.527768
    local upper bound updated to 0.529578

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 2.01497 seconds.
    local lower bound updated to 0.527768
    local upper bound updated to 0.52839

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 1.80258 seconds.
    local lower bound updated to 0.527768
    local upper bound updated to 0.528258

    ++ RESTRICTED PRIMAL ITERATION 7 ++
One worst-case parameter optimization takes 1.82076 seconds.
    local lower bound updated to 0.528258
    local upper bound updated to 0.528258
The Primal step takes 12.3706 (S)
lower bound updated to 0.528258

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.586094
    local lower bound updated to 0.56089

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.586094
    local lower bound updated to 0.561727

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.575357
    local lower bound updated to 0.562882

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 9.95464 seconds.
    local lower bound updated to 0.442814
    local upper bound updated to 0.556291

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 2.83149 seconds.
    local lower bound updated to 0.498165
    local upper bound updated to 0.547478

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 2.75869 seconds.
    local lower bound updated to 0.520272
    local upper bound updated to 0.546365

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 6.19916 seconds.
    local lower bound updated to 0.521762
    local upper bound updated to 0.536935

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 8.33147 seconds.
    local lower bound updated to 0.534379
    local upper bound updated to 0.536845

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 9.55837 seconds.
    local lower bound updated to 0.536716
    local upper bound updated to 0.536832

    ++ RESTRICTED PRIMAL ITERATION 7 ++
One worst-case parameter optimization takes 10.0982 seconds.
    local lower bound updated to 0.536832
    local upper bound updated to 0.536832
The Primal step takes 49.7622 (S)
lower bound updated to 0.536832

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.575073
    local lower bound updated to 0.536832

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.566071
    local lower bound updated to 0.546405

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.559967
    local lower bound updated to 0.548732

    ++ RESTRICTED DUAL ITERATION 4 ++
    local upper bound updated to 0.557541
    local lower bound updated to 0.551947

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 11.6897 seconds.
    local lower bound updated to 0.465861
    local upper bound updated to 0.551947

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 7.8751 seconds.
    local lower bound updated to 0.539921
    local upper bound updated to 0.549359

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 12.4678 seconds.
    local lower bound updated to 0.539921
    local upper bound updated to 0.549273

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 11.8402 seconds.
    local lower bound updated to 0.54213
    local upper bound updated to 0.549194

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 22.2274 seconds.
    local lower bound updated to 0.544687
    local upper bound updated to 0.547115

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 11.5644 seconds.
    local lower bound updated to 0.544687
    local upper bound updated to 0.546968

    ++ RESTRICTED PRIMAL ITERATION 7 ++
One worst-case parameter optimization takes 14.621 seconds.
    local lower bound updated to 0.544687
    local upper bound updated to 0.546816

    ++ RESTRICTED PRIMAL ITERATION 8 ++
One worst-case parameter optimization takes 9.76707 seconds.
    local lower bound updated to 0.545355
    local upper bound updated to 0.546503

    ++ RESTRICTED PRIMAL ITERATION 9 ++
One worst-case parameter optimization takes 16.0734 seconds.
    local lower bound updated to 0.54551
    local upper bound updated to 0.546457

    ++ RESTRICTED PRIMAL ITERATION 10 ++
One worst-case parameter optimization takes 8.22017 seconds.
    local lower bound updated to 0.546087
    local upper bound updated to 0.546444

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.575769
    local lower bound updated to 0.546444

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.564455
    local lower bound updated to 0.547712

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.556731
    local lower bound updated to 0.548092

    ++ RESTRICTED DUAL ITERATION 4 ++
    local upper bound updated to 0.548935
    local lower bound updated to 0.54815

    ++ RESTRICTED DUAL ITERATION 5 ++
    local upper bound updated to 0.548555
    local lower bound updated to 0.54816

    ++ RESTRICTED DUAL ITERATION 6 ++
    local upper bound updated to 0.54816
    local lower bound updated to 0.54816
The Dual step takes 13.8529 (S)
upper bound updated to 0.54816
*** OUTER ITERATION 4 ***

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 15.2648 seconds.
    local lower bound updated to 0.473668
    local upper bound updated to 0.54816

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 19.1175 seconds.
    local lower bound updated to 0.546548
    local upper bound updated to 0.547662

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 18.8204 seconds.
    local lower bound updated to 0.546548
    local upper bound updated to 0.547585

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.575271
    local lower bound updated to 0.547585

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 15.9269 seconds.
    local lower bound updated to 0.473668
    local upper bound updated to 0.547585

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 26.1486 seconds.
    local lower bound updated to 0.547585
    local upper bound updated to 0.547585
The time obtain the optimal randomized assortment is 333.265 (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_100.000000_108618.log"
The computation time limit for a lower bound is 85662
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 2798 rows, 2138 columns and 9173 nonzeros
Model fingerprint: 0x5e56484c
Variable types: 2073 continuous, 65 integer (65 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 644 rows and 1182 columns
Presolve time: 0.03s
Presolved: 2154 rows, 956 columns, 8430 nonzeros
Variable types: 893 continuous, 63 integer (63 binary)
Found heuristic solution: objective 0.7552826
Found heuristic solution: objective 0.6261333

Root relaxation: objective 3.762240e-01, 245 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.37622    0   18    0.62613    0.37622  39.9%     -    0s
H    0     0                       0.6146692    0.37622  38.8%     -    0s
     0     0    0.37732    0   25    0.61467    0.37732  38.6%     -    0s
     0     0    0.42030    0   29    0.61467    0.42030  31.6%     -    0s
H    0     0                       0.6120074    0.42030  31.3%     -    0s
H    0     0                       0.6114361    0.42030  31.3%     -    0s
H    0     0                       0.6102009    0.42030  31.1%     -    0s
     0     0    0.42030    0   29    0.61020    0.42030  31.1%     -    0s
H    0     0                       0.5863223    0.43174  26.4%     -    0s
     0     0    0.43174    0   30    0.58632    0.43174  26.4%     -    0s
     0     0    0.43255    0   30    0.58632    0.43255  26.2%     -    0s
H    0     0                       0.5569947    0.43255  22.3%     -    0s
     0     0    0.44688    0   31    0.55699    0.44688  19.8%     -    0s
     0     0    0.44855    0   32    0.55699    0.44855  19.5%     -    0s
H    0     0                       0.5561435    0.44855  19.3%     -    0s
H    0     0                       0.5558526    0.44855  19.3%     -    0s
     0     0    0.45743    0   32    0.55585    0.45743  17.7%     -    0s
H    0     0                       0.5475849    0.45743  16.5%     -    3s
     0     2    0.45743    0   32    0.54758    0.45743  16.5%     -    3s
   416   205    0.50191    8   20    0.54758    0.48124  12.1%  41.1    5s
H  508   221                       0.5475849    0.49166  10.2%  40.1    5s
H  742   268                       0.5475849    0.49550  9.51%  36.6    7s
  1970   476 infeasible   10         0.54758    0.51078  6.72%  31.4   10s
  3639   506    0.53375   13   12    0.54758    0.52272  4.54%  29.7   15s
  5526   375     cutoff   16         0.54758    0.53316  2.63%  27.3   20s

Cutting planes:
  Implied bound: 336
  MIR: 88
  Flow cover: 305
  RLT: 23
  Relax-and-lift: 145

Explored 7726 nodes (196074 simplex iterations) in 21.86 seconds (15.55 work units)
Thread count was 4 (of 48 available processors)

Solution count 10: 0.547585 0.547585 0.547585 ... 0.612007

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

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

        Job resource usage summary 

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

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