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.131287 seconds.
    local lower bound updated to 0.292716
    local upper bound updated to 0.554702

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.643268
    local lower bound updated to 0.613443

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.638171
    local lower bound updated to 0.624633

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.62558
    local lower bound updated to 0.625125

    ++ RESTRICTED DUAL ITERATION 4 ++
    local upper bound updated to 0.625219
    local lower bound updated to 0.625182

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.418432 seconds.
    local lower bound updated to 0.405832
    local upper bound updated to 0.571855

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.471628 seconds.
    local lower bound updated to 0.543945
    local upper bound updated to 0.567677

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 0.843425 seconds.
    local lower bound updated to 0.543945
    local upper bound updated to 0.556109

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 0.676146 seconds.
    local lower bound updated to 0.551568
    local upper bound updated to 0.553417

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 0.544709 seconds.
    local lower bound updated to 0.552252
    local upper bound updated to 0.553343

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.613087
    local lower bound updated to 0.576104

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.60388
    local lower bound updated to 0.586068

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.590999
    local lower bound updated to 0.590041

    ++ RESTRICTED DUAL ITERATION 4 ++
    local upper bound updated to 0.590999
    local lower bound updated to 0.590905

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 1.36805 seconds.
    local lower bound updated to 0.47955
    local upper bound updated to 0.590905

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.570149 seconds.
    local lower bound updated to 0.559577
    local upper bound updated to 0.576571

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 1.88641 seconds.
    local lower bound updated to 0.560198
    local upper bound updated to 0.576009

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 1.11394 seconds.
    local lower bound updated to 0.560198
    local upper bound updated to 0.575075

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 2.6186 seconds.
    local lower bound updated to 0.570685
    local upper bound updated to 0.573099

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 2.81932 seconds.
    local lower bound updated to 0.570685
    local upper bound updated to 0.57299

    ++ RESTRICTED PRIMAL ITERATION 7 ++
One worst-case parameter optimization takes 2.62659 seconds.
    local lower bound updated to 0.570685
    local upper bound updated to 0.571935

    ++ RESTRICTED PRIMAL ITERATION 8 ++
One worst-case parameter optimization takes 3.04218 seconds.
    local lower bound updated to 0.570685
    local upper bound updated to 0.571707

    ++ RESTRICTED PRIMAL ITERATION 9 ++
One worst-case parameter optimization takes 2.59088 seconds.
    local lower bound updated to 0.570685
    local upper bound updated to 0.57129

    ++ RESTRICTED PRIMAL ITERATION 10 ++
One worst-case parameter optimization takes 3.86304 seconds.
    local lower bound updated to 0.570685
    local upper bound updated to 0.571232

    ++ RESTRICTED PRIMAL ITERATION 11 ++
One worst-case parameter optimization takes 2.99393 seconds.
    local lower bound updated to 0.570685
    local upper bound updated to 0.571185

    ++ RESTRICTED PRIMAL ITERATION 12 ++
One worst-case parameter optimization takes 2.29237 seconds.
    local lower bound updated to 0.571084
    local upper bound updated to 0.571172

    ++ RESTRICTED PRIMAL ITERATION 13 ++
One worst-case parameter optimization takes 3.40899 seconds.
    local lower bound updated to 0.571128
    local upper bound updated to 0.571162

    ++ RESTRICTED PRIMAL ITERATION 14 ++
One worst-case parameter optimization takes 3.82402 seconds.
    local lower bound updated to 0.571162
    local upper bound updated to 0.571162
The Primal step takes 35.0756 (S)
lower bound updated to 0.571162

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.587387
    local lower bound updated to 0.572523

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.587387
    local lower bound updated to 0.574228

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.578531
    local lower bound updated to 0.576025

    ++ RESTRICTED DUAL ITERATION 4 ++
    local upper bound updated to 0.578531
    local lower bound updated to 0.576382

    ++ RESTRICTED DUAL ITERATION 5 ++
    local upper bound updated to 0.578531
    local lower bound updated to 0.576729

    ++ RESTRICTED DUAL ITERATION 6 ++
    local upper bound updated to 0.578531
    local lower bound updated to 0.576796

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 4.08922 seconds.
    local lower bound updated to 0.51357
    local upper bound updated to 0.576796

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 9.6506 seconds.
    local lower bound updated to 0.567945
    local upper bound updated to 0.576391

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 2.46036 seconds.
    local lower bound updated to 0.567945
    local upper bound updated to 0.575046

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 3.11133 seconds.
    local lower bound updated to 0.571137
    local upper bound updated to 0.57461

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 2.74268 seconds.
    local lower bound updated to 0.571137
    local upper bound updated to 0.574387

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 3.0326 seconds.
    local lower bound updated to 0.572677
    local upper bound updated to 0.574164

    ++ RESTRICTED PRIMAL ITERATION 7 ++
One worst-case parameter optimization takes 3.77087 seconds.
    local lower bound updated to 0.572758
    local upper bound updated to 0.574136

    ++ RESTRICTED PRIMAL ITERATION 8 ++
