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.320485 seconds.
    local lower bound updated to 0.351691
    local upper bound updated to 0.538888

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

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 3.60421 seconds.
    local lower bound updated to 0.451659
    local upper bound updated to 0.651594

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.329047 seconds.
    local lower bound updated to 0.511825
    local upper bound updated to 0.608371

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 2.9533 seconds.
    local lower bound updated to 0.582429
    local upper bound updated to 0.597736

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 6.8295 seconds.
    local lower bound updated to 0.596111
    local upper bound updated to 0.596956

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 5.91454 seconds.
    local lower bound updated to 0.596731
    local upper bound updated to 0.596741

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.668397
    local lower bound updated to 0.636379

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.645785
    local lower bound updated to 0.636405

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 1.83741 seconds.
    local lower bound updated to 0.490828
    local upper bound updated to 0.599079

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 12.5043 seconds.
    local lower bound updated to 0.598188
    local upper bound updated to 0.598772

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 11.6257 seconds.
    local lower bound updated to 0.598188
    local upper bound updated to 0.598421

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.636617
    local lower bound updated to 0.598421

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.610316
    local lower bound updated to 0.601534

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.610316
    local lower bound updated to 0.603873

    ++ RESTRICTED DUAL ITERATION 4 ++
    local upper bound updated to 0.610316
    local lower bound updated to 0.607164

    ++ RESTRICTED DUAL ITERATION 5 ++
    local upper bound updated to 0.610316
    local lower bound updated to 0.607543

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 28.4837 seconds.
    local lower bound updated to 0.545257
    local upper bound updated to 0.606036

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 1.89218 seconds.
    local lower bound updated to 0.545257
    local upper bound updated to 0.603594

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 8.86899 seconds.
    local lower bound updated to 0.579421
    local upper bound updated to 0.60212

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 3.12702 seconds.
    local lower bound updated to 0.579421
    local upper bound updated to 0.601099

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 32.7094 seconds.
    local lower bound updated to 0.600406
    local upper bound updated to 0.601021

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 27.4027 seconds.
    local lower bound updated to 0.600524
    local upper bound updated to 0.600791

    ++ RESTRICTED PRIMAL ITERATION 7 ++
One worst-case parameter optimization takes 33.459 seconds.
    local lower bound updated to 0.600524
    local upper bound updated to 0.60078

    ++ RESTRICTED PRIMAL ITERATION 8 ++
One worst-case parameter optimization takes 25.3558 seconds.
    local lower bound updated to 0.600524
    local upper bound updated to 0.600741

    ++ RESTRICTED PRIMAL ITERATION 9 ++
One worst-case parameter optimization takes 29.1653 seconds.
    local lower bound updated to 0.600524
    local upper bound updated to 0.600736

    ++ RESTRICTED PRIMAL ITERATION 10 ++
One worst-case parameter optimization takes 31.6513 seconds.
    local lower bound updated to 0.600571
    local upper bound updated to 0.600732

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.641026
    local lower bound updated to 0.600732

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 28.9145 seconds.
    local lower bound updated to 0.545257
    local upper bound updated to 0.600732

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 29.7709 seconds.
    local lower bound updated to 0.600732
    local upper bound updated to 0.600732
The time obtain the optimal randomized assortment is 379.878 (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_15_4_200.000000_200816.log"
The computation time limit for a lower bound is 85617
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 1520 rows, 1228 columns and 4912 nonzeros
Model fingerprint: 0x9a467a22
Variable types: 1171 continuous, 57 integer (57 binary)
Coefficient statistics:
  Matrix range     [8e-03, 1e+00]
  Objective range  [1e+00, 1e+00]
  Bounds range     [1e+00, 1e+00]
  RHS range        [6e-01, 1e+00]
Presolve removed 403 rows and 724 columns
Presolve time: 0.01s
Presolved: 1117 rows, 504 columns, 4332 nonzeros
Variable types: 453 continuous, 51 integer (51 binary)
Found heuristic solution: objective 0.7629402
Found heuristic solution: objective 0.7431456
Found heuristic solution: objective 0.6776377

Root relaxation: objective 3.876172e-01, 141 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.38762    0   16    0.67764    0.38762  42.8%     -    0s
H    0     0                       0.6749970    0.40156  40.5%     -    0s
     0     0    0.40156    0   25    0.67500    0.40156  40.5%     -    0s
H    0     0                       0.6634467    0.40156  39.5%     -    0s
H    0     0                       0.6349299    0.40156  36.8%     -    0s
     0     0    0.46253    0   26    0.63493    0.46253  27.2%     -    0s
H    0     0                       0.6310622    0.46253  26.7%     -    0s
     0     0    0.46329    0   26    0.63106    0.46329  26.6%     -    0s
H    0     0                       0.6193054    0.46329  25.2%     -    0s
H    0     0                       0.6115123    0.48579  20.6%     -    0s
     0     0    0.48579    0   25    0.61151    0.48579  20.6%     -    0s
     0     0    0.48708    0   26    0.61151    0.48708  20.3%     -    0s
     0     0    0.49068    0   24    0.61151    0.49068  19.8%     -    0s
     0     0    0.49117    0   25    0.61151    0.49117  19.7%     -    0s
     0     0    0.49233    0   24    0.61151    0.49233  19.5%     -    0s
H    0     0                       0.6007316    0.49233  18.0%     -    0s
     0     2    0.49233    0   24    0.60073    0.49233  18.0%     -    0s
  1573   599    0.57394   13   12    0.60073    0.53942  10.2%  17.7    5s
  3300   998    0.59955   29    7    0.60073    0.55019  8.41%  16.5   10s
  6107   710     cutoff   34         0.60073    0.55457  7.68%  17.3   15s
  8467   885    0.58711   29   12    0.60073    0.56450  6.03%  17.0   20s
H 9733   874                       0.6007316    0.56920  5.25%  16.8   22s
 10721   795    0.59198   26   12    0.60073    0.57253  4.69%  16.5   25s
 14812    65     cutoff   27         0.60073    0.58661  2.35%  15.8   30s

Cutting planes:
  Gomory: 1
  Implied bound: 144
  MIR: 102
  Flow cover: 200
  RLT: 50
  Relax-and-lift: 50

Explored 14921 nodes (236429 simplex iterations) in 30.20 seconds (21.42 work units)
Thread count was 4 (of 48 available processors)

Solution count 10: 0.600732 0.600732 0.611512 ... 0.743146

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

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

        Job resource usage summary 

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

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