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.186425 seconds.
    local lower bound updated to 0.251215
    local upper bound updated to 0.472502

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.603536
    local lower bound updated to 0.590659

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.303268 seconds.
    local lower bound updated to 0.302732
    local upper bound updated to 0.466383

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.210667 seconds.
    local lower bound updated to 0.457264
    local upper bound updated to 0.462295

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.52081
    local lower bound updated to 0.463915

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.492401
    local lower bound updated to 0.470318

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.492401
    local lower bound updated to 0.483716

    ++ RESTRICTED DUAL ITERATION 4 ++
    local upper bound updated to 0.492401
    local lower bound updated to 0.484112

    ++ RESTRICTED DUAL ITERATION 5 ++
    local upper bound updated to 0.488017
    local lower bound updated to 0.486209

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.527951 seconds.
    local lower bound updated to 0.403236
    local upper bound updated to 0.486209

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.211852 seconds.
    local lower bound updated to 0.446192
    local upper bound updated to 0.477576

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 0.378406 seconds.
    local lower bound updated to 0.457711
    local upper bound updated to 0.476993

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 0.510179 seconds.
    local lower bound updated to 0.464197
    local upper bound updated to 0.476867

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 0.811365 seconds.
    local lower bound updated to 0.469945
    local upper bound updated to 0.475293

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 0.463976 seconds.
    local lower bound updated to 0.474811
    local upper bound updated to 0.475163

    ++ RESTRICTED PRIMAL ITERATION 7 ++
One worst-case parameter optimization takes 0.382246 seconds.
    local lower bound updated to 0.475163
    local upper bound updated to 0.475163
The Primal step takes 3.29854 (S)
lower bound updated to 0.475163

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.522551
    local lower bound updated to 0.475163

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.48131
    local lower bound updated to 0.476095

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.477109
    local lower bound updated to 0.476095

    ++ RESTRICTED DUAL ITERATION 4 ++
    local upper bound updated to 0.477109
    local lower bound updated to 0.476534

    ++ RESTRICTED DUAL ITERATION 5 ++
    local upper bound updated to 0.477109
    local lower bound updated to 0.476679

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.570705 seconds.
    local lower bound updated to 0.422518
    local upper bound updated to 0.476679

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.604631 seconds.
    local lower bound updated to 0.466848
    local upper bound updated to 0.47641

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.514337
    local lower bound updated to 0.47641

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.468547 seconds.
    local lower bound updated to 0.422518
    local upper bound updated to 0.47641

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 1.07197 seconds.
    local lower bound updated to 0.47641
    local upper bound updated to 0.47641
The time obtain the optimal randomized assortment is 10.1355 (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_104612.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: 128 physical cores, 128 logical processors, using up to 4 threads
Optimize a model with 1196 rows, 1170 columns and 3634 nonzeros
Model fingerprint: 0xaa6b53b6
Variable types: 1129 continuous, 41 integer (41 binary)
Coefficient statistics:
  Matrix range     [1e-06, 1e+00]
  Objective range  [1e+00, 1e+00]
  Bounds range     [1e+00, 1e+00]
  RHS range        [4e-01, 1e+00]
Presolve removed 426 rows and 830 columns
Presolve time: 0.01s
Presolved: 770 rows, 340 columns, 2778 nonzeros
Variable types: 302 continuous, 38 integer (38 binary)
Found heuristic solution: objective 0.6101960
Found heuristic solution: objective 0.6087210
Found heuristic solution: objective 0.5934917

Root relaxation: objective 3.167295e-01, 117 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.31673    0   14    0.59349    0.31673  46.6%     -    0s
H    0     0                       0.5735294    0.31673  44.8%     -    0s
H    0     0                       0.5720943    0.35562  37.8%     -    0s
     0     0    0.35562    0   15    0.57209    0.35562  37.8%     -    0s
H    0     0                       0.5188822    0.35562  31.5%     -    0s
     0     0    0.39183    0   17    0.51888    0.39183  24.5%     -    0s
H    0     0                       0.5041823    0.39183  22.3%     -    0s
H    0     0                       0.5003295    0.39193  21.7%     -    0s
     0     0    0.39193    0   17    0.50033    0.39193  21.7%     -    0s
H    0     0                       0.4935481    0.39193  20.6%     -    0s
H    0     0                       0.4911228    0.41711  15.1%     -    0s
     0     0    0.41711    0   16    0.49112    0.41711  15.1%     -    0s
H    0     0                       0.4781370    0.41711  12.8%     -    0s
     0     0    0.41935    0   17    0.47814    0.41935  12.3%     -    0s
     0     0    0.43123    0   17    0.47814    0.43123  9.81%     -    0s
H    0     0                       0.4764098    0.43123  9.48%     -    0s
     0     0    0.43646    0   17    0.47641    0.43646  8.38%     -    0s
     0     0    0.44199    0   18    0.47641    0.44199  7.22%     -    0s
     0     2    0.44199    0   18    0.47641    0.44199  7.22%     -    0s

Cutting planes:
  Implied bound: 111
  MIR: 19
  Flow cover: 66
  RLT: 3
  Relax-and-lift: 41

Explored 125 nodes (3237 simplex iterations) in 0.95 seconds (0.21 work units)
Thread count was 4 (of 128 available processors)

Solution count 10: 0.47641 0.478137 0.491123 ... 0.593492

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

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

        Job resource usage summary 

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

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