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 6.13138 seconds.
    local lower bound updated to 0.233474
    local upper bound updated to 0.456852

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.534304
    local lower bound updated to 0.532498

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.534304
    local lower bound updated to 0.534221

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 38.8814 seconds.
    local lower bound updated to 0.323427
    local upper bound updated to 0.453856

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 23.8876 seconds.
    local lower bound updated to 0.443156
    local upper bound updated to 0.450553

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 38.9086 seconds.
    local lower bound updated to 0.444003
    local upper bound updated to 0.448104

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 60.0112 seconds.
    local lower bound updated to 0.444585
    local upper bound updated to 0.447288

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 60.0145 seconds.
    local lower bound updated to 0.44661
    local upper bound updated to 0.446981

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 35.8781 seconds.
    local lower bound updated to 0.446922
    local upper bound updated to 0.446962

    ++ RESTRICTED PRIMAL ITERATION 7 ++
One worst-case parameter optimization takes 40.0933 seconds.
    local lower bound updated to 0.446962
    local upper bound updated to 0.446962
The Primal step takes 297.693 (S)
lower bound updated to 0.446962

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.481932
    local lower bound updated to 0.450042

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.467121
    local lower bound updated to 0.452079

    ++ RESTRICTED DUAL ITERATION 3 ++
    local upper bound updated to 0.467121
    local lower bound updated to 0.452589

    ++ RESTRICTED DUAL ITERATION 4 ++
    local upper bound updated to 0.46374
    local lower bound updated to 0.45689

    ++ RESTRICTED DUAL ITERATION 5 ++
    local upper bound updated to 0.460026
    local lower bound updated to 0.456932

    ++ RESTRICTED DUAL ITERATION 6 ++
    local upper bound updated to 0.458649
    local lower bound updated to 0.45699

    ++ RESTRICTED DUAL ITERATION 7 ++
    local upper bound updated to 0.45699
    local lower bound updated to 0.45699
The Dual step takes 4.83604 (S)
upper bound updated to 0.45699
*** OUTER ITERATION 2 ***

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 60.0181 seconds.
    local lower bound updated to 0.364585
    local upper bound updated to 0.452107

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 60.036 seconds.
    local lower bound updated to 0.437367
    local upper bound updated to 0.449142

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 60.0212 seconds.
    local lower bound updated to 0.447884
    local upper bound updated to 0.448585

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 60.0222 seconds.
    local lower bound updated to 0.448415
    local upper bound updated to 0.448541

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 60.0168 seconds.
    local lower bound updated to 0.448415
    local upper bound updated to 0.448529

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

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.46134
    local lower bound updated to 0.449608

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.453151
    local lower bound updated to 0.450105

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 60.0168 seconds.
    local lower bound updated to 0.378905
    local upper bound updated to 0.450105

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 60.0162 seconds.
    local lower bound updated to 0.442608
    local upper bound updated to 0.449249

    ++ RESTRICTED PRIMAL ITERATION 3 ++
One worst-case parameter optimization takes 60.0182 seconds.
    local lower bound updated to 0.442608
    local upper bound updated to 0.449198

    ++ RESTRICTED PRIMAL ITERATION 4 ++
One worst-case parameter optimization takes 60.0204 seconds.
    local lower bound updated to 0.447976
    local upper bound updated to 0.449145

    ++ RESTRICTED PRIMAL ITERATION 5 ++
One worst-case parameter optimization takes 60.0288 seconds.
    local lower bound updated to 0.448459
    local upper bound updated to 0.449116

    ++ RESTRICTED PRIMAL ITERATION 6 ++
One worst-case parameter optimization takes 60.0259 seconds.
    local lower bound updated to 0.448706
    local upper bound updated to 0.449061

    ++ RESTRICTED PRIMAL ITERATION 7 ++
One worst-case parameter optimization takes 60.0233 seconds.
    local lower bound updated to 0.449061
    local upper bound updated to 0.449061
