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.158457 seconds.
    local lower bound updated to 0.196356
    local upper bound updated to 0.383851

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

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.66171 seconds.
    local lower bound updated to 0.271696
    local upper bound updated to 0.41239

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.28452 seconds.
    local lower bound updated to 0.384483
    local upper bound updated to 0.401404

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 0.224782 seconds.
    local lower bound updated to 0.391397
    local upper bound updated to 0.392897

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 0.250294 seconds.
    local lower bound updated to 0.391397
    local upper bound updated to 0.392091

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 0.249809 seconds.
    local lower bound updated to 0.392091
    local upper bound updated to 0.392091
The Primal step takes 1.68072 (S)
lower bound updated to 0.392091

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.430659
    local lower bound updated to 0.412755

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.415498
    local lower bound updated to 0.413756

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.835668 seconds.
    local lower bound updated to 0.322368
    local upper bound updated to 0.400373

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.636659 seconds.
    local lower bound updated to 0.397512
    local upper bound updated to 0.398611

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 0.469949 seconds.
    local lower bound updated to 0.397793
    local upper bound updated to 0.398424

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 0.521187 seconds.
    local lower bound updated to 0.397793
    local upper bound updated to 0.398284

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 0.534511 seconds.
    local lower bound updated to 0.398284
    local upper bound updated to 0.398284
The Primal step takes 3.01022 (S)
lower bound updated to 0.398284

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.419531
    local lower bound updated to 0.398284

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.409022
    local lower bound updated to 0.399512

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.403711
    local lower bound updated to 0.402937

    ++ RESTRICTED DUAL ITERATION 4 ++
    local upper bound updated to 0.403711
    local lower bound updated to 0.403121

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.996484 seconds.
    local lower bound updated to 0.35101
    local upper bound updated to 0.403121

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.596517 seconds.
    local lower bound updated to 0.35101
    local upper bound updated to 0.402094

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 1.5248 seconds.
    local lower bound updated to 0.398483
    local upper bound updated to 0.401525

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 1.35271 seconds.
    local lower bound updated to 0.400822
    local upper bound updated to 0.40151

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 1.09004 seconds.
    local lower bound updated to 0.401266
    local upper bound updated to 0.401474

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 1.4891 seconds.
    local lower bound updated to 0.401282
    local upper bound updated to 0.401404

    ++ RESTRICTED PRIMAL ITERATION 7 ++
One worst-case parameter optimization takes 1.76425 seconds.
    local lower bound updated to 0.401342
    local upper bound updated to 0.401393

    ++ RESTRICTED PRIMAL ITERATION 8 ++
One worst-case parameter optimization takes 1.21799 seconds.
    local lower bound updated to 0.401377
    local upper bound updated to 0.401391

    ++ RESTRICTED PRIMAL ITERATION 9 ++
One worst-case parameter optimization takes 1.14027 seconds.
    local lower bound updated to 0.401391
    local upper bound updated to 0.401391
The Primal step takes 11.2038 (S)
lower bound updated to 0.401391

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.422054
    local lower bound updated to 0.401391

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.404642
    local lower bound updated to 0.40146

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.404642
    local lower bound updated to 0.401618

    ++ RESTRICTED DUAL ITERATION 4 ++
    local upper bound updated to 0.402579
    local lower bound updated to 0.401661

    ++ RESTRICTED DUAL ITERATION 5 ++
    local upper bound updated to 0.401661
    local lower bound updated to 0.401661
The Dual step takes 1.2734 (S)
upper bound updated to 0.401661
*** OUTER ITERATION 4 ***

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 1.69415 seconds.
    local lower bound updated to 0.364872
    local upper bound updated to 0.401661

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 2.2193 seconds.
    local lower bound updated to 0.40001
    local upper bound updated to 0.401583

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 2.38341 seconds.
    local lower bound updated to 0.401109
    local upper bound updated to 0.401543

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 1.69924 seconds.
    local lower bound updated to 0.401405
    local upper bound updated to 0.401541

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 1.91614 seconds.
    local lower bound updated to 0.401423
    local upper bound updated to 0.40151

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 2.34175 seconds.
    local lower bound updated to 0.40149
    local upper bound updated to 0.40151

    ++ RESTRICTED PRIMAL ITERATION 7 ++
One worst-case parameter optimization takes 1.53523 seconds.
    local lower bound updated to 0.401505
    local upper bound updated to 0.401509
The Primal step takes 13.8244 (S)
lower bound updated to 0.401505

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.422632
    local lower bound updated to 0.401509

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 1.66436 seconds.
    local lower bound updated to 0.364872
    local upper bound updated to 0.401509

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 1.88112 seconds.
    local lower bound updated to 0.401509
    local upper bound updated to 0.401509
The time obtain the optimal randomized assortment is 36.405 (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_60.000000_63414.log"
The computation time limit for a lower bound is 85961
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 1464 rows, 1282 columns and 4555 nonzeros
Model fingerprint: 0xd00a1401
Variable types: 1233 continuous, 49 integer (49 binary)
Coefficient statistics:
  Matrix range     [2e-03, 1e+00]
  Objective range  [1e+00, 1e+00]
  Bounds range     [1e+00, 1e+00]
  RHS range        [4e-01, 1e+00]
Presolve removed 493 rows and 849 columns
Presolve time: 0.01s
Presolved: 971 rows, 433 columns, 3694 nonzeros
Variable types: 386 continuous, 47 integer (47 binary)
Found heuristic solution: objective 0.5846343
Found heuristic solution: objective 0.4888086
Found heuristic solution: objective 0.4224525

Root relaxation: objective 1.221933e-01, 111 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.12219    0   24    0.42245    0.12219  71.1%     -    3s
     0     0    0.18812    0   24    0.42245    0.18812  55.5%     -    3s
     0     0    0.23975    0   25    0.42245    0.23975  43.2%     -    3s
H    0     0                       0.4072351    0.23975  41.1%     -    3s
     0     0    0.23978    0   25    0.40724    0.23978  41.1%     -    3s
     0     0    0.26026    0   23    0.40724    0.26026  36.1%     -    3s
     0     0    0.26264    0   23    0.40724    0.26264  35.5%     -    3s
     0     0    0.27245    0   25    0.40724    0.27245  33.1%     -    3s
H    0     0                       0.4015139    0.27957  30.4%     -    3s
     0     0    0.27957    0   25    0.40151    0.27957  30.4%     -    3s
     0     0    0.28146    0   25    0.40151    0.28146  29.9%     -    5s
H    0     0                       0.4015094    0.28146  29.9%     -    6s
     0     2    0.28146    0   25    0.40151    0.28146  29.9%     -    6s

Cutting planes:
  Gomory: 2
  Implied bound: 138
  MIR: 41
  Flow cover: 134
  RLT: 1
  Relax-and-lift: 54

Explored 1260 nodes (17265 simplex iterations) in 7.75 seconds (1.47 work units)
Thread count was 4 (of 48 available processors)

Solution count 6: 0.401509 0.401514 0.407235 ... 0.584634

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

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

        Job resource usage summary 

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

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