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.731042 seconds.
    local lower bound updated to 0.294818
    local upper bound updated to 0.55454

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

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 3.44577 seconds.
    local lower bound updated to 0.395176
    local upper bound updated to 0.58476

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.483549 seconds.
    local lower bound updated to 0.470478
    local upper bound updated to 0.575306

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 6.27333 seconds.
    local lower bound updated to 0.565993
    local upper bound updated to 0.573145

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 3.913 seconds.
    local lower bound updated to 0.567273
    local upper bound updated to 0.567871

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.595221
    local lower bound updated to 0.570805

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.577385
    local lower bound updated to 0.571094

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.577385
    local lower bound updated to 0.571227

    ++ RESTRICTED DUAL ITERATION 4 ++
    local upper bound updated to 0.576454
    local lower bound updated to 0.573484

    ++ RESTRICTED DUAL ITERATION 5 ++
    local upper bound updated to 0.576454
    local lower bound updated to 0.574952

    ++ RESTRICTED DUAL ITERATION 6 ++
    local upper bound updated to 0.576454
    local lower bound updated to 0.574976

    ++ RESTRICTED DUAL ITERATION 7 ++
    local upper bound updated to 0.574976
    local lower bound updated to 0.574976
The Dual step takes 5.26682 (S)
upper bound updated to 0.574976
*** OUTER ITERATION 2 ***

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 100.027 seconds.
    local lower bound updated to 0.486531
    local upper bound updated to 0.574976

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 43.083 seconds.
    local lower bound updated to 0.552828
    local upper bound updated to 0.574145

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 100.03 seconds.
    local lower bound updated to 0.569853
    local upper bound updated to 0.572633

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 51.4098 seconds.
    local lower bound updated to 0.569853
    local upper bound updated to 0.572191

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 54.7629 seconds.
    local lower bound updated to 0.570739
    local upper bound updated to 0.572055

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 100.019 seconds.
    local lower bound updated to 0.570739
    local upper bound updated to 0.572049

    ++ RESTRICTED PRIMAL ITERATION 7 ++
One worst-case parameter optimization takes 100.019 seconds.
    local lower bound updated to 0.571298
    local upper bound updated to 0.57171

    ++ RESTRICTED PRIMAL ITERATION 8 ++
One worst-case parameter optimization takes 100.021 seconds.
    local lower bound updated to 0.571298
    local upper bound updated to 0.57167

    ++ RESTRICTED PRIMAL ITERATION 9 ++
One worst-case parameter optimization takes 100.022 seconds.
    local lower bound updated to 0.571298
    local upper bound updated to 0.571651

    ++ RESTRICTED PRIMAL ITERATION 10 ++
One worst-case parameter optimization takes 100.028 seconds.
    local lower bound updated to 0.571498
    local upper bound updated to 0.571615

    ++ RESTRICTED PRIMAL ITERATION 11 ++
One worst-case parameter optimization takes 100.023 seconds.
    local lower bound updated to 0.571531
    local upper bound updated to 0.571608

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.59932
    local lower bound updated to 0.571608

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.57529
    local lower bound updated to 0.571649

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 100.02 seconds.
    local lower bound updated to 0.490641
    local upper bound updated to 0.571649

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 100.024 seconds.
    local lower bound updated to 0.570942
    local upper bound updated to 0.571608

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.595803
    local lower bound updated to 0.571608

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 100.025 seconds.
    local lower bound updated to 0.490641
    local upper bound updated to 0.571608

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 100.022 seconds.
    local lower bound updated to 0.571608
    local upper bound updated to 0.571608
