[Live-devel] RTP over RTSP: client sending RR "early"

Ralf Globisch rglobisch at csir.co.za
Wed Oct 10 11:59:06 PDT 2012 

Hi Ross,

We upgraded the server side to the live555 with the fix, but the issue continues to happen.


> Does this problem happen *always* whenever you stream from this particular server (in RTP/RTCP-over-TCP mode), or only *sometimes* from this server (e.g., only when the network is congested)?


At the moment, it happens every time when *I* try to connect with the android device which is connected to the Internet over wifi. Some more info, not sure if it helps at all: I'm currently located in Germany, and the server is in South Africa. With the upgrade my colleagues in South Africa have a much lower failure rate, say around 1 out of every 10 times. At least it's consistently failing on my end so I'm hoping that will make it easier to track down the issue.

> If the problem still happens - even after you've upgraded your server - then please add the line
#define DEBUG_RECEIVE 1
to the start of "liveMedia/RTPInterface.cpp" (for your client), recompile your client, and send us another log (when you see the error happening again).

Here's an excerpt of the log with DEBUG_RECEIVE:

D/VLC     (21494): [0x434770]: live555 demux version 2012.10.04
D/VLC     (21494): [0x434770]: live555 demux RTP subsession 'video/H263-1998'
D/live555 (21494): SocketDescriptor(socket 
D/live555 (21494): 47
D/live555 (21494): )::registerRTPInterface(channel 
D/live555 (21494): 0
D/live555 (21494): ): isFirstRegistration 
D/live555 (21494): 1
D/live555 (21494): 
D/live555 (21494): SocketDescriptor(socket 
D/live555 (21494): 47
D/live555 (21494): )::registerRTPInterface(channel 
D/live555 (21494): 1
D/live555 (21494): ): isFirstRegistration 
D/live555 (21494): 0
D/live555 (21494): 
D/live555 (21494): SocketDescriptor(socket 
D/live555 (21494): 47
D/live555 (21494): )::registerRTPInterface(channel 
D/live555 (21494): 1
D/live555 (21494): ): isFirstRegistration 
D/live555 (21494): 0
D/live555 (21494): 
D/VLC     (21494): [0x427ff8]: main input selecting program id=0
D/VLC     (21494): [0x434770]: live555 demux RTP subsession 'audio/AMR'
D/live555 (21494): SocketDescriptor(socket 
D/live555 (21494): 47
D/live555 (21494): )::registerRTPInterface(channel 
D/live555 (21494): 2
D/live555 (21494): ): isFirstRegistration 
D/live555 (21494): 0
D/live555 (21494): 
D/live555 (21494): SocketDescriptor(socket 
D/live555 (21494): 47
D/live555 (21494): )::registerRTPInterface(channel 
D/live555 (21494): 3
D/live555 (21494): ): isFirstRegistration 
D/live555 (21494): 0
D/live555 (21494): 
D/live555 (21494): SocketDescriptor(socket 
D/live555 (21494): 47
D/live555 (21494): )::registerRTPInterface(channel 
D/live555 (21494): 3
D/live555 (21494): ): isFirstRegistration 
D/live555 (21494): 0
D/live555 (21494): 
D/VLC     (21494): [0x434770]: live555 demux setup start: 0.000000 stop:0.000000
D/live555 (21494): SocketDescriptor(socket 
D/live555 (21494): 47
D/live555 (21494): )::tcpReadHandler(): Saw '$'
D/live555 (21494): SocketDescriptor(socket 
D/live555 (21494): 47
D/live555 (21494): )::tcpReadHandler(): No handler proc for "rtpInterface" for channel 
D/live555 (21494): 0
D/live555 (21494): 
D/live555 (21494): SocketDescriptor(socket 
D/live555 (21494): 47
D/live555 (21494): )::tcpReadHandler(): Saw '$'
D/live555 (21494): SocketDescriptor(socket 
D/live555 (21494): 47
D/live555 (21494): )::tcpReadHandler(): Saw nonexistent stream channel id: 
D/live555 (21494): 135
D/live555 (21494): 
D/live555 (21494): SocketDescriptor(socket 
D/live555 (21494): 47
D/live555 (21494): )::tcpReadHandler(): Saw '$'
D/live555 (21494): SocketDescriptor(socket 
D/live555 (21494): 47
D/live555 (21494): )::tcpReadHandler(): Saw nonexistent stream channel id: 
D/live555 (21494): 104
D/live555 (21494): 
D/live555 (21494): SocketDescriptor(socket 
D/live555 (21494): 47
D/live555 (21494): )::tcpReadHandler(): Saw '$'
D/live555 (21494): SocketDescriptor(socket 
D/live555 (21494): 47
D/live555 (21494): )::tcpReadHandler(): Saw nonexistent stream channel id: 
D/live555 (21494): 86
D/live555 (21494): 
D/live555 (21494): SocketDescriptor(socket 
D/live555 (21494): 47
D/live555 (21494): )::tcpReadHandler(): Saw '$'
D/live555 (21494): SocketDescriptor(socket 
D/live555 (21494): 47
D/live555 (21494): )::tcpReadHandler(): Saw nonexistent stream channel id: 
D/live555 (21494): 217
D/live555 (21494): 
D/live555 (21494): SocketDescriptor(socket 
D/live555 (21494): 47
D/live555 (21494): )::tcpReadHandler(): Saw '$'
D/live555 (21494): SocketDescriptor(socket 
D/live555 (21494): 47
D/live555 (21494): )::tcpReadHandler(): Saw nonexistent stream channel id: 
D/live555 (21494): 106
D/live555 (21494): 
D/live555 (21494): SocketDescriptor(socket 
D/live555 (21494): 47
D/live555 (21494): )::tcpReadHandler(): Saw '$'
D/live555 (21494): SocketDescriptor(socket 
D/live555 (21494): 47
D/live555 (21494): )::tcpReadHandler(): Saw nonexistent stream channel id: 
D/live555 (21494): 253
D/live555 (21494): 
D/live555 (21494): SocketDescriptor(socket 
D/live555 (21494): 47
D/live555 (21494): )::tcpReadHandler(): Saw '$'
D/live555 (21494): SocketDescriptor(socket 
D/live555 (21494): 47
D/live555 (21494): )::tcpReadHandler(): Saw nonexistent stream channel id: 
D/live555 (21494): 250
D/live555 (21494): 
D/live555 (21494): SocketDescriptor(socket 
D/live555 (21494): 47
D/live555 (21494): )::tcpReadHandler(): Saw '$'
D/live555 (21494): SocketDescriptor(socket 
D/live555 (21494): 47
D/live555 (21494): )::tcpReadHandler(): Saw nonexistent stream channel id: 
D/live555 (21494): 183
D/live555 (21494): 
D/live555 (21494): SocketDescriptor(socket 
D/live555 (21494): 47
D/live555 (21494): )::tcpReadHandler(): Saw '$'
D/live555 (21494): SocketDescriptor(socket 
D/live555 (21494): 47
D/live555 (21494): )::tcpReadHandler(): Saw nonexistent stream channel id: 
D/live555 (21494): 247
D/live555 (21494): 
D/live555 (21494): SocketDescriptor(socket 
D/live555 (21494): 47
D/live555 (21494): )::tcpReadHandler(): Saw '$'
D/live555 (21494): SocketDescriptor(socket 
D/live555 (21494): 47
D/live555 (21494): )::tcpReadHandler(): No handler proc for "rtpInterface" for channel 
D/live555 (21494): 0
D/live555 (21494): 
D/live555 (21494): SocketDescriptor(socket 
D/live555 (21494): 47
D/live555 (21494): )::tcpReadHandler(): Saw '$'
D/live555 (21494): SocketDescriptor(socket 
D/live555 (21494): 47
D/live555 (21494): )::tcpReadHandler(): No handler proc for "rtpInterface" for channel 
D/live555 (21494): 2
D/live555 (21494): 
D/live555 (21494): SocketDescriptor(socket 
D/live555 (21494): 47
D/live555 (21494): )::tcpReadHandler(): Saw '$'
D/live555 (21494): SocketDescriptor(socket 
D/live555 (21494): 47
D/live555 (21494): )::tcpReadHandler(): Saw nonexistent stream channel id: 
D/live555 (21494): 24
D/live555 (21494): 
D/live555 (21494): SocketDescriptor(socket 
D/live555 (21494): 47
D/live555 (21494): )::tcpReadHandler(): Saw '$'
D/live555 (21494): SocketDescriptor(socket 
D/live555 (21494): 47
D/live555 (21494): )::tcpReadHandler(): Saw nonexistent stream channel id: 
D/live555 (21494): 85
D/live555 (21494): 
D/live555 (21494): SocketDescriptor(socket 
D/live555 (21494): 47
D/live555 (21494): )::tcpReadHandler(): Saw '$'
D/live555 (21494): SocketDescriptor(socket 
D/live555 (21494): 47
D/live555 (21494): )::tcpReadHandler(): No handler proc for "rtpInterface" for channel 
D/live555 (21494): 0
D/live555 (21494): 
D/live555 (21494): SocketDescriptor(socket 
D/live555 (21494): 47
D/live555 (21494): )::tcpReadHandler(): Saw '$'
D/live555 (21494): SocketDescriptor(socket 
D/live555 (21494): 47
D/live555 (21494): )::tcpReadHandler(): Saw nonexistent stream channel id: 
D/live555 (21494): 246
D/live555 (21494): 
...
...
E/VLC     (21494): [0x434770]: live555 demux RTSP PLAY failed RTSP response was truncated. Increase "RTSPClient::responseBufferSize"
D/live555 (21494): SocketDescriptor(socket 
D/live555 (21494): 47
D/live555 (21494): )::deregisterRTPInterface(channel 
D/live555 (21494): 1
D/live555 (21494): 
D/live555 (21494): SocketDescriptor(socket 
D/live555 (21494): 47
D/live555 (21494): )::deregisterRTPInterface(channel 
D/live555 (21494): 0
D/live555 (21494): 
D/live555 (21494): SocketDescriptor(socket 
D/live555 (21494): 47
D/live555 (21494): )::deregisterRTPInterface(channel 
D/live555 (21494): 3
D/live555 (21494): 
D/live555 (21494): SocketDescriptor(socket 
D/live555 (21494): 47
D/live555 (21494): )::deregisterRTPInterface(channel 
D/live555 (21494): 2
D/live555 (21494): 



Any idea what might be going wrong?


Thanks for your help in investigating this. I'd be glad to add any other debugging info if that helps.


Regards,
Ralf






-- 
This message is subject to the CSIR's copyright terms and conditions, e-mail legal notice, and implemented Open Document Format (ODF) standard. 
The full disclaimer details can be found at http://www.csir.co.za/disclaimer.html.

This message has been scanned for viruses and dangerous content by MailScanner, 
and is believed to be clean.

Please consider the environment before printing this email.

More information about the live-devel mailing list