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.0695289 seconds.
    local lower bound updated to 0.349407
    local upper bound updated to 0.63736

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.726571
    local lower bound updated to 0.679262

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.719505
    local lower bound updated to 0.700888

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.712816
    local lower bound updated to 0.709687

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.239474 seconds.
    local lower bound updated to 0.489526
    local upper bound updated to 0.629417

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.14875 seconds.
    local lower bound updated to 0.62465
    local upper bound updated to 0.627957

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 0.133646 seconds.
    local lower bound updated to 0.625529
    local upper bound updated to 0.625869

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.661768
    local lower bound updated to 0.625869

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.646482
    local lower bound updated to 0.627913

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.290178 seconds.
    local lower bound updated to 0.508733
    local upper bound updated to 0.627913

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.170977 seconds.
    local lower bound updated to 0.623336
    local upper bound updated to 0.627549

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 0.215467 seconds.
    local lower bound updated to 0.623924
    local upper bound updated to 0.626165

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 0.296279 seconds.
    local lower bound updated to 0.625899
    local upper bound updated to 0.625984

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 0.211771 seconds.
    local lower bound updated to 0.625899
    local upper bound updated to 0.625966

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.649475
    local lower bound updated to 0.625966

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.649475
    local lower bound updated to 0.626148

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.636143
    local lower bound updated to 0.626493

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.33329 seconds.
    local lower bound updated to 0.524807
    local upper bound updated to 0.626493

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.268039 seconds.
    local lower bound updated to 0.623529
    local upper bound updated to 0.626049

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 0.262058 seconds.
    local lower bound updated to 0.625721
    local upper bound updated to 0.625966

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.643417
    local lower bound updated to 0.625966

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.63043
    local lower bound updated to 0.62597

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.629954
    local lower bound updated to 0.625974

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.614777 seconds.
    local lower bound updated to 0.535424
    local upper bound updated to 0.625974

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.332539 seconds.
    local lower bound updated to 0.625876
    local upper bound updated to 0.625966

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 0.300658 seconds.
    local lower bound updated to 0.625966
    local upper bound updated to 0.625966
The time obtain the optimal randomized assortment is 5.29348 (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_200.000000_202812.log"
The computation time limit for a lower bound is 85993
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 996 rows, 982 columns and 2998 nonzeros
Model fingerprint: 0xaa1dabc8
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        [5e-01, 1e+00]
Presolve removed 397 rows and 709 columns
Presolve time: 0.01s
Presolved: 599 rows, 273 columns, 2182 nonzeros
Variable types: 234 continuous, 39 integer (39 binary)
Found heuristic solution: objective 0.7017218
Found heuristic solution: objective 0.6642506

Root relaxation: objective 5.082724e-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.50827    0   12    0.66425    0.50827  23.5%     -    0s
H    0     0                       0.6621781    0.55273  16.5%     -    0s
     0     0    0.55273    0   15    0.66218    0.55273  16.5%     -    0s
H    0     0                       0.6444928    0.55273  14.2%     -    0s
     0     0    0.55273    0   15    0.64449    0.55273  14.2%     -    0s
     0     0    0.58557    0   15    0.64449    0.58557  9.14%     -    0s
     0     0    0.58559    0   15    0.64449    0.58559  9.14%     -    0s
H    0     0                       0.6442164    0.58559  9.10%     -    0s
H    0     0                       0.6435886    0.58559  9.01%     -    0s
H    0     0                       0.6260839    0.60494  3.38%     -    0s
H    0     0                       0.6259664    0.60494  3.36%     -    0s
     0     0    0.60494    0   16    0.62597    0.60494  3.36%     -    0s
     0     0    0.60550    0   14    0.62597    0.60550  3.27%     -    0s
     0     0    0.60855    0   16    0.62597    0.60855  2.78%     -    0s
     0     0    0.61038    0   15    0.62597    0.61038  2.49%     -    0s
     0     0    0.61401    0   16    0.62597    0.61401  1.91%     -    0s
     0     2    0.61401    0   16    0.62597    0.61401  1.91%     -    0s

Cutting planes:
  Implied bound: 58
  MIR: 8
  Flow cover: 54
  RLT: 7
  Relax-and-lift: 20

Explored 49 nodes (1569 simplex iterations) in 0.30 seconds (0.11 work units)
Thread count was 4 (of 48 available processors)

Solution count 8: 0.625966 0.626084 0.643589 ... 0.701722

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

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

        Job resource usage summary 

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

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