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.130728 seconds.
    local lower bound updated to 0.3641
    local upper bound updated to 0.723604

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.730833
    local lower bound updated to 0.718625

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.726853
    local lower bound updated to 0.7212

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.327808 seconds.
    local lower bound updated to 0.482138
    local upper bound updated to 0.71387

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.319109 seconds.
    local lower bound updated to 0.704282
    local upper bound updated to 0.707972

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 0.267865 seconds.
    local lower bound updated to 0.706003
    local upper bound updated to 0.706843

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 0.315759 seconds.
    local lower bound updated to 0.706252
    local upper bound updated to 0.706514

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.726824
    local lower bound updated to 0.712847

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.486175 seconds.
    local lower bound updated to 0.526053
    local upper bound updated to 0.712698

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.647466 seconds.
    local lower bound updated to 0.711073
    local upper bound updated to 0.711077
The Primal step takes 1.13826 (S)
lower bound updated to 0.711073

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.722287
    local lower bound updated to 0.711077

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.467549 seconds.
    local lower bound updated to 0.526053
    local upper bound updated to 0.711077

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.60562 seconds.
    local lower bound updated to 0.709793
    local upper bound updated to 0.711075

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 0.611592 seconds.
    local lower bound updated to 0.711075
    local upper bound updated to 0.711075
The time obtain the optimal randomized assortment is 4.81625 (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_61814.log"
The computation time limit for a lower bound is 85994
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 708 rows, 610 columns and 2215 nonzeros
Model fingerprint: 0xad7e1920
Variable types: 561 continuous, 49 integer (49 binary)
Coefficient statistics:
  Matrix range     [5e-03, 1e+00]
  Objective range  [1e+00, 1e+00]
  Bounds range     [1e+00, 1e+00]
  RHS range        [8e-01, 1e+00]
Presolve removed 202 rows and 364 columns
Presolve time: 0.01s
Presolved: 506 rows, 246 columns, 1868 nonzeros
Variable types: 201 continuous, 45 integer (45 binary)
Found heuristic solution: objective 0.7859373
Found heuristic solution: objective 0.7655167

Root relaxation: objective 6.159118e-01, 68 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.61591    0   11    0.76552    0.61591  19.5%     -    0s
H    0     0                       0.7479982    0.61591  17.7%     -    0s
H    0     0                       0.7467333    0.62740  16.0%     -    0s
     0     0    0.62740    0   19    0.74673    0.62740  16.0%     -    0s
     0     0    0.64814    0   17    0.74673    0.64814  13.2%     -    0s
H    0     0                       0.7428506    0.64814  12.7%     -    0s
     0     0    0.65121    0   17    0.74285    0.65121  12.3%     -    0s
H    0     0                       0.7318544    0.65121  11.0%     -    0s
H    0     0                       0.7317228    0.65915  9.92%     -    0s
     0     0    0.65915    0   18    0.73172    0.65915  9.92%     -    0s
     0     0    0.66033    0   18    0.73172    0.66033  9.76%     -    0s
     0     0    0.66403    0   22    0.73172    0.66403  9.25%     -    0s
H    0     0                       0.7298862    0.66403  9.02%     -    0s
     0     0    0.66410    0   23    0.72989    0.66410  9.01%     -    0s
     0     0    0.66636    0   19    0.72989    0.66636  8.70%     -    0s
H    0     0                       0.7273264    0.66636  8.38%     -    0s
H    0     0                       0.7114070    0.66636  6.33%     -    0s
     0     2    0.66636    0   19    0.71141    0.66636  6.33%     -    0s
H   33    29                       0.7112118    0.68362  3.88%  17.9    0s
H   41    24                       0.7110752    0.68362  3.86%  16.1    0s

Cutting planes:
  Gomory: 1
  Implied bound: 80
  MIR: 20
  Flow cover: 52
  RLT: 7
  Relax-and-lift: 39

Explored 508 nodes (5623 simplex iterations) in 0.57 seconds (0.26 work units)
Thread count was 4 (of 48 available processors)

Solution count 10: 0.711075 0.711407 0.727326 ... 0.765517

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

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

        Job resource usage summary 

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

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