[SIP Beyond VoIP] File Transfer between Blink clients through Sylkserver

Saúl Ibarra Corretgé saul at ag-projects.com
Mon Nov 2 11:41:34 CET 2015


Hi,

> On 07 Oct 2015, at 16:39, Ravi Kansangara <ravi.kansangara at matrixcomsec.com> wrote:
> 
> ​​Hi,
> 
> I am evaluating Blink Client & Sylk seerver to implement some features (i.e. Group Chat, File Transfer, Desktop Sharing) over SIP/MSRP.
> 
> I have configured Blink Client to transfer media over TCP/MSRP means i have disabled the TLS.
> 
> Same way i have make the "use_tls = False" in MSRP section of config.ini to relay media over TCP/MSRP.
> 
> But in one thread i have read that Sylk server forces the clients to use MSRP media transfer over TCP/TLS/MSRP only. The flag  "use_tls = False" in config.ini of sylk server is just used for development phase. In reality media must be transmitted over TLS.
> 
> Query: Is this correct information?
> 

Yes. In general, there is no reason why TLS shouldn’t be used, and the MSRP RFC mandates TLS. It should work over TCP though, if you have toggled the right switches.

> Exception: File Transfer & Desktop Sharing is not supported over TCP/MSRP but Group Chat is still working on TCP/MSRP.
> 

They should also work, please attach the SIP trace for us to see the SDP.

> So i have again enabled the TLS in Sylk Server & Blink Client.
> 
> 
> File Transfer over TCP/TLS/MSRP:
> 
> For testing i have established one chat session with Sylk server which will create conference room on-the-fly.
> 
> Also connected the second Blink Client to that conference chat room.
> 
> Now when i send one file in chat room (by drag-drop file), It send INVITE message to Sylk server. Sylk server also returns its TCP/TLS/MSRP port for media transfer in 200 OK response.
> 
> After that Blink Client sends BYE message and File Transfer gets cancelled.
> 
> Same thing happens with Desktop Sharing over TCP/TLS/MSRP.
> 
> Below are the logs of Blink Client & Sylk server for the File Transfer Session.
> 

Can you attach the SIP trace please?

