View Single Post
Old 2020-01-27, 12:46   #464
kriesel
 
kriesel's Avatar
 
"TF79LL86GIMPS96gpu17"
Mar 2017
US midwest

24·11·29 Posts
Default too-long iteration times, cured eventually by manual stop all workers/restart all workers

Dual Xeon E5-2670, Windows 7 X64, prime95 V29.8b6, 4 workers, all showed tslower than normal iteration timing, to varying degrees. One example shown following. All 4 exponents are 258M<p<383M. Speed ratios ranged from1.22 to 2.30.
Code:
[Jan 15 10:26] Waiting 15 seconds to stagger worker starts.
[Jan 15 10:27] Worker starting
[Jan 15 10:27] Setting affinity to run worker on CPU core #13
[Jan 15 10:27] Setting affinity to run helper thread 1 on CPU core #14
[Jan 15 10:27] Setting affinity to run helper thread 2 on CPU core #15
[Jan 15 10:27] Setting affinity to run helper thread 3 on CPU core #16
[Jan 15 10:27] Resuming Gerbicz error-checking PRP test of M315690521 using AVX FFT length 17920K, Pass1=896, Pass2=20K, clm=2, 4 threads
[Jan 15 10:27] Iteration: 124666805 / 315690521 [39.49%].
[Jan 15 10:31] Iteration: 124670000 / 315690521 [39.49%], ms/iter: 85.981, ETA: 190d 02:14
[Jan 15 10:50] Iteration: 124680000 / 315690521 [39.49%], ms/iter: 112.920, ETA: 249d 15:20
[Jan 15 11:10] Iteration: 124690000 / 315690521 [39.49%], ms/iter: 117.746, ETA: 260d 07:06
...
[Jan 27 00:51] Iteration: 132970000 / 315690521 [42.12%], ms/iter: 120.968, ETA: 255d 19:49
[Jan 27 01:11] Iteration: 132980000 / 315690521 [42.12%], ms/iter: 120.476, ETA: 254d 18:30
[Jan 27 01:32] Iteration: 132990000 / 315690521 [42.12%], ms/iter: 120.248, ETA: 254d 06:37
[Jan 27 01:52] Iteration: 133000000 / 315690521 [42.12%], ms/iter: 121.018, ETA: 255d 21:21
[Jan 27 01:53] Gerbicz error check passed at iteration 133000000.
[Jan 27 02:14] Iteration: 133010000 / 315690521 [42.13%], ms/iter: 116.939, ETA: 247d 06:00
[Jan 27 02:34] Iteration: 133020000 / 315690521 [42.13%], ms/iter: 120.483, ETA: 254d 17:31
[Jan 27 02:54] Iteration: 133030000 / 315690521 [42.13%], ms/iter: 121.195, ETA: 256d 05:17
[Jan 27 03:14] Iteration: 133040000 / 315690521 [42.14%], ms/iter: 120.390, ETA: 254d 12:09
[Jan 27 03:35] Iteration: 133050000 / 315690521 [42.14%], ms/iter: 120.685, ETA: 255d 02:44
[Jan 27 03:55] Iteration: 133060000 / 315690521 [42.14%], ms/iter: 120.953, ETA: 255d 16:02
[Jan 27 04:15] Iteration: 133070000 / 315690521 [42.15%], ms/iter: 120.515, ETA: 254d 17:29
[Jan 27 04:36] Iteration: 133080000 / 315690521 [42.15%], ms/iter: 120.331, ETA: 254d 07:47
[Jan 27 04:56] Iteration: 133090000 / 315690521 [42.15%], ms/iter: 120.725, ETA: 255d 03:27
[Jan 27 05:16] Iteration: 133100000 / 315690521 [42.16%], ms/iter: 120.079, ETA: 253d 18:20
[Jan 27 05:36] Iteration: 133110000 / 315690521 [42.16%], ms/iter: 119.458, ETA: 252d 10:30
[Jan 27 05:54] Stopping PRP test of M315690521 at iteration 133118583 [42.16%]
[Jan 27 05:54] Worker stopped.
[Jan 27 05:54] Waiting 15 seconds to stagger worker starts.
[Jan 27 05:54] Worker starting
[Jan 27 05:54] Setting affinity to run worker on CPU core #13
[Jan 27 05:54] Setting affinity to run helper thread 1 on CPU core #14
[Jan 27 05:54] Setting affinity to run helper thread 2 on CPU core #15
[Jan 27 05:54] Setting affinity to run helper thread 3 on CPU core #16
[Jan 27 05:54] Resuming Gerbicz error-checking PRP test of M315690521 using AVX FFT length 17920K, Pass1=896, Pass2=20K, clm=2, 4 threads
[Jan 27 05:54] Iteration: 133118584 / 315690521 [42.16%].
[Jan 27 05:55] Iteration: 133120000 / 315690521 [42.16%], ms/iter: 52.086, ETA: 110d 01:29
[Jan 27 06:04] Iteration: 133130000 / 315690521 [42.17%], ms/iter: 52.412, ETA: 110d 17:52
[Jan 27 06:13] Iteration: 133140000 / 315690521 [42.17%], ms/iter: 52.550, ETA: 111d 00:42
[Jan 27 06:22] Iteration: 133150000 / 315690521 [42.17%], ms/iter: 52.169, ETA: 110d 05:14
[Jan 27 06:30] Iteration: 133160000 / 315690521 [42.18%], ms/iter: 52.202, ETA: 110d 06:47

Last fiddled with by kriesel on 2020-01-27 at 12:48
kriesel is offline   Reply With Quote