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.40416 seconds.
    local lower bound updated to 0.296425
    local upper bound updated to 0.572757

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.629647
    local lower bound updated to 0.628105

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 6.85511 seconds.
    local lower bound updated to 0.382961
    local upper bound updated to 0.586685

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 22.2847 seconds.
    local lower bound updated to 0.578357
    local upper bound updated to 0.580169

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 24.6771 seconds.
    local lower bound updated to 0.578357
    local upper bound updated to 0.579255

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.599604
    local lower bound updated to 0.58475

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.599604
    local lower bound updated to 0.585331

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.594221
    local lower bound updated to 0.591285

    ++ RESTRICTED DUAL ITERATION 4 ++
    local upper bound updated to 0.594221
    local lower bound updated to 0.591285

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 44.8676 seconds.
    local lower bound updated to 0.477142
    local upper bound updated to 0.591255

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 23.5535 seconds.
    local lower bound updated to 0.563866
    local upper bound updated to 0.584256

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 100.021 seconds.
    local lower bound updated to 0.579992
    local upper bound updated to 0.582063

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 100.021 seconds.
    local lower bound updated to 0.580017
    local upper bound updated to 0.581881

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 100.018 seconds.
    local lower bound updated to 0.580017
    local upper bound updated to 0.581643

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 79.0375 seconds.
    local lower bound updated to 0.580144
    local upper bound updated to 0.581343

    ++ RESTRICTED PRIMAL ITERATION 7 ++
One worst-case parameter optimization takes 69.4468 seconds.
    local lower bound updated to 0.580144
    local upper bound updated to 0.581341

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.589953
    local lower bound updated to 0.581341

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.585337
    local lower bound updated to 0.581673

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.584152
    local lower bound updated to 0.581847

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 100.021 seconds.
    local lower bound updated to 0.497996
    local upper bound updated to 0.581847

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 100.017 seconds.
    local lower bound updated to 0.578703
    local upper bound updated to 0.581683

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 100.021 seconds.
    local lower bound updated to 0.581324
    local upper bound updated to 0.581678

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 100.02 seconds.
    local lower bound updated to 0.581402
    local upper bound updated to 0.581651

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.589084
    local lower bound updated to 0.581651

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 100.018 seconds.
    local lower bound updated to 0.497996
    local upper bound updated to 0.581651

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 100.025 seconds.
    local lower bound updated to 0.581651
    local upper bound updated to 0.581651
