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.570574 seconds.
    local lower bound updated to 0.36177
    local upper bound updated to 0.66017

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.714826
    local lower bound updated to 0.698513

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.714826
    local lower bound updated to 0.705917

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.710121
    local lower bound updated to 0.707548

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 2.51244 seconds.
    local lower bound updated to 0.500695
    local upper bound updated to 0.680948

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.808687 seconds.
    local lower bound updated to 0.631541
    local upper bound updated to 0.661434

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 0.48885 seconds.
    local lower bound updated to 0.659893
    local upper bound updated to 0.66017

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.692852
    local lower bound updated to 0.686751

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.690007
    local lower bound updated to 0.686751

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 2.31263 seconds.
    local lower bound updated to 0.541264
    local upper bound updated to 0.686751

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.442979 seconds.
    local lower bound updated to 0.636171
    local upper bound updated to 0.680267

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 1.38636 seconds.
    local lower bound updated to 0.661353
    local upper bound updated to 0.674678

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 0.656858 seconds.
    local lower bound updated to 0.663264
    local upper bound updated to 0.673678

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 2.38301 seconds.
    local lower bound updated to 0.672872
    local upper bound updated to 0.673166

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 2.89559 seconds.
    local lower bound updated to 0.673134
    local upper bound updated to 0.673141
The Primal step takes 10.1015 (S)
lower bound updated to 0.673134

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.687953
    local lower bound updated to 0.673141

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.687953
    local lower bound updated to 0.67387

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.679324
    local lower bound updated to 0.674191

    ++ RESTRICTED DUAL ITERATION 4 ++
    local upper bound updated to 0.675809
    local lower bound updated to 0.674216

    ++ RESTRICTED DUAL ITERATION 5 ++
    local upper bound updated to 0.67505
    local lower bound updated to 0.674237

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 4.91843 seconds.
    local lower bound updated to 0.584161
    local upper bound updated to 0.674205

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 9.14019 seconds.
    local lower bound updated to 0.672375
    local upper bound updated to 0.674171

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 7.51753 seconds.
    local lower bound updated to 0.672375
    local upper bound updated to 0.673431

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 5.0057 seconds.
    local lower bound updated to 0.673007
    local upper bound updated to 0.673304

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 5.65084 seconds.
    local lower bound updated to 0.673007
    local upper bound updated to 0.673282

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 5.24231 seconds.
    local lower bound updated to 0.67308
    local upper bound updated to 0.673248

    ++ RESTRICTED PRIMAL ITERATION 7 ++
One worst-case parameter optimization takes 5.28287 seconds.
    local lower bound updated to 0.67308
    local upper bound updated to 0.67323

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.684248
    local lower bound updated to 0.67323

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 4.65598 seconds.
    local lower bound updated to 0.584161
    local upper bound updated to 0.67323

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 5.66901 seconds.
    local lower bound updated to 0.67323
    local upper bound updated to 0.67323
The time obtain the optimal randomized assortment is 75.6932 (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_201114.log"
The computation time limit for a lower bound is 85923
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 1590 rows, 1394 columns and 4978 nonzeros
Model fingerprint: 0x291a98ab
Variable types: 1345 continuous, 49 integer (49 binary)
Coefficient statistics:
  Matrix range     [3e-06, 1e+00]
  Objective range  [1e+00, 1e+00]
  Bounds range     [1e+00, 1e+00]
  RHS range        [2e-01, 1e+00]
Presolve removed 467 rows and 901 columns
Presolve time: 0.01s
Presolved: 1123 rows, 493 columns, 4207 nonzeros
Variable types: 445 continuous, 48 integer (48 binary)
Found heuristic solution: objective 0.7711365
Found heuristic solution: objective 0.7585872

Root relaxation: objective 4.804543e-01, 159 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.48045    0   21    0.75859    0.48045  36.7%     -    0s
H    0     0                       0.7122893    0.48045  32.5%     -    0s
H    0     0                       0.7034214    0.48045  31.7%     -    0s
H    0     0                       0.6916511    0.50642  26.8%     -    0s
     0     0    0.50642    0   23    0.69165    0.50642  26.8%     -    0s
     0     0    0.56628    0   22    0.69165    0.56628  18.1%     -    0s
H    0     0                       0.6749653    0.56628  16.1%     -    0s
     0     0    0.56628    0   22    0.67497    0.56628  16.1%     -    0s
     0     0    0.57561    0   24    0.67497    0.57561  14.7%     -    0s
     0     0    0.57726    0   23    0.67497    0.57726  14.5%     -    0s
H    0     0                       0.6732305    0.57726  14.3%     -    0s
     0     0    0.58689    0   23    0.67323    0.58689  12.8%     -    0s
     0     0    0.58738    0   23    0.67323    0.58738  12.8%     -    0s
     0     0    0.59104    0   22    0.67323    0.59104  12.2%     -    0s
     0     2    0.59104    0   22    0.67323    0.59104  12.2%     -    1s

Cutting planes:
  Implied bound: 180
  MIR: 53
  Flow cover: 168
  RLT: 6
  Relax-and-lift: 83

Explored 2207 nodes (36795 simplex iterations) in 4.90 seconds (2.11 work units)
Thread count was 4 (of 40 available processors)

Solution count 7: 0.67323 0.674965 0.691651 ... 0.771137

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

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

        Job resource usage summary 

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

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