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.57374 seconds.
    local lower bound updated to 0.280075
    local upper bound updated to 0.55165

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.728971
    local lower bound updated to 0.706043

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 1.30953 seconds.
    local lower bound updated to 0.36627
    local upper bound updated to 0.574444

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 9.81568 seconds.
    local lower bound updated to 0.566431
    local upper bound updated to 0.568426

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 4.69244 seconds.
    local lower bound updated to 0.566431
    local upper bound updated to 0.566666

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.615929
    local lower bound updated to 0.579254

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.600255
    local lower bound updated to 0.596024

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.598856
    local lower bound updated to 0.598085

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 12.9712 seconds.
    local lower bound updated to 0.473454
    local upper bound updated to 0.592863

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.980746 seconds.
    local lower bound updated to 0.527492
    local upper bound updated to 0.588834

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 28.1976 seconds.
    local lower bound updated to 0.572453
    local upper bound updated to 0.582465

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 11.5669 seconds.
    local lower bound updated to 0.572453
    local upper bound updated to 0.581462

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 27.3857 seconds.
    local lower bound updated to 0.576811
    local upper bound updated to 0.579857

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 18.1628 seconds.
    local lower bound updated to 0.576811
    local upper bound updated to 0.578625

    ++ RESTRICTED PRIMAL ITERATION 7 ++
One worst-case parameter optimization takes 30.3877 seconds.
    local lower bound updated to 0.576811
    local upper bound updated to 0.578546

    ++ RESTRICTED PRIMAL ITERATION 8 ++
One worst-case parameter optimization takes 34.9688 seconds.
    local lower bound updated to 0.577201
    local upper bound updated to 0.578195

    ++ RESTRICTED PRIMAL ITERATION 9 ++
One worst-case parameter optimization takes 35.8077 seconds.
    local lower bound updated to 0.577262
    local upper bound updated to 0.57812

    ++ RESTRICTED PRIMAL ITERATION 10 ++
One worst-case parameter optimization takes 29.7868 seconds.
    local lower bound updated to 0.577499
    local upper bound updated to 0.57785

    ++ RESTRICTED PRIMAL ITERATION 11 ++
One worst-case parameter optimization takes 26.5001 seconds.
    local lower bound updated to 0.577499
    local upper bound updated to 0.577738

    ++ RESTRICTED PRIMAL ITERATION 12 ++
One worst-case parameter optimization takes 32.1737 seconds.
    local lower bound updated to 0.577629
    local upper bound updated to 0.577735

    ++ RESTRICTED PRIMAL ITERATION 13 ++
One worst-case parameter optimization takes 30.7394 seconds.
    local lower bound updated to 0.577734
    local upper bound updated to 0.577735
The Primal step takes 319.681 (S)
lower bound updated to 0.577734

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.614586
    local lower bound updated to 0.581632

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.586705
    local lower bound updated to 0.581647

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.582121
    local lower bound updated to 0.581683

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 38.0659 seconds.
    local lower bound updated to 0.504757
    local upper bound updated to 0.581683

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 70.0505 seconds.
    local lower bound updated to 0.577274
    local upper bound updated to 0.581629

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 121.301 seconds.
    local lower bound updated to 0.577274
    local upper bound updated to 0.581593

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 105.16 seconds.
    local lower bound updated to 0.578944
    local upper bound updated to 0.581327

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 101.269 seconds.
    local lower bound updated to 0.580899
    local upper bound updated to 0.581198

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 106.911 seconds.
    local lower bound updated to 0.581092
    local upper bound updated to 0.581189

    ++ RESTRICTED PRIMAL ITERATION 7 ++
One worst-case parameter optimization takes 88.8912 seconds.
    local lower bound updated to 0.581125
    local upper bound updated to 0.581178

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.606315
    local lower bound updated to 0.581178

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 36.2286 seconds.
    local lower bound updated to 0.504757
    local upper bound updated to 0.581178

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 80.8107 seconds.
    local lower bound updated to 0.581178
    local upper bound updated to 0.581178
