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.569256 seconds.
    local lower bound updated to 0.28784
    local upper bound updated to 0.468084

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.501598
    local lower bound updated to 0.493907

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.498465
    local lower bound updated to 0.496765

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.606743 seconds.
    local lower bound updated to 0.362716
    local upper bound updated to 0.474384

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.625687 seconds.
    local lower bound updated to 0.472461
    local upper bound updated to 0.474242

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 0.611396 seconds.
    local lower bound updated to 0.472461
    local upper bound updated to 0.473504

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 0.602636 seconds.
    local lower bound updated to 0.472693
    local upper bound updated to 0.473058

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 0.624262 seconds.
    local lower bound updated to 0.472693
    local upper bound updated to 0.472818

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.499314
    local lower bound updated to 0.474312

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.485998
    local lower bound updated to 0.481211

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.485998
    local lower bound updated to 0.481958

    ++ RESTRICTED DUAL ITERATION 4 ++
    local upper bound updated to 0.485998
    local lower bound updated to 0.482628

    ++ RESTRICTED DUAL ITERATION 5 ++
    local upper bound updated to 0.48494
    local lower bound updated to 0.482649

    ++ RESTRICTED DUAL ITERATION 6 ++
    local upper bound updated to 0.482649
    local lower bound updated to 0.482649
The Dual step takes 1.89713 (S)
upper bound updated to 0.482649
*** OUTER ITERATION 2 ***

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 1.39391 seconds.
    local lower bound updated to 0.415742
    local upper bound updated to 0.482649

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 1.99266 seconds.
    local lower bound updated to 0.470135
    local upper bound updated to 0.479844

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 2.11418 seconds.
    local lower bound updated to 0.476082
    local upper bound updated to 0.47959

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 2.83366 seconds.
    local lower bound updated to 0.478555
    local upper bound updated to 0.479236

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 1.82388 seconds.
    local lower bound updated to 0.478649
    local upper bound updated to 0.479203

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.486046
    local lower bound updated to 0.479838

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 1.68118 seconds.
    local lower bound updated to 0.420752
    local upper bound updated to 0.479838

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 3.0125 seconds.
    local lower bound updated to 0.478836
    local upper bound updated to 0.479568

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.48635
    local lower bound updated to 0.479568

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.482842
    local lower bound updated to 0.479624

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.479714
    local lower bound updated to 0.479626

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 1.67673 seconds.
    local lower bound updated to 0.418023
    local upper bound updated to 0.479626

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 5.81719 seconds.
    local lower bound updated to 0.478711
    local upper bound updated to 0.479568

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.487859
    local lower bound updated to 0.479568

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 1.3323 seconds.
    local lower bound updated to 0.418023
    local upper bound updated to 0.479568

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 5.2408 seconds.
    local lower bound updated to 0.479568
    local upper bound updated to 0.479568
The time obtain the optimal randomized assortment is 58.984 (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_15_4_100.000000_106916.log"
The computation time limit for a lower bound is 85939
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 2000 rows, 1618 columns and 6407 nonzeros
Model fingerprint: 0x7443cf6b
Variable types: 1561 continuous, 57 integer (57 binary)
Coefficient statistics:
  Matrix range     [1e-03, 1e+00]
  Objective range  [1e+00, 1e+00]
  Bounds range     [1e+00, 1e+00]
  RHS range        [4e-01, 1e+00]
Presolve removed 526 rows and 980 columns
Presolve time: 0.02s
Presolved: 1474 rows, 638 columns, 5735 nonzeros
Variable types: 584 continuous, 54 integer (54 binary)
Found heuristic solution: objective 0.5923781
Found heuristic solution: objective 0.5367245

Root relaxation: objective 3.622817e-01, 223 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.36228    0   22    0.53672    0.36228  32.5%     -    0s
H    0     0                       0.5222274    0.36228  30.6%     -    0s
H    0     0                       0.5162544    0.36266  29.8%     -    0s
H    0     0                       0.5101259    0.36266  28.9%     -    0s
     0     0    0.38011    0   24    0.51013    0.38011  25.5%     -    0s
     0     0    0.40565    0   27    0.51013    0.40565  20.5%     -    0s
H    0     0                       0.5093559    0.40565  20.4%     -    0s
     0     0    0.40746    0   25    0.50936    0.40746  20.0%     -    0s
H    0     0                       0.5027959    0.42429  15.6%     -    0s
H    0     0                       0.4902603    0.42429  13.5%     -    0s
     0     0    0.42429    0   24    0.49026    0.42429  13.5%     -    0s
     0     0    0.42502    0   24    0.49026    0.42502  13.3%     -    0s
     0     0    0.42917    0   24    0.49026    0.42917  12.5%     -    0s
     0     0    0.42983    0   24    0.49026    0.42983  12.3%     -    0s
     0     0    0.43078    0   27    0.49026    0.43078  12.1%     -    0s
H    0     0                       0.4868044    0.43078  11.5%     -    0s
H    0     0                       0.4795678    0.43078  10.2%     -    1s
     0     2    0.43078    0   27    0.47957    0.43078  10.2%     -    1s
H  329    92                       0.4795678    0.45116  5.92%  31.1    1s
H  463   115                       0.4795678    0.45450  5.23%  28.6    1s
H  836   162                       0.4795678    0.46158  3.75%  26.6    2s
H 1536   129                       0.4795678    0.46813  2.39%  23.9    4s
  1961     7     cutoff   11         0.47957    0.47537  0.87%  22.7    5s

Cutting planes:
  Implied bound: 213
  MIR: 56
  Flow cover: 244
  RLT: 16
  Relax-and-lift: 76

Explored 1980 nodes (46633 simplex iterations) in 5.11 seconds (3.93 work units)
Thread count was 4 (of 48 available processors)

Solution count 10: 0.479568 0.486804 0.49026 ... 0.592378

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

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

        Job resource usage summary 

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

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