Peer Connecting, Reconnecting, Disconnected all the time in loop in my logs?

BiggyVince · May 14, 2021, 6:12am

Hello,
Goodmorning,

Observing my log file, I see something every time in loop…
I am feeling that something is not in the right way…

2021-05-14T08:03:02.860 harvester harvester_server        : INFO     Connection closed: 127.0.0.1, node id: 7b092db00d35a1749fb7be5a8de5a8f611191a75d404b4336f88af1121094cca
2021-05-14T08:03:02.862 harvester chia.harvester.harvester: INFO     peer disconnected {'host': '127.0.0.1', 'port': 8447}
2021-05-14T08:03:03.730 harvester harvester               : INFO     Reconnecting to peer {'host': '127.0.0.1', 'port': 8447}
2021-05-14T08:03:03.740 harvester harvester_server        : INFO     -> handshake to peer 127.0.0.1 7b092db00d35a1749fb7be5a8de5a8f611191a75d404b4336f88af1121094cca
2021-05-14T08:03:03.741 harvester harvester_server        : INFO     Connected with farmer {'host': '127.0.0.1', 'port': 8447}
2021-05-14T08:03:03.743 harvester harvester_server        : INFO     <- harvester_handshake from peer 7b092db00d35a1749fb7be5a8de5a8f611191a75d404b4336f88af1121094cca 127.0.0.1
2021-05-14T08:03:03.773 harvester chia.plotting.plot_tools: INFO     Searching directories ['D:\\', 'E:\\', 'G:\\']
2021-05-14T08:03:03.774 harvester chia.plotting.plot_tools: INFO     Not checking subdirectory D:\$RECYCLE.BIN, subdirectories not added by default
2021-05-14T08:03:03.777 harvester chia.plotting.plot_tools: INFO     Not checking subdirectory D:\System Volume Information, subdirectories not added by default
2021-05-14T08:03:03.778 harvester chia.plotting.plot_tools: INFO     Not checking subdirectory E:\$RECYCLE.BIN, subdirectories not added by default
2021-05-14T08:03:03.781 harvester chia.plotting.plot_tools: INFO     Not checking subdirectory E:\System Volume Information, subdirectories not added by default
2021-05-14T08:03:03.783 harvester chia.plotting.plot_tools: INFO     Not checking subdirectory G:\System Volume Information, subdirectories not added by default
2021-05-14T08:03:03.815 harvester chia.plotting.plot_tools: INFO     Loaded a total of 148 plots of size 14.649537847317333 TiB, in 0.0690009593963623 seconds
2021-05-14T08:03:05.890 harvester harvester_server        : INFO     Connection closed: 127.0.0.1, node id: 7b092db00d35a1749fb7be5a8de5a8f611191a75d404b4336f88af1121094cca
2021-05-14T08:03:05.892 harvester chia.harvester.harvester: INFO     peer disconnected {'host': '127.0.0.1', 'port': 8447}
2021-05-14T08:03:06.751 harvester harvester               : INFO     Reconnecting to peer {'host': '127.0.0.1', 'port': 8447}
2021-05-14T08:03:06.759 harvester harvester_server        : INFO     -> handshake to peer 127.0.0.1 7b092db00d35a1749fb7be5a8de5a8f611191a75d404b4336f88af1121094cca
2021-05-14T08:03:06.761 harvester harvester_server        : INFO     Connected with farmer {'host': '127.0.0.1', 'port': 8447}
2021-05-14T08:03:06.762 harvester harvester_server        : INFO     <- harvester_handshake from peer 7b092db00d35a1749fb7be5a8de5a8f611191a75d404b4336f88af1121094cca 127.0.0.1
2021-05-14T08:03:06.792 harvester chia.plotting.plot_tools: INFO     Searching directories ['D:\\', 'E:\\', 'G:\\']
2021-05-14T08:03:06.793 harvester chia.plotting.plot_tools: INFO     Not checking subdirectory D:\$RECYCLE.BIN, subdirectories not added by default
2021-05-14T08:03:06.797 harvester chia.plotting.plot_tools: INFO     Not checking subdirectory D:\System Volume Information, subdirectories not added by default
2021-05-14T08:03:06.799 harvester chia.plotting.plot_tools: INFO     Not checking subdirectory E:\$RECYCLE.BIN, subdirectories not added by default
2021-05-14T08:03:06.802 harvester chia.plotting.plot_tools: INFO     Not checking subdirectory E:\System Volume Information, subdirectories not added by default
2021-05-14T08:03:06.803 harvester chia.plotting.plot_tools: INFO     Not checking subdirectory G:\System Volume Information, subdirectories not added by default

