VialerSIPLib icon indicating copy to clipboard operation
VialerSIPLib copied to clipboard

Account registered successfully but no call is initiating (No ringback tone nothing)

Open shadowwalkersteam opened this issue 3 years ago • 8 comments

Hi,

I have tried the example code, after compiling it on latest xcode 12.0 and iOS 14.0 I launched the application (from example code), it is registering the account and successfully but when I try to dial the number it doesn't give any ringback nothing and after sometime is shows disconnected etc. I don't know what is the issue, the server seems fine as I used the same configuration in my Android Application and there it is working fine absolutely fine. Below are the logs:

💙 INFO 16:15:41.134 [DDLogWrapper +[DDLogWrapper logInfo:]:40] Using UDP 💚 DEBUG 16:15:41.139 [VSLEndpoint -[VSLEndpoint startEndpointWithEndpointConfiguration:error:]:138] Creating new PJSIP Endpoint instance. 16:15:41.142 os_core_unix.c !pjlib 2.8 for POSIX initialized 16:15:41.143 sip_endpoint.c .Creating endpoint instance... 16:15:41.144 pjlib .select() I/O Queue created (0x10480ae28) 16:15:41.144 sip_endpoint.c .Module "mod-msg-print" registered 16:15:41.144 sip_transport.c .Transport manager created. 16:15:41.144 pjsua_core.c .PJSUA state changed: NULL --> CREATED 💚 DEBUG 16:15:41.145 [VSLEndpoint void logCallBack(int, const char *, int):567] sip_endpoint.c .Module "mod-pjsua-log" registered 💚 DEBUG 16:15:41.147 [VSLEndpoint void logCallBack(int, const char *, int):567] sip_endpoint.c .Module "mod-tsx-layer" registered 💚 DEBUG 16:15:41.147 [VSLEndpoint void logCallBack(int, const char *, int):567] sip_endpoint.c .Module "mod-stateful-util" registered 💚 DEBUG 16:15:41.148 [VSLEndpoint void logCallBack(int, const char *, int):567] sip_endpoint.c .Module "mod-ua" registered 💚 DEBUG 16:15:41.148 [VSLEndpoint void logCallBack(int, const char *, int):567] sip_endpoint.c .Module "mod-100rel" registered 💚 DEBUG 16:15:41.148 [VSLEndpoint void logCallBack(int, const char *, int):567] sip_endpoint.c .Module "mod-pjsua" registered 💚 DEBUG 16:15:41.149 [VSLEndpoint void logCallBack(int, const char *, int):567] sip_endpoint.c .Module "mod-invite" registered 💚 DEBUG 16:15:41.241 [VSLEndpoint void logCallBack(int, const char *, int):567] coreaudio_dev.c .. dev_id 0: iPhone IO device (in=1, out=1) 8000Hz 💚 DEBUG 16:15:41.242 [VSLEndpoint void logCallBack(int, const char *, int):567] coreaudio_dev.c ..core audio initialized 💚 DEBUG 16:15:41.243 [VSLEndpoint void logCallBack(int, const char *, int):567] pjlib ..select() I/O Queue created (0x10781e428) 💚 DEBUG 16:15:41.252 [VSLEndpoint void logCallBack(int, const char *, int):567] pjsua_vid.c ..Initializing video subsystem.. 💚 DEBUG 16:15:41.252 [VSLEndpoint void logCallBack(int, const char *, int):567] openh264.cpp ...OpenH264 codec initialized 💚 DEBUG 16:15:41.252 [VSLEndpoint void logCallBack(int, const char *, int):567] opengl_dev.c ...OpenGL device initialized 💚 DEBUG 16:15:41.306 [VSLEndpoint void logCallBack(int, const char *, int):567] darwin_dev.m ...Darwin video initialized with 3 devices: 💚 DEBUG 16:15:41.306 [VSLEndpoint void logCallBack(int, const char *, int):567] darwin_dev.m ... 0: [Renderer] iOS - UIView 💚 DEBUG 16:15:41.306 [VSLEndpoint void logCallBack(int, const char *, int):567] darwin_dev.m ... 1: [Capturer] AVF - Front Camera 💚 DEBUG 16:15:41.307 [VSLEndpoint void logCallBack(int, const char *, int):567] darwin_dev.m ... 2: [Capturer] AVF - Back Camera 💚 DEBUG 16:15:41.307 [VSLEndpoint void logCallBack(int, const char *, int):567] colorbar_dev.c ...Colorbar video src initialized with 2 device(s): 💚 DEBUG 16:15:41.307 [VSLEndpoint void logCallBack(int, const char *, int):567] colorbar_dev.c ... 0: Colorbar generator 💚 DEBUG 16:15:41.307 [VSLEndpoint void logCallBack(int, const char *, int):567] colorbar_dev.c ... 1: Colorbar-active 💚 DEBUG 16:15:41.308 [VSLEndpoint void logCallBack(int, const char *, int):567] sip_endpoint.c .Module "mod-evsub" registered 💚 DEBUG 16:15:41.308 [VSLEndpoint void logCallBack(int, const char *, int):567] sip_endpoint.c .Module "mod-presence" registered 💚 DEBUG 16:15:41.308 [VSLEndpoint void logCallBack(int, const char *, int):567] sip_endpoint.c .Module "mod-mwi" registered 💚 DEBUG 16:15:41.309 [VSLEndpoint void logCallBack(int, const char *, int):567] sip_endpoint.c .Module "mod-refer" registered 💚 DEBUG 16:15:41.309 [VSLEndpoint void logCallBack(int, const char *, int):567] sip_endpoint.c .Module "mod-pjsua-pres" registered 💚 DEBUG 16:15:41.309 [VSLEndpoint void logCallBack(int, const char *, int):567] sip_endpoint.c .Module "mod-pjsua-im" registered 💚 DEBUG 16:15:41.310 [VSLEndpoint void logCallBack(int, const char *, int):567] sip_endpoint.c .Module "mod-pjsua-options" registered 💚 DEBUG 16:15:41.310 [VSLEndpoint void logCallBack(int, const char *, int):567] pjsua_core.c .1 SIP worker threads created 💙 INFO 16:15:41.310 [VSLEndpoint void logCallBack(int, const char *, int):564] pjsua_core.c .pjsua version 2.8 for iOS-14.0.1/arm-iPhone10,6/iOS-SDK initialized 💚 DEBUG 16:15:41.310 [VSLEndpoint void logCallBack(int, const char *, int):567] pjsua_core.c .PJSUA state changed: CREATED --> INIT 💚 DEBUG 16:15:41.311 [VSLEndpoint void logCallBack(int, const char *, int):567] pjsua_core.c SIP UDP socket reachable at 10.5.0.2:63781 💚 DEBUG 16:15:41.311 [VSLEndpoint void logCallBack(int, const char *, int):567] udp0x103a1b6c0 SIP UDP transport started, published address is 10.5.0.2:63781 💚 DEBUG 16:15:41.311 [VSLEndpoint void logCallBack(int, const char *, int):567] pjsua_core.c PJSUA state changed: INIT --> STARTING 💚 DEBUG 16:15:41.311 [VSLEndpoint void logCallBack(int, const char *, int):567] sip_endpoint.c .Module "mod-unsolicited-mwi" registered 💚 DEBUG 16:15:41.312 [VSLEndpoint void logCallBack(int, const char *, int):567] pjsua_core.c .PJSUA state changed: STARTING --> RUNNING 💙 INFO 16:15:41.312 [VSLEndpoint -[VSLEndpoint startEndpointWithEndpointConfiguration:error:]:271] PJSIP Endpoint started succesfully 💚 DEBUG 16:15:41.312 [VSLEndpoint void logCallBack(int, const char *, int):567] pjsua_acc.c Adding account: id=sip:[email protected]:5060 💚 DEBUG 16:15:41.313 [VSLEndpoint void logCallBack(int, const char *, int):567] pjsua_acc.c .Account sip:[email protected]:5060 added with id 0 💙 INFO 16:15:41.313 [VSLAccount -[VSLAccount configureWithAccountConfiguration:error:]:189] Account added succesfully 💚 DEBUG 16:15:43.007 [VSLAccount -[VSLAccount registerAccountWithCompletion:]:231] Account valid: YES 💚 DEBUG 16:15:43.008 [VSLAccount -[VSLAccount registerAccountWithCompletion:]:232] Should force registration: NO 💜 VERBOSE 16:15:43.008 [VSLAccount -[VSLAccount registerAccountWithCompletion:]:259] Sending registration for account: 0 💚 DEBUG 16:15:43.008 [VSLEndpoint void logCallBack(int, const char *, int):567] pjsua_acc.c Acc 0: setting registration.. 💚 DEBUG 16:15:43.010 [VSLEndpoint void logCallBack(int, const char *, int):567] pjsua_core.c ..TX 534 bytes Request msg REGISTER/cseq=19983 (tdta0x108809ca8) to UDP 54.33.60.88:5060: REGISTER sip:54.33.60.88:5060 SIP/2.0

