Android remote connection delay

Support
1

Core Machine (Operating system/System info/Roon build number)

Debian 10 : Roon 521

Network Details (Including networking gear model/manufacturer and if on WiFi/Ethernet)

Classical, ethernet & wifi 5hghz

Audio Devices (Specify what device you’re using and its connection type - USB/HDMI/etc.)

Honor 8 Android 8

Description Of Issue

Hi,

Sometimes the connexion to the core with the android remote app is slow (10s)

This is the connexion logs :slight_smile:

6:53 Trace: [raat] [sood] Refreshing device list
02/24 23:46:57 Trace: [raat] RAATServer discovered: RaatServer FRD-L09 @ 192.168.1.3:38697
02/24 23:46:57 Info: [raatserver] GOT SERVER 8c06de5c-255c-55cf-2147-b82f16bed26b::8c06de5c255c55cf2147b82f16bed26b @ 192.168.1.3:38697 FRD-L09 PROTOVER=1 RAATVER=1.1.36
02/24 23:46:57 Trace: [raatserver] [RaatServer FRD-L09 @ 192.168.1.3:38697] connecting (attempt 1)
02/24 23:46:58 Trace: [raatserver] [RaatServer FRD-L09 @ 192.168.1.3:38697] connected
02/24 23:46:58 Trace: [rnet/RnetJsonClient] SENT {"request":"enumerate_devices","subscription_id":"0"}
02/24 23:46:58 Trace: [rnet/RnetJsonClient] GOT NONFINAL {"status": "Success", "devices": [{"auto_name": "FRD-L09", "device_id": "default", "auto_enable": true, "type": "android", "name": "Default Output", "is_system_output": true}]}
02/24 23:46:58 Info: [raatserver] GOT DEVICE 8c06de5c255c55cf2147b82f16bed26b::default Type=android Name=Default Output
02/24 23:47:05 Info: [stats] 7469mb Virtual, 1280mb Physical, 588mb Managed, 0 Handles, 96 Threads
02/24 23:47:08 Info: [brokerserver] Client connected: 192.168.1.3:42714
02/24 23:47:08 Trace: [SOOD] Adding User IP 192.168.1.3

Why ten seconds between

02/24 23:46:57 Trace: [raat] RAATServer discovered: RaatServer FRD-L09 @ 192.168.1.3:38697

and

02/24 23:47:08 Trace: [SOOD] Adding User IP 192.168.1.3

An other phone (more recent and better CPU)

