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.170848 seconds.
    local lower bound updated to 0.246257
    local upper bound updated to 0.465006

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

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.239804 seconds.
    local lower bound updated to 0.321045
    local upper bound updated to 0.47062

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.254124 seconds.
    local lower bound updated to 0.364298
    local upper bound updated to 0.468081

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 0.432385 seconds.
    local lower bound updated to 0.456992
    local upper bound updated to 0.466375

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 0.457688 seconds.
    local lower bound updated to 0.462739
    local upper bound updated to 0.463168

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.4967
    local lower bound updated to 0.463168

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.49061
    local lower bound updated to 0.464969

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.468661
    local lower bound updated to 0.465743

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.446879 seconds.
    local lower bound updated to 0.374053
    local upper bound updated to 0.465743

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.768909 seconds.
    local lower bound updated to 0.463608
    local upper bound updated to 0.464939

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 0.677837 seconds.
    local lower bound updated to 0.463608
    local upper bound updated to 0.464859

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 0.925688 seconds.
    local lower bound updated to 0.463608
    local upper bound updated to 0.464788

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 0.907435 seconds.
    local lower bound updated to 0.463667
    local upper bound updated to 0.464723

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 0.885186 seconds.
    local lower bound updated to 0.464191
    local upper bound updated to 0.464716

    ++ RESTRICTED PRIMAL ITERATION 7 ++
One worst-case parameter optimization takes 1.06271 seconds.
    local lower bound updated to 0.464424
    local upper bound updated to 0.464704

    ++ RESTRICTED PRIMAL ITERATION 8 ++
One worst-case parameter optimization takes 0.865745 seconds.
    local lower bound updated to 0.464505
    local upper bound updated to 0.464693

    ++ RESTRICTED PRIMAL ITERATION 9 ++
One worst-case parameter optimization takes 0.961583 seconds.
    local lower bound updated to 0.464667
    local upper bound updated to 0.46469

    ++ RESTRICTED PRIMAL ITERATION 10 ++
One worst-case parameter optimization takes 1.06573 seconds.
    local lower bound updated to 0.464672
    local upper bound updated to 0.46469

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.513284
    local lower bound updated to 0.46469

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.476206
    local lower bound updated to 0.464835

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.543461 seconds.
    local lower bound updated to 0.380533
    local upper bound updated to 0.464814

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 1.0205 seconds.
    local lower bound updated to 0.464366
    local upper bound updated to 0.46469

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.5056
    local lower bound updated to 0.46469

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.544668 seconds.
    local lower bound updated to 0.380533
    local upper bound updated to 0.46469

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.934988 seconds.
    local lower bound updated to 0.46469
    local upper bound updated to 0.46469
The time obtain the optimal randomized assortment is 17.6583 (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_200.000000_206814.log"
The computation time limit for a lower bound is 85981
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 834 rows, 722 columns and 2624 nonzeros
Model fingerprint: 0xd8fb540a
Variable types: 673 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        [6e-01, 1e+00]
Presolve removed 245 rows and 445 columns
Presolve time: 0.01s
Presolved: 589 rows, 277 columns, 2206 nonzeros
Variable types: 231 continuous, 46 integer (46 binary)
Found heuristic solution: objective 0.7471582
Found heuristic solution: objective 0.5495964

Root relaxation: objective 1.844793e-01, 81 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.18448    0    9    0.54960    0.18448  66.4%     -    0s
H    0     0                       0.5249409    0.18448  64.9%     -    0s
H    0     0                       0.5237615    0.18448  64.8%     -    0s
     0     0    0.22116    0   21    0.52376    0.22116  57.8%     -    0s
H    0     0                       0.4841267    0.22116  54.3%     -    0s
     0     0    0.29690    0   25    0.48413    0.29690  38.7%     -    0s
     0     0    0.30191    0   25    0.48413    0.30191  37.6%     -    0s
     0     0    0.33035    0   20    0.48413    0.33035  31.8%     -    0s
H    0     0                       0.4702875    0.33035  29.8%     -    0s
     0     0    0.33228    0   21    0.47029    0.33228  29.3%     -    0s
     0     0    0.34488    0   22    0.47029    0.34488  26.7%     -    0s
     0     0    0.34604    0   21    0.47029    0.34604  26.4%     -    0s
     0     0    0.34889    0   22    0.47029    0.34889  25.8%     -    0s
H    0     0                       0.4661119    0.34889  25.1%     -    0s
H    0     0                       0.4646897    0.34889  24.9%     -    0s
     0     2    0.34889    0   22    0.46469    0.34889  24.9%     -    0s
H  230    55                       0.4646897    0.40715  12.4%  11.3    0s

Cutting planes:
  Gomory: 1
  Implied bound: 88
  MIR: 26
  Flow cover: 69
  RLT: 8
  Relax-and-lift: 41

Explored 596 nodes (6837 simplex iterations) in 0.93 seconds (0.34 work units)
Thread count was 4 (of 40 available processors)

Solution count 9: 0.46469 0.46469 0.466112 ... 0.747158

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

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

        Job resource usage summary 

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

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