Via: SIP/2.0/UDP 10.5.0.2:63781;rport;branch=z9hG4bKPjgkwUEI.0Ooir4FJ3qSSOfl6.0k.NYmYz

Max-Forwards: 70

From: sip:[email protected];tag=oHDCxUNNAPoqBdvMAFcMPGINZmkexSyV

To: sip:[email protected]

Call-ID: CZuGDRLTayXHhUninh5tJzUk9Mrd0lc6

CSeq: 19983 REGISTER

User-Agent: VialerSIPLib Example App

Contact: sip:[email protected]:63781;ob

Expires: 800

Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS

Content-Length: 0

--end msg-- 💜 VERBOSE 16:15:43.039 [VSLEndpoint void onRegStarted2(pjsua_acc_id, pjsua_reg_info *):643] PJSUA callback: registration or unregistration has been initiated. 💚 DEBUG 16:15:43.039 [VSLEndpoint void logCallBack(int, const char *, int):567] pjsua_acc.c .Acc 0: Registration sent 💚 DEBUG 16:15:43.303 [VSLEndpoint void logCallBack(int, const char *, int):567] pjsua_core.c .RX 562 bytes Response msg 401/REGISTER/cseq=19983 (rdata0x10484fa28) from UDP 54.33.60.88:5060: SIP/2.0 401 Unauthorized

Via: SIP/2.0/UDP 10.5.0.2:63781;rport=63781;received=67.21.32.25;branch=z9hG4bKPjgkwUEI.0Ooir4FJ3qSSOfl6.0k.NYmYz

Call-ID: CZuGDRLTayXHhUninh5tJzUk9Mrd0lc6

From: sip:[email protected];tag=oHDCxUNNAPoqBdvMAFcMPGINZmkexSyV

To: sip:[email protected];tag=z9hG4bKPjgkwUEI.0Ooir4FJ3qSSOfl6.0k.NYmYz

CSeq: 19983 REGISTER

WWW-Authenticate: Digest realm="asterisk",nonce="1601896559/3b37cd8531feea76615353f90fe92f15",opaque="1a8a5d3937738875",algorithm=md5,qop="auth"

Server: Asterisk PBX 13.22.0-rc1

Content-Length: 0