> 
> -------------------------------------------------------------------------------------------
> Blink Client Logs
> -------------------------------------------------------------------------------------------
> 
> notification_trace.txt
> 
> 2015-09-29 19:40:20.046875 [blink.exe 2872]: Notification name=MediaStreamDidInitialize sender=<sipsimple.streams.msrp.FileTransferStream object at 0x094615cc> data=NotificationData()
> 2015-09-29 19:40:20.062500 [blink.exe 2872]: Notification name=SIPInvitationChangedState sender=<sipsimple.core._core.Invitation object at 0x04bf32cc> data=NotificationData(originator='local', body='v=0\r\no=- 3652544420 3652544420 IN IP4 192.168.101.26\r\ns=Blink 1.4.2 (Windows)\r\nt=0 0\r\nm=message 2855 TCP/TLS/MSRP *\r\nc=IN IP4 192.168.101.26\r\na=path:msrps://192.168.101.26:2855/d41793c2e535905b840;tcp\r\na=sendonly\r\na=accept-types:*\r\na=setup:active\r\na=file-selector:name:"test.pdf" type:application/pdf size:257365 hash:sha1:CD:DD:B2:7F:80:CA:72:B2:E2:86:20:4F:A7:77:E2:C6:CF:19:B1:C1\r\na=x-file-offset\r\na=file-transfer-id:c6817484-53e0-48f1-9817-e3c3fc5ab919\r\n', state='outgoing', prev_state=None, headers={'Via': [FrozenViaHeader('UDP', '192.168.101.26', 3451, frozendict({'rport': 0, 'branch': 'z9hG4bKPj0d46618b5761475aae4c1ef825b303ce'}))], 'From': FrozenFromHeader(FrozenSIPURI('192.168.101.6', 'ravi', None, None, False, frozendict({}), frozendict({})), u'ravi', frozendict({'tag': 'd2816e639c83426db91aafcc5af5c54d'})), 'Route': [FrozenRouteHeader(FrozenSIPURI('192.168.101.6', None, None, None, False, frozendict({'lr': None, 'hide': None}), frozendict({})), None, frozendict({}))], 'Supported': ['100rel', 'replaces', 'norefersub', 'gruu'], 'User-Agent': FrozenHeader('User-Agent', 'Blink 1.4.2 (Windows)'), 'To': FrozenToHeader(FrozenSIPURI('192.168.101.6', 'sylkchat', None, None, False, frozendict({}), frozendict({})), None, frozendict({})), 'Contact': [FrozenContactHeader(FrozenSIPURI('192.168.101.26', '61503427', None, 3451, False, frozendict({}), frozendict({})), None, frozendict({'q': '0.0'}))], 'CSeq': (30333, 'INVITE'), 'Allow': ['SUBSCRIBE', 'NOTIFY', 'PRACK', 'INVITE', 'ACK', 'BYE', 'CANCEL', 'UPDATE', 'MESSAGE', 'REFER'], 'Call-ID': FrozenHeader('Call-ID', '0c6928edc82b4d8abba6c4f93a698176'), 'Max-Forwards': 70}, method='INVITE', request_uri=FrozenSIPURI('192.168.101.6', 'sylkchat', None, None, False, frozendict({}), frozendict({})))
> 2015-09-29 19:40:20.078125 [blink.exe 2872]: Notification name=SIPInvitationChangedState sender=<sipsimple.core._core.Invitation object at 0x04bf32cc> data=NotificationData(originator='remote', body='v=0\r\no=- 3652544364 3652544365 IN IP4 192.168.101.6\r\ns=SylkServer-3.0.1\r\nt=0 0\r\nm=message 37614 TCP/TLS/MSRP *\r\nc=IN IP4 192.168.101.6\r\na=path:msrps://192.168.101.6:37614/622bef1e9b29bcdb5a7;tcp\r\na=recvonly\r\na=accept-types:*\r\na=setup:passive\r\na=file-selector:name:"test.pdf" type:application/pdf size:257365 hash:sha1:CD:DD:B2:7F:80:CA:72:B2:E2:86:20:4F:A7:77:E2:C6:CF:19:B1:C1\r\na=x-file-offset\r\na=file-transfer-id:c6817484-53e0-48f1-9817-e3c3fc5ab919\r\n', reason='OK', code=200, headers={'Content-Length': 453, 'Via': [FrozenViaHeader('UDP', '192.168.101.26', 3451, frozendict({'received': '192.168.101.26', 'rport': 3451, 'branch': 'z9hG4bKPj0d46618b5761475aae4c1ef825b303ce'}))], 'From': FrozenFromHeader(FrozenSIPURI('192.168.101.6', 'ravi', None, None, False, frozendict({}), frozendict({})), u'ravi', frozendict({'tag': 'd2816e639c83426db91aafcc5af5c54d'})), 'Supported': ['100rel', 'replaces', 'norefersub', 'gruu'], 'Server': FrozenHeader('Server', 'SylkServer-3.0.1'), 'To': FrozenToHeader(FrozenSIPURI('192.168.101.6', 'sylkchat', None, None, False, frozendict({}), frozendict({})), None, frozendict({'tag': '-ptXgZJXQ2UtyKBLn3GFu8vOJuug7QW3'})), 'Contact': [FrozenContactHeader(FrozenSIPURI('192.168.101.6', 'sylkserver', None, 5060, False, frozendict({}), frozendict({})), None, frozendict({'q': '0.0', 'isfocus': None}))], 'CSeq': (30333, 'INVITE'), 'Allow': ['SUBSCRIBE', 'NOTIFY', 'PRACK', 'INVITE', 'ACK', 'BYE', 'CANCEL', 'UPDATE', 'MESSAGE', 'REFER'], 'Call-ID': FrozenHeader('Call-ID', '0c6928edc82b4d8abba6c4f93a698176'), 'Content-Type': FrozenContentTypeHeader('application/sdp', frozendict({}))}, prev_state='outgoing', state='connecting')
> 2015-09-29 19:40:20.078125 [blink.exe 2872]: Notification name=SIPInvitationGotSDPUpdate sender=<sipsimple.core._core.Invitation object at 0x04bf32cc> data=NotificationData(local_sdp=FrozenSDPSession('192.168.101.26', 3652544420L, 3652544420L, '-', 'IN', 'IP4', 'Blink 1.4.2 (Windows)', None, 0, 0, frozenlist([]), frozenlist([]), frozenlist([FrozenSDPMediaStream('message', 2855, 'TCP/TLS/MSRP', 1, frozenlist(['*']), FrozenSDPConnection('192.168.101.26', 'IN', 'IP4'), frozenlist([FrozenSDPAttribute('path', 'msrps://192.168.101.26:2855/d41793c2e535905b840;tcp'), FrozenSDPAttribute('sendonly', ''), FrozenSDPAttribute('accept-types', '*'), FrozenSDPAttribute('setup', 'active'), FrozenSDPAttribute('file-selector', 'name:"test.pdf" type:application/pdf size:257365 hash:sha1:CD:DD:B2:7F:80:CA:72:B2:E2:86:20:4F:A7:77:E2:C6:CF:19:B1:C1'), FrozenSDPAttribute('x-file-offset', ''), FrozenSDPAttribute('file-transfer-id', 'c6817484-53e0-48f1-9817-e3c3fc5ab919')]), frozenlist([]))])), succeeded=True, remote_sdp=FrozenSDPSession('192.168.101.6', 3652544364L, 3652544365L, '-', 'IN', 'IP4', 'SylkServer-3.0.1', None, 0, 0, frozenlist([]), frozenlist([]), frozenlist([FrozenSDPMediaStream('message', 37614, 'TCP/TLS/MSRP', 0, frozenlist(['*']), FrozenSDPConnection('192.168.101.6', 'IN', 'IP4'), frozenlist([FrozenSDPAttribute('path', 'msrps://192.168.101.6:37614/622bef1e9b29bcdb5a7;tcp'), FrozenSDPAttribute('recvonly', ''), FrozenSDPAttribute('accept-types', '*'), FrozenSDPAttribute('setup', 'passive'), FrozenSDPAttribute('file-selector', 'name:"test.pdf" type:application/pdf size:257365 hash:sha1:CD:DD:B2:7F:80:CA:72:B2:E2:86:20:4F:A7:77:E2:C6:CF:19:B1:C1'), FrozenSDPAttribute('x-file-offset', ''), FrozenSDPAttribute('file-transfer-id', 'c6817484-53e0-48f1-9817-e3c3fc5ab919')]), frozenlist([]))])))
> 2015-09-29 19:40:20.078125 [blink.exe 2872]: Notification name=SIPInvitationChangedState sender=<sipsimple.core._core.Invitation object at 0x04bf32cc> data=NotificationData(originator=None, body=None, state='connected', prev_state='connecting', headers={}, sub_state='normal')
> 2015-09-29 19:40:20.078125 [blink.exe 2872]: Notification name=SIPSessionWillStart sender=<sipsimple.session.Session object at 0x0921e94c> data=NotificationData()
> 2015-09-29 19:40:20.078125 [blink.exe 2872]: Notification name=BlinkFileTransferDidChangeState sender=<blink.sessions.BlinkFileTransfer object at 0x04ff560c> data=NotificationData(old_state='connecting', new_state='connecting/starting')
> 2015-09-29 19:40:20.078125 [blink.exe 2872]: Notification name=MSRPLibraryLog sender=UnknownSender data=NotificationData(message='Connecting to msrps://192.168.101.6:37614/622bef1e9b29bcdb5a7;tcp', level=INFO)
> 2015-09-29 19:40:20.078125 [blink.exe 2872]: Notification name=FileTransferItemDidChange sender=FileTransferItem(<blink.sessions.BlinkFileTransfer object at 0x04ff560c>) data=NotificationData()
> 2015-09-29 19:40:20.078125 [blink.exe 2872]: Notification name=MediaStreamDidFail sender=<sipsimple.streams.msrp.FileTransferStream object at 0x094615cc> data=NotificationData(reason='The TLS connection was non-properly terminated.', context='start')
> 2015-09-29 19:40:20.078125 [blink.exe 2872]: Notification name=SIPSessionWillEnd sender=<sipsimple.session.Session object at 0x0921e94c> data=NotificationData(originator='local')
> 2015-09-29 19:40:20.093750 [blink.exe 2872]: Notification name=MediaStreamWillEnd sender=<sipsimple.streams.msrp.FileTransferStream object at 0x094615cc> data=NotificationData()
> 2015-09-29 19:40:20.093750 [blink.exe 2872]: Notification name=FileTransferHandlerDidEnd sender=<sipsimple.streams.msrp.OutgoingFileTransferHandler object at 0x094612ac> data=NotificationData(reason='Cancelled', error=True)
> 2015-09-29 19:40:20.093750 [blink.exe 2872]: Notification name=MediaStreamDidEnd sender=<sipsimple.streams.msrp.FileTransferStream object at 0x094615cc> data=NotificationData(error='The TLS connection was non-properly terminated.')
> 2015-09-29 19:40:20.093750 [blink.exe 2872]: Notification name=SIPInvitationChangedState sender=<sipsimple.core._core.Invitation object at 0x04bf32cc> data=NotificationData(originator='local', body=None, prev_sub_state='normal', headers={'Via': [FrozenViaHeader('UDP', '192.168.101.26', 3451, frozendict({'rport': 0, 'branch': 'z9hG4bKPjd14e492fc254443da081d5567b9b5371'}))], 'From': FrozenFromHeader(FrozenSIPURI('192.168.101.6', 'ravi', None, None, False, frozendict({}), frozendict({})), u'ravi', frozendict({'tag': 'd2816e639c83426db91aafcc5af5c54d'})), 'User-Agent': FrozenHeader('User-Agent', 'Blink 1.4.2 (Windows)'), 'To': FrozenToHeader(FrozenSIPURI('192.168.101.6', 'sylkchat', None, None, False, frozendict({}), frozendict({})), None, frozendict({'tag': '-ptXgZJXQ2UtyKBLn3GFu8vOJuug7QW3'})), 'CSeq': (30334, 'BYE'), 'Call-ID': FrozenHeader('Call-ID', '0c6928edc82b4d8abba6c4f93a698176'), 'Max-Forwards': 70}, state='disconnecting', prev_state='connected', method='BYE', request_uri=FrozenSIPURI('192.168.101.6', 'sylkserver', None, 5060, False, frozendict({}), frozendict({})))
> 2015-09-29 19:40:20.093750 [blink.exe 2872]: Notification name=SIPInvitationChangedState sender=<sipsimple.core._core.Invitation object at 0x04bf32cc> data=NotificationData(originator='remote', body=None, code=200, disconnect_reason='media stream failed to start', state='disconnected', headers={'Content-Length': 0, 'Via': [FrozenViaHeader('UDP', '192.168.101.6', 5060, frozendict({'received': '192.168.101.6', 'rport': 5060, 'branch': 'z9hG4bKPjQwRVREmrE7VqnpZ6vZsm8eLx74.PCRoL'}))], 'From': FrozenFromHeader(FrozenSIPURI('192.168.101.6', 'sylkchat', None, None, False, frozendict({}), frozendict({})), None, frozendict({'tag': '-ptXgZJXQ2UtyKBLn3GFu8vOJuug7QW3'})), 'User-Agent': FrozenHeader('User-Agent', 'SylkServer-3.0.1'), 'To': FrozenToHeader(FrozenSIPURI('192.168.101.6', 'ravi', None, None, False, frozendict({}), frozendict({})), u'ravi', frozendict({'tag': 'd2816e639c83426db91aafcc5af5c54d'})), 'Reason': FrozenReasonHeader('SIP ', frozendict({'text': '"media stream failed to start" ', 'cause': '500'})), 'CSeq': (5967, 'BYE'), 'Call-ID': FrozenHeader('Call-ID', '0c6928edc82b4d8abba6c4f93a698176'), 'Max-Forwards': 70}, reason='Normal call clearing', prev_state='disconnecting', method='BYE', request_uri=FrozenSIPURI('192.168.101.26', '61503427', None, 3451, False, frozendict({}), frozendict({})))
> 2015-09-29 19:40:20.093750 [blink.exe 2872]: Notification name=SIPSessionDidProcessTransaction sender=<sipsimple.session.Session object at 0x0921e94c> data=NotificationData(originator='remote', reason='OK', code=200, method='BYE')
> 2015-09-29 19:40:20.093750 [blink.exe 2872]: Notification name=SIPSessionDidFail sender=<sipsimple.session.Session object at 0x0921e94c> data=NotificationData(originator='remote', redirect_identities=None, code=0, reason=None, failure_reason='media stream failed: The TLS connection was non-properly terminated.')
> 2015-09-29 19:40:20.109375 [blink.exe 2872]: Notification name=BlinkFileTransferDidChangeState sender=<blink.sessions.BlinkFileTransfer object at 0x04ff560c> data=NotificationData(old_state='connecting/starting', new_state='ending')
> 
> -------------------------------------------------------------------------------------------
> Sylk Server Logs
> -------------------------------------------------------------------------------------------
> 
> notification_trace.log
> 
> 2015-09-30 01:09:24.560815 [sylk-server 2602]: Notification name=SIPInvitationChangedState sender=<sipsimple.core._core.Invitation object at 0xb02c7f0c>
> {'body': 'v=0\r\no=- 3652544420 3652544420 IN IP4 192.168.101.26\r\ns=Blink 1.4.2 (Windows)\r\nt=0 0\r\nm=message 2855 TCP/TLS/MSRP *\r\nc=IN IP4 192.168.101.26\r\na=path:msrps://192.168.101.26:2855/d41793c2e535905b840;tcp\r\na=sendonly\r\na=accept-types:*\r\na=setup:active\r\na=file-selector:name:"test.pdf" type:application/pdf size:257365 hash:sha1:CD:DD:B2:7F:80:CA:72:B2:E2:86:20:4F:A7:77:E2:C6:CF:19:B1:C1\r\na=x-file-offset\r\na=file-transfer-id:c6817484-53e0-48f1-9817-e3c3fc5ab919\r\n',
>  'headers': {'Allow': ['SUBSCRIBE',
>                        'NOTIFY',
>                        'PRACK',
>                        'INVITE',
>                        'ACK',
>                        'BYE',
>                        'CANCEL',
>                        'UPDATE',
>                        'MESSAGE',
>                        'REFER'],
>              'CSeq': (30333, 'INVITE'),
>              'Call-ID': FrozenHeader('Call-ID', '0c6928edc82b4d8abba6c4f93a698176'),
>              'Contact': [FrozenContactHeader(FrozenSIPURI('192.168.101.26', '61503427', None, 3451, False, frozendict({}), frozendict({})), None, frozendict({'q': '0.0'}))],
>              'Content-Length': 458,
>              'Content-Type': FrozenContentTypeHeader('application/sdp', frozendict({})),
>              'From': FrozenFromHeader(FrozenSIPURI('192.168.101.6', 'ravi', None, None, False, frozendict({}), frozendict({})), u'ravi', frozendict({'tag': 'd2816e639c83426db91aafcc5af5c54d'})),
>              'Max-Forwards': 70,
>              'Supported': ['100rel', 'replaces', 'norefersub', 'gruu'],
>              'To': FrozenToHeader(FrozenSIPURI('192.168.101.6', 'sylkchat', None, None, False, frozendict({}), frozendict({})), None, frozendict({})),
>              'User-Agent': FrozenHeader('User-Agent', 'Blink 1.4.2 (Windows)'),
>              'Via': [FrozenViaHeader('UDP', '192.168.101.26', 3451, frozendict({'received': '192.168.101.26', 'rport': 3451, 'branch': 'z9hG4bKPj0d46618b5761475aae4c1ef825b303ce'}))]},
>  'method': 'INVITE',
>  'originator': 'remote',
>  'prev_state': None,
>  'request_uri': FrozenSIPURI('192.168.101.6', 'sylkchat', None, None, False, frozendict({}), frozendict({})),
>  'state': 'incoming'}
> 2015-09-30 01:09:24.564811 [sylk-server 2602]: Notification name=SIPSessionNewIncoming sender=<sylk.session.Session object at 0xb0008f2c>
> {'headers': {'Allow': ['SUBSCRIBE',
>                        'NOTIFY',
>                        'PRACK',
>                        'INVITE',
>                        'ACK',
>                        'BYE',
>                        'CANCEL',
>                        'UPDATE',
>                        'MESSAGE',
>                        'REFER'],
>              'CSeq': (30333, 'INVITE'),
>              'Call-ID': FrozenHeader('Call-ID', '0c6928edc82b4d8abba6c4f93a698176'),
>              'Contact': [FrozenContactHeader(FrozenSIPURI('192.168.101.26', '61503427', None, 3451, False, frozendict({}), frozendict({})), None, frozendict({'q': '0.0'}))],
>              'Content-Length': 458,
>              'Content-Type': FrozenContentTypeHeader('application/sdp', frozendict({})),
>              'From': FrozenFromHeader(FrozenSIPURI('192.168.101.6', 'ravi', None, None, False, frozendict({}), frozendict({})), u'ravi', frozendict({'tag': 'd2816e639c83426db91aafcc5af5c54d'})),
>              'Max-Forwards': 70,
>              'Supported': ['100rel', 'replaces', 'norefersub', 'gruu'],
>              'To': FrozenToHeader(FrozenSIPURI('192.168.101.6', 'sylkchat', None, None, False, frozendict({}), frozendict({})), None, frozendict({})),
>              'User-Agent': FrozenHeader('User-Agent', 'Blink 1.4.2 (Windows)'),
>              'Via': [FrozenViaHeader('UDP', '192.168.101.26', 3451, frozendict({'received': '192.168.101.26', 'rport': 3451, 'branch': 'z9hG4bKPj0d46618b5761475aae4c1ef825b303ce'}))]},
>  'streams': [<sipsimple.streams.msrp.FileTransferStream object at 0xb0014b8c>]}
> 2015-09-30 01:09:24.565590 [sylk-server 2602]: Notification name=FileTransferHandlerDidInitialize sender=<sipsimple.streams.msrp.IncomingFileTransferHandler object at 0xb0014b6c>
> {}
> 2015-09-30 01:09:24.571947 [sylk-server 2602]: Notification name=MSRPLibraryLog sender=UnknownSender
> {'level': INFO,
>  'message': 'Listening for incoming MSRPS connections on 192.168.101.6:37614'}
> 2015-09-30 01:09:24.572097 [sylk-server 2602]: Notification name=MediaStreamDidInitialize sender=<sipsimple.streams.msrp.FileTransferStream object at 0xb0014b8c>
> {}
> 2015-09-30 01:09:24.572467 [sylk-server 2602]: Notification name=SIPSessionWillStart sender=<sylk.session.Session object at 0xb0008f2c>
> {}
> 2015-09-30 01:09:24.578756 [sylk-server 2602]: Notification name=SIPInvitationGotSDPUpdate sender=<sipsimple.core._core.Invitation object at 0xb02c7f0c>
> {'local_sdp': FrozenSDPSession('192.168.101.6', 3652544364L, 3652544365L, '-', 'IN', 'IP4', 'SylkServer-3.0.1', None, 0, 0, frozenlist([]), frozenlist([]), frozenlist([FrozenSDPMediaStream('message', 37614, 'TCP/TLS/MSRP', 1, frozenlist(['*']), FrozenSDPConnection('192.168.101.6', 'IN', 'IP4'), frozenlist([FrozenSDPAttribute('path', 'msrps://192.168.101.6:37614/622bef1e9b29bcdb5a7;tcp'), FrozenSDPAttribute('recvonly', ''), FrozenSDPAttribute('accept-types', '*'), FrozenSDPAttribute('setup', 'passive'), FrozenSDPAttribute('file-selector', 'name:"test.pdf" type:application/pdf size:257365 hash:sha1:CD:DD:B2:7F:80:CA:72:B2:E2:86:20:4F:A7:77:E2:C6:CF:19:B1:C1'), FrozenSDPAttribute('x-file-offset', ''), FrozenSDPAttribute('file-transfer-id', 'c6817484-53e0-48f1-9817-e3c3fc5ab919')]), frozenlist([]))])),
>  'remote_sdp': FrozenSDPSession('192.168.101.26', 3652544420L, 3652544420L, '-', 'IN', 'IP4', 'Blink 1.4.2 (Windows)', None, 0, 0, frozenlist([]), frozenlist([]), frozenlist([FrozenSDPMediaStream('message', 2855, 'TCP/TLS/MSRP', 0, frozenlist(['*']), FrozenSDPConnection('192.168.101.26', 'IN', 'IP4'), frozenlist([FrozenSDPAttribute('path', 'msrps://192.168.101.26:2855/d41793c2e535905b840;tcp'), FrozenSDPAttribute('sendonly', ''), FrozenSDPAttribute('accept-types', '*'), FrozenSDPAttribute('setup', 'active'), FrozenSDPAttribute('file-selector', 'name:"test.pdf" type:application/pdf size:257365 hash:sha1:CD:DD:B2:7F:80:CA:72:B2:E2:86:20:4F:A7:77:E2:C6:CF:19:B1:C1'), FrozenSDPAttribute('x-file-offset', ''), FrozenSDPAttribute('file-transfer-id', 'c6817484-53e0-48f1-9817-e3c3fc5ab919')]), frozenlist([]))])),
>  'succeeded': True}
> 2015-09-30 01:09:24.579913 [sylk-server 2602]: Notification name=SIPInvitationChangedState sender=<sipsimple.core._core.Invitation object at 0xb02c7f0c>
> {'body': 'v=0\r\no=- 3652544364 3652544365 IN IP4 192.168.101.6\r\ns=SylkServer-3.0.1\r\nt=0 0\r\nm=message 37614 TCP/TLS/MSRP *\r\nc=IN IP4 192.168.101.6\r\na=path:msrps://192.168.101.6:37614/622bef1e9b29bcdb5a7;tcp\r\na=recvonly\r\na=accept-types:*\r\na=setup:passive\r\na=file-selector:name:"test.pdf" type:application/pdf size:257365 hash:sha1:CD:DD:B2:7F:80:CA:72:B2:E2:86:20:4F:A7:77:E2:C6:CF:19:B1:C1\r\na=x-file-offset\r\na=file-transfer-id:c6817484-53e0-48f1-9817-e3c3fc5ab919\r\n',
>  'code': 200,
>  'headers': {'Allow': ['SUBSCRIBE',
>                        'NOTIFY',
>                        'PRACK',
>                        'INVITE',
>                        'ACK',
>                        'BYE',
>                        'CANCEL',
>                        'UPDATE',
>                        'MESSAGE',
>                        'REFER'],
>              'CSeq': (30333, 'INVITE'),
>              'Call-ID': FrozenHeader('Call-ID', '0c6928edc82b4d8abba6c4f93a698176'),
>              'Contact': [FrozenContactHeader(FrozenSIPURI('192.168.101.6', 'sylkserver', None, 5060, False, frozendict({}), frozendict({})), None, frozendict({'q': '0.0', 'isfocus': None}))],
>              'From': FrozenFromHeader(FrozenSIPURI('192.168.101.6', 'ravi', None, None, False, frozendict({}), frozendict({})), u'ravi', frozendict({'tag': 'd2816e639c83426db91aafcc5af5c54d'})),
>              'Server': FrozenHeader('Server', 'SylkServer-3.0.1'),
>              'Supported': ['100rel', 'replaces', 'norefersub', 'gruu'],
>              'To': FrozenToHeader(FrozenSIPURI('192.168.101.6', 'sylkchat', None, None, False, frozendict({}), frozendict({})), None, frozendict({'tag': '-ptXgZJXQ2UtyKBLn3GFu8vOJuug7QW3'})),
>              'Via': [FrozenViaHeader('UDP', '192.168.101.26', 3451, frozendict({'received': '192.168.101.26', 'rport': 3451, 'branch': 'z9hG4bKPj0d46618b5761475aae4c1ef825b303ce'}))]},
>  'originator': 'local',
>  'prev_state': 'incoming',
>  'reason': 'OK',
>  'state': 'connecting'}
> 2015-09-30 01:09:24.580434 [sylk-server 2602]: Notification name=SIPInvitationChangedState sender=<sipsimple.core._core.Invitation object at 0xb02c7f0c>
> {'body': None,
>  'headers': {'CSeq': (30333, 'ACK'),
>              'Call-ID': FrozenHeader('Call-ID', '0c6928edc82b4d8abba6c4f93a698176'),
>              'Content-Length': 0,
>              'From': FrozenFromHeader(FrozenSIPURI('192.168.101.6', 'ravi', None, None, False, frozendict({}), frozendict({})), u'ravi', frozendict({'tag': 'd2816e639c83426db91aafcc5af5c54d'})),
>              'Max-Forwards': 70,
>              'To': FrozenToHeader(FrozenSIPURI('192.168.101.6', 'sylkchat', None, None, False, frozendict({}), frozendict({})), None, frozendict({'tag': '-ptXgZJXQ2UtyKBLn3GFu8vOJuug7QW3'})),
>              'User-Agent': FrozenHeader('User-Agent', 'Blink 1.4.2 (Windows)'),
>              'Via': [FrozenViaHeader('UDP', '192.168.101.26', 3451, frozendict({'received': '192.168.101.26', 'rport': 3451, 'branch': 'z9hG4bKPj6ee65b77db864a28bc511a5fcb7025c9'}))]},
>  'method': 'ACK',
>  'originator': 'remote',
>  'prev_state': 'connecting',
>  'request_uri': FrozenSIPURI('192.168.101.6', 'sylkserver', None, 5060, False, frozendict({}), frozendict({})),
>  'state': 'connected',
>  'sub_state': 'normal'}
> 2015-09-30 01:09:24.584113 [sylk-server 2602]: Notification name=MSRPLibraryLog sender=UnknownSender
> {'level': INFO,
>  'message': 'Closed connection to 192.168.101.26:3829 (Could not negotiate a supported cipher suite.)'}
> 2015-09-30 01:09:24.584432 [sylk-server 2602]: Notification name=MediaStreamDidFail sender=<sipsimple.streams.msrp.FileTransferStream object at 0xb0014b8c>
> {'context': 'start', 'reason': 'Could not negotiate a supported cipher suite.'}
> 2015-09-30 01:09:24.584870 [sylk-server 2602]: Notification name=SIPSessionWillEnd sender=<sylk.session.Session object at 0xb0008f2c>
> {'originator': 'local'}
> 2015-09-30 01:09:24.585210 [sylk-server 2602]: Notification name=MediaStreamWillEnd sender=<sipsimple.streams.msrp.FileTransferStream object at 0xb0014b8c>
> {}
> 2015-09-30 01:09:24.585348 [sylk-server 2602]: Notification name=FileTransferHandlerDidEnd sender=<sipsimple.streams.msrp.IncomingFileTransferHandler object at 0xb0014b6c>
> {'error': True, 'reason': 'Cancelled'}
> 2015-09-30 01:09:24.585526 [sylk-server 2602]: Notification name=MediaStreamDidEnd sender=<sipsimple.streams.msrp.FileTransferStream object at 0xb0014b8c>
> {'error': 'Could not negotiate a supported cipher suite.'}
> 2015-09-30 01:09:24.589553 [sylk-server 2602]: Notification name=SIPInvitationChangedState sender=<sipsimple.core._core.Invitation object at 0xb02c7f0c>
> {'body': None,
>  'headers': {'CSeq': (5967, 'BYE'),
>              'Call-ID': FrozenHeader('Call-ID', '0c6928edc82b4d8abba6c4f93a698176'),
>              'From': FrozenFromHeader(FrozenSIPURI('192.168.101.6', 'sylkchat', None, None, False, frozendict({}), frozendict({})), None, frozendict({'tag': '-ptXgZJXQ2UtyKBLn3GFu8vOJuug7QW3'})),
>              'Max-Forwards': 70,
>              'Reason': FrozenReasonHeader('SIP ', frozendict({'text': '"media stream failed to start" ', 'cause': '500'})),
>              'To': FrozenToHeader(FrozenSIPURI('192.168.101.6', 'ravi', None, None, False, frozendict({}), frozendict({})), u'ravi', frozendict({'tag': 'd2816e639c83426db91aafcc5af5c54d'})),
>              'User-Agent': FrozenHeader('User-Agent', 'SylkServer-3.0.1'),
>              'Via': [FrozenViaHeader('UDP', '192.168.101.6', 5060, frozendict({'rport': 0, 'branch': 'z9hG4bKPjQwRVREmrE7VqnpZ6vZsm8eLx74.PCRoL'}))]},
>  'method': 'BYE',
>  'originator': 'local',
>  'prev_state': 'connected',
>  'prev_sub_state': 'normal',
>  'request_uri': FrozenSIPURI('192.168.101.26', '61503427', None, 3451, False, frozendict({}), frozendict({})),
>  'state': 'disconnecting'}
> 2015-09-30 01:09:24.591332 [sylk-server 2602]: Notification name=SIPInvitationChangedState sender=<sipsimple.core._core.Invitation object at 0xb02c7f0c>
> {'body': None,
>  'code': 200,
>  'disconnect_reason': 'user request',
>  'headers': {'CSeq': (5967, 'BYE'),
>              'Call-ID': FrozenHeader('Call-ID', '0c6928edc82b4d8abba6c4f93a698176'),
>              'Content-Length': 0,
>              'From': FrozenFromHeader(FrozenSIPURI('192.168.101.6', 'sylkchat', None, None, False, frozendict({}), frozendict({})), None, frozendict({'tag': '-ptXgZJXQ2UtyKBLn3GFu8vOJuug7QW3'})),
>              'Server': FrozenHeader('Server', 'Blink 1.4.2 (Windows)'),
>              'To': FrozenToHeader(FrozenSIPURI('192.168.101.6', 'ravi', None, None, False, frozendict({}), frozendict({})), u'ravi', frozendict({'tag': 'd2816e639c83426db91aafcc5af5c54d'})),
>              'Via': [FrozenViaHeader('UDP', '192.168.101.6', 5060, frozendict({'received': '192.168.101.6', 'rport': 5060, 'branch': 'z9hG4bKPjQwRVREmrE7VqnpZ6vZsm8eLx74.PCRoL'}))]},
>  'originator': 'remote',
>  'prev_state': 'disconnecting',
>  'reason': 'Normal call clearing',
>  'state': 'disconnected'}
> 2015-09-30 01:09:24.591575 [sylk-server 2602]: Notification name=SIPSessionDidFail sender=<sylk.session.Session object at 0xb0008f2c>
> {'code': 0,
>  'failure_reason': 'media stream failed: Could not negotiate a supported cipher suite.',
>  'originator': 'local',
>  'reason': None,
>  'redirect_identities': None}
> 2015-09-30 01:09:28.540861 [sylk-server 2602]: Notification name=SIPInvitationChangedState sender=<sipsimple.core._core.Invitation object at 0xb02c7d4c>
> {'body': None,
>  'code': 200,
>  'disconnect_reason': 'user request',
>  'headers': {'CSeq': (1870, 'BYE'),
>              'Call-ID': FrozenHeader('Call-ID', 'ab832b2941524bbf853894478e7bcf5d'),
>              'Content-Length': 0,
>              'From': FrozenFromHeader(FrozenSIPURI('192.168.101.6', 'ravi', None, None, False, frozendict({}), frozendict({})), u'ravi', frozendict({'tag': '136feef1d7d248e4a17151169406eb36'})),
>              'Max-Forwards': 70,
>              'To': FrozenToHeader(FrozenSIPURI('192.168.101.6', 'sylkchat', None, None, False, frozendict({}), frozendict({})), None, frozendict({'tag': '750wMeNVMOlRJc.lc4ykopqP4t2MxTdd'})),
>              'User-Agent': FrozenHeader('User-Agent', 'Blink 1.4.2 (Windows)'),
>              'Via': [FrozenViaHeader('UDP', '192.168.101.26', 3451, frozendict({'received': '192.168.101.26', 'rport': 3451, 'branch': 'z9hG4bKPjb4d10913608f4e7f9b9e5a6e4b7ae2a4'}))]},
>  'method': 'BYE',
>  'originator': 'remote',
>  'prev_state': 'connected',
>  'prev_sub_state': 'normal',
>  'reason': 'Normal call clearing',
>  'request_uri': FrozenSIPURI('192.168.101.6', 'sylkserver', None, 5060, False, frozendict({}), frozendict({})),
>  'state': 'disconnected'}
> 
> 
> core_trace.log
> 
> 2015-09-30 01:09:24.553800 [sylk-server 2602] (5) 2015-09-30 01:09:24.553 sip_endpoint.c Processing incoming message: Request msg INVITE/cseq=30333 (rdata0xb15260a0)
> 2015-09-30 01:09:24.554452 [sylk-server 2602] (5) 2015-09-30 01:09:24.553  tsx0xb156d7a8 ..Transaction created for Request msg INVITE/cseq=30333 (rdata0xb15260a0)
> 2015-09-30 01:09:24.554871 [sylk-server 2602] (5) 2015-09-30 01:09:24.553  tsx0xb156d7a8 .Incoming Request msg INVITE/cseq=30333 (rdata0xb15260a0) in state Null
> 2015-09-30 01:09:24.555386 [sylk-server 2602] (5) 2015-09-30 01:09:24.553  tsx0xb156d7a8 ..State changed from Null to Trying, event=RX_MSG
> 2015-09-30 01:09:24.555509 [sylk-server 2602] (5) 2015-09-30 01:09:24.553  dlg0xb156cfa0 ...Transaction tsx0xb156d7a8 state changed to Trying
> 2015-09-30 01:09:24.555798 [sylk-server 2602] (5) 2015-09-30 01:09:24.553  dlg0xb156cfa0 .UAS dialog created
> 2015-09-30 01:09:24.555905 [sylk-server 2602] (5) 2015-09-30 01:09:24.553  dlg0xb156cfa0 .Module mod-invite added as dialog usage, data=0xb156e728
> 2015-09-30 01:09:24.556072 [sylk-server 2602] (5) 2015-09-30 01:09:24.553  dlg0xb156cfa0 ..Session count inc to 2 by mod-invite
> 2015-09-30 01:09:24.556443 [sylk-server 2602] (5) 2015-09-30 01:09:24.553  inv0xb156cfa0 .UAS invite session created for dialog dlg0xb156cfa0
> 2015-09-30 01:09:24.556730 [sylk-server 2602] (5) 2015-09-30 01:09:24.553       endpoint ..Response msg 100/INVITE/cseq=30333 (tdta0xb156f258) created
> 2015-09-30 01:09:24.557028 [sylk-server 2602] (5) 2015-09-30 01:09:24.553  dlg0xb156cfa0 ..Initial answer Response msg 100/INVITE/cseq=30333 (tdta0xb156f258)
> 2015-09-30 01:09:24.573843 [sylk-server 2602] (5) 2015-09-30 01:09:24.557  inv0xb156cfa0 .Sending Response msg 100/INVITE/cseq=30333 (tdta0xb156f258)
> 2015-09-30 01:09:24.574034 [sylk-server 2602] (5) 2015-09-30 01:09:24.557  dlg0xb156cfa0 ..Sending Response msg 100/INVITE/cseq=30333 (tdta0xb156f258)
> 2015-09-30 01:09:24.574096 [sylk-server 2602] (5) 2015-09-30 01:09:24.557  tsx0xb156d7a8 ..Sending Response msg 100/INVITE/cseq=30333 (tdta0xb156f258) in state Trying
> 2015-09-30 01:09:24.574302 [sylk-server 2602] (5) 2015-09-30 01:09:24.560  tsx0xb156d7a8 ...State changed from Trying to Proceeding, event=TX_MSG
> 2015-09-30 01:09:24.574520 [sylk-server 2602] (5) 2015-09-30 01:09:24.560  dlg0xb156cfa0 ....Transaction tsx0xb156d7a8 state changed to Proceeding
> 2015-09-30 01:09:24.574702 [sylk-server 2602] (5) 2015-09-30 01:09:24.572  inv0xb156cfa0 .SDP negotiation done, status=0
> 2015-09-30 01:09:24.574753 [sylk-server 2602] (5) 2015-09-30 01:09:24.572  inv0xb156cfa0 .Sending Response msg 200/INVITE/cseq=30333 (tdta0xb156f258)
> 2015-09-30 01:09:24.574898 [sylk-server 2602] (5) 2015-09-30 01:09:24.572  dlg0xb156cfa0 ..Sending Response msg 200/INVITE/cseq=30333 (tdta0xb156f258)
> 2015-09-30 01:09:24.575016 [sylk-server 2602] (5) 2015-09-30 01:09:24.572  tsx0xb156d7a8 ..Sending Response msg 200/INVITE/cseq=30333 (tdta0xb156f258) in state Proceeding
> 2015-09-30 01:09:24.575553 [sylk-server 2602] (5) 2015-09-30 01:09:24.572  tsx0xb156d7a8 ...State changed from Proceeding to Completed, event=TX_MSG
> 2015-09-30 01:09:24.575842 [sylk-server 2602] (5) 2015-09-30 01:09:24.572  dlg0xb156cfa0 ....Transaction tsx0xb156d7a8 state changed to Completed
> 2015-09-30 01:09:24.576221 [sylk-server 2602] (5) 2015-09-30 01:09:24.573 sip_endpoint.c Processing incoming message: Request msg ACK/cseq=30333 (rdata0xb15260a0)
> 2015-09-30 01:09:24.576900 [sylk-server 2602] (5) 2015-09-30 01:09:24.573  dlg0xb156cfa0 .Received Request msg ACK/cseq=30333 (rdata0xb15260a0)
> 2015-09-30 01:09:24.576999 [sylk-server 2602] (5) 2015-09-30 01:09:24.573  tsx0xb156d7a8 ..Request to terminate transaction
> 2015-09-30 01:09:24.577165 [sylk-server 2602] (5) 2015-09-30 01:09:24.573  tsx0xb156d7a8 ...State changed from Completed to Terminated, event=USER
> 2015-09-30 01:09:24.577311 [sylk-server 2602] (5) 2015-09-30 01:09:24.573  dlg0xb156cfa0 ....Transaction tsx0xb156d7a8 state changed to Terminated
> 2015-09-30 01:09:24.586278 [sylk-server 2602] (5) 2015-09-30 01:09:24.578  tsx0xb156d7a8 Timeout timer event
> 2015-09-30 01:09:24.586453 [sylk-server 2602] (5) 2015-09-30 01:09:24.578  tsx0xb156d7a8 .State changed from Terminated to Destroyed, event=TIMER
> 2015-09-30 01:09:24.586500 [sylk-server 2602] (5) 2015-09-30 01:09:24.578 tdta0xb156f258 ..Destroying txdata Response msg 200/INVITE/cseq=30333 (tdta0xb156f258)
> 2015-09-30 01:09:24.586624 [sylk-server 2602] (5) 2015-09-30 01:09:24.578  tsx0xb156d7a8 Transaction destroyed
> 
> 
> 
> Best Regards,
> Ravi Kansangara
> _______________________________________________
> SIPBeyondVoIP mailing list
> SIPBeyondVoIP at lists.ag-projects.com
> http://lists.ag-projects.com/mailman/listinfo/sipbeyondvoip

--
Saúl Ibarra Corretgé
AG Projects





-------------- next part --------------
A non-text attachment was scrubbed...
Name: signature.asc
Type: application/pgp-signature
Size: 842 bytes
Desc: Message signed with OpenPGP using GPGMail
URL: <http://lists.ag-projects.com/pipermail/sipbeyondvoip/attachments/20151102/864b9e08/attachment-0001.pgp>


More information about the SIPBeyondVoIP mailing list