JayDDee / cpuminer-opt

Optimized multi algo CPU miner
Other
773 stars 545 forks source link

Some mess-up with "Accepted/Submitted" CLI output counter #272

Closed YetAnotherRussian closed 3 years ago

YetAnotherRussian commented 3 years ago

Hi. Something went wrong with the CLI output:

cpuminer-opt 3.15.0 -- cut-off -- CPU: AMD Ryzen 9 3900X 12-Core Processor SW built on Oct 2 2020 with GCC 9.3.0 -- cut-off --

Starting miner with AVX2...

[2020-10-06 10:22:22] CPU affinity [!.!.....!.!.!.!.....!.!.] [2020-10-06 10:22:22] Stratum connect stratum-ru.rplant.xyz:7025 [2020-10-06 10:22:22] Miner thread priority 0 (nice 19) [2020-10-06 10:22:22] 8 of 24 miner threads started using 'lyra2z330' algorithm [2020-10-06 10:22:23] Extranonce subscription enabled [2020-10-06 10:22:23] Stratum connection established [2020-10-06 10:22:23] New Stratum Diff 0.0005, Block 760587, Job e287 Diff: Net 0.0035265, Stratum 0.0005, Target 1.9531e-006 [2020-10-06 10:22:25] 1 Submitted Diff 2.7197e-006, Block 760587, Job e287 [2020-10-06 10:22:25] 1 Accepted 1 S0 R0 B0, 2.807 sec (89ms) [2020-10-06 10:22:25] 2 Submitted Diff 2.2176e-006, Block 760587, Job e287 [2020-10-06 10:22:26] 2 Accepted 2 S0 R0 B0, 0.195 sec (84ms) [2020-10-06 10:22:31] 3 Submitted Diff 5.157e-006, Block 760587, Job e287 [2020-10-06 10:22:31] 3 Accepted 3 S0 R0 B0, 5.749 sec (70ms) [2020-10-06 10:22:33] 4 Submitted Diff 3.7199e-005, Block 760587, Job e287 [2020-10-06 10:22:33] 4 Accepted 4 S0 R0 B0, 2.109 sec (68ms) [2020-10-06 10:22:34] 5 Submitted Diff 9.4109e-006, Block 760587, Job e287 [2020-10-06 10:22:35] 5 Accepted 5 S0 R0 B0, 1.218 sec (74ms) [2020-10-06 10:22:37] 6 Submitted Diff 3.2684e-006, Block 760587, Job e287 [2020-10-06 10:22:37] 6 Accepted 6 S0 R0 B0, 2.816 sec (80ms) [2020-10-06 10:22:40] 7 Submitted Diff 2.3802e-006, Block 760587, Job e287 [2020-10-06 10:22:40] 7 Accepted 7 S0 R0 B0, 2.310 sec (75ms) [2020-10-06 10:22:43] 8 Submitted Diff 3.1837e-006, Block 760587, Job e287 [2020-10-06 10:22:43] 8 Accepted 8 S0 R0 B0, 2.921 sec (76ms) [2020-10-06 10:22:45] 9 Submitted Diff 2.032e-006, Block 760587, Job e287 [2020-10-06 10:22:45] 9 Accepted 9 S0 R0 B0, 2.285 sec (74ms) [2020-10-06 10:22:45] 10 Submitted Diff 2.519e-006, Block 760587, Job e287 [2020-10-06 10:22:46] 10 Accepted 10 S0 R0 B0, 0.610 sec (77ms) [2020-10-06 10:22:47] 11 Submitted Diff 2.2164e-006, Block 760587, Job e287 [2020-10-06 10:22:47] 11 Accepted 11 S0 R0 B0, 1.762 sec (69ms) [2020-10-06 10:22:54] 12 Submitted Diff 5.8161e-006, Block 760587, Job e287 [2020-10-06 10:22:54] 12 Accepted 12 S0 R0 B0, 6.925 sec (77ms) [2020-10-06 10:22:55] 13 Submitted Diff 1.0174e-005, Block 760587, Job e287 [2020-10-06 10:22:55] 13 Accepted 13 S0 R0 B0, 0.543 sec (74ms) [2020-10-06 10:22:59] 14 Submitted Diff 3.3429e-006, Block 760587, Job e287 [2020-10-06 10:22:59] 14 Accepted 14 S0 R0 B0, 4.147 sec (67ms) [2020-10-06 10:22:59] 15 Submitted Diff 3.5447e-006, Block 760587, Job e287 [2020-10-06 10:22:59] 15 Accepted 15 S0 R0 B0, 0.555 sec (77ms) [2020-10-06 10:23:05] New Block 760588, Job e288 Diff: Net 0.0035145, Stratum 0.0005, Target 1.9531e-006 TTF @ 3717.13 h/s: Block 1h07m, Share 0m02s Net hash rate (est) 359.39 kh/s [2020-10-06 10:23:06] 16 Submitted Diff 3.4843e-006, Block 760588, Job e288 [2020-10-06 10:23:06] 17 Submitted Diff 1.0725e-005, Block 760588, Job e288 [2020-10-06 10:23:06] 18 Submitted Diff 4.9428e-006, Block 760588, Job e288 [2020-10-06 10:23:10] 19 Submitted Diff 3.5417e-006, Block 760588, Job e288 [2020-10-06 10:23:12] 20 Submitted Diff 5.9948e-005, Block 760588, Job e288 [2020-10-06 10:23:12] 21 Submitted Diff 4.759e-006, Block 760588, Job e288 [2020-10-06 10:23:18] 22 Submitted Diff 7.9253e-006, Block 760588, Job e288 [2020-10-06 10:23:21] 23 Submitted Diff 2.0911e-005, Block 760588, Job e288 [2020-10-06 10:23:22] 24 Submitted Diff 2.8295e-006, Block 760588, Job e288 [2020-10-06 10:23:25] 25 Submitted Diff 7.0611e-006, Block 760588, Job e288 [2020-10-06 10:23:32] 26 Submitted Diff 2.2607e-006, Block 760588, Job e288 [2020-10-06 10:23:33] 27 Submitted Diff 2.8694e-005, Block 760588, Job e288 [2020-10-06 10:23:37] 28 Submitted Diff 1.2954e-005, Block 760588, Job e288 [2020-10-06 10:23:37] 29 Submitted Diff 1.0786e-005, Block 760588, Job e288 [2020-10-06 10:23:38] 30 Submitted Diff 5.4505e-006, Block 760588, Job e288 [2020-10-06 10:23:39] 31 Submitted Diff 5.5248e-006, Block 760588, Job e288 [2020-10-06 10:23:47] 32 Submitted Diff 1.168e-005, Block 760588, Job e288 [2020-10-06 10:23:48] 33 Submitted Diff 0.010959, Block 760588, Job e288 [2020-10-06 10:23:53] 34 Submitted Diff 2.0195e-005, Block 760588, Job e288 [2020-10-06 10:23:58] 35 Submitted Diff 2.1239e-006, Block 760588, Job e288 [2020-10-06 10:23:58] 36 Submitted Diff 2.6585e-006, Block 760588, Job e288 [2020-10-06 10:23:59] 37 Submitted Diff 4.7981e-006, Block 760588, Job e288 [2020-10-06 10:23:59] 38 Submitted Diff 1.1357e-005, Block 760588, Job e288 [2020-10-06 10:24:00] 39 Submitted Diff 3.4786e-006, Block 760588, Job e288 [2020-10-06 10:24:00] 40 Submitted Diff 2.4827e-006, Block 760588, Job e288 [2020-10-06 10:24:00] lyra2z330: stratum-ru.rplant.xyz:7025 Periodic Report 1m37s 1m37s Share rate 9.20/min 24.54/min Hash rate 1286.67h/s 1297.21h/s (3717.13h/s) Lost hash rate 0.00h/s 2162.01h/s Submitted 15 40 Accepted 15 15 Hi/Lo Share Diff 3.7199e-005 / 2.032e-006 [2020-10-06 10:24:00] New Stratum Diff 0.001, Block 760588, Job e28a Diff: Net 0.0035145, Stratum 0.001, Target 3.9063e-006 TTF @ 3715.82 h/s: Block 1h07m, Share 0m04s Net hash rate (est) 155.61 kh/s [2020-10-06 10:24:04] 41 Submitted Diff 4.0937e-006, Block 760588, Job e28a [2020-10-06 10:24:04] 40 Accepted 16 S0 R0 B0, 60.836 sec (3387ms) [2020-10-06 10:24:07] 42 Submitted Diff 2.0427e-005, Block 760588, Job e28a [2020-10-06 10:24:07] 41 Accepted 17 S0 R0 B0, 3.315 sec (3129ms) [2020-10-06 10:24:18] 43 Submitted Diff 7.424e-006, Block 760588, Job e28a [2020-10-06 10:24:19] 42 Accepted 18 S0 R0 B0, 3.048 sec (11959ms) [2020-10-06 10:24:23] 44 Submitted Diff 5.9856e-006, Block 760588, Job e28a [2020-10-06 10:24:23] 43 Accepted 19 S0 R0 B0, 11.881 sec (4779ms) [2020-10-06 10:24:32] 45 Submitted Diff 1.4578e-005, Block 760588, Job e28a [2020-10-06 10:24:32] 44 Accepted 20 S0 R0 B0, 4.701 sec (8811ms) [2020-10-06 10:24:32] 46 Submitted Diff 4.5233e-006, Block 760588, Job e28a [2020-10-06 10:24:32] 45 Accepted 21 S0 R0 B0, 8.741 sec (326ms) [2020-10-06 10:24:33] 47 Submitted Diff 4.1054e-006, Block 760588, Job e28a [2020-10-06 10:24:33] 46 Accepted 22 S0 R0 B0, 0.246 sec (692ms) [2020-10-06 10:24:33] New Block 760589, Job e28b Diff: Net 0.0035082, Stratum 0.001, Target 3.9063e-006 TTF @ 3718.66 h/s: Block 1h07m, Share 0m04s Net hash rate (est) 231.81 kh/s [2020-10-06 10:24:41] 48 Submitted Diff 3.2422e-005, Block 760589, Job e28b [2020-10-06 10:24:41] 49 Submitted Diff 2.042e-005, Block 760589, Job e28b [2020-10-06 10:24:44] lyra2z330: stratum-ru.rplant.xyz:7025 Periodic Report 0m43s 2m21s Share rate 9.58/min 20.76/min Hash rate 2679.18h/s 1665.82h/s (3718.66h/s) Lost hash rate 0.00h/s 3212.66h/s Submitted 7 49 Accepted 7 22 Hi/Lo Share Diff 3.7199e-005 / 9e+099 [2020-10-06 10:24:44] New Stratum Diff 0.002, Block 760590, Job e28d Diff: Net 0.0035203, Stratum 0.002, Target 7.8125e-006 TTF @ 3698.86 h/s: Block 1h08m, Share 0m09s Net hash rate (est) 321.69 kh/s [2020-10-06 10:24:48] 50 Submitted Diff 5.3669e-005, Block 760590, Job e28d [2020-10-06 10:24:53] 51 Submitted Diff 2.0009e-005, Block 760590, Job e28d [2020-10-06 10:24:58] 52 Submitted Diff 2.4777e-005, Block 760590, Job e28d [2020-10-06 10:25:02] 53 Submitted Diff 1.3896e-005, Block 760590, Job e28d [2020-10-06 10:25:13] 54 Submitted Diff 7.8395e-006, Block 760590, Job e28d [2020-10-06 10:25:15] 55 Submitted Diff 1.2005e-005, Block 760590, Job e28d [2020-10-06 10:25:17] 56 Submitted Diff 8.598e-006, Block 760590, Job e28d [2020-10-06 10:25:19] 57 Submitted Diff 1.0771e-005, Block 760590, Job e28d [2020-10-06 10:25:31] 58 Submitted Diff 2.5164e-005, Block 760590, Job e28d [2020-10-06 10:25:33] 59 Submitted Diff 9.9368e-006, Block 760590, Job e28d [2020-10-06 10:25:39] New Work: Block 760590, Net diff 0.0035203, Job e28f

