You are viewing a plain text version of this content. The canonical link for it is here.
Posted to issues@ignite.apache.org by "Pavel Tupitsyn (JIRA)" <ji...@apache.org> on 2016/11/28 13:15:58 UTC
[jira] [Commented] (IGNITE-4322) .NET: ClientReconnectExample is
not clear enough
[ https://issues.apache.org/jira/browse/IGNITE-4322?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=15701934#comment-15701934 ]
Pavel Tupitsyn commented on IGNITE-4322:
----------------------------------------
Console output and timeouts improved.
There is nothing to do with SocketException, it is thrown and caught internally.
> .NET: ClientReconnectExample is not clear enough
> -------------------------------------------------
>
> Key: IGNITE-4322
> URL: https://issues.apache.org/jira/browse/IGNITE-4322
> Project: Ignite
> Issue Type: Bug
> Components: platforms
> Affects Versions: 1.8
> Reporter: Ksenia Rybakova
> Assignee: Pavel Tupitsyn
> Fix For: 1.9
>
>
> ClientReconnectExample has the following output
> {noformat}
> >>> Client reconnect example started.
> [13:19:53] __________ ________________
> [13:19:53] / _/ ___/ |/ / _/_ __/ __/
> [13:19:53] _/ // (7 7 // / / / / _/
> [13:19:53] /___/\___/_/|_/___/ /_/ /___/
> [13:19:53]
> [13:19:53] ver. 1.8.0-QASK2501#20161125-sha1:ccbe6007
> [13:19:53] 2016 Copyright(C) Apache Software Foundation
> [13:19:53]
> [13:19:53] Ignite documentation: http://ignite.apache.org
> [13:19:53]
> [13:19:53] Quiet mode.
> [13:19:53] ^-- Logging to file 'C:\WORK\Releases\apache-ignite-fabric-1.8.0-QASK2501-bin\work\log\ignite-a18708d8.0.log'
> [13:19:53] ^-- To see **FULL** console log here add -DIGNITE_QUIET=false or "-v" to ignite.{sh|bat}
> [13:19:53]
> [13:19:53] OS: Windows 10 10.0 amd64
> [13:19:53] VM information: Java(TM) SE Runtime Environment 1.8.0_91-b14 Oracle Corporation Java HotSpot(TM) 64-Bit Server VM 25.91-b14
> [13:19:53] Initial heap size is 256MB (should be no less than 512MB, use -Xms512m -Xmx512m).
> [13:19:53] Configured plugins:
> [13:19:53] ^-- None
> [13:19:53]
> [13:19:58] Security status [authentication=off, tls/ssl=off]
> [13:19:59] Performance suggestions for grid 'serverNode' (fix if possible)
> [13:19:59] To disable, set -DIGNITE_PERFORMANCE_SUGGESTIONS_DISABLED=true
> [13:19:59] ^-- Disable grid events (remove 'includeEventTypes' from configuration)
> [13:19:59] ^-- Disable fully synchronous writes (set 'writeSynchronizationMode' to PRIMARY_SYNC or FULL_ASYNC)
> [13:19:59]
> [13:19:59] To start Console Management & Monitoring run ignitevisorcmd.{sh|bat}
> [13:19:59]
> [13:19:59] Ignite node started OK (id=a18708d8, grid=serverNode)
> [13:19:59] Topology snapshot [ver=1, servers=1, clients=0, CPUs=4, heap=3.5GB]
> >>> Server node started.
> [13:20:00] __________ ________________
> [13:20:00] / _/ ___/ |/ / _/_ __/ __/
> [13:20:00] _/ // (7 7 // / / / / _/
> [13:20:00] /___/\___/_/|_/___/ /_/ /___/
> [13:20:00]
> [13:20:00] ver. 1.8.0-QASK2501#20161125-sha1:ccbe6007
> [13:20:00] 2016 Copyright(C) Apache Software Foundation
> [13:20:00]
> [13:20:00] Ignite documentation: http://ignite.apache.org
> [13:20:00]
> [13:20:00] Quiet mode.
> [13:20:00] ^-- Logging to file 'C:\WORK\Releases\apache-ignite-fabric-1.8.0-QASK2501-bin\work\log\ignite-a18708d8.0.log'
> [13:20:00] ^-- To see **FULL** console log here add -DIGNITE_QUIET=false or "-v" to ignite.{sh|bat}
> [13:20:00]
> [13:20:00] OS: Windows 10 10.0 amd64
> [13:20:00] VM information: Java(TM) SE Runtime Environment 1.8.0_91-b14 Oracle Corporation Java HotSpot(TM) 64-Bit Server VM 25.91-b14
> [13:20:00] Initial heap size is 256MB (should be no less than 512MB, use -Xms512m -Xmx512m).
> [13:20:00] Configured plugins:
> [13:20:00] ^-- None
> [13:20:00]
> [13:20:00] Security status [authentication=off, tls/ssl=off]
> [13:20:02] Topology snapshot [ver=2, servers=1, clients=1, CPUs=4, heap=3.5GB]
> [13:20:02] To start Console Management & Monitoring run ignitevisorcmd.{sh|bat}
> [13:20:02]
> [13:20:02] Ignite node started OK (id=2f5922f5)
> [13:20:02] Topology snapshot [ver=2, servers=1, clients=1, CPUs=4, heap=3.5GB]
> >>> Client node connected to the cluster.
> >>> Put value with key:0
> >>> Put value with key:1
> >>> Put value with key:2
> [13:20:04,824][SEVERE][tcp-client-disco-sock-writer-#5%null%][TcpDiscoverySpi] Failed to send message: TcpDiscoveryClientPingRequest [nodeToPing=a18708d8-e489-4b47-a8e9-e16efc6b814e, super=TcpDiscoveryAbstractMessage [sndNodeId=null, id=a9fa27aa851-2f5922f5-d38b-4b4f-80cf-feec8bf52013, verifierNodeId=null, topVer=0, pendingIdx=0, failedNodes=null, isClient=false]]
> java.net.SocketException: Socket is closed
> at java.net.Socket.getOutputStream(Socket.java:943)
> at org.apache.ignite.spi.discovery.tcp.TcpDiscoverySpi.writeToSocket(TcpDiscoverySpi.java:1354)
> at org.apache.ignite.spi.discovery.tcp.ClientImpl$SocketWriter.body(ClientImpl.java:1088)
> at org.apache.ignite.spi.IgniteSpiThread.run(IgniteSpiThread.java:62)
> [13:20:04] Ignite node stopped OK [name=serverNode, uptime=00:00:04:899]
> >>> Put value with key:3
> [13:20:09] New version is available at ignite.apache.org: 1.7.0
> >>> Restarting server node...
> [13:20:09] __________ ________________
> [13:20:09] / _/ ___/ |/ / _/_ __/ __/
> [13:20:09] _/ // (7 7 // / / / / _/
> [13:20:09] /___/\___/_/|_/___/ /_/ /___/
> [13:20:09]
> [13:20:09] ver. 1.8.0-QASK2501#20161125-sha1:ccbe6007
> [13:20:09] 2016 Copyright(C) Apache Software Foundation
> [13:20:09]
> [13:20:09] Ignite documentation: http://ignite.apache.org
> [13:20:09]
> [13:20:09] Quiet mode.
> [13:20:09] ^-- Logging to file 'C:\WORK\Releases\apache-ignite-fabric-1.8.0-QASK2501-bin\work\log\ignite-a18708d8.0.log'
> [13:20:09] ^-- To see **FULL** console log here add -DIGNITE_QUIET=false or "-v" to ignite.{sh|bat}
> [13:20:09]
> [13:20:09] OS: Windows 10 10.0 amd64
> [13:20:09] VM information: Java(TM) SE Runtime Environment 1.8.0_91-b14 Oracle Corporation Java HotSpot(TM) 64-Bit Server VM 25.91-b14
> [13:20:09] Initial heap size is 256MB (should be no less than 512MB, use -Xms512m -Xmx512m).
> [13:20:09] Configured plugins:
> [13:20:09] ^-- None
> [13:20:09]
> [13:20:09] Security status [authentication=off, tls/ssl=off]
> [13:20:10] Performance suggestions for grid 'serverNode' (fix if possible)
> [13:20:10] To disable, set -DIGNITE_PERFORMANCE_SUGGESTIONS_DISABLED=true
> [13:20:10] ^-- Disable grid events (remove 'includeEventTypes' from configuration)
> [13:20:10] ^-- Disable fully synchronous writes (set 'writeSynchronizationMode' to PRIMARY_SYNC or FULL_ASYNC)
> [13:20:10]
> [13:20:10] To start Console Management & Monitoring run ignitevisorcmd.{sh|bat}
> [13:20:10]
> [13:20:10] Ignite node started OK (id=791211e8, grid=serverNode)
> [13:20:10] Topology snapshot [ver=1, servers=1, clients=0, CPUs=4, heap=3.5GB]
> [13:20:12] New version is available at ignite.apache.org: 1.7.0
> >>> Client disconnected from the cluster.
> [13:20:20] Topology snapshot [ver=2, servers=1, clients=1, CPUs=4, heap=3.5GB]
> [13:20:20] Client node was reconnected after it was already considered failed by the server topology (this could happen after all servers restarted or due to a long network outage between the client and servers). All continuous queries and remote event listeners created by this client will be unsubscribed, consider listening to EVT_CLIENT_NODE_RECONNECTED event to restore them.
> [13:20:20] New version is available at ignite.apache.org: 1.7.0
> >>> Client reconnected to the cluster.
> [13:20:20] Topology snapshot [ver=2, servers=1, clients=1, CPUs=4, heap=3.5GB]
> >>> Put value with key:5
> >>> Put value with key:6
> >>> Put value with key:7
> >>> Put value with key:8
> >>> Put value with key:9
> >>> Example finished, press any key to exit ...
> [13:20:23] Ignite node stopped OK [name=serverNode, uptime=00:00:12:607]
> [13:20:24,312][SEVERE][tcp-client-disco-sock-writer-#5%null%][TcpDiscoverySpi] Failed to send message: TcpDiscoveryClientPingRequest [nodeToPing=791211e8-9f45-4a19-8d8b-79950a421f38, super=TcpDiscoveryAbstractMessage [sndNodeId=null, id=7ffa27aa851-844ade6c-017c-4384-a2a6-cdbf149268dd, verifierNodeId=null, topVer=0, pendingIdx=0, failedNodes=null, isClient=false]]
> java.net.SocketException: Socket is closed
> at java.net.Socket.getOutputStream(Socket.java:943)
> at org.apache.ignite.spi.discovery.tcp.TcpDiscoverySpi.writeToSocket(TcpDiscoverySpi.java:1354)
> at org.apache.ignite.spi.discovery.tcp.ClientImpl$SocketWriter.body(ClientImpl.java:1088)
> at org.apache.ignite.spi.IgniteSpiThread.run(IgniteSpiThread.java:62)
> {noformat}
> The following is confusing:
> 1) When server node stops we get SocketException but still put key 3 successfully.
> 2) ">>> Client disconnected from the cluster." message appears after server restart (should be before). Possibly need to increase this timeout:
> {noformat}
> // Wait for client to detect the disconnect.
> Thread.Sleep(5000);
> {noformat}
> 3) SocketException happens when example finished already.
> {noformat}
> [13:20:24,312][SEVERE][tcp-client-disco-sock-writer-#5%null%][TcpDiscoverySpi] Failed to send message: TcpDiscoveryClientPingRequest [nodeToPing=791211e8-9f45-4a19-8d8b-79950a421f38, super=TcpDiscoveryAbstractMessage [sndNodeId=null, id=7ffa27aa851-844ade6c-017c-4384-a2a6-cdbf149268dd, verifierNodeId=null, topVer=0, pendingIdx=0, failedNodes=null, isClient=false]]
> java.net.SocketException: Socket is closed
> at java.net.Socket.getOutputStream(Socket.java:943)
> at org.apache.ignite.spi.discovery.tcp.TcpDiscoverySpi.writeToSocket(TcpDiscoverySpi.java:1354)
> at org.apache.ignite.spi.discovery.tcp.ClientImpl$SocketWriter.body(ClientImpl.java:1088)
> at org.apache.ignite.spi.IgniteSpiThread.run(IgniteSpiThread.java:62)
> {noformat}
--
This message was sent by Atlassian JIRA
(v6.3.4#6332)