The time obtain the optimal randomized assortment is 1190.2 (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_202018.log"
The computation time limit for a lower bound is 84806
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 1828 rows, 1398 columns and 6027 nonzeros
Model fingerprint: 0x53a6a137
Variable types: 1333 continuous, 65 integer (65 binary)
Coefficient statistics:
  Matrix range     [3e-06, 1e+00]
  Objective range  [1e+00, 1e+00]
  Bounds range     [1e+00, 1e+00]
  RHS range        [1e-01, 1e+00]
Presolve removed 421 rows and 735 columns
Presolve time: 0.02s
Presolved: 1407 rows, 663 columns, 5423 nonzeros
Variable types: 601 continuous, 62 integer (62 binary)
Found heuristic solution: objective 0.7556109
Found heuristic solution: objective 0.7214543

Root relaxation: objective 4.555850e-01, 171 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.45558    0   26    0.72145    0.45558  36.9%     -    0s
H    0     0                       0.7049421    0.45558  35.4%     -    0s
H    0     0                       0.6869796    0.45824  33.3%     -    0s
H    0     0                       0.6809870    0.45824  32.7%     -    0s
     0     0    0.45824    0   30    0.68099    0.45824  32.7%     -    0s
H    0     0                       0.6448341    0.45824  28.9%     -    0s
     0     0    0.45824    0   30    0.64483    0.45824  28.9%     -    0s
     0     0    0.50443    0   29    0.64483    0.50443  21.8%     -    0s
H    0     0                       0.5926653    0.50443  14.9%     -    0s
H    0     0                       0.5925571    0.50493  14.8%     -    0s
     0     0    0.50493    0   30    0.59256    0.50493  14.8%     -    0s
     0     0    0.51182    0   31    0.59256    0.51182  13.6%     -    0s
H    0     0                       0.5884388    0.51182  13.0%     -    0s
     0     0    0.51289    0   29    0.58844    0.51289  12.8%     -    0s
     0     0    0.51610    0   33    0.58844    0.51610  12.3%     -    0s
     0     0    0.51682    0   33    0.58844    0.51682  12.2%     -    0s
H    0     0                       0.5861051    0.51682  11.8%     -    0s
     0     0    0.51739    0   30    0.58611    0.51739  11.7%     -    0s
H    0     0                       0.5811783    0.51739  11.0%     -    1s
     0     2    0.51739    0   30    0.58118    0.51739  11.0%     -    1s
  1535   771    0.54822   11   32    0.58118    0.53589  7.79%  19.6    6s
  2454   873    0.57378   28   17    0.58118    0.53754  7.51%  23.9   10s
  3386   849     cutoff   31         0.58118    0.54131  6.86%  23.6   15s
  4848  1050     cutoff   24         0.58118    0.54513  6.20%  22.7   20s
  6040  1286    0.55316   28   14    0.58118    0.54764  5.77%  22.1   25s
  7369  1494    0.55933   27   18    0.58118    0.54936  5.48%  21.4   30s
  8767  1690     cutoff   28         0.58118    0.55131  5.14%  21.1   35s
 10314  1891    0.57379   25   16    0.58118    0.55305  4.84%  20.8   41s
*10503  1891              37       0.5811782    0.55305  4.84%  20.7   41s
 13282  2034     cutoff   32         0.58118    0.55541  4.43%  20.0   45s
 15311  2136    0.57375   30   10    0.58118    0.55703  4.15%  19.6   50s
 18644  2134     cutoff   28         0.58118    0.55929  3.77%  19.2   55s
 22152  2013    0.57679   29   17    0.58118    0.56163  3.36%  18.8   60s
 25258  1773    0.57497   33   10    0.58118    0.56373  3.00%  18.5   65s
 28513  1340     cutoff   27         0.58118    0.56637  2.55%  18.2   70s
 31019   934     cutoff   32         0.58118    0.56937  2.03%  18.1   75s

Cutting planes:
  Implied bound: 165
  MIR: 142
  Flow cover: 266
  RLT: 69
  Relax-and-lift: 63

Explored 33405 nodes (596498 simplex iterations) in 79.37 seconds (66.00 work units)
Thread count was 4 (of 48 available processors)

Solution count 10: 0.581178 0.581178 0.586105 ... 0.704942

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

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

        Job resource usage summary 

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

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