There:

[2020-10-06 10:24:00] 40 Submitted Diff 2.4827e-006, Block 760588, Job e288 ... [2020-10-06 10:24:04] 41 Submitted Diff 4.0937e-006, Block 760588, Job e28a [2020-10-06 10:24:04] 40 Accepted 16 S0 R0 B0, 60.836 sec (3387ms)

Around 4 seconds to display. And it is a quite often thing I can say...

image

Ofc all of these were accepted @ pool side.

v3.14.2 has some changes on CLI output, so I've tested v3.12.7 - it's absolutely OK. Seems that thread count or affinity does not affect this (I mean, yep, I use some kinda strange affinity and thread count, but this one is the best setting possible for the algo and given CPU).

No crazy ping (3000ms or somethin') over network detected, so I guess something is just getting locked.

Thanks!

JayDDee commented 3 years ago

I saw this while testing minotaur for v3.15.0 at rplant pool but I've never seen it in any other pool. I think we need input from @rplant8.

My initial suspicion is the pool is not sending replies for some reason, possibly some kind of load shedding. I see no reason it is related to the miner version, more likely an intermittant issue that didn't occur while testing the older version.

JayDDee commented 3 years ago

My current assessment is a high share rate is triggering throttling of replies by the pool. More information is required to proceed. Some suggestions:

  1. A packet capture showing replies being received over the network but not displayed by the miner. This will demostrate a problem with the miner.

  2. Problem observed in another pool. This will eliminate a pool specific problem.

  3. Higher stratum difficulty to reduce share rate. This may eliminate the problem if my assesment is correct.

JayDDee commented 3 years ago

Unless I receive evidence to the contrary I will conclude it's a pool issue and close this.

JayDDee commented 3 years ago

No response. Closed.