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.413668 seconds.
    local lower bound updated to 0.285162
    local upper bound updated to 0.560845

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.620752
    local lower bound updated to 0.608727

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 5.05597 seconds.
    local lower bound updated to 0.378319
    local upper bound updated to 0.574677

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 2.67857 seconds.
    local lower bound updated to 0.564529
    local upper bound updated to 0.566339

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 1.08057 seconds.
    local lower bound updated to 0.564529
    local upper bound updated to 0.564822

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.592423
    local lower bound updated to 0.583052

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.592423
    local lower bound updated to 0.583873

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.592423
    local lower bound updated to 0.589582

    ++ RESTRICTED DUAL ITERATION 4 ++
    local upper bound updated to 0.590994
    local lower bound updated to 0.589783

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 19.0141 seconds.
    local lower bound updated to 0.465177
    local upper bound updated to 0.578669

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 11.4944 seconds.
    local lower bound updated to 0.563028
    local upper bound updated to 0.576114

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 19.5954 seconds.
    local lower bound updated to 0.564532
    local upper bound updated to 0.574924

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 25.2667 seconds.
    local lower bound updated to 0.568293
    local upper bound updated to 0.573234

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 8.39872 seconds.
    local lower bound updated to 0.568293
    local upper bound updated to 0.57251

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 18.6599 seconds.
    local lower bound updated to 0.569853
    local upper bound updated to 0.571693

    ++ RESTRICTED PRIMAL ITERATION 7 ++
One worst-case parameter optimization takes 14.0901 seconds.
    local lower bound updated to 0.570566
    local upper bound updated to 0.57152

    ++ RESTRICTED PRIMAL ITERATION 8 ++
One worst-case parameter optimization takes 16.5095 seconds.
    local lower bound updated to 0.570952
    local upper bound updated to 0.571494

    ++ RESTRICTED PRIMAL ITERATION 9 ++
One worst-case parameter optimization takes 17.6923 seconds.
    local lower bound updated to 0.571134
    local upper bound updated to 0.571401

    ++ RESTRICTED PRIMAL ITERATION 10 ++
One worst-case parameter optimization takes 14.0137 seconds.
    local lower bound updated to 0.571134
    local upper bound updated to 0.571396

    ++ RESTRICTED PRIMAL ITERATION 11 ++
One worst-case parameter optimization takes 12.5204 seconds.
    local lower bound updated to 0.571202
    local upper bound updated to 0.571277

    ++ RESTRICTED PRIMAL ITERATION 12 ++
One worst-case parameter optimization takes 16.7077 seconds.
    local lower bound updated to 0.571277
    local upper bound updated to 0.571277
The Primal step takes 194.012 (S)
lower bound updated to 0.571277

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.581398
    local lower bound updated to 0.571277

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.581398
    local lower bound updated to 0.571329

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.581398
    local lower bound updated to 0.572793

    ++ RESTRICTED DUAL ITERATION 4 ++
    local upper bound updated to 0.578471
    local lower bound updated to 0.574052

    ++ RESTRICTED DUAL ITERATION 5 ++
    local upper bound updated to 0.575095
    local lower bound updated to 0.574136

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 77.2415 seconds.
    local lower bound updated to 0.502465
    local upper bound updated to 0.573948

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 47.7196 seconds.
    local lower bound updated to 0.572398
    local upper bound updated to 0.573745

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 44.8794 seconds.
    local lower bound updated to 0.572398
    local upper bound updated to 0.573557

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 38.4363 seconds.
    local lower bound updated to 0.572398
    local upper bound updated to 0.57354

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 58.723 seconds.
    local lower bound updated to 0.572405
    local upper bound updated to 0.573288

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 44.8009 seconds.
    local lower bound updated to 0.572547
    local upper bound updated to 0.573182

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.583384
    local lower bound updated to 0.573182

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.578265
    local lower bound updated to 0.573719

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.573931
    local lower bound updated to 0.573719

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 98.8132 seconds.
    local lower bound updated to 0.513588
    local upper bound updated to 0.573719

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 50.9029 seconds.
    local lower bound updated to 0.572936
    local upper bound updated to 0.57364

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 58.9407 seconds.
    local lower bound updated to 0.573122
    local upper bound updated to 0.573628

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 49.9828 seconds.
    local lower bound updated to 0.573549
    local upper bound updated to 0.573622

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.583026
    local lower bound updated to 0.573622

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 96.7682 seconds.
    local lower bound updated to 0.513588
    local upper bound updated to 0.573622

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 52.8405 seconds.
    local lower bound updated to 0.573622
    local upper bound updated to 0.573622
