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.169348 seconds.
    local lower bound updated to 0.283292
    local upper bound updated to 0.555053

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.617398
    local lower bound updated to 0.611717

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.612609
    local lower bound updated to 0.611876

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.339635 seconds.
    local lower bound updated to 0.409533
    local upper bound updated to 0.547771

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.0663699 seconds.
    local lower bound updated to 0.510874
    local upper bound updated to 0.538756

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 0.0952704 seconds.
    local lower bound updated to 0.527118
    local upper bound updated to 0.528627

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 0.0608755 seconds.
    local lower bound updated to 0.527118
    local upper bound updated to 0.528207

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 0.0952714 seconds.
    local lower bound updated to 0.527118
    local upper bound updated to 0.528082

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 0.0955026 seconds.
    local lower bound updated to 0.528082
    local upper bound updated to 0.528082
The Primal step takes 0.761866 (S)
lower bound updated to 0.528082

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.55236
    local lower bound updated to 0.5358

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.544477
    local lower bound updated to 0.536073

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.542954
    local lower bound updated to 0.538915

    ++ RESTRICTED DUAL ITERATION 4 ++
    local upper bound updated to 0.542049
    local lower bound updated to 0.540491

    ++ RESTRICTED DUAL ITERATION 5 ++
    local upper bound updated to 0.542049
    local lower bound updated to 0.540591

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.634982 seconds.
    local lower bound updated to 0.480689
    local upper bound updated to 0.540591

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.458698 seconds.
    local lower bound updated to 0.529895
    local upper bound updated to 0.539509

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 0.638027 seconds.
    local lower bound updated to 0.534628
    local upper bound updated to 0.539471

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 0.556633 seconds.
    local lower bound updated to 0.535024
    local upper bound updated to 0.538942

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 0.609186 seconds.
    local lower bound updated to 0.537359
    local upper bound updated to 0.538915

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 0.668832 seconds.
    local lower bound updated to 0.537359
    local upper bound updated to 0.538484

    ++ RESTRICTED PRIMAL ITERATION 7 ++
One worst-case parameter optimization takes 0.728437 seconds.
    local lower bound updated to 0.53793
    local upper bound updated to 0.538466

    ++ RESTRICTED PRIMAL ITERATION 8 ++
One worst-case parameter optimization takes 0.626911 seconds.
    local lower bound updated to 0.538202
    local upper bound updated to 0.538466

    ++ RESTRICTED PRIMAL ITERATION 9 ++
One worst-case parameter optimization takes 0.585134 seconds.
    local lower bound updated to 0.538355
    local upper bound updated to 0.538466

    ++ RESTRICTED PRIMAL ITERATION 10 ++
One worst-case parameter optimization takes 0.610253 seconds.
    local lower bound updated to 0.538355
    local upper bound updated to 0.53845

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.548229
    local lower bound updated to 0.53845

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.538664
    local lower bound updated to 0.538458

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.634851 seconds.
    local lower bound updated to 0.48702
    local upper bound updated to 0.538458

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.661481 seconds.
    local lower bound updated to 0.538458
    local upper bound updated to 0.538458
The time obtain the optimal randomized assortment is 10.2766 (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_205114.log"
The computation time limit for a lower bound is 85988
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 1338 rows, 1170 columns and 4170 nonzeros
Model fingerprint: 0x640803b3
Variable types: 1121 continuous, 49 integer (49 binary)
Coefficient statistics:
  Matrix range     [6e-06, 1e+00]
  Objective range  [1e+00, 1e+00]
  Bounds range     [1e+00, 1e+00]
  RHS range        [3e-01, 1e+00]
Presolve removed 440 rows and 762 columns
Presolve time: 0.01s
Presolved: 898 rows, 408 columns, 3362 nonzeros
Variable types: 362 continuous, 46 integer (46 binary)
Found heuristic solution: objective 0.6147679
Found heuristic solution: objective 0.5987707
Found heuristic solution: objective 0.5762645

Root relaxation: objective 4.497603e-01, 155 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.44976    0   18    0.57626    0.44976  22.0%     -    0s
H    0     0                       0.5698893    0.48361  15.1%     -    0s
     0     0    0.48361    0   23    0.56989    0.48361  15.1%     -    0s
H    0     0                       0.5463592    0.48361  11.5%     -    0s
     0     0    0.50218    0   24    0.54636    0.50218  8.09%     -    0s
     0     0    0.50295    0   24    0.54636    0.50295  7.94%     -    0s
H    0     0                       0.5403235    0.51253  5.14%     -    0s
     0     0    0.51253    0   24    0.54032    0.51253  5.14%     -    0s
H    0     0                       0.5393329    0.51268  4.94%     -    0s
     0     0    0.51268    0   23    0.53933    0.51268  4.94%     -    0s
     0     0    0.51620    0   21    0.53933    0.51620  4.29%     -    0s
     0     0    0.51729    0   21    0.53933    0.51729  4.09%     -    0s
     0     0    0.51765    0   23    0.53933    0.51765  4.02%     -    0s
     0     2    0.51765    0   23    0.53933    0.51765  4.02%     -    0s
*   47    27              13       0.5390260    0.52716  2.20%  18.6    0s
*   98    34              14       0.5384580    0.52840  1.87%  19.8    0s

Cutting planes:
  Gomory: 2
  Implied bound: 119
  MIR: 44
  Flow cover: 142
  RLT: 13
  Relax-and-lift: 36

Explored 354 nodes (7226 simplex iterations) in 0.67 seconds (0.40 work units)
Thread count was 4 (of 40 available processors)

Solution count 9: 0.538458 0.539026 0.539333 ... 0.614768

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

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

        Job resource usage summary 

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

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