The time obtain the optimal randomized assortment is 1590.18 (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_100.000000_100518.log"
The computation time limit for a lower bound is 84402
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 2022 rows, 1546 columns and 6688 nonzeros
Model fingerprint: 0x605bb7dd
Variable types: 1481 continuous, 65 integer (65 binary)
Coefficient statistics:
  Matrix range     [1e-03, 1e+00]
  Objective range  [1e+00, 1e+00]
  Bounds range     [1e+00, 1e+00]
  RHS range        [5e-01, 1e+00]
Presolve removed 452 rows and 834 columns
Presolve time: 0.02s
Presolved: 1570 rows, 712 columns, 6166 nonzeros
Variable types: 648 continuous, 64 integer (64 binary)
Found heuristic solution: objective 0.6664560
Found heuristic solution: objective 0.6410689

Root relaxation: objective 4.298996e-01, 206 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.42990    0   16    0.64107    0.42990  32.9%     -    0s
H    0     0                       0.6319422    0.43367  31.4%     -    0s
     0     0    0.43853    0   21    0.63194    0.43853  30.6%     -    0s
H    0     0                       0.6076763    0.43853  27.8%     -    0s
     0     0    0.47113    0   32    0.60768    0.47113  22.5%     -    0s
H    0     0                       0.5853859    0.47113  19.5%     -    0s
     0     0    0.47981    0   32    0.58539    0.47981  18.0%     -    0s
     0     0    0.47981    0   34    0.58539    0.47981  18.0%     -    0s
H    0     0                       0.5751437    0.47981  16.6%     -    0s
     0     0    0.47981    0   36    0.57514    0.47981  16.6%     -    0s
     0     0    0.48673    0   31    0.57514    0.48673  15.4%     -    0s
H    0     0                       0.5716084    0.48673  14.8%     -    0s
     0     0    0.48721    0   31    0.57161    0.48721  14.8%     -    0s
     0     0    0.48914    0   29    0.57161    0.48914  14.4%     -    0s
     0     2    0.48914    0   29    0.57161    0.48914  14.4%     -    2s
   489   192    0.55411   10   14    0.57161    0.51173  10.5%  22.0    5s
H  527   205                       0.5716084    0.51173  10.5%  21.5    5s
H  605   259                       0.5716084    0.51329  10.2%  21.1    6s
H  606   259                       0.5716084    0.51329  10.2%  21.1    6s
  1774   609    0.56258   17   10    0.57161    0.52151  8.77%  18.6   10s
  2489   802    0.53720   12   28    0.57161    0.52427  8.28%  18.1   15s
H 3000   880                       0.5716084    0.52427  8.28%  20.8   19s
  3157   888    0.52751   15   20    0.57161    0.52427  8.28%  20.9   20s
  4781   708     cutoff   28         0.57161    0.53374  6.62%  20.8   25s
H 5104   781                       0.5716084    0.53484  6.43%  20.9   28s
  5352   878    0.56526   28   10    0.57161    0.53568  6.29%  21.0   30s
  6875  1082    0.55895   21   13    0.57161    0.53842  5.81%  20.9   35s
  8201  1362    0.55988   23    8    0.57161    0.54052  5.44%  21.0   40s
  9553  1496    0.54855   24   10    0.57161    0.54255  5.08%  21.0   45s
H10898  1587                       0.5716084    0.54342  4.93%  20.7   48s
 11246  1624     cutoff   22         0.57161    0.54389  4.85%  20.7   50s
 12586  1740    0.55089   22   14    0.57161    0.54544  4.58%  20.4   55s
 14196  1833     cutoff   25         0.57161    0.54668  4.36%  20.4   60s
 15108  1909    0.55863   23   14    0.57161    0.54749  4.22%  20.3   66s
 16868  2031 infeasible   29         0.57161    0.54862  4.02%  20.2   70s
 18475  2068    0.56282   22   14    0.57161    0.54961  3.85%  20.1   75s
 21160  2116    0.56885   25   10    0.57161    0.55103  3.60%  19.9   80s
 23056  2101     cutoff   24         0.57161    0.55213  3.41%  19.8   85s
 24520  2107    0.55942   26   14    0.57161    0.55253  3.34%  19.8   91s
 26686  2061    0.56985   27   10    0.57161    0.55346  3.18%  19.7   96s
 28436  1949    0.56775   29   10    0.57161    0.55469  2.96%  19.6  100s
 30960  1867     cutoff   30         0.57161    0.55582  2.76%  19.5  105s
 31816  1783     cutoff   25         0.57161    0.55626  2.69%  19.5  110s
 33855  1620     cutoff   24         0.57161    0.55745  2.48%  19.5  115s
 35594  1446     cutoff   23         0.57161    0.55857  2.28%  19.5  122s
 36604  1241    0.56269   25   10    0.57161    0.55935  2.14%  19.4  125s
 38586   843 infeasible   22         0.57161    0.56192  1.69%  19.4  130s

Cutting planes:
  Gomory: 1
  Implied bound: 192
  MIR: 106
  Flow cover: 284
  RLT: 27
  Relax-and-lift: 68

Explored 40509 nodes (781061 simplex iterations) in 132.03 seconds (97.83 work units)
Thread count was 4 (of 256 available processors)

Solution count 10: 0.571608 0.571608 0.571608 ... 0.641069

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

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

        Job resource usage summary 

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

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