[QUOTE=wombatman;497391]I was able to get the linear algebra to re-run by deleting the bwc folder under the /tmp/ work directory. Just posting this in case someone else runs into the same issue (or I do again...)[/QUOTE]
That sounds good. I wondered if there may be a way, but I don't know enough about CADO-NFS to know where to look. I remember deleting some files to rerun some msieve steps in a similar fashion, but I'd have to research what files I did that with, too.

I'm running a C146 using the default parameters.c145 using CADO-NFS (3.0-dev of a few months old)
So I can compare it with VBCurtis better parameters :)

I did do two C116s with different parameters, but the difference was negligible:

Aliquot 2515098 index 518 C116 (default c115 parameters)
[code]57260624163558114907105482591325041150144795085724341980289789123163352120442484657512017354806368372606893536015689[/code][code]Info:Square Root: Factors: 5366819040225876374810043852991007541729343594563691842154849129 10669378589882202242046713973010894938014632978556641
Info:Polynomial Selection (size optimized): Aggregate statistics:
Info:Polynomial Selection (size optimized): potential collisions: 21492.9
Info:Polynomial Selection (size optimized): raw lognorm (nr/min/av/max/std): 21788/33.700/41.357/46.600/1.112
Info:Polynomial Selection (size optimized): optimized lognorm (nr/min/av/max/std): 21788/32.870/36.651/41.770/0.956
Info:Polynomial Selection (size optimized): Total time: 2839.91
Info:Polynomial Selection (root optimized): Aggregate statistics:
Info:Polynomial Selection (root optimized): Total time: 501.88
Info:Polynomial Selection (root optimized): Rootsieve time: 500.25
Info:Generate Factor Base: Total cpu/real time for makefb: 9.41/0.595049
Info:Generate Free Relations: Total cpu/real time for freerel: 108.79/3.46431
Info:Lattice Sieving: Aggregate statistics:
Info:Lattice Sieving: Total number of relations: 7476517
Info:Lattice Sieving: Average J: 1911.27 for 175501 special-q, max bucket fill -bkmult 1.0,1s:1.156260
Info:Lattice Sieving: Total time: 39802.7s
Info:Filtering - Duplicate Removal, splitting pass: Total cpu/real time for dup1: 26.93/38.9862
Info:Filtering - Duplicate Removal, splitting pass: Aggregate statistics:
Info:Filtering - Duplicate Removal, splitting pass: CPU time for dup1: 37.9s
Info:Filtering - Duplicate Removal, removal pass: Total cpu/real time for dup2: 206.85/149.014
Info:Filtering - Duplicate Removal, removal pass: Aggregate statistics:
Info:Filtering - Duplicate Removal, removal pass: CPU time for dup2: 125.0s
Info:Filtering - Singleton removal: Total cpu/real time for purge: 177.66/156.63
Info:Filtering - Merging: Total cpu/real time for merge: 177.67/141.849
Info:Filtering - Merging: Total cpu/real time for replay: 22.74/18.5985
Info:Linear Algebra: Total cpu/real time for bwc: 4464.77/404.3
Info:Linear Algebra: Aggregate statistics:
Info:Linear Algebra: Krylov: WCT time 238.7, iteration CPU time 0.01, COMM 0.0, cpu-wait 0.0, comm-wait 0.0 (15000 iterations)
Info:Linear Algebra: Lingen CPU time 189.98, WCT time 17.9
Info:Linear Algebra: Mksol: WCT time 127.46, iteration CPU time 0.01, COMM 0.0, cpu-wait 0.0, comm-wait 0.0 (7000 iterations)
Info:Quadratic Characters: Total cpu/real time for characters: 32.85/5.83791
Info:Square Root: Total cpu/real time for sqrt: 550.98/79.8058
Info:Complete Factorization: Total cpu/elapsed time for entire factorization: 102295/3488.36[/code]Aliquot 2324328 index 1754 C116 (parameters from [URL]https://mersenneforum.org/showpost.php?p=493816&postcount=294[/URL])
[code]16231073505513910375586118092559047695476874861018044665771298171360337986331251933825629231182569153705365622682051[/code][code]Info:Square Root: Factors: 24031256700679804831899451534455089680339988350903629141920263071775427401 675415094086809031967441080036510893844651
Info:Polynomial Selection (size optimized): Aggregate statistics:
Info:Polynomial Selection (size optimized): potential collisions: 12883.5
Info:Polynomial Selection (size optimized): raw lognorm (nr/min/av/max/std): 13313/32.880/41.399/50.410/1.390
Info:Polynomial Selection (size optimized): optimized lognorm (nr/min/av/max/std): 13313/32.880/36.561/42.320/1.095
Info:Polynomial Selection (size optimized): Total time: 2000.54
Info:Polynomial Selection (root optimized): Aggregate statistics:
Info:Polynomial Selection (root optimized): Total time: 523.23
Info:Polynomial Selection (root optimized): Rootsieve time: 522.04
Info:Generate Factor Base: Total cpu/real time for makefb: 6.27/0.403468
Info:Generate Free Relations: Total cpu/real time for freerel: 216.27/6.85179
Info:Lattice Sieving: Aggregate statistics:
Info:Lattice Sieving: Total number of relations: 13327906
Info:Lattice Sieving: Average J: 1888.34 for 188639 special-q, max bucket fill -bkmult 1.0,1s:1.177090
Info:Lattice Sieving: Total time: 40384.9s
Info:Filtering - Duplicate Removal, splitting pass: Total cpu/real time for dup1: 47.52/70.735
Info:Filtering - Duplicate Removal, splitting pass: Aggregate statistics:
Info:Filtering - Duplicate Removal, splitting pass: CPU time for dup1: 70.19999999999999s
Info:Filtering - Duplicate Removal, removal pass: Total cpu/real time for dup2: 289.07/166.718
Info:Filtering - Duplicate Removal, removal pass: Aggregate statistics:
Info:Filtering - Duplicate Removal, removal pass: CPU time for dup2: 140.10000000000002s
Info:Filtering - Singleton removal: Total cpu/real time for purge: 191.33/155.735
Info:Filtering - Merging: Total cpu/real time for merge: 156.48/120.167
Info:Filtering - Merging: Total cpu/real time for replay: 22.89/18.0962
Info:Linear Algebra: Total cpu/real time for bwc: 4680.55/469.7
Info:Linear Algebra: Aggregate statistics:
Info:Linear Algebra: Krylov: WCT time 292.48, iteration CPU time 0.01, COMM 0.0, cpu-wait 0.01, comm-wait 0.0 (14000 iterations)
Info:Linear Algebra: Lingen CPU time 184.26, WCT time 17.55
Info:Linear Algebra: Mksol: WCT time 138.62, iteration CPU time 0.01, COMM 0.0, cpu-wait 0.0, comm-wait 0.0 (7000 iterations)
Info:Quadratic Characters: Total cpu/real time for characters: 35.84/6.89125
Info:Square Root: Total cpu/real time for sqrt: 660.36/92.6011
Info:HTTP server: Shutting down HTTP server
Info:Complete Factorization: Total cpu/elapsed time for entire factorization: 101763/3579.63[/code]

Aliquot 2380332 index 1881 C120 (default parameters)

[code]199287076077883734257277351040454144441000030759204246737980837594631635996650954243527367115572838436022957492373596441
[/code][code]nfo:Square Root: Factors: 7881718165498387521633582355355082520893963326151214533539440818991 25284724966473365753246256372756737619902873207696951
Info:Polynomial Selection (size optimized): Aggregate statistics:
Info:Polynomial Selection (size optimized): potential collisions: 19893.3
Info:Polynomial Selection (size optimized): raw lognorm (nr/min/av/max/std): 20038/34.700/42.654/47.580/1.068
Info:Polynomial Selection (size optimized): optimized lognorm (nr/min/av/max/std): 20038/33.860/37.787/43.120/0.946
Info:Polynomial Selection (size optimized): Total time: 4368.44
Info:Polynomial Selection (root optimized): Aggregate statistics:
Info:Polynomial Selection (root optimized): Total time: 1693.06
Info:Polynomial Selection (root optimized): Rootsieve time: 1691.2
Info:Generate Factor Base: Total cpu/real time for makefb: 11.41/0.716381
Info:Generate Free Relations: Total cpu/real time for freerel: 215.96/6.88374
Info:Lattice Sieving: Aggregate statistics:
Info:Lattice Sieving: Total number of relations: 13210726
Info:Lattice Sieving: Average J: 1886.16 for 231501 special-q, max bucket fill -bkmult 1.0,1s:1.181410
Info:Lattice Sieving: Total time: 57872.1s
Info:Filtering - Duplicate Removal, splitting pass: Total cpu/real time for dup1: 46.94/79.2834
Info:Filtering - Duplicate Removal, splitting pass: Aggregate statistics:
Info:Filtering - Duplicate Removal, splitting pass: CPU time for dup1: 78.29999999999998s
Info:Filtering - Duplicate Removal, removal pass: Total cpu/real time for dup2: 368.44/240.362
Info:Filtering - Duplicate Removal, removal pass: Aggregate statistics:
Info:Filtering - Duplicate Removal, removal pass: CPU time for dup2: 200.29999999999998s
Info:Filtering - Singleton removal: Total cpu/real time for purge: 282.74/235.527
Info:Filtering - Merging: Total cpu/real time for merge: 280.69/221.189
Info:Filtering - Merging: Total cpu/real time for replay: 30.63/24.3347
Info:Linear Algebra: Total cpu/real time for bwc: 8233.92/769.52
Info:Linear Algebra: Aggregate statistics:
Info:Linear Algebra: Krylov: WCT time 469.89, iteration CPU time 0.02, COMM 0.0, cpu-wait 0.01, comm-wait 0.0 (19000 iterations)
Info:Linear Algebra: Lingen CPU time 247.53, WCT time 24.12
Info:Linear Algebra: Mksol: WCT time 257.82, iteration CPU time 0.02, COMM 0.0, cpu-wait 0.01, comm-wait 0.0 (9500 iterations)
Info:Quadratic Characters: Total cpu/real time for characters: 48.31/9.27324
Info:Square Root: Total cpu/real time for sqrt: 892.67/125.86
Info:HTTP server: Shutting down HTTP server
Info:Complete Factorization: Total cpu/elapsed time for entire factorization: 147386/5296.77
[/code]Aliquot 2729472 index 1295 C120 parameters from [URL]https://mersenneforum.org/showpost.php?p=493816&postcount=294[/URL]

[code]205139061732834871832777149640498376066462709627022246947242115024979684074456599994309638679576103310646656416412986993[/code][code]Info:Square Root: Factors: 551378319562220129379188795853993269123323508651567304673518464786424349 372047747353776779859748207675312690256707865957
Info:Square Root: Total cpu/real time for sqrt: 883.47/124.153
Info:Polynomial Selection (size optimized): Aggregate statistics:
Info:Polynomial Selection (size optimized): potential collisions: 20828.5
Info:Polynomial Selection (size optimized): raw lognorm (nr/min/av/max/std): 20997/35.120/43.125/51.980/1.501
Info:Polynomial Selection (size optimized): optimized lognorm (nr/min/av/max/std): 20997/34.030/37.941/43.730/1.044
Info:Polynomial Selection (size optimized): Total time: 4206.01
Info:Polynomial Selection (root optimized): Aggregate statistics:
Info:Polynomial Selection (root optimized): Total time: 1018.39
Info:Polynomial Selection (root optimized): Rootsieve time: 1017.02
Info:Generate Factor Base: Total cpu/real time for makefb: 11.48/0.695448
Info:Generate Free Relations: Total cpu/real time for freerel: 425.41/13.5391
Info:Lattice Sieving: Aggregate statistics:
Info:Lattice Sieving: Total number of relations: 17128933
Info:Lattice Sieving: Average J: 1906.83 for 200409 special-q, max bucket fill -bkmult 1.0,1s:1.224170
Info:Lattice Sieving: Total time: 53632.9s
Info:Filtering - Duplicate Removal, splitting pass: Total cpu/real time for dup1: 60.59/98.9291
Info:Filtering - Duplicate Removal, splitting pass: Aggregate statistics:
Info:Filtering - Duplicate Removal, splitting pass: CPU time for dup1: 98.8s
Info:Filtering - Duplicate Removal, removal pass: Total cpu/real time for dup2: 301.1/103.734
Info:Filtering - Duplicate Removal, removal pass: Aggregate statistics:
Info:Filtering - Duplicate Removal, removal pass: CPU time for dup2: 95.39999999999999s
Info:Filtering - Singleton removal: Total cpu/real time for purge: 124.38/42.177
Info:Filtering - Merging: Total cpu/real time for merge: 202.8/152.94
Info:Filtering - Merging: Total cpu/real time for replay: 28.72/22.8961
Info:Linear Algebra: Total cpu/real time for bwc: 8543.11/836.9
Info:Linear Algebra: Aggregate statistics:
Info:Linear Algebra: Krylov: WCT time 485.25, iteration CPU time 0.02, COMM 0.0, cpu-wait 0.01, comm-wait 0.0 (19000 iterations)
Info:Linear Algebra: Lingen CPU time 232.35, WCT time 22.34
Info:Linear Algebra: Mksol: WCT time 303.19, iteration CPU time 0.02, COMM 0.0, cpu-wait 0.01, comm-wait 0.0 (10000 iterations)
Info:Quadratic Characters: Total cpu/real time for characters: 45.39/7.23988
Info:Square Root: Total cpu/real time for sqrt: 883.47/124.153
Info:HTTP server: Shutting down HTTP server
Info:Complete Factorization: Total cpu/elapsed time for entire factorization: 139378/5141.93
[/code]So those do improve CPU and elapsed time.
147386/5296.77
[B]139378/5141.93[/B]

I sent my params files for C120 and lower to CADO in early 2018; I believe they're included in the 3.0 git versions. The "new" params you list from the forum in August are the result of trying to eke out 5% more speed, e.g. from spending less time in poly select.

I think I didn't have a clear case that the new August params were obviously faster, so I didn't send them to the CADO folks. I do believe they're faster, but barely so. In your case, the second input was a factor of 3 smaller, so "should" have been ~5% faster even using the same params; yet, in this test, the second job was ~500 thread-sec faster (0.5%). Hrmmm

Thanks for reporting your test!

I get a 30% improvement (faster sieving and smaller matrix) compared to current git for a c100 with this patch:
[CODE]diff --git a/parameters/factor/params.c100 b/parameters/factor/params.c100
index e0f8b151c..e72a78e41 100644
--- a/parameters/factor/params.c100
+++ b/parameters/factor/params.c100
@@ -27,18 +27,23 @@ tasks.polyselect.ropteffort = 0.5
# Sieve
###########################################################################

-tasks.lim0 = 919082
-tasks.lim1 = 1051872
-tasks.lpb0 = 24
-tasks.lpb1 = 25
-tasks.sieve.mfb0 = 49
-tasks.sieve.mfb1 = 50
+tasks.lim0 = 620000
+tasks.lim1 = 950000
+tasks.lpb0 = 26
+tasks.lpb1 = 26
+tasks.sieve.mfb0 = 52
+tasks.sieve.mfb1 = 52
tasks.sieve.ncurves0 = 11
tasks.sieve.ncurves1 = 16
-tasks.I = 11
+tasks.sieve.lambda0 = 1.775
+tasks.sieve.lambda1 = 1.775
+tasks.I = 12
+
+#tasks.sieve.qrange = 10000
+tasks.sieve.qrange = 2000
+tasks.qmin = 300000
+tasks.sieve.rels_wanted = 3200000

-tasks.sieve.qrange = 10000
-tasks.qmin = 1051872

###########################################################################
# Filtering[/CODE]

[QUOTE=Gimarel;502155]I get a 30% improvement (faster sieving and smaller matrix) compared to current git for a c100 with this patch:
[/QUOTE]
RSA100

[B]default params[/B]
Total cpu/elapsed time for entire factorization:
22154.3/645.17

[B]Your params[/B]
Total cpu/elapsed time for entire factorization:
16324.5/624.355

:bow:

Attached is a new params file for C105. (delete the .txt suffix for CADO to recognise)
I've discovered that adding ~5% to target relations wanted yields a 30-50% reduction in matrix-solve time. Second, starting at very low Q produces lots of duplicate relations, but still sieves faster than a more normal starting Q value. I've moved Qmin from lim0 / 4 to lim0 / 16.

I appreciate any comparison runs to CADO-git 3.0 or msieve/factmsieve.py.

[QUOTE=VBCurtis;504740]Attached is a new params file for C105. (delete the .txt suffix for CADO to recognise)
I've discovered that adding ~5% to target relations wanted yields a 30-50% reduction in matrix-solve time. Second, starting at very low Q produces lots of duplicate relations, but still sieves faster than a more normal starting Q value. I've moved Qmin from lim0 / 4 to lim0 / 16.

I appreciate any comparison runs to CADO-git 3.0 or msieve/factmsieve.py.[/QUOTE]


default c105 params

[code]109632612184518587513828778388808335173534513011647049031182822755389306787273092842624843623516386466817[/code] [code]Info:Polynomial Selection (size optimized): Aggregate statistics:
Info:Polynomial Selection (size optimized): potential collisions: 9952.64
Info:Polynomial Selection (size optimized): raw lognorm (nr/min/av/max/std): 9418/30.140/36.778/42.590/1.071
Info:Polynomial Selection (size optimized): optimized lognorm (nr/min/av/max/std): 9418/29.410/32.699/37.260/0.964
Info:Polynomial Selection (size optimized): Total time: 808.92
Info:Polynomial Selection (root optimized): Aggregate statistics:
Info:Polynomial Selection (root optimized): Total time: 235.3
Info:Polynomial Selection (root optimized): Rootsieve time: 234.53
Info:Generate Factor Base: Total cpu/real time for makefb: 3.32/0.233966
Info:Generate Free Relations: Total cpu/real time for freerel: 107.57/3.43082
Info:Lattice Sieving: Aggregate statistics:
Info:Lattice Sieving: Total number of relations: 5314822
Info:Lattice Sieving: Average J: 1901.73 for 48049 special-q, max bucket fill -bkmult 1.0,1s:1.191890
Info:Lattice Sieving: Total time: 9941.66s
Info:Filtering - Duplicate Removal, splitting pass: Total cpu/real time for dup1: 18.54/26.7606
Info:Filtering - Duplicate Removal, splitting pass: Aggregate statistics:
Info:Filtering - Duplicate Removal, splitting pass: CPU time for dup1: 26.4s
Info:Filtering - Duplicate Removal, removal pass: Total cpu/real time for dup2: 85.03/49.4793
Info:Filtering - Duplicate Removal, removal pass: Aggregate statistics:
Info:Filtering - Duplicate Removal, removal pass: CPU time for dup2: 43.599999999999994s
Info:Filtering - Singleton removal: Total cpu/real time for purge: 61.84/31.2877
Info:Filtering - Merging: Total cpu/real time for merge: 61.04/42.6015
Info:Filtering - Merging: Total cpu/real time for replay: 8.2/6.48986
Info:Linear Algebra: Total cpu/real time for bwc: 743.78/87.26
Info:Linear Algebra: Aggregate statistics:
Info:Linear Algebra: Krylov: WCT time 50.75, iteration CPU time 0, COMM 0.0, cpu-wait 0.0, comm-wait 0.0 (6000 iterations)
Info:Linear Algebra: Lingen CPU time 59.71, WCT time 5.66
Info:Linear Algebra: Mksol: WCT time 12.55, iteration CPU time 0, COMM 0.0, cpu-wait 0.0, comm-wait 0.0 (3000 iterations)
Info:Quadratic Characters: Total cpu/real time for characters: 11.27/1.93752
Info:Square Root: Total cpu/real time for sqrt: 183.65/27.1619
Info:HTTP server: Shutting down HTTP server
Info:Complete Factorization: Total cpu/elapsed time for entire factorization: 29423.9/1054.2
20134157657651598100858476591180697221596297298877 5445105479386907888285946208202118057060224985751395221
[/code][B]29,424 CPUsec / 1,054 WCT[/B]

new c105 params
[code]107774169621361997338509361816744634033698066592448031046848063179170577441576972428346870619448060739421[/code][code]Info:Polynomial Selection (size optimized): Aggregate statistics:
Info:Polynomial Selection (size optimized): potential collisions: 4473.5
Info:Polynomial Selection (size optimized): raw lognorm (nr/min/av/max/std): 4331/30.060/37.058/44.280/1.429
Info:Polynomial Selection (size optimized): optimized lognorm (nr/min/av/max/std): 4331/29.800/32.734/37.690/1.062
Info:Polynomial Selection (size optimized): Total time: 413.75
Info:Polynomial Selection (root optimized): Aggregate statistics:
Info:Polynomial Selection (root optimized): Total time: 156.39
Info:Polynomial Selection (root optimized): Rootsieve time: 155.82
Info:Generate Factor Base: Total cpu/real time for makefb: 2.9/0.21063
Info:Generate Free Relations: Total cpu/real time for freerel: 107.34/3.42818
Info:Lattice Sieving: Aggregate statistics:
Info:Lattice Sieving: Total number of relations: 5795540
Info:Lattice Sieving: Average J: 1920.26 for 48157 special-q, max bucket fill -bkmult 1.0,1s:1.252780
Info:Lattice Sieving: Total time: 9458.12s
Info:Filtering - Duplicate Removal, splitting pass: Total cpu/real time for dup1: 19.41/27.519
Info:Filtering - Duplicate Removal, splitting pass: Aggregate statistics:
Info:Filtering - Duplicate Removal, splitting pass: CPU time for dup1: 27.2s
Info:Filtering - Duplicate Removal, removal pass: Total cpu/real time for dup2: 88/33.5168
Info:Filtering - Duplicate Removal, removal pass: Aggregate statistics:
Info:Filtering - Duplicate Removal, removal pass: CPU time for dup2: 29.499999999999996s
Info:Filtering - Singleton removal: Total cpu/real time for purge: 40.61/18.0718
Info:Filtering - Merging: Total cpu/real time for merge: 92.75/64.2703
Info:Filtering - Merging: Total cpu/real time for replay: 11.11/8.90364
Info:Linear Algebra: Total cpu/real time for bwc: 995.79/81.67
Info:Linear Algebra: Aggregate statistics:
Info:Linear Algebra: Krylov: WCT time 36.87, iteration CPU time 0, COMM 0.0, cpu-wait 0.0, comm-wait 0.0 (7000 iterations)
Info:Linear Algebra: Lingen CPU time 82.87, WCT time 7.8
Info:Linear Algebra: Mksol: WCT time 27.01, iteration CPU time 0.01, COMM 0.0, cpu-wait 0.0, comm-wait 0.0 (4000 iterations)
Info:Quadratic Characters: Total cpu/real time for characters: 17.61/3.01295
Info:Square Root: Total cpu/real time for sqrt: 255.01/37.0997
Info:HTTP server: Shutting down HTTP server
Info:Complete Factorization: Total cpu/elapsed time for entire factorization: 30104.3/951.544
86095283758496432104324268439192937 1251801084989468478426112275293353943851931081438584113030607271192533
[/code][B]30,104 CPUsec / 952 WCT[/B]

The machine (dual Xeon E5-2650) has quite a bit of variance on these small composites, so I might need to do a couple of runs and take the average to make a fair comparison.

another fast c105
[code]106940938640385179198475163991847262203326129306969135559785399736892912049980963873983444092667843094963[/code]for this one I used your polyselect params, but slightly different sieve params:

[code]tasks.lim0 = 750000
tasks.lim1 = 1200000
tasks.lpb0 = 26
tasks.lpb1 = 26
tasks.sieve.mfb0 = 52
tasks.sieve.mfb1 = 52
tasks.sieve.ncurves0 = 11
tasks.sieve.ncurves1 = 16
tasks.I = 12

tasks.sieve.qrange = 5000
tasks.sieve.qmin = 100000
tasks.sieve.rels_wanted = 5700000


###########################################################################
# Filtering
###########################################################################

tasks.filter.purge.keep = 170
tasks.filter.maxlevel = 20
tasks.filter.target_density = 155.0[/code][code]Info:Polynomial Selection (size optimized): Aggregate statistics:
Info:Polynomial Selection (size optimized): potential collisions: 4473.5
Info:Polynomial Selection (size optimized): raw lognorm (nr/min/av/max/std): 4246/29.740/37.012/44.730/1.470
Info:Polynomial Selection (size optimized): optimized lognorm (nr/min/av/max/std): 4246/29.280/32.778/38.300/1.149
Info:Polynomial Selection (size optimized): Total time: 405.26
Info:Polynomial Selection (root optimized): Aggregate statistics:
Info:Polynomial Selection (root optimized): Total time: 173.41
Info:Polynomial Selection (root optimized): Rootsieve time: 172.83
Info:Generate Factor Base: Total cpu/real time for makefb: 2.54/0.168372
Info:Generate Free Relations: Total cpu/real time for freerel: 108.61/3.46267
Info:Lattice Sieving: Aggregate statistics:
Info:Lattice Sieving: Total number of relations: 6718856
Info:Lattice Sieving: Average J: 1910.06 for 43933 special-q, max bucket fill -bkmult 1.0,1s:1.294890
Info:Lattice Sieving: Total time: 9501.16s
Info:Filtering - Duplicate Removal, splitting pass: Total cpu/real time for dup1: 23.24/32.0983
Info:Filtering - Duplicate Removal, splitting pass: Aggregate statistics:
Info:Filtering - Duplicate Removal, splitting pass: CPU time for dup1: 31.900000000000002s
Info:Filtering - Duplicate Removal, removal pass: Total cpu/real time for dup2: 103.57/57.6821
Info:Filtering - Duplicate Removal, removal pass: Aggregate statistics:
Info:Filtering - Duplicate Removal, removal pass: CPU time for dup2: 51.3s
Info:Filtering - Singleton removal: Total cpu/real time for purge: 56.14/39.6721
Info:Filtering - Merging: Total cpu/real time for merge: 73.47/50.1402
Info:Filtering - Merging: Total cpu/real time for replay: 8.51/6.87158
Info:Linear Algebra: Total cpu/real time for bwc: 716.98/59.17
Info:Linear Algebra: Aggregate statistics:
Info:Linear Algebra: Krylov: WCT time 29.15, iteration CPU time 0, COMM 0.0, cpu-wait 0.0, comm-wait 0.0 (6000 iterations)
Info:Linear Algebra: Lingen CPU time 69.91, WCT time 6.98
Info:Linear Algebra: Mksol: WCT time 14.8, iteration CPU time 0, COMM 0.0, cpu-wait 0.0, comm-wait 0.0 (3000 iterations)
Info:Quadratic Characters: Total cpu/real time for characters: 15.29/2.85822
Info:Square Root: Total cpu/real time for sqrt: 232.4/33.9271
Info:HTTP server: Shutting down HTTP server
Info:Complete Factorization: Total cpu/elapsed time for entire factorization: 28071.1/882.506
96419734812774740119994365852866859903514856721672957 1109118779968024502616433643203969184292927435816559
[/code][B]28,071 CPUsec / 883 WCT[/B]
Could be an outlier, so we need moar data!

Thanks; seems I'm only helping wall-clock time (nice, but not all that much help).
I'll do some more research. I've been tracking poly select time, sieve time, bwc time; but I have been using the sum of those three as a proxy for job length, ignoring filtering time and other little steps (e.g. free relations).