--end msg-- 💙 INFO 16:15:43.321 [VSLEndpoint void logCallBack(int, const char *, int):564] pjsua_acc.c ....IP address change detected for account 0 (10.5.0.2:63781 --> 67.21.32.25:63781). Updating registration (using method 0) 💚 DEBUG 16:15:43.324 [VSLEndpoint void logCallBack(int, const char *, int):567] pjsua_core.c ....TX 837 bytes Request msg REGISTER/cseq=19984 (tdta0x108809ca8) to UDP 54.33.60.88:5060: REGISTER sip:54.33.60.88:5060 SIP/2.0

Via: SIP/2.0/UDP 67.21.32.25:63781;rport;branch=z9hG4bKPjxy3HeaJtRonw2igzL2EE5SieLSXPbvsM

Max-Forwards: 70

From: sip:[email protected];tag=oHDCxUNNAPoqBdvMAFcMPGINZmkexSyV

To: sip:[email protected]

Call-ID: CZuGDRLTayXHhUninh5tJzUk9Mrd0lc6

CSeq: 19984 REGISTER

User-Agent: VialerSIPLib Example App

Contact: sip:[email protected]:63781;ob

Expires: 800

Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS

Authorization: Digest username="abc123", realm="asterisk", nonce="1601896559/3b37cd8531feea76615353f90fe92f15", uri="sip:54.33.60.88:5060", response="1943f7d34cf730853766820a0279f274", algorithm=md5, cnonce="MheEtw.80s-Q1w2l6gVb08f133P7Fumt", opaque="1a8a5d3937738875", qop=auth, nc=00000001

Content-Length: 0

--end msg-- 💚 DEBUG 16:15:43.860 [VSLEndpoint void logCallBack(int, const char *, int):567] pjsua_core.c .TX 837 bytes Request msg REGISTER/cseq=19984 (tdta0x108809ca8) to UDP 54.33.60.88:5060: REGISTER sip:54.33.60.88:5060 SIP/2.0

Via: SIP/2.0/UDP 67.21.32.25:63781;rport;branch=z9hG4bKPjxy3HeaJtRonw2igzL2EE5SieLSXPbvsM

Max-Forwards: 70

From: sip:[email protected];tag=oHDCxUNNAPoqBdvMAFcMPGINZmkexSyV

To: sip:[email protected]

Call-ID: CZuGDRLTayXHhUninh5tJzUk9Mrd0lc6

CSeq: 19984 REGISTER

User-Agent: VialerSIPLib Example App

Contact: sip:[email protected]:63781;ob

Expires: 800

Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS

Authorization: Digest username="abc123", realm="asterisk", nonce="1601896559/3b37cd8531feea76615353f90fe92f15", uri="sip:54.33.60.88:5060", response="1943f7d34cf730853766820a0279f274", algorithm=md5, cnonce="MheEtw.80s-Q1w2l6gVb08f133P7Fumt", opaque="1a8a5d3937738875", qop=auth, nc=00000001

Content-Length: 0

--end msg-- 💚 DEBUG 16:15:44.153 [VSLEndpoint void logCallBack(int, const char *, int):567] pjsua_core.c .RX 459 bytes Response msg 200/REGISTER/cseq=19984 (rdata0x10405d628) from UDP 54.33.60.88:5060: SIP/2.0 200 OK

Via: SIP/2.0/UDP 67.21.32.25:63781;rport=63781;received=67.21.32.25;branch=z9hG4bKPjxy3HeaJtRonw2igzL2EE5SieLSXPbvsM

Call-ID: CZuGDRLTayXHhUninh5tJzUk9Mrd0lc6

From: sip:[email protected];tag=oHDCxUNNAPoqBdvMAFcMPGINZmkexSyV

To: sip:[email protected];tag=z9hG4bKPjxy3HeaJtRonw2igzL2EE5SieLSXPbvsM

CSeq: 19984 REGISTER

Date: Mon, 05 Oct 2020 11:15:59 GMT

Expires: 800

Server: Asterisk PBX 13.22.0-rc1

Content-Length: 0

