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.0973734 seconds.
    local lower bound updated to 0.229956
    local upper bound updated to 0.429656

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.442024
    local lower bound updated to 0.429656

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.26331 seconds.
    local lower bound updated to 0.327024
    local upper bound updated to 0.429656

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.440993
    local lower bound updated to 0.431868

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.466151 seconds.
    local lower bound updated to 0.334777
    local upper bound updated to 0.429656

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.435403
    local lower bound updated to 0.429656

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.430101
    local lower bound updated to 0.429665

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.429739
    local lower bound updated to 0.429698

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.457431 seconds.
    local lower bound updated to 0.361945
    local upper bound updated to 0.429698

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.432688
    local lower bound updated to 0.429698

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.471026 seconds.
    local lower bound updated to 0.361945
    local upper bound updated to 0.429698

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.422805 seconds.
    local lower bound updated to 0.429698
    local upper bound updated to 0.429698
The time obtain the optimal randomized assortment is 3.67564 (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_66914.log"
The computation time limit for a lower bound is 85995
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 960 rows, 834 columns and 3000 nonzeros
Model fingerprint: 0xfbe45afc
Variable types: 785 continuous, 49 integer (49 binary)
Coefficient statistics:
  Matrix range     [2e-03, 1e+00]
  Objective range  [1e+00, 1e+00]
  Bounds range     [1e+00, 1e+00]
  RHS range        [3e-01, 1e+00]
Presolve removed 295 rows and 521 columns
Presolve time: 0.01s
Presolved: 665 rows, 313 columns, 2519 nonzeros
Variable types: 266 continuous, 47 integer (47 binary)
Found heuristic solution: objective 0.5151785
Found heuristic solution: objective 0.5127389
Found heuristic solution: objective 0.4867935
Found heuristic solution: objective 0.4732089

Root relaxation: objective 3.294132e-01, 75 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.32941    0   16    0.47321    0.32941  30.4%     -    0s
H    0     0                       0.4724847    0.32941  30.3%     -    0s
H    0     0                       0.4698270    0.32941  29.9%     -    0s
H    0     0                       0.4695990    0.32941  29.9%     -    0s
H    0     0                       0.4635994    0.34127  26.4%     -    0s
     0     0    0.34127    0   16    0.46360    0.34127  26.4%     -    0s
     0     0    0.34127    0   16    0.46360    0.34127  26.4%     -    0s
     0     0    0.37103    0   21    0.46360    0.37103  20.0%     -    0s
H    0     0                       0.4435950    0.37103  16.4%     -    0s
     0     0    0.37200    0   20    0.44360    0.37200  16.1%     -    0s
H    0     0                       0.4296978    0.39398  8.31%     -    0s
     0     0    0.39398    0   21    0.42970    0.39398  8.31%     -    0s
     0     0    0.39421    0   21    0.42970    0.39421  8.26%     -    0s
     0     0    0.40383    0   18    0.42970    0.40383  6.02%     -    0s
     0     0    0.40465    0   21    0.42970    0.40465  5.83%     -    0s
     0     0    0.40658    0   19    0.42970    0.40658  5.38%     -    0s
     0     2    0.40658    0   19    0.42970    0.40658  5.38%     -    1s

Cutting planes:
  Implied bound: 72
  MIR: 18
  Flow cover: 55
  RLT: 3
  Relax-and-lift: 27

Explored 62 nodes (2013 simplex iterations) in 1.21 seconds (0.19 work units)
Thread count was 4 (of 48 available processors)

Solution count 10: 0.429698 0.443595 0.463599 ... 0.515178

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

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

        Job resource usage summary 

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

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