The Primal step takes 420.195 (S)
lower bound updated to 0.449061

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.459162
    local lower bound updated to 0.449076

    ++ RESTRICTED DUAL ITERATION 2 ++
    local upper bound updated to 0.454586
    local lower bound updated to 0.449248

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 60.0309 seconds.
    local lower bound updated to 0.390807
    local upper bound updated to 0.449248

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 60.0302 seconds.
    local lower bound updated to 0.449239
    local upper bound updated to 0.449248
The Primal step takes 120.074 (S)
lower bound updated to 0.449239

    ++ RESTRICTED DUAL ITERATION 1 ++
    local upper bound updated to 0.458266
    local lower bound updated to 0.449248

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

    ++ RESTRICTED PRIMAL ITERATION 1 ++
One worst-case parameter optimization takes 60.0234 seconds.
    local lower bound updated to 0.390807
    local upper bound updated to 0.449248

    ++ RESTRICTED PRIMAL ITERATION 2 ++
One worst-case parameter optimization takes 60.0266 seconds.
    local lower bound updated to 0.449248
    local upper bound updated to 0.449248
The time obtain the optimal randomized assortment is 1358.9 (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_19_4_60.000000_61520.log"
The computation time limit for a lower bound is 84629
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 3276 rows, 2398 columns and 11090 nonzeros
Model fingerprint: 0x33f47d5e
Variable types: 2325 continuous, 73 integer (73 binary)
Coefficient statistics:
  Matrix range     [5e-04, 1e+00]
  Objective range  [1e+00, 1e+00]
  Bounds range     [1e+00, 1e+00]
  RHS range        [3e-01, 1e+00]
Presolve removed 624 rows and 1166 columns
Presolve time: 0.04s
Presolved: 2652 rows, 1232 columns, 10331 nonzeros
Variable types: 1163 continuous, 69 integer (69 binary)
Found heuristic solution: objective 0.6561260
Found heuristic solution: objective 0.6472111
Found heuristic solution: objective 0.4974275

Root relaxation: objective 3.303335e-01, 297 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.33033    0   26    0.49743    0.33033  33.6%     -    0s
     0     0    0.33355    0   30    0.49743    0.33355  32.9%     -    0s
     0     0    0.36344    0   33    0.49743    0.36344  26.9%     -    0s
H    0     0                       0.4619482    0.36344  21.3%     -    0s
     0     0    0.36347    0   33    0.46195    0.36347  21.3%     -    0s
H    0     0                       0.4604825    0.37292  19.0%     -    0s
     0     0    0.37292    0   34    0.46048    0.37292  19.0%     -    0s
H    0     0                       0.4590652    0.37292  18.8%     -    0s
H    0     0                       0.4574766    0.37326  18.4%     -    0s
     0     0    0.37326    0   34    0.45748    0.37326  18.4%     -    0s
H    0     0                       0.4558135    0.37326  18.1%     -    0s
     0     0    0.37691    0   34    0.45581    0.37691  17.3%     -    0s
H    0     0                       0.4497636    0.37691  16.2%     -    0s
     0     0    0.37736    0   35    0.44976    0.37736  16.1%     -    0s
     0     0    0.37817    0   31    0.44976    0.37817  15.9%     -    0s
H    0     0                       0.4492475    0.37817  15.8%     -    3s
     0     2    0.37817    0   31    0.44925    0.37817  15.8%     -    3s
   198   118    0.40716    9   16    0.44925    0.38395  14.5%  39.8    6s
   796   346    0.43087   16   10    0.44925    0.39586  11.9%  33.7   10s
  1390   517    0.44658   17    8    0.44925    0.40032  10.9%  30.3   15s
  2275   759    0.41529   12   31    0.44925    0.40330  10.2%  28.5   20s
  2355   817    0.41358   23   19    0.44925    0.40330  10.2%  31.5   25s
  2631   848    0.44016   31    6    0.44925    0.40330  10.2%  32.9   30s
H 2784   816                       0.4492475    0.40330  10.2%  33.5   30s
  3095   806    0.41407   24   16    0.44925    0.40405  10.1%  34.0   35s
  3391   845    0.41047   24   16    0.44925    0.40566  9.70%  34.3   40s
  3673   869     cutoff   23         0.44925    0.40741  9.31%  34.9   46s
  3878   837     cutoff   32         0.44925    0.40842  9.09%  35.0   50s
  4353   832    0.44702   31   13    0.44925    0.40929  8.89%  35.5   55s
  5513  1185 infeasible   30         0.44925    0.41124  8.46%  35.3   60s
  6295  1337    0.44639   28   13    0.44925    0.41248  8.18%  35.4   66s
  6557  1433    0.43708   26   16    0.44925    0.41251  8.18%  35.4   70s
  7175  1584    0.44146   33   11    0.44925    0.41395  7.86%  35.5   76s
  7936  1730    0.42125   26   14    0.44925    0.41484  7.66%  35.4   80s
  8953  1866     cutoff   33         0.44925    0.41582  7.44%  35.0   86s
  9637  2034    0.44674   27   20    0.44925    0.41667  7.25%  34.9   91s
 10352  2189     cutoff   33         0.44925    0.41700  7.18%  34.7   95s
 12048  2440     cutoff   32         0.44925    0.41827  6.89%  34.5  102s
 12851  2529    0.44037   30   10    0.44925    0.41868  6.80%  34.3  107s
 13169  2596     cutoff   29         0.44925    0.41918  6.69%  34.3  112s
 14377  2779     cutoff   33         0.44925    0.41973  6.57%  34.2  116s
 15257  2886    0.44474   29   12    0.44925    0.42008  6.49%  34.1  123s
 15870  2981     cutoff   27         0.44925    0.42042  6.42%  34.2  125s
 17287  3132    0.43274   26   16    0.44925    0.42114  6.26%  34.0  131s
 18525  3188    0.44550   29   12    0.44925    0.42198  6.07%  33.8  137s
 18926  3239    0.44737   34    8    0.44925    0.42212  6.04%  33.9  140s
H19400  3294                       0.4492475    0.42236  5.98%  33.8  142s
H19819  3301                       0.4492475    0.42238  5.98%  33.7  145s
 21592  3438     cutoff   35         0.44925    0.42329  5.78%  33.6  151s
 22409  3549    0.44246   32   13    0.44925    0.42349  5.73%  33.6  155s
H23559  3575                       0.4492475    0.42374  5.68%  33.5  158s
 23560  3604    0.44371   33    8    0.44925    0.42380  5.66%  33.5  161s
 24797  3635     cutoff   29         0.44925    0.42433  5.55%  33.4  165s
 25545  3760     cutoff   36         0.44925    0.42459  5.49%  33.4  170s
 26622  3842    0.44484   30    6    0.44925    0.42487  5.43%  33.4  177s
 27654  3885    0.43435   30   16    0.44925    0.42530  5.33%  33.3  183s
 28042  3890    0.44457   34    8    0.44925    0.42539  5.31%  33.2  185s
 29069  3918    0.44587   29   10    0.44925    0.42575  5.23%  33.1  190s
 30304  3955     cutoff   35         0.44925    0.42589  5.20%  33.1  197s
 30916  3976     cutoff   35         0.44925    0.42622  5.13%  33.1  200s
 32132  4015 infeasible   32         0.44925    0.42653  5.06%  32.9  205s
 32983  4035    0.44523   33    8    0.44925    0.42682  4.99%  32.9  210s
 33806  4050     cutoff   30         0.44925    0.42716  4.92%  32.9  215s
 35338  4092    0.44346   32   14    0.44925    0.42749  4.84%  32.9  222s
 35942  4110     cutoff   32         0.44925    0.42771  4.79%  32.9  225s
 37558  4094     cutoff   31         0.44925    0.42822  4.68%  32.9  233s
 38116  4113    0.44343   30   10    0.44925    0.42848  4.62%  32.9  236s
 39571  4103    0.44292   27   14    0.44925    0.42888  4.53%  33.0  242s
H40183  4103                       0.4492475    0.42907  4.49%  33.0  242s
 40265  4069 infeasible   32         0.44925    0.42911  4.48%  33.0  245s
 41493  4051 infeasible   33         0.44925    0.42948  4.40%  32.9  250s
H42607  4041                       0.4492475    0.42969  4.35%  32.9  252s
 42608  4009    0.44138   31   12    0.44925    0.42970  4.35%  32.9  255s
H43198  4009                       0.4492475    0.43000  4.28%  32.8  255s
H43200  3994                       0.4492475    0.43000  4.28%  32.8  256s
H43427  3994                       0.4492475    0.43000  4.28%  32.8  256s
 43967  3970    0.43866   32   12    0.44925    0.43016  4.25%  32.8  262s
H44334  3970                       0.4492475    0.43018  4.24%  32.8  262s
 44708  3919     cutoff   33         0.44925    0.43048  4.18%  32.8  265s
 46153  3902 infeasible   34         0.44925    0.43084  4.10%  32.8  271s
 46255  3864    0.44069   32   10    0.44925    0.43085  4.09%  32.7  275s
H46446  3864                       0.4492475    0.43086  4.09%  32.8  275s
 47760  3783     cutoff   35         0.44925    0.43129  4.00%  32.7  280s
 49350  3708     cutoff   33         0.44925    0.43181  3.88%  32.7  287s
H49854  3708                       0.4492475    0.43184  3.88%  32.8  287s
 50106  3639    0.44051   31   16    0.44925    0.43208  3.82%  32.7  291s
H50879  3639                       0.4492475    0.43209  3.82%  32.7  291s
 51156  3569    0.44819   32   10    0.44925    0.43236  3.76%  32.7  295s
 52255  3497     cutoff   34         0.44925    0.43283  3.65%  32.7  302s
 53283  3396     cutoff   32         0.44925    0.43309  3.60%  32.6  307s
H53622  3396                       0.4492475    0.43311  3.59%  32.6  307s
 53782  3336     cutoff   35         0.44925    0.43318  3.58%  32.6  310s
H53900  3336                       0.4492475    0.43318  3.58%  32.6  310s
H55006  3302                       0.4492475    0.43346  3.51%  32.5  312s
H55218  3302                       0.4492474    0.43348  3.51%  32.5  312s
 55219  3236     cutoff   31         0.44925    0.43355  3.49%  32.5  315s
H55764  3236                       0.4492474    0.43370  3.46%  32.5  315s
 56687  3150 infeasible   30         0.44925    0.43417  3.36%  32.5  321s
 57730  3024    0.44860   36    5    0.44925    0.43475  3.23%  32.4  325s
 58925  2836     cutoff   31         0.44925    0.43537  3.09%  32.4  331s
 60476  2707     cutoff   34         0.44925    0.43587  2.98%  32.3  337s
 61305  2554    0.44406   35    9    0.44925    0.43640  2.86%  32.3  341s
 62197  2470 infeasible   27         0.44925    0.43678  2.78%  32.2  346s
 62649  2358    0.44545   37    9    0.44925    0.43720  2.68%  32.2  350s
 63710  2168    0.44439   36   13    0.44925    0.43753  2.61%  32.1  355s
 65558  1907    0.44257   29   10    0.44925    0.43871  2.35%  32.0  360s
H66917  1753                       0.4492474    0.43949  2.17%  31.8  364s
 66918  1753 infeasible   30         0.44925    0.43950  2.17%  31.8  366s
 67948  1344     cutoff   30         0.44925    0.44086  1.87%  31.7  372s
 69050   844     cutoff   28         0.44925    0.44210  1.59%  31.6  376s
 70374   300     cutoff   29         0.44925    0.44517  0.91%  31.4  380s

Cutting planes:
  Implied bound: 367
  MIR: 189
  Flow cover: 467
  RLT: 45
  Relax-and-lift: 180

Explored 71030 nodes (2221855 simplex iterations) in 382.30 seconds (346.17 work units)
Thread count was 4 (of 48 available processors)

Solution count 10: 0.449247 0.449248 0.449764 ... 0.647211

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

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

        Job resource usage summary 

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

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