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 2.27952 seconds.
    local lower bound updated to 0.213171
    local upper bound updated to 0.388867

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.458752
    local lower bound updated to 0.406436

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.456615
    local lower bound updated to 0.453722

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 5.85509 seconds.
    local lower bound updated to 0.29502
    local upper bound updated to 0.388831

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 1.58099 seconds.
    local lower bound updated to 0.377492
    local upper bound updated to 0.387423

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 1.77409 seconds.
    local lower bound updated to 0.384098
    local upper bound updated to 0.384359

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.440787
    local lower bound updated to 0.423198

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.427687
    local lower bound updated to 0.42397

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.426662
    local lower bound updated to 0.425719

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 20.3264 seconds.
    local lower bound updated to 0.335693
    local upper bound updated to 0.396682

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 5.88324 seconds.
    local lower bound updated to 0.387278
    local upper bound updated to 0.394359

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 6.74665 seconds.
    local lower bound updated to 0.387278
    local upper bound updated to 0.392694

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 11.7145 seconds.
    local lower bound updated to 0.387278
    local upper bound updated to 0.391559

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 14.6298 seconds.
    local lower bound updated to 0.390605
    local upper bound updated to 0.391301

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 15.7595 seconds.
    local lower bound updated to 0.390831
    local upper bound updated to 0.391236

    ++ RESTRICTED PRIMAL ITERATION 7 ++
One worst-case parameter optimization takes 19.2857 seconds.
    local lower bound updated to 0.39112
    local upper bound updated to 0.391176

    ++ RESTRICTED PRIMAL ITERATION 8 ++
One worst-case parameter optimization takes 21.5705 seconds.
    local lower bound updated to 0.391176
    local upper bound updated to 0.391176
The Primal step takes 115.942 (S)
lower bound updated to 0.391176

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.411775
    local lower bound updated to 0.396231

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.408748
    local lower bound updated to 0.400951

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 37.9113 seconds.
    local lower bound updated to 0.350394
    local upper bound updated to 0.395989

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 3.38224 seconds.
    local lower bound updated to 0.380121
    local upper bound updated to 0.394561

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 9.29902 seconds.
    local lower bound updated to 0.388524
    local upper bound updated to 0.393948

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 7.13519 seconds.
    local lower bound updated to 0.389484
    local upper bound updated to 0.393681

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 15.4921 seconds.
    local lower bound updated to 0.390262
    local upper bound updated to 0.393308

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 11.6054 seconds.
    local lower bound updated to 0.390262
    local upper bound updated to 0.393159

    ++ RESTRICTED PRIMAL ITERATION 7 ++
One worst-case parameter optimization takes 12.4067 seconds.
    local lower bound updated to 0.390262
    local upper bound updated to 0.393143

    ++ RESTRICTED PRIMAL ITERATION 8 ++
One worst-case parameter optimization takes 23.9008 seconds.
    local lower bound updated to 0.391904
    local upper bound updated to 0.392907

    ++ RESTRICTED PRIMAL ITERATION 9 ++
One worst-case parameter optimization takes 13.8071 seconds.
    local lower bound updated to 0.39223
    local upper bound updated to 0.392885

    ++ RESTRICTED PRIMAL ITERATION 10 ++
One worst-case parameter optimization takes 20.3743 seconds.
    local lower bound updated to 0.392606
    local upper bound updated to 0.392874

    ++ RESTRICTED PRIMAL ITERATION 11 ++
One worst-case parameter optimization takes 20.424 seconds.
    local lower bound updated to 0.392606
    local upper bound updated to 0.39287

    ++ RESTRICTED PRIMAL ITERATION 12 ++
One worst-case parameter optimization takes 26.5783 seconds.
    local lower bound updated to 0.392809
    local upper bound updated to 0.392868

    ++ RESTRICTED PRIMAL ITERATION 13 ++
One worst-case parameter optimization takes 28.8513 seconds.
    local lower bound updated to 0.392868
    local upper bound updated to 0.392868
