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.162583 seconds.
    local lower bound updated to 0.263855
    local upper bound updated to 0.387108

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.572746
    local lower bound updated to 0.552227

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.0506547 seconds.
    local lower bound updated to 0.271854
    local upper bound updated to 0.394248

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.111782 seconds.
    local lower bound updated to 0.385049
    local upper bound updated to 0.386729

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 0.0783595 seconds.
    local lower bound updated to 0.386558
    local upper bound updated to 0.386695

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.492497
    local lower bound updated to 0.388957

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.435571
    local lower bound updated to 0.403185

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.0857984 seconds.
    local lower bound updated to 0.314445
    local upper bound updated to 0.402646

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.06289 seconds.
    local lower bound updated to 0.384197
    local upper bound updated to 0.40221

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 0.0991326 seconds.
    local lower bound updated to 0.398557
    local upper bound updated to 0.402102

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 0.0918972 seconds.
    local lower bound updated to 0.398719
    local upper bound updated to 0.398819

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.459034
    local lower bound updated to 0.399607

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.444992
    local lower bound updated to 0.400687

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.403963
    local lower bound updated to 0.400989

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.113727 seconds.
    local lower bound updated to 0.33146
    local upper bound updated to 0.400989

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.233116 seconds.
    local lower bound updated to 0.396354
    local upper bound updated to 0.400346

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 0.39026 seconds.
    local lower bound updated to 0.397711
    local upper bound updated to 0.398819

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.444454
    local lower bound updated to 0.398819

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.415723
    local lower bound updated to 0.398819

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.129762 seconds.
    local lower bound updated to 0.336905
    local upper bound updated to 0.398819

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.114816 seconds.
    local lower bound updated to 0.398819
    local upper bound updated to 0.398819
The time obtain the optimal randomized assortment is 3.13304 (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_11_4_100.000000_104012.log"
The computation time limit for a lower bound is 85995
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 920 rows, 888 columns and 2773 nonzeros
Model fingerprint: 0x91df0d88
Variable types: 847 continuous, 41 integer (41 binary)
Coefficient statistics:
  Matrix range     [3e-03, 1e+00]
  Objective range  [1e+00, 1e+00]
  Bounds range     [1e+00, 1e+00]
  RHS range        [3e-01, 1e+00]
Presolve removed 357 rows and 632 columns
Presolve time: 0.01s
Presolved: 563 rows, 256 columns, 2048 nonzeros
Variable types: 220 continuous, 36 integer (36 binary)
Found heuristic solution: objective 0.4835541
Found heuristic solution: objective 0.4624647

Root relaxation: objective 3.197044e-01, 104 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.31970    0   13    0.46246    0.31970  30.9%     -    0s
H    0     0                       0.4254575    0.31970  24.9%     -    0s
     0     0    0.35138    0   12    0.42546    0.35138  17.4%     -    0s
H    0     0                       0.4218209    0.35138  16.7%     -    0s
     0     0    0.35138    0   12    0.42182    0.35138  16.7%     -    0s
     0     0    0.37698    0   14    0.42182    0.37698  10.6%     -    0s
H    0     0                       0.4070943    0.37698  7.40%     -    0s
     0     0    0.37725    0   14    0.40709    0.37725  7.33%     -    0s
H    0     0                       0.3988192    0.37725  5.41%     -    0s
     0     0    0.38663    0   13    0.39882    0.38663  3.06%     -    0s
     0     0    0.38788    0   13    0.39882    0.38788  2.74%     -    0s

Cutting planes:
  Gomory: 1
  Implied bound: 58
  MIR: 9
  Flow cover: 41
  RLT: 9
  Relax-and-lift: 20

Explored 1 nodes (721 simplex iterations) in 0.11 seconds (0.04 work units)
Thread count was 4 (of 48 available processors)

Solution count 6: 0.398819 0.407094 0.421821 ... 0.483554

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

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

        Job resource usage summary 

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

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