The time obtain the optimal randomized assortment is 1037.75 (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_202818.log"
The computation time limit for a lower bound is 84959
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 2604 rows, 1990 columns and 8573 nonzeros
Model fingerprint: 0x87353042
Variable types: 1925 continuous, 65 integer (65 binary)
Coefficient statistics:
  Matrix range     [4e-04, 1e+00]
  Objective range  [1e+00, 1e+00]
  Bounds range     [1e+00, 1e+00]
  RHS range        [3e-01, 1e+00]
Presolve removed 614 rows and 1082 columns
Presolve time: 0.03s
Presolved: 1990 rows, 908 columns, 7738 nonzeros
Variable types: 845 continuous, 63 integer (63 binary)
Found heuristic solution: objective 0.7069813
Found heuristic solution: objective 0.6731763
Found heuristic solution: objective 0.6502107

Root relaxation: objective 3.919801e-01, 248 iterations, 0.01 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.39198    0   16    0.65021    0.39198  39.7%     -    0s
     0     0    0.40403    0   29    0.65021    0.40403  37.9%     -    0s
H    0     0                       0.6310033    0.46242  26.7%     -    0s
     0     0    0.46243    0   32    0.63100    0.46243  26.7%     -    0s
H    0     0                       0.6186957    0.46243  25.3%     -    0s
     0     0    0.46289    0   31    0.61870    0.46289  25.2%     -    0s
H    0     0                       0.6126072    0.48674  20.5%     -    0s
H    0     0                       0.6069005    0.48674  19.8%     -    0s
     0     0    0.48674    0   28    0.60690    0.48674  19.8%     -    0s
H    0     0                       0.5926010    0.48674  17.9%     -    0s
     0     0    0.48710    0   26    0.59260    0.48710  17.8%     -    0s
H    0     0                       0.5911297    0.48710  17.6%     -    0s
H    0     0                       0.5885005    0.48710  17.2%     -    0s
     0     0    0.49504    0   29    0.58850    0.49504  15.9%     -    0s
     0     0    0.49624    0   29    0.58850    0.49624  15.7%     -    0s
H    0     0                       0.5849111    0.49624  15.2%     -    0s
     0     0    0.49892    0   28    0.58491    0.49892  14.7%     -    0s
H    0     0                       0.5770972    0.49892  13.5%     -    2s
     0     2    0.49892    0   28    0.57710    0.49892  13.5%     -    3s
H   58    49                       0.5736217    0.50275  12.4%  49.8    3s
  1017   254    0.55023    7   15    0.57362    0.53112  7.41%  29.3    5s
  2991   479    0.57053   11   18    0.57362    0.54324  5.30%  26.8   10s
  4279   608    0.57076   14    6    0.57362    0.54765  4.53%  25.3   15s
  5316   655     cutoff   16         0.57362    0.55037  4.05%  24.4   20s
  6346   708    0.56066   15   26    0.57362    0.55243  3.69%  23.8   26s
  7387   601    0.56647   24   12    0.57362    0.55243  3.69%  25.5   30s
  8570   356    0.56188   26   18    0.57362    0.55243  3.69%  26.0   35s
  9774   370    0.56797   31   14    0.57362    0.55536  3.18%  26.1   40s
 10641   351     cutoff   29         0.57362    0.55854  2.63%  26.0   45s
 12197   230     cutoff   35         0.57362    0.56403  1.67%  25.8   50s

Cutting planes:
  Implied bound: 234
  MIR: 95
  Flow cover: 371
  RLT: 45
  Relax-and-lift: 80

Explored 13169 nodes (333778 simplex iterations) in 52.71 seconds (33.45 work units)
Thread count was 4 (of 40 available processors)

Solution count 10: 0.573622 0.577097 0.584911 ... 0.631003

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

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

        Job resource usage summary 

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

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