Nový PJSIP přitvrdil?
Re: Nový PJSIP přitvrdil?
Moc díky.
Teď to ještě zkoumám. Volání 419194 (PJSIP) -> 687543 (SPA112) projde - telefon zvoní
hovor funguje. Na obou linkách mám zapnuto SRTP pro příchozí hovory.
Volání obráceně 687543 -> 419194 skončí 480 SIPS required. Asi je PJSIP
striktnější při kontrole pravidel než SPA112. Zřejmě není ale tolik užívaná,
tak si moc lidí nestěžuje. Každopádně snad to přispěje k dalšímu zkvalitnění
vašich už tak skvělých služeb.
Diky
Teď to ještě zkoumám. Volání 419194 (PJSIP) -> 687543 (SPA112) projde - telefon zvoní
hovor funguje. Na obou linkách mám zapnuto SRTP pro příchozí hovory.
Volání obráceně 687543 -> 419194 skončí 480 SIPS required. Asi je PJSIP
striktnější při kontrole pravidel než SPA112. Zřejmě není ale tolik užívaná,
tak si moc lidí nestěžuje. Každopádně snad to přispěje k dalšímu zkvalitnění
vašich už tak skvělých služeb.
Diky
Re: Nový PJSIP přitvrdil?
Ano,pjsip chce jeste 'sips:' v contaktu,mam to pripravene po nocnim restartu by to melo fungovat komplet.
Dekuji za test a budu vdecny za dalsi.
Dekuji za test a budu vdecny za dalsi.
Re: Nový PJSIP přitvrdil?
Dnes jsem zkusil všechny kombinace, které mne napadly
tedy PJSIP na počítači, CSipSimple v telefonu a SPA112
a vše fungovalo jak má.
Diky moc za rychlé vyřešení.
tedy PJSIP na počítači, CSipSimple v telefonu a SPA112
a vše fungovalo jak má.
Diky moc za rychlé vyřešení.
Re: Nový PJSIP přitvrdil?
Ja dekuji za nahlaseni.Netolish píše:Dnes jsem zkusil všechny kombinace, které mne napadly
tedy PJSIP na počítači, CSipSimple v telefonu a SPA112
a vše fungovalo jak má.
Diky moc za rychlé vyřešení.
Re: Nový PJSIP přitvrdil?
Aktualizoval jsem si PJSIP na verzi 2.8 a je tu podobný problém v domluvě na šifrování. Tentokrát ale nevím,
zda se chová PJSIP korektně. Po prvním úspěšném INVITE totiž pošle ještě jednou skoro stejný,
dle debug logu, z důvodu "Call 0 sending re-INVITE for updating media session to use only one codec".
V prvním INVITE jsou 4 a:crypto. Server si vybere ten 3. a použije v odpovědi. Ve druhém INVITE
je však ze strany PJSIP už pouze jeden a:crypto s číslem 1. Server si však ponechá původní
s číslem 3 a komunikace skončí na Invalid "SRTP crypto tag". Neboť dle RFC4568 5.1.2
by měly tagy "sedět".
Můžete prosím prověřit jestli je to chyba PJSIP (posílat dvakrát INVITE),
nebo serveru (ponechá si původní klíč s, vzhledem k novému invite, neplatným tagem)?
Omlouvám se, že s tím pořád otravuju, ale po té co gůgl vyhodil CSipSimple,
řekl jsem si že si ho budu buildit sám a rovnou při té příležitosti zaktualizuji
i pjsip který používá.
Díky Netolický
zda se chová PJSIP korektně. Po prvním úspěšném INVITE totiž pošle ještě jednou skoro stejný,
dle debug logu, z důvodu "Call 0 sending re-INVITE for updating media session to use only one codec".
V prvním INVITE jsou 4 a:crypto. Server si vybere ten 3. a použije v odpovědi. Ve druhém INVITE
je však ze strany PJSIP už pouze jeden a:crypto s číslem 1. Server si však ponechá původní
s číslem 3 a komunikace skončí na Invalid "SRTP crypto tag". Neboť dle RFC4568 5.1.2
by měly tagy "sedět".
Můžete prosím prověřit jestli je to chyba PJSIP (posílat dvakrát INVITE),
nebo serveru (ponechá si původní klíč s, vzhledem k novému invite, neplatným tagem)?
Omlouvám se, že s tím pořád otravuju, ale po té co gůgl vyhodil CSipSimple,
řekl jsem si že si ho budu buildit sám a rovnou při té příležitosti zaktualizuji
i pjsip který používá.
Díky Netolický
Kód: Vybrat vše
INVITE sips:*081@sip.odorik.cz:6670 SIP/2.0
Via: SIP/2.0/TLS 37.157.194.179:57375;rport;branch=z9hG4bKPjfd24b587-4f17-4d7f-86c4-91e0874a4848;alias
Max-Forwards: 70
From: sips:419194@sip.odorik.cz;tag=88036dd1-5345-4a4b-bcad-bab7e1808450
To: sips:*081@sip.odorik.cz
Contact: <sips:419194@172.16.3.6:57375;transport=TLS;ob>
Call-ID: 7692b4d2-aa32-4bca-89d4-e4086c9ac5e1
CSeq: 5640 INVITE
Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS
Supported: replaces, 100rel, timer, norefersub
Session-Expires: 1800
Min-SE: 90
User-Agent: PJSUA v2.8 Linux-5.0.1/x86_64/glibc-2.28
Proxy-Authorization: Digest username="419194", realm="sip.odorik.cz", nonce="XIj1t1yI9IvSVsECGhs9JzOn2zv4eK3D", uri="sips:*081@sip.odorik.cz:6670", response="***************"
Content-Type: application/sdp
Content-Length: 821
v=0
o=- 3761468171 3761468171 IN IP4 172.16.3.6
s=pjmedia
b=AS:117
t=0 0
a=X-nat:0
m=audio 4000 RTP/SAVP 104 3 8 120 96
c=IN IP4 172.16.3.6
b=TIAS:96000
a=rtcp:4001 IN IP4 172.16.3.6
a=sendrecv
a=rtpmap:104 iLBC/8000
a=fmtp:104 mode=30
a=rtpmap:3 GSM/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:120 opus/48000/2
a=fmtp:120 useinbandfec=1
a=rtpmap:96 telephone-event/8000
a=fmtp:96 0-16
a=ssrc:316208229 cname:2ce8bdf93f6e3cff
a=crypto:1 AES_256_CM_HMAC_SHA1_80 inline:U3m0Qx8xHyZhDHkgrZPiG/wJa5z6VGIj0JIFWqFa/fV35qi5aZTx8jdtyO/43A==
a=crypto:2 AES_256_CM_HMAC_SHA1_32 inline:7X19aSagSPN+JbOs8TmDi8QoVsv50ziN3czGkFoID1krVU1mHNzSLvFJYTOoNA==
a=crypto:3 AES_CM_128_HMAC_SHA1_80 inline:VOMK3U4bKK4V2a8EcyK5twU7q69crUNuEkz92aUG
a=crypto:4 AES_CM_128_HMAC_SHA1_32 inline:PfQFbG5poXjMIu2ZnbxDZZR9F6RNVX5qOhLgjnyb
--end msg--
SIP/2.0 100 Trying
Via: SIP/2.0/TLS 37.157.194.179:57375;rport=57375;branch=z9hG4bKPjfd24b587-4f17-4d7f-86c4-91e0874a4848;alias;received=37.157.194.179
From: sips:419194@sip.odorik.cz;tag=88036dd1-5345-4a4b-bcad-bab7e1808450
To: sips:*081@sip.odorik.cz
Call-ID: 7692b4d2-aa32-4bca-89d4-e4086c9ac5e1
CSeq: 5640 INVITE
Content-Length: 0
--end msg--
SIP/2.0 200 OK
Via: SIP/2.0/TLS 37.157.194.179:57375;received=37.157.194.179;rport=57375;branch=z9hG4bKPjfd24b587-4f17-4d7f-86c4-91e0874a4848;alias
Record-Route: <sips:*081@81.31.45.51;r2=on;lr=on;ftag=88036dd1-5345-4a4b-bcad-bab7e1808450;did=4719.58be2;nat=yes>
Record-Route: <sips:*081@81.31.45.51:6670;transport=tls;r2=on;lr=on;ftag=88036dd1-5345-4a4b-bcad-bab7e1808450;did=4719.58be2;nat=yes>
From: sips:419194@sip.odorik.cz;tag=88036dd1-5345-4a4b-bcad-bab7e1808450
To: sips:*081@sip.odorik.cz;tag=as58fb17ff
Call-ID: 7692b4d2-aa32-4bca-89d4-e4086c9ac5e1
CSeq: 5640 INVITE
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces
Contact: <sips:*081@89.185.255.38:5060;alias=89.185.255.38~5060~1>
Content-Type: application/sdp
Content-Length: 370
v=0
o=root 575156978 575156978 IN IP4 89.185.255.38
s=-
c=IN IP4 89.185.255.38
t=0 0
m=audio 22810 RTP/SAVP 8 3 104 96
a=rtpmap:8 PCMA/8000
a=rtpmap:3 GSM/8000
a=rtpmap:104 iLBC/8000
a=fmtp:104 mode=30
a=rtpmap:96 telephone-event/8000
a=fmtp:96 0-16
a=ptime:20
a=sendrecv
a=crypto:3 AES_CM_128_HMAC_SHA1_80 inline:DG9UQ/x7u8HaWfZuJXzQ2MbN2WkXAtkFhDhmnpzk
--end msg--
ACK sips:*081@89.185.255.38:5060;alias=89.185.255.38~5060~1 SIP/2.0
Via: SIP/2.0/TLS 37.157.194.179:57375;rport;branch=z9hG4bKPj0f7e91cf-c7ca-421c-88cd-1799d0a13dd0;alias
Max-Forwards: 70
From: sips:419194@sip.odorik.cz;tag=88036dd1-5345-4a4b-bcad-bab7e1808450
To: sips:*081@sip.odorik.cz;tag=as58fb17ff
Call-ID: 7692b4d2-aa32-4bca-89d4-e4086c9ac5e1
CSeq: 5640 ACK
Route: <sips:*081@81.31.45.51:6670;transport=tls;lr;r2=on;ftag=88036dd1-5345-4a4b-bcad-bab7e1808450;did=4719.58be2;nat=yes>
Route: <sips:*081@81.31.45.51;lr;r2=on;ftag=88036dd1-5345-4a4b-bcad-bab7e1808450;did=4719.58be2;nat=yes>
Content-Length: 0
--end msg--
13:16:12.983 pjsua_call.c .Call 0 sending re-INVITE for updating media session to use only one codec
INVITE sips:*081@89.185.255.38:5060;alias=89.185.255.38~5060~1 SIP/2.0
Via: SIP/2.0/TLS 37.157.194.179:57375;rport;branch=z9hG4bKPj8421afe6-71f8-40aa-bfaa-1bda51a3c0e5;alias
Max-Forwards: 70
From: sips:419194@sip.odorik.cz;tag=88036dd1-5345-4a4b-bcad-bab7e1808450
To: sips:*081@sip.odorik.cz;tag=as58fb17ff
Contact: <sips:419194@172.16.3.6:57375;transport=TLS;ob>
Call-ID: 7692b4d2-aa32-4bca-89d4-e4086c9ac5e1
CSeq: 5641 INVITE
Route: <sips:*081@81.31.45.51:6670;transport=tls;lr;r2=on;ftag=88036dd1-5345-4a4b-bcad-bab7e1808450;did=4719.58be2;nat=yes>
Route: <sips:*081@81.31.45.51;lr;r2=on;ftag=88036dd1-5345-4a4b-bcad-bab7e1808450;did=4719.58be2;nat=yes>
Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS
Supported: replaces, 100rel, timer, norefersub
Session-Expires: 1800
Min-SE: 90
Content-Type: application/sdp
Content-Length: 392
v=0
o=- 3761468171 3761468172 IN IP4 172.16.3.6
s=pjmedia
b=AS:117
t=0 0
a=X-nat:0
m=audio 4000 RTP/SAVP 8 96
c=IN IP4 172.16.3.6
b=TIAS:96000
a=rtcp:4001 IN IP4 172.16.3.6
a=ssrc:316208229 cname:2ce8bdf93f6e3cff
a=crypto:1 AES_CM_128_HMAC_SHA1_80 inline:VOMK3U4bKK4V2a8EcyK5twU7q69crUNuEkz92aUG
a=rtpmap:8 PCMA/8000
a=rtpmap:96 telephone-event/8000
a=fmtp:96 0-16
a=sendrecv
--end msg--
SIP/2.0 100 Trying
Via: SIP/2.0/TLS 37.157.194.179:57375;rport=57375;branch=z9hG4bKPj8421afe6-71f8-40aa-bfaa-1bda51a3c0e5;alias;received=37.157.194.179
From: sips:419194@sip.odorik.cz;tag=88036dd1-5345-4a4b-bcad-bab7e1808450
To: sips:*081@sip.odorik.cz;tag=as58fb17ff
Call-ID: 7692b4d2-aa32-4bca-89d4-e4086c9ac5e1
CSeq: 5641 INVITE
Content-Length: 0
--end msg--
SIP/2.0 200 OK
Via: SIP/2.0/TLS 37.157.194.179:57375;received=37.157.194.179;rport=57375;branch=z9hG4bKPj8421afe6-71f8-40aa-bfaa-1bda51a3c0e5;alias
Record-Route: <sips:*081@81.31.45.51;r2=on;lr=on;ftag=88036dd1-5345-4a4b-bcad-bab7e1808450;did=4719.58be2>
Record-Route: <sips:*081@81.31.45.51:6670;transport=tls;r2=on;lr=on;ftag=88036dd1-5345-4a4b-bcad-bab7e1808450;did=4719.58be2>
From: sips:419194@sip.odorik.cz;tag=88036dd1-5345-4a4b-bcad-bab7e1808450
To: sips:*081@sip.odorik.cz;tag=as58fb17ff
Call-ID: 7692b4d2-aa32-4bca-89d4-e4086c9ac5e1
CSeq: 5641 INVITE
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces
Contact: <sips:*081@89.185.255.38:5060;alias=89.185.255.38~5060~1>
Content-Type: application/sdp
Content-Length: 299
v=0
o=root 575156978 575156979 IN IP4 89.185.255.38
s=-
c=IN IP4 89.185.255.38
t=0 0
m=audio 22810 RTP/SAVP 8 96
a=rtpmap:8 PCMA/8000
a=rtpmap:96 telephone-event/8000
a=fmtp:96 0-16
a=ptime:20
a=sendrecv
a=crypto:3 AES_CM_128_HMAC_SHA1_80 inline:DG9UQ/x7u8HaWfZuJXzQ2MbN2WkXAtkFhDhmnpzk
--end msg--
13:16:13.094 pjsua_media.c ......pjmedia_transport_media_start() failed for call_id 0 media 0: Invalid SRTP crypto tag
Re: Nový PJSIP přitvrdil?
Dobry den,
aktualizoval jsem take na 2.8 z svn, zkusil hovor a prosel.
Pouzil sem pjsua, a aby to neposilalo RE-INVITE, tak jsem odstranil codeky, ale slo mi to i bez odstraneni codeku.
aktualizoval jsem take na 2.8 z svn, zkusil hovor a prosel.
Pouzil sem pjsua, a aby to neposilalo RE-INVITE, tak jsem odstranil codeky, ale slo mi to i bez odstraneni codeku.
Kód: Vybrat vše
pjsua --registrar=sips:sip.odorik.cz --id=sips:405277@sip.odorik.cz --realm=* --username=405277 --password=XxXxXxXx --disable-stun --use-tls --use-srtp=2 sips:*412879@sip.odorik.cz --null-audio --dis-codec=speex --dis-codec=GSM --dis-codec=iLBC --dis-codec=G722 --dis-codec=PCMU --dis-codec=opus --log-file=/tmp/xxx
Kód: Vybrat vše
17:04:11.388 sip_endpoint.c .Module "mod-pjsua-log" registered
17:04:11.388 sip_endpoint.c .Module "mod-tsx-layer" registered
17:04:11.388 sip_endpoint.c .Module "mod-stateful-util" registered
17:04:11.388 sip_endpoint.c .Module "mod-ua" registered
17:04:11.388 sip_endpoint.c .Module "mod-100rel" registered
17:04:11.388 sip_endpoint.c .Module "mod-pjsua" registered
17:04:11.389 sip_endpoint.c .Module "mod-invite" registered
17:04:11.389 pjlib ..select() I/O Queue created (0x55e8f9c9e718)
17:04:11.389 conference.c ..Creating conference bridge with 254 ports
17:04:11.389 Master/sound ..Using delay buffer with WSOLA.
17:04:11.394 sip_endpoint.c .Module "mod-evsub" registered
17:04:11.394 sip_endpoint.c .Module "mod-presence" registered
17:04:11.394 evsub.c .Event pkg "presence" registered by mod-presence
17:04:11.394 sip_endpoint.c .Module "mod-mwi" registered
17:04:11.394 evsub.c .Event pkg "message-summary" registered by mod-mwi
17:04:11.394 sip_endpoint.c .Module "mod-refer" registered
17:04:11.394 evsub.c .Event pkg "refer" registered by mod-refer
17:04:11.394 sip_endpoint.c .Module "mod-pjsua-pres" registered
17:04:11.394 sip_endpoint.c .Module "mod-pjsua-im" registered
17:04:11.394 sip_endpoint.c .Module "mod-pjsua-options" registered
17:04:11.394 pjsua_core.c .1 SIP worker threads created
17:04:11.394 pjsua_core.c .pjsua version 2.8-svn for Linux-4.9.0.8/x86_64/glibc-2.24 initialized
17:04:11.394 pjsua_core.c .PJSUA state changed: CREATED --> INIT
17:04:11.394 sip_endpoint.c Module "mod-default-handler" registered
17:04:11.400 pjsua_core.c SIP UDP socket reachable at 192.168.2.111:5060
17:04:11.400 udp0x55e8f9cb70e0 SIP UDP transport started, published address is 192.168.2.111:5060
17:04:11.400 pjsua_acc.c Adding account: id=<sip:192.168.2.111:5060>
17:04:11.400 pjsua_acc.c .Account <sip:192.168.2.111:5060> added with id 0
17:04:11.400 pjsua_acc.c Modifying account 0
17:04:11.400 pjsua_acc.c Acc 0: setting online status to 1..
17:04:11.405 tcptp:5060 SIP TCP listener ready for incoming connections at 192.168.2.111:5060
17:04:11.405 pjsua_acc.c Adding account: id=<sip:192.168.2.111:5060;transport=TCP>
17:04:11.405 pjsua_acc.c .Account <sip:192.168.2.111:5060;transport=TCP> added with id 1
17:04:11.406 pjsua_acc.c Modifying account 1
17:04:11.406 pjsua_acc.c Acc 1: setting online status to 1..
17:04:11.412 tlstp:5061 SIP TLS listener is ready for incoming connections at 192.168.2.111:5061
17:04:11.412 pjsua_acc.c Adding account: id=<sip:192.168.2.111:5061;transport=TLS>
17:04:11.412 pjsua_acc.c .Account <sip:192.168.2.111:5061;transport=TLS> added with id 2
17:04:11.412 pjsua_acc.c Modifying account 2
17:04:11.412 pjsua_acc.c Acc 2: setting online status to 1..
17:04:11.412 pjsua_acc.c Adding account: id=sips:405277@sip.odorik.cz
17:04:11.412 pjsua_acc.c .Account sips:405277@sip.odorik.cz added with id 3
17:04:11.412 pjsua_acc.c .Acc 3: setting registration..
17:04:11.419 tlsc0x55e8f9cc0508 ..TLS client transport created
17:04:11.419 tlsc0x55e8f9cc0508 ..TLS transport 192.168.2.111:48375 is connecting to sip.odorik.cz:5061...
17:04:11.419 pjsua_acc.c ..Contact for acc 3 updated: <sips:405277@192.168.2.111:48375;transport=TLS;ob>;reg-id=1;+sip.instance="<urn:uuid:00000000-0000-0000-0000-0000b08a276a>"
17:04:11.419 endpoint ..Request msg REGISTER/cseq=27481 (tdta0x55e8f9cc2fe8) created.
17:04:11.425 tsx0x55e8f9cc4fa8 ...Transaction created for Request msg REGISTER/cseq=27482 (tdta0x55e8f9cc2fe8)
17:04:11.425 tsx0x55e8f9cc4fa8 ..Sending Request msg REGISTER/cseq=27482 (tdta0x55e8f9cc2fe8) in state Null
17:04:11.425 sip_resolve.c ...DNS resolver not available, target 'sip.odorik.cz:0' type=TLS will be resolved with getaddrinfo()
17:04:11.430 sip_resolve.c ...Target 'sip.odorik.cz:0' type=TLS resolved to '81.31.45.51:5061' type=TLS (TLS transport)
17:04:11.430 pjsua_core.c ...TX 679 bytes Request msg REGISTER/cseq=27482 (tdta0x55e8f9cc2fe8) to TLS 81.31.45.51:5061:
REGISTER sips:sip.odorik.cz SIP/2.0
Via: SIP/2.0/TLS 192.168.2.111:48375;rport;branch=z9hG4bKPjNYotOxwUtbr.TM-iZdRm4hsB2yWo8753;alias
Max-Forwards: 70
From: <sips:405277@sip.odorik.cz>;tag=SiGejr.ogYndipLf5Fmfnkvs6OzxSb34
To: <sips:405277@sip.odorik.cz>
Call-ID: 6qsIOAHVSzbGp6tlXSgSGVh3OECxb7Sf
CSeq: 27482 REGISTER
User-Agent: PJSUA v2.8-svn Linux-4.9.0.8/x86_64/glibc-2.24
Supported: outbound, path
Contact: <sips:405277@192.168.2.111:48375;transport=TLS;ob>;reg-id=1;+sip.instance="<urn:uuid:00000000-0000-0000-0000-0000b08a276a>"
Expires: 300
Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS
Content-Length: 0
--end msg--
17:04:11.431 tsx0x55e8f9cc4fa8 ...State changed from Null to Calling, event=TX_MSG
17:04:11.431 pjsua_acc.c ..Acc 3: Registration sent
17:04:11.431 pjsua_acc.c Acc 3: setting online status to 1..
17:04:11.431 pjsua_pres.c Adding buddy: sips:*412879@sip.odorik.cz
17:04:11.431 pjsua_pres.c .Buddy 0 added.
17:04:11.431 pjsua_pres.c ..Buddy 0: updating presence..
17:04:11.431 pjsua_aud.c Setting null sound device..
17:04:11.431 pjsua_app.c .Turning sound device -99 -99 ON
17:04:11.431 pjsua_aud.c .Opening null sound device..
17:04:11.431 pjsua_core.c PJSUA state changed: INIT --> STARTING
17:04:11.431 sip_endpoint.c .Module "mod-unsolicited-mwi" registered
17:04:11.431 pjsua_core.c .PJSUA state changed: STARTING --> RUNNING
17:04:11.431 main.c Ready: Success
17:04:11.431 pjsua_call.c Making call with acc #3 to sips:*412879@sip.odorik.cz
17:04:11.431 dlg0x55e8f9cc8928 .UAC dialog created
17:04:11.438 dlg0x55e8f9cc8928 ..Session count inc to 2 by mod-pjsua
17:04:11.438 pjsua_media.c .Call 0: initializing media..
17:04:11.444 pjsua_media.c ..RTP socket reachable at 192.168.2.111:4000
17:04:11.444 pjsua_media.c ..RTCP socket reachable at 192.168.2.111:4001
17:04:11.444 srtp0x55e8f9ccc900 ..SRTP keying SDES created
17:04:11.444 pjsua_media.c ..Media index 0 selected for audio call 0
17:04:11.444 pjsua_media.c ..Call 0: media transport initialization complete: Success
17:04:11.444 dlg0x55e8f9cc8928 ..Session count dec to 2 by mod-pjsua
17:04:11.444 srtp0x55e8f9ccc900 .SRTP uses keying method SDES
17:04:11.444 dlg0x55e8f9cc8928 .Module mod-invite added as dialog usage, data=0x55e8f9cceae8
17:04:11.444 dlg0x55e8f9cc8928 ..Session count inc to 4 by mod-invite
17:04:11.444 dlg0x55e8f9cc8928 .Module mod-100rel added as dialog usage, data=0x55e8f9cd07f0
17:04:11.444 dlg0x55e8f9cc8928 .100rel module attached
17:04:11.444 inv0x55e8f9cc8928 .UAC invite session created for dialog dlg0x55e8f9cc8928
17:04:11.444 endpoint .Request msg INVITE/cseq=3486 (tdta0x55e8f9cd0af8) created.
17:04:11.444 inv0x55e8f9cc8928 ..Sending Request msg INVITE/cseq=3486 (tdta0x55e8f9cd0af8)
17:04:11.444 dlg0x55e8f9cc8928 ...Sending Request msg INVITE/cseq=3486 (tdta0x55e8f9cd0af8)
17:04:11.444 tsx0x55e8f9cd3a68 ....Transaction created for Request msg INVITE/cseq=3485 (tdta0x55e8f9cd0af8)
17:04:11.444 tsx0x55e8f9cd3a68 ...Sending Request msg INVITE/cseq=3485 (tdta0x55e8f9cd0af8) in state Null
17:04:11.444 sip_resolve.c ....DNS resolver not available, target 'sip.odorik.cz:0' type=TLS will be resolved with getaddrinfo()
17:04:11.450 sip_resolve.c ....Target 'sip.odorik.cz:0' type=TLS resolved to '81.31.45.51:5061' type=TLS (TLS transport)
17:04:11.450 pjsua_core.c ....TX 1383 bytes Request msg INVITE/cseq=3485 (tdta0x55e8f9cd0af8) to TLS 81.31.45.51:5061:
INVITE sips:*412879@sip.odorik.cz SIP/2.0
Via: SIP/2.0/TLS 192.168.2.111:48375;rport;branch=z9hG4bKPj9bXAdOO6xLcWCR3jtRltdUkaC-njOPUJ;alias
Max-Forwards: 70
From: sips:405277@sip.odorik.cz;tag=9phURiud6sS-CCFQjOwfrqFsW7AKbUmf
To: sips:*412879@sip.odorik.cz
Contact: <sips:405277@192.168.2.111:48375;transport=TLS;ob>
Call-ID: vhX1dbDmK7ASzl-5kUZrQW9SKJyV8Fs3
CSeq: 3485 INVITE
Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS
Supported: replaces, 100rel, timer, norefersub
Session-Expires: 1800
Min-SE: 90
User-Agent: PJSUA v2.8-svn Linux-4.9.0.8/x86_64/glibc-2.24
Content-Type: application/sdp
Content-Length: 701
v=0
o=- 3761481851 3761481851 IN IP4 192.168.2.111
s=pjmedia
b=AS:84
t=0 0
a=X-nat:0
m=audio 4000 RTP/SAVP 8 96
c=IN IP4 192.168.2.111
b=TIAS:64000
a=rtcp:4001 IN IP4 192.168.2.111
a=sendrecv
a=rtpmap:8 PCMA/8000
a=rtpmap:96 telephone-event/8000
a=fmtp:96 0-16
a=ssrc:1248634765 cname:7c1044e84fbb5062
a=crypto:1 AES_256_CM_HMAC_SHA1_80 inline:iPi1GV4WPns8Zhh+i8i2/dhF/NAJLuDdLYLmWqW0BAfFinVGT/jqHmsdtVV5dw==
a=crypto:2 AES_256_CM_HMAC_SHA1_32 inline:2ljIoyJWcnufWFCAKIOWwVx0aB6PQsna1OFs5W6pJzCT9nIxqh4ovZUZw96CVQ==
a=crypto:3 AES_CM_128_HMAC_SHA1_80 inline:58gGK3hKsYqvkNQSWVYY+iEgrFek2LrHoh6YwMfl
a=crypto:4 AES_CM_128_HMAC_SHA1_32 inline:IvPcEV6GS5tm4PfSdn/egs/RYvb4VnmEZ4FgPMVh
--end msg--
17:04:11.450 tsx0x55e8f9cd3a68 ....State changed from Null to Calling, event=TX_MSG
17:04:11.450 dlg0x55e8f9cc8928 .....Transaction tsx0x55e8f9cd3a68 state changed to Calling
17:04:11.450 pjsua_app.c .......Call 0 state changed to CALLING
17:04:11.464 pjsua_app.c !SIP TLS transport is connected to sip.odorik.cz:5061
17:04:11.464 pjsua_app.c TLS cipher used: 0x00009D/AES256-GCM-SHA384
17:04:11.464 pjsua_app.c TLS cert info of sip.odorik.cz:5061:
Version : v3
Serial : 01
Subject : sip.odorik.cz
/C=CZ/ST=Czech Republic/O=miniTEL s.r.o./OU=odorik.cz/CN=sip.odorik.cz/emailAddress=kontakt@odorik.cz
Issuer : OdorikCA
/CN=OdorikCA/ST=Czech Republic/C=CZ/emailAddress=kontakt@minitel.cz/O=miniTEL s.r.o.
Valid from : Tue 2016-04-26 15:24:51.000 GMT
Valid to : Wed 2055-09-29 15:24:51.000 GMT
17:04:11.464 pjsua_app.c TLS cert verification result of sip.odorik.cz:5061 :
17:04:11.464 pjsua_app.c - The certificate is untrusted
17:04:11.464 pjsua_app.c - Unknown verification error
17:04:11.464 pjsua_app.c PJSUA is configured to ignore TLS cert verification errors
17:04:11.464 tlsc0x55e8f9cc0508 TLS transport 192.168.2.111:48375 is connected to sip.odorik.cz:5061
17:04:11.476 sip_endpoint.c Processing incoming message: Response msg 401/REGISTER/cseq=27482 (rdata0x55e8f9cc0820)
17:04:11.476 pjsua_core.c .RX 478 bytes Response msg 401/REGISTER/cseq=27482 (rdata0x55e8f9cc0820) from TLS 81.31.45.51:5061:
SIP/2.0 401 Unauthorized
Via: SIP/2.0/TLS 192.168.2.111:48375;rport=48375;branch=z9hG4bKPjNYotOxwUtbr.TM-iZdRm4hsB2yWo8753;alias;received=85.135.106.202
From: <sips:405277@sip.odorik.cz>;tag=SiGejr.ogYndipLf5Fmfnkvs6OzxSb34
To: <sips:405277@sip.odorik.cz>;tag=d9f55a8611ba6e9295acea97d3a19a47.2b20
Call-ID: 6qsIOAHVSzbGp6tlXSgSGVh3OECxb7Sf
CSeq: 27482 REGISTER
WWW-Authenticate: Digest realm="sip.odorik.cz", nonce="XIkrKVyJKf1kdmCT+3WNa2eB11qHlU1p"
Content-Length: 0
--end msg--
17:04:11.476 tsx0x55e8f9cc4fa8 .Incoming Response msg 401/REGISTER/cseq=27482 (rdata0x55e8f9cc0820) in state Calling
17:04:11.476 tsx0x55e8f9cc4fa8 ..State changed from Calling to Completed, event=RX_MSG
17:04:11.477 pjsua_acc.c ....IP address change detected for account 3 (192.168.2.111:48375 --> 85.135.106.202:48375). Updating registration (using method 4)
17:04:11.477 pjsua_acc.c ....Contact for acc 3 updated: <sips:405277@85.135.106.202:48375;transport=TLS;ob>;reg-id=1;+sip.instance="<urn:uuid:00000000-0000-0000-0000-0000b08a276a>"
17:04:11.477 tsx0x7fef14022178 ....Transaction created for Request msg REGISTER/cseq=27483 (tdta0x55e8f9cc2fe8)
17:04:11.477 tsx0x7fef14022178 ...Sending Request msg REGISTER/cseq=27483 (tdta0x55e8f9cc2fe8) in state Null
17:04:11.477 endpoint ....Request msg REGISTER/cseq=27483 (tdta0x55e8f9cc2fe8): skipping target resolution because address is already set
17:04:11.477 pjsua_core.c ....TX 858 bytes Request msg REGISTER/cseq=27483 (tdta0x55e8f9cc2fe8) to TLS 81.31.45.51:5061:
REGISTER sips:sip.odorik.cz SIP/2.0
Via: SIP/2.0/TLS 85.135.106.202:48375;rport;branch=z9hG4bKPjdH-GIgvuU-9j.hww3I4sFc4r80cPtwW-;alias
Max-Forwards: 70
From: <sips:405277@sip.odorik.cz>;tag=SiGejr.ogYndipLf5Fmfnkvs6OzxSb34
To: <sips:405277@sip.odorik.cz>
Call-ID: 6qsIOAHVSzbGp6tlXSgSGVh3OECxb7Sf
CSeq: 27483 REGISTER
User-Agent: PJSUA v2.8-svn Linux-4.9.0.8/x86_64/glibc-2.24
Supported: outbound, path
Contact: <sips:405277@85.135.106.202:48375;transport=TLS;ob>;reg-id=1;+sip.instance="<urn:uuid:00000000-0000-0000-0000-0000b08a276a>"
Expires: 300
Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS
Authorization: Digest username="405277", realm="sip.odorik.cz", nonce="XIkrKVyJKf1kdmCT+3WNa2eB11qHlU1p", uri="sips:sip.odorik.cz", response="5d7b624eb06c951aca6a70e329c6da98"
Content-Length: 0
--end msg--
17:04:11.477 tsx0x7fef14022178 ....State changed from Null to Calling, event=TX_MSG
17:04:11.477 tsx0x55e8f9cc4fa8 Timeout timer event
17:04:11.477 tsx0x55e8f9cc4fa8 .State changed from Completed to Terminated, event=TIMER
17:04:11.477 tsx0x55e8f9cc4fa8 Timeout timer event
17:04:11.477 tsx0x55e8f9cc4fa8 .State changed from Terminated to Destroyed, event=TIMER
17:04:11.477 tsx0x55e8f9cc4fa8 Transaction destroyed!
17:04:11.488 sip_endpoint.c Processing incoming message: Response msg 407/INVITE/cseq=3485 (rdata0x55e8f9cc0820)
17:04:11.488 pjsua_core.c .RX 491 bytes Response msg 407/INVITE/cseq=3485 (rdata0x55e8f9cc0820) from TLS 81.31.45.51:5061:
SIP/2.0 407 Proxy Authentication Required
Via: SIP/2.0/TLS 192.168.2.111:48375;rport=48375;branch=z9hG4bKPj9bXAdOO6xLcWCR3jtRltdUkaC-njOPUJ;alias;received=85.135.106.202
From: sips:405277@sip.odorik.cz;tag=9phURiud6sS-CCFQjOwfrqFsW7AKbUmf
To: sips:*412879@sip.odorik.cz;tag=d9f55a8611ba6e9295acea97d3a19a47.8147
Call-ID: vhX1dbDmK7ASzl-5kUZrQW9SKJyV8Fs3
CSeq: 3485 INVITE
Proxy-Authenticate: Digest realm="sip.odorik.cz", nonce="XIkrKVyJKf1kdmCT+3WNa2eB11qHlU1p"
Content-Length: 0
--end msg--
17:04:11.488 tsx0x55e8f9cd3a68 .Incoming Response msg 407/INVITE/cseq=3485 (rdata0x55e8f9cc0820) in state Calling
17:04:11.488 endpoint ..Request msg ACK/cseq=3485 (tdta0x7fef14022988) created.
17:04:11.488 pjsua_core.c ..TX 382 bytes Request msg ACK/cseq=3485 (tdta0x7fef14022988) to TLS 81.31.45.51:5061:
ACK sips:*412879@sip.odorik.cz SIP/2.0
Via: SIP/2.0/TLS 192.168.2.111:48375;rport;branch=z9hG4bKPj9bXAdOO6xLcWCR3jtRltdUkaC-njOPUJ;alias
Max-Forwards: 70
From: sips:405277@sip.odorik.cz;tag=9phURiud6sS-CCFQjOwfrqFsW7AKbUmf
To: sips:*412879@sip.odorik.cz;tag=d9f55a8611ba6e9295acea97d3a19a47.8147
Call-ID: vhX1dbDmK7ASzl-5kUZrQW9SKJyV8Fs3
CSeq: 3485 ACK
Content-Length: 0
--end msg--
17:04:11.488 tsx0x55e8f9cd3a68 ..State changed from Calling to Completed, event=RX_MSG
17:04:11.488 dlg0x55e8f9cc8928 ...Received Response msg 407/INVITE/cseq=3485 (rdata0x55e8f9cc0820)
17:04:11.488 dlg0x55e8f9cc8928 ...Transaction tsx0x55e8f9cd3a68 state changed to Completed
17:04:11.488 inv0x55e8f9cc8928 .....Sending Request msg INVITE/cseq=3485 (tdta0x55e8f9cd0af8)
17:04:11.488 dlg0x55e8f9cc8928 ......Sending Request msg INVITE/cseq=3485 (tdta0x55e8f9cd0af8)
17:04:11.488 tsx0x7fef14025cf8 .......Transaction created for Request msg INVITE/cseq=3486 (tdta0x55e8f9cd0af8)
17:04:11.488 tsx0x7fef14025cf8 ......Sending Request msg INVITE/cseq=3486 (tdta0x55e8f9cd0af8) in state Null
17:04:11.488 endpoint .......Request msg INVITE/cseq=3486 (tdta0x55e8f9cd0af8): skipping target resolution because address is already set
17:04:11.488 pjsua_core.c .......TX 1574 bytes Request msg INVITE/cseq=3486 (tdta0x55e8f9cd0af8) to TLS 81.31.45.51:5061:
INVITE sips:*412879@sip.odorik.cz SIP/2.0
Via: SIP/2.0/TLS 192.168.2.111:48375;rport;branch=z9hG4bKPjIZvqhdnFBJRE7OaHChSvHDCOnVkM3tpV;alias
Max-Forwards: 70
From: sips:405277@sip.odorik.cz;tag=9phURiud6sS-CCFQjOwfrqFsW7AKbUmf
To: sips:*412879@sip.odorik.cz
Contact: <sips:405277@192.168.2.111:48375;transport=TLS;ob>
Call-ID: vhX1dbDmK7ASzl-5kUZrQW9SKJyV8Fs3
CSeq: 3486 INVITE
Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS
Supported: replaces, 100rel, timer, norefersub
Session-Expires: 1800
Min-SE: 90
User-Agent: PJSUA v2.8-svn Linux-4.9.0.8/x86_64/glibc-2.24
Proxy-Authorization: Digest username="405277", realm="sip.odorik.cz", nonce="XIkrKVyJKf1kdmCT+3WNa2eB11qHlU1p", uri="sips:*412879@sip.odorik.cz", response="7772a3728b0a51887a92b422c6b9b41e"
Content-Type: application/sdp
Content-Length: 701
v=0
o=- 3761481851 3761481851 IN IP4 192.168.2.111
s=pjmedia
b=AS:84
t=0 0
a=X-nat:0
m=audio 4000 RTP/SAVP 8 96
c=IN IP4 192.168.2.111
b=TIAS:64000
a=rtcp:4001 IN IP4 192.168.2.111
a=sendrecv
a=rtpmap:8 PCMA/8000
a=rtpmap:96 telephone-event/8000
a=fmtp:96 0-16
a=ssrc:1248634765 cname:7c1044e84fbb5062
a=crypto:1 AES_256_CM_HMAC_SHA1_80 inline:iPi1GV4WPns8Zhh+i8i2/dhF/NAJLuDdLYLmWqW0BAfFinVGT/jqHmsdtVV5dw==
a=crypto:2 AES_256_CM_HMAC_SHA1_32 inline:2ljIoyJWcnufWFCAKIOWwVx0aB6PQsna1OFs5W6pJzCT9nIxqh4ovZUZw96CVQ==
a=crypto:3 AES_CM_128_HMAC_SHA1_80 inline:58gGK3hKsYqvkNQSWVYY+iEgrFek2LrHoh6YwMfl
a=crypto:4 AES_CM_128_HMAC_SHA1_32 inline:IvPcEV6GS5tm4PfSdn/egs/RYvb4VnmEZ4FgPMVh
--end msg--
17:04:11.489 tsx0x7fef14025cf8 .......State changed from Null to Calling, event=TX_MSG
17:04:11.489 dlg0x55e8f9cc8928 ........Transaction tsx0x7fef14025cf8 state changed to Calling
17:04:11.489 tsx0x55e8f9cd3a68 Timeout timer event
17:04:11.489 tsx0x55e8f9cd3a68 .State changed from Completed to Terminated, event=TIMER
17:04:11.489 dlg0x55e8f9cc8928 ..Transaction tsx0x55e8f9cd3a68 state changed to Terminated
17:04:11.489 tsx0x55e8f9cd3a68 Timeout timer event
17:04:11.489 tsx0x55e8f9cd3a68 .State changed from Terminated to Destroyed, event=TIMER
17:04:11.489 tdta0x7fef14022988 ..Destroying txdata Request msg ACK/cseq=3485 (tdta0x7fef14022988)
17:04:11.489 tsx0x55e8f9cd3a68 Transaction destroyed!
17:04:11.502 sip_endpoint.c Processing incoming message: Response msg 200/REGISTER/cseq=27483 (rdata0x55e8f9cc0820)
17:04:11.502 pjsua_core.c .RX 573 bytes Response msg 200/REGISTER/cseq=27483 (rdata0x55e8f9cc0820) from TLS 81.31.45.51:5061:
SIP/2.0 200 OK
Via: SIP/2.0/TLS 85.135.106.202:48375;rport=48375;branch=z9hG4bKPjdH-GIgvuU-9j.hww3I4sFc4r80cPtwW-;alias;received=85.135.106.202
From: <sips:405277@sip.odorik.cz>;tag=SiGejr.ogYndipLf5Fmfnkvs6OzxSb34
To: <sips:405277@sip.odorik.cz>;tag=d9f55a8611ba6e9295acea97d3a19a47.13cc
Call-ID: 6qsIOAHVSzbGp6tlXSgSGVh3OECxb7Sf
CSeq: 27483 REGISTER
Contact: <sip:405277@88.150.183.67:35060>;expires=3306, <sips:405277@85.135.106.202:48375;transport=TLS;ob>;expires=300;+sip.instance="<urn:uuid:00000000-0000-0000-0000-0000b08a276a>";reg-id=1
Content-Length: 0
--end msg--
17:04:11.502 tsx0x7fef14022178 .Incoming Response msg 200/REGISTER/cseq=27483 (rdata0x55e8f9cc0820) in state Calling
17:04:11.502 tsx0x7fef14022178 ..State changed from Calling to Completed, event=RX_MSG
17:04:11.502 pjsua_acc.c ....SIP outbound status for acc 3 is not active
17:04:11.502 pjsua_acc.c ....sips:405277@sip.odorik.cz: registration success, status=200 (OK), will re-register in 300 seconds
17:04:11.502 tsx0x7fef14022178 Timeout timer event
17:04:11.502 tsx0x7fef14022178 .State changed from Completed to Terminated, event=TIMER
17:04:11.502 tsx0x7fef14022178 Timeout timer event
17:04:11.502 tsx0x7fef14022178 .State changed from Terminated to Destroyed, event=TIMER
17:04:11.502 tdta0x55e8f9cc2fe8 ..Destroying txdata Request msg REGISTER/cseq=27483 (tdta0x55e8f9cc2fe8)
17:04:11.502 tsx0x7fef14022178 Transaction destroyed!
17:04:11.513 sip_endpoint.c Processing incoming message: Response msg 100/INVITE/cseq=3486 (rdata0x55e8f9cc0820)
17:04:11.513 pjsua_core.c .RX 334 bytes Response msg 100/INVITE/cseq=3486 (rdata0x55e8f9cc0820) from TLS 81.31.45.51:5061:
SIP/2.0 100 Trying
Via: SIP/2.0/TLS 192.168.2.111:48375;rport=48375;branch=z9hG4bKPjIZvqhdnFBJRE7OaHChSvHDCOnVkM3tpV;alias;received=85.135.106.202
From: sips:405277@sip.odorik.cz;tag=9phURiud6sS-CCFQjOwfrqFsW7AKbUmf
To: sips:*412879@sip.odorik.cz
Call-ID: vhX1dbDmK7ASzl-5kUZrQW9SKJyV8Fs3
CSeq: 3486 INVITE
Content-Length: 0
--end msg--
17:04:11.513 tsx0x7fef14025cf8 .Incoming Response msg 100/INVITE/cseq=3486 (rdata0x55e8f9cc0820) in state Calling
17:04:11.513 tsx0x7fef14025cf8 ..State changed from Calling to Proceeding, event=RX_MSG
17:04:11.513 dlg0x55e8f9cc8928 ...Received Response msg 100/INVITE/cseq=3486 (rdata0x55e8f9cc0820)
17:04:11.513 dlg0x55e8f9cc8928 ...Transaction tsx0x7fef14025cf8 state changed to Proceeding
17:04:11.728 sip_endpoint.c Processing incoming message: Response msg 200/INVITE/cseq=3486 (rdata0x55e8f9cc0820)
17:04:11.728 pjsua_core.c .RX 1124 bytes Response msg 200/INVITE/cseq=3486 (rdata0x55e8f9cc0820) from TLS 81.31.45.51:5061:
SIP/2.0 200 OK
Via: SIP/2.0/TLS 192.168.2.111:48375;received=85.135.106.202;rport=48375;branch=z9hG4bKPjIZvqhdnFBJRE7OaHChSvHDCOnVkM3tpV;alias
Record-Route: <sips:*412879@81.31.45.51;r2=on;lr=on;ftag=9phURiud6sS-CCFQjOwfrqFsW7AKbUmf;did=2efd.57462;nat=yes>
Record-Route: <sips:*412879@81.31.45.51:5061;transport=tls;r2=on;lr=on;ftag=9phURiud6sS-CCFQjOwfrqFsW7AKbUmf;did=2efd.57462;nat=yes>
From: sips:405277@sip.odorik.cz;tag=9phURiud6sS-CCFQjOwfrqFsW7AKbUmf
To: sips:*412879@sip.odorik.cz;tag=as1e8206bd
Call-ID: vhX1dbDmK7ASzl-5kUZrQW9SKJyV8Fs3
CSeq: 3486 INVITE
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces
Contact: <sips:*086*412879@81.31.45.59:5060;alias=81.31.45.59~5060~1>
Content-Type: application/sdp
Content-Length: 322
v=0
o=root 221091432 221091432 IN IP4 81.31.45.59
s=-
c=IN IP4 81.31.45.59
t=0 0
m=audio 22066 RTP/SAVP 8 96
a=rtpmap:8 PCMA/8000
a=rtpmap:96 telephone-event/8000
a=fmtp:96 0-16
a=silenceSupp:off - - - -
a=ptime:20
a=sendrecv
a=crypto:3 AES_CM_128_HMAC_SHA1_80 inline:nRsmds+L/TG0BBRrR6+xeFUmO47VqUl2iSZU8LrF
--end msg--
17:04:11.729 tsx0x7fef14025cf8 .Incoming Response msg 200/INVITE/cseq=3486 (rdata0x55e8f9cc0820) in state Proceeding
17:04:11.729 tsx0x7fef14025cf8 ..State changed from Proceeding to Terminated, event=RX_MSG
17:04:11.729 dlg0x55e8f9cc8928 ...Received Response msg 200/INVITE/cseq=3486 (rdata0x55e8f9cc0820)
17:04:11.729 dlg0x55e8f9cc8928 ....Route-set updated
17:04:11.729 dlg0x55e8f9cc8928 ....Route-set frozen
17:04:11.729 dlg0x55e8f9cc8928 ...Transaction tsx0x7fef14025cf8 state changed to Terminated
17:04:11.729 pjsua_app.c .....Call 0 state changed to CONNECTING
17:04:11.729 inv0x55e8f9cc8928 ....Got SDP answer in Response msg 200/INVITE/cseq=3486 (rdata0x55e8f9cc0820)
17:04:11.729 inv0x55e8f9cc8928 ....SDP negotiation done, status=0
17:04:11.729 pjsua_call.c .....Call 0: remote NAT type is 0 (Unknown)
17:04:11.729 pjsua_media.c .....Call 0: updating media..
17:04:11.729 pjsua_media.c .......Media stream call00:0 is destroyed
17:04:11.729 srtp0x55e8f9ccc900 ......TX: AES_CM_128_HMAC_SHA1_80 key=58gGK3hKsYqvkNQSWVYY+iEgrFek2LrHoh6YwMfl
17:04:11.729 srtp0x55e8f9ccc900 ......RX: AES_CM_128_HMAC_SHA1_80 key=nRsmds+L/TG0BBRrR6+xeFUmO47VqUl2iSZU8LrF
17:04:11.729 srtp0x55e8f9ccc900 ......SRTP started, keying=SDES, crypto=AES_CM_128_HMAC_SHA1_80
17:04:11.729 pjsua_aud.c ......Audio channel update..
17:04:11.729 strm0x7fef14037458 .......VAD temporarily disabled
17:04:11.729 rtp.c .......pjmedia_rtp_session_init: ses=0x7fef1403a2c0, default_pt=8, ssrc=0x4a6ca78d
17:04:11.729 rtp.c .......pjmedia_rtp_session_init: ses=0x7fef1403a940, default_pt=8, ssrc=0x4a6ca78d
17:04:11.729 stream.c .......Stream strm0x7fef14037458 created
17:04:11.729 strm0x7fef14037458 .......Encoder stream started
17:04:11.729 strm0x7fef14037458 .......Decoder stream started
17:04:11.730 resample.c .......resample created: high qualiy, large filter, in/out rate=8000/16000
17:04:11.730 resample.c .......resample created: high qualiy, large filter, in/out rate=16000/8000
17:04:11.730 pjsua_media.c ......Audio updated, stream #0: PCMA (sendrecv)
17:04:11.730 pjsua_app.c .....Call 0 media 0 [type=audio], status is Active
17:04:11.730 pjsua_aud.c .....Conf connect: 3 --> 0
17:04:11.730 conference.c ......Port 3 (sips:*412879@sip.odorik.cz) transmitting to port 0 (Master/sound)
17:04:11.730 pjsua_aud.c .....Conf connect: 0 --> 3
17:04:11.730 conference.c ......Port 0 (Master/sound) transmitting to port 3 (sips:*412879@sip.odorik.cz)
17:04:11.730 inv0x55e8f9cc8928 ....Received Response msg 200/INVITE/cseq=3486 (rdata0x55e8f9cc0820), sending ACK
17:04:11.730 endpoint ....Request msg ACK/cseq=3486 (tdta0x7fef1403cbe8) created.
17:04:11.730 dlg0x55e8f9cc8928 .....Sending Request msg ACK/cseq=3486 (tdta0x7fef1403cbe8)
17:04:11.730 sip_resolve.c .....Target '81.31.45.51:5061' type=TLS resolved to '81.31.45.51:5061' type=TLS (TLS transport)
17:04:11.730 pjsua_core.c .....TX 616 bytes Request msg ACK/cseq=3486 (tdta0x7fef1403cbe8) to TLS 81.31.45.51:5061:
ACK sips:*086*412879@81.31.45.59:5060;alias=81.31.45.59~5060~1 SIP/2.0
Via: SIP/2.0/TLS 192.168.2.111:48375;rport;branch=z9hG4bKPjsvU2ksLtdOByx1RcsF9W89jT7Stqk3qO;alias
Max-Forwards: 70
From: sips:405277@sip.odorik.cz;tag=9phURiud6sS-CCFQjOwfrqFsW7AKbUmf
To: sips:*412879@sip.odorik.cz;tag=as1e8206bd
Call-ID: vhX1dbDmK7ASzl-5kUZrQW9SKJyV8Fs3
CSeq: 3486 ACK
Route: <sips:*412879@81.31.45.51:5061;transport=tls;lr;r2=on;ftag=9phURiud6sS-CCFQjOwfrqFsW7AKbUmf;did=2efd.57462;nat=yes>
Route: <sips:*412879@81.31.45.51;lr;r2=on;ftag=9phURiud6sS-CCFQjOwfrqFsW7AKbUmf;did=2efd.57462;nat=yes>
Content-Length: 0
--end msg--
17:04:11.731 pjsua_app.c .....Call 0 state changed to CONFIRMED
17:04:11.731 tsx0x7fef14025cf8 Timeout timer event
17:04:11.731 tsx0x7fef14025cf8 .State changed from Terminated to Destroyed, event=TIMER
17:04:11.731 tsx0x7fef14025cf8 Transaction destroyed!
17:04:11.733 strm0x7fef14037458 !Jitter buffer is bufferring (prefetch=0)
17:04:11.734 strm0x7fef14037458 Start talksprut..
17:04:11.890 strm0x7fef14037458 !RTP status: badpt=0, badssrc=0, dup=0, outorder=0, probation=-1, restart=0
17:04:11.893 strm0x7fef14037458 !Jitter buffer starts returning normal frames (after 8 empty/lost)
17:04:12.332 strm0x7fef14037458 Frame lost, recovered!
17:04:12.332 strm0x7fef14037458 Jitter buffer starts returning normal frames (after 1 empty/lost)
17:04:12.353 strm0x7fef14037458 VAD re-enabled
17:04:12.353 strm0x7fef14037458 Starting silence
17:04:12.619 strm0x7fef14037458 Frame lost, recovered!
17:04:12.619 strm0x7fef14037458 Jitter buffer starts returning normal frames (after 1 empty/lost)
17:04:12.933 strm0x7fef14037458 Frame lost, recovered!
17:04:12.953 strm0x7fef14037458 Jitter buffer starts returning normal frames (after 1 empty/lost)
17:04:13.177 strm0x7fef14037458 Jitter buffer empty (prefetch=0), plc invoked
17:04:13.459 strm0x7fef14037458 Jitter buffer starts returning normal frames (after 14 empty/lost)
17:04:15.297 strm0x7fef14037458 Jitter buffer empty (prefetch=0), plc invoked
17:04:16.333 silencedet.c Re-adjust threshold (in silence)to 0
17:04:16.452 strm0x7fef14037458 Start talksprut..
17:04:16.477 strm0x7fef14037458 Starting silence
17:04:20.334 silencedet.c Re-adjust threshold (in silence)to 0
17:04:21.455 strm0x7fef14037458 Start talksprut..
17:04:21.473 strm0x7fef14037458 Starting silence
17:04:24.333 silencedet.c Re-adjust threshold (in silence)to 0
17:04:26.453 strm0x7fef14037458 Start talksprut..
17:04:26.472 strm0x7fef14037458 Starting silence
17:04:28.333 silencedet.c Re-adjust threshold (in silence)to 0
17:04:31.452 strm0x7fef14037458 Start talksprut..
17:04:31.473 strm0x7fef14037458 Starting silence
17:04:31.790 sip_endpoint.c !Processing incoming message: Request msg BYE/cseq=102 (rdata0x55e8f9cc0820)
17:04:31.790 pjsua_core.c .RX 455 bytes Request msg BYE/cseq=102 (rdata0x55e8f9cc0820) from TLS 81.31.45.51:5061:
BYE sips:405277@192.168.2.111:48375;transport=TLS;ob SIP/2.0
Via: SIP/2.0/TLS 81.31.45.51:5061;branch=z9hG4bK2bef.f7ba88e3879645f825d04ec40b024444.0
Via: SIP/2.0/UDP 81.31.45.59:5060;received=81.31.45.59;branch=z9hG4bK4ee97515;rport=5060
Max-Forwards: 69
From: sips:*412879@sip.odorik.cz;tag=as1e8206bd
To: sips:405277@sip.odorik.cz;tag=9phURiud6sS-CCFQjOwfrqFsW7AKbUmf
Call-ID: vhX1dbDmK7ASzl-5kUZrQW9SKJyV8Fs3
CSeq: 102 BYE
Content-Length: 0
--end msg--
17:04:31.790 dlg0x55e8f9cc8928 .Received Request msg BYE/cseq=102 (rdata0x55e8f9cc0820)
17:04:31.790 tsx0x7fef14025cf8 ...Transaction created for Request msg BYE/cseq=102 (rdata0x55e8f9cc0820)
17:04:31.790 tsx0x7fef14025cf8 ..Incoming Request msg BYE/cseq=102 (rdata0x55e8f9cc0820) in state Null
17:04:31.790 tsx0x7fef14025cf8 ...State changed from Null to Trying, event=RX_MSG
17:04:31.790 dlg0x55e8f9cc8928 ....Transaction tsx0x7fef14025cf8 state changed to Trying
17:04:31.790 endpoint .....Response msg 200/BYE/cseq=102 (tdta0x7fef14040af8) created
17:04:31.790 dlg0x55e8f9cc8928 ......Sending Response msg 200/BYE/cseq=102 (tdta0x7fef14040af8)
17:04:31.790 tsx0x7fef14025cf8 ......Sending Response msg 200/BYE/cseq=102 (tdta0x7fef14040af8) in state Trying
17:04:31.790 pjsua_core.c .......TX 417 bytes Response msg 200/BYE/cseq=102 (tdta0x7fef14040af8) to TLS 81.31.45.51:5061:
SIP/2.0 200 OK
Via: SIP/2.0/TLS 81.31.45.51:5061;received=81.31.45.51;branch=z9hG4bK2bef.f7ba88e3879645f825d04ec40b024444.0
Via: SIP/2.0/UDP 81.31.45.59:5060;rport=5060;received=81.31.45.59;branch=z9hG4bK4ee97515
Call-ID: vhX1dbDmK7ASzl-5kUZrQW9SKJyV8Fs3
From: <sips:*412879@sip.odorik.cz>;tag=as1e8206bd
To: <sips:405277@sip.odorik.cz>;tag=9phURiud6sS-CCFQjOwfrqFsW7AKbUmf
CSeq: 102 BYE
Content-Length: 0
--end msg--
17:04:31.791 tsx0x7fef14025cf8 .......State changed from Trying to Completed, event=TX_MSG
17:04:31.791 dlg0x55e8f9cc8928 ........Transaction tsx0x7fef14025cf8 state changed to Completed
17:04:31.791 pjsua_app.c ......Call 0 is DISCONNECTED [reason=200 (Normal call clearing)]
17:04:31.791 pjsua_app.c ......Call 0 disconnected, dumping media stats..
17:04:31.791 pjsua_app_common.c ......
[DISCONNCTD] To: sips:*412879@sip.odorik.cz;tag=as1e8206bd
Call time: 00h:00m:20s, 1st res in 298 ms, conn in 300ms
#0 audio PCMA @8kHz, sendrecv, peer=81.31.45.59:22066
SRTP status: Active Crypto-suite: AES_CM_128_HMAC_SHA1_80
RX pt=8, last update:00h:00m:00.536s ago
total 158pkt 25.2KB (31.6KB +IP hdr) @avg=10.0Kbps/12.6Kbps
pkt loss=0 (0.0%), discrd=0 (0.0%), dup=0 (0.0%), reord=0 (0.0%)
(msec) min avg max last dev
loss period: 0.000 0.000 0.000 0.000 0.000
jitter : 0.000 0.430 0.750 0.625 0.148
TX pt=8, ptime=20, last update:00h:00m:00.005s ago
total 35pkt 5.6KB (7.0KB +IP hdr) @avg=2.2Kbps/2.7Kbps
pkt loss=3 (8.6%), dup=0 (0.0%), reorder=0 (0.0%)
(msec) min avg max last dev
loss period
Re: Nový PJSIP přitvrdil?
Díky za rychlou reakci.
Je pravda, že pokud zakážu všechny kodeky až na PCMA tak to projde. Jako rychlý workaround
na pokusy to stačí. V reálu by ale nebylo špatné aby si systémy mohly kodeky dohodnout
z průniku podporovaných. Třeba zrovna Opus se mi na VOIP zdá jako moc pěkný kodek
(z pohledu kvalita/datový tok).
Přiznávám, že jsem líný číst všechny RFC. Je tedy re-invite který dělá PJSIP špatné/nevhodné řešení?
Pokud ano, povrtám se ve zdrojácích - a zkusím s nich tuhle vlastnost vyhodit.
Díky Jiří Netolický
Je pravda, že pokud zakážu všechny kodeky až na PCMA tak to projde. Jako rychlý workaround
na pokusy to stačí. V reálu by ale nebylo špatné aby si systémy mohly kodeky dohodnout
z průniku podporovaných. Třeba zrovna Opus se mi na VOIP zdá jako moc pěkný kodek
(z pohledu kvalita/datový tok).
Přiznávám, že jsem líný číst všechny RFC. Je tedy re-invite který dělá PJSIP špatné/nevhodné řešení?
Pokud ano, povrtám se ve zdrojácích - a zkusím s nich tuhle vlastnost vyhodit.
Díky Jiří Netolický
Re: Nový PJSIP přitvrdil?
Dobry den,
v poslednim prispevku pisu, ze mi hovor projde i bez odstraneni codeku s re-INVITEM, prikladam log.
Nevim, proc pjsip posila re-INVITE,` normalne` se to nedela stejne v re-INVITU posle ALAW.
Odorik opus nepodporuje ani to mema moc smysl, protoze by dochazelo k transkodovani na alaw.
prikaz:
log:
v poslednim prispevku pisu, ze mi hovor projde i bez odstraneni codeku s re-INVITEM, prikladam log.
Nevim, proc pjsip posila re-INVITE,` normalne` se to nedela stejne v re-INVITU posle ALAW.
Odorik opus nepodporuje ani to mema moc smysl, protoze by dochazelo k transkodovani na alaw.
prikaz:
Kód: Vybrat vše
pjsua --id=sips:405277@sip.odorik.cz --realm=* --username=405277 --password=XxXXxXX --disable-stun --use-tls --use-srtp=2 sips:*412879@sip.odorik.cz --null-audio --log-file=/tmp/xxx
Kód: Vybrat vše
15:26:59.105 sip_endpoint.c .Module "mod-pjsua-log" registered
15:26:59.105 sip_endpoint.c .Module "mod-tsx-layer" registered
15:26:59.105 sip_endpoint.c .Module "mod-stateful-util" registered
15:26:59.105 sip_endpoint.c .Module "mod-ua" registered
15:26:59.105 sip_endpoint.c .Module "mod-100rel" registered
15:26:59.105 sip_endpoint.c .Module "mod-pjsua" registered
15:26:59.106 sip_endpoint.c .Module "mod-invite" registered
15:26:59.106 pjlib ..select() I/O Queue created (0x556c963fb718)
15:26:59.106 conference.c ..Creating conference bridge with 254 ports
15:26:59.106 Master/sound ..Using delay buffer with WSOLA.
15:26:59.110 sip_endpoint.c .Module "mod-evsub" registered
15:26:59.110 sip_endpoint.c .Module "mod-presence" registered
15:26:59.110 evsub.c .Event pkg "presence" registered by mod-presence
15:26:59.110 sip_endpoint.c .Module "mod-mwi" registered
15:26:59.110 evsub.c .Event pkg "message-summary" registered by mod-mwi
15:26:59.110 sip_endpoint.c .Module "mod-refer" registered
15:26:59.110 evsub.c .Event pkg "refer" registered by mod-refer
15:26:59.110 sip_endpoint.c .Module "mod-pjsua-pres" registered
15:26:59.110 sip_endpoint.c .Module "mod-pjsua-im" registered
15:26:59.110 sip_endpoint.c .Module "mod-pjsua-options" registered
15:26:59.110 pjsua_core.c .1 SIP worker threads created
15:26:59.110 pjsua_core.c .pjsua version 2.8-svn for Linux-4.9.0.8/x86_64/glibc-2.24 initialized
15:26:59.110 pjsua_core.c .PJSUA state changed: CREATED --> INIT
15:26:59.110 sip_endpoint.c Module "mod-default-handler" registered
15:26:59.116 pjsua_core.c SIP UDP socket reachable at 192.168.2.111:5060
15:26:59.116 udp0x556c964140e0 SIP UDP transport started, published address is 192.168.2.111:5060
15:26:59.116 pjsua_acc.c Adding account: id=<sip:192.168.2.111:5060>
15:26:59.116 pjsua_acc.c .Account <sip:192.168.2.111:5060> added with id 0
15:26:59.116 pjsua_acc.c Modifying account 0
15:26:59.116 pjsua_acc.c Acc 0: setting online status to 1..
15:26:59.121 tcptp:5060 SIP TCP listener ready for incoming connections at 192.168.2.111:5060
15:26:59.121 pjsua_acc.c Adding account: id=<sip:192.168.2.111:5060;transport=TCP>
15:26:59.121 pjsua_acc.c .Account <sip:192.168.2.111:5060;transport=TCP> added with id 1
15:26:59.121 pjsua_acc.c Modifying account 1
15:26:59.121 pjsua_acc.c Acc 1: setting online status to 1..
15:26:59.125 tlstp:5061 SIP TLS listener is ready for incoming connections at 192.168.2.111:5061
15:26:59.125 pjsua_acc.c Adding account: id=<sip:192.168.2.111:5061;transport=TLS>
15:26:59.125 pjsua_acc.c .Account <sip:192.168.2.111:5061;transport=TLS> added with id 2
15:26:59.125 pjsua_acc.c Modifying account 2
15:26:59.125 pjsua_acc.c Acc 2: setting online status to 1..
15:26:59.125 pjsua_acc.c Adding account: id=sips:405277@sip.odorik.cz
15:26:59.125 pjsua_acc.c .Account sips:405277@sip.odorik.cz added with id 3
15:26:59.125 pjsua_acc.c Acc 3: setting online status to 1..
15:26:59.125 pjsua_pres.c Adding buddy: sips:*412879@sip.odorik.cz
15:26:59.125 pjsua_pres.c .Buddy 0 added.
15:26:59.125 pjsua_pres.c ..Buddy 0: updating presence..
15:26:59.125 pjsua_aud.c Setting null sound device..
15:26:59.125 pjsua_app.c .Turning sound device -99 -99 ON
15:26:59.125 pjsua_aud.c .Opening null sound device..
15:26:59.125 pjsua_core.c PJSUA state changed: INIT --> STARTING
15:26:59.125 sip_endpoint.c .Module "mod-unsolicited-mwi" registered
15:26:59.125 pjsua_core.c .PJSUA state changed: STARTING --> RUNNING
15:26:59.125 main.c Ready: Success
15:26:59.125 pjsua_call.c Making call with acc #3 to sips:*412879@sip.odorik.cz
15:26:59.130 tlsc0x556c9641dfa8 .TLS client transport created
15:26:59.130 tlsc0x556c9641dfa8 .TLS transport 192.168.2.111:53517 is connecting to sip.odorik.cz:5061...
15:26:59.130 dlg0x556c9641fa48 .UAC dialog created
15:26:59.135 dlg0x556c9641fa48 ..Session count inc to 2 by mod-pjsua
15:26:59.135 pjsua_media.c .Call 0: initializing media..
15:26:59.139 pjsua_media.c ..RTP socket reachable at 192.168.2.111:4000
15:26:59.139 pjsua_media.c ..RTCP socket reachable at 192.168.2.111:4001
15:26:59.139 srtp0x556c96423a20 ..SRTP keying SDES created
15:26:59.139 pjsua_media.c ..Media index 0 selected for audio call 0
15:26:59.140 pjsua_media.c ..Call 0: media transport initialization complete: Success
15:26:59.140 dlg0x556c9641fa48 ..Session count dec to 2 by mod-pjsua
15:26:59.140 srtp0x556c96423a20 .SRTP uses keying method SDES
15:26:59.140 dlg0x556c9641fa48 .Module mod-invite added as dialog usage, data=0x556c96425e18
15:26:59.140 dlg0x556c9641fa48 ..Session count inc to 4 by mod-invite
15:26:59.140 dlg0x556c9641fa48 .Module mod-100rel added as dialog usage, data=0x556c96428220
15:26:59.140 dlg0x556c9641fa48 .100rel module attached
15:26:59.140 inv0x556c9641fa48 .UAC invite session created for dialog dlg0x556c9641fa48
15:26:59.140 endpoint .Request msg INVITE/cseq=15573 (tdta0x556c96428568) created.
15:26:59.140 inv0x556c9641fa48 ..Sending Request msg INVITE/cseq=15573 (tdta0x556c96428568)
15:26:59.140 dlg0x556c9641fa48 ...Sending Request msg INVITE/cseq=15573 (tdta0x556c96428568)
15:26:59.140 tsx0x556c9642b4d8 ....Transaction created for Request msg INVITE/cseq=15572 (tdta0x556c96428568)
15:26:59.140 tsx0x556c9642b4d8 ...Sending Request msg INVITE/cseq=15572 (tdta0x556c96428568) in state Null
15:26:59.140 sip_resolve.c ....DNS resolver not available, target 'sip.odorik.cz:0' type=TLS will be resolved with getaddrinfo()
15:26:59.144 sip_resolve.c ....Target 'sip.odorik.cz:0' type=TLS resolved to '81.31.45.51:5061' type=TLS (TLS transport)
15:26:59.144 pjsua_core.c ....TX 1644 bytes Request msg INVITE/cseq=15572 (tdta0x556c96428568) to TLS 81.31.45.51:5061:
INVITE sips:*412879@sip.odorik.cz SIP/2.0
Via: SIP/2.0/TLS 192.168.2.111:53517;rport;branch=z9hG4bKPj2nN28.PXXsGw8vXIXIb70ES304ZrY8wq;alias
Max-Forwards: 70
From: sips:405277@sip.odorik.cz;tag=C3nkkXpG3tTT3es.ol6CDn94e2Hk2RpS
To: sips:*412879@sip.odorik.cz
Contact: <sips:405277@192.168.2.111:53517;transport=TLS;ob>
Call-ID: d8dVCzU5H23u.i6eiIJsjJaU9nj0UJ9-
CSeq: 15572 INVITE
Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS
Supported: replaces, 100rel, timer, norefersub
Session-Expires: 1800
Min-SE: 90
User-Agent: PJSUA v2.8-svn Linux-4.9.0.8/x86_64/glibc-2.24
Content-Type: application/sdp
Content-Length: 961
v=0
o=- 3761648819 3761648819 IN IP4 192.168.2.111
s=pjmedia
b=AS:117
t=0 0
a=X-nat:0
m=audio 4000 RTP/SAVP 98 97 99 104 3 0 8 9 120 96
c=IN IP4 192.168.2.111
b=TIAS:96000
a=rtcp:4001 IN IP4 192.168.2.111
a=sendrecv
a=rtpmap:98 speex/16000
a=rtpmap:97 speex/8000
a=rtpmap:99 speex/32000
a=rtpmap:104 iLBC/8000
a=fmtp:104 mode=30
a=rtpmap:3 GSM/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:9 G722/8000
a=rtpmap:120 opus/48000/2
a=fmtp:120 useinbandfec=1
a=rtpmap:96 telephone-event/8000
a=fmtp:96 0-16
a=ssrc:698982219 cname:0629d1f05b40e9d3
a=crypto:1 AES_256_CM_HMAC_SHA1_80 inline:LMYPMX09hAjNdtDlM4rk4kk5BoKqjMjvtwzO6so9pYiLfWbLu6GJyyefc9rF8A==
a=crypto:2 AES_256_CM_HMAC_SHA1_32 inline:rvB4OdvjFQYe62d7i84H72viCEzdRMPu4XDYbnnaC0I7EERl0/WommACFbstJA==
a=crypto:3 AES_CM_128_HMAC_SHA1_80 inline:y89ybfcvUE6lifPWvK6o5TjhM+wQ7z2uBhMrjzgU
a=crypto:4 AES_CM_128_HMAC_SHA1_32 inline:YUlHRq8qDMd4ZWwihCUgso47Ywzpzp7A/xhnW6/B
--end msg--
15:26:59.144 tsx0x556c9642b4d8 ....State changed from Null to Calling, event=TX_MSG
15:26:59.144 dlg0x556c9641fa48 .....Transaction tsx0x556c9642b4d8 state changed to Calling
15:26:59.144 pjsua_app.c .......Call 0 state changed to CALLING
15:26:59.169 pjsua_app.c !SIP TLS transport is connected to sip.odorik.cz:5061
15:26:59.169 pjsua_app.c TLS cipher used: 0x00009D/AES256-GCM-SHA384
15:26:59.169 pjsua_app.c TLS cert info of sip.odorik.cz:5061:
Version : v3
Serial : 01
Subject : sip.odorik.cz
/C=CZ/ST=Czech Republic/O=miniTEL s.r.o./OU=odorik.cz/CN=sip.odorik.cz/emailAddress=kontakt@odorik.cz
Issuer : OdorikCA
/CN=OdorikCA/ST=Czech Republic/C=CZ/emailAddress=kontakt@minitel.cz/O=miniTEL s.r.o.
Valid from : Tue 2016-04-26 15:24:51.000 GMT
Valid to : Wed 2055-09-29 15:24:51.000 GMT
15:26:59.169 pjsua_app.c TLS cert verification result of sip.odorik.cz:5061 :
15:26:59.169 pjsua_app.c - The certificate is untrusted
15:26:59.169 pjsua_app.c - Unknown verification error
15:26:59.169 pjsua_app.c PJSUA is configured to ignore TLS cert verification errors
15:26:59.169 tlsc0x556c9641dfa8 TLS transport 192.168.2.111:53517 is connected to sip.odorik.cz:5061
15:26:59.180 sip_endpoint.c Processing incoming message: Response msg 407/INVITE/cseq=15572 (rdata0x556c9641e2c0)
15:26:59.180 pjsua_core.c .RX 492 bytes Response msg 407/INVITE/cseq=15572 (rdata0x556c9641e2c0) from TLS 81.31.45.51:5061:
SIP/2.0 407 Proxy Authentication Required
Via: SIP/2.0/TLS 192.168.2.111:53517;rport=53517;branch=z9hG4bKPj2nN28.PXXsGw8vXIXIb70ES304ZrY8wq;alias;received=85.135.106.202
From: sips:405277@sip.odorik.cz;tag=C3nkkXpG3tTT3es.ol6CDn94e2Hk2RpS
To: sips:*412879@sip.odorik.cz;tag=d9f55a8611ba6e9295acea97d3a19a47.7e28
Call-ID: d8dVCzU5H23u.i6eiIJsjJaU9nj0UJ9-
CSeq: 15572 INVITE
Proxy-Authenticate: Digest realm="sip.odorik.cz", nonce="XIu4rFyLt4CSpS5vODfOyoetwAYszLT0"
Content-Length: 0
--end msg--
15:26:59.180 tsx0x556c9642b4d8 .Incoming Response msg 407/INVITE/cseq=15572 (rdata0x556c9641e2c0) in state Calling
15:26:59.180 endpoint ..Request msg ACK/cseq=15572 (tdta0x7fe4b4022048) created.
15:26:59.180 pjsua_core.c ..TX 383 bytes Request msg ACK/cseq=15572 (tdta0x7fe4b4022048) to TLS 81.31.45.51:5061:
ACK sips:*412879@sip.odorik.cz SIP/2.0
Via: SIP/2.0/TLS 192.168.2.111:53517;rport;branch=z9hG4bKPj2nN28.PXXsGw8vXIXIb70ES304ZrY8wq;alias
Max-Forwards: 70
From: sips:405277@sip.odorik.cz;tag=C3nkkXpG3tTT3es.ol6CDn94e2Hk2RpS
To: sips:*412879@sip.odorik.cz;tag=d9f55a8611ba6e9295acea97d3a19a47.7e28
Call-ID: d8dVCzU5H23u.i6eiIJsjJaU9nj0UJ9-
CSeq: 15572 ACK
Content-Length: 0
--end msg--
15:26:59.180 tsx0x556c9642b4d8 ..State changed from Calling to Completed, event=RX_MSG
15:26:59.180 dlg0x556c9641fa48 ...Received Response msg 407/INVITE/cseq=15572 (rdata0x556c9641e2c0)
15:26:59.180 dlg0x556c9641fa48 ...Transaction tsx0x556c9642b4d8 state changed to Completed
15:26:59.180 inv0x556c9641fa48 .....Sending Request msg INVITE/cseq=15572 (tdta0x556c96428568)
15:26:59.180 dlg0x556c9641fa48 ......Sending Request msg INVITE/cseq=15572 (tdta0x556c96428568)
15:26:59.180 tsx0x7fe4b4024fa8 .......Transaction created for Request msg INVITE/cseq=15573 (tdta0x556c96428568)
15:26:59.180 tsx0x7fe4b4024fa8 ......Sending Request msg INVITE/cseq=15573 (tdta0x556c96428568) in state Null
15:26:59.180 endpoint .......Request msg INVITE/cseq=15573 (tdta0x556c96428568): skipping target resolution because address is already set
15:26:59.180 pjsua_core.c .......TX 1835 bytes Request msg INVITE/cseq=15573 (tdta0x556c96428568) to TLS 81.31.45.51:5061:
INVITE sips:*412879@sip.odorik.cz SIP/2.0
Via: SIP/2.0/TLS 192.168.2.111:53517;rport;branch=z9hG4bKPjeCYOscGOcvHMlMPfkl1RLki-tOcUziq5;alias
Max-Forwards: 70
From: sips:405277@sip.odorik.cz;tag=C3nkkXpG3tTT3es.ol6CDn94e2Hk2RpS
To: sips:*412879@sip.odorik.cz
Contact: <sips:405277@192.168.2.111:53517;transport=TLS;ob>
Call-ID: d8dVCzU5H23u.i6eiIJsjJaU9nj0UJ9-
CSeq: 15573 INVITE
Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS
Supported: replaces, 100rel, timer, norefersub
Session-Expires: 1800
Min-SE: 90
User-Agent: PJSUA v2.8-svn Linux-4.9.0.8/x86_64/glibc-2.24
Proxy-Authorization: Digest username="405277", realm="sip.odorik.cz", nonce="XIu4rFyLt4CSpS5vODfOyoetwAYszLT0", uri="sips:*412879@sip.odorik.cz", response="18ef0093ae151dd1b34c5047a798bbe6"
Content-Type: application/sdp
Content-Length: 961
v=0
o=- 3761648819 3761648819 IN IP4 192.168.2.111
s=pjmedia
b=AS:117
t=0 0
a=X-nat:0
m=audio 4000 RTP/SAVP 98 97 99 104 3 0 8 9 120 96
c=IN IP4 192.168.2.111
b=TIAS:96000
a=rtcp:4001 IN IP4 192.168.2.111
a=sendrecv
a=rtpmap:98 speex/16000
a=rtpmap:97 speex/8000
a=rtpmap:99 speex/32000
a=rtpmap:104 iLBC/8000
a=fmtp:104 mode=30
a=rtpmap:3 GSM/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:9 G722/8000
a=rtpmap:120 opus/48000/2
a=fmtp:120 useinbandfec=1
a=rtpmap:96 telephone-event/8000
a=fmtp:96 0-16
a=ssrc:698982219 cname:0629d1f05b40e9d3
a=crypto:1 AES_256_CM_HMAC_SHA1_80 inline:LMYPMX09hAjNdtDlM4rk4kk5BoKqjMjvtwzO6so9pYiLfWbLu6GJyyefc9rF8A==
a=crypto:2 AES_256_CM_HMAC_SHA1_32 inline:rvB4OdvjFQYe62d7i84H72viCEzdRMPu4XDYbnnaC0I7EERl0/WommACFbstJA==
a=crypto:3 AES_CM_128_HMAC_SHA1_80 inline:y89ybfcvUE6lifPWvK6o5TjhM+wQ7z2uBhMrjzgU
a=crypto:4 AES_CM_128_HMAC_SHA1_32 inline:YUlHRq8qDMd4ZWwihCUgso47Ywzpzp7A/xhnW6/B
--end msg--
15:26:59.180 tsx0x7fe4b4024fa8 .......State changed from Null to Calling, event=TX_MSG
15:26:59.180 dlg0x556c9641fa48 ........Transaction tsx0x7fe4b4024fa8 state changed to Calling
15:26:59.180 tsx0x556c9642b4d8 Timeout timer event
15:26:59.180 tsx0x556c9642b4d8 .State changed from Completed to Terminated, event=TIMER
15:26:59.180 dlg0x556c9641fa48 ..Transaction tsx0x556c9642b4d8 state changed to Terminated
15:26:59.180 tsx0x556c9642b4d8 Timeout timer event
15:26:59.180 tsx0x556c9642b4d8 .State changed from Terminated to Destroyed, event=TIMER
15:26:59.181 tdta0x7fe4b4022048 ..Destroying txdata Request msg ACK/cseq=15572 (tdta0x7fe4b4022048)
15:26:59.181 tsx0x556c9642b4d8 Transaction destroyed!
15:26:59.202 sip_endpoint.c Processing incoming message: Response msg 100/INVITE/cseq=15573 (rdata0x556c9641e2c0)
15:26:59.202 pjsua_core.c .RX 335 bytes Response msg 100/INVITE/cseq=15573 (rdata0x556c9641e2c0) from TLS 81.31.45.51:5061:
SIP/2.0 100 Trying
Via: SIP/2.0/TLS 192.168.2.111:53517;rport=53517;branch=z9hG4bKPjeCYOscGOcvHMlMPfkl1RLki-tOcUziq5;alias;received=85.135.106.202
From: sips:405277@sip.odorik.cz;tag=C3nkkXpG3tTT3es.ol6CDn94e2Hk2RpS
To: sips:*412879@sip.odorik.cz
Call-ID: d8dVCzU5H23u.i6eiIJsjJaU9nj0UJ9-
CSeq: 15573 INVITE
Content-Length: 0
--end msg--
15:26:59.202 tsx0x7fe4b4024fa8 .Incoming Response msg 100/INVITE/cseq=15573 (rdata0x556c9641e2c0) in state Calling
15:26:59.202 tsx0x7fe4b4024fa8 ..State changed from Calling to Proceeding, event=RX_MSG
15:26:59.202 dlg0x556c9641fa48 ...Received Response msg 100/INVITE/cseq=15573 (rdata0x556c9641e2c0)
15:26:59.202 dlg0x556c9641fa48 ...Transaction tsx0x7fe4b4024fa8 state changed to Proceeding
15:26:59.394 sip_endpoint.c Processing incoming message: Response msg 200/INVITE/cseq=15573 (rdata0x556c9641e2c0)
15:26:59.394 pjsua_core.c .RX 1245 bytes Response msg 200/INVITE/cseq=15573 (rdata0x556c9641e2c0) from TLS 81.31.45.51:5061:
SIP/2.0 200 OK
Via: SIP/2.0/TLS 192.168.2.111:53517;received=85.135.106.202;rport=53517;branch=z9hG4bKPjeCYOscGOcvHMlMPfkl1RLki-tOcUziq5;alias
Record-Route: <sips:*412879@81.31.45.51;r2=on;lr=on;ftag=C3nkkXpG3tTT3es.ol6CDn94e2Hk2RpS;did=73e5.e83f;nat=yes>
Record-Route: <sips:*412879@81.31.45.51:5061;transport=tls;r2=on;lr=on;ftag=C3nkkXpG3tTT3es.ol6CDn94e2Hk2RpS;did=73e5.e83f;nat=yes>
From: sips:405277@sip.odorik.cz;tag=C3nkkXpG3tTT3es.ol6CDn94e2Hk2RpS
To: sips:*412879@sip.odorik.cz;tag=as059b3d29
Call-ID: d8dVCzU5H23u.i6eiIJsjJaU9nj0UJ9-
CSeq: 15573 INVITE
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces
Contact: <sips:*086*412879@81.31.45.59:5060;alias=81.31.45.59~5060~1>
Content-Type: application/sdp
Content-Length: 444
v=0
o=root 815884359 815884359 IN IP4 81.31.45.59
s=-
c=IN IP4 81.31.45.59
t=0 0
m=audio 13010 RTP/SAVP 8 97 3 104 9 96
a=rtpmap:8 PCMA/8000
a=rtpmap:97 speex/8000
a=rtpmap:3 GSM/8000
a=rtpmap:104 iLBC/8000
a=fmtp:104 mode=30
a=rtpmap:9 G722/8000
a=rtpmap:96 telephone-event/8000
a=fmtp:96 0-16
a=silenceSupp:off - - - -
a=ptime:20
a=sendrecv
a=crypto:3 AES_CM_128_HMAC_SHA1_80 inline:U77xcr7Y8lQ3nksege5+vZ4Ht4mOq9ky3VwAYR0A
--end msg--
15:26:59.394 tsx0x7fe4b4024fa8 .Incoming Response msg 200/INVITE/cseq=15573 (rdata0x556c9641e2c0) in state Proceeding
15:26:59.394 tsx0x7fe4b4024fa8 ..State changed from Proceeding to Terminated, event=RX_MSG
15:26:59.394 dlg0x556c9641fa48 ...Received Response msg 200/INVITE/cseq=15573 (rdata0x556c9641e2c0)
15:26:59.395 dlg0x556c9641fa48 ....Route-set updated
15:26:59.395 dlg0x556c9641fa48 ....Route-set frozen
15:26:59.395 dlg0x556c9641fa48 ...Transaction tsx0x7fe4b4024fa8 state changed to Terminated
15:26:59.395 pjsua_app.c .....Call 0 state changed to CONNECTING
15:26:59.395 inv0x556c9641fa48 ....Got SDP answer in Response msg 200/INVITE/cseq=15573 (rdata0x556c9641e2c0)
15:26:59.395 inv0x556c9641fa48 ....SDP negotiation done, status=0
15:26:59.395 pjsua_call.c .....Call 0: remote NAT type is 0 (Unknown)
15:26:59.395 pjsua_media.c .....Call 0: updating media..
15:26:59.395 pjsua_media.c .......Media stream call00:0 is destroyed
15:26:59.395 srtp0x556c96423a20 ......TX: AES_CM_128_HMAC_SHA1_80 key=y89ybfcvUE6lifPWvK6o5TjhM+wQ7z2uBhMrjzgU
15:26:59.395 srtp0x556c96423a20 ......RX: AES_CM_128_HMAC_SHA1_80 key=U77xcr7Y8lQ3nksege5+vZ4Ht4mOq9ky3VwAYR0A
15:26:59.395 srtp0x556c96423a20 ......SRTP started, keying=SDES, crypto=AES_CM_128_HMAC_SHA1_80
15:26:59.395 pjsua_aud.c ......Audio channel update..
15:26:59.395 strm0x7fe4b4036f48 .......VAD temporarily disabled
15:26:59.395 rtp.c .......pjmedia_rtp_session_init: ses=0x7fe4b40395d0, default_pt=8, ssrc=0x29a99f4b
15:26:59.395 rtp.c .......pjmedia_rtp_session_init: ses=0x7fe4b4039c50, default_pt=8, ssrc=0x29a99f4b
15:26:59.395 stream.c .......Stream strm0x7fe4b4036f48 created
15:26:59.395 strm0x7fe4b4036f48 .......Encoder stream started
15:26:59.395 strm0x7fe4b4036f48 .......Decoder stream started
15:26:59.395 resample.c .......resample created: high qualiy, large filter, in/out rate=8000/16000
15:26:59.395 resample.c .......resample created: high qualiy, large filter, in/out rate=16000/8000
15:26:59.395 pjsua_media.c ......Audio updated, stream #0: PCMA (sendrecv)
15:26:59.395 pjsua_app.c .....Call 0 media 0 [type=audio], status is Active
15:26:59.395 pjsua_aud.c .....Conf connect: 3 --> 0
15:26:59.395 conference.c ......Port 3 (sips:*412879@sip.odorik.cz) transmitting to port 0 (Master/sound)
15:26:59.395 pjsua_aud.c .....Conf connect: 0 --> 3
15:26:59.395 conference.c ......Port 0 (Master/sound) transmitting to port 3 (sips:*412879@sip.odorik.cz)
15:26:59.395 inv0x556c9641fa48 ....Received Response msg 200/INVITE/cseq=15573 (rdata0x556c9641e2c0), sending ACK
15:26:59.395 endpoint ....Request msg ACK/cseq=15573 (tdta0x7fe4b403c308) created.
15:26:59.395 dlg0x556c9641fa48 .....Sending Request msg ACK/cseq=15573 (tdta0x7fe4b403c308)
15:26:59.395 sip_resolve.c .....Target '81.31.45.51:5061' type=TLS resolved to '81.31.45.51:5061' type=TLS (TLS transport)
15:26:59.395 pjsua_core.c .....TX 615 bytes Request msg ACK/cseq=15573 (tdta0x7fe4b403c308) to TLS 81.31.45.51:5061:
ACK sips:*086*412879@81.31.45.59:5060;alias=81.31.45.59~5060~1 SIP/2.0
Via: SIP/2.0/TLS 192.168.2.111:53517;rport;branch=z9hG4bKPj6YgDNpH4ate.g3O7vnbaMuFugkRHC.Px;alias
Max-Forwards: 70
From: sips:405277@sip.odorik.cz;tag=C3nkkXpG3tTT3es.ol6CDn94e2Hk2RpS
To: sips:*412879@sip.odorik.cz;tag=as059b3d29
Call-ID: d8dVCzU5H23u.i6eiIJsjJaU9nj0UJ9-
CSeq: 15573 ACK
Route: <sips:*412879@81.31.45.51:5061;transport=tls;lr;r2=on;ftag=C3nkkXpG3tTT3es.ol6CDn94e2Hk2RpS;did=73e5.e83f;nat=yes>
Route: <sips:*412879@81.31.45.51;lr;r2=on;ftag=C3nkkXpG3tTT3es.ol6CDn94e2Hk2RpS;did=73e5.e83f;nat=yes>
Content-Length: 0
--end msg--
15:26:59.395 pjsua_app.c .....Call 0 state changed to CONFIRMED
15:26:59.395 pjsua_call.c .Call 0 sending re-INVITE for updating media session to use only one codec
15:26:59.395 srtp0x556c96423a20 .SRTP uses keying method SDES
15:26:59.395 endpoint ..Request msg INVITE/cseq=15575 (tdta0x7fe4b4041898) created.
15:26:59.395 inv0x556c9641fa48 ..Sending Request msg INVITE/cseq=15575 (tdta0x7fe4b4041898)
15:26:59.395 dlg0x556c9641fa48 ...Sending Request msg INVITE/cseq=15575 (tdta0x7fe4b4041898)
15:26:59.395 tsx0x7fe4b4044808 ....Transaction created for Request msg INVITE/cseq=15574 (tdta0x7fe4b4041898)
15:26:59.395 tsx0x7fe4b4044808 ...Sending Request msg INVITE/cseq=15574 (tdta0x7fe4b4041898) in state Null
15:26:59.395 sip_resolve.c ....Target '81.31.45.51:5061' type=TLS resolved to '81.31.45.51:5061' type=TLS (TLS transport)
15:26:59.395 pjsua_core.c ....TX 1298 bytes Request msg INVITE/cseq=15574 (tdta0x7fe4b4041898) to TLS 81.31.45.51:5061:
INVITE sips:*086*412879@81.31.45.59:5060;alias=81.31.45.59~5060~1 SIP/2.0
Via: SIP/2.0/TLS 192.168.2.111:53517;rport;branch=z9hG4bKPj.CKNK29H2JUW1v5pp1UEYbARap-3LJ.i;alias
Max-Forwards: 70
From: sips:405277@sip.odorik.cz;tag=C3nkkXpG3tTT3es.ol6CDn94e2Hk2RpS
To: sips:*412879@sip.odorik.cz;tag=as059b3d29
Contact: <sips:405277@192.168.2.111:53517;transport=TLS;ob>
Call-ID: d8dVCzU5H23u.i6eiIJsjJaU9nj0UJ9-
CSeq: 15574 INVITE
Route: <sips:*412879@81.31.45.51:5061;transport=tls;lr;r2=on;ftag=C3nkkXpG3tTT3es.ol6CDn94e2Hk2RpS;did=73e5.e83f;nat=yes>
Route: <sips:*412879@81.31.45.51;lr;r2=on;ftag=C3nkkXpG3tTT3es.ol6CDn94e2Hk2RpS;did=73e5.e83f;nat=yes>
Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS
Supported: replaces, 100rel, timer, norefersub
Session-Expires: 1800
Min-SE: 90
Content-Type: application/sdp
Content-Length: 401
v=0
o=- 3761648819 3761648820 IN IP4 192.168.2.111
s=pjmedia
b=AS:117
t=0 0
a=X-nat:0
m=audio 4000 RTP/SAVP 8 96
c=IN IP4 192.168.2.111
b=TIAS:96000
a=rtcp:4001 IN IP4 192.168.2.111
a=ssrc:698982219 cname:0629d1f05b40e9d3
a=crypto:1 AES_CM_128_HMAC_SHA1_80 inline:y89ybfcvUE6lifPWvK6o5TjhM+wQ7z2uBhMrjzgU
a=rtpmap:8 PCMA/8000
a=rtpmap:96 telephone-event/8000
a=fmtp:96 0-16
a=sendrecv
--end msg--
15:26:59.396 tsx0x7fe4b4044808 ....State changed from Null to Calling, event=TX_MSG
15:26:59.396 dlg0x556c9641fa48 .....Transaction tsx0x7fe4b4044808 state changed to Calling
15:26:59.396 tsx0x7fe4b4024fa8 Timeout timer event
15:26:59.396 tsx0x7fe4b4024fa8 .State changed from Terminated to Destroyed, event=TIMER
15:26:59.396 tsx0x7fe4b4024fa8 Transaction destroyed!
15:26:59.406 strm0x7fe4b4036f48 !Jitter buffer is bufferring (prefetch=0)
15:26:59.406 strm0x7fe4b4036f48 Start talksprut..
15:26:59.456 sip_endpoint.c !Processing incoming message: Response msg 100/INVITE/cseq=15574 (rdata0x556c9641e2c0)
15:26:59.456 pjsua_core.c .RX 350 bytes Response msg 100/INVITE/cseq=15574 (rdata0x556c9641e2c0) from TLS 81.31.45.51:5061:
SIP/2.0 100 Trying
Via: SIP/2.0/TLS 192.168.2.111:53517;rport=53517;branch=z9hG4bKPj.CKNK29H2JUW1v5pp1UEYbARap-3LJ.i;alias;received=85.135.106.202
From: sips:405277@sip.odorik.cz;tag=C3nkkXpG3tTT3es.ol6CDn94e2Hk2RpS
To: sips:*412879@sip.odorik.cz;tag=as059b3d29
Call-ID: d8dVCzU5H23u.i6eiIJsjJaU9nj0UJ9-
CSeq: 15574 INVITE
Content-Length: 0
--end msg--
15:26:59.456 tsx0x7fe4b4044808 .Incoming Response msg 100/INVITE/cseq=15574 (rdata0x556c9641e2c0) in state Calling
15:26:59.456 tsx0x7fe4b4044808 ..State changed from Calling to Proceeding, event=RX_MSG
15:26:59.456 dlg0x556c9641fa48 ...Received Response msg 100/INVITE/cseq=15574 (rdata0x556c9641e2c0)
15:26:59.456 dlg0x556c9641fa48 ...Transaction tsx0x7fe4b4044808 state changed to Proceeding
15:26:59.458 sip_endpoint.c Processing incoming message: Response msg 200/INVITE/cseq=15574 (rdata0x556c9641e2c0)
15:26:59.458 pjsua_core.c .RX 1115 bytes Response msg 200/INVITE/cseq=15574 (rdata0x556c9641e2c0) from TLS 81.31.45.51:5061:
SIP/2.0 200 OK
Via: SIP/2.0/TLS 192.168.2.111:53517;received=85.135.106.202;rport=53517;branch=z9hG4bKPj.CKNK29H2JUW1v5pp1UEYbARap-3LJ.i;alias
Record-Route: <sips:*086*412879@81.31.45.51;r2=on;lr=on;ftag=C3nkkXpG3tTT3es.ol6CDn94e2Hk2RpS;did=73e5.e83f>
Record-Route: <sips:*086*412879@81.31.45.51:5061;transport=tls;r2=on;lr=on;ftag=C3nkkXpG3tTT3es.ol6CDn94e2Hk2RpS;did=73e5.e83f>
From: sips:405277@sip.odorik.cz;tag=C3nkkXpG3tTT3es.ol6CDn94e2Hk2RpS
To: sips:*412879@sip.odorik.cz;tag=as059b3d29
Call-ID: d8dVCzU5H23u.i6eiIJsjJaU9nj0UJ9-
CSeq: 15574 INVITE
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces
Contact: <sips:*086*412879@81.31.45.59:5060;alias=81.31.45.59~5060~1>
Content-Type: application/sdp
Content-Length: 322
v=0
o=root 815884359 815884360 IN IP4 81.31.45.59
s=-
c=IN IP4 81.31.45.59
t=0 0
m=audio 13010 RTP/SAVP 8 96
a=rtpmap:8 PCMA/8000
a=rtpmap:96 telephone-event/8000
a=fmtp:96 0-16
a=silenceSupp:off - - - -
a=ptime:20
a=sendrecv
a=crypto:3 AES_CM_128_HMAC_SHA1_80 inline:U77xcr7Y8lQ3nksege5+vZ4Ht4mOq9ky3VwAYR0A
--end msg--
15:26:59.458 tsx0x7fe4b4044808 .Incoming Response msg 200/INVITE/cseq=15574 (rdata0x556c9641e2c0) in state Proceeding
15:26:59.458 tsx0x7fe4b4044808 ..State changed from Proceeding to Terminated, event=RX_MSG
15:26:59.458 dlg0x556c9641fa48 ...Received Response msg 200/INVITE/cseq=15574 (rdata0x556c9641e2c0)
15:26:59.458 dlg0x556c9641fa48 ...Transaction tsx0x7fe4b4044808 state changed to Terminated
15:26:59.458 inv0x556c9641fa48 ....Got SDP answer in Response msg 200/INVITE/cseq=15574 (rdata0x556c9641e2c0)
15:26:59.458 inv0x556c9641fa48 ....SDP negotiation done, status=0
15:26:59.458 pjsua_call.c .....Call 0: remote NAT type is 0 (Unknown)
15:26:59.458 pjsua_media.c .....Call 0: updating media..
15:26:59.458 strm0x7fe4b4036f48 .......JB summary:
size=0/eff=0 prefetch=0 level=0
delay (min/max/avg/dev)=0/0/0/0 ms
burst (min/max/avg/dev)=0/0/0/0 frames
lost=0 discard=0 empty=3
15:26:59.458 pjsua_media.c .......Media stream call00:0 is destroyed
15:26:59.458 pjsua_media.c ......pjmedia_transport_media_start() failed for call_id 0 media 0: Invalid SRTP crypto tag (PJMEDIA_SRTP_ESDPINCRYPTOTAG)
15:26:59.458 pjsua_media.c .......Media stream call00:0 is destroyed
15:26:59.458 pjsua_media.c ......Error updating media call00:0: Invalid SRTP crypto tag (PJMEDIA_SRTP_ESDPINCRYPTOTAG)
15:26:59.458 pjsua_app.c .....Call 0 media 0 [type=audio], status is Error
15:26:59.458 inv0x556c9641fa48 ....Received Response msg 200/INVITE/cseq=15574 (rdata0x556c9641e2c0), sending ACK
15:26:59.458 tdta0x7fe4b403c308 ....Destroying txdata Request msg ACK/cseq=15573 (tdta0x7fe4b403c308)
15:26:59.458 endpoint ....Request msg ACK/cseq=15574 (tdta0x7fe4b4023dc8) created.
15:26:59.458 dlg0x556c9641fa48 .....Sending Request msg ACK/cseq=15574 (tdta0x7fe4b4023dc8)
15:26:59.458 sip_resolve.c .....Target '81.31.45.51:5061' type=TLS resolved to '81.31.45.51:5061' type=TLS (TLS transport)
15:26:59.458 pjsua_core.c .....TX 615 bytes Request msg ACK/cseq=15574 (tdta0x7fe4b4023dc8) to TLS 81.31.45.51:5061:
ACK sips:*086*412879@81.31.45.59:5060;alias=81.31.45.59~5060~1 SIP/2.0
Via: SIP/2.0/TLS 192.168.2.111:53517;rport;branch=z9hG4bKPjaRztjoV5cswhxYEhqicpselRgjF5AXpO;alias
Max-Forwards: 70
From: sips:405277@sip.odorik.cz;tag=C3nkkXpG3tTT3es.ol6CDn94e2Hk2RpS
To: sips:*412879@sip.odorik.cz;tag=as059b3d29
Call-ID: d8dVCzU5H23u.i6eiIJsjJaU9nj0UJ9-
CSeq: 15574 ACK
Route: <sips:*412879@81.31.45.51:5061;transport=tls;lr;r2=on;ftag=C3nkkXpG3tTT3es.ol6CDn94e2Hk2RpS;did=73e5.e83f;nat=yes>
Route: <sips:*412879@81.31.45.51;lr;r2=on;ftag=C3nkkXpG3tTT3es.ol6CDn94e2Hk2RpS;did=73e5.e83f;nat=yes>
Content-Length: 0
--end msg--
15:26:59.458 tsx0x7fe4b4044808 Timeout timer event
15:26:59.458 tsx0x7fe4b4044808 .State changed from Terminated to Destroyed, event=TIMER
15:26:59.458 tdta0x7fe4b4041898 ..Destroying txdata Request msg INVITE/cseq=15574 (tdta0x7fe4b4041898)
15:26:59.458 tsx0x7fe4b4044808 Transaction destroyed!
15:27:15.743 sip_endpoint.c Processing incoming message: Request msg BYE/cseq=102 (rdata0x556c9641e2c0)
15:27:15.743 pjsua_core.c .RX 455 bytes Request msg BYE/cseq=102 (rdata0x556c9641e2c0) from TLS 81.31.45.51:5061:
BYE sips:405277@192.168.2.111:53517;transport=TLS;ob SIP/2.0
Via: SIP/2.0/TLS 81.31.45.51:5061;branch=z9hG4bK60d7.6fa56da1921fd59f8aa1cc02cf5db64e.0
Via: SIP/2.0/UDP 81.31.45.59:5060;received=81.31.45.59;branch=z9hG4bK24f53ee4;rport=5060
Max-Forwards: 69
From: sips:*412879@sip.odorik.cz;tag=as059b3d29
To: sips:405277@sip.odorik.cz;tag=C3nkkXpG3tTT3es.ol6CDn94e2Hk2RpS
Call-ID: d8dVCzU5H23u.i6eiIJsjJaU9nj0UJ9-
CSeq: 102 BYE
Content-Length: 0
--end msg--
15:27:15.744 dlg0x556c9641fa48 .Received Request msg BYE/cseq=102 (rdata0x556c9641e2c0)
15:27:15.744 tsx0x7fe4b4022ff8 ...Transaction created for Request msg BYE/cseq=102 (rdata0x556c9641e2c0)
15:27:15.744 tsx0x7fe4b4022ff8 ..Incoming Request msg BYE/cseq=102 (rdata0x556c9641e2c0) in state Null
15:27:15.744 tsx0x7fe4b4022ff8 ...State changed from Null to Trying, event=RX_MSG
15:27:15.744 dlg0x556c9641fa48 ....Transaction tsx0x7fe4b4022ff8 state changed to Trying
15:27:15.744 endpoint .....Response msg 200/BYE/cseq=102 (tdta0x7fe4b4038f18) created
15:27:15.744 dlg0x556c9641fa48 ......Sending Response msg 200/BYE/cseq=102 (tdta0x7fe4b4038f18)
15:27:15.744 tsx0x7fe4b4022ff8 ......Sending Response msg 200/BYE/cseq=102 (tdta0x7fe4b4038f18) in state Trying
15:27:15.744 pjsua_core.c .......TX 417 bytes Response msg 200/BYE/cseq=102 (tdta0x7fe4b4038f18) to TLS 81.31.45.51:5061:
SIP/2.0 200 OK
Via: SIP/2.0/TLS 81.31.45.51:5061;received=81.31.45.51;branch=z9hG4bK60d7.6fa56da1921fd59f8aa1cc02cf5db64e.0
Via: SIP/2.0/UDP 81.31.45.59:5060;rport=5060;received=81.31.45.59;branch=z9hG4bK24f53ee4
Call-ID: d8dVCzU5H23u.i6eiIJsjJaU9nj0UJ9-
From: <sips:*412879@sip.odorik.cz>;tag=as059b3d29
To: <sips:405277@sip.odorik.cz>;tag=C3nkkXpG3tTT3es.ol6CDn94e2Hk2RpS
CSeq: 102 BYE
Content-Length: 0
--end msg--
15:27:15.744 tsx0x7fe4b4022ff8 .......State changed from Trying to Completed, event=TX_MSG
15:27:15.744 dlg0x556c9641fa48 ........Transaction tsx0x7fe4b4022ff8 state changed to Completed
15:27:15.744 pjsua_app.c ......Call 0 is DISCONNECTED [reason=200 (Normal call clearing)]
15:27:15.744 pjsua_app.c ......Call 0 disconnected, dumping media stats..
15:27:15.744 pjsua_app_common.c ......
[DISCONNCTD] To: sips:*412879@sip.odorik.cz;tag=as059b3d29
Call time: 00h:00m:16s, 1st res in 269 ms, conn in 269ms
#0 audio deactivated
15:27:15.744 pjsua_media.c ......Call 0: deinitializing media..
15:27:15.744 pjsua_media.c ........Media stream call00:0 is destroyed
15:27:15.744 tdta0x7fe4b4023dc8 .....Destroying txdata Request msg ACK/cseq=15574 (tdta0x7fe4b4023dc8)
15:27:15.744 tdta0x556c96428568 .....Destroying txdata Request msg INVITE/cseq=15573 (tdta0x556c96428568)
15:27:15.745 dlg0x556c9641fa48 ......Session count dec to 3 by mod-invite
15:27:15.745 tsx0x7fe4b4022ff8 Timeout timer event
15:27:15.745 tsx0x7fe4b4022ff8 .State changed from Completed to Terminated, event=TIMER
15:27:15.745 dlg0x556c9641fa48 ..Transaction tsx0x7fe4b4022ff8 state changed to Terminated
15:27:15.745 dlg0x556c9641fa48 ...Dialog destroyed
15:27:15.745 tsx0x7fe4b4022ff8 Timeout timer event
15:27:15.745 tsx0x7fe4b4022ff8 .State changed from Terminated to Destroyed, event=TIMER
15:27:15.745 tdta0x7fe4b4038f18 ..Destroying txdata Response msg 200/BYE/cseq=102 (tdta0x7fe4b4038f18)
15:27:15.745 tsx0x7fe4b4022ff8 Transaction destroyed!
15:27:16.745 pjsua_aud.c Closing sound device after idle for 1 second(s)
15:27:16.745 pjsua_app.c .Turning sound device -99 -99 OFF
15:27:16.745 pjsua_aud.c .Closing null sound device..
15:27:20.627 pjsua_core.c !Shutting down, flags=0...
15:27:20.627 pjsua_core.c PJSUA state changed: RUNNING --> CLOSING
15:27:20.632 pjsua_call.c .Hangup all calls..
15:27:20.632 pjsua_media.c .Call 0: deinitializing media..
15:27:20.632 pjsua_media.c .Call 1: deinitializing media..
15:27:20.632 pjsua_media.c .Call 2: deinitializing media..
15:27:20.632 pjsua_media.c .Call 3: deinitializing media..
15:27:20.632 pjsua_pres.c .Shutting down presence..
15:27:21.647 pjsua_core.c .Destroying...
15:27:21.647 pjsua_media.c .Shutting down media..
15:27:21.705 sip_endpoint.c .Destroying endpoing instance..
15:27:21.705 sip_transaction.c .Stopping transaction layer module
15:27:21.705 sip_transaction.c .Stopped transaction layer module
15:27:21.705 sip_endpoint.c .Module "mod-default-handler" unregistered
15:27:21.706 sip_endpoint.c .Module "mod-unsolicited-mwi" unregistered
15:27:21.706 sip_endpoint.c .Module "mod-pjsua-options" unregistered
15:27:21.706 sip_endpoint.c .Module "mod-pjsua-im" unregistered
15:27:21.706 sip_endpoint.c .Module "mod-pjsua-pres" unregistered
15:27:21.706 sip_endpoint.c .Module "mod-pjsua" unregistered
15:27:21.706 sip_endpoint.c .Module "mod-stateful-util" unregistered
15:27:21.706 sip_endpoint.c .Module "mod-refer" unregistered
15:27:21.706 sip_endpoint.c .Module "mod-mwi" unregistered
15:27:21.706 sip_endpoint.c .Module "mod-presence" unregistered
15:27:21.706 sip_endpoint.c .Module "mod-evsub" unregistered
15:27:21.706 sip_endpoint.c .Module "mod-invite" unregistered
15:27:21.706 sip_endpoint.c .Module "mod-100rel" unregistered
15:27:21.706 sip_endpoint.c .Module "mod-ua" unregistered
15:27:21.706 sip_transaction.c .Transaction layer module destroyed
15:27:21.706 sip_endpoint.c .Module "mod-tsx-layer" unregistered
15:27:21.706 sip_endpoint.c .Module "mod-msg-print" unregistered
15:27:21.706 sip_endpoint.c .Module "mod-pjsua-log" unregistered
15:27:21.706 sip_transport.c .Destroying transport manager
15:27:21.709 udp0x556c964140e0 .SIP UDP transport destroyed
15:27:21.709 tlsc0x556c9641dfa8 .TLS transport destroyed normally
15:27:21.709 tcptp:5060 .SIP TCP transport destroyed
15:27:21.709 tlstp:5061 .SIP TLS transport destroyed
15:27:21.709 sip_endpoint.c .Endpoint 0x556c963e1928 destroyed
15:27:21.709 pjsua_core.c .PJSUA state changed: CLOSING --> NULL
15:27:21.709 pjsua_core.c .PJSUA destroyed...