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.117313 seconds.
    local lower bound updated to 0.246959
    local upper bound updated to 0.405676

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.489953
    local lower bound updated to 0.480653

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.154771 seconds.
    local lower bound updated to 0.31123
    local upper bound updated to 0.423547

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.133977 seconds.
    local lower bound updated to 0.397187
    local upper bound updated to 0.417995

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 0.247906 seconds.
    local lower bound updated to 0.415106
    local upper bound updated to 0.417312

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 0.231519 seconds.
    local lower bound updated to 0.415641
    local upper bound updated to 0.416128

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 0.327096 seconds.
    local lower bound updated to 0.415822
    local upper bound updated to 0.415826
The Primal step takes 1.10267 (S)
lower bound updated to 0.415822

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.468614
    local lower bound updated to 0.416768

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.443514
    local lower bound updated to 0.417208

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.423535
    local lower bound updated to 0.422641

    ++ RESTRICTED DUAL ITERATION 4 ++
    local upper bound updated to 0.423535
    local lower bound updated to 0.422641

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.505096 seconds.
    local lower bound updated to 0.333089
    local upper bound updated to 0.422641

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.193725 seconds.
    local lower bound updated to 0.388155
    local upper bound updated to 0.4205

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 0.51782 seconds.
    local lower bound updated to 0.402474
    local upper bound updated to 0.418192

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 0.699289 seconds.
    local lower bound updated to 0.412368
    local upper bound updated to 0.415826

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.447263
    local lower bound updated to 0.415826

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.455789 seconds.
    local lower bound updated to 0.333089
    local upper bound updated to 0.415826

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.69176 seconds.
    local lower bound updated to 0.415826
    local upper bound updated to 0.415826
The time obtain the optimal randomized assortment is 5.92615 (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_64214.log"
The computation time limit for a lower bound is 85993
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 960 rows, 834 columns and 3031 nonzeros
Model fingerprint: 0x414118de
Variable types: 785 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        [3e-01, 1e+00]
Presolve removed 283 rows and 520 columns
Presolve time: 0.01s
Presolved: 677 rows, 314 columns, 2553 nonzeros
Variable types: 271 continuous, 43 integer (43 binary)
Found heuristic solution: objective 0.4802848
Found heuristic solution: objective 0.4766856

Root relaxation: objective 2.886906e-01, 95 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.28869    0   14    0.47669    0.28869  39.4%     -    0s
     0     0    0.30869    0   17    0.47669    0.30869  35.2%     -    0s
H    0     0                       0.4519800    0.30869  31.7%     -    0s
H    0     0                       0.4515991    0.30869  31.6%     -    0s
     0     0    0.36080    0   17    0.45160    0.36080  20.1%     -    0s
H    0     0                       0.4239308    0.36080  14.9%     -    0s
     0     0    0.36737    0   19    0.42393    0.36737  13.3%     -    0s
H    0     0                       0.4168607    0.36737  11.9%     -    0s
H    0     0                       0.4166115    0.38208  8.29%     -    0s
     0     0    0.38208    0   21    0.41661    0.38208  8.29%     -    0s
     0     0    0.38233    0   19    0.41661    0.38233  8.23%     -    0s
     0     0    0.38614    0   20    0.41661    0.38614  7.31%     -    0s
     0     0    0.38712    0   21    0.41661    0.38712  7.08%     -    0s
H    0     0                       0.4158264    0.38712  6.90%     -    0s
     0     0    0.38962    0   18    0.41583    0.38962  6.30%     -    0s
     0     2    0.38962    0   18    0.41583    0.38962  6.30%     -    0s

Cutting planes:
  Implied bound: 85
  MIR: 27
  Flow cover: 88
  RLT: 19
  Relax-and-lift: 15

Explored 304 nodes (5224 simplex iterations) in 0.79 seconds (0.36 work units)
Thread count was 4 (of 48 available processors)

Solution count 8: 0.415826 0.416612 0.416861 ... 0.480285

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

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

        Job resource usage summary 

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

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