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 1.04274 seconds.
    local lower bound updated to 0.294163
    local upper bound updated to 0.564275

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

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 11.1115 seconds.
    local lower bound updated to 0.384802
    local upper bound updated to 0.573859

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 11.8251 seconds.
    local lower bound updated to 0.566249
    local upper bound updated to 0.566609

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 5.70343 seconds.
    local lower bound updated to 0.566249
    local upper bound updated to 0.566416

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.594403
    local lower bound updated to 0.578089

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.585034
    local lower bound updated to 0.583003

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 48.9513 seconds.
    local lower bound updated to 0.463246
    local upper bound updated to 0.583003

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 5.0678 seconds.
    local lower bound updated to 0.505109
    local upper bound updated to 0.579632

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 18.867 seconds.
    local lower bound updated to 0.55388
    local upper bound updated to 0.577645

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 10.4108 seconds.
    local lower bound updated to 0.562977
    local upper bound updated to 0.573251

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 13.5359 seconds.
    local lower bound updated to 0.569547
    local upper bound updated to 0.570984

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 12.7767 seconds.
    local lower bound updated to 0.570787
    local upper bound updated to 0.570886

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.595229
    local lower bound updated to 0.572361

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.576521
    local lower bound updated to 0.572361

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 46.4396 seconds.
    local lower bound updated to 0.484491
    local upper bound updated to 0.572361

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 17.7934 seconds.
    local lower bound updated to 0.570069
    local upper bound updated to 0.572265

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 26.1738 seconds.
    local lower bound updated to 0.572084
    local upper bound updated to 0.572216

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 25.4396 seconds.
    local lower bound updated to 0.572084
    local upper bound updated to 0.572161

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 26.6341 seconds.
    local lower bound updated to 0.572084
    local upper bound updated to 0.57214

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 29.0494 seconds.
    local lower bound updated to 0.57211
    local upper bound updated to 0.572135

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.586893
    local lower bound updated to 0.572135

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.575524
    local lower bound updated to 0.572146

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 47.0434 seconds.
    local lower bound updated to 0.493437
    local upper bound updated to 0.572146

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 35.8054 seconds.
    local lower bound updated to 0.572032
    local upper bound updated to 0.572135

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.585784
    local lower bound updated to 0.572135

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 46.9101 seconds.
    local lower bound updated to 0.493437
    local upper bound updated to 0.572135

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 32.0144 seconds.
    local lower bound updated to 0.572135
    local upper bound updated to 0.572135
The time obtain the optimal randomized assortment is 553.253 (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_17_4_200.000000_201918.log"
The computation time limit for a lower bound is 85433
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 1634 rows, 1250 columns and 5382 nonzeros
Model fingerprint: 0x9e596e50
Variable types: 1185 continuous, 65 integer (65 binary)
Coefficient statistics:
  Matrix range     [1e-06, 1e+00]
  Objective range  [1e+00, 1e+00]
  Bounds range     [1e+00, 1e+00]
  RHS range        [6e-01, 1e+00]
Presolve removed 365 rows and 659 columns
Presolve time: 0.01s
Presolved: 1269 rows, 591 columns, 4982 nonzeros
Variable types: 529 continuous, 62 integer (62 binary)
Found heuristic solution: objective 0.7040766
Found heuristic solution: objective 0.6839174

Root relaxation: objective 3.692758e-01, 154 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.36928    0   20    0.68392    0.36928  46.0%     -    0s
H    0     0                       0.6430421    0.36928  42.6%     -    0s
H    0     0                       0.6246120    0.37563  39.9%     -    0s
     0     0    0.37563    0   26    0.62461    0.37563  39.9%     -    0s
H    0     0                       0.6166774    0.37563  39.1%     -    0s
H    0     0                       0.6022050    0.37563  37.6%     -    0s
     0     0    0.44513    0   27    0.60221    0.44513  26.1%     -    0s
H    0     0                       0.5880447    0.44513  24.3%     -    0s
     0     0    0.44540    0   27    0.58804    0.44540  24.3%     -    0s
H    0     0                       0.5879079    0.45464  22.7%     -    0s
     0     0    0.45464    0   27    0.58791    0.45464  22.7%     -    0s
H    0     0                       0.5877787    0.45666  22.3%     -    0s
H    0     0                       0.5868887    0.45666  22.2%     -    0s
     0     0    0.45666    0   31    0.58689    0.45666  22.2%     -    0s
     0     0    0.47556    0   28    0.58689    0.47556  19.0%     -    0s
H    0     0                       0.5790567    0.47556  17.9%     -    0s
     0     0    0.47811    0   26    0.57906    0.47811  17.4%     -    0s
     0     0    0.48008    0   26    0.57906    0.48008  17.1%     -    0s
H    0     0                       0.5721354    0.48008  16.1%     -    1s
     0     2    0.48008    0   26    0.57214    0.48008  16.1%     -    1s
   897   420    0.55119   12   17    0.57214    0.50558  11.6%  20.5    5s
H 2857   913                       0.5721354    0.51818  9.43%  18.9    8s
  3154   969    0.54703   11   26    0.57214    0.51884  9.32%  18.8   10s
H 4400   945                       0.5721354    0.52886  7.56%  19.7   14s
  4585   932     cutoff   31         0.57214    0.53012  7.34%  19.6   15s
  7177   708    0.55042   29   15    0.57214    0.54102  5.44%  19.2   20s
  9717   636    0.55729   29   13    0.57214    0.54965  3.93%  19.1   25s
 12574   125     cutoff   28         0.57214    0.56086  1.97%  18.8   30s

Cutting planes:
  Implied bound: 134
  MIR: 73
  Flow cover: 234
  RLT: 25
  Relax-and-lift: 39

Explored 12955 nodes (243061 simplex iterations) in 30.46 seconds (24.24 work units)
Thread count was 4 (of 48 available processors)

Solution count 10: 0.572135 0.572135 0.579057 ... 0.624612

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

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

        Job resource usage summary 

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

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