The Primal step takes 231.22 (S)
lower bound updated to 0.392868

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.403312
    local lower bound updated to 0.392868

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.403312
    local lower bound updated to 0.392868

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.401101
    local lower bound updated to 0.394959

    ++ RESTRICTED DUAL ITERATION 4 ++
    local upper bound updated to 0.396433
    local lower bound updated to 0.395008

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 50.0294 seconds.
    local lower bound updated to 0.354439
    local upper bound updated to 0.395008

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 27.5658 seconds.
    local lower bound updated to 0.393862
    local upper bound updated to 0.394972

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 33.8607 seconds.
    local lower bound updated to 0.394415
    local upper bound updated to 0.394874

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 36.2379 seconds.
    local lower bound updated to 0.394815
    local upper bound updated to 0.394871

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.403347
    local lower bound updated to 0.394871

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 49.4072 seconds.
    local lower bound updated to 0.354439
    local upper bound updated to 0.394871

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 37.9179 seconds.
    local lower bound updated to 0.394871
    local upper bound updated to 0.394871
The time obtain the optimal randomized assortment is 651.361 (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_208118.log"
The computation time limit for a lower bound is 85344
The model output flag is 1
Gurobi Optimizer version 9.5.1 build v9.5.1rc2 (linux64)
Thread count: 128 physical cores, 256 logical processors, using up to 4 threads
Optimize a model with 2604 rows, 1990 columns and 8543 nonzeros
Model fingerprint: 0x13667914
Variable types: 1925 continuous, 65 integer (65 binary)
Coefficient statistics:
  Matrix range     [5e-06, 1e+00]
  Objective range  [1e+00, 1e+00]
  Bounds range     [1e+00, 1e+00]
  RHS range        [4e-01, 1e+00]
Presolve removed 595 rows and 1079 columns
Presolve time: 0.02s
Presolved: 2009 rows, 911 columns, 7784 nonzeros
Variable types: 848 continuous, 63 integer (63 binary)
Found heuristic solution: objective 0.5282561
Found heuristic solution: objective 0.5121014

Root relaxation: objective 2.886973e-01, 254 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.28870    0   25    0.51210    0.28870  43.6%     -    0s
H    0     0                       0.4783414    0.29160  39.0%     -    0s
H    0     0                       0.4582024    0.29160  36.4%     -    0s
     0     0    0.29160    0   29    0.45820    0.29160  36.4%     -    0s
     0     0    0.31923    0   31    0.45820    0.31923  30.3%     -    0s
H    0     0                       0.3995867    0.31923  20.1%     -    0s
     0     0    0.31956    0   32    0.39959    0.31956  20.0%     -    0s
     0     0    0.33017    0   34    0.39959    0.33017  17.4%     -    0s
     0     0    0.33127    0   32    0.39959    0.33127  17.1%     -    0s
     0     0    0.33645    0   33    0.39959    0.33645  15.8%     -    0s
H    0     0                       0.3987761    0.33645  15.6%     -    0s
     0     0    0.33674    0   33    0.39878    0.33674  15.6%     -    0s
     0     0    0.33815    0   30    0.39878    0.33815  15.2%     -    0s
H    0     0                       0.3948713    0.33815  14.4%     -    1s
     0     2    0.33815    0   30    0.39487    0.33815  14.4%     -    1s
   499   225    0.38312    9   18    0.39487    0.36011  8.80%  24.6    5s
  1785   519    0.38613   12   14    0.39487    0.36871  6.63%  21.5   10s
  2591   617    0.38087   13   10    0.39487    0.37253  5.66%  20.7   15s
  4625   746    0.38429   13   12    0.39487    0.37854  4.14%  20.1   20s
H 6241   725                       0.3948713    0.38132  3.43%  19.6   24s
  6341   731    0.39355   16   12    0.39487    0.38191  3.28%  19.5   26s
  7943   570    0.39257   14   12    0.39487    0.38501  2.50%  18.8   30s
  9410   232    0.39436   17   12    0.39487    0.38803  1.73%  18.3   35s

Cutting planes:
  Gomory: 2
  Implied bound: 312
  MIR: 88
  Flow cover: 288
  RLT: 34
  Relax-and-lift: 132

Explored 10319 nodes (186648 simplex iterations) in 35.90 seconds (28.89 work units)
Thread count was 4 (of 256 available processors)

Solution count 8: 0.394871 0.394871 0.398776 ... 0.528256

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

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

        Job resource usage summary 

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

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