The peer Connecting, Reconnecting, Disconnected all the time in loop…
I dont think is correct…

Also, I have around 12/13 peers… not more… it is normal?

Someone could share a correct log?

Thank you in advance.

Vins

rmii · May 14, 2021, 6:41am

Can you confirm the ports are open and your status is Synced?

Generally, once a connection is made to the farmer it will start checking for eligibility of the plots, which I am not seeing in your log?

BiggyVince · May 14, 2021, 6:47am

Hello rmii

Tha status is synced and the wallet is synced.
The port 8444 is opened, and also the 8447…

Here i see the eligible, but most of the time connecting and disconneted withouth check it…

2021-05-14T08:12:23.695 harvester harvester_server        : INFO     Connection closed: 127.0.0.1, node id: 7b092db00d35a1749fb7be5a8de5a8f611191a75d404b4336f88af1121094cca
2021-05-14T08:12:23.696 harvester chia.harvester.harvester: INFO     peer disconnected {'host': '127.0.0.1', 'port': 8447}
2021-05-14T08:12:24.645 harvester harvester               : INFO     Reconnecting to peer {'host': '127.0.0.1', 'port': 8447}
2021-05-14T08:12:24.651 harvester harvester_server        : INFO     -> handshake to peer 127.0.0.1 7b092db00d35a1749fb7be5a8de5a8f611191a75d404b4336f88af1121094cca
2021-05-14T08:12:24.651 harvester harvester_server        : INFO     Connected with farmer {'host': '127.0.0.1', 'port': 8447}
2021-05-14T08:12:24.652 harvester harvester_server        : INFO     <- harvester_handshake from peer 7b092db00d35a1749fb7be5a8de5a8f611191a75d404b4336f88af1121094cca 127.0.0.1
2021-05-14T08:12:24.677 harvester chia.plotting.plot_tools: INFO     Searching directories ['D:\\', 'E:\\', 'G:\\']
2021-05-14T08:12:24.678 harvester chia.plotting.plot_tools: INFO     Not checking subdirectory D:\$RECYCLE.BIN, subdirectories not added by default
2021-05-14T08:12:24.680 harvester chia.plotting.plot_tools: INFO     Not checking subdirectory D:\System Volume Information, subdirectories not added by default
2021-05-14T08:12:24.681 harvester chia.plotting.plot_tools: INFO     Not checking subdirectory E:\$RECYCLE.BIN, subdirectories not added by default
2021-05-14T08:12:24.684 harvester chia.plotting.plot_tools: INFO     Not checking subdirectory E:\System Volume Information, subdirectories not added by default
2021-05-14T08:12:24.685 harvester chia.plotting.plot_tools: INFO     Not checking subdirectory G:\System Volume Information, subdirectories not added by default
2021-05-14T08:12:24.720 harvester chia.plotting.plot_tools: INFO     Loaded a total of 148 plots of size 14.649537847317333 TiB, in 0.06600069999694824 seconds
2021-05-14T08:12:26.280 harvester harvester_server        : INFO     <- new_signage_point_harvester from peer 7b092db00d35a1749fb7be5a8de5a8f611191a75d404b4336f88af1121094cca 127.0.0.1
2021-05-14T08:12:26.290 harvester chia.harvester.harvester: INFO     0 plots were eligible for farming 6fbff95fec... Found 0 proofs. Time: 0.00899 s. Total 148 plots
2021-05-14T08:12:26.290 harvester harvester_server        : INFO     -> farming_info to peer 127.0.0.1 7b092db00d35a1749fb7be5a8de5a8f611191a75d404b4336f88af1121094cca
2021-05-14T08:12:26.703 harvester harvester_server        : INFO     Connection closed: 127.0.0.1, node id: 7b092db00d35a1749fb7be5a8de5a8f611191a75d404b4336f88af1121094cca
2021-05-14T08:12:26.703 harvester chia.harvester.harvester: INFO     peer disconnected {'host': '127.0.0.1', 'port': 8447}
2021-05-14T08:12:27.669 harvester harvester               : INFO     Reconnecting to peer {'host': '127.0.0.1', 'port': 8447}
2021-05-14T08:12:27.676 harvester harvester_server        : INFO     -> handshake to peer 127.0.0.1 7b092db00d35a1749fb7be5a8de5a8f611191a75d404b4336f88af1121094cca
2021-05-14T08:12:27.678 harvester harvester_server        : INFO     Connected with farmer {'host': '127.0.0.1', 'port': 8447}
2021-05-14T08:12:27.679 harvester harvester_server        : INFO     <- harvester_handshake from peer 7b092db00d35a1749fb7be5a8de5a8f611191a75d404b4336f88af1121094cca 127.0.0.1

