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.077138 seconds.
    local lower bound updated to 0.228211
    local upper bound updated to 0.378272

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.439524
    local lower bound updated to 0.403912

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.426397
    local lower bound updated to 0.421659

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.426397
    local lower bound updated to 0.425117

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.303197 seconds.
    local lower bound updated to 0.260039
    local upper bound updated to 0.380402

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.248441 seconds.
    local lower bound updated to 0.368356
    local upper bound updated to 0.374127

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 0.271823 seconds.
    local lower bound updated to 0.369991
    local upper bound updated to 0.372089

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 0.226235 seconds.
    local lower bound updated to 0.371671
    local upper bound updated to 0.371686

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.418746
    local lower bound updated to 0.381544

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.399441
    local lower bound updated to 0.39269

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.399441
    local lower bound updated to 0.396635

    ++ RESTRICTED DUAL ITERATION 4 ++
    local upper bound updated to 0.399441
    local lower bound updated to 0.398883

    ++ RESTRICTED DUAL ITERATION 5 ++
    local upper bound updated to 0.399441
    local lower bound updated to 0.398905

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 2.50661 seconds.
    local lower bound updated to 0.333111
    local upper bound updated to 0.398905

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.647732 seconds.
    local lower bound updated to 0.333111
    local upper bound updated to 0.39595

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 0.989919 seconds.
    local lower bound updated to 0.367371
    local upper bound updated to 0.387598

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 0.718442 seconds.
    local lower bound updated to 0.375923
    local upper bound updated to 0.382909

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 1.17899 seconds.
    local lower bound updated to 0.375923
    local upper bound updated to 0.382769

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 0.792556 seconds.
    local lower bound updated to 0.375923
    local upper bound updated to 0.379317

    ++ RESTRICTED PRIMAL ITERATION 7 ++
One worst-case parameter optimization takes 0.979471 seconds.
    local lower bound updated to 0.375923
    local upper bound updated to 0.379016

    ++ RESTRICTED PRIMAL ITERATION 8 ++
One worst-case parameter optimization takes 0.672447 seconds.
    local lower bound updated to 0.375923
    local upper bound updated to 0.378784

    ++ RESTRICTED PRIMAL ITERATION 9 ++
One worst-case parameter optimization takes 0.823587 seconds.
    local lower bound updated to 0.378134
    local upper bound updated to 0.378491

    ++ RESTRICTED PRIMAL ITERATION 10 ++
One worst-case parameter optimization takes 1.15694 seconds.
    local lower bound updated to 0.378134
    local upper bound updated to 0.378425

    ++ RESTRICTED PRIMAL ITERATION 11 ++
One worst-case parameter optimization takes 1.17818 seconds.
    local lower bound updated to 0.378134
    local upper bound updated to 0.378394

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.391999
    local lower bound updated to 0.387295

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.391999
    local lower bound updated to 0.387318

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.391615
    local lower bound updated to 0.387429

    ++ RESTRICTED DUAL ITERATION 4 ++
    local upper bound updated to 0.389629
    local lower bound updated to 0.387535

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 2.50611 seconds.
    local lower bound updated to 0.344471
    local upper bound updated to 0.387535

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.974755 seconds.
    local lower bound updated to 0.368405
    local upper bound updated to 0.382455

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 1.06408 seconds.
    local lower bound updated to 0.377868
    local upper bound updated to 0.382301

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 2.00105 seconds.
    local lower bound updated to 0.377868
    local upper bound updated to 0.380903

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 2.63907 seconds.
    local lower bound updated to 0.378768
    local upper bound updated to 0.380685

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 1.98856 seconds.
    local lower bound updated to 0.380599
    local upper bound updated to 0.380684

    ++ RESTRICTED PRIMAL ITERATION 7 ++
One worst-case parameter optimization takes 2.19921 seconds.
    local lower bound updated to 0.380607
    local upper bound updated to 0.380681

    ++ RESTRICTED PRIMAL ITERATION 8 ++
One worst-case parameter optimization takes 1.79356 seconds.
    local lower bound updated to 0.380681
    local upper bound updated to 0.380681
The Primal step takes 15.2072 (S)
lower bound updated to 0.380681

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.389305
    local lower bound updated to 0.380681

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 2.3957 seconds.
    local lower bound updated to 0.344471
    local upper bound updated to 0.380681

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 1.64265 seconds.
    local lower bound updated to 0.380681
    local upper bound updated to 0.380681
The time obtain the optimal randomized assortment is 42.0187 (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_66714.log"
The computation time limit for a lower bound is 85955
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 1842 rows, 1618 columns and 5779 nonzeros
Model fingerprint: 0xa270f8d8
Variable types: 1569 continuous, 49 integer (49 binary)
Coefficient statistics:
  Matrix range     [3e-06, 1e+00]
  Objective range  [1e+00, 1e+00]
  Bounds range     [1e+00, 1e+00]
  RHS range        [4e-01, 1e+00]
Presolve removed 580 rows and 1064 columns
Presolve time: 0.02s
Presolved: 1262 rows, 554 columns, 4745 nonzeros
Variable types: 506 continuous, 48 integer (48 binary)
Found heuristic solution: objective 0.4364573
Found heuristic solution: objective 0.4304503
Found heuristic solution: objective 0.4147966

Root relaxation: objective 2.524685e-01, 207 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.25247    0   18    0.41480    0.25247  39.1%     -    0s
H    0     0                       0.4090038    0.25247  38.3%     -    0s
H    0     0                       0.4076213    0.27635  32.2%     -    0s
H    0     0                       0.3990514    0.27635  30.7%     -    0s
     0     0    0.27635    0   20    0.39905    0.27635  30.7%     -    0s
     0     0    0.27635    0   20    0.39905    0.27635  30.7%     -    0s
H    0     0                       0.3887691    0.31167  19.8%     -    0s
     0     0    0.31167    0   21    0.38877    0.31167  19.8%     -    0s
H    0     0                       0.3840045    0.31169  18.8%     -    0s
     0     0    0.31169    0   22    0.38400    0.31169  18.8%     -    0s
     0     0    0.33072    0   22    0.38400    0.33072  13.9%     -    0s
     0     0    0.33110    0   23    0.38400    0.33110  13.8%     -    0s
     0     0    0.33564    0   22    0.38400    0.33564  12.6%     -    0s
     0     0    0.33872    0   22    0.38400    0.33872  11.8%     -    0s
H    0     0                       0.3816244    0.33872  11.2%     -    0s
     0     0    0.34108    0   22    0.38162    0.34108  10.6%     -    0s
H    0     0                       0.3810018    0.34108  10.5%     -    0s
     0     2    0.34108    0   22    0.38100    0.34108  10.5%     -    0s
*   68    38              13       0.3809129    0.35525  6.74%  37.8    1s
*  164    48              15       0.3807459    0.36150  5.06%  33.5    1s
*  166    48              14       0.3806813    0.36150  5.04%  33.2    1s

Cutting planes:
  Implied bound: 156
  MIR: 60
  Flow cover: 186
  RLT: 18
  Relax-and-lift: 69

Explored 694 nodes (15900 simplex iterations) in 1.62 seconds (0.96 work units)
Thread count was 4 (of 40 available processors)

Solution count 10: 0.380681 0.380746 0.380913 ... 0.409004

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

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

        Job resource usage summary 

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

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