--end msg-- 💚 DEBUG 16:15:44.171 [VSLEndpoint void logCallBack(int, const char *, int):567] pjsua_acc.c ....SIP outbound status for acc 0 is not active 💙 INFO 16:15:44.172 [VSLEndpoint void logCallBack(int, const char *, int):564] pjsua_acc.c ....sip:[email protected]:5060: registration success, status=200 (OK), will re-register in 800 seconds 💚 DEBUG 16:15:44.173 [VSLEndpoint void logCallBack(int, const char *, int):567] pjsua_acc.c ....Keep-alive timer started for acc 0, destination:54.33.60.88:5060:15, interval:67496264s 💜 VERBOSE 16:15:44.174 [VSLEndpoint void onRegState2(pjsua_acc_id, pjsua_reg_info *):650] PJSUA callback: registration status has changed. 💚 DEBUG 16:15:44.175 [VSLAccount -[VSLAccount setAccountState:]:54] AccountState will change from VSLAccountStateOffline(0) to VSLAccountStateConnected(2) 💜 VERBOSE 16:15:44.176 [VSLAccount -[VSLAccount accountStateChanged]:359] Account registered succesfully 💚 DEBUG 16:15:55.821 [VSLAccount -[VSLAccount registerAccountWithCompletion:]:231] Account valid: YES 💚 DEBUG 16:15:55.821 [VSLAccount -[VSLAccount registerAccountWithCompletion:]:232] Should force registration: NO 💜 VERBOSE 16:15:55.821 [VSLAccount -[VSLAccount registerAccountWithCompletion:]:275] VSLAccount registered or registration in progress, cannot sent another registration 💜 VERBOSE 16:15:55.822 [VSLAccount -[VSLAccount registerAccountWithCompletion:]:276] VSLAccount state: 2 💜 VERBOSE 16:15:55.822 [VSLCallManager -[VSLCallManager addCall:]:139] Call(620F467E-BCA5-49C9-9FAF-7EEDF0C22B55) added. Calls count:1 💙 INFO 16:15:55.843 [VSLCallManager -[VSLCallManager startCallToNumber:forAccount:completion:]_block_invoke:83] "Start Call Transaction" requested succesfully for Call(620F467E-BCA5-49C9-9FAF-7EEDF0C22B55) with account(0) 💜 VERBOSE 16:15:55.885 [VSLCallManager -[VSLCallManager callWithUUID:]:184] Looking for a call with UUID:620F467E-BCA5-49C9-9FAF-7EEDF0C22B55 💚 DEBUG 16:15:55.885 [VSLCallManager -[VSLCallManager callWithUUID:]:194] VSLCall found for UUID:620F467E-BCA5-49C9-9FAF-7EEDF0C22B55 VSLCall:<VSLCall: 0x2839a42d0> 💜 VERBOSE 16:15:55.886 [VSLAudioController -[VSLAudioController configureAudioSession]:60] Setting AVAudioSessionCategory to "Play and Record" 💜 VERBOSE 16:15:55.886 [VSLAudioController -[VSLAudioController configureAudioSession]:69] Setting AVAudioSessionCategory to "Mode Voice Chat" 💚 DEBUG 16:15:55.887 [VSLEndpoint void logCallBack(int, const char *, int):567] pjsua_call.c !Making call with acc #0 to sip:[email protected]:5060 💚 DEBUG 16:15:55.888 [VSLEndpoint void logCallBack(int, const char *, int):567] pjsua_media.c .Call 0: initializing media.. 💚 DEBUG 16:15:55.888 [VSLEndpoint void logCallBack(int, const char *, int):567] pjsua_media.c ..RTP socket reachable at 10.5.0.2:4000 💚 DEBUG 16:15:55.889 [VSLEndpoint void logCallBack(int, const char *, int):567] pjsua_media.c ..RTCP socket reachable at 10.5.0.2:4001 💚 DEBUG 16:15:55.889 [VSLEndpoint void logCallBack(int, const char *, int):567] pjsua_media.c ..Media index 0 selected for audio call 0 💚 DEBUG 16:15:55.890 [VSLEndpoint void logCallBack(int, const char *, int):567] pjsua_core.c ....TX 1043 bytes Request msg INVITE/cseq=5019 (tdta0x10403b2a8) to UDP 54.33.60.88:5060: INVITE sip:[email protected]:5060 SIP/2.0

Via: SIP/2.0/UDP 67.21.32.25:63781;rport;branch=z9hG4bKPjM7XIlWkLt78OG8s48lFOnfa58pk7.zvO

Max-Forwards: 70

From: sip:[email protected];tag=.DjQaw3v7Skt.aos6SnOk4XE3mA9Q2wX

To: sip:[email protected]

Contact: sip:[email protected]:63781;ob

Call-ID: AXAyvKcaVfmcVQtZg4nCk85wP5Qmybf1

CSeq: 5019 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: VialerSIPLib Example App

Content-Type: application/sdp

Content-Length: 396

v=0

o=- 3810885355 3810885355 IN IP4 10.5.0.2

s=pjmedia

b=AS:84

t=0 0

a=X-nat:0

m=audio 4000 RTP/AVP 9 8 104 0 96

c=IN IP4 10.5.0.2

b=TIAS:64000

a=rtcp:4001 IN IP4 10.5.0.2

a=sendrecv

a=rtpmap:9 G722/8000

a=rtpmap:8 PCMA/8000

a=rtpmap:104 iLBC/8000

a=fmtp:104 mode=30

a=rtpmap:0 PCMU/8000

a=rtpmap:96 telephone-event/8000

a=fmtp:96 0-16

a=ssrc:160018452 cname:7b157e58401a0289

--end msg-- 💜 VERBOSE 16:15:55.910 [VSLEndpoint void onCallState(pjsua_call_id, pjsip_event *):608] PJSUA callback: call state changed to VSLCallStateCalling. 💚 DEBUG 16:15:55.911 [VSLCall -[VSLCall setCallState:]:131] Call(620F467E-BCA5-49C9-9FAF-7EEDF0C22B55). CallState will change from VSLCallStateNull(0) to VSLCallStateCalling(1) 💚 DEBUG 16:15:55.911 [CallKitProviderDelegate -[CallKitProviderDelegate callStateChanged:]:240] Outgoing call, in CALLING state, with UUID: 620F467E-BCA5-49C9-9FAF-7EEDF0C22B55 💜 VERBOSE 16:15:55.911 [VSLEndpoint void onTxStateChange(pjsua_call_id, pjsip_transaction *, pjsip_event *):716] PJSUA callback: transaction within the call has changed state. 💜 VERBOSE 16:15:55.911 [VSLCall -[VSLCall startWithCompletion:]:266] Call(620F467E-BCA5-49C9-9FAF-7EEDF0C22B55) started with id:0 💙 INFO 16:15:55.911 [CallKitProviderDelegate -[CallKitProviderDelegate provider:performStartCallAction:]_block_invoke:156] Call 620F467E-BCA5-49C9-9FAF-7EEDF0C22B55 started 💚 DEBUG 16:15:56.092 [VSLAudioController -[VSLAudioController activateSoundDevice]:85] Activating audiosession 💚 DEBUG 16:15:56.092 [VSLEndpoint void logCallBack(int, const char *, int):567] pjsua_aud.c Set sound device: capture=-1, playback=-2 💚 DEBUG 16:15:56.092 [VSLEndpoint void logCallBack(int, const char *, int):567] pjsua_aud.c .Opening sound device (speaker + mic) PCM@16000/1/20ms 💚 DEBUG 16:15:56.093 [VSLEndpoint void logCallBack(int, const char *, int):567] coreaudio_dev.c ..Using VoiceProcessingIO audio unit 💚 DEBUG 16:15:56.164 [VSLEndpoint void logCallBack(int, const char *, int):567] pjsua_core.c .RX 563 bytes Response msg 401/INVITE/cseq=5019 (rdata0x107822e28) from UDP 54.33.60.88:5060: SIP/2.0 401 Unauthorized

