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.413506 seconds.
    local lower bound updated to 0.34259
    local upper bound updated to 0.524985

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.58377
    local lower bound updated to 0.582072

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.545445 seconds.
    local lower bound updated to 0.387264
    local upper bound updated to 0.530202

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.53391 seconds.
    local lower bound updated to 0.510715
    local upper bound updated to 0.514382

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 0.669972 seconds.
    local lower bound updated to 0.510715
    local upper bound updated to 0.513

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 0.584588 seconds.
    local lower bound updated to 0.5116
    local upper bound updated to 0.512491

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.600593
    local lower bound updated to 0.552132

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.565745
    local lower bound updated to 0.557033

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.565739
    local lower bound updated to 0.560067

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 1.06268 seconds.
    local lower bound updated to 0.472904
    local upper bound updated to 0.552147

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.446424 seconds.
    local lower bound updated to 0.533061
    local upper bound updated to 0.545851

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 0.37584 seconds.
    local lower bound updated to 0.533061
    local upper bound updated to 0.544425

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 0.917059 seconds.
    local lower bound updated to 0.540244
    local upper bound updated to 0.544387

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 0.893447 seconds.
    local lower bound updated to 0.543121
    local upper bound updated to 0.543897

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 1.23039 seconds.
    local lower bound updated to 0.543235
    local upper bound updated to 0.543786

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.566332
    local lower bound updated to 0.543786

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.546967
    local lower bound updated to 0.544504

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.546459
    local lower bound updated to 0.544653

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 1.21201 seconds.
    local lower bound updated to 0.473418
    local upper bound updated to 0.544653

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 1.45076 seconds.
    local lower bound updated to 0.53967
    local upper bound updated to 0.54451

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.566694
    local lower bound updated to 0.54451

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 1.41784 seconds.
    local lower bound updated to 0.48472
    local upper bound updated to 0.54451

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 1.88926 seconds.
    local lower bound updated to 0.54451
    local upper bound updated to 0.54451
The time obtain the optimal randomized assortment is 18.0045 (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_200.000000_208614.log"
The computation time limit for a lower bound is 85980
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 1212 rows, 1058 columns and 3783 nonzeros
Model fingerprint: 0x216fa1ca
Variable types: 1009 continuous, 49 integer (49 binary)
Coefficient statistics:
  Matrix range     [6e-04, 1e+00]
  Objective range  [1e+00, 1e+00]
  Bounds range     [1e+00, 1e+00]
  RHS range        [6e-01, 1e+00]
Presolve removed 401 rows and 691 columns
Presolve time: 0.01s
Presolved: 811 rows, 367 columns, 3092 nonzeros
Variable types: 320 continuous, 47 integer (47 binary)
Found heuristic solution: objective 0.6454314

Root relaxation: objective 2.241334e-01, 94 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.22413    0   17    0.64543    0.22413  65.3%     -    0s
H    0     0                       0.6029931    0.22413  62.8%     -    0s
H    0     0                       0.5946884    0.28779  51.6%     -    0s
     0     0    0.28779    0   22    0.59469    0.28779  51.6%     -    0s
H    0     0                       0.5764620    0.28779  50.1%     -    0s
H    0     0                       0.5617582    0.28779  48.8%     -    0s
     0     0    0.28779    0   22    0.56176    0.28779  48.8%     -    0s
     0     0    0.35574    0   22    0.56176    0.35574  36.7%     -    0s
H    0     0                       0.5612093    0.35574  36.6%     -    0s
     0     0    0.35662    0   21    0.56121    0.35662  36.5%     -    0s
     0     0    0.40436    0   24    0.56121    0.40436  27.9%     -    0s
H    0     0                       0.5506890    0.40436  26.6%     -    0s
     0     0    0.40675    0   24    0.55069    0.40675  26.1%     -    0s
H    0     0                       0.5445576    0.40675  25.3%     -    0s
     0     0    0.41840    0   23    0.54456    0.41840  23.2%     -    0s
     0     0    0.41930    0   24    0.54456    0.41930  23.0%     -    0s
     0     0    0.42242    0   23    0.54456    0.42242  22.4%     -    0s
H    0     0                       0.5445101    0.42242  22.4%     -    0s
     0     2    0.42242    0   23    0.54451    0.42242  22.4%     -    0s

Cutting planes:
  Implied bound: 100
  MIR: 41
  Flow cover: 119
  RLT: 14
  Relax-and-lift: 45

Explored 1405 nodes (18707 simplex iterations) in 1.74 seconds (0.94 work units)
Thread count was 4 (of 40 available processors)

Solution count 9: 0.54451 0.544558 0.550689 ... 0.645431

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

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

        Job resource usage summary 

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

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