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.287385 seconds.
    local lower bound updated to 0.227907
    local upper bound updated to 0.449616

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.550633
    local lower bound updated to 0.490855

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.60788 seconds.
    local lower bound updated to 0.295958
    local upper bound updated to 0.410798

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.262324 seconds.
    local lower bound updated to 0.398585
    local upper bound updated to 0.400057

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 0.285111 seconds.
    local lower bound updated to 0.398585
    local upper bound updated to 0.399522

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.486401
    local lower bound updated to 0.448135

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.476953
    local lower bound updated to 0.459601

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.462
    local lower bound updated to 0.460839

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.524194 seconds.
    local lower bound updated to 0.338023
    local upper bound updated to 0.408743

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.507942 seconds.
    local lower bound updated to 0.399269
    local upper bound updated to 0.405798

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 0.709766 seconds.
    local lower bound updated to 0.399269
    local upper bound updated to 0.404532

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 0.771882 seconds.
    local lower bound updated to 0.399269
    local upper bound updated to 0.399998

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 0.562358 seconds.
    local lower bound updated to 0.399269
    local upper bound updated to 0.399923

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 0.480001 seconds.
    local lower bound updated to 0.399779
    local upper bound updated to 0.399906

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.447312
    local lower bound updated to 0.400446

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.419596
    local lower bound updated to 0.407493

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.879377 seconds.
    local lower bound updated to 0.351656
    local upper bound updated to 0.407493

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.53509 seconds.
    local lower bound updated to 0.405443
    local upper bound updated to 0.40711

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 0.963791 seconds.
    local lower bound updated to 0.40562
    local upper bound updated to 0.406554

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 0.50618 seconds.
    local lower bound updated to 0.406213
    local upper bound updated to 0.406548

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 0.741964 seconds.
    local lower bound updated to 0.406213
    local upper bound updated to 0.406265

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.441139
    local lower bound updated to 0.406265

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.415906
    local lower bound updated to 0.407131

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.414695
    local lower bound updated to 0.407207

    ++ RESTRICTED DUAL ITERATION 4 ++
    local upper bound updated to 0.407337
    local lower bound updated to 0.40722

    ++ RESTRICTED DUAL ITERATION 5 ++
    local upper bound updated to 0.407337
    local lower bound updated to 0.407226

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 1.48399 seconds.
    local lower bound updated to 0.370537
    local upper bound updated to 0.407226

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 1.4501 seconds.
    local lower bound updated to 0.402086
    local upper bound updated to 0.406881

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 1.41283 seconds.
    local lower bound updated to 0.406497
    local upper bound updated to 0.406836

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 1.0812 seconds.
    local lower bound updated to 0.406693
    local upper bound updated to 0.406833

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.435879
    local lower bound updated to 0.406833

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 1.44566 seconds.
    local lower bound updated to 0.370537
    local upper bound updated to 0.406833

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 1.55189 seconds.
    local lower bound updated to 0.406833
    local upper bound updated to 0.406833
The time obtain the optimal randomized assortment is 22.388 (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_60.000000_67314.log"
The computation time limit for a lower bound is 85975
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 1590 rows, 1394 columns and 5054 nonzeros
Model fingerprint: 0xaf68744c
Variable types: 1345 continuous, 49 integer (49 binary)
Coefficient statistics:
  Matrix range     [3e-07, 1e+00]
  Objective range  [1e+00, 1e+00]
  Bounds range     [1e+00, 1e+00]
  RHS range        [3e-01, 1e+00]
Presolve removed 477 rows and 903 columns
Presolve time: 0.01s
Presolved: 1113 rows, 491 columns, 4263 nonzeros
Variable types: 444 continuous, 47 integer (47 binary)
Found heuristic solution: objective 0.5384420
Found heuristic solution: objective 0.4817252

Root relaxation: objective 2.930072e-01, 186 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.29301    0   19    0.48173    0.29301  39.2%     -    0s
H    0     0                       0.4420190    0.29301  33.7%     -    0s
H    0     0                       0.4288690    0.30640  28.6%     -    0s
     0     0    0.30640    0   22    0.42887    0.30640  28.6%     -    0s
H    0     0                       0.4161608    0.30640  26.4%     -    0s
H    0     0                       0.4129539    0.30640  25.8%     -    0s
     0     0    0.30640    0   22    0.41295    0.30640  25.8%     -    0s
     0     0    0.34762    0   21    0.41295    0.34762  15.8%     -    0s
     0     0    0.34775    0   19    0.41295    0.34775  15.8%     -    0s
     0     0    0.36743    0   18    0.41295    0.36743  11.0%     -    0s
     0     0    0.36883    0   19    0.41295    0.36883  10.7%     -    0s
H    0     0                       0.4122749    0.36883  10.5%     -    0s
H    0     0                       0.4117743    0.37360  9.27%     -    0s
     0     0    0.37360    0   18    0.41177    0.37360  9.27%     -    0s
     0     0    0.37482    0   18    0.41177    0.37482  8.97%     -    0s
     0     0    0.37551    0   19    0.41177    0.37551  8.81%     -    0s
H    0     0                       0.4068329    0.37551  7.70%     -    0s
     0     2    0.37551    0   19    0.40683    0.37551  7.70%     -    0s
H  410     9                       0.4068329    0.40153  1.30%  15.5    1s

Cutting planes:
  Implied bound: 136
  MIR: 27
  Flow cover: 99
  RLT: 7
  Relax-and-lift: 57

Explored 437 nodes (7984 simplex iterations) in 1.14 seconds (0.59 work units)
Thread count was 4 (of 48 available processors)

Solution count 9: 0.406833 0.411774 0.412275 ... 0.538442
No other solutions better than 0.406833

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

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

        Job resource usage summary 

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

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