Via: SIP/2.0/UDP 67.21.32.25:63781;rport=63781;received=67.21.32.25;branch=z9hG4bKPjM7XIlWkLt78OG8s48lFOnfa58pk7.zvO

Call-ID: AXAyvKcaVfmcVQtZg4nCk85wP5Qmybf1

From: sip:[email protected];tag=.DjQaw3v7Skt.aos6SnOk4XE3mA9Q2wX

To: sip:[email protected];tag=z9hG4bKPjM7XIlWkLt78OG8s48lFOnfa58pk7.zvO

CSeq: 5019 INVITE

WWW-Authenticate: Digest realm="asterisk",nonce="1601896572/fe2aed75863d9146564e0b5d036ba7b6",opaque="336dfd5615df67f5",algorithm=md5,qop="auth"

Server: Asterisk PBX 13.22.0-rc1

Content-Length: 0

--end msg-- 💚 DEBUG 16:15:56.166 [VSLEndpoint void logCallBack(int, const char *, int):567] pjsua_core.c ..TX 386 bytes Request msg ACK/cseq=5019 (tdta0x1040f20a8) to UDP 54.33.60.88:5060: ACK sip:[email protected]:5060 SIP/2.0

Via: SIP/2.0/UDP 67.21.32.25:63781;rport;branch=z9hG4bKPjM7XIlWkLt78OG8s48lFOnfa58pk7.zvO

Max-Forwards: 70

From: sip:[email protected];tag=.DjQaw3v7Skt.aos6SnOk4XE3mA9Q2wX

To: sip:[email protected];tag=z9hG4bKPjM7XIlWkLt78OG8s48lFOnfa58pk7.zvO

Call-ID: AXAyvKcaVfmcVQtZg4nCk85wP5Qmybf1

CSeq: 5019 ACK

Content-Length: 0

--end msg-- 💙 INFO 16:15:56.171 [VSLEndpoint void logCallBack(int, const char *, int):564] tsx0x1048ca2a8 .......Temporary failure in sending Request msg INVITE/cseq=5020 (tdta0x10403b2a8), will try next server: Unsupported transport (PJSIP_EUNSUPTRANSPORT) 💚 DEBUG 16:15:56.173 [VSLEndpoint void logCallBack(int, const char *, int):567] pjsua_core.c .......TX 1352 bytes Request msg INVITE/cseq=5020 (tdta0x10403b2a8) to UDP 54.33.60.88:5060: INVITE sip:[email protected]:5060 SIP/2.0

Via: SIP/2.0/UDP 67.21.32.25:63781;rport;branch=z9hG4bKPjS-TPJus0xrWoWs83DjgrpGaykvG0TD.U

Max-Forwards: 70

From: sip:[email protected];tag=.DjQaw3v7Skt.aos6SnOk4XE3mA9Q2wX

To: sip:[email protected]

Contact: sip:[email protected]:63781;ob

Call-ID: AXAyvKcaVfmcVQtZg4nCk85wP5Qmybf1

CSeq: 5020 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: VialerSIPLib Example App

Authorization: Digest username="abc123", realm="asterisk", nonce="1601896572/fe2aed75863d9146564e0b5d036ba7b6", uri="sip:[email protected]:5060", response="b99d63db75d4c627bc0b1d9e10247fdf", algorithm=md5, cnonce="qQSEeZx2Fv1n-FlzPmwpFOdhaU0JXhL8", opaque="336dfd5615df67f5", qop=auth, nc=00000001

Content-Type: application/sdp

Content-Length: 396

v=0

o=- 3810885355 3810885355 IN IP4 10.5.0.2

s=pjmedia

b=AS:84

t=0 0

a=X-nat:0

m=audio 4000 RTP/AVP 9 8 104 0 96

c=IN IP4 10.5.0.2

b=TIAS:64000

a=rtcp:4001 IN IP4 10.5.0.2

a=sendrecv

a=rtpmap:9 G722/8000

a=rtpmap:8 PCMA/8000

a=rtpmap:104 iLBC/8000

a=fmtp:104 mode=30

a=rtpmap:0 PCMU/8000

a=rtpmap:96 telephone-event/8000

a=fmtp:96 0-16

a=ssrc:160018452 cname:7b157e58401a0289

--end msg-- 💜 VERBOSE 16:15:56.223 [VSLEndpoint void onTxStateChange(pjsua_call_id, pjsip_transaction *, pjsip_event *):716] PJSUA callback: transaction within the call has changed state. 💚 DEBUG 16:15:56.343 [VSLEndpoint void logCallBack(int, const char *, int):567] coreaudio_dev.c !..core audio stream started 💚 DEBUG 16:15:56.365 [VSLEndpoint void logCallBack(int, const char *, int):567] os_core_unix.c Info: possibly re-registering existing thread 💚 DEBUG 16:15:56.724 [VSLEndpoint void logCallBack(int, const char *, int):567] pjsua_core.c .TX 1352 bytes Request msg INVITE/cseq=5020 (tdta0x10403b2a8) to UDP 54.33.60.88:5060: INVITE sip:[email protected]:5060 SIP/2.0

