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.42206 seconds.
    local lower bound updated to 0.268796
    local upper bound updated to 0.523178

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.721312
    local lower bound updated to 0.709694

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 5.00399 seconds.
    local lower bound updated to 0.330736
    local upper bound updated to 0.534767

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 4.94748 seconds.
    local lower bound updated to 0.519898
    local upper bound updated to 0.523531

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 1.37774 seconds.
    local lower bound updated to 0.519898
    local upper bound updated to 0.520774

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 4.46751 seconds.
    local lower bound updated to 0.520722
    local upper bound updated to 0.520734

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.588031
    local lower bound updated to 0.548503

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.551481
    local lower bound updated to 0.548982

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.55122
    local lower bound updated to 0.550856

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 35.7847 seconds.
    local lower bound updated to 0.431538
    local upper bound updated to 0.542209

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.513574 seconds.
    local lower bound updated to 0.479444
    local upper bound updated to 0.539921

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 12.4409 seconds.
    local lower bound updated to 0.527375
    local upper bound updated to 0.536428

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 17.4959 seconds.
    local lower bound updated to 0.534372
    local upper bound updated to 0.534807

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 23.5721 seconds.
    local lower bound updated to 0.534372
    local upper bound updated to 0.534728

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 22.2797 seconds.
    local lower bound updated to 0.534372
    local upper bound updated to 0.534653

    ++ RESTRICTED PRIMAL ITERATION 7 ++
One worst-case parameter optimization takes 22.6339 seconds.
    local lower bound updated to 0.534372
    local upper bound updated to 0.53461

    ++ RESTRICTED PRIMAL ITERATION 8 ++
One worst-case parameter optimization takes 25.8248 seconds.
    local lower bound updated to 0.534542
    local upper bound updated to 0.534568

    ++ RESTRICTED PRIMAL ITERATION 9 ++
One worst-case parameter optimization takes 24.3148 seconds.
    local lower bound updated to 0.534568
    local upper bound updated to 0.534568
The Primal step takes 184.888 (S)
lower bound updated to 0.534568

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.558643
    local lower bound updated to 0.534568

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.536196
    local lower bound updated to 0.534606

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.535566
    local lower bound updated to 0.534828

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 38.4781 seconds.
    local lower bound updated to 0.455143
    local upper bound updated to 0.534743

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 36.8886 seconds.
    local lower bound updated to 0.534012
    local upper bound updated to 0.534686

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 37.059 seconds.
    local lower bound updated to 0.53428
    local upper bound updated to 0.534637

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 31.3463 seconds.
    local lower bound updated to 0.53428
    local upper bound updated to 0.534634

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 30.8281 seconds.
    local lower bound updated to 0.534575
    local upper bound updated to 0.534633

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 33.5074 seconds.
    local lower bound updated to 0.534621
    local upper bound updated to 0.534633

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.551695
    local lower bound updated to 0.534633

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 38.267 seconds.
    local lower bound updated to 0.455143
    local upper bound updated to 0.534633

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 36.9996 seconds.
    local lower bound updated to 0.534633
    local upper bound updated to 0.534633
The time obtain the optimal randomized assortment is 522.536 (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_60.000000_63716.log"
The computation time limit for a lower bound is 85475
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 1360 rows, 1098 columns and 4379 nonzeros
Model fingerprint: 0x49635fdf
Variable types: 1041 continuous, 57 integer (57 binary)
Coefficient statistics:
  Matrix range     [2e-06, 1e+00]
  Objective range  [1e+00, 1e+00]
  Bounds range     [1e+00, 1e+00]
  RHS range        [2e-01, 1e+00]
Presolve removed 343 rows and 627 columns
Presolve time: 0.02s
Presolved: 1017 rows, 471 columns, 3879 nonzeros
Variable types: 416 continuous, 55 integer (55 binary)
Found heuristic solution: objective 0.6117843
Found heuristic solution: objective 0.5858818
Found heuristic solution: objective 0.5799495

Root relaxation: objective 4.038196e-01, 109 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.40382    0   18    0.57995    0.40382  30.4%     -    0s
H    0     0                       0.5616533    0.40382  28.1%     -    0s
H    0     0                       0.5603033    0.40796  27.2%     -    0s
     0     0    0.40813    0   26    0.56030    0.40813  27.2%     -    0s
H    0     0                       0.5570733    0.40813  26.7%     -    0s
H    0     0                       0.5514830    0.43787  20.6%     -    0s
     0     0    0.43787    0   27    0.55148    0.43787  20.6%     -    0s
H    0     0                       0.5415355    0.43849  19.0%     -    0s
     0     0    0.43849    0   26    0.54154    0.43849  19.0%     -    0s
     0     0    0.45061    0   25    0.54154    0.45061  16.8%     -    0s
     0     0    0.45336    0   28    0.54154    0.45336  16.3%     -    0s
     0     0    0.45580    0   26    0.54154    0.45580  15.8%     -    0s
     0     0    0.45662    0   27    0.54154    0.45662  15.7%     -    0s
H    0     0                       0.5402623    0.45662  15.5%     -    0s
     0     0    0.45732    0   29    0.54026    0.45732  15.4%     -    0s
H    0     0                       0.5373482    0.45732  14.9%     -    1s
     0     2    0.45732    0   29    0.53735    0.45732  14.9%     -    1s
H   98    71                       0.5368885    0.46433  13.5%  20.3    1s
H  400   248                       0.5346331    0.48066  10.1%  15.8    2s
H  508   287                       0.5346331    0.48085  10.1%  15.5    3s
H  638   349                       0.5346331    0.48656  8.99%  15.4    3s
  1605   820    0.52604   17   29    0.53463    0.49361  7.67%  13.4    5s
H 2165   868                       0.5346330    0.49530  7.36%  15.6    7s
  2883   826    0.52935   25   10    0.53463    0.49916  6.63%  15.9   10s
  5189  1014    0.53018   25   12    0.53463    0.50714  5.14%  15.7   15s
  7918  1591    0.51642   23   12    0.53463    0.51134  4.36%  15.4   20s
 13062  1989    0.53007   32   10    0.53463    0.51704  3.29%  14.7   25s
 17066  1887    0.53019   24   16    0.53463    0.52059  2.63%  14.4   30s
 22518  1134    0.52602   29   10    0.53463    0.52560  1.69%  14.1   35s

Cutting planes:
  Implied bound: 83
  MIR: 76
  Flow cover: 250
  RLT: 26
  Relax-and-lift: 50

Explored 26282 nodes (365806 simplex iterations) in 37.25 seconds (28.99 work units)
Thread count was 4 (of 48 available processors)

Solution count 10: 0.534633 0.534633 0.534633 ... 0.560303

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

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

        Job resource usage summary 

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

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