The time obtain the optimal randomized assortment is 1407.49 (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_19_4_100.000000_100020.log"
The computation time limit for a lower bound is 84582
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 2136 rows, 1568 columns and 7222 nonzeros
Model fingerprint: 0x60c2cc20
Variable types: 1495 continuous, 73 integer (73 binary)
Coefficient statistics:
  Matrix range     [8e-06, 1e+00]
  Objective range  [1e+00, 1e+00]
  Bounds range     [1e+00, 1e+00]
  RHS range        [5e-01, 1e+00]
Presolve removed 405 rows and 735 columns
Presolve time: 0.02s
Presolved: 1731 rows, 833 columns, 6726 nonzeros
Variable types: 763 continuous, 70 integer (70 binary)
Found heuristic solution: objective 0.7388367
Found heuristic solution: objective 0.6498228

Root relaxation: objective 4.659028e-01, 207 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.46590    0   18    0.64982    0.46590  28.3%     -    0s
H    0     0                       0.6484534    0.46764  27.9%     -    0s
     0     0    0.46764    0   27    0.64845    0.46764  27.9%     -    0s
H    0     0                       0.6145501    0.46764  23.9%     -    0s
     0     0    0.47218    0   27    0.61455    0.47218  23.2%     -    0s
     0     0    0.48240    0   36    0.61455    0.48240  21.5%     -    0s
H    0     0                       0.6022412    0.48334  19.7%     -    0s
     0     0    0.49696    0   35    0.60224    0.49696  17.5%     -    0s
H    0     0                       0.5840677    0.49826  14.7%     -    0s
     0     0    0.49826    0   33    0.58407    0.49826  14.7%     -    0s
     0     0    0.50544    0   35    0.58407    0.50544  13.5%     -    0s
     0     0    0.50612    0   35    0.58407    0.50612  13.3%     -    0s
     0     0    0.50838    0   31    0.58407    0.50838  13.0%     -    0s
H    0     0                       0.5837101    0.50838  12.9%     -    2s
     0     2    0.50838    0   31    0.58371    0.50838  12.9%     -    2s
*  229   163              19       0.5826525    0.51735  11.2%  27.8    2s
H  500   239                       0.5818679    0.52371  10.0%  27.1    4s
   539   271    0.56554   11   19    0.58187    0.52556  9.68%  27.7    5s
H  600   288                       0.5816507    0.52722  9.36%  27.6    6s
  1283   504    0.55661    8   18    0.58165    0.53338  8.30%  23.9   10s
  1898   677    0.53893    8   20    0.58165    0.53676  7.72%  23.2   15s
  2870   923    0.57858   32    6    0.58165    0.53779  7.54%  25.1   20s
  3545   925    0.57537   29   13    0.58165    0.54172  6.86%  24.7   25s
  4917  1095    0.57662   30   15    0.58165    0.54640  6.06%  23.9   30s
  6412  1453    0.57042   25   24    0.58165    0.54987  5.46%  23.6   35s
  7272  1657     cutoff   29         0.58165    0.55122  5.23%  23.6   40s
  8170  1810    0.55545   25   20    0.58165    0.55250  5.01%  23.3   46s
  8530  1942    0.57407   32   15    0.58165    0.55314  4.90%  23.3   50s
 10112  2163     cutoff   32         0.58165    0.55465  4.64%  22.7   55s
 11514  2384     cutoff   31         0.58165    0.55586  4.43%  22.3   60s
 13798  2684    0.57829   28   12    0.58165    0.55779  4.10%  21.9   67s
 15011  2816     cutoff   35         0.58165    0.55847  3.99%  21.7   71s
 17272  2964     cutoff   27         0.58165    0.56002  3.72%  21.3   76s
 18542  3080    0.57063   24   17    0.58165    0.56064  3.61%  21.2   81s
 19317  3111     cutoff   32         0.58165    0.56118  3.52%  21.1   85s
 20215  3154    0.57246   32   14    0.58165    0.56165  3.44%  21.0   90s
 22920  3264     cutoff   29         0.58165    0.56292  3.22%  20.8   95s
 24532  3358    0.57066   29   14    0.58165    0.56365  3.10%  20.6  100s
 26356  3384    0.57116   28   18    0.58165    0.56437  2.97%  20.5  105s
 29233  3386 infeasible   30         0.58165    0.56550  2.78%  20.3  111s
H31186  3360                       0.5816507    0.56627  2.64%  20.1  113s
 31264  3345     cutoff   33         0.58165    0.56629  2.64%  20.1  115s
H31265  3345                       0.5816507    0.56629  2.64%  20.1  115s
 32134  3324    0.57933   31   10    0.58165    0.56656  2.59%  20.1  121s
H32742  3308                       0.5816507    0.56678  2.56%  20.1  122s
 33160  3276    0.57702   28   18    0.58165    0.56693  2.53%  20.0  126s
 35308  3203     cutoff   33         0.58165    0.56756  2.42%  20.0  131s
 36715  3105    0.57206   26   15    0.58165    0.56816  2.32%  19.9  135s
 38897  2931     cutoff   27         0.58165    0.56900  2.17%  19.8  141s
 40372  2768    0.57612   29   16    0.58165    0.56935  2.12%  19.7  145s
 42874  2459     cutoff   34         0.58165    0.57052  1.91%  19.6  150s
 44842  2181     cutoff   32         0.58165    0.57125  1.79%  19.5  155s
 47594  1628    0.57542   31   12    0.58165    0.57316  1.46%  19.3  161s
 49020  1230 infeasible   30         0.58165    0.57398  1.32%  19.3  165s
 51030   285    0.58073   26   17    0.58165    0.57646  0.89%  19.2  171s

Cutting planes:
  Implied bound: 206
  MIR: 103
  Flow cover: 318
  RLT: 44
  Relax-and-lift: 76

Explored 51915 nodes (990071 simplex iterations) in 171.25 seconds (158.16 work units)
Thread count was 4 (of 256 available processors)

Solution count 10: 0.581651 0.581651 0.581651 ... 0.648453

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

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

        Job resource usage summary 

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

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