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.129652 seconds.
    local lower bound updated to 0.331556
    local upper bound updated to 0.634588

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.730733
    local lower bound updated to 0.695243

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.780185 seconds.
    local lower bound updated to 0.466807
    local upper bound updated to 0.655537

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.69551 seconds.
    local lower bound updated to 0.617914
    local upper bound updated to 0.644701

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 0.741753 seconds.
    local lower bound updated to 0.635903
    local upper bound updated to 0.637597

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 0.848354 seconds.
    local lower bound updated to 0.636639
    local upper bound updated to 0.6369

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.693106
    local lower bound updated to 0.674654

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.679706
    local lower bound updated to 0.675571

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 1.72712 seconds.
    local lower bound updated to 0.528247
    local upper bound updated to 0.657679

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.773787 seconds.
    local lower bound updated to 0.633172
    local upper bound updated to 0.645728

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 1.70483 seconds.
    local lower bound updated to 0.644219
    local upper bound updated to 0.645609

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 1.86193 seconds.
    local lower bound updated to 0.64422
    local upper bound updated to 0.645272

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 1.87504 seconds.
    local lower bound updated to 0.645034
    local upper bound updated to 0.645189

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 1.7749 seconds.
    local lower bound updated to 0.645174
    local upper bound updated to 0.645187

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.677459
    local lower bound updated to 0.648171

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.670536
    local lower bound updated to 0.652261

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.653203
    local lower bound updated to 0.652284

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 2.2215 seconds.
    local lower bound updated to 0.5604
    local upper bound updated to 0.651322

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.541177 seconds.
    local lower bound updated to 0.629893
    local upper bound updated to 0.648646

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 1.05274 seconds.
    local lower bound updated to 0.636713
    local upper bound updated to 0.646957

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 3.02087 seconds.
    local lower bound updated to 0.644127
    local upper bound updated to 0.646119

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 2.93261 seconds.
    local lower bound updated to 0.6453
    local upper bound updated to 0.646083

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.660157
    local lower bound updated to 0.646083

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 2.18829 seconds.
    local lower bound updated to 0.5604
    local upper bound updated to 0.646083

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 2.7578 seconds.
    local lower bound updated to 0.646083
    local upper bound updated to 0.646083
The time obtain the optimal randomized assortment is 35.0784 (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_200.000000_205714.log"
The computation time limit for a lower bound is 85963
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 3736 nonzeros
Model fingerprint: 0x1d2add04
Variable types: 1009 continuous, 49 integer (49 binary)
Coefficient statistics:
  Matrix range     [5e-03, 1e+00]
  Objective range  [1e+00, 1e+00]
  Bounds range     [1e+00, 1e+00]
  RHS range        [2e-01, 1e+00]
Presolve removed 399 rows and 689 columns
Presolve time: 0.01s
Presolved: 813 rows, 369 columns, 3012 nonzeros
Variable types: 323 continuous, 46 integer (46 binary)
Found heuristic solution: objective 0.6917778

Root relaxation: objective 4.562426e-01, 118 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.45624    0   13    0.69178    0.45624  34.0%     -    0s
H    0     0                       0.6740560    0.45624  32.3%     -    0s
     0     0    0.48500    0   18    0.67406    0.48500  28.0%     -    0s
H    0     0                       0.6734860    0.48500  28.0%     -    0s
     0     0    0.48500    0   18    0.67349    0.48500  28.0%     -    0s
H    0     0                       0.6707848    0.48500  27.7%     -    0s
H    0     0                       0.6606891    0.51816  21.6%     -    0s
     0     0    0.51816    0   20    0.66069    0.51816  21.6%     -    0s
     0     0    0.52019    0   21    0.66069    0.52019  21.3%     -    0s
H    0     0                       0.6485297    0.54443  16.1%     -    0s
     0     0    0.54443    0   19    0.64853    0.54443  16.1%     -    0s
H    0     0                       0.6460832    0.54443  15.7%     -    0s
     0     0    0.54627    0   21    0.64608    0.54627  15.4%     -    0s
     0     0    0.55419    0   23    0.64608    0.55419  14.2%     -    0s
     0     0    0.55469    0   23    0.64608    0.55469  14.1%     -    0s
     0     0    0.55604    0   20    0.64608    0.55604  13.9%     -    0s
     0     2    0.55604    0   20    0.64608    0.55604  13.9%     -    0s

Cutting planes:
  Implied bound: 119
  MIR: 66
  Flow cover: 115
  RLT: 7
  Relax-and-lift: 67

Explored 2916 nodes (38920 simplex iterations) in 2.20 seconds (1.50 work units)
Thread count was 4 (of 40 available processors)

Solution count 7: 0.646083 0.64853 0.660689 ... 0.691778

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

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

        Job resource usage summary 

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

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