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.939572 seconds.
    local lower bound updated to 0.307892
    local upper bound updated to 0.567572

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.630272
    local lower bound updated to 0.618363

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.691662 seconds.
    local lower bound updated to 0.367135
    local upper bound updated to 0.563919

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.91247 seconds.
    local lower bound updated to 0.557472
    local upper bound updated to 0.558023

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 0.783464 seconds.
    local lower bound updated to 0.557472
    local upper bound updated to 0.557692

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 0.942287 seconds.
    local lower bound updated to 0.557472
    local upper bound updated to 0.557519

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 1.25375 seconds.
    local lower bound updated to 0.557519
    local upper bound updated to 0.557519
The Primal step takes 4.59185 (S)
lower bound updated to 0.557519

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.587277
    local lower bound updated to 0.564227

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.587277
    local lower bound updated to 0.573514

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.587277
    local lower bound updated to 0.574449

    ++ RESTRICTED DUAL ITERATION 4 ++
    local upper bound updated to 0.581152
    local lower bound updated to 0.574686

    ++ RESTRICTED DUAL ITERATION 5 ++
    local upper bound updated to 0.576498
    local lower bound updated to 0.574805

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 6.65655 seconds.
    local lower bound updated to 0.490765
    local upper bound updated to 0.573868

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.630866 seconds.
    local lower bound updated to 0.516005
    local upper bound updated to 0.572381

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 7.65341 seconds.
    local lower bound updated to 0.570418
    local upper bound updated to 0.572271

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 7.03427 seconds.
    local lower bound updated to 0.570523
    local upper bound updated to 0.57193

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 7.72114 seconds.
    local lower bound updated to 0.57095
    local upper bound updated to 0.571835

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 7.81312 seconds.
    local lower bound updated to 0.57095
    local upper bound updated to 0.571694

    ++ RESTRICTED PRIMAL ITERATION 7 ++
One worst-case parameter optimization takes 9.69036 seconds.
    local lower bound updated to 0.57095
    local upper bound updated to 0.571684

    ++ RESTRICTED PRIMAL ITERATION 8 ++
One worst-case parameter optimization takes 11.0137 seconds.
    local lower bound updated to 0.57095
    local upper bound updated to 0.571554

    ++ RESTRICTED PRIMAL ITERATION 9 ++
One worst-case parameter optimization takes 8.81748 seconds.
    local lower bound updated to 0.57095
    local upper bound updated to 0.571516

    ++ RESTRICTED PRIMAL ITERATION 10 ++
One worst-case parameter optimization takes 8.71579 seconds.
    local lower bound updated to 0.571402
    local upper bound updated to 0.571474

    ++ RESTRICTED PRIMAL ITERATION 11 ++
One worst-case parameter optimization takes 9.85148 seconds.
    local lower bound updated to 0.571402
    local upper bound updated to 0.571458

    ++ RESTRICTED PRIMAL ITERATION 12 ++
One worst-case parameter optimization takes 7.30329 seconds.
    local lower bound updated to 0.571458
    local upper bound updated to 0.571458
The Primal step takes 92.944 (S)
lower bound updated to 0.571458

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.58993
    local lower bound updated to 0.571458

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.58993
    local lower bound updated to 0.57225

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.579218
    local lower bound updated to 0.57226

    ++ RESTRICTED DUAL ITERATION 4 ++
    local upper bound updated to 0.573398
    local lower bound updated to 0.572269

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 4.87941 seconds.
    local lower bound updated to 0.501664
    local upper bound updated to 0.572269

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 11.8217 seconds.
    local lower bound updated to 0.571505
    local upper bound updated to 0.572069

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 16.1495 seconds.
    local lower bound updated to 0.571698
    local upper bound updated to 0.571992

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 13.1945 seconds.
    local lower bound updated to 0.57187
    local upper bound updated to 0.571982

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 16.7772 seconds.
    local lower bound updated to 0.571881
    local upper bound updated to 0.571978

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 16.9579 seconds.
    local lower bound updated to 0.571889
    local upper bound updated to 0.57197

    ++ RESTRICTED PRIMAL ITERATION 7 ++
One worst-case parameter optimization takes 11.7888 seconds.
    local lower bound updated to 0.571889
    local upper bound updated to 0.571947

    ++ RESTRICTED PRIMAL ITERATION 8 ++
One worst-case parameter optimization takes 17.8225 seconds.
    local lower bound updated to 0.571903
    local upper bound updated to 0.571944

    ++ RESTRICTED PRIMAL ITERATION 9 ++
One worst-case parameter optimization takes 14.6953 seconds.
    local lower bound updated to 0.571944
    local upper bound updated to 0.571944
