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.113476 seconds.
    local lower bound updated to 0.189875
    local upper bound updated to 0.31128

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

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.169684 seconds.
    local lower bound updated to 0.238145
    local upper bound updated to 0.334687

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.132265 seconds.
    local lower bound updated to 0.310031
    local upper bound updated to 0.317476

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 0.208197 seconds.
    local lower bound updated to 0.312044
    local upper bound updated to 0.312613

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.332409
    local lower bound updated to 0.312613

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.317924
    local lower bound updated to 0.317678

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.260465 seconds.
    local lower bound updated to 0.257819
    local upper bound updated to 0.315675

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.219793 seconds.
    local lower bound updated to 0.312005
    local upper bound updated to 0.313553

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 0.222392 seconds.
    local lower bound updated to 0.313526
    local upper bound updated to 0.313531
The Primal step takes 0.707624 (S)
lower bound updated to 0.313526

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.327384
    local lower bound updated to 0.313531

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.31692
    local lower bound updated to 0.31354

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.276445 seconds.
    local lower bound updated to 0.264646
    local upper bound updated to 0.31354

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.267044 seconds.
    local lower bound updated to 0.313489
    local upper bound updated to 0.313534

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 0.34809 seconds.
    local lower bound updated to 0.313505
    local upper bound updated to 0.313531

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.327734
    local lower bound updated to 0.313531

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.298471 seconds.
    local lower bound updated to 0.264646
    local upper bound updated to 0.313531

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.437626 seconds.
    local lower bound updated to 0.313531
    local upper bound updated to 0.313531
The time obtain the optimal randomized assortment is 4.5137 (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_11_4_100.000000_101212.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 536 rows, 512 columns and 1625 nonzeros
Model fingerprint: 0xdafdbad8
Variable types: 471 continuous, 41 integer (41 binary)
Coefficient statistics:
  Matrix range     [1e-02, 1e+00]
  Objective range  [1e+00, 1e+00]
  Bounds range     [1e+00, 1e+00]
  RHS range        [2e-01, 1e+00]
Presolve removed 209 rows and 350 columns
Presolve time: 0.01s
Presolved: 327 rows, 162 columns, 1210 nonzeros
Variable types: 128 continuous, 34 integer (34 binary)
Found heuristic solution: objective 0.3450608

Root relaxation: objective 2.177613e-01, 46 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.21776    0   10    0.34506    0.21776  36.9%     -    0s
H    0     0                       0.3169874    0.21776  31.3%     -    0s
     0     0    0.23280    0   12    0.31699    0.23280  26.6%     -    0s
H    0     0                       0.3167125    0.23280  26.5%     -    0s
     0     0    0.23280    0   12    0.31671    0.23280  26.5%     -    0s
     0     0    0.25482    0   14    0.31671    0.25482  19.5%     -    0s
H    0     0                       0.3160661    0.25482  19.4%     -    0s
     0     0    0.25684    0   13    0.31607    0.25684  18.7%     -    0s
     0     0    0.26654    0   15    0.31607    0.26654  15.7%     -    0s
H    0     0                       0.3135312    0.26654  15.0%     -    0s
     0     0    0.26690    0   17    0.31353    0.26690  14.9%     -    0s
     0     0    0.27168    0   13    0.31353    0.27168  13.3%     -    0s
     0     0    0.27180    0   16    0.31353    0.27180  13.3%     -    0s
     0     0    0.27317    0   12    0.31353    0.27317  12.9%     -    0s
     0     2    0.27317    0   12    0.31353    0.27317  12.9%     -    0s

Cutting planes:
  Gomory: 1
  Implied bound: 29
  MIR: 21
  Flow cover: 33
  RLT: 3
  Relax-and-lift: 17

Explored 251 nodes (2320 simplex iterations) in 0.42 seconds (0.18 work units)
Thread count was 4 (of 48 available processors)

Solution count 5: 0.313531 0.316066 0.316713 ... 0.345061

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

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

        Job resource usage summary 

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

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