Project

General

Profile

Bug #1784

Updated by zecke over 7 years ago

Bug Summary from UX pov: No early media when connecting through voip provider. 
 No audio feedback of call progress on local GSM-GSM calls with (at least) certain Nokia phones. 

 This is a diff of two log segment from osmo-nitb.  
 The call is exactly the same, osc.log was created with osmo-sip-connector and lcr.log with LCR. 

 I note the extra MNCC sent by by LCR: 

 <pre> 
 $ diff -u osc.log lcr.log      
 --- osc.log       2016-07-26 16:17:19.986897563 +0100 
 +++ lcr.log       2016-07-26 16:17:33.238845393 +0100 
 @@ -17,6 +17,12 @@ 
  <0001> gsm_04_08.c:1300 new state NULL -> INITIATED 
  <0001> gsm_04_08.c:1935 Subscriber Meteor (68000137793) sends SETUP to 68000135657 
  <0001> gsm_04_08.c:1361 (bts 0 trx 0 ts 2 ti 8 sub 68000137793) Sending 'MNCC_SETUP_IND' to MNCC. 
 +<0006> gsm_04_08.c:3211 receive message MNCC_CALL_PROC_REQ 
 +<0001> gsm_04_08.c:3415 (bts 0 trx 0 ts 2 ti 08 sub 68000137793) Received 'MNCC_CALL_PROC_REQ' from MNCC in state 1 (INITIATED) 
 +<0001> gsm_04_08.c:1300 new state INITIATED -> MO_CALL_PROC 
 +<0001> gsm_04_08.c:138 (bts 0 trx 0 ts 2 ti 80) Sending 'CALL_PROC' to MS. 
 +<0006> gsm_04_08.c:3211 receive message MNCC_FRAME_RECV 
 +<0001> gsm_04_08.c:1722 queue tch_recv_mncc request (1) 
  <0006> gsm_04_08.c:3211 receive message MNCC_RTP_CREATE 
  <000a> bsc_api.c:383 Sending ChanModify for speech 1 1 
  <0003> gsm_04_08_utils.c:461 -> CHANNEL MODE MODIFY mode=0x01 @@ -25,13 +31,9 @@ 
  <0004> abis_rsl.c:1866 (bts=0,trx=0,ts=2,ss=0) IPAC_BIND speech_mode=0x10 RTP_PAYLOAD=3 
  <0003> osmo_msc.c:72 MSC assign complete (do nothing). 
  <0004> abis_rsl.c:1217 (bts=0,trx=0,ts=2,ss=0) CHANNEL MODE MODIFY ACK 
 -<0004> abis_rsl.c:2030 (bts=0,trx=0,ts=2,ss=0) IPAC_CRCX_ACK LOCAL_IP=172.16.0.11 LOCAL_PORT=14286 CON_ID=0 <0006> gsm_04_08.c:3118 (bts=0,trx=0,ts=2,ss=0) sending pending RTP create ind. 
 +<0004> abis_rsl.c:2030 (bts=0,trx=0,ts=2,ss=0) IPAC_CRCX_ACK LOCAL_IP=172.16.0.11 LOCAL_PORT=58708 CON_ID=0 <0006> gsm_04_08.c:3118 (bts=0,trx=0,ts=2,ss=0) sending pending RTP create ind. 
  <0001> gsm_04_08.c:1369 (bts - trx - ts - ti -- sub -) Sending 'MNCC_RTP_CREATE' to MNCC. 
 
 -<0006> gsm_04_08.c:3211 receive message MNCC_CALL_PROC_REQ 
 -<0001> gsm_04_08.c:3415 (bts 0 trx 0 ts 2 ti 08 sub 68000137793) Received 'MNCC_CALL_PROC_REQ' from MNCC in state 1 (INITIATED) 
 -<0001> gsm_04_08.c:1300 new state INITIATED -> MO_CALL_PROC 
 -<0001> gsm_04_08.c:138 (bts 0 trx 0 ts 2 ti 80) Sending 'CALL_PROC' to MS. 
  <0006> gsm_04_08.c:3211 receive message MNCC_SETUP_REQ 
  <000d> db.c:894 Found Subscriber: ID 72, IMSI 214220001782190, NAME 'DigiMovil', TMSI 4294967295, EXTEN '68000135657', LAC 1, AUTH 1 
  <0001> transaction.c:71 subscr=0xf578f0, net=0xf11a80 @@ -39,7 +41,7 @@ 
  <0007> paging.c:291 Start paging of subscriber 72 on bts 0. 
  <0007> paging.c:83 Going to send paging commands: imsi: '214220001782190' tmsi: '0xffffffff' 
  <0007> paging.c:83 Going to send paging commands: imsi: '214220001782190' tmsi: '0xffffffff' 
 -<0004> abis_rsl.c:1464 (bts=0,trx=0,ts=3,ss=0) Activating ARFCN(31) SS(0) lctype TCH/F r=PAGING ra=0x2f ta=0 
 +<0004> abis_rsl.c:1464 (bts=0,trx=0,ts=3,ss=0) Activating ARFCN(31) SS(0) lctype TCH/F r=PAGING ra=0x2e ta=0 
  <0004> abis_rsl.c:1198 (bts=0,trx=0,ts=3,ss=0) CHANNEL ACTIVATE ACK 
  <0007> paging.c:83 Going to send paging commands: imsi: '214220001782190' tmsi: '0xffffffff' 
  <0000> abis_rsl.c:1652 (bts=0,trx=0,ts=3,ss=0) SAPI=0 ESTABLISH INDICATION @@ -62,7 +64,8 @@ 
  <0001> gsm_04_08.c:1857 starting timer T310 with 180 seconds 
  <0001> gsm_04_08.c:1300 new state CALL_PRESENT -> MO_TERM_CALL_CONF 
  <0001> gsm_04_08.c:1361 (bts 0 trx 0 ts 3 ti 0 sub 68000135657) Sending 'MNCC_CALL_CONF_IND' to MNCC. 
 -<0006> gsm_04_08.c:3211 receive message MNCC_RTP_CREATE 
 +<0006> gsm_04_08.c:3211 receive message MNCC_LCHAN_MODIFY 
 +<0001> gsm_04_08.c:3415 (bts 0 trx 0 ts 3 ti 00 sub 68000135657) Received 'MNCC_LCHAN_MODIFY' from MNCC in state 9 (MO_TERM_CALL_CONF) 
  <000a> bsc_api.c:383 Sending ChanModify for speech 1 1 
  <0003> gsm_04_08_utils.c:461 -> CHANNEL MODE MODIFY mode=0x01 
  <0000> abis_rsl.c:1652 (bts=0,trx=0,ts=3,ss=0) SAPI=0 DATA INDICATION @@ -70,8 +73,9 @@ 
  <0004> abis_rsl.c:1866 (bts=0,trx=0,ts=3,ss=0) IPAC_BIND speech_mode=0x10 RTP_PAYLOAD=3 
  <0003> osmo_msc.c:72 MSC assign complete (do nothing). 
  <0004> abis_rsl.c:1217 (bts=0,trx=0,ts=3,ss=0) CHANNEL MODE MODIFY ACK 
 -<0004> abis_rsl.c:2030 (bts=0,trx=0,ts=3,ss=0) IPAC_CRCX_ACK LOCAL_IP=172.16.0.11 LOCAL_PORT=53836 CON_ID=0 <0006> gsm_04_08.c:3118 (bts=0,trx=0,ts=3,ss=0) sending pending RTP create ind. 
 -<0001> gsm_04_08.c:1369 (bts - trx - ts - ti -- sub -) Sending 'MNCC_RTP_CREATE' to MNCC. 
 +<0004> abis_rsl.c:2030 (bts=0,trx=0,ts=3,ss=0) IPAC_CRCX_ACK LOCAL_IP=172.16.0.11 LOCAL_PORT=13340 CON_ID=0 <001b> rtp_proxy.c:542 rtp_socket_create(): success 
 +<001b> rtp_proxy.c:627 rtp_socket_bind(rs=0xf40f00, IP=0.0.0.0): BOUND_IP=0.0.0.0, BOUND_PORT=30000 
 +<001b> rtp_proxy.c:682 rtp_socket_connect(rs=0xf40f00, ip=172.16.0.11, port=13340) 
 
  <0000> abis_rsl.c:1652 (bts=0,trx=0,ts=3,ss=0) SAPI=0 DATA INDICATION 
  <0000> gsm_04_08.c:3584 Dispatching 04.08 message, pdisc=3 @@ -80,6 +84,13 @@ 
  <0001> gsm_04_08.c:1857 starting timer T301 with 180 seconds 
  <0001> gsm_04_08.c:1300 new state MO_TERM_CALL_CONF -> CALL_RECEIVED 
  <0001> gsm_04_08.c:1361 (bts 0 trx 0 ts 3 ti 0 sub 68000135657) Sending 'MNCC_ALERT_IND' to MNCC. 
 +<0006> gsm_04_08.c:3211 receive message MNCC_LCHAN_MODIFY 
 +<0001> gsm_04_08.c:3415 (bts 0 trx 0 ts 2 ti 08 sub 68000137793) Received 'MNCC_LCHAN_MODIFY' from MNCC in state 3 (MO_CALL_PROC) 
 +<0006> gsm_04_08.c:3211 receive message MNCC_RTP_CONNECT 
 +<0004> abis_rsl.c:1905 (bts=0,trx=0,ts=2,ss=0) IPAC_MDCX IP=172.16.0.1 PORT=16396 RTP_PAYLOAD=3 RTP_PAYLOAD2=0 CONN_ID=0 speech_mode=0x00 
 +<0004> abis_rsl.c:2040 (bts=0,trx=0,ts=2,ss=0) IPAC_MDCX_ACK LOCAL_IP=172.16.0.11 LOCAL_PORT=58708 CON_ID=0 <0006> gsm_04_08.c:3131 (bts=0,trx=0,ts=2,ss=0) sending pending RTP connect ind. 
 +<0001> gsm_04_08.c:1369 (bts - trx - ts - ti -- sub -) Sending 'MNCC_RTP_CONNECT' to MNCC. 
 +<0000> abis_rsl.c:1652 (bts=0,trx=0,ts=2,ss=0) SAPI=0 DATA INDICATION 
  <0000> gsm_04_08.c:3584 Dispatching 04.08 message, pdisc=3 
  <0001> gsm_04_08.c:3508 (bts 0 trx 0 ts 2 ti 8 sub 68000137793) Received 'DISCONNECT' from MS in state 3 (MO_CALL_PROC) @@ -116,10 +127,10 @@ 
  <0004> abis_rsl.c:615 (bts=0,trx=0,ts=2,ss=0) DEACTivate SACCH CMD 
  <0000> abis_rsl.c:1652 (bts=0,trx=0,ts=3,ss=0) SAPI=0 RELEASE INDICATION 
  <0004> abis_rsl.c:661 (bts=0,trx=0,ts=3,ss=0) RF Channel Release CMD due error 0 
 -<0004> abis_rsl.c:2049 (bts=0,trx=0,ts=3,ss=0) IPAC_DLCX_IND CAUSE=0x0f(Normal event, unspecified) 
 +<0004> abis_rsl.c:2049 (bts=0,trx=0,ts=3,ss=0) IPAC_DLCX_IND CAUSE=0x0f(Normal event, unspecified) <001b> rtp_proxy.c:743 rtp_socket_free(rs=0xf40f00) 
 +<0004> abis_rsl.c:717 (bts=0,trx=0,ts=3,ss=0) RF CHANNEL RELEASE ACK 
  <0000> abis_rsl.c:1652 (bts=0,trx=0,ts=2,ss=0) SAPI=0 RELEASE INDICATION 
  <0004> abis_rsl.c:661 (bts=0,trx=0,ts=2,ss=0) RF Channel Release CMD due error 0 
  <0004> abis_rsl.c:2049 (bts=0,trx=0,ts=2,ss=0) IPAC_DLCX_IND CAUSE=0x0f(Normal event, unspecified) 
  <0004> abis_rsl.c:717 (bts=0,trx=0,ts=2,ss=0) RF CHANNEL RELEASE ACK 
 - 
 </pre> 
 

Back

Add picture from clipboard (Maximum size: 48.8 MB)