Via: SIP/2.0/UDP 67.21.32.25:63781;rport;branch=z9hG4bKPjS-TPJus0xrWoWs83DjgrpGaykvG0TD.U

Max-Forwards: 70

From: sip:[email protected];tag=.DjQaw3v7Skt.aos6SnOk4XE3mA9Q2wX

To: sip:[email protected]

Contact: sip:[email protected]:63781;ob

Call-ID: AXAyvKcaVfmcVQtZg4nCk85wP5Qmybf1

CSeq: 5020 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: VialerSIPLib Example App

Authorization: Digest username="abc123", realm="asterisk", nonce="1601896572/fe2aed75863d9146564e0b5d036ba7b6", uri="sip:[email protected]:5060", response="b99d63db75d4c627bc0b1d9e10247fdf", algorithm=md5, cnonce="qQSEeZx2Fv1n-FlzPmwpFOdhaU0JXhL8", opaque="336dfd5615df67f5", qop=auth, nc=00000001

Content-Type: application/sdp

Content-Length: 396

v=0

o=- 3810885355 3810885355 IN IP4 10.5.0.2

s=pjmedia

b=AS:84

t=0 0

a=X-nat:0

m=audio 4000 RTP/AVP 9 8 104 0 96

c=IN IP4 10.5.0.2

b=TIAS:64000

a=rtcp:4001 IN IP4 10.5.0.2

a=sendrecv

a=rtpmap:9 G722/8000

a=rtpmap:8 PCMA/8000

a=rtpmap:104 iLBC/8000

a=fmtp:104 mode=30

a=rtpmap:0 PCMU/8000

a=rtpmap:96 telephone-event/8000

a=fmtp:96 0-16

a=ssrc:160018452 cname:7b157e58401a0289

--end msg-- 💚 DEBUG 16:15:57.724 [VSLEndpoint void logCallBack(int, const char *, int):567] pjsua_core.c .TX 1352 bytes Request msg INVITE/cseq=5020 (tdta0x10403b2a8) to UDP 54.33.60.88:5060: INVITE sip:[email protected]:5060 SIP/2.0

Via: SIP/2.0/UDP 67.21.32.25:63781;rport;branch=z9hG4bKPjS-TPJus0xrWoWs83DjgrpGaykvG0TD.U

Max-Forwards: 70

From: sip:[email protected];tag=.DjQaw3v7Skt.aos6SnOk4XE3mA9Q2wX

To: sip:[email protected]

Contact: sip:[email protected]:63781;ob

Call-ID: AXAyvKcaVfmcVQtZg4nCk85wP5Qmybf1

CSeq: 5020 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: VialerSIPLib Example App

Authorization: Digest username="abc123", realm="asterisk", nonce="1601896572/fe2aed75863d9146564e0b5d036ba7b6", uri="sip:[email protected]:5060", response="b99d63db75d4c627bc0b1d9e10247fdf", algorithm=md5, cnonce="qQSEeZx2Fv1n-FlzPmwpFOdhaU0JXhL8", opaque="336dfd5615df67f5", qop=auth, nc=00000001

Content-Type: application/sdp

Content-Length: 396

v=0

o=- 3810885355 3810885355 IN IP4 10.5.0.2

s=pjmedia

b=AS:84

t=0 0

a=X-nat:0

m=audio 4000 RTP/AVP 9 8 104 0 96

c=IN IP4 10.5.0.2

b=TIAS:64000

a=rtcp:4001 IN IP4 10.5.0.2

a=sendrecv

a=rtpmap:9 G722/8000

a=rtpmap:8 PCMA/8000

a=rtpmap:104 iLBC/8000

a=fmtp:104 mode=30

a=rtpmap:0 PCMU/8000

a=rtpmap:96 telephone-event/8000

a=fmtp:96 0-16

a=ssrc:160018452 cname:7b157e58401a0289

--end msg-- 💚 DEBUG 16:15:59.726 [VSLEndpoint void logCallBack(int, const char *, int):567] pjsua_core.c .TX 1352 bytes Request msg INVITE/cseq=5020 (tdta0x10403b2a8) to UDP 54.33.60.88:5060: INVITE sip:[email protected]:5060 SIP/2.0

Via: SIP/2.0/UDP 67.21.32.25:63781;rport;branch=z9hG4bKPjS-TPJus0xrWoWs83DjgrpGaykvG0TD.U

Max-Forwards: 70

From: sip:[email protected];tag=.DjQaw3v7Skt.aos6SnOk4XE3mA9Q2wX

To: sip:[email protected]

Contact: sip:[email protected]:63781;ob

Call-ID: AXAyvKcaVfmcVQtZg4nCk85wP5Qmybf1

CSeq: 5020 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: VialerSIPLib Example App

Authorization: Digest username="abc123", realm="asterisk", nonce="1601896572/fe2aed75863d9146564e0b5d036ba7b6", uri="sip:[email protected]:5060", response="b99d63db75d4c627bc0b1d9e10247fdf", algorithm=md5, cnonce="qQSEeZx2Fv1n-FlzPmwpFOdhaU0JXhL8", opaque="336dfd5615df67f5", qop=auth, nc=00000001

Content-Type: application/sdp

Content-Length: 396

v=0

o=- 3810885355 3810885355 IN IP4 10.5.0.2

s=pjmedia

b=AS:84

t=0 0

a=X-nat:0

m=audio 4000 RTP/AVP 9 8 104 0 96

c=IN IP4 10.5.0.2

b=TIAS:64000

a=rtcp:4001 IN IP4 10.5.0.2

a=sendrecv

a=rtpmap:9 G722/8000

a=rtpmap:8 PCMA/8000

a=rtpmap:104 iLBC/8000

a=fmtp:104 mode=30

