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.163016 seconds.
    local lower bound updated to 0.216231
    local upper bound updated to 0.428923

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.535467
    local lower bound updated to 0.515061

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.2549 seconds.
    local lower bound updated to 0.261632
    local upper bound updated to 0.427042

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.245265 seconds.
    local lower bound updated to 0.423368
    local upper bound updated to 0.423814

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.466804
    local lower bound updated to 0.428448

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.45082
    local lower bound updated to 0.445365

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.45082
    local lower bound updated to 0.450123

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 0.919077 seconds.
    local lower bound updated to 0.350462
    local upper bound updated to 0.447155

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 0.673353 seconds.
    local lower bound updated to 0.431395
    local upper bound updated to 0.444816

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 0.940838 seconds.
    local lower bound updated to 0.442525
    local upper bound updated to 0.444128

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 0.97679 seconds.
    local lower bound updated to 0.442525
    local upper bound updated to 0.443951

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 0.89752 seconds.
    local lower bound updated to 0.443819
    local upper bound updated to 0.443887

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 1.02611 seconds.
    local lower bound updated to 0.443887
    local upper bound updated to 0.443887
The Primal step takes 5.44991 (S)
lower bound updated to 0.443887

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.462035
    local lower bound updated to 0.443887

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.445705
    local lower bound updated to 0.443986

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 1.07131 seconds.
    local lower bound updated to 0.361184
    local upper bound updated to 0.443986

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 1.254 seconds.
    local lower bound updated to 0.440942
    local upper bound updated to 0.443932

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 1.03391 seconds.
    local lower bound updated to 0.442721
    local upper bound updated to 0.443892

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 1.48996 seconds.
    local lower bound updated to 0.443796
    local upper bound updated to 0.443887

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.471926
    local lower bound updated to 0.443887

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.444052
    local lower bound updated to 0.443887

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 1.17829 seconds.
    local lower bound updated to 0.371172
    local upper bound updated to 0.443887

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 1.65774 seconds.
    local lower bound updated to 0.443887
    local upper bound updated to 0.443887
The time obtain the optimal randomized assortment is 17.0174 (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_64314.log"
The computation time limit for a lower bound is 85981
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 3792 nonzeros
Model fingerprint: 0x9f02e8b4
Variable types: 1009 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        [2e-01, 1e+00]
Presolve removed 358 rows and 678 columns
Presolve time: 0.01s
Presolved: 854 rows, 380 columns, 3262 nonzeros
Variable types: 334 continuous, 46 integer (46 binary)
Found heuristic solution: objective 0.5647774
Found heuristic solution: objective 0.4690436

Root relaxation: objective 3.225031e-01, 125 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.32250    0   14    0.46904    0.32250  31.2%     -    0s
H    0     0                       0.4684056    0.32526  30.6%     -    0s
H    0     0                       0.4671421    0.32526  30.4%     -    0s
     0     0    0.32526    0   18    0.46714    0.32526  30.4%     -    0s
     0     0    0.33038    0   18    0.46714    0.33038  29.3%     -    0s
     0     0    0.36821    0   20    0.46714    0.36821  21.2%     -    0s
H    0     0                       0.4634037    0.36821  20.5%     -    0s
     0     0    0.36887    0   19    0.46340    0.36887  20.4%     -    0s
     0     0    0.37828    0   18    0.46340    0.37828  18.4%     -    0s
H    0     0                       0.4444378    0.37828  14.9%     -    0s
     0     0    0.38209    0   16    0.44444    0.38209  14.0%     -    0s
H    0     0                       0.4444067    0.38209  14.0%     -    0s
     0     0    0.38824    0   18    0.44441    0.38824  12.6%     -    0s
H    0     0                       0.4441412    0.39092  12.0%     -    0s
     0     0    0.39092    0   18    0.44414    0.39092  12.0%     -    0s
     0     0    0.39372    0   16    0.44414    0.39372  11.4%     -    0s
H    0     0                       0.4438872    0.39372  11.3%     -    0s
     0     2    0.39372    0   16    0.44389    0.39372  11.3%     -    0s

Cutting planes:
  Implied bound: 107
  MIR: 22
  Flow cover: 108
  RLT: 20
  Relax-and-lift: 34

Explored 903 nodes (13532 simplex iterations) in 1.65 seconds (0.94 work units)
Thread count was 4 (of 40 available processors)

Solution count 9: 0.443887 0.444141 0.444407 ... 0.564777

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

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

        Job resource usage summary 

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

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