02/25 00:07:06 Trace: [raat] RAATServer discovered: RaatServer Redmi Note 8 Pro @ 192.168.1.47:38647
02/25 00:07:06 Info: [raatserver] GOT SERVER 2911670e-f8fe-9cfe-4311-a100c896badf::2911670ef8fe9cfe4311a100c896badf @ 192.168.1.47:38647 Redmi Note 8 Pro PROTOVER=1 RAATVER=1.1.36
02/25 00:07:06 Trace: [raatserver] [RaatServer Redmi Note 8 Pro @ 192.168.1.47:38647] connecting (attempt 1)
02/25 00:07:07 Trace: [raatserver] [RaatServer Redmi Note 8 Pro @ 192.168.1.47:38647] connected
02/25 00:07:07 Trace: [rnet/RnetJsonClient] SENT {"request":"enumerate_devices","subscription_id":"0"}
02/25 00:07:09 Trace: [rnet/RnetJsonClient] GOT NONFINAL {"status": "Success", "devices": [{"device_id": "default", "type": "android", "name": "Default Output", "config": {"external_config": {"is_private": true}, "unique_id": "f0aa736b-ceaf-ad13-f8e1-21394cc1b4c4", "volume": {"device": "default", "type": "android"}, "output": {"name": "Default Output", "device": "default", "type": "android"}}, "is_system_output": true, "auto_enable": true, "auto_name": "Redmi Note 8 Pro"}]}
02/25 00:07:09 Info: [raatserver] GOT DEVICE 2911670ef8fe9cfe4311a100c896badf::default Type=android Name=Default Output
02/25 00:07:09 Trace: [rnet/RnetJsonClient] SENT {"request":"enable_device","device_id":"default","subscription_id":"25"}
02/25 00:07:09 Trace: [rnet/RnetJsonClient] GOT NONFINAL {"status": "DeviceChanged", "device": {"device_id": "default", "type": "android", "name": "Default Output", "config": {"external_config": {"is_private": true}, "unique_id": "f0aa736b-ceaf-ad13-f8e1-21394cc1b4c4", "volume": {"device": "default", "type": "android"}, "output": {"name": "Default Output", "device": "default", "type": "android"}}, "discovery_data": {"tcp_port": 39881, "raat_version": "1.1.36", "unique_id": "f0aa736b-ceaf-ad13-f8e1-21394cc1b4c4", "vendor": "N/A", "version": "N/A", "model": "N/A", "protocol_version": "3"}, "is_system_output": true, "auto_enable": true, "auto_name": "Redmi Note 8 Pro"}}
02/25 00:07:09 Info: [raatserver] [Default Output] connecting (attempt 1)
02/25 00:07:09 Trace: [Default Output] [raatclient] Initializing RAAT session
02/25 00:07:09 Trace: [Default Output] [raatclient] Loading script raat.dat:base.lua as module base [1088 chars]
02/25 00:07:09 Trace: [Default Output] [raatclient] Loading script raat.dat:dkjson.lua as module dkjson [22416 chars]
02/25 00:07:09 Trace: [Default Output] [raatclient] Loading script raat.dat:protocol.lua as module protocol [2045 chars]
02/25 00:07:09 Trace: [Default Output] [raatclient] Loading script raat.dat:roon_tcp.lua [43475 chars]
02/25 00:07:09 Trace: [rnet/RnetJsonClient] GOT NONFINAL {"status": "Success"}
02/25 00:07:09 Trace: [Default Output] [raatclient] RAAT Session initialized in 76ms
02/25 00:07:09 Trace: [Default Output] [raatclient] SENT [2]{"request":"info"}
02/25 00:07:09 Trace: [Default Output] [raatclient] SENT [3]{"request":"set_client_type","client_type":"Roon"}
02/25 00:07:09 Trace: [Default Output] [raatclient] GOT [2] {"source_selection":{"info":[],"is_supported":false},"status":"Success","flags":{"has_write_chmap":true},"volume":{"info":{},"is_supported":true},"platform":{"os":"android","uname":{"machine":"aarch64","version":"#1 SMP PREEMPT Tue Dec 10 20:39:11 WIB 2019","nodename":"localhost","release":"4.14.94+","sysname":"Linux"}},"transport":{"info":{"config":{}},"is_update_artwork_supported":true,"is_update_status_supported":true,"is_supported":true},"output":{"info":{"refresh_supported_formats_before_playback":true},"supported_formats":"48000/16/1|2,48000/24/1|2"},"info":{"model":"N/A","raat_version":"1.1.36","protocol_version":"3","unique_id":"f0aa736b-ceaf-ad13-f8e1-21394cc1b4c4","vendor":"N/A","version":"N/A"}}
02/25 00:07:09 Trace: [raatserver] [Default Output] connected
02/25 00:07:09 Info: [transport] creating endpoint for raat device f0aa736b-ceaf-ad13-f8e1-21394cc1b4c4
02/25 00:07:09 Trace: [Default Output] [raatclient] SENT [4]{"request":"subscribe_transport"}
02/25 00:07:09 Trace: [Default Output] [raatclient] SENT [5]{"request":"subscribe_controls","controller_id":"3a509ea7-3831-4d97-9250-bf5680a97d1b"}
02/25 00:07:09 Trace: [dspengine] created new dsp config {"version":3,"items":[{"type":"bs2b","enabled":false},{"type":"parametric_equalizer","enabled":false},{"type":"audeze_presets","enabled":false}]}
02/25 00:07:09 Trace: [transport/audeze] picking preset lowlatency
02/25 00:07:09 Trace: [transport/audeze] picked null preset!
02/25 00:07:09 Trace: [Default Output] [raatclient] GOT [3] {"status":"Success"}
02/25 00:07:09 Trace: [zone Redmi Note 8 Pro] Loading
02/25 00:07:09 Trace: [zone Redmi Note 8 Pro] Suspend
02/25 00:07:09 Trace: [Redmi Note 8 Pro] [zoneplayer/raat] Endpoint Default Output Initial State: Idle
02/25 00:07:09 Info: [transport] created zone Redmi Note 8 Pro
02/25 00:07:09 Info: [transport]     with endpoint Default Output (23:1:f0aa736b-ceaf-ad13-f8e1-21394cc1b4c4) [IsAvailable=True]
02/25 00:07:09 Trace: [Redmi Note 8 Pro] [Inactive] [STOPPED @ 0:00]
02/25 00:07:09 Trace: [zone Redmi Note 8 Pro] Loaded Queue=63 Tracks Swim=Inactive AutoSwim=True Loop=Disabled Shuffle=False
02/25 00:07:09 Trace: [Redmi Note 8 Pro] [Inactive] [PAUSED @ 2:11/5:09] Antisocial - Trust
02/25 00:07:09 Trace: [Default Output] [raatclient] GOT [5] {"status":"Success","controls":{"volume":{"min":0.0,"type":"number","step":1.0,"max":15.0,"mute":false,"value":0,"info":{}}},"action":"Changed"}
02/25 00:07:09 Trace: [Default Output] [raatclient] SENT [8]{"request":"update_artwork","mimetype":"image/jpeg"}
02/25 00:07:09 Trace: [Default Output] [raatclient] GOT [8] {"status":"Success"}
02/25 00:07:15 Trace: [broker/accounts] [heartbeat] now=02/24/2020 23:07:15 nextauthrefresh=02/24/2020 23:57:16 nextmachineallocate=02/25/2020 02:57:15
02/25 00:07:17 Info: [brokerserver] Client connected: 192.168.1.47:46152

