Description
Hi,
I am using socket.io version 1.7.3 on nodejs and 0.8.3 on Java.
The socket.io Java client sends data to the socket.io nodejs application.
On the upgrade request, the connection is broken with the error message
engine:socket client did not complete upgrade - transport closed
Could you please let me know why the connection gets disconnected?
Thanks
Ram
Here is the full log (if it helps more):
ram@rampc:~$ DEBUG=* node 5gfe/app.js socket.io:server initializing namespace / +0ms socket.io:server creating http server and binding to 8080 +19ms socket.io:server creating engine.io instance with opts {"path":"/socket.io"} +27ms socket.io:server attaching client serving req handler +108ms Server running engine intercepting request for path "/socket.io/" +17s engine handling "GET" http request "/socket.io/?EIO=3&transport=polling" +7ms engine handshaking client "AGSXig1EuXMzl0ZdAAAA" +10ms engine:socket sending packet "open" ({"sid":"AGSXig1EuXMzl0ZdAAAA","upgrades":["websocket"],"pingInterval":25000,"pingTimeout":60000} ) +7ms engine:polling setting request +5ms engine:socket flushing buffer to transport +2ms engine:polling writing " �0{"sid":"AGSXig1EuXMzl0ZdAAAA","upgrades":["websocket"],"pingInterval":25000,"pingTimeout":60000}" +10 ms engine:socket executing batch send callback +26ms socket.io:server incoming connection with id AGSXig1EuXMzl0ZdAAAA +3ms socket.io:client connecting to namespace / +6ms socket.io:namespace adding socket to nsp / +1ms socket.io:socket socket connected - writing packet +12ms socket.io:socket joining room AGSXig1EuXMzl0ZdAAAA +1ms socket.io:client writing packet {"type":0,"nsp":"/"} +2ms socket.io-parser encoding packet {"type":0,"nsp":"/"} +0ms socket.io-parser encoded {"type":0,"nsp":"/"} as 0 +26ms engine:socket sending packet "message" (0) +33ms socket.io:socket joined room AGSXig1EuXMzl0ZdAAAA +6ms engine intercepting request for path "/socket.io/" +2s engine handling "GET" http request "/socket.io/?EIO=3&transport=polling&sid=AGSXig1EuXMzl0ZdAAAA" +0ms engine setting new request for existing client +1ms engine:polling setting request +0ms engine:socket flushing buffer to transport +0ms engine:polling writing "�40" +1ms engine:socket executing batch send callback +3ms engine upgrading existing transport +36ms engine:socket might upgrade socket transport from "polling" to "websocket" +14ms engine intercepting request for path "/socket.io/" +16ms engine handling "POST" http request "/socket.io/?EIO=3&transport=polling&sid=AGSXig1EuXMzl0ZdAAAA" +1ms engine setting new request for existing client +2ms engine:polling received �42["MeasurementData",{"Time":1490087856656,"Date":"Tue Mar 21 10:17:36 CET 2017"}]" +6ms engine:socket packet +4ms socket.io-parser decoded 2["MeasurementData",{"Time":1490087856656,"Date":"Tue Mar 21 10:17:36 CET 2017"}] as {"type":2,"nsp":"/","da ta":["MeasurementData",{"Time":1490087856656,"Date":"Tue Mar 21 10:17:36 CET 2017"}]} +2s socket.io:socket got packet {"type":2,"nsp":"/","data":["MeasurementData",{"Time":1490087856656,"Date":"Tue Mar 21 10:17:36 CET 2017" }]} +9ms socket.io:socket emitting event ["MeasurementData",{"Time":1490087856656,"Date":"Tue Mar 21 10:17:36 CET 2017"}] +1ms socket.io:socket dispatching an event ["MeasurementData",{"Time":1490087856656,"Date":"Tue Mar 21 10:17:36 CET 2017"}] +0ms MeasurementData: Tue Mar 21 10:17:36 CET 2017: 1490087856656 engine:socket client did not complete upgrade - closing transport +10s engine:ws closing +1ms engine:polling closing +1m engine:polling transport not writable - buffering orderly close +1ms socket.io:client client close with reason ping timeout +4ms socket.io:socket closing socket - reason ping timeout +3ms disconnected... engine intercepting request for path "/socket.io/" +10m engine handling "GET" http request "/socket.io/?EIO=3&transport=polling" +0ms engine handshaking client "jC1EJWCHXLC4H8WdAAAB" +1ms engine:socket sending packet "open" ({"sid":"jC1EJWCHXLC4H8WdAAAB","upgrades":["websocket"],"pingInterval":25000,"pingTimeout":60000}) +1ms engine:polling setting request +0ms engine:socket flushing buffer to transport +0ms engine:polling writing " �0{"sid":"jC1EJWCHXLC4H8WdAAAB","upgrades":["websocket"],"pingInterval":25000,"pingTimeout":60000}" +2ms engine:socket executing batch send callback +2ms socket.io:server incoming connection with id jC1EJWCHXLC4H8WdAAAB +1ms socket.io:client connecting to namespace / +3ms socket.io:namespace adding socket to nsp / +1ms socket.io:socket socket connected - writing packet +4ms socket.io:socket joining room jC1EJWCHXLC4H8WdAAAB +1ms socket.io:client writing packet {"type":0,"nsp":"/"} +2ms socket.io-parser encoding packet {"type":0,"nsp":"/"} +11m socket.io-parser encoded {"type":0,"nsp":"/"} as 0 +1ms engine:socket sending packet "message" (0) +4ms socket.io:socket joined room jC1EJWCHXLC4H8WdAAAB +2ms engine intercepting request for path "/socket.io/" +2s engine handling "GET" http request "/socket.io/?EIO=3&transport=polling&sid=jC1EJWCHXLC4H8WdAAAB" +1ms engine setting new request for existing client +0ms engine:polling setting request +0ms engine:socket flushing buffer to transport +0ms engine:polling writing "�40" +0ms engine:socket executing batch send callback +0ms engine upgrading existing transport +29ms engine:socket might upgrade socket transport from "polling" to "websocket" +1ms engine intercepting request for path "/socket.io/" +1ms engine handling "POST" http request "/socket.io/?EIO=3&transport=polling&sid=jC1EJWCHXLC4H8WdAAAB" +0ms engine setting new request for existing client +0ms engine:polling received �420["MeasurementData",{"Time":1490088532965,"Date":"Tue Mar 21 10:28:52 CET 2017"}]" +1ms engine:socket packet +0ms socket.io-parser decoded 20["MeasurementData",{"Time":1490088532965,"Date":"Tue Mar 21 10:28:52 CET 2017"}] as {"type":2,"nsp":"/","id":0,"data":["MeasurementData",{"Time":1490088532965,"Date":"Tue Mar 21 10:28:52 CET 2017"}]} +2s socket.io:socket got packet {"type":2,"nsp":"/","id":0,"data":["MeasurementData",{"Time":1490088532965,"Date":"Tue Mar 21 10:28:52 CET 2017"}]} +2ms socket.io:socket emitting event ["MeasurementData",{"Time":1490088532965,"Date":"Tue Mar 21 10:28:52 CET 2017"}] +0ms socket.io:socket attaching ack callback to event +0ms socket.io:socket dispatching an event ["MeasurementData",{"Time":1490088532965,"Date":"Tue Mar 21 10:28:52 CET 2017"},null] +1ms MeasurementData: Tue Mar 21 10:28:52 CET 2017: 1490088532965 engine:socket client did not complete upgrade - transport closed +8s engine:polling closing +1m engine:polling transport not writable - buffering orderly close +0ms socket.io:client client close with reason ping timeout +0ms socket.io:socket closing socket - reason ping timeout +1ms disconnected...