socket event listeners not removing after disconnect in objective c

[NarasimhaDo]

I'm disconnecting socket from client side. whenever server is restarted on connect method is triggering.

[nuclearace]

Can you post some logs around this happening?

[NarasimhaDo]

2018-12-17 17:50:10.799123+0530 DemoApp[2382:681711] connecting to socket
2018-12-17 17:50:10.869857+0530 DemoApp[2382:681711] socket connected :: xNDgfWoRILV6arciAACz (socketID)
2018-12-17 17:51:07.822233+0530 DemoApp[2382:681711] User logging out -> socket disconnecting
2018-12-17 17:51:07.824516+0530 DemoApp[2382:681711] socket disconnected from client

-------------------- socket server restarted --------------------

2018-12-17 17:53:52.101874+0530 DemoApp[2382:681711] socket connected :: rGlir5Q9AKiqeXPZAAAH (socketID)

Notes :
After socket server got restarted , client is receiving onConnect method called automatically (should not, as the client was already logged out (disconnected))

[nuclearace]

Can you post the actual client logs? I want to see what the engine/manager/client think they should do in this case.

[NarasimhaDo]

2018-12-17 18:29:30.442719+0530 DemoApp[19774:531010] libMobileGestalt MobileGestalt.c:890: MGIsDeviceOneOfType is not supported on this platform.
2018-12-17 18:29:30.669262+0530 DemoApp[19774:531010] the launch options is (null)
2018-12-17 18:29:30.669449+0530 DemoApp[19774:531010] the launch options is (null)
2018-12-17 18:29:30.851201+0530 DemoApp[19774:531010] the network connected to wifi 1
2018-12-17 18:29:30.881476+0530 DemoApp[19774:531010] db path is /Users/narasimhudu/Library/Developer/CoreSimulator/Devices/F530DA8D-7614-484D-8E73-2F919CC2C0AD/data/Containers/Data/Application/124FABFB-002B-41F8-88CA-F5F05627546B/Documents/DemoApp.db
2018-12-17 18:29:31.026244+0530 DemoApp[19774:531293] the network connected to wifi 2
2018-12-17 18:29:31.028496+0530 DemoApp[19774:531293] the network connected to wifi 2
2018-12-17 18:29:32.004458+0530 DemoApp[19774:531010] the search string is ***
2018-12-17 18:29:32.012219+0530 DemoApp[19774:531010] Push registration success.
2018-12-17 18:29:32.033757+0530 DemoApp[19774:531287] 4.9.0 - [Firebase/Analytics][I-ACS023007] Firebase Analytics v.40009000 started
2018-12-17 18:29:32.035019+0530 DemoApp[19774:531287] 4.9.0 - [Firebase/Analytics][I-ACS023008] To enable debug logging set the following application argument: -FIRAnalyticsDebugEnabled (see http://goo.gl/RfcP7r)
2018-12-17 18:29:32.187433+0530 DemoApp[19774:531311] 4.9.0 - [Firebase/Messaging][I-FCM001000] FIRMessaging Remote Notifications proxy enabled, will swizzle remote notification receiver handlers. If you'd prefer to manually integrate Firebase Messaging, add "FirebaseAppDelegateProxyEnabled" to your Info.plist, and set it to NO. Follow the instructions at:
https://firebase.google.com/docs/cloud-messaging/ios/client#method_swizzling_in_firebase_messaging
to ensure proper integration.
2018-12-17 18:29:32.194418+0530 DemoApp[19774:531010] the generate fcm token is 152
2018-12-17 18:29:32.289234+0530 DemoApp[19774:531010] user_id available
2018-12-17 18:29:32.292752+0530 DemoApp[19774:531010] the dict is <SocketIO.SocketIOClient: 0x600001eb5560>
2018-12-17 18:29:32.293068+0530 DemoApp[19774:531010] connecting socket
2018-12-17 18:29:32.299259+0530 DemoApp[19774:531272] 4.9.0 - [Firebase/Messaging][I-FCM012002] Error in application:didFailToRegisterForRemoteNotificationsWithError: remote notifications are not supported in the simulator
2018-12-17 18:29:32.301541+0530 DemoApp[19774:531272] 4.9.0 - [Firebase/Messaging][I-FCM012002] Error in application:didFailToRegisterForRemoteNotificationsWithError: remote notifications are not supported in the simulator
2018-12-17 18:29:32.324998+0530 DemoApp[19774:531319] the data is voip not exist {
message = success;
success = 1;
}
2018-12-17 18:29:32.377231+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Adding handler for event: get_online_users
2018-12-17 18:29:32.377623+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Adding handler for event: receive_message
2018-12-17 18:29:32.377759+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Adding handler for event: typing
2018-12-17 18:29:32.377874+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Adding handler for event: message_sent
2018-12-17 18:29:32.378024+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Adding handler for event: message_read
2018-12-17 18:29:32.378177+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Adding handler for event: message_delivered
2018-12-17 18:29:32.378320+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Adding handler for event: group_updated
2018-12-17 18:29:32.378428+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Adding handler for event: group_created
2018-12-17 18:29:32.378593+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Adding handler for event: new_online
2018-12-17 18:29:32.378753+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Adding handler for event: new_offline
2018-12-17 18:29:32.378944+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Adding handler for event: get_new_users_available_status
2018-12-17 18:29:32.379333+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Adding handler for event: new_dnd
2018-12-17 18:29:32.379693+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Adding handler for event: unread_messages_count
2018-12-17 18:29:32.379840+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Adding handler for event: user_created
2018-12-17 18:29:32.380116+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Adding handler for event: get_user_last_seen
2018-12-17 18:29:32.380274+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Adding handler for event: user_unread_messages_count
2018-12-17 18:29:32.380539+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Adding handler for event: get_missing_messages
2018-12-17 18:29:32.380790+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Adding handler for event: sync_offline_messages
2018-12-17 18:29:32.381074+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Adding handler for event: logout
2018-12-17 18:29:32.381310+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Adding handler for event: user_pic_updated
2018-12-17 18:29:32.382259+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Adding handler for event: disconnect
2018-12-17 18:29:32.382499+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Adding handler for event: socket_error
2018-12-17 18:29:32.382801+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Adding handler for event: video_call_user
2018-12-17 18:29:32.405643+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Adding handler for event: video_call_permission
2018-12-17 18:29:32.405843+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Adding handler for event: video_signal
2018-12-17 18:29:32.406040+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Adding handler for event: stop_video_call
2018-12-17 18:29:32.406167+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Adding handler for event: screen_share_permission
2018-12-17 18:29:32.406326+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Adding handler for event: sharing_signal
2018-12-17 18:29:32.406469+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Adding handler for event: stop_screen_sharing
2018-12-17 18:29:32.406650+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Adding handler for event: share_screen
2018-12-17 18:29:32.407503+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Adding handler for event: is_calling_screen_active
2018-12-17 18:29:32.407831+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Adding handler for event: account_verified
2018-12-17 18:29:32.408023+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Adding handler for event: get_active_devices
2018-12-17 18:29:32.408320+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Adding handler for event: delete_message
2018-12-17 18:29:32.408622+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Adding handler for event: recall_message
2018-12-17 18:29:32.408977+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Closing socket
2018-12-17 18:29:32.409309+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Disconnected: Namespace leave
2018-12-17 18:29:32.433712+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Handling event: statusChange with data: [disconnected]
2018-12-17 18:29:32.434245+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Handling event: disconnect with data: ["Namespace leave"]
2018-12-17 18:29:32.434615+0530 DemoApp[19774:531010] the socket disconnect (
"Namespace leave"
) *****
2018-12-17 18:29:32.435592+0530 DemoApp[19774:531010] socket disconnected
2018-12-17 18:29:32.435704+0530 DemoApp[19774:531010] the socket disconnet data is called
2018-12-17 18:29:32.436012+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Adding handler for event: private_chat_permission
2018-12-17 18:29:32.436142+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Adding handler for event: end_private_chat
2018-12-17 18:29:32.436300+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Adding handler for event: check_private_chat
2018-12-17 18:29:32.436413+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Adding handler for event: init_private_chat
2018-12-17 18:29:32.436547+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Adding handler for event: get_all_burnouts
2018-12-17 18:29:32.436740+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Adding handler for event: user_status_updated
2018-12-17 18:29:32.436858+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Adding handler for event: reconnect
2018-12-17 18:29:32.436969+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Adding handler for event: disconnect
2018-12-17 18:29:32.437122+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Adding handler for event: connect
2018-12-17 18:29:32.437247+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Handling event: statusChange with data: [connecting]
2018-12-17 18:29:32.437400+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Joining namespace /
2018-12-17 18:29:32.437625+0530 DemoApp[19774:531010] LOG SocketManager: Tried connecting socket when engine isn't open. Connecting
2018-12-17 18:29:32.437783+0530 DemoApp[19774:531010] LOG SocketManager: Adding engine
2018-12-17 18:29:32.439508+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Handling event: error with data: ["Tried emitting when not connected"]
2018-12-17 18:29:32.453071+0530 DemoApp[19774:531287] LOG SocketEngine: Starting engine. Server: http://192.168.2.55:8080
2018-12-17 18:29:32.453263+0530 DemoApp[19774:531287] LOG SocketEngine: Handshaking
2018-12-17 18:29:32.453688+0530 DemoApp[19774:531287] LOG SocketEnginePolling: Doing polling GET http://192.168.2.55:8080/socket.io/?transport=polling&b64=1&platform=4&is_background=0&user_id=33&device_name=iPhone%208%20Plus&token=0jhWvsQF04rVSwNjeJ0g5xy8lS7rPVEQ
2018-12-17 18:29:32.460525+0530 DemoApp[19774:531319] LOG SocketEnginePolling: Got polling response
2018-12-17 18:29:32.460728+0530 DemoApp[19774:531319] LOG SocketEnginePolling: Got poll message: 96:0{"sid":"mEseJQeozIo0A9f_AAAh","upgrades":["websocket"],"pingInterval":25000,"pingTimeout":5000}2:40
2018-12-17 18:29:32.461118+0530 DemoApp[19774:531319] LOG SocketEngine: Got message: 0{"sid":"mEseJQeozIo0A9f_AAAh","upgrades":["websocket"],"pingInterval":25000,"pingTimeout":5000}
2018-12-17 18:29:32.464502+0530 DemoApp[19774:531319] LOG SocketEngine: Got message: 40
2018-12-17 18:29:32.464777+0530 DemoApp[19774:531319] LOG SocketEnginePolling: Doing polling GET http://192.168.2.55:8080/socket.io/?transport=polling&b64=1&platform=4&is_background=0&user_id=33&device_name=iPhone%208%20Plus&token=0jhWvsQF04rVSwNjeJ0g5xy8lS7rPVEQ&sid=mEseJQeozIo0A9f_AAAh
2018-12-17 18:29:32.465986+0530 DemoApp[19774:531319] LOG SocketEngine: Writing poll: has data: false
2018-12-17 18:29:32.466337+0530 DemoApp[19774:531319] LOG SocketEnginePolling: Sending poll: as type: 2
2018-12-17 18:29:32.467099+0530 DemoApp[19774:531319] LOG SocketEnginePolling: Created POST string: 1:2
2018-12-17 18:29:32.467649+0530 DemoApp[19774:531319] LOG SocketEnginePolling: POSTing
2018-12-17 18:29:32.468153+0530 DemoApp[19774:531319] LOG SocketEnginePolling: Doing polling POST http://192.168.2.55:8080/socket.io/?transport=polling&b64=1&platform=4&is_background=0&user_id=33&device_name=iPhone%208%20Plus&token=0jhWvsQF04rVSwNjeJ0g5xy8lS7rPVEQ&sid=mEseJQeozIo0A9f_AAAh
2018-12-17 18:29:32.473909+0530 DemoApp[19774:531287] LOG SocketEnginePolling: Got polling response
2018-12-17 18:29:32.474071+0530 DemoApp[19774:531287] LOG SocketEnginePolling: Got poll message: 33:42["new_online",{"user_id":"33"}]96:42["get_users_available_status",{"online":["138","54","6","46","70","33","102","157"],"dnd":[]}]
2018-12-17 18:29:32.474507+0530 DemoApp[19774:531287] LOG SocketEngine: Got message: 42["new_online",{"user_id":"33"}]
2018-12-17 18:29:32.474915+0530 DemoApp[19774:531287] LOG SocketEngine: Got message: 42["get_users_available_status",{"online":["138","54","6","46","70","33","102","157"],"dnd":[]}]
2018-12-17 18:29:32.475691+0530 DemoApp[19774:531287] LOG SocketEnginePolling: Doing polling GET http://192.168.2.55:8080/socket.io/?transport=polling&b64=1&platform=4&is_background=0&user_id=33&device_name=iPhone%208%20Plus&token=0jhWvsQF04rVSwNjeJ0g5xy8lS7rPVEQ&sid=mEseJQeozIo0A9f_AAAh
2018-12-17 18:29:32.477364+0530 DemoApp[19774:531272] LOG SocketEngineWebSocket: Sending ws: probe as type: 2
2018-12-17 18:29:32.480787+0530 DemoApp[19774:531272] LOG SocketEnginePolling: Got polling response
2018-12-17 18:29:32.480953+0530 DemoApp[19774:531272] LOG SocketEnginePolling: Got poll message: 1:3
2018-12-17 18:29:32.481096+0530 DemoApp[19774:531272] LOG SocketEngine: Got message: 3
2018-12-17 18:29:32.481595+0530 DemoApp[19774:531272] LOG SocketEnginePolling: Doing polling GET http://192.168.2.55:8080/socket.io/?transport=polling&b64=1&platform=4&is_background=0&user_id=33&device_name=iPhone%208%20Plus&token=0jhWvsQF04rVSwNjeJ0g5xy8lS7rPVEQ&sid=mEseJQeozIo0A9f_AAAh
2018-12-17 18:29:32.482911+0530 DemoApp[19774:531287] LOG SocketEngine: Got message: 3probe
2018-12-17 18:29:32.484339+0530 DemoApp[19774:531287] LOG SocketEngine: Received probe response, should upgrade to WebSockets
2018-12-17 18:29:32.484906+0530 DemoApp[19774:531287] LOG SocketEngine: Upgrading transport to WebSockets
2018-12-17 18:29:32.485541+0530 DemoApp[19774:531287] LOG SocketEnginePolling: Sending poll: as type: 6
2018-12-17 18:29:32.486476+0530 DemoApp[19774:531287] LOG SocketEnginePolling: Created POST string: 1:6
2018-12-17 18:29:32.487036+0530 DemoApp[19774:531287] LOG SocketEnginePolling: POSTing
2018-12-17 18:29:32.595194+0530 DemoApp[19774:531319] LOG SocketEnginePolling: Got polling response
2018-12-17 18:29:32.595452+0530 DemoApp[19774:531319] LOG SocketEnginePolling: Got poll message: 1:6
2018-12-17 18:29:32.595708+0530 DemoApp[19774:531319] LOG SocketEngine: Got message: 6
2018-12-17 18:29:32.595830+0530 DemoApp[19774:531319] LOG SocketEngine: Switching to WebSockets
2018-12-17 18:29:32.595944+0530 DemoApp[19774:531319] LOG SocketEngineWebSocket: Sending ws: as type: 5
2018-12-17 18:29:32.596127+0530 DemoApp[19774:531319] LOG SocketEngine: Flushing probe wait
2018-12-17 18:29:32.731544+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Handling event: ping with data: []
2018-12-17 18:29:32.732017+0530 DemoApp[19774:531010] LOG SocketManager: Engine opened Connect
2018-12-17 18:29:32.732325+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Socket connected
2018-12-17 18:29:32.732593+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Handling event: statusChange with data: [connected]
2018-12-17 18:29:32.733592+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Handling event: connect with data: ["/"]
2018-12-17 18:29:32.734872+0530 DemoApp[19774:531010] socket connceted :: mEseJQeozIo0A9f_AAAh
2018-12-17 18:29:32.735146+0530 DemoApp[19774:531010] the suer ID 33
2018-12-17 18:29:32.736040+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Emitting: 21["version_management",{"app_version":"1.1.10"}]
2018-12-17 18:29:32.736352+0530 DemoApp[19774:531319] LOG SocketEngine: Writing ws: 21["version_management",{"app_version":"1.1.10"}] has data: false
2018-12-17 18:29:32.736499+0530 DemoApp[19774:531319] LOG SocketEngineWebSocket: Sending ws: 21["version_management",{"app_version":"1.1.10"}] as type: 4
2018-12-17 18:29:32.736636+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Emitting: 2["get_new_users_available_status",{"user_id":"33","token":"0jhWvsQF04rVSwNjeJ0g5xy8lS7rPVEQ"}]
2018-12-17 18:29:33.179058+0530 DemoApp[19774:531319] LOG SocketEngine: Writing ws: 2["get_new_users_available_status",{"user_id":"33","token":"0jhWvsQF04rVSwNjeJ0g5xy8lS7rPVEQ"}] has data: false
2018-12-17 18:29:33.179137+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Emitting: 2["sync_undelivered_messages",{"user_id":"33"}]
2018-12-17 18:29:33.179223+0530 DemoApp[19774:531319] LOG SocketEngineWebSocket: Sending ws: 2["get_new_users_available_status",{"user_id":"33","token":"0jhWvsQF04rVSwNjeJ0g5xy8lS7rPVEQ"}] as type: 4
2018-12-17 18:29:33.179343+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Emitting: 2["user_unread_messages_count",{"user_id":"33"}]
2018-12-17 18:29:33.179380+0530 DemoApp[19774:531319] LOG SocketEngine: Writing ws: 2["sync_undelivered_messages",{"user_id":"33"}] has data: false
2018-12-17 18:29:33.179572+0530 DemoApp[19774:531319] LOG SocketEngineWebSocket: Sending ws: 2["sync_undelivered_messages",{"user_id":"33"}] as type: 4
2018-12-17 18:29:33.179754+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Emitting: 22["get_all_burnouts",{}]
2018-12-17 18:29:33.179986+0530 DemoApp[19774:531319] LOG SocketEngine: Writing ws: 2["user_unread_messages_count",{"user_id":"33"}] has data: false
2018-12-17 18:29:33.180619+0530 DemoApp[19774:531319] LOG SocketEngineWebSocket: Sending ws: 2["user_unread_messages_count",{"user_id":"33"}] as type: 4
2018-12-17 18:29:33.180948+0530 DemoApp[19774:531319] LOG SocketEngine: Writing ws: 22["get_all_burnouts",{}] has data: false
2018-12-17 18:29:33.181188+0530 DemoApp[19774:531319] LOG SocketEngineWebSocket: Sending ws: 22["get_all_burnouts",{}] as type: 4
2018-12-17 18:29:33.181472+0530 DemoApp[19774:531319] LOG SocketEngine: Got message: 431[{"success":false,"message":"No updates"}]
2018-12-17 18:29:33.182015+0530 DemoApp[19774:531319] LOG SocketEngine: Got message: 42["get_new_users_available_status",{"online":["6","33","46","54","70","138"],"dnd":[]}]
2018-12-17 18:29:33.189109+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Emitting: 2["get_missing_messages",{"message_ids":["6096","6095","6094","6093","6092","6091","6090","6089","6088","6087","6086","6085","6084","6083","6082","6081","6080","6079","6078","6077","6076","6075","6074","6073","6072","6071","6070","6069","6068","6067","6066","6065","6064","6063","6062","6061","6060","6059","6058","6057","6056","6055","6054","6053","6052","6051","6050","6046","6045","6044","6043","6042","6041","6040","6018","6017","6016","6014","6012","6011","6010","6009","6008","6007","6006","6005","6004","6003","6002","6001","6000","5999","5998","5997","5996","5995","5994","5993","5992","5991","5990","5989","5988","5987","5986","5985","5984","5983","5982","5981","5980","5979","5978","5977","5976","5975","5974","5973","5972","5971"],"user_id":"33"}]
2018-12-17 18:29:33.189444+0530 DemoApp[19774:531311] LOG SocketEngine: Writing ws: 2["get_missing_messages",{"message_ids":["6096","6095","6094","6093","6092","6092018-12-17 18:29:33.189546+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Emitting: 23["get_all_burnouts",{}]
1","6090","6089","6088","6087","6086","6085","6084","6083","6082","6081","6080","6079","6078","6077","6076","6075","6074","6073","6072","6071","6070","6069","6068","6067","6066","6065","6064","6063","6062","6061","6060","6059","6058","6057","6056","6055","6054","6053","6052","6051","6050","6046","6045","6044","6043","6042","6041","6040","6018","6017","6016","6014","6012","6011","6010","6009","6008","6007","6006","6005","6004","6003","6002","6001","6000","5999","5998","5997","5996","5995","5994","5993","5992","5991","5990","5989","5988","5987","5986","5985","5984","5983","5982","5981","5980","5979","5978","5977","5976","5975","5974","5973","5972","5971"],"user_id":"33"}] has data: false
2018-12-17 18:29:33.190062+0530 DemoApp[19774:531311] LOG SocketEngineWebSocket: Sending ws: 2["get_missing_messages",{"message_ids":["6096","6095","6094","6093","6092","6091","6090","6089","6088","6087","6086","6085","6084","6083","6082","6081","6080","6079","6078","6077","6076","6075","6074","6073","6072","6071","6070","6069","6068","6067","6066","6065","6064","6063","6062","6061","6060","6059","6058","6057","6056","6055","6054","6053","6052","6051","6050","6046","6045","6044","6043","6042","6041","6040","6018","6017","6016","6014","6012","6011","6010","6009","6008","6007","6006","6005","6004","6003","6002","6001","6000","5999","5998","5997","5996","5995","5994","5993","5992","5991","5990","5989","5988","5987","5986","5985","5984","5983","5982","5981","5980","5979","5978","5977","5976","5975","5974","5973","5972","5971"],"user_id":"33"}] as type: 4
2018-12-17 18:29:33.190078+0530 DemoApp[19774:531010] LOG SocketParser: Parsing 0
2018-12-17 18:29:33.211417+0530 DemoApp[19774:531010] LOG SocketParser: Decoded packet as: SocketPacket {type: 0; data: []; id: -1; placeholders: 0; nsp: /}
2018-12-17 18:29:33.211429+0530 DemoApp[19774:531311] LOG SocketEngine: Writing ws: 23["get_all_burnouts",{}] has data: false
2018-12-17 18:29:33.211589+0530 DemoApp[19774:531010] LOG SocketParser: Parsing 2["new_online",{"user_id":"33"}]
2018-12-17 18:29:33.211639+0530 DemoApp[19774:531311] LOG SocketEngineWebSocket: Sending ws: 23["get_all_burnouts",{}] as type: 4
2018-12-17 18:29:33.211935+0530 DemoApp[19774:531311] LOG SocketEngine: Got message: 42["user_unread_messages_count",[{"unread_messages":1,"entity_type":1,"entity_id":6}]]
2018-12-17 18:29:33.211943+0530 DemoApp[19774:531010] LOG SocketParser: Decoded packet as: SocketPacket {type: 2; data: [new_online, {
"user_id" = 33;
}]; id: -1; placeholders: -1; nsp: /}
2018-12-17 18:29:33.212078+0530 DemoApp[19774:531311] LOG SocketEngine: Got message: 432[{"success":true,"data":[]}]
2018-12-17 18:29:33.212550+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Handling event: new_online with data: [{
"user_id" = 33;
}]
2018-12-17 18:29:33.213315+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Emitting: 2["get_new_users_available_status",{"user_id":"33","token":"0jhWvsQF04rVSwNjeJ0g5xy8lS7rPVEQ"}]
2018-12-17 18:29:33.213497+0530 DemoApp[19774:531311] LOG SocketEngine: Writing ws: 2["get_new_users_available_status",{"user_id":"33","token":"0jhWvsQF04rVSwNjeJ0g5xy8lS7rPVEQ"}] has data: false
2018-12-17 18:29:33.213524+0530 DemoApp[19774:531010] LOG SocketParser: Parsing 2["get_users_available_status",{"online":["138","54","6","46","70","33","102","157"],"dnd":[]}]
2018-12-17 18:29:33.213628+0530 DemoApp[19774:531311] LOG SocketEngineWebSocket: Sending ws: 2["get_new_users_available_status",{"user_id":"33","token":"0jhWvsQF04rVSwNjeJ0g5xy8lS7rPVEQ"}] as type: 4
2018-12-17 18:29:33.213800+0530 DemoApp[19774:531010] LOG SocketParser: Decoded packet as: SocketPacket {type: 2; data: [get_users_available_status, {
dnd = (
);
online = (
138,
54,
6,
46,
70,
33,
102,
157
);
}]; id: -1; placeholders: -1; nsp: /}
2018-12-17 18:29:33.214281+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Handling event: get_users_available_status with data: [{
dnd = (
);
online = (
138,
54,
6,
46,
70,
33,
102,
157
);
}]
2018-12-17 18:29:33.214515+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Handling event: pong with data: []
2018-12-17 18:29:33.214775+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Handling event: pong with data: []
2018-12-17 18:29:33.216315+0530 DemoApp[19774:531010] LOG SocketParser: Parsing 31[{"success":false,"message":"No updates"}]
2018-12-17 18:29:33.216588+0530 DemoApp[19774:531010] LOG SocketParser: Decoded packet as: SocketPacket {type: 3; data: [{
message = "No updates";
success = 0;
}]; id: 1; placeholders: -1; nsp: /}
2018-12-17 18:29:33.216737+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Handling ack: 1 with data: [{
message = "No updates";
success = 0;
}]
2018-12-17 18:29:33.216970+0530 DemoApp[19774:531010] teh data is (
{
message = "No updates";
success = 0;
}
)
2018-12-17 18:29:33.217126+0530 DemoApp[19774:531010] LOG SocketParser: Parsing 2["get_new_users_available_status",{"online":["6","33","46","54","70","138"],"dnd":[]}]
2018-12-17 18:29:33.217340+0530 DemoApp[19774:531010] LOG SocketParser: Decoded packet as: SocketPacket {type: 2; data: [get_new_users_available_status, {
dnd = (
);
online = (
6,
33,
46,
54,
70,
138
);
}]; id: -1; placeholders: -1; nsp: /}
2018-12-17 18:29:33.217502+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Handling event: get_new_users_available_status with data: [{
dnd = (
);
online = (
6,
33,
46,
54,
70,
138
);
}]
2018-12-17 18:29:33.218054+0530 DemoApp[19774:531010] LOG SocketParser: Parsing 2["user_unread_messages_count",[{"unread_messages":1,"entity_type":1,"entity_id":6}]]
2018-12-17 18:29:33.218399+0530 DemoApp[19774:531010] LOG SocketParser: Decoded packet as: SocketPacket {type: 2; data: [user_unread_messages_count, <__NSArrayM 0x6000034e4960>(
{
"entity_id" = 6;
"entity_type" = 1;
"unread_messages" = 1;
}
)
]; id: -1; placeholders: -1; nsp: /}
2018-12-17 18:29:33.218611+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Handling event: user_unread_messages_count with data: [<__NSArrayM 0x6000034e4960>(
{
"entity_id" = 6;
"entity_type" = 1;
"unread_messages" = 1;
}
)
]
2018-12-17 18:29:33.219228+0530 DemoApp[19774:531010] LOG SocketParser: Parsing 32[{"success":true,"data":[]}]
2018-12-17 18:29:33.219461+0530 DemoApp[19774:531010] LOG SocketParser: Decoded packet as: SocketPacket {type: 3; data: [{
data = (
);
success = 1;
}]; id: 2; placeholders: -1; nsp: /}
2018-12-17 18:29:33.219610+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Handling ack: 2 with data: [{
data = (
);
success = 1;
}]
2018-12-17 18:29:33.219755+0530 DemoApp[19774:531010] get all burnout list (
{
data = (
);
success = 1;
}
)
2018-12-17 18:29:33.221530+0530 DemoApp[19774:531010] Statement FAILED is message exist or not (no more rows available)
2018-12-17 18:29:33.253000+0530 DemoApp[19774:531319] LOG SocketEngine: Got message: 433[{"success":true,"data":[]}]
2018-12-17 18:29:33.253424+0530 DemoApp[19774:531319] LOG SocketEngine: Got message: 42["get_new_users_available_status",{"online":["6","33","46","54","70","138"],"dnd":[]}]
2018-12-17 18:29:33.277393+0530 DemoApp[19774:531010] LOG SocketParser: Parsing 33[{"success":true,"data":[]}]
2018-12-17 18:29:33.277714+0530 DemoApp[19774:531010] LOG SocketParser: Decoded packet as: SocketPacket {type: 3; data: [{
data = (
);
success = 1;
}]; id: 3; placeholders: -1; nsp: /}
2018-12-17 18:29:33.277879+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Handling ack: 3 with data: [{
data = (
);
success = 1;
}]
2018-12-17 18:29:33.278021+0530 DemoApp[19774:531010] the burn out list data is (
{
data = (
);
success = 1;
}
)
2018-12-17 18:29:33.278139+0530 DemoApp[19774:531010] get all burnout list (
{
data = (
);
success = 1;
}
)
2018-12-17 18:29:33.280103+0530 DemoApp[19774:531010] Statement FAILED is message exist or not (no more rows available)
2018-12-17 18:29:33.280797+0530 DemoApp[19774:531010] LOG SocketParser: Parsing 2["get_new_users_available_status",{"online":["6","33","46","54","70","138"],"dnd":[]}]
2018-12-17 18:29:33.281322+0530 DemoApp[19774:531010] LOG SocketParser: Decoded packet as: SocketPacket {type: 2; data: [get_new_users_available_status, {
dnd = (
);
online = (
6,
33,
46,
54,
70,
138
);
}]; id: -1; placeholders: -1; nsp: /}
2018-12-17 18:29:33.281551+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Handling event: get_new_users_available_status with data: [{
dnd = (
);
online = (
6,
33,
46,
54,
70,
138
);
}]
2018-12-17 18:29:35.382499+0530 DemoApp[19774:531010] the time is 2018-12-17 18:29:32
2018-12-17 18:29:35.382837+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Emitting: 24["sync_messages_by_time",{"time":"2018-12-17 18:29:32"}]
2018-12-17 18:29:35.383013+0530 DemoApp[19774:531311] LOG SocketEngine: Writing ws: 24["sync_messages_by_time",{"time":"2018-12-17 18:29:32"}] has data: false
2018-12-17 18:29:35.383188+0530 DemoApp[19774:531311] LOG SocketEngineWebSocket: Sending ws: 24["sync_messages_by_time",{"time":"2018-12-17 18:29:32"}] as type: 4
2018-12-17 18:29:35.408828+0530 DemoApp[19774:531294] LOG SocketEngine: Got message: 434[{"success":true,"data":[]}]
2018-12-17 18:29:35.409207+0530 DemoApp[19774:531010] LOG SocketParser: Parsing 34[{"success":true,"data":[]}]
2018-12-17 18:29:35.409599+0530 DemoApp[19774:531010] LOG SocketParser: Decoded packet as: SocketPacket {type: 3; data: [{
data = (
);
success = 1;
}]; id: 4; placeholders: -1; nsp: /}
2018-12-17 18:29:35.409791+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Handling ack: 4 with data: [{
data = (
);
success = 1;
}]
2018-12-17 18:29:35.409928+0530 DemoApp[19774:531010] teh delete and recall data is (
{
data = (
);
success = 1;
}
)
2018-12-17 18:29:35.737510+0530 DemoApp[19774:531010] teh data is (
"NO ACK"
)
2018-12-17 18:29:35.737765+0530 DemoApp[19774:531010] LOG OnAckCallback: OnAckCallback for 0 being released
2018-12-17 18:29:35.737978+0530 DemoApp[19774:531010] LOG OnAckCallback: OnAckCallback for 1 being released
2018-12-17 18:29:38.437760+0530 DemoApp[19774:531010] LOG OnAckCallback: OnAckCallback for 2 being released
2018-12-17 18:29:38.437954+0530 DemoApp[19774:531010] LOG OnAckCallback: OnAckCallback for 3 being released
2018-12-17 18:29:38.438107+0530 DemoApp[19774:531010] LOG OnAckCallback: OnAckCallback for 4 being released
2018-12-17 18:29:59.847673+0530 DemoApp[19774:531334] LOG SocketEngine: Writing ws: has data: false
2018-12-17 18:29:59.847670+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Handling event: ping with data: []
2018-12-17 18:29:59.847860+0530 DemoApp[19774:531334] LOG SocketEngineWebSocket: Sending ws: as type: 2
2018-12-17 18:29:59.849172+0530 DemoApp[19774:531334] LOG SocketEngine: Got message: 3
2018-12-17 18:29:59.849386+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Handling event: pong with data: []
2018-12-17 18:30:24.848564+0530 DemoApp[19774:531294] LOG SocketEngine: Writing ws: has data: false
2018-12-17 18:30:24.848564+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Handling event: ping with data: []
2018-12-17 18:30:24.848764+0530 DemoApp[19774:531294] LOG SocketEngineWebSocket: Sending ws: as type: 2
2018-12-17 18:30:24.850042+0530 DemoApp[19774:531294] LOG SocketEngine: Got message: 3
2018-12-17 18:30:24.850216+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Handling event: pong with data: []
2018-12-17 18:30:28.426799+0530 DemoApp[19774:531010] appdelegate search string is
2018-12-17 18:30:31.546341+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Closing socket
2018-12-17 18:30:31.546596+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Disconnected: Namespace leave
2018-12-17 18:30:31.546642+0530 DemoApp[19774:531785] LOG SocketEngine: Writing ws: 1/, has data: false
2018-12-17 18:30:31.546739+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Handling event: statusChange with data: [disconnected]
2018-12-17 18:30:31.546750+0530 DemoApp[19774:531785] LOG SocketEngineWebSocket: Sending ws: 1/, as type: 4
2018-12-17 18:30:31.546888+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Handling event: disconnect with data: ["Namespace leave"]
2018-12-17 18:30:31.547012+0530 DemoApp[19774:531010] the socket disconnect (
"Namespace leave"
) *****
2018-12-17 18:30:31.548116+0530 DemoApp[19774:531010] socket starting disconnect
2018-12-17 18:30:31.549144+0530 DemoApp[19774:531010] socket disconnected from client
2018-12-17 18:30:31.551054+0530 DemoApp[19774:531010] Statement FAILED is message exist or not (no more rows available)
2018-12-17 18:30:31.946163+0530 DemoApp[19774:531010] Statement FAILED is message exist or not (no more rows available)

2018-12-17 18:30:31.972611+0530 DemoApp[19774:531010] [<__NSCFString 0x60000342bdb0> valueForUndefinedKey:]: this class is not key value coding-compliant for the key api_key.
2018-12-17 18:30:31.973424+0530 DemoApp[19774:531010] the socket is is (null) ******** (null)
2018-12-17 18:30:32.007298+0530 DemoApp[19774:531294] the data is voip not exist {
errorCode = 2;
message = "UnAuthorized Request";
success = 0;
}
2018-12-17 18:30:32.166431+0530 DemoApp[19774:531010] [MC] System group container for systemgroup.com.apple.configurationprofiles path is /Users/narasimhudu/Library/Developer/CoreSimulator/Devices/F530DA8D-7614-484D-8E73-2F919CC2C0AD/data/Containers/Shared/SystemGroup/systemgroup.com.apple.configurationprofiles
2018-12-17 18:30:32.166916+0530 DemoApp[19774:531010] [MC] Reading from private effective user settings.
2018-12-17 18:30:45.412006+0530 DemoApp[19774:531010] LOG SocketManager: Starting reconnect
2018-12-17 18:30:45.412177+0530 DemoApp[19774:531010] LOG SocketManager: Trying to reconnect
2018-12-17 18:30:45.412401+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Handling event: reconnectAttempt with data: [-1]
2018-12-17 18:30:45.412698+0530 DemoApp[19774:531785] LOG SocketEngine: Starting engine. Server: http://192.168.2.55:8080
2018-12-17 18:30:45.412806+0530 DemoApp[19774:531785] LOG SocketEngine: Handshaking
2018-12-17 18:30:45.413082+0530 DemoApp[19774:531785] LOG SocketEnginePolling: Doing polling GET http://192.168.2.55:8080/socket.io/?transport=polling&b64=1&platform=4&is_background=0&user_id=33&device_name=iPhone%208%20Plus&token=0jhWvsQF04rVSwNjeJ0g5xy8lS7rPVEQ
2018-12-17 18:30:45.518390+0530 DemoApp[19774:532341] [] nw_socket_handle_socket_event [C11:2] Socket SO_ERROR [61: Connection refused]
2018-12-17 18:30:45.519352+0530 DemoApp[19774:532341] TIC TCP Conn Failed [11:0x600000fab300]: 1:61 Err(61)
2018-12-17 18:30:45.521195+0530 DemoApp[19774:532341] Task <97D240BE-3490-4377-8781-DD183D4D22CB>.<1> HTTP load failed (error code: -1004 [1:61])
2018-12-17 18:30:45.521463+0530 DemoApp[19774:531785] Task <97D240BE-3490-4377-8781-DD183D4D22CB>.<1> finished with error - code: -1004
2018-12-17 18:30:45.539693+0530 DemoApp[19774:532341] ERROR SocketEnginePolling: Could not connect to the server.
2018-12-17 18:30:45.539977+0530 DemoApp[19774:532341] ERROR SocketEngine: Could not connect to the server.
2018-12-17 18:30:45.540139+0530 DemoApp[19774:531010] ERROR SocketManager: Could not connect to the server.
2018-12-17 18:30:45.540276+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Handling event: error with data: ["Could not connect to the server."]
2018-12-17 18:30:55.413137+0530 DemoApp[19774:531010] LOG SocketManager: Trying to reconnect
2018-12-17 18:30:55.413339+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Handling event: reconnectAttempt with data: [-2]
2018-12-17 18:30:55.413571+0530 DemoApp[19774:532342] LOG SocketEngine: Starting engine. Server: http://192.168.2.55:8080
2018-12-17 18:30:55.413702+0530 DemoApp[19774:532342] LOG SocketEngine: Handshaking
2018-12-17 18:30:55.414041+0530 DemoApp[19774:532342] LOG SocketEnginePolling: Doing polling GET http://192.168.2.55:8080/socket.io/?transport=polling&b64=1&platform=4&is_background=0&user_id=33&device_name=iPhone%208%20Plus&token=0jhWvsQF04rVSwNjeJ0g5xy8lS7rPVEQ
2018-12-17 18:30:55.421212+0530 DemoApp[19774:532454] LOG SocketEnginePolling: Got polling response
2018-12-17 18:30:55.421365+0530 DemoApp[19774:532454] LOG SocketEnginePolling: Got poll message: 96:0{"sid":"WZiCBS7K7Qvt8gqRAAAG","upgrades":["websocket"],"pingInterval":25000,"pingTimeout":5000}2:40
2018-12-17 18:30:55.421529+0530 DemoApp[19774:532454] LOG SocketEngine: Got message: 0{"sid":"WZiCBS7K7Qvt8gqRAAAG","upgrades":["websocket"],"pingInterval":25000,"pingTimeout":5000}
2018-12-17 18:30:55.422910+0530 DemoApp[19774:532454] LOG SocketEngine: Got message: 40
2018-12-17 18:30:55.422910+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Handling event: ping with data: []
2018-12-17 18:30:55.423165+0530 DemoApp[19774:532454] LOG SocketEnginePolling: Doing polling GET http://192.168.2.55:8080/socket.io/?transport=polling&b64=1&platform=4&is_background=0&user_id=33&device_name=iPhone%208%20Plus&token=0jhWvsQF04rVSwNjeJ0g5xy8lS7rPVEQ&sid=WZiCBS7K7Qvt8gqRAAAG
2018-12-17 18:30:55.429243+0530 DemoApp[19774:531010] LOG SocketManager: Engine opened Connect
2018-12-17 18:30:55.429384+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Socket connected
2018-12-17 18:30:55.429502+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Handling event: statusChange with data: [connected]
2018-12-17 18:30:55.429437+0530 DemoApp[19774:532454] LOG SocketEngine: Writing poll: has data: false
2018-12-17 18:30:55.429636+0530 DemoApp[19774:532454] LOG SocketEnginePolling: Sending poll: as type: 2
2018-12-17 18:30:55.429675+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Handling event: connect with data: ["/"]
2018-12-17 18:30:55.430248+0530 DemoApp[19774:532454] LOG SocketEnginePolling: Created POST string: 1:2
2018-12-17 18:30:55.430459+0530 DemoApp[19774:531010] socket connceted :: WZiCBS7K7Qvt8gqRAAAG
2018-12-17 18:30:55.430920+0530 DemoApp[19774:532454] LOG SocketEnginePolling: POSTing
2018-12-17 18:30:55.431080+0530 DemoApp[19774:531010] No user login
2018-12-17 18:30:55.431294+0530 DemoApp[19774:532454] LOG SocketEnginePolling: Doing polling POST http://192.168.2.55:8080/socket.io/?transport=polling&b64=1&platform=4&is_background=0&user_id=33&device_name=iPhone%208%20Plus&token=0jhWvsQF04rVSwNjeJ0g5xy8lS7rPVEQ&sid=WZiCBS7K7Qvt8gqRAAAG
2018-12-17 18:30:55.431639+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Emitting: 2["force_disconnect"]
2018-12-17 18:30:55.432026+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Closing socket
2018-12-17 18:30:55.432241+0530 DemoApp[19774:532454] LOG SocketEngineWebSocket: Sending ws: probe as type: 2
2018-12-17 18:30:55.432421+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Disconnected: Namespace leave
2018-12-17 18:30:55.433015+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Handling event: statusChange with data: [disconnected]
2018-12-17 18:30:55.433246+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Handling event: disconnect with data: ["Namespace leave"]
2018-12-17 18:30:55.433526+0530 DemoApp[19774:531010] the socket disconnect (
"Namespace leave"
) *****
2018-12-17 18:30:55.434664+0530 DemoApp[19774:531010] socket starting disconnect

-------------------- socket server restarted --------------------

2018-12-17 18:30:55.435118+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Handling event: error with data: ["Tried emitting when not connected"]
2018-12-17 18:30:55.435140+0530 DemoApp[19774:532454] LOG SocketEngine: Got message: 3probe
2018-12-17 18:30:55.435357+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Handling event: error with data: ["Tried emitting get_new_users_available_status when not connected"]
2018-12-17 18:30:55.435518+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Handling event: error with data: ["Tried emitting user_unread_messages_count when not connected"]
2018-12-17 18:30:55.435798+0530 DemoApp[19774:532454] LOG SocketEngine: Received probe response, should upgrade to WebSockets
2018-12-17 18:30:55.436721+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Handling event: error with data: ["Tried emitting when not connected"]
2018-12-17 18:30:55.436977+0530 DemoApp[19774:531010] LOG SocketParser: Parsing 0
2018-12-17 18:30:55.436977+0530 DemoApp[19774:532454] LOG SocketEngine: Upgrading transport to WebSockets
2018-12-17 18:30:55.437139+0530 DemoApp[19774:531010] LOG SocketParser: Decoded packet as: SocketPacket {type: 0; data: []; id: -1; placeholders: 0; nsp: /}
2018-12-17 18:30:55.437244+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Socket connected
2018-12-17 18:30:55.437372+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Handling event: statusChange with data: [connected]
2018-12-17 18:30:55.437437+0530 DemoApp[19774:532454] LOG SocketEnginePolling: Sending poll: as type: 6
2018-12-17 18:30:55.437508+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Handling event: connect with data: ["/"]
2018-12-17 18:30:55.437707+0530 DemoApp[19774:531010] socket connceted :: WZiCBS7K7Qvt8gqRAAAG
2018-12-17 18:30:55.438277+0530 DemoApp[19774:531010] No user login
2018-12-17 18:30:55.438470+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Emitting: 2["force_disconnect"]
2018-12-17 18:30:55.438637+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Closing socket
2018-12-17 18:30:55.439020+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Disconnected: Namespace leave
2018-12-17 18:30:55.439166+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Handling event: statusChange with data: [disconnected]
2018-12-17 18:30:55.439466+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Handling event: disconnect with data: ["Namespace leave"]
2018-12-17 18:30:55.439638+0530 DemoApp[19774:531010] the socket disconnect (
"Namespace leave"
) *****
2018-12-17 18:30:55.439937+0530 DemoApp[19774:531010] socket starting disconnect
2018-12-17 18:30:55.440624+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Handling event: error with data: ["Tried emitting when not connected"]
2018-12-17 18:30:55.440887+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Handling event: error with data: ["Tried emitting get_new_users_available_status when not connected"]
2018-12-17 18:30:55.441063+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Handling event: error with data: ["Tried emitting user_unread_messages_count when not connected"]
2018-12-17 18:30:55.442225+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Handling event: error with data: ["Tried emitting when not connected"]
2018-12-17 18:30:55.442514+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Handling event: pong with data: []
2018-12-17 18:30:55.651695+0530 DemoApp[19774:532342] LOG SocketEnginePolling: Got polling response
2018-12-17 18:30:55.651879+0530 DemoApp[19774:532342] LOG SocketEnginePolling: Got poll message: 33:42["new_online",{"user_id":"33"}]78:42["get_users_available_status",{"online":["46","6","54","70","33"],"dnd":[]}]
2018-12-17 18:30:55.652038+0530 DemoApp[19774:532342] LOG SocketEngine: Got message: 42["new_online",{"user_id":"33"}]
2018-12-17 18:30:55.652233+0530 DemoApp[19774:531010] LOG SocketParser: Parsing 2["new_online",{"user_id":"33"}]
2018-12-17 18:30:55.652275+0530 DemoApp[19774:532342] LOG SocketEngine: Got message: 42["get_users_available_status",{"online":["46","6","54","70","33"],"dnd":[]}]
2018-12-17 18:30:55.653011+0530 DemoApp[19774:531010] LOG SocketParser: Decoded packet as: SocketPacket {type: 2; data: [new_online, {
"user_id" = 33;
}]; id: -1; placeholders: -1; nsp: /}
2018-12-17 18:30:55.653107+0530 DemoApp[19774:532342] LOG SocketEngine: Switching to WebSockets
2018-12-17 18:30:55.653988+0530 DemoApp[19774:531010] LOG SocketParser: Parsing 2["get_users_available_status",{"online":["46","6","54","70","33"],"dnd":[]}]
2018-12-17 18:30:55.654291+0530 DemoApp[19774:532342] LOG SocketEngineWebSocket: Sending ws: as type: 5
2018-12-17 18:30:55.654946+0530 DemoApp[19774:531010] LOG SocketParser: Decoded packet as: SocketPacket {type: 2; data: [get_users_available_status, {
dnd = (
);
online = (
46,
6,
54,
70,
33
);
}]; id: -1; placeholders: -1; nsp: /}
2018-12-17 18:30:55.655207+0530 DemoApp[19774:532342] LOG SocketEngine: Flushing probe wait
2018-12-17 18:30:55.656568+0530 DemoApp[19774:532342] LOG SocketEngine: Writing ws: 2["force_disconnect"] has data: false
2018-12-17 18:30:55.669594+0530 DemoApp[19774:532342] LOG SocketEngineWebSocket: Sending ws: 2["force_disconnect"] as type: 4
2018-12-17 18:30:55.669801+0530 DemoApp[19774:532342] LOG SocketEngine: Writing ws: 1/, has data: false
2018-12-17 18:30:55.669947+0530 DemoApp[19774:532342] LOG SocketEngineWebSocket: Sending ws: 1/, as type: 4
2018-12-17 18:30:55.670105+0530 DemoApp[19774:532342] LOG SocketEngine: Writing ws: 2["force_disconnect"] has data: false
2018-12-17 18:30:55.670234+0530 DemoApp[19774:532342] LOG SocketEngineWebSocket: Sending ws: 2["force_disconnect"] as type: 4
2018-12-17 18:30:55.670399+0530 DemoApp[19774:532342] LOG SocketEngine: Writing ws: 1/, has data: false
2018-12-17 18:30:55.670552+0530 DemoApp[19774:532342] LOG SocketEngineWebSocket: Sending ws: 1/, as type: 4
2018-12-17 18:30:57.501370+0530 DemoApp[19774:531010] the time is 2018-12-17 18:30:55
2018-12-17 18:30:57.501665+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Handling event: error with data: ["Tried emitting when not connected"]
2018-12-17 18:30:57.502397+0530 DemoApp[19774:531010] the time is 2018-12-17 18:30:55
2018-12-17 18:30:57.502648+0530 DemoApp[19774:531010] LOG SocketIOClient{/}: Handling event: error with data: ["Tried emitting when not connected"]
2018-12-17 18:30:58.595905+0530 DemoApp[19774:531010] teh data is (
"NO ACK"
)
2018-12-17 18:30:58.596527+0530 DemoApp[19774:531010] LOG OnAckCallback: OnAckCallback for 5 being released
2018-12-17 18:30:58.596898+0530 DemoApp[19774:531010] teh data is (
"NO ACK"
)
2018-12-17 18:30:58.597279+0530 DemoApp[19774:531010] LOG OnAckCallback: OnAckCallback for 7 being released
2018-12-17 18:31:00.631464+0530 DemoApp[19774:531010] the burn out list data is (
"NO ACK"
)
2018-12-17 18:31:00.631733+0530 DemoApp[19774:531010] LOG OnAckCallback: OnAckCallback for 6 being released
2018-12-17 18:31:00.631887+0530 DemoApp[19774:531010] the burn out list data is (
"NO ACK"
)
2018-12-17 18:31:00.632006+0530 DemoApp[19774:531010] LOG OnAckCallback: OnAckCallback for 8 being released
2018-12-17 18:31:00.632120+0530 DemoApp[19774:531010] teh delete and recall data is (
"NO ACK"
)
2018-12-17 18:31:00.632245+0530 DemoApp[19774:531010] LOG OnAckCallback: OnAckCallback for 9 being released
2018-12-17 18:31:00.632362+0530 DemoApp[19774:531010] teh delete and recall data is (
"NO ACK"
)
2018-12-17 18:31:00.632474+0530 DemoApp[19774:531010] LOG OnAckCallback: OnAckCallback for 10 being released
2018-12-17 18:31:01.817526+0530 DemoApp[19774:531010] [<__NSCFString 0x6000034fee20> valueForUndefinedKey:]: this class is not key value coding-compliant for the key api_key.
2018-12-17 18:31:01.818563+0530 DemoApp[19774:531010] [<__NSCFString 0x6000034fd800> valueForUndefinedKey:]: this class is not key value coding-compliant for the key api_key.

[NarasimhaDo]

Hi nuclerace! Have you seen the client log?

[nuclearace]

Oh I think I misunderstood the issue. Currently the client doesn't remove handlers on a disconnect, you'll have to manually call removeAllHandlers.

[nuclearace]

Does manually calling removeAllHandlers before your disconnect solve your issue?

[NarasimhaDo]

Thanks nuclearace, however manually calling removeAllHandlers did not solve the issue. Now at client app we are not receiving onConnect callback after socket.io server restarts, but at the server end the client is reconnected with a new socketID after server is restarted.

[janvennemann]

@nuclearace, I'm having the same issue. When i disconnect via the socket client everything is fine, no reconnect happens. Now, if the server restarts the client reconnects shortly after. I expect the client to stay disconnected until i specifically reconnect it manually.

A simple test case:

iOS client:

import UIKit
import SocketIO

class ViewController: UIViewController {
  
  private var manager = SocketManager(socketURL: URL(string: "http://localhost:3210")!);

  override func viewDidLoad() {
    super.viewDidLoad()

    let socket = self.manager.defaultSocket
    socket.on("connect") { (data, ack) in
      print("connect")
    }
    socket.on("disconnect") { (data, ack) in
      print("disconnect")
    }
    socket.connect()
    
    DispatchQueue.main.asyncAfter(deadline: .now() + 2.0) {
      socket.disconnect() // just disconnecting the client will make it reconnect after server restart
      //socket.manager?.disconnect() // disconnecting the whole manager works as expected.
    }
  }
}

socket.io node.js server

const io = require('socket.io');
const server = io(3210);

Logs:

2019-02-05 20:16:30.902367+0100 socket-test[76663:9803276] LOG SocketIOClient{/}: Adding handler for event: connect
2019-02-05 20:16:30.902948+0100 socket-test[76663:9803276] LOG SocketIOClient{/}: Adding handler for event: disconnect
2019-02-05 20:16:30.904117+0100 socket-test[76663:9803276] LOG SocketIOClient{/}: Handling event: statusChange with data: [connecting]
2019-02-05 20:16:30.904247+0100 socket-test[76663:9803276] LOG SocketIOClient{/}: Joining namespace /
2019-02-05 20:16:30.904434+0100 socket-test[76663:9803276] LOG SocketManager: Tried connecting socket when engine isn't open. Connecting
2019-02-05 20:16:30.904544+0100 socket-test[76663:9803276] LOG SocketManager: Adding engine
2019-02-05 20:16:30.907935+0100 socket-test[76663:9803339] LOG SocketEngine: Starting engine. Server: http://localhost:3210
2019-02-05 20:16:30.908061+0100 socket-test[76663:9803339] LOG SocketEngine: Handshaking
2019-02-05 20:16:30.910371+0100 socket-test[76663:9803339] LOG SocketEnginePolling: Doing polling GET http://localhost:3210/socket.io/?transport=polling&b64=1
2019-02-05 20:16:30.986352+0100 socket-test[76663:9803339] LOG SocketEnginePolling: Got polling response
2019-02-05 20:16:30.987017+0100 socket-test[76663:9803339] LOG SocketEnginePolling: Got poll message: 95:0{"sid":"zqWUQ4CoI1Zt2c9mAAAC","upgrades":["websocket"],"pingInterval":2000,"pingTimeout":5000}
2019-02-05 20:16:30.988009+0100 socket-test[76663:9803339] LOG SocketEngine: Got message: 0{"sid":"zqWUQ4CoI1Zt2c9mAAAC","upgrades":["websocket"],"pingInterval":2000,"pingTimeout":5000}
2019-02-05 20:16:30.996417+0100 socket-test[76663:9803276] LOG SocketIOClient{/}: Handling event: ping with data: []
2019-02-05 20:16:30.996441+0100 socket-test[76663:9803339] LOG SocketEnginePolling: Doing polling GET http://localhost:3210/socket.io/?transport=polling&b64=1&sid=zqWUQ4CoI1Zt2c9mAAAC
2019-02-05 20:16:30.996565+0100 socket-test[76663:9803276] LOG SocketManager: Engine opened Connect
2019-02-05 20:16:30.996801+0100 socket-test[76663:9803276] LOG SocketIOClient{/}: Socket connected
2019-02-05 20:16:30.996932+0100 socket-test[76663:9803276] LOG SocketIOClient{/}: Handling event: statusChange with data: [connected]
2019-02-05 20:16:30.997202+0100 socket-test[76663:9803276] LOG SocketIOClient{/}: Handling event: connect with data: ["/"]
2019-02-05 20:16:30.997463+0100 socket-test[76663:9803339] LOG SocketEngine: Writing poll:  has data: false
2019-02-05 20:16:31.047770+0100 socket-test[76663:9803339] LOG SocketEnginePolling: Sending poll:  as type: 2
2019-02-05 20:16:31.048003+0100 socket-test[76663:9803339] LOG SocketEnginePolling: Created POST string: 1:2
2019-02-05 20:16:31.048319+0100 socket-test[76663:9803339] LOG SocketEnginePolling: POSTing
2019-02-05 20:16:31.048448+0100 socket-test[76663:9803339] LOG SocketEnginePolling: Doing polling POST http://localhost:3210/socket.io/?transport=polling&b64=1&sid=zqWUQ4CoI1Zt2c9mAAAC
!!! connect
2019-02-05 20:16:31.048831+0100 socket-test[76663:9803339] LOG SocketEnginePolling: Got polling response
2019-02-05 20:16:31.048938+0100 socket-test[76663:9803339] LOG SocketEnginePolling: Got poll message: 2:40
2019-02-05 20:16:31.049040+0100 socket-test[76663:9803339] LOG SocketEngine: Got message: 40
2019-02-05 20:16:31.049196+0100 socket-test[76663:9803276] LOG SocketIOClient{/}: Handling event: websocketUpgrade with data: [["sec-websocket-accept": "CBdfUFVHiU4RtQnKjDm7AhVje3o=", "upgrade": "websocket", "connection": "Upgrade"]]
2019-02-05 20:16:31.049208+0100 socket-test[76663:9803339] LOG SocketEnginePolling: Doing polling GET http://localhost:3210/socket.io/?transport=polling&b64=1&sid=zqWUQ4CoI1Zt2c9mAAAC
2019-02-05 20:16:31.049450+0100 socket-test[76663:9803276] LOG SocketParser: Parsing 0
2019-02-05 20:16:31.049456+0100 socket-test[76663:9803339] LOG SocketEngineWebSocket: Sending ws: probe as type: 2
2019-02-05 20:16:31.061533+0100 socket-test[76663:9803276] LOG SocketParser: Decoded packet as: SocketPacket {type: 0; data: []; id: -1; placeholders: 0; nsp: /}
2019-02-05 20:16:31.061570+0100 socket-test[76663:9803339] LOG SocketEnginePolling: Got polling response
2019-02-05 20:16:31.061686+0100 socket-test[76663:9803339] LOG SocketEnginePolling: Got poll message: 1:3
2019-02-05 20:16:31.061809+0100 socket-test[76663:9803339] LOG SocketEngine: Got message: 3
2019-02-05 20:16:31.061942+0100 socket-test[76663:9803276] LOG SocketIOClient{/}: Handling event: pong with data: []
2019-02-05 20:16:31.061982+0100 socket-test[76663:9803339] LOG SocketEnginePolling: Doing polling GET http://localhost:3210/socket.io/?transport=polling&b64=1&sid=zqWUQ4CoI1Zt2c9mAAAC
2019-02-05 20:16:31.099733+0100 socket-test[76663:9803355] LOG SocketEngine: Got message: 3probe
2019-02-05 20:16:31.100036+0100 socket-test[76663:9803355] LOG SocketEngine: Received probe response, should upgrade to WebSockets
2019-02-05 20:16:31.100164+0100 socket-test[76663:9803355] LOG SocketEngine: Upgrading transport to WebSockets
2019-02-05 20:16:31.100339+0100 socket-test[76663:9803355] LOG SocketEnginePolling: Sending poll:  as type: 6
2019-02-05 20:16:31.100506+0100 socket-test[76663:9803355] LOG SocketEnginePolling: Created POST string: 1:6
2019-02-05 20:16:31.100887+0100 socket-test[76663:9803355] LOG SocketEnginePolling: POSTing
2019-02-05 20:16:31.101082+0100 socket-test[76663:9803276] LOG SocketIOClient{/}: Handling event: pong with data: []
2019-02-05 20:16:31.167047+0100 socket-test[76663:9803355] LOG SocketEnginePolling: Got polling response
2019-02-05 20:16:31.167150+0100 socket-test[76663:9803355] LOG SocketEnginePolling: Got poll message: 1:6
2019-02-05 20:16:31.167252+0100 socket-test[76663:9803355] LOG SocketEngine: Got message: 6
2019-02-05 20:16:31.167370+0100 socket-test[76663:9803355] LOG SocketEngine: Switching to WebSockets
2019-02-05 20:16:31.167471+0100 socket-test[76663:9803355] LOG SocketEngineWebSocket: Sending ws:  as type: 5
2019-02-05 20:16:31.167611+0100 socket-test[76663:9803355] LOG SocketEngine: Flushing probe wait
2019-02-05 20:16:33.104174+0100 socket-test[76663:9803276] LOG SocketIOClient{/}: Closing socket
2019-02-05 20:16:33.104180+0100 socket-test[76663:9803339] LOG SocketEngine: Writing ws:  has data: false
2019-02-05 20:16:33.104358+0100 socket-test[76663:9803276] LOG SocketIOClient{/}: Disconnected: Namespace leave
2019-02-05 20:16:33.104337+0100 socket-test[76663:9803339] LOG SocketEngineWebSocket: Sending ws:  as type: 2
2019-02-05 20:16:33.104442+0100 socket-test[76663:9803276] LOG SocketIOClient{/}: Handling event: statusChange with data: [disconnected]
2019-02-05 20:16:33.104507+0100 socket-test[76663:9803339] LOG SocketEngine: Writing ws: 1/, has data: false
2019-02-05 20:16:33.104553+0100 socket-test[76663:9803276] LOG SocketIOClient{/}: Handling event: disconnect with data: ["Namespace leave"]
!!! dis2019-02-05 20:16:33.104627+0100 socket-test[76663:9803339] LOG SocketEngineWebSocket: Sending ws: 1/, as type: 4
connect
2019-02-05 20:16:33.104754+0100 socket-test[76663:9803276] LOG SocketIOClient{/}: Handling event: ping with data: []
2019-02-05 20:16:33.105170+0100 socket-test[76663:9803339] LOG SocketEngine: Got message: 3
2019-02-05 20:16:33.105311+0100 socket-test[76663:9803276] LOG SocketIOClient{/}: Handling event: pong with data: []
2019-02-05 20:16:35.299871+0100 socket-test[76663:9803276] LOG SocketIOClient{/}: Handling event: ping with data: []
2019-02-05 20:16:35.299903+0100 socket-test[76663:9803338] LOG SocketEngine: Writing ws:  has data: false
2019-02-05 20:16:35.300150+0100 socket-test[76663:9803338] LOG SocketEngineWebSocket: Sending ws:  as type: 2
2019-02-05 20:16:35.301275+0100 socket-test[76663:9803338] LOG SocketEngine: Got message: 3
2019-02-05 20:16:35.301556+0100 socket-test[76663:9803276] LOG SocketIOClient{/}: Handling event: pong with data: []
2019-02-05 20:16:37.299914+0100 socket-test[76663:9803337] LOG SocketEngine: Writing ws:  has data: false
2019-02-05 20:16:37.299914+0100 socket-test[76663:9803276] LOG SocketIOClient{/}: Handling event: ping with data: []
2019-02-05 20:16:37.300091+0100 socket-test[76663:9803337] LOG SocketEngineWebSocket: Sending ws:  as type: 2
2019-02-05 20:16:37.301011+0100 socket-test[76663:9803337] LOG SocketEngine: Got message: 3
2019-02-05 20:16:37.301177+0100 socket-test[76663:9803276] LOG SocketIOClient{/}: Handling event: pong with data: []
2019-02-05 20:16:39.300008+0100 socket-test[76663:9803339] LOG SocketEngine: Writing ws:  has data: false
2019-02-05 20:16:39.300032+0100 socket-test[76663:9803276] LOG SocketIOClient{/}: Handling event: ping with data: []
2019-02-05 20:16:39.300233+0100 socket-test[76663:9803339] LOG SocketEngineWebSocket: Sending ws:  as type: 2
2019-02-05 20:16:39.301442+0100 socket-test[76663:9803339] LOG SocketEngine: Got message: 3
2019-02-05 20:16:39.301658+0100 socket-test[76663:9803276] LOG SocketIOClient{/}: Handling event: pong with data: []
2019-02-05 20:16:41.495863+0100 socket-test[76663:9803337] LOG SocketEngine: Writing ws:  has data: false
2019-02-05 20:16:41.495882+0100 socket-test[76663:9803276] LOG SocketIOClient{/}: Handling event: ping with data: []
2019-02-05 20:16:41.496112+0100 socket-test[76663:9803337] LOG SocketEngineWebSocket: Sending ws:  as type: 2
2019-02-05 20:16:41.496958+0100 socket-test[76663:9803339] LOG SocketEngine: Got message: 3
2019-02-05 20:16:41.497139+0100 socket-test[76663:9803276] LOG SocketIOClient{/}: Handling event: pong with data: []
2019-02-05 20:16:43.495970+0100 socket-test[76663:9803276] LOG SocketIOClient{/}: Handling event: ping with data: []
2019-02-05 20:16:43.495979+0100 socket-test[76663:9803337] LOG SocketEngine: Writing ws:  has data: false
2019-02-05 20:16:43.496179+0100 socket-test[76663:9803337] LOG SocketEngineWebSocket: Sending ws:  as type: 2
2019-02-05 20:16:43.497004+0100 socket-test[76663:9803339] LOG SocketEngine: Got message: 3
2019-02-05 20:16:43.497157+0100 socket-test[76663:9803276] LOG SocketIOClient{/}: Handling event: pong with data: []
2019-02-05 20:16:44.658389+0100 socket-test[76663:9803276] LOG SocketManager: Starting reconnect
2019-02-05 20:16:44.658567+0100 socket-test[76663:9803276] LOG SocketManager: Trying to reconnect
2019-02-05 20:16:44.658868+0100 socket-test[76663:9803276] LOG SocketIOClient{/}: Handling event: reconnectAttempt with data: [-1]
2019-02-05 20:16:44.659208+0100 socket-test[76663:9803337] LOG SocketEngine: Starting engine. Server: http://localhost:3210
2019-02-05 20:16:44.659345+0100 socket-test[76663:9803337] LOG SocketEngine: Handshaking
2019-02-05 20:16:44.659643+0100 socket-test[76663:9803337] LOG SocketEnginePolling: Doing polling GET http://localhost:3210/socket.io/?transport=polling&b64=1
2019-02-05 20:16:44.668115+0100 socket-test[76663:9803339] [] nw_socket_handle_socket_event [C4.1:2] Socket SO_ERROR [61: Connection refused]
2019-02-05 20:16:44.669891+0100 socket-test[76663:9803339] [] nw_socket_handle_socket_event [C4.2:2] Socket SO_ERROR [61: Connection refused]
2019-02-05 20:16:44.671055+0100 socket-test[76663:9803339] TIC TCP Conn Failed [4:0x600003e7c000]: 1:61 Err(61)
2019-02-05 20:16:44.675372+0100 socket-test[76663:9803339] Task <8B14817F-C381-4ECD-B75B-7BFAACD70DB2>.<1> HTTP load failed (error code: -1004 [1:61])
2019-02-05 20:16:44.675555+0100 socket-test[76663:9803354] Task <8B14817F-C381-4ECD-B75B-7BFAACD70DB2>.<1> finished with error - code: -1004
2019-02-05 20:16:44.677437+0100 socket-test[76663:9803339] ERROR SocketEnginePolling: Could not connect to the server.
2019-02-05 20:16:44.677664+0100 socket-test[76663:9803339] ERROR SocketEngine: Could not connect to the server.
2019-02-05 20:16:44.677811+0100 socket-test[76663:9803276] ERROR SocketManager: Could not connect to the server.
2019-02-05 20:16:44.677937+0100 socket-test[76663:9803276] LOG SocketIOClient{/}: Handling event: error with data: ["Could not connect to the server."]
2019-02-05 20:16:55.657754+0100 socket-test[76663:9803276] LOG SocketManager: Trying to reconnect
2019-02-05 20:16:55.658055+0100 socket-test[76663:9803276] LOG SocketIOClient{/}: Handling event: reconnectAttempt with data: [-2]
2019-02-05 20:16:55.658393+0100 socket-test[76663:9803337] LOG SocketEngine: Starting engine. Server: http://localhost:3210
2019-02-05 20:16:55.658643+0100 socket-test[76663:9803337] LOG SocketEngine: Handshaking
2019-02-05 20:16:55.659111+0100 socket-test[76663:9803337] LOG SocketEnginePolling: Doing polling GET http://localhost:3210/socket.io/?transport=polling&b64=1
2019-02-05 20:16:55.668714+0100 socket-test[76663:9803748] LOG SocketEnginePolling: Got polling response
2019-02-05 20:16:55.668854+0100 socket-test[76663:9803748] LOG SocketEnginePolling: Got poll message: 95:0{"sid":"a-t5k9s9SzmS4e64AAAB","upgrades":["websocket"],"pingInterval":2000,"pingTimeout":5000}
2019-02-05 20:16:55.668987+0100 socket-test[76663:9803748] LOG SocketEngine: Got message: 0{"sid":"a-t5k9s9SzmS4e64AAAB","upgrades":["websocket"],"pingInterval":2000,"pingTimeout":5000}
2019-02-05 20:16:55.669914+0100 socket-test[76663:9803276] LOG SocketIOClient{/}: Handling event: ping with data: []
2019-02-05 20:16:55.669972+0100 socket-test[76663:9803748] LOG SocketEnginePolling: Doing polling GET http://localhost:3210/socket.io/?transport=polling&b64=1&sid=a-t52019-02-05 20:16:55.670025+0100 socket-test[76663:9803276] LOG SocketManager: Engine opened Connect
k9s9SzmS4e64AAAB
2019-02-05 20:16:55.674466+0100 socket-test[76663:9803276] LOG SocketIOClient{/}: Socket connected
2019-02-05 20:16:55.674634+0100 socket-test[76663:9803276] LOG SocketIOClient{/}: Handling event: statusChange with data: [connected]
2019-02-05 20:16:55.674799+0100 socket-test[76663:9803276] LOG SocketIOClient{/}: Handling event: connect with data: ["/"]
!!! connect
2019-02-05 20:16:55.675474+0100 socket-test[76663:9803748] LOG SocketEngine: Writing poll:  has data: false
2019-02-05 20:16:55.675678+0100 socket-test[76663:9803748] LOG SocketEnginePolling: Sending poll:  as type: 2
2019-02-05 20:16:55.675874+0100 socket-test[76663:9803748] LOG SocketEnginePolling: Created POST string: 1:2
2019-02-05 20:16:55.676244+0100 socket-test[76663:9803748] LOG SocketEnginePolling: POSTing
2019-02-05 20:16:55.676606+0100 socket-test[76663:9803748] LOG SocketEnginePolling: Doing polling POST http://localhost:3210/socket.io/?transport=polling&b64=1&sid=a-t5k9s9SzmS4e64AAAB
2019-02-05 20:16:55.677290+0100 socket-test[76663:9803276] LOG SocketIOClient{/}: Handling event: websocketUpgrade with data: [["sec-websocket-accept": "asH7PBPw89BcKPCmSs5XtMh0l0I=", "upgrade": "websocket", "connection": "Upgrade"]]
2019-02-05 20:16:55.677429+0100 socket-test[76663:9803337] LOG SocketEngineWebSocket: Sending ws: probe as type: 2
2019-02-05 20:16:55.678282+0100 socket-test[76663:9803753] LOG SocketEnginePolling: Got polling response
2019-02-05 20:16:55.678487+0100 socket-test[76663:9803753] LOG SocketEnginePolling: Got poll message: 2:40
2019-02-05 20:16:55.678685+0100 socket-test[76663:9803753] LOG SocketEngine: Got message: 40
2019-02-05 20:16:55.678943+0100 socket-test[76663:9803276] LOG SocketParser: Parsing 0
2019-02-05 20:16:55.679010+0100 socket-test[76663:9803753] LOG SocketEnginePolling: Doing polling GET http://localhost:3210/socket.io/?transport=polling&b64=1&sid=a-t5k9s9SzmS4e64AAAB
2019-02-05 20:16:55.679235+0100 socket-test[76663:9803276] LOG SocketParser: Decoded packet as: SocketPacket {type: 0; data: []; id: -1; placeholders: 0; nsp: /}
2019-02-05 20:16:55.679596+0100 socket-test[76663:9803753] LOG SocketEngine: Got message: 3probe
2019-02-05 20:16:55.679915+0100 socket-test[76663:9803753] LOG SocketEngine: Received probe response, should upgrade to WebSockets
2019-02-05 20:16:55.680092+0100 socket-test[76663:9803753] LOG SocketEngine: Upgrading transport to WebSockets
2019-02-05 20:16:55.680274+0100 socket-test[76663:9803753] LOG SocketEnginePolling: Sending poll:  as type: 6
2019-02-05 20:16:55.680513+0100 socket-test[76663:9803276] LOG SocketIOClient{/}: Handling event: pong with data: []
2019-02-05 20:16:55.686013+0100 socket-test[76663:9803748] LOG SocketEnginePolling: Got polling response
2019-02-05 20:16:55.686108+0100 socket-test[76663:9803748] LOG SocketEnginePolling: Got poll message: 1:3
2019-02-05 20:16:55.686210+0100 socket-test[76663:9803748] LOG SocketEngine: Got message: 3
2019-02-05 20:16:55.686355+0100 socket-test[76663:9803748] LOG SocketEngine: Switching to WebSockets
2019-02-05 20:16:55.686364+0100 socket-test[76663:9803276] LOG SocketIOClient{/}: Handling event: pong with data: []
2019-02-05 20:16:55.686464+0100 socket-test[76663:9803748] LOG SocketEngineWebSocket: Sending ws:  as type: 5
2019-02-05 20:16:55.686568+0100 socket-test[76663:9803748] LOG SocketEngine: Flushing probe wait
2019-02-05 20:16:57.670029+0100 socket-test[76663:9803676] LOG SocketEngine: Writing ws:  has data: false
2019-02-05 20:16:57.670073+0100 socket-test[76663:9803276] LOG SocketIOClient{/}: Handling event: ping with data: []
2019-02-05 20:16:57.670279+0100 socket-test[76663:9803676] LOG SocketEngineWebSocket: Sending ws:  as type: 2
2019-02-05 20:16:57.671375+0100 socket-test[76663:9803676] LOG SocketEngine: Got message: 3
2019-02-05 20:16:57.671594+0100 socket-test[76663:9803276] LOG SocketIOClient{/}: Handling event: pong with data: []
2019-02-05 20:16:59.861943+0100 socket-test[76663:9803748] LOG SocketEngine: Writing ws:  has data: false
2019-02-05 20:16:59.861949+0100 socket-test[76663:9803276] LOG SocketIOClient{/}: Handling event: ping with data: []
2019-02-05 20:16:59.862265+0100 socket-test[76663:9803748] LOG SocketEngineWebSocket: Sending ws:  as type: 2
2019-02-05 20:16:59.863958+0100 socket-test[76663:9803337] LOG SocketEngine: Got message: 3
2019-02-05 20:16:59.864314+0100 socket-test[76663:9803276] LOG SocketIOClient{/}: Handling event: pong with data: []

[mmmoussa]

I'm experiencing this same issue as well

[danielerpl]

Same issue here, also trying to make socket to nil but still receiving LOG callback