6s to get ready

To compare, this is my desktop delay (Windows 10) :

02/24 23:52:31 Trace: [raat] RAATServer discovered: RaatServer DESKTOP-FKP2HUH @ 192.168.1.94:62314
02/24 23:52:31 Info: [raatserver] GOT SERVER a2d2d9e3-0f8a-4c25-c724-dcf3026cfab8::58770229-bbb2-433c-98e0-9aeca8470459 @ 192.168.1.94:62314 DESKTOP-FKP2HUH PROTOVER=1 RAATVER=1.1.36
02/24 23:52:31 Trace: [raatserver] [RaatServer DESKTOP-FKP2HUH @ 192.168.1.94:62314] connecting (attempt 1)
02/24 23:52:31 Trace: [raatserver] [RaatServer DESKTOP-FKP2HUH @ 192.168.1.94:62314] connected
02/24 23:52:31 Trace: [rnet/RnetJsonClient] SENT {"request":"enumerate_devices","subscription_id":

Less than 1s…

3

Hi @ComasSky,

Can you please provide some more details regarding your network setup? What kind of router are you using? What is the model/manufacturer?

We have seen reports from other users that IGMP Proxying/IGMP Snooping help with Android connectivity issues, do you by any chance have such a setting on your setup?

4

My wifi router is my IFP box ( TVW620 ubee model)

My core is wired to my isp box

which switch to buy ? (i can get an TP-LINK SG105E from my brother) :slight_smile:

5

Hi @ComasSky,

Thanks for the information. I am not saying to add a network switch here, but if you access the Ubee router settings page, do you by any chance see an option for IGMP Snooping or IGMP Proxying? If you enable either setting, is there any change in behavior?

6

No solution with my ISP box … very poor settings possibilty … and my actual switch is not IGMP ready (Netgear GS3005).

I buy a SG105E (IGMP ready), receive it tomorow :wink:

If a add it to my netwoks, and enable IGMT, it will work ? :slight_smile:

7

Hi @ComasSky,

There’s no guarantee that this will help, but it is a good aspect to look into. Do let me know if there’s any change in behavior though.

8

Looks like it’s working!

I’m waiting to see over several days, but I get good delays, between 1 and 2s max.

02/26 19:16:42 Info: [raatserver] GOT SERVER 8c06de5c-255c-55cf-2147-b82f16bed26b::8c06de5c255c55cf2147b82f16bed26b @ 192.168.1.3:34700 FRD-L09 PROTOVER=1 RAATVER=1.1.36
02/26 19:16:42 Trace: [raatserver] [RaatServer FRD-L09 @ 192.168.1.3:34700] connecting (attempt 1)
02/26 19:16:42 Trace: [raatserver] [RaatServer FRD-L09 @ 192.168.1.3:34700] connected
02/26 19:16:42 Trace: [rnet/RnetJsonClient] SENT {"request":"enumerate_devices","subscription_id":"0"}
02/26 19:16:43 Trace: [rnet/RnetJsonClient] GOT NONFINAL {"status": "Success", "devices": [{"device_id": "default", "type": "android", "is_system_output": true, "name": "Default Output", "auto_enable": true, "auto_name": "FRD-L09"}]}
02/26 19:16:43 Info: [raatserver] GOT DEVICE 8c06de5c255c55cf2147b82f16bed26b::default Type=android Name=Default Output
02/26 19:16:43 Info: [brokerserver] Client connected: 192.168.1.3:56200
02/26 19:16:43 Trace: [SOOD] Adding User IP 192.168.1.3
02/26 19:16:43 Trace: [raat] [sood] Refreshing device list
1 Like
9

Hi @ComasSky,

That’s great news indeed! It looks like the switch helped resolve the issue, but if it re-occurs just let me know and we can take another look, thanks!

10

Day 2 : Still working :smile:

1 Like
11

Issues is still here in fact … 10 secondes

The network structure is really classic : Roon Server -> Ethernet -> ISP Box -> Wifi -> Phone

06/13 11:00:13 Trace: [raat] RAATServer discovered: RaatServer POCO F2 Pro @ 192.168.1.25:42231
06/13 11:00:13 Info: [raatserver] GOT SERVER 446c45a9-ee17-21e8-5ce9-b32f206b0101::446c45a9ee1721e85ce9b32f206b0101 @ 192.168.1.25:42231 POCO F2 Pro PROTOVER=1 RAATVER=1.1.38
06/13 11:00:13 Trace: [raatserver] [RaatServer POCO F2 Pro @ 192.168.1.25:42231] connecting (attempt 1)
06/13 11:00:13 Trace: [raatserver] [RaatServer POCO F2 Pro @ 192.168.1.25:42231] connected
06/13 11:00:13 Trace: [rnet/RnetJsonClient] SENT {"request":"enumerate_devices","subscription_id":"0"}
06/13 11:00:13 Trace: [rnet/RnetJsonClient] GOT NONFINAL {"devices": [{"auto_enable": true, "type": "android", "device_id": "default", "auto_name": "POCO F2 Pro", "name": "Default Output", "is_system_output": true, "config": {"unique_id": "71280b00-f99f-eb48-ee9d-566641c6fdf1", "output": {"name": "Default Output", "type": "android", "device": "default"}, "volume": {"type": "android", "device": "default"}, "external_config": {"is_private": true}}}], "status": "Success"}
06/13 11:00:13 Info: [raatserver] GOT DEVICE 446c45a9ee1721e85ce9b32f206b0101::default Type=android Name=Default Output
06/13 11:00:16 Info: [stats] 6917mb Virtual, 1138mb Physical, 560mb Managed, 0 Handles, 107 Threads
06/13 11:00:24 Info: [brokerserver] Client connected: 192.168.1.25:39344
06/13 11:00:24 Trace: [SOOD] Adding User IP 192.168.1.25
06/13 11:00:24 Trace: [raat] [sood] Refreshing device list
06/13 11:00:24 Trace: [raatserver] [sood] Refreshing device list
06/13 11:00:24 Trace: SENT NONFINAL DistributedBroker.ConnectResponse={ BrokerId=b62b4ba2-767a-4634-b05c-28f8a9f09f23 BrokerName='Serveur-Hadrien' }
06/13 11:00:24 Trace: SENT NONFINAL DistributedBroker.UpdatesChangedResponse={ IsSupported=True WasJustUpdated=False Status='UpToDate' HasChangeLog=False CurrentVersion={ MachineValue=100700555 DisplayValue='1.7 (build 555) stable' Branch='stable' } }
06/13 11:00:26 Info: [library/albumdetails] Created album details screen for LibraryAlbum[1257775, Axelle Red - French Soul]
12

Hi @ComasSky,

Have you changed anything since your post 4 months ago when it was working after the switch changes? If you use the Windows PC in Client/Remote mode, does the same issue occur there?

13

No change since my last post :confused:

Windows GUI seems to be faster (3/4 seconds max)

14

Hi @ComasSky,

If the Windows is working ok and just the Android is affected, have you tried reinstalling the Roon app? Any change if you reinstall?

15

Yes, 2/3 times.

Can I give you some logs ?

16

Hi @ComasSky,

Is there by any chance a change in behavior with our latest build?
Or is the issue still the same on b571?