One worst-case parameter optimization takes 3.6578 seconds.
    local lower bound updated to 0.573465
    local upper bound updated to 0.57412

    ++ RESTRICTED PRIMAL ITERATION 9 ++
One worst-case parameter optimization takes 3.26148 seconds.
    local lower bound updated to 0.573916
    local upper bound updated to 0.574113

    ++ RESTRICTED PRIMAL ITERATION 10 ++
One worst-case parameter optimization takes 2.79429 seconds.
    local lower bound updated to 0.574113
    local upper bound updated to 0.574113
The Primal step takes 38.6295 (S)
lower bound updated to 0.574113

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.585431
    local lower bound updated to 0.574113

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.584718
    local lower bound updated to 0.574777

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.578093
    local lower bound updated to 0.574793

    ++ RESTRICTED DUAL ITERATION 4 ++
    local upper bound updated to 0.577029
    local lower bound updated to 0.574793

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 3.32171 seconds.
    local lower bound updated to 0.511148
    local upper bound updated to 0.574793

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 4.16292 seconds.
    local lower bound updated to 0.571333
    local upper bound updated to 0.574692

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 3.55287 seconds.
    local lower bound updated to 0.572259
    local upper bound updated to 0.574454

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 2.72915 seconds.
    local lower bound updated to 0.573093
    local upper bound updated to 0.5744

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 2.6247 seconds.
    local lower bound updated to 0.573351
    local upper bound updated to 0.574199

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 1.62927 seconds.
    local lower bound updated to 0.573351
    local upper bound updated to 0.574192

    ++ RESTRICTED PRIMAL ITERATION 7 ++
One worst-case parameter optimization takes 3.50598 seconds.
    local lower bound updated to 0.573351
    local upper bound updated to 0.57415

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.588913
    local lower bound updated to 0.57415

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 3.32044 seconds.
    local lower bound updated to 0.511148
    local upper bound updated to 0.57415

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 3.01738 seconds.
    local lower bound updated to 0.57415
    local upper bound updated to 0.57415
The time obtain the optimal randomized assortment is 124.968 (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_13_4_60.000000_69414.log"
The computation time limit for a lower bound is 85873
The model output flag is 1
Gurobi Optimizer version 9.5.1 build v9.5.1rc2 (linux64)
Thread count: 20 physical cores, 40 logical processors, using up to 4 threads
Optimize a model with 2472 rows, 2178 columns and 7665 nonzeros
Model fingerprint: 0x806d5eca
Variable types: 2129 continuous, 49 integer (49 binary)
Coefficient statistics:
  Matrix range     [2e-03, 1e+00]
  Objective range  [1e+00, 1e+00]
  Bounds range     [1e+00, 1e+00]
  RHS range        [4e-01, 1e+00]
Presolve removed 817 rows and 1469 columns
Presolve time: 0.03s
Presolved: 1655 rows, 709 columns, 6197 nonzeros
Variable types: 661 continuous, 48 integer (48 binary)
Found heuristic solution: objective 0.7039409
Found heuristic solution: objective 0.6812801
Found heuristic solution: objective 0.6066485

Root relaxation: objective 3.626149e-01, 204 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.36261    0   21    0.60665    0.36261  40.2%     -    0s
H    0     0                       0.6062905    0.36261  40.2%     -    0s
H    0     0                       0.5960737    0.39826  33.2%     -    0s
     0     0    0.39826    0   25    0.59607    0.39826  33.2%     -    0s
     0     0    0.39826    0   25    0.59607    0.39826  33.2%     -    0s
     0     0    0.47076    0   20    0.59607    0.47076  21.0%     -    0s
H    0     0                       0.5746747    0.47076  18.1%     -    0s
     0     0    0.47151    0   20    0.57467    0.47151  18.0%     -    0s
H    0     0                       0.5744373    0.48744  15.1%     -    0s
     0     0    0.48744    0   22    0.57444    0.48744  15.1%     -    0s
     0     0    0.48756    0   23    0.57444    0.48756  15.1%     -    0s
     0     0    0.49225    0   23    0.57444    0.49225  14.3%     -    0s
     0     0    0.49352    0   22    0.57444    0.49352  14.1%     -    0s
     0     0    0.49523    0   20    0.57444    0.49523  13.8%     -    0s
H    0     0                       0.5741503    0.49523  13.7%     -    1s
     0     2    0.49523    0   20    0.57415    0.49523  13.7%     -    1s

Cutting planes:
  Implied bound: 268
  MIR: 88
  Flow cover: 223
  RLT: 18
  Relax-and-lift: 122
  BQP: 1

Explored 1169 nodes (38380 simplex iterations) in 2.06 seconds (1.32 work units)
Thread count was 4 (of 40 available processors)

Solution count 8: 0.57415 0.574437 0.574675 ... 0.703941

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

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

        Job resource usage summary 

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

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