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.268444 seconds.
    local lower bound updated to 0.23406
    local upper bound updated to 0.403614

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

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 4.70674 seconds.
    local lower bound updated to 0.283569
    local upper bound updated to 0.408709

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 4.20267 seconds.
    local lower bound updated to 0.397591
    local upper bound updated to 0.401488

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 0.840332 seconds.
    local lower bound updated to 0.400976
    local upper bound updated to 0.401121

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.419132
    local lower bound updated to 0.413415

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 2.8797 seconds.
    local lower bound updated to 0.311108
    local upper bound updated to 0.406516

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 1.64058 seconds.
    local lower bound updated to 0.402499
    local upper bound updated to 0.403787

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 2.57876 seconds.
    local lower bound updated to 0.402499
    local upper bound updated to 0.403486

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 1.40799 seconds.
    local lower bound updated to 0.402499
    local upper bound updated to 0.402709

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.412938
    local lower bound updated to 0.403433

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.409071
    local lower bound updated to 0.408066

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 2.26962 seconds.
    local lower bound updated to 0.31706
    local upper bound updated to 0.405026

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 5.07047 seconds.
    local lower bound updated to 0.399472
    local upper bound updated to 0.402709

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 2.76304 seconds.
    local lower bound updated to 0.402709
    local upper bound updated to 0.402709
The Primal step takes 10.1147 (S)
lower bound updated to 0.402709

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.407842
    local lower bound updated to 0.402709

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.406029
    local lower bound updated to 0.402893

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 1.87163 seconds.
    local lower bound updated to 0.311886
    local upper bound updated to 0.402893

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 1.95066 seconds.
    local lower bound updated to 0.398661
    local upper bound updated to 0.402723

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 1.73399 seconds.
    local lower bound updated to 0.402589
    local upper bound updated to 0.402711

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 1.96541 seconds.
    local lower bound updated to 0.402589
    local upper bound updated to 0.402709

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.408007
    local lower bound updated to 0.402709

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.406297
    local lower bound updated to 0.402709

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 2.13996 seconds.
    local lower bound updated to 0.319716
    local upper bound updated to 0.402709

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 1.8572 seconds.
    local lower bound updated to 0.402709
    local upper bound updated to 0.402709
The time obtain the optimal randomized assortment is 47.6824 (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_60818.log"
The computation time limit for a lower bound is 85948
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 1828 rows, 1398 columns and 5978 nonzeros
Model fingerprint: 0x833cbc9b
Variable types: 1333 continuous, 65 integer (65 binary)
Coefficient statistics:
  Matrix range     [6e-03, 1e+00]
  Objective range  [1e+00, 1e+00]
  Bounds range     [1e+00, 1e+00]
  RHS range        [4e-01, 1e+00]
Presolve removed 440 rows and 740 columns
Presolve time: 0.02s
Presolved: 1388 rows, 658 columns, 5307 nonzeros
Variable types: 594 continuous, 64 integer (64 binary)
Found heuristic solution: objective 0.5710129
Found heuristic solution: objective 0.5627650
Found heuristic solution: objective 0.5009966

Root relaxation: objective 3.166977e-01, 159 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.31670    0   22    0.50100    0.31670  36.8%     -    0s
     0     0    0.31762    0   26    0.50100    0.31762  36.6%     -    0s
H    0     0                       0.4656566    0.31762  31.8%     -    0s
     0     0    0.31762    0   26    0.46566    0.31762  31.8%     -    0s
     0     0    0.34639    0   27    0.46566    0.34639  25.6%     -    0s
H    0     0                       0.4043639    0.34639  14.3%     -    0s
     0     0    0.34963    0   27    0.40436    0.34963  13.5%     -    0s
     0     0    0.35358    0   30    0.40436    0.35358  12.6%     -    0s
     0     0    0.35897    0   29    0.40436    0.35897  11.2%     -    0s
     0     0    0.36405    0   28    0.40436    0.36405  10.0%     -    0s
     0     0    0.36536    0   31    0.40436    0.36536  9.64%     -    0s
     0     0    0.36681    0   26    0.40436    0.36681  9.29%     -    0s
H    0     0                       0.4027092    0.36681  8.91%     -    1s
     0     2    0.36681    0   26    0.40271    0.36681  8.91%     -    1s

Cutting planes:
  Implied bound: 167
  MIR: 26
  Flow cover: 96
  RLT: 18
  Relax-and-lift: 87

Explored 849 nodes (15890 simplex iterations) in 1.93 seconds (0.98 work units)
Thread count was 4 (of 48 available processors)

Solution count 6: 0.402709 0.404364 0.465657 ... 0.571013

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

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

        Job resource usage summary 

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

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