Communication session broken: A request to send or receive data was...

[peterjn]

I have 100+ warning 'Communication session broken: A request to send or receive data was disallowed because the socket had already been shut down in that direction with a previous shutdown call.' in the system event log. I have this problem on 2 different systems. One windows 2008 and the other 2012.
On the 2012 i changed to configuration to create a debug log.

This is a section from the debug log:

[18-Oct-2014 16:59:39.703] [DEBUG] [session:0] Received message CMD_GET_PARAMETER
[18-Oct-2014 16:59:39.703] [DEBUG] [session:0] Requesting parameter "Net.Interface.Link(21)"
[18-Oct-2014 16:59:39.703] [DEBUG] [session:0] GetParameterValue(): result is 0 (SUCCESS)
[18-Oct-2014 16:59:39.703] [DEBUG] [session:0] Sending message CMD_REQUEST_COMPLETED (size 48)
[18-Oct-2014 16:59:39.703] [DEBUG] [session:0] Message dump:
  ** 0041000000000038000083C100000001
  ** 00000055018F87AB0000001A00530079
  ** 007300740065006D002E005500700074
  ** 0069006D00650002
  ** code=0x0041 (CMD_GET_PARAMETER) flags=0x0000 id=33729 size=56 numFields=1
  ** [    85] STRING "System.Uptime"

[18-Oct-2014 16:59:39.703] [DEBUG] [session:0] Received message CMD_GET_PARAMETER
[18-Oct-2014 16:59:39.703] [DEBUG] [session:0] Requesting parameter "System.Uptime"
[18-Oct-2014 16:59:39.703] [DEBUG] [session:0] GetParameterValue(): result is 0 (SUCCESS)
[18-Oct-2014 16:59:39.703] [DEBUG] [session:0] Sending message CMD_REQUEST_COMPLETED (size 56)
[18-Oct-2014 16:59:39.750] [DEBUG] [session:0] Message dump:
  ** 0041000000000038000083C200000001
  ** 00000055017200660000001800410067
  ** 0065006E0074002E0055007000740069
  ** 006D006502010002
  ** code=0x0041 (CMD_GET_PARAMETER) flags=0x0000 id=33730 size=56 numFields=1
  ** [    85] STRING "Agent.Uptime"

[18-Oct-2014 16:59:39.750] [DEBUG] [session:0] Received message CMD_GET_PARAMETER
[18-Oct-2014 16:59:39.750] [DEBUG] [session:0] Requesting parameter "Agent.Uptime"
[18-Oct-2014 16:59:39.750] [DEBUG] [session:0] GetParameterValue(): result is 0 (SUCCESS)
[18-Oct-2014 16:59:39.750] [DEBUG] [session:0] Sending message CMD_REQUEST_COMPLETED (size 56)
[18-Oct-2014 17:00:40.199] [DEBUG] [session:0] Session disconnected by watchdog (last activity timestamp is 1413644379)
[18-Oct-2014 17:00:40.199] [DEBUG] [session:0] CommSession::disconnect()
[18-Oct-2014 17:00:40.199] [WARN ] Communication session broken: A request to send or receive data was disallowed because the socket had already been shut down in that direction with a previous shutdown call.
[18-Oct-2014 17:00:40.199] [DEBUG] [session:0] Session with 192.168.202.11 closed
[18-Oct-2014 17:00:44.777] [DEBUG] Incoming connection from 192.168.202.11
[18-Oct-2014 17:00:44.777] [DEBUG] Connection from 192.168.202.11 accepted
[18-Oct-2014 17:00:44.792] [DEBUG] [session:0] Message dump:
  ** 00B60020000000100000000000000000
  ** code=0x00B6 (CMD_GET_NXCP_CAPS) flags=0x0020 id=0 size=16 numFields=0

[18-Oct-2014 17:00:44.792] [DEBUG] [session:0] Received control message CMD_GET_NXCP_CAPS
[18-Oct-2014 17:00:44.792] [DEBUG] [session:0] Sending message CMD_NXCP_CAPS (size 16)
[18-Oct-2014 17:00:44.792] [DEBUG] [session:0] Message dump:
  ** 0003000000000010000083C400000000
  ** code=0x0003 (CMD_KEEPALIVE) flags=0x0000 id=33732 size=16 numFields=0

It seems that the connect was closed by the watchdog (red line) but way?

[victor]

Can you please show your agent's configuration file?

Best regards,
Victor

[peterjn]

It is very simple

MasterServers = XXX.YYY.ZZZ
ConfigIncludeDir = C:\NetXMS\etc\nxagentd.conf.d
LogFile = C:\NetXMS\log\debug.log
FileStore = C:\NetXMS\var
SubAgent = logwatch.nsm
SubAgent = winperf.nsm
DebugLevel = 9

[victor]

Quite strange. What agent version you are running?

Best regards,
Victor

[peterjn]

Version 1.2.16.

The strange thing is that sometimes it runs days without any messages and sometime +100 a day.

[victor]

Can you try to upgrade this agent to 1.2.17 (it will work with server 1.2.16)?

Best regards,
Victor