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 7.78827 seconds.
    local lower bound updated to 0.236106
    local upper bound updated to 0.434596

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.468491
    local lower bound updated to 0.465919

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 19.2112 seconds.
    local lower bound updated to 0.307708
    local upper bound updated to 0.446522

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 1.19743 seconds.
    local lower bound updated to 0.336851
    local upper bound updated to 0.439452

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 21.2979 seconds.
    local lower bound updated to 0.426382
    local upper bound updated to 0.437615

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 24.195 seconds.
    local lower bound updated to 0.437052
    local upper bound updated to 0.437436

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.481251
    local lower bound updated to 0.437436

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.446511
    local lower bound updated to 0.439215

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.446511
    local lower bound updated to 0.439881

    ++ RESTRICTED DUAL ITERATION 4 ++
    local upper bound updated to 0.443493
    local lower bound updated to 0.440556

    ++ RESTRICTED DUAL ITERATION 5 ++
    local upper bound updated to 0.441792
    local lower bound updated to 0.440896

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 60.023 seconds.
    local lower bound updated to 0.381492
    local upper bound updated to 0.438488

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 60.0197 seconds.
    local lower bound updated to 0.425911
    local upper bound updated to 0.438342

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 60.0176 seconds.
    local lower bound updated to 0.431365
    local upper bound updated to 0.438029

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 60.022 seconds.
    local lower bound updated to 0.435517
    local upper bound updated to 0.437776

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 60.0208 seconds.
    local lower bound updated to 0.435517
    local upper bound updated to 0.43774

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 60.023 seconds.
    local lower bound updated to 0.435517
    local upper bound updated to 0.437732

    ++ RESTRICTED PRIMAL ITERATION 7 ++
One worst-case parameter optimization takes 60.0213 seconds.
    local lower bound updated to 0.435517
    local upper bound updated to 0.437718

    ++ RESTRICTED PRIMAL ITERATION 8 ++
One worst-case parameter optimization takes 60.0221 seconds.
    local lower bound updated to 0.436119
    local upper bound updated to 0.437686

    ++ RESTRICTED PRIMAL ITERATION 9 ++
One worst-case parameter optimization takes 60.0325 seconds.
    local lower bound updated to 0.436643
    local upper bound updated to 0.437682

    ++ RESTRICTED PRIMAL ITERATION 10 ++
One worst-case parameter optimization takes 60.0231 seconds.
    local lower bound updated to 0.436643
    local upper bound updated to 0.437663

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.489876
    local lower bound updated to 0.437663

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.438912
    local lower bound updated to 0.437819

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 60.0151 seconds.
    local lower bound updated to 0.3824
    local upper bound updated to 0.437819

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 60.017 seconds.
    local lower bound updated to 0.43762
    local upper bound updated to 0.437818

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 60.0249 seconds.
    local lower bound updated to 0.437814
    local upper bound updated to 0.437817
The Primal step takes 180.074 (S)
lower bound updated to 0.437814

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.505352
    local lower bound updated to 0.437817

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 60.0197 seconds.
    local lower bound updated to 0.3824
    local upper bound updated to 0.437817

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 60.0147 seconds.
    local lower bound updated to 0.437817
    local upper bound updated to 0.437817
The time obtain the optimal randomized assortment is 1068.37 (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_61618.log"
The computation time limit for a lower bound is 84913
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 1634 rows, 1250 columns and 5383 nonzeros
Model fingerprint: 0x0a2ecd86
Variable types: 1185 continuous, 65 integer (65 binary)
Coefficient statistics:
  Matrix range     [7e-06, 1e+00]
  Objective range  [1e+00, 1e+00]
  Bounds range     [1e+00, 1e+00]
  RHS range        [2e-01, 1e+00]
Presolve removed 378 rows and 670 columns
Presolve time: 0.01s
Presolved: 1256 rows, 580 columns, 4948 nonzeros
Variable types: 518 continuous, 62 integer (62 binary)
Found heuristic solution: objective 0.6366725
Found heuristic solution: objective 0.5884780

Root relaxation: objective 1.923564e-01, 142 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.19236    0   18    0.58848    0.19236  67.3%     -    0s
H    0     0                       0.4971120    0.19236  61.3%     -    0s
     0     0    0.19679    0   30    0.49711    0.19679  60.4%     -    0s
H    0     0                       0.4838071    0.19679  59.3%     -    0s
     0     0    0.24084    0   28    0.48381    0.24084  50.2%     -    0s
     0     0    0.24146    0   28    0.48381    0.24146  50.1%     -    0s
     0     0    0.26530    0   31    0.48381    0.26530  45.2%     -    0s
H    0     0                       0.4552974    0.26530  41.7%     -    0s
     0     0    0.26959    0   32    0.45530    0.26959  40.8%     -    0s
     0     0    0.28055    0   31    0.45530    0.28055  38.4%     -    0s
     0     0    0.28126    0   30    0.45530    0.28126  38.2%     -    0s
     0     0    0.28668    0   29    0.45530    0.28668  37.0%     -    0s
H    0     0                       0.4387792    0.28668  34.7%     -    0s
     0     2    0.28668    0   29    0.43878    0.28668  34.7%     -    1s
H  249   206                       0.4381377    0.29989  31.6%  19.8    1s
H  357   243                       0.4381377    0.31292  28.6%  20.7    1s
H  628   342                       0.4378172    0.31941  27.0%  18.5    2s
  1688   768    0.43624   20   10    0.43782    0.34181  21.9%  16.8    5s
  2602   980     cutoff   29         0.43782    0.34396  21.4%  18.5   10s
  3946  1005    0.43495   27    8    0.43782    0.35353  19.3%  19.7   15s
  6252  1270    0.37880   23   16    0.43782    0.36711  16.2%  20.5   20s
  8153  1626    0.39262   25   14    0.43782    0.37476  14.4%  20.9   25s
  9887  1830    0.42598   23   12    0.43782    0.37980  13.3%  20.8   30s
 12649  2011    0.41709   26   16    0.43782    0.38581  11.9%  20.8   35s
 15444  2101 infeasible   28         0.43782    0.39046  10.8%  20.7   41s
 17497  2127     cutoff   25         0.43782    0.39333  10.2%  20.7   45s
 19710  2075    0.42013   24   14    0.43782    0.39673  9.38%  20.8   50s
 22324  2013    0.42686   22   19    0.43782    0.40084  8.44%  20.7   55s
 24458  1890     cutoff   27         0.43782    0.40374  7.78%  20.7   60s
 27121  1622    0.41375   25   12    0.43782    0.40726  6.98%  20.6   65s
 29873  1235    0.43411   32    6    0.43782    0.41263  5.75%  20.5   70s
H31403   934                       0.4378172    0.41618  4.94%  20.5   72s
H32024   886                       0.4378171    0.41777  4.58%  20.5   74s
 32084   823     cutoff   20         0.43782    0.41806  4.51%  20.5   75s

Cutting planes:
  Implied bound: 171
  MIR: 111
  Flow cover: 212
  RLT: 21
  Relax-and-lift: 66

Explored 33985 nodes (692117 simplex iterations) in 79.59 seconds (78.21 work units)
Thread count was 4 (of 48 available processors)

Solution count 10: 0.437817 0.437817 0.438138 ... 0.636672

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

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

        Job resource usage summary 

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

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