a=rtpmap:0 PCMU/8000

a=rtpmap:96 telephone-event/8000

a=fmtp:96 0-16

a=ssrc:160018452 cname:7b157e58401a0289

--end msg-- 💚 DEBUG 16:16:03.727 [VSLEndpoint void logCallBack(int, const char *, int):567] pjsua_core.c .TX 1352 bytes Request msg INVITE/cseq=5020 (tdta0x10403b2a8) to UDP 54.33.60.88:5060: INVITE sip:[email protected]:5060 SIP/2.0

Via: SIP/2.0/UDP 67.21.32.25:63781;rport;branch=z9hG4bKPjS-TPJus0xrWoWs83DjgrpGaykvG0TD.U

Max-Forwards: 70

From: sip:[email protected];tag=.DjQaw3v7Skt.aos6SnOk4XE3mA9Q2wX

To: sip:[email protected]

Contact: sip:[email protected]:63781;ob

Call-ID: AXAyvKcaVfmcVQtZg4nCk85wP5Qmybf1

CSeq: 5020 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: VialerSIPLib Example App

Authorization: Digest username="abc123", realm="asterisk", nonce="1601896572/fe2aed75863d9146564e0b5d036ba7b6", uri="sip:[email protected]:5060", response="b99d63db75d4c627bc0b1d9e10247fdf", algorithm=md5, cnonce="qQSEeZx2Fv1n-FlzPmwpFOdhaU0JXhL8", opaque="336dfd5615df67f5", qop=auth, nc=00000001

Content-Type: application/sdp

Content-Length: 396

v=0

o=- 3810885355 3810885355 IN IP4 10.5.0.2

s=pjmedia

b=AS:84

t=0 0

a=X-nat:0

m=audio 4000 RTP/AVP 9 8 104 0 96

c=IN IP4 10.5.0.2

b=TIAS:64000

a=rtcp:4001 IN IP4 10.5.0.2

a=sendrecv

a=rtpmap:9 G722/8000

a=rtpmap:8 PCMA/8000

a=rtpmap:104 iLBC/8000

a=fmtp:104 mode=30

a=rtpmap:0 PCMU/8000

a=rtpmap:96 telephone-event/8000

a=fmtp:96 0-16

a=ssrc:160018452 cname:7b157e58401a0289

--end msg-- 💚 DEBUG 16:16:11.728 [VSLEndpoint void logCallBack(int, const char *, int):567] pjsua_core.c .TX 1352 bytes Request msg INVITE/cseq=5020 (tdta0x10403b2a8) to UDP 54.33.60.88:5060: INVITE sip:[email protected]:5060 SIP/2.0

Via: SIP/2.0/UDP 67.21.32.25:63781;rport;branch=z9hG4bKPjS-TPJus0xrWoWs83DjgrpGaykvG0TD.U

Max-Forwards: 70

From: sip:[email protected];tag=.DjQaw3v7Skt.aos6SnOk4XE3mA9Q2wX

To: sip:[email protected]

Contact: sip:[email protected]:63781;ob

Call-ID: AXAyvKcaVfmcVQtZg4nCk85wP5Qmybf1

CSeq: 5020 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: VialerSIPLib Example App

Authorization: Digest username="abc123", realm="asterisk", nonce="1601896572/fe2aed75863d9146564e0b5d036ba7b6", uri="sip:[email protected]:5060", response="b99d63db75d4c627bc0b1d9e10247fdf", algorithm=md5, cnonce="qQSEeZx2Fv1n-FlzPmwpFOdhaU0JXhL8", opaque="336dfd5615df67f5", qop=auth, nc=00000001

Content-Type: application/sdp

Content-Length: 396

v=0

o=- 3810885355 3810885355 IN IP4 10.5.0.2

s=pjmedia

b=AS:84

t=0 0

a=X-nat:0

m=audio 4000 RTP/AVP 9 8 104 0 96

c=IN IP4 10.5.0.2

b=TIAS:64000

a=rtcp:4001 IN IP4 10.5.0.2

a=sendrecv

a=rtpmap:9 G722/8000

a=rtpmap:8 PCMA/8000

a=rtpmap:104 iLBC/8000

a=fmtp:104 mode=30

a=rtpmap:0 PCMU/8000

a=rtpmap:96 telephone-event/8000

a=fmtp:96 0-16

a=ssrc:160018452 cname:7b157e58401a0289

--end msg-- 💚 DEBUG 16:16:27.729 [VSLEndpoint void logCallBack(int, const char *, int):567] pjsua_core.c .TX 1352 bytes Request msg INVITE/cseq=5020 (tdta0x10403b2a8) to UDP 54.33.60.88:5060: INVITE sip:[email protected]:5060 SIP/2.0

Via: SIP/2.0/UDP 67.21.32.25:63781;rport;branch=z9hG4bKPjS-TPJus0xrWoWs83DjgrpGaykvG0TD.U

Max-Forwards: 70

From: sip:[email protected];tag=.DjQaw3v7Skt.aos6SnOk4XE3mA9Q2wX

To: sip:[email protected]

Contact: sip:[email protected]:63781;ob

Call-ID: AXAyvKcaVfmcVQtZg4nCk85wP5Qmybf1

CSeq: 5020 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: VialerSIPLib Example App

Authorization: Digest username="abc123", realm="asterisk", nonce="1601896572/fe2aed75863d9146564e0b5d036ba7b6", uri="sip:[email protected]:5060", response="b99d63db75d4c627bc0b1d9e10247fdf", algorithm=md5, cnonce="qQSEeZx2Fv1n-FlzPmwpFOdhaU0JXhL8", opaque="336dfd5615df67f5", qop=auth, nc=00000001

