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.158506 seconds.
    local lower bound updated to 0.21458
    local upper bound updated to 0.422124

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.478398
    local lower bound updated to 0.422185

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.382764 seconds.
    local lower bound updated to 0.292352
    local upper bound updated to 0.430001

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.297642 seconds.
    local lower bound updated to 0.424875
    local upper bound updated to 0.426779

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 0.35097 seconds.
    local lower bound updated to 0.424875
    local upper bound updated to 0.425338

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 0.35537 seconds.
    local lower bound updated to 0.424875
    local upper bound updated to 0.425292

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 0.374299 seconds.
    local lower bound updated to 0.424907
    local upper bound updated to 0.425235

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 0.303071 seconds.
    local lower bound updated to 0.425032
    local upper bound updated to 0.425167

    ++ RESTRICTED PRIMAL ITERATION 7 ++
One worst-case parameter optimization takes 0.446411 seconds.
    local lower bound updated to 0.425048
    local upper bound updated to 0.425068

    ++ RESTRICTED PRIMAL ITERATION 8 ++
One worst-case parameter optimization takes 0.454829 seconds.
    local lower bound updated to 0.425048
    local upper bound updated to 0.425062

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.454713
    local lower bound updated to 0.430869

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.452444
    local lower bound updated to 0.433378

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.435765
    local lower bound updated to 0.434163

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.731129 seconds.
    local lower bound updated to 0.349446
    local upper bound updated to 0.434163

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.451305 seconds.
    local lower bound updated to 0.4214
    local upper bound updated to 0.430891

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 0.417197 seconds.
    local lower bound updated to 0.423051
    local upper bound updated to 0.428156

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 0.416445 seconds.
    local lower bound updated to 0.426644
    local upper bound updated to 0.427358

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.444759
    local lower bound updated to 0.427358

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.432363
    local lower bound updated to 0.42764

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.673847 seconds.
    local lower bound updated to 0.352204
    local upper bound updated to 0.42764

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.816737 seconds.
    local lower bound updated to 0.427242
    local upper bound updated to 0.427515

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 0.657073 seconds.
    local lower bound updated to 0.427309
    local upper bound updated to 0.427405

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.438672
    local lower bound updated to 0.427405

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.428658
    local lower bound updated to 0.427419

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.88854 seconds.
    local lower bound updated to 0.352498
    local upper bound updated to 0.427419

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.717112 seconds.
    local lower bound updated to 0.427199
    local upper bound updated to 0.427405

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.436359
    local lower bound updated to 0.427405

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.915785 seconds.
    local lower bound updated to 0.352498
    local upper bound updated to 0.427405

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.53532 seconds.
    local lower bound updated to 0.427405
    local upper bound updated to 0.427405
The time obtain the optimal randomized assortment is 15.9048 (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_204414.log"
The computation time limit for a lower bound is 85983
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 3811 nonzeros
Model fingerprint: 0x59663c36
Variable types: 1009 continuous, 49 integer (49 binary)
Coefficient statistics:
  Matrix range     [1e-03, 1e+00]
  Objective range  [1e+00, 1e+00]
  Bounds range     [1e+00, 1e+00]
  RHS range        [2e-01, 1e+00]
Presolve removed 372 rows and 680 columns
Presolve time: 0.01s
Presolved: 840 rows, 378 columns, 3202 nonzeros
Variable types: 330 continuous, 48 integer (48 binary)
Found heuristic solution: objective 0.5548456
Found heuristic solution: objective 0.5537736

Root relaxation: objective 3.387201e-01, 154 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.33872    0   15    0.55377    0.33872  38.8%     -    0s
H    0     0                       0.5395595    0.34260  36.5%     -    0s
     0     0    0.34260    0   19    0.53956    0.34260  36.5%     -    0s
H    0     0                       0.5352552    0.34260  36.0%     -    0s
H    0     0                       0.4710363    0.34260  27.3%     -    0s
H    0     0                       0.4681791    0.36013  23.1%     -    0s
     0     0    0.36013    0   18    0.46818    0.36013  23.1%     -    0s
H    0     0                       0.4300944    0.36013  16.3%     -    0s
H    0     0                       0.4297163    0.36013  16.2%     -    0s
     0     0    0.36393    0   18    0.42972    0.36393  15.3%     -    0s
     0     0    0.37010    0   20    0.42972    0.37010  13.9%     -    0s
H    0     0                       0.4295670    0.37038  13.8%     -    0s
     0     0    0.37038    0   20    0.42957    0.37038  13.8%     -    0s
H    0     0                       0.4295397    0.37038  13.8%     -    0s
H    0     0                       0.4294888    0.37967  11.6%     -    0s
     0     0    0.37967    0   20    0.42949    0.37967  11.6%     -    0s
H    0     0                       0.4294491    0.37977  11.6%     -    0s
     0     0    0.37977    0   20    0.42945    0.37977  11.6%     -    0s
H    0     0                       0.4294376    0.37977  11.6%     -    0s
     0     0    0.38789    0   20    0.42944    0.38789  9.68%     -    0s
H    0     0                       0.4291986    0.38789  9.63%     -    0s
H    0     0                       0.4274054    0.38789  9.25%     -    0s
     0     2    0.38789    0   20    0.42741    0.38789  9.25%     -    0s

Cutting planes:
  Gomory: 1
  Implied bound: 125
  MIR: 13
  Flow cover: 76
  RLT: 7
  Relax-and-lift: 63

Explored 175 nodes (3085 simplex iterations) in 0.53 seconds (0.21 work units)
Thread count was 4 (of 40 available processors)

Solution count 10: 0.427405 0.429199 0.429438 ... 0.468179

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

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

        Job resource usage summary 

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

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