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.361605 seconds.
    local lower bound updated to 0.349042
    local upper bound updated to 0.684723

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.751528
    local lower bound updated to 0.73432

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.741202
    local lower bound updated to 0.740691

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 2.85487 seconds.
    local lower bound updated to 0.517965
    local upper bound updated to 0.692229

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.278654 seconds.
    local lower bound updated to 0.625769
    local upper bound updated to 0.667094

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 0.399202 seconds.
    local lower bound updated to 0.651578
    local upper bound updated to 0.661435

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 0.406287 seconds.
    local lower bound updated to 0.651578
    local upper bound updated to 0.659471

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 0.541413 seconds.
    local lower bound updated to 0.651578
    local upper bound updated to 0.656008

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 0.680261 seconds.
    local lower bound updated to 0.655148
    local upper bound updated to 0.655661

    ++ RESTRICTED PRIMAL ITERATION 7 ++
One worst-case parameter optimization takes 0.376917 seconds.
    local lower bound updated to 0.655194
    local upper bound updated to 0.655432

    ++ RESTRICTED PRIMAL ITERATION 8 ++
One worst-case parameter optimization takes 0.504342 seconds.
    local lower bound updated to 0.655194
    local upper bound updated to 0.655375

    ++ RESTRICTED PRIMAL ITERATION 9 ++
One worst-case parameter optimization takes 0.460844 seconds.
    local lower bound updated to 0.655194
    local upper bound updated to 0.655319

    ++ RESTRICTED PRIMAL ITERATION 10 ++
One worst-case parameter optimization takes 0.421107 seconds.
    local lower bound updated to 0.655319
    local upper bound updated to 0.655319
The Primal step takes 6.94488 (S)
lower bound updated to 0.655319

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.69462
    local lower bound updated to 0.676482

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 5.27731 seconds.
    local lower bound updated to 0.553233
    local upper bound updated to 0.676482

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.45867 seconds.
    local lower bound updated to 0.648511
    local upper bound updated to 0.667656

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 0.496088 seconds.
    local lower bound updated to 0.65198
    local upper bound updated to 0.665464

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 0.635671 seconds.
    local lower bound updated to 0.658188
    local upper bound updated to 0.663833

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 0.666049 seconds.
    local lower bound updated to 0.658188
    local upper bound updated to 0.662535

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 0.540667 seconds.
    local lower bound updated to 0.658188
    local upper bound updated to 0.6591

    ++ RESTRICTED PRIMAL ITERATION 7 ++
One worst-case parameter optimization takes 0.568286 seconds.
    local lower bound updated to 0.658326
    local upper bound updated to 0.659043

    ++ RESTRICTED PRIMAL ITERATION 8 ++
One worst-case parameter optimization takes 0.683576 seconds.
    local lower bound updated to 0.658665
    local upper bound updated to 0.659033

    ++ RESTRICTED PRIMAL ITERATION 9 ++
One worst-case parameter optimization takes 0.805076 seconds.
    local lower bound updated to 0.658665
    local upper bound updated to 0.658872

    ++ RESTRICTED PRIMAL ITERATION 10 ++
One worst-case parameter optimization takes 0.581749 seconds.
    local lower bound updated to 0.658867
    local upper bound updated to 0.658871
The Primal step takes 10.739 (S)
lower bound updated to 0.658867

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.677937
    local lower bound updated to 0.658871

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.677074
    local lower bound updated to 0.659145

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.677074
    local lower bound updated to 0.659501

    ++ RESTRICTED DUAL ITERATION 4 ++
    local upper bound updated to 0.667017
    local lower bound updated to 0.661274

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 9.047 seconds.
    local lower bound updated to 0.580009
    local upper bound updated to 0.661274

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 1.23674 seconds.
    local lower bound updated to 0.657358
    local upper bound updated to 0.660832

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 1.16933 seconds.
    local lower bound updated to 0.657358
    local upper bound updated to 0.660606

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 0.823815 seconds.
    local lower bound updated to 0.657358
    local upper bound updated to 0.660103

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 0.650001 seconds.
    local lower bound updated to 0.657358
    local upper bound updated to 0.660049

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.677749
    local lower bound updated to 0.660049

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 8.67912 seconds.
    local lower bound updated to 0.586007
    local upper bound updated to 0.660049

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.850407 seconds.
    local lower bound updated to 0.660049
    local upper bound updated to 0.660049
The time obtain the optimal randomized assortment is 45.5184 (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_100.000000_105014.log"
The computation time limit for a lower bound is 85953
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 1212 rows, 1058 columns and 3807 nonzeros
Model fingerprint: 0x84638774
Variable types: 1009 continuous, 49 integer (49 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 373 rows and 679 columns
Presolve time: 0.01s
Presolved: 839 rows, 379 columns, 3120 nonzeros
Variable types: 332 continuous, 47 integer (47 binary)
Found heuristic solution: objective 0.7813763
Found heuristic solution: objective 0.7545575

Root relaxation: objective 5.201568e-01, 138 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.52016    0   11    0.75456    0.52016  31.1%     -    0s
H    0     0                       0.6833377    0.52016  23.9%     -    0s
     0     0    0.55345    0   18    0.68334    0.55345  19.0%     -    0s
H    0     0                       0.6656604    0.57175  14.1%     -    0s
     0     0    0.57175    0   16    0.66566    0.57175  14.1%     -    0s
H    0     0                       0.6612987    0.57175  13.5%     -    0s
     0     0    0.57267    0   16    0.66130    0.57267  13.4%     -    0s
     0     0    0.58652    0   18    0.66130    0.58652  11.3%     -    0s
     0     0    0.58696    0   20    0.66130    0.58696  11.2%     -    0s
     0     0    0.59124    0   17    0.66130    0.59124  10.6%     -    0s
H    0     0                       0.6600492    0.59124  10.4%     -    0s
     0     0    0.59210    0   16    0.66005    0.59210  10.3%     -    0s
     0     0    0.59275    0   17    0.66005    0.59275  10.2%     -    0s
     0     2    0.59275    0   17    0.66005    0.59275  10.2%     -    0s

Cutting planes:
  Implied bound: 101
  MIR: 21
  Flow cover: 53
  RLT: 6
  Relax-and-lift: 57

Explored 370 nodes (5464 simplex iterations) in 0.83 seconds (0.43 work units)
Thread count was 4 (of 40 available processors)

Solution count 6: 0.660049 0.661299 0.66566 ... 0.781376

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

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

        Job resource usage summary 

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

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