Content-Type: application/sdp

Content-Length: 396

v=0

o=- 3810885355 3810885355 IN IP4 10.5.0.2

s=pjmedia

b=AS:84

t=0 0

a=X-nat:0

m=audio 4000 RTP/AVP 9 8 104 0 96

c=IN IP4 10.5.0.2

b=TIAS:64000

a=rtcp:4001 IN IP4 10.5.0.2

a=sendrecv

a=rtpmap:9 G722/8000

a=rtpmap:8 PCMA/8000

a=rtpmap:104 iLBC/8000

a=fmtp:104 mode=30

a=rtpmap:0 PCMU/8000

a=rtpmap:96 telephone-event/8000

a=fmtp:96 0-16

a=ssrc:160018452 cname:7b157e58401a0289

--end msg-- 💜 VERBOSE 16:16:28.223 [VSLEndpoint void onTxStateChange(pjsua_call_id, pjsip_transaction *, pjsip_event *):716] PJSUA callback: transaction within the call has changed state. 💜 VERBOSE 16:16:28.223 [VSLEndpoint void onCallState(pjsua_call_id, pjsip_event *):608] PJSUA callback: call state changed to VSLCallStateDisconnected. 💚 DEBUG 16:16:28.223 [VSLCall -[VSLCall setCallState:]:131] Call(620F467E-BCA5-49C9-9FAF-7EEDF0C22B55). CallState will change from VSLCallStateCalling(1) to VSLCallStateDisconnected(6) 💚 DEBUG 16:16:28.224 [VSLCall -[VSLCall calculateStats]:862] Stream is not active! 💙 INFO 16:16:28.224 [VSLRingback -[VSLRingback stop]:100] Stop ringback, isPlaying: NO 💜 VERBOSE 16:16:28.225 [VSLCallManager -[VSLCallManager removeCall:]:149] Call(620F467E-BCA5-49C9-9FAF-7EEDF0C22B55) removed. Calls count: 0 💚 DEBUG 16:16:28.225 [CallKitProviderDelegate -[CallKitProviderDelegate callStateChanged:]:271] Call never connected, in DISCONNECTED state, with UUID: 620F467E-BCA5-49C9-9FAF-7EEDF0C22B55 💜 VERBOSE 16:16:28.226 [VSLEndpoint -[VSLEndpoint stopNetworkMonitoring]:872] No active calls for any account, stopping network monitor 💚 DEBUG 16:16:28.227 [VSLEndpoint void logCallBack(int, const char *, int):567] pjsua_media.c ....Call 0: deinitializing media.. 💚 DEBUG 16:16:28.228 [VSLEndpoint void logCallBack(int, const char *, int):567] pjsua_media.c .....Call 0: cleaning up provisional media, prov_med_cnt=1, med_cnt=0 💚 DEBUG 16:16:29.072 [VSLAudioController -[VSLAudioController deactivateSoundDevice]:111] Deactivating audiosession 💚 DEBUG 16:16:29.080 [VSLEndpoint void logCallBack(int, const char *, int):567] pjsua_aud.c !.Closing iPhone IO device sound playback device and iPhone IO device sound capture device 💚 DEBUG 16:16:29.090 [VSLEndpoint void logCallBack(int, const char *, int):567] coreaudio_dev.c .core audio stream stopped 💚 DEBUG 16:16:29.227 [VSLEndpoint void logCallBack(int, const char *, int):567] pjsua_aud.c Closing sound device after idle for 1 second(s) 💜 VERBOSE 16:16:30.920 [VSLCall -[VSLCall dealloc]:122] Dealloc call with uuid:620F467E-BCA5-49C9-9FAF-7EEDF0C22B55 callId:0

shadowwalkersteam avatar Oct 05 '20 11:10 shadowwalkersteam

Hi! I have similar problem, did you find any explanation?

vyusupov avatar Oct 24 '20 23:10 vyusupov

Hi! I have similar problem, did you find any explanation?

@vyusupov Yes i have resolved it, I was using VPN and the server firewall was rejecting my IP that's why the call was not initiating or ring back tone was not coming out.

shadowwalkersteam avatar Oct 25 '20 08:10 shadowwalkersteam

@shadowwalkersteam Hi! Thank you for reply! So, the lib is working and the problem is in provider configuration? Cause I don't using vpn and have same issue. I found in the log (in mine and your) Temporary failure in sending Request msg INVITE/cseq=13730 (tdta0x7fea438750a8), will try next server: Unsupported transport (PJSIP_EUNSUPTRANSPORT). Did you configured stun or turn server?

vyusupov avatar Oct 25 '20 14:10 vyusupov

@vyusupov I also changed the codec, my server is configured to use G722 codec but by default in the app it was different, so i had to change my codec to G722 as well.

shadowwalkersteam avatar Oct 26 '20 04:10 shadowwalkersteam

@vyusupov When you dial the number check on your server if you are getting anything on the server? That's how i figured out

shadowwalkersteam avatar Oct 26 '20 04:10 shadowwalkersteam

@shadowwalkersteam thank you! You save so much time for me. The problem really was in codecs, my server is configured with OPUS codec.

vyusupov avatar Oct 26 '20 12:10 vyusupov

@vyusupov how can u fix this? Please share ur fixed code thanks

fukemy avatar Jul 02 '21 15:07 fukemy

@vyusupov how can u fix this? Please share ur fixed code thanks

Hi! You need to use in your client's config the same audio codec, which is using on server configuration. In my case it was G711.

let codecConfiguration = VSLCodecConfiguration() codecConfiguration.audioCodecs = [ VSLAudioCodecs(audioCodec: .G711, andPriority: 210) ]

vyusupov avatar Jul 04 '21 23:07 vyusupov