greenicetea · May 24, 2021, 1:02pm

Same here …

Did you manage to fix this issue?

Puppis · May 29, 2021, 1:35am

I am noticing similar issues on one or my harvesters. Anyone figure this one out?

Farmer120493930 · May 31, 2021, 12:32am

Same issue for me - any clue why its happening?

I have 4 nodes pointing towards main harvester.

jimmy · June 1, 2021, 6:14pm

I have the same problem.
Peer closed connection farmer 127.0.0.1:8447/8447
Then reconnect, then peer closed connection in the loop.
How to solve this ?
Does this problem indicate my farmer not working at all?

SilentStorm · June 3, 2021, 1:12pm

Same problem… But cant find any solution

Bones · June 4, 2021, 2:10pm

I have the same issue.

Bones · June 4, 2021, 7:05pm

Do you have more than 1 plotter?
I has this issue, or similar.
I disabled upnp on all but the actual farmer and things looking better.

Hope this helps.

Burntec · June 9, 2021, 6:05pm

I’m having similar issue on my main node. plot checks are being done however they are skipped occasionally on only my main node. I have two other machines running as plotters/harvesters. Both have upnp changed to false in config file.

this happens every time plots try to pass the filter on my main node.
Anyone have a solution?

Burntec · June 9, 2021, 10:47pm

Ok so possible solution to this problem.

Check if you have multiple “start_harvester.exe” processes running. If you do end task on all of them and restart chia.

Not sure if this is caused by not letting chia shut itself down fully or if more start on their own. This has fixed my connecting/disconnecting/reconnecting issues for now.

expbaby · March 6, 2022, 4:45pm

I was having the same issue. Re-importing the CA certs fixed the issue for me.

2022-03-06T11:13:30.931 harvester harvester_server        : INFO     Connected with farmer {'host': '10.0.0.10', 'port': 8447}
2022-03-06T11:13:32.304 harvester chia.harvester.harvester: INFO     0 plots were eligible for farming 4c776826fd... Found 0 proofs. Time: 0.01438 s. Total 215 plots
2022-03-06T11:13:33.909 harvester harvester_server        : INFO     Connection closed: 10.0.0.10, node id: 012cf5d4fe221eacf7d2e67b738aaf00ab0752e71b23dba6769a68bd25741e45
2022-03-06T11:13:33.910 harvester chia.harvester.harvester: INFO     peer disconnected {'host': '10.0.0.10', 'port': 8447}
2022-03-06T11:13:33.932 harvester harvester               : INFO     Reconnecting to peer {'host': '10.0.0.10', 'port': 8447}
2022-03-06T11:13:33.946 harvester harvester_server        : INFO     Connected with farmer {'host': '10.0.0.10', 'port': 8447}
2022-03-06T11:13:36.924 harvester harvester_server        : INFO     Connection closed: 10.0.0.10, node id: 012cf5d4fe221eacf7d2e67b738aaf00ab0752e71b23dba6769a68bd25741e45

Jacek · March 6, 2022, 9:29pm

Harvester events are local (nothing to do with remote peers), as such you would think that those protocol problems would warrant an ERROR level, not mere INFO (as basically such harvester or rather farm is screwed).

Also, you would think that instead of just logging the event (disconnection), the program would also (or rather) log the cause of such disconnection, making it easier to fix those issues. (Assuming that disconnection reasons are passed to the harvester during the handshake.)

Although, those events should also be reported on the farmer side, where the cause is known, so really no reason to not log it there. If not just to help resolve issues like yours, to also potentially warn of attempted attacks by rogue harvesters.