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.171499 seconds.
    local lower bound updated to 0.226988
    local upper bound updated to 0.409559

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

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.278058 seconds.
    local lower bound updated to 0.284068
    local upper bound updated to 0.410608

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.232297 seconds.
    local lower bound updated to 0.410105
    local upper bound updated to 0.410322

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 0.35715 seconds.
    local lower bound updated to 0.410105
    local upper bound updated to 0.410129

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.421199
    local lower bound updated to 0.410913

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.421199
    local lower bound updated to 0.415302

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.415368
    local lower bound updated to 0.415312

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.86666 seconds.
    local lower bound updated to 0.346443
    local upper bound updated to 0.413559

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.663239 seconds.
    local lower bound updated to 0.40074
    local upper bound updated to 0.412642

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 0.521742 seconds.
    local lower bound updated to 0.41104
    local upper bound updated to 0.412196

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.423229
    local lower bound updated to 0.412767

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.416119
    local lower bound updated to 0.412813

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.41304
    local lower bound updated to 0.412838

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.754137 seconds.
    local lower bound updated to 0.362
    local upper bound updated to 0.412838

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.56519 seconds.
    local lower bound updated to 0.409119
    local upper bound updated to 0.412693

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 0.827736 seconds.
    local lower bound updated to 0.412439
    local upper bound updated to 0.412683

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 0.851617 seconds.
    local lower bound updated to 0.412575
    local upper bound updated to 0.412677

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 0.628663 seconds.
    local lower bound updated to 0.412575
    local upper bound updated to 0.41266

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 0.636078 seconds.
    local lower bound updated to 0.412575
    local upper bound updated to 0.412644

    ++ RESTRICTED PRIMAL ITERATION 7 ++
One worst-case parameter optimization takes 0.62521 seconds.
    local lower bound updated to 0.412586
    local upper bound updated to 0.412639

    ++ RESTRICTED PRIMAL ITERATION 8 ++
One worst-case parameter optimization takes 0.51544 seconds.
    local lower bound updated to 0.412639
    local upper bound updated to 0.412639
The Primal step takes 5.41902 (S)
lower bound updated to 0.412639

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.415951
    local lower bound updated to 0.412639

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.579135 seconds.
    local lower bound updated to 0.366202
    local upper bound updated to 0.412639

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.668476 seconds.
    local lower bound updated to 0.412639
    local upper bound updated to 0.412639
The time obtain the optimal randomized assortment is 13.1069 (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_60.000000_67612.log"
The computation time limit for a lower bound is 85985
The model output flag is 1
Gurobi Optimizer version 9.5.1 build v9.5.1rc2 (linux64)
Thread count: 128 physical cores, 128 logical processors, using up to 4 threads
Optimize a model with 996 rows, 982 columns and 3058 nonzeros
Model fingerprint: 0x916a53f2
Variable types: 941 continuous, 41 integer (41 binary)
Coefficient statistics:
  Matrix range     [4e-03, 1e+00]
  Objective range  [1e+00, 1e+00]
  Bounds range     [1e+00, 1e+00]
  RHS range        [3e-01, 1e+00]
Presolve removed 367 rows and 698 columns
Presolve time: 0.01s
Presolved: 629 rows, 284 columns, 2366 nonzeros
Variable types: 249 continuous, 35 integer (35 binary)
Found heuristic solution: objective 0.4659922
Found heuristic solution: objective 0.4236017

Root relaxation: objective 2.563152e-01, 121 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.25632    0   17    0.42360    0.25632  39.5%     -    0s
     0     0    0.33463    0   18    0.42360    0.33463  21.0%     -    0s
H    0     0                       0.4219778    0.33464  20.7%     -    0s
     0     0    0.33464    0   20    0.42198    0.33464  20.7%     -    0s
     0     0    0.35615    0   17    0.42198    0.35615  15.6%     -    0s
     0     0    0.35649    0   18    0.42198    0.35649  15.5%     -    0s
     0     0    0.37442    0   18    0.42198    0.37442  11.3%     -    0s
     0     0    0.37467    0   18    0.42198    0.37467  11.2%     -    0s
     0     0    0.38126    0   18    0.42198    0.38126  9.65%     -    0s
     0     0    0.38231    0   19    0.42198    0.38231  9.40%     -    0s
H    0     0                       0.4217855    0.38231  9.36%     -    0s
H    0     0                       0.4196955    0.38231  8.91%     -    0s
H    0     0                       0.4175480    0.38231  8.44%     -    0s
     0     0    0.38488    0   17    0.41755    0.38488  7.82%     -    0s
H    0     0                       0.4127236    0.38488  6.75%     -    0s
H    0     0                       0.4126389    0.38488  6.73%     -    0s
H    0     0                       0.4126389    0.38488  6.73%     -    0s
     0     2    0.38488    0   17    0.41264    0.38488  6.73%     -    0s
H  124    15                       0.4126389    0.39895  3.32%  14.2    0s
H  200     3                       0.4126389    0.40704  1.36%  13.8    0s

Cutting planes:
  Gomory: 1
  Implied bound: 95
  MIR: 20
  Flow cover: 95
  RLT: 10
  Relax-and-lift: 34

Explored 223 nodes (3865 simplex iterations) in 0.67 seconds (0.30 work units)
Thread count was 4 (of 128 available processors)

Solution count 10: 0.412639 0.412639 0.412639 ... 0.465992

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

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

        Job resource usage summary 

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

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