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

Saúl Ibarra Corretgé saul at ag-projects.com
Wed Dec 9 15:35:19 CET 2015


Hi Ravi,

Can you please try the latest code in the repo? We have made some related fixes recently, which should solve the problem.


Thanks,

> On 17 Nov 2015, at 12:11, Ravi Kansangara <ravi.kansangara at matrixcomsec.com> wrote:
> 
> ​Below are the SIP trace for Blink & Sylk server.
> 
> ​-------------------------------------------------------------------------------------------
> Blink Client Logs
> -------------------------------------------------------------------------------------------
> 
> sip_trace.log
> 
> 2015-09-29 19:40:20.062500 [blink.exe 2872]: SENDING: Packet 11, +0:00:48.640625
> 192.168.101.26:3451 -(SIP over UDP)-> 192.168.101.6:5060
> INVITE sip:sylkchat at 192.168.101.6 SIP/2.0
> 
> Via: SIP/2.0/UDP 192.168.101.26:3451;rport;branch=z9hG4bKPj0d46618b5761475aae4c1ef825b303ce
> 
> Max-Forwards: 70
> 
> From: "ravi" <sip:ravi at 192.168.101.6>;tag=d2816e639c83426db91aafcc5af5c54d
> 
> To: <sip:sylkchat at 192.168.101.6>
> 
> Contact: <sip:61503427 at 192.168.101.26:3451>
> 
> Call-ID: 0c6928edc82b4d8abba6c4f93a698176
> 
> CSeq: 30333 INVITE
> 
> Allow: SUBSCRIBE, NOTIFY, PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, MESSAGE, REFER
> 
> Supported: 100rel, replaces, norefersub, gruu
> 
> User-Agent: Blink 1.4.2 (Windows)
> 
> Content-Type: application/sdp
> 
> Content-Length:   458
> 
> 
> 
> v=0
> 
> o=- 3652544420 3652544420 IN IP4 192.168.101.26
> 
> s=Blink 1.4.2 (Windows)
> 
> t=0 0
> 
> m=message 2855 TCP/TLS/MSRP *
> 
> c=IN IP4 192.168.101.26
> 
> a=path:msrps://192.168.101.26:2855/d41793c2e535905b840;tcp
> 
> a=sendonly
> 
> a=accept-types:*
> 
> a=setup:active
> 
> a=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
> 
> a=x-file-offset
> 
> a=file-transfer-id:c6817484-53e0-48f1-9817-e3c3fc5ab919
> 
> 
> --
> 2015-09-29 19:40:20.062500 [blink.exe 2872]: RECEIVED: Packet 12, +0:00:48.640625
> 192.168.101.6:5060 -(SIP over UDP)-> 192.168.101.26:3451
> SIP/2.0 100 Trying
> 
> Via: SIP/2.0/UDP 192.168.101.26:3451;rport=3451;received=192.168.101.26;branch=z9hG4bKPj0d46618b5761475aae4c1ef825b303ce
> 
> Call-ID: 0c6928edc82b4d8abba6c4f93a698176
> 
> From: "ravi" <sip:ravi at 192.168.101.6>;tag=d2816e639c83426db91aafcc5af5c54d
> 
> To: <sip:sylkchat at 192.168.101.6>
> 
> CSeq: 30333 INVITE
> 
> Server: SylkServer-3.0.1
> 
> Content-Length:  0
> 
> 
> 
> 
> --
> 2015-09-29 19:40:20.078125 [blink.exe 2872]: RECEIVED: Packet 13, +0:00:48.656250
> 192.168.101.6:5060 -(SIP over UDP)-> 192.168.101.26:3451
> SIP/2.0 200 OK
> 
> Via: SIP/2.0/UDP 192.168.101.26:3451;rport=3451;received=192.168.101.26;branch=z9hG4bKPj0d46618b5761475aae4c1ef825b303ce
> 
> Call-ID: 0c6928edc82b4d8abba6c4f93a698176
> 
> From: "ravi" <sip:ravi at 192.168.101.6>;tag=d2816e639c83426db91aafcc5af5c54d
> 
> To: <sip:sylkchat at 192.168.101.6>;tag=-ptXgZJXQ2UtyKBLn3GFu8vOJuug7QW3
> 
> CSeq: 30333 INVITE
> 
> Server: SylkServer-3.0.1
> 
> Contact: <sip:sylkserver at 192.168.101.6:5060>;isfocus
> 
> Allow: SUBSCRIBE, NOTIFY, PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, MESSAGE, REFER
> 
> Supported: 100rel, replaces, norefersub, gruu
> 
> Content-Type: application/sdp
> 
> Content-Length:   453
> 
> 
> 
> v=0
> 
> o=- 3652544364 3652544365 IN IP4 192.168.101.6
> 
> s=SylkServer-3.0.1
> 
> t=0 0
> 
> m=message 37614 TCP/TLS/MSRP *
> 
> c=IN IP4 192.168.101.6
> 
> a=path:msrps://192.168.101.6:37614/622bef1e9b29bcdb5a7;tcp
> 
> a=recvonly
> 
> a=accept-types:*
> 
> a=setup:passive
> 
> a=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
> 
> a=x-file-offset
> 
> a=file-transfer-id:c6817484-53e0-48f1-9817-e3c3fc5ab919
> 
> 
> --
> 2015-09-29 19:40:20.078125 [blink.exe 2872]: SENDING: Packet 14, +0:00:48.656250
> 192.168.101.26:3451 -(SIP over UDP)-> 192.168.101.6:5060
> ACK sip:sylkserver at 192.168.101.6:5060 SIP/2.0
> 
> Via: SIP/2.0/UDP 192.168.101.26:3451;rport;branch=z9hG4bKPj6ee65b77db864a28bc511a5fcb7025c9
> 
> Max-Forwards: 70
> 
> From: "ravi" <sip:ravi at 192.168.101.6>;tag=d2816e639c83426db91aafcc5af5c54d
> 
> To: <sip:sylkchat at 192.168.101.6>;tag=-ptXgZJXQ2UtyKBLn3GFu8vOJuug7QW3
> 
> Call-ID: 0c6928edc82b4d8abba6c4f93a698176
> 
> CSeq: 30333 ACK
> 
> User-Agent: Blink 1.4.2 (Windows)
> 
> Content-Length:  0
> 
> 
> 
> 
> --
> 2015-09-29 19:40:20.093750 [blink.exe 2872]: RECEIVED: Packet 15, +0:00:48.671875
> 192.168.101.6:5060 -(SIP over UDP)-> 192.168.101.26:3451
> BYE sip:61503427 at 192.168.101.26:3451 SIP/2.0
> 
> Via: SIP/2.0/UDP 192.168.101.6:5060;rport;branch=z9hG4bKPjQwRVREmrE7VqnpZ6vZsm8eLx74.PCRoL
> 
> Max-Forwards: 70
> 
> From: <sip:sylkchat at 192.168.101.6>;tag=-ptXgZJXQ2UtyKBLn3GFu8vOJuug7QW3
> 
> To: "ravi" <sip:ravi at 192.168.101.6>;tag=d2816e639c83426db91aafcc5af5c54d
> 
> Call-ID: 0c6928edc82b4d8abba6c4f93a698176
> 
> CSeq: 5967 BYE
> 
> Reason: SIP ;text="media stream failed to start" ;cause=500
> 
> User-Agent: SylkServer-3.0.1
> 
> Content-Length:  0
> 
> 
> 
> 
> --
> 2015-09-29 19:40:20.093750 [blink.exe 2872]: SENDING: Packet 16, +0:00:48.671875
> 192.168.101.26:3451 -(SIP over UDP)-> 192.168.101.6:5060
> SIP/2.0 200 OK
> 
> Via: SIP/2.0/UDP 192.168.101.6:5060;rport=5060;received=192.168.101.6;branch=z9hG4bKPjQwRVREmrE7VqnpZ6vZsm8eLx74.PCRoL
> 
> Call-ID: 0c6928edc82b4d8abba6c4f93a698176
> 
> From: <sip:sylkchat at 192.168.101.6>;tag=-ptXgZJXQ2UtyKBLn3GFu8vOJuug7QW3
> 
> To: "ravi" <sip:ravi at 192.168.101.6>;tag=d2816e639c83426db91aafcc5af5c54d
> 
> CSeq: 5967 BYE
> 
> Server: Blink 1.4.2 (Windows)
> 
> Content-Length:  0
> 
> 
> 
> 
> --
> 2015-09-29 19:40:20.093750 [blink.exe 2872]: SENDING: Packet 17, +0:00:48.671875
> 192.168.101.26:3451 -(SIP over UDP)-> 192.168.101.6:5060
> BYE sip:sylkserver at 192.168.101.6:5060 SIP/2.0
> 
> Via: SIP/2.0/UDP 192.168.101.26:3451;rport;branch=z9hG4bKPjd14e492fc254443da081d5567b9b5371
> 
> Max-Forwards: 70
> 
> From: "ravi" <sip:ravi at 192.168.101.6>;tag=d2816e639c83426db91aafcc5af5c54d
> 
> To: <sip:sylkchat at 192.168.101.6>;tag=-ptXgZJXQ2UtyKBLn3GFu8vOJuug7QW3
> 
> Call-ID: 0c6928edc82b4d8abba6c4f93a698176
> 
> CSeq: 30334 BYE
> 
> User-Agent: Blink 1.4.2 (Windows)
> 
> Content-Length:  0
> 
> 
> 
> 
> --
> 2015-09-29 19:40:20.093750 [blink.exe 2872]: RECEIVED: Packet 18, +0:00:48.671875
> 192.168.101.6:5060 -(SIP over UDP)-> 192.168.101.26:3451
> SIP/2.0 200 OK
> 
> Via: SIP/2.0/UDP 192.168.101.26:3451;rport=3451;received=192.168.101.26;branch=z9hG4bKPjd14e492fc254443da081d5567b9b5371
> 
> Call-ID: 0c6928edc82b4d8abba6c4f93a698176
> 
> From: "ravi" <sip:ravi at 192.168.101.6>;tag=d2816e639c83426db91aafcc5af5c54d
> 
> To: <sip:sylkchat at 192.168.101.6>;tag=-ptXgZJXQ2UtyKBLn3GFu8vOJuug7QW3
> 
> CSeq: 30334 BYE
> 
> Server: SylkServer-3.0.1
> 
> Content-Length:  0
> 
> 
> 
> 
> --
> 2015-09-29 19:40:24.031250 [blink.exe 2872]: SENDING: Packet 19, +0:00:52.609375
> 192.168.101.26:3451 -(SIP over UDP)-> 192.168.101.6:5060
> BYE sip:sylkserver at 192.168.101.6:5060 SIP/2.0
> 
> Via: SIP/2.0/UDP 192.168.101.26:3451;rport;branch=z9hG4bKPjb4d10913608f4e7f9b9e5a6e4b7ae2a4
> 
> Max-Forwards: 70
> 
> From: "ravi" <sip:ravi at 192.168.101.6>;tag=136feef1d7d248e4a17151169406eb36
> 
> To: <sip:sylkchat at 192.168.101.6>;tag=750wMeNVMOlRJc.lc4ykopqP4t2MxTdd
> 
> Call-ID: ab832b2941524bbf853894478e7bcf5d
> 
> CSeq: 1870 BYE
> 
> User-Agent: Blink 1.4.2 (Windows)
> 
> Content-Length:  0
> 
> 
> 
> 
> --
> 2015-09-29 19:40:24.031250 [blink.exe 2872]: RECEIVED: Packet 20, +0:00:52.609375
> 192.168.101.6:5060 -(SIP over UDP)-> 192.168.101.26:3451
> SIP/2.0 200 OK
> 
> Via: SIP/2.0/UDP 192.168.101.26:3451;rport=3451;received=192.168.101.26;branch=z9hG4bKPjb4d10913608f4e7f9b9e5a6e4b7ae2a4
> 
> Call-ID: ab832b2941524bbf853894478e7bcf5d
> 
> From: "ravi" <sip:ravi at 192.168.101.6>;tag=136feef1d7d248e4a17151169406eb36
> 
> To: <sip:sylkchat at 192.168.101.6>;tag=750wMeNVMOlRJc.lc4ykopqP4t2MxTdd
> 
> CSeq: 1870 BYE
> 
> Server: SylkServer-3.0.1
> 
> Content-Length:  0
> 
> -------------------------------------------------------------------------------------------
> Sylk Server Logs
> -------------------------------------------------------------------------------------------
> 
> sip_trace.log
> 
> 2015-09-30 01:09:24.554268 [sylk-server 2602]: RECEIVED: Packet 13, +0:00:23.351820
> 192.168.101.26:3451 -(SIP over UDP)-> 192.168.101.6:5060
> INVITE sip:sylkchat at 192.168.101.6 SIP/2.0
> Via: SIP/2.0/UDP 192.168.101.26:3451;rport;branch=z9hG4bKPj0d46618b5761475aae4c1ef825b303ce
> Max-Forwards: 70
> From: "ravi" <sip:ravi at 192.168.101.6>;tag=d2816e639c83426db91aafcc5af5c54d
> To: <sip:sylkchat at 192.168.101.6>
> Contact: <sip:61503427 at 192.168.101.26:3451>
> Call-ID: 0c6928edc82b4d8abba6c4f93a698176
> CSeq: 30333 INVITE
> Allow: SUBSCRIBE, NOTIFY, PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, MESSAGE, REFER
> Supported: 100rel, replaces, norefersub, gruu
> User-Agent: Blink 1.4.2 (Windows)
> Content-Type: application/sdp
> Content-Length:   458
> 
> v=0
> o=- 3652544420 3652544420 IN IP4 192.168.101.26
> s=Blink 1.4.2 (Windows)
> t=0 0
> m=message 2855 TCP/TLS/MSRP *
> c=IN IP4 192.168.101.26
> a=path:msrps://192.168.101.26:2855/d41793c2e535905b840;tcp
> a=sendonly
> a=accept-types:*
> a=setup:active
> a=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
> a=x-file-offset
> a=file-transfer-id:c6817484-53e0-48f1-9817-e3c3fc5ab919
> 
> --
> 2015-09-30 01:09:24.574246 [sylk-server 2602]: SENDING: Packet 14, +0:00:23.371798
> 192.168.101.6:5060 -(SIP over UDP)-> 192.168.101.26:3451
> SIP/2.0 100 Trying
> Via: SIP/2.0/UDP 192.168.101.26:3451;rport=3451;received=192.168.101.26;branch=z9hG4bKPj0d46618b5761475aae4c1ef825b303ce
> Call-ID: 0c6928edc82b4d8abba6c4f93a698176
> From: "ravi" <sip:ravi at 192.168.101.6>;tag=d2816e639c83426db91aafcc5af5c54d
> To: <sip:sylkchat at 192.168.101.6>
> CSeq: 30333 INVITE
> Server: SylkServer-3.0.1
> Content-Length:  0
> 
> 
> --
> 2015-09-30 01:09:24.575196 [sylk-server 2602]: SENDING: Packet 15, +0:00:23.372748
> 192.168.101.6:5060 -(SIP over UDP)-> 192.168.101.26:3451
> SIP/2.0 200 OK
> Via: SIP/2.0/UDP 192.168.101.26:3451;rport=3451;received=192.168.101.26;branch=z9hG4bKPj0d46618b5761475aae4c1ef825b303ce
> Call-ID: 0c6928edc82b4d8abba6c4f93a698176
> From: "ravi" <sip:ravi at 192.168.101.6>;tag=d2816e639c83426db91aafcc5af5c54d
> To: <sip:sylkchat at 192.168.101.6>;tag=-ptXgZJXQ2UtyKBLn3GFu8vOJuug7QW3
> CSeq: 30333 INVITE
> Server: SylkServer-3.0.1
> Contact: <sip:sylkserver at 192.168.101.6:5060>;isfocus
> Allow: SUBSCRIBE, NOTIFY, PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, MESSAGE, REFER
> Supported: 100rel, replaces, norefersub, gruu
> Content-Type: application/sdp
> Content-Length:   453
> 
> v=0
> o=- 3652544364 3652544365 IN IP4 192.168.101.6
> s=SylkServer-3.0.1
> t=0 0
> m=message 37614 TCP/TLS/MSRP *
> c=IN IP4 192.168.101.6
> a=path:msrps://192.168.101.6:37614/622bef1e9b29bcdb5a7;tcp
> a=recvonly
> a=accept-types:*
> a=setup:passive
> a=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
> a=x-file-offset
> a=file-transfer-id:c6817484-53e0-48f1-9817-e3c3fc5ab919
> 
> --
> 2015-09-30 01:09:24.576648 [sylk-server 2602]: RECEIVED: Packet 16, +0:00:23.374200
> 192.168.101.26:3451 -(SIP over UDP)-> 192.168.101.6:5060
> ACK sip:sylkserver at 192.168.101.6:5060 SIP/2.0
> Via: SIP/2.0/UDP 192.168.101.26:3451;rport;branch=z9hG4bKPj6ee65b77db864a28bc511a5fcb7025c9
> Max-Forwards: 70
> From: "ravi" <sip:ravi at 192.168.101.6>;tag=d2816e639c83426db91aafcc5af5c54d
> To: <sip:sylkchat at 192.168.101.6>;tag=-ptXgZJXQ2UtyKBLn3GFu8vOJuug7QW3
> Call-ID: 0c6928edc82b4d8abba6c4f93a698176
> CSeq: 30333 ACK
> User-Agent: Blink 1.4.2 (Windows)
> Content-Length:  0
> 
> 
> --
> 2015-09-30 01:09:24.588011 [sylk-server 2602]: SENDING: Packet 17, +0:00:23.385563
> 192.168.101.6:5060 -(SIP over UDP)-> 192.168.101.26:3451
> BYE sip:61503427 at 192.168.101.26:3451 SIP/2.0
> Via: SIP/2.0/UDP 192.168.101.6:5060;rport;branch=z9hG4bKPjQwRVREmrE7VqnpZ6vZsm8eLx74.PCRoL
> Max-Forwards: 70
> From: <sip:sylkchat at 192.168.101.6>;tag=-ptXgZJXQ2UtyKBLn3GFu8vOJuug7QW3
> To: "ravi" <sip:ravi at 192.168.101.6>;tag=d2816e639c83426db91aafcc5af5c54d
> Call-ID: 0c6928edc82b4d8abba6c4f93a698176
> CSeq: 5967 BYE
> Reason: SIP ;text="media stream failed to start" ;cause=500
> User-Agent: SylkServer-3.0.1
> Content-Length:  0
> 
> 
> --
> 2015-09-30 01:09:24.588725 [sylk-server 2602]: RECEIVED: Packet 18, +0:00:23.386277
> 192.168.101.26:3451 -(SIP over UDP)-> 192.168.101.6:5060
> SIP/2.0 200 OK
> Via: SIP/2.0/UDP 192.168.101.6:5060;rport=5060;received=192.168.101.6;branch=z9hG4bKPjQwRVREmrE7VqnpZ6vZsm8eLx74.PCRoL
> Call-ID: 0c6928edc82b4d8abba6c4f93a698176
> From: <sip:sylkchat at 192.168.101.6>;tag=-ptXgZJXQ2UtyKBLn3GFu8vOJuug7QW3
> To: "ravi" <sip:ravi at 192.168.101.6>;tag=d2816e639c83426db91aafcc5af5c54d
> CSeq: 5967 BYE
> Server: Blink 1.4.2 (Windows)
> Content-Length:  0
> 
> 
> --
> 2015-09-30 01:09:24.592057 [sylk-server 2602]: RECEIVED: Packet 19, +0:00:23.389609
> 192.168.101.26:3451 -(SIP over UDP)-> 192.168.101.6:5060
> BYE sip:sylkserver at 192.168.101.6:5060 SIP/2.0
> Via: SIP/2.0/UDP 192.168.101.26:3451;rport;branch=z9hG4bKPjd14e492fc254443da081d5567b9b5371
> Max-Forwards: 70
> From: "ravi" <sip:ravi at 192.168.101.6>;tag=d2816e639c83426db91aafcc5af5c54d
> To: <sip:sylkchat at 192.168.101.6>;tag=-ptXgZJXQ2UtyKBLn3GFu8vOJuug7QW3
> Call-ID: 0c6928edc82b4d8abba6c4f93a698176
> CSeq: 30334 BYE
> User-Agent: Blink 1.4.2 (Windows)
> Content-Length:  0
> 
> 
> --
> 2015-09-30 01:09:24.593315 [sylk-server 2602]: SENDING: Packet 20, +0:00:23.390867
> 192.168.101.6:5060 -(SIP over UDP)-> 192.168.101.26:3451
> SIP/2.0 200 OK
> Via: SIP/2.0/UDP 192.168.101.26:3451;rport=3451;received=192.168.101.26;branch=z9hG4bKPjd14e492fc254443da081d5567b9b5371
> Call-ID: 0c6928edc82b4d8abba6c4f93a698176
> From: "ravi" <sip:ravi at 192.168.101.6>;tag=d2816e639c83426db91aafcc5af5c54d
> To: <sip:sylkchat at 192.168.101.6>;tag=-ptXgZJXQ2UtyKBLn3GFu8vOJuug7QW3
> CSeq: 30334 BYE
> Server: SylkServer-3.0.1
> Content-Length:  0
> 
> Best Regards,
> Ravi Kansangara
> 
> On Mon, Nov 2, 2015 at 4:11 PM, Saúl Ibarra Corretgé <saul at ag-projects.com> wrote:
> 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
> 
> 
> 
> 
> 
> 
> _______________________________________________
> SIPBeyondVoIP mailing list
> SIPBeyondVoIP at lists.ag-projects.com
> http://lists.ag-projects.com/mailman/listinfo/sipbeyondvoip
> 
> 
> _______________________________________________
> 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/20151209/3fb92058/attachment-0001.pgp>


More information about the SIPBeyondVoIP mailing list