The Primal step takes 124.134 (S)
lower bound updated to 0.571944

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.585849
    local lower bound updated to 0.571944

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.574254
    local lower bound updated to 0.571971

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 6.52106 seconds.
    local lower bound updated to 0.508798
    local upper bound updated to 0.571971

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.587697
    local lower bound updated to 0.571971

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 6.27125 seconds.
    local lower bound updated to 0.508798
    local upper bound updated to 0.571971

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 15.2606 seconds.
    local lower bound updated to 0.571971
    local upper bound updated to 0.571971
The time obtain the optimal randomized assortment is 273.347 (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_13_4_200.000000_205014.log"
The computation time limit for a lower bound is 85725
The model output flag is 1
Gurobi Optimizer version 9.5.1 build v9.5.1rc2 (linux64)
Thread count: 20 physical cores, 40 logical processors, using up to 4 threads
Optimize a model with 1590 rows, 1394 columns and 5010 nonzeros
Model fingerprint: 0x89742c2b
Variable types: 1345 continuous, 49 integer (49 binary)
Coefficient statistics:
  Matrix range     [1e-04, 1e+00]
  Objective range  [1e+00, 1e+00]
  Bounds range     [1e+00, 1e+00]
  RHS range        [2e-01, 1e+00]
Presolve removed 458 rows and 902 columns
Presolve time: 0.02s
Presolved: 1132 rows, 492 columns, 4293 nonzeros
Variable types: 444 continuous, 48 integer (48 binary)
Found heuristic solution: objective 0.6735298
Found heuristic solution: objective 0.6400969
Found heuristic solution: objective 0.6280655

Root relaxation: objective 4.068834e-01, 155 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.40688    0   16    0.62807    0.40688  35.2%     -    0s
H    0     0                       0.5865147    0.40688  30.6%     -    0s
H    0     0                       0.5846581    0.40688  30.4%     -    0s
     0     0    0.44184    0   23    0.58466    0.44184  24.4%     -    0s
H    0     0                       0.5757576    0.44184  23.3%     -    0s
     0     0    0.44184    0   23    0.57576    0.44184  23.3%     -    0s
     0     0    0.47719    0   24    0.57576    0.47719  17.1%     -    0s
     0     0    0.47766    0   24    0.57576    0.47766  17.0%     -    0s
     0     0    0.49213    0   24    0.57576    0.49213  14.5%     -    0s
H    0     0                       0.5744145    0.49458  13.9%     -    0s
     0     0    0.49458    0   24    0.57441    0.49458  13.9%     -    0s
H    0     0                       0.5728805    0.49458  13.7%     -    0s
H    0     0                       0.5728220    0.49458  13.7%     -    0s
     0     0    0.49702    0   24    0.57282    0.49702  13.2%     -    0s
     0     0    0.49774    0   24    0.57282    0.49774  13.1%     -    0s
     0     0    0.49884    0   24    0.57282    0.49884  12.9%     -    0s
H    0     0                       0.5725164    0.49884  12.9%     -    0s
H    0     0                       0.5720535    0.49884  12.8%     -    1s
     0     2    0.49884    0   24    0.57205    0.49884  12.8%     -    1s
H  228   106                       0.5719949    0.51605  9.78%  25.2    1s
H  257   106                       0.5719949    0.51605  9.78%  25.3    1s
H  323   137                       0.5719949    0.53196  7.00%  23.6    1s
H  370   137                       0.5719949    0.53210  6.97%  22.4    1s
H  407   177                       0.5719949    0.53210  6.97%  22.1    1s
H  419   177                       0.5719949    0.53210  6.97%  22.0    1s
H  445   199                       0.5719949    0.53466  6.53%  21.9    1s
* 1046   290              18       0.5719708    0.54069  5.47%  18.6    2s
H 1328   327                       0.5719708    0.54230  5.19%  17.6    2s
H 1500   358                       0.5719707    0.54351  4.98%  17.4    2s
  2662   452    0.56910   11   12    0.57197    0.54969  3.89%  16.1    5s
  4121   548    0.56791   14   12    0.57197    0.55474  3.01%  15.5   10s
H 8044    43                       0.5719706    0.56389  1.41%  13.8   14s

Cutting planes:
  Implied bound: 193
  MIR: 99
  Flow cover: 172
  RLT: 16
  Relax-and-lift: 85

Explored 8502 nodes (117058 simplex iterations) in 14.83 seconds (9.19 work units)
Thread count was 4 (of 40 available processors)

Solution count 10: 0.571971 0.571971 0.571971 ... 0.575758

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

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

        Job resource usage summary 

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

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