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.32058 seconds.
    local lower bound updated to 0.384269
    local upper bound updated to 0.657708

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.794031
    local lower bound updated to 0.792779

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 1.36235 seconds.
    local lower bound updated to 0.466254
    local upper bound updated to 0.665679

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.930097 seconds.
    local lower bound updated to 0.658367
    local upper bound updated to 0.660137

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 4.44246 seconds.
    local lower bound updated to 0.659382
    local upper bound updated to 0.659626

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 2.31007 seconds.
    local lower bound updated to 0.659428
    local upper bound updated to 0.659547

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 3.61098 seconds.
    local lower bound updated to 0.659496
    local upper bound updated to 0.659503
The Primal step takes 12.6682 (S)
lower bound updated to 0.659496

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.702297
    local lower bound updated to 0.666533

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.67489
    local lower bound updated to 0.671908

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.672322
    local lower bound updated to 0.671955

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 10.865 seconds.
    local lower bound updated to 0.557194
    local upper bound updated to 0.670132

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 1.83892 seconds.
    local lower bound updated to 0.645583
    local upper bound updated to 0.665218

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 7.28603 seconds.
    local lower bound updated to 0.661559
    local upper bound updated to 0.664982

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 5.7564 seconds.
    local lower bound updated to 0.662408
    local upper bound updated to 0.664271

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 2.19143 seconds.
    local lower bound updated to 0.662585
    local upper bound updated to 0.663977

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 11.1916 seconds.
    local lower bound updated to 0.662585
    local upper bound updated to 0.663883

    ++ RESTRICTED PRIMAL ITERATION 7 ++
One worst-case parameter optimization takes 6.78272 seconds.
    local lower bound updated to 0.663161
    local upper bound updated to 0.663859

    ++ RESTRICTED PRIMAL ITERATION 8 ++
One worst-case parameter optimization takes 6.09243 seconds.
    local lower bound updated to 0.663473
    local upper bound updated to 0.66374

    ++ RESTRICTED PRIMAL ITERATION 9 ++
One worst-case parameter optimization takes 3.54893 seconds.
    local lower bound updated to 0.663616
    local upper bound updated to 0.663727

    ++ RESTRICTED PRIMAL ITERATION 10 ++
One worst-case parameter optimization takes 3.69235 seconds.
    local lower bound updated to 0.663646
    local upper bound updated to 0.663724

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.701861
    local lower bound updated to 0.665518

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 6.06964 seconds.
    local lower bound updated to 0.567222
    local upper bound updated to 0.665058

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 5.67749 seconds.
    local lower bound updated to 0.663325
    local upper bound updated to 0.664861

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 9.78966 seconds.
    local lower bound updated to 0.664551
    local upper bound updated to 0.664759

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.693003
    local lower bound updated to 0.664759

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 5.85481 seconds.
    local lower bound updated to 0.567222
    local upper bound updated to 0.664759

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 8.7772 seconds.
    local lower bound updated to 0.664759
    local upper bound updated to 0.664759
The time obtain the optimal randomized assortment is 124.336 (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_100.000000_105016.log"
The computation time limit for a lower bound is 85872
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 1200 rows, 968 columns and 3882 nonzeros
Model fingerprint: 0xf83d3376
Variable types: 911 continuous, 57 integer (57 binary)
Coefficient statistics:
  Matrix range     [5e-04, 1e+00]
  Objective range  [1e+00, 1e+00]
  Bounds range     [1e+00, 1e+00]
  RHS range        [6e-01, 1e+00]
Presolve removed 327 rows and 565 columns
Presolve time: 0.02s
Presolved: 873 rows, 403 columns, 3432 nonzeros
Variable types: 349 continuous, 54 integer (54 binary)
Found heuristic solution: objective 0.7220906
Found heuristic solution: objective 0.7187861
Found heuristic solution: objective 0.7085605

Root relaxation: objective 5.747831e-01, 110 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.57478    0   19    0.70856    0.57478  18.9%     -    0s
H    0     0                       0.7056572    0.58925  16.5%     -    0s
     0     0    0.58925    0   24    0.70566    0.58925  16.5%     -    0s
     0     0    0.60277    0   25    0.70566    0.60277  14.6%     -    0s
H    0     0                       0.6983513    0.60277  13.7%     -    0s
     0     0    0.60786    0   26    0.69835    0.60786  13.0%     -    0s
H    0     0                       0.6690281    0.60786  9.14%     -    0s
     0     0    0.61746    0   25    0.66903    0.61746  7.71%     -    0s
     0     0    0.61782    0   25    0.66903    0.61782  7.65%     -    0s
     0     0    0.62093    0   25    0.66903    0.62093  7.19%     -    0s
H    0     0                       0.6671730    0.62093  6.93%     -    0s
     0     0    0.62124    0   25    0.66717    0.62124  6.89%     -    0s
H    0     0                       0.6668856    0.62124  6.84%     -    0s
     0     0    0.62291    0   23    0.66689    0.62291  6.59%     -    0s
H    0     0                       0.6662276    0.62291  6.50%     -    0s
H    0     0                       0.6657071    0.62291  6.43%     -    1s
     0     2    0.62291    0   23    0.66571    0.62291  6.43%     -    1s
*   61    56              18       0.6655224    0.62996  5.34%  23.2    1s
*  187   102              20       0.6647589    0.63079  5.11%  18.1    1s
   984   346     cutoff   20         0.66476    0.64167  3.47%  15.0    5s
  2398   403     cutoff   14         0.66476    0.64904  2.37%  14.2   10s

Cutting planes:
  Implied bound: 137
  MIR: 49
  Flow cover: 94
  RLT: 7
  Relax-and-lift: 59

Explored 4080 nodes (56955 simplex iterations) in 12.51 seconds (6.54 work units)
Thread count was 4 (of 48 available processors)

Solution count 10: 0.664759 0.665522 0.665707 ... 0.708561

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

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

        Job resource usage summary 

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

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