Project

General

Profile

Actions
Copy link

Bug #6080

closed

ERROR ptmap contains illegal mapping: codec=4294967295

Added by neels 10 months ago. Updated 9 months ago.

Status:
Resolved
Priority:
Normal
Assignee:
-
Category:
-
Target version:
-
Start date:
06/29/2023
Due date:
% Done:

0%

Resolution:
Spec Reference:

Description

When establishing a (3G) voice call, I see this weird error:

20230629191816423 DLMGCP ERROR ptmap contains illegal mapping: codec=4294967295 maps to pt=96 (mgcp_client.c:128)

It is using current master of osmo-msc.

Attaching the pcap and log around this.

Files

3g_call_est.pcapng 3g_call_est.pcapng 9.99 KB neels, 06/29/2023 07:25 PM

Related issues

Related to Cellular Network Infrastructure - Bug #6074: Current master as of 2023-06-25 broken in my environmentResolvedfalconia06/27/2023

Actions
Actions
Copy link
 #1

Updated by neels 10 months ago 

 20230629191815679 DIUCS DEBUG (UTRAN-Iu-21 from RI=SSN_PC,PC=0.23.5,SSN=RANAP) sccp_ran_sap_up(N-CONNECT.indication) (sccp_ran.c:84)
20230629191815679 DIUCS DEBUG msc_a(unknown:UTRAN-Iu-21:NONE)[0x557e0d5e37e0]{MSC_A_ST_VALIDATE_L3}: RAN decode: RANAP: dir=1 proc=19 (ran_msg_iu.c:274)
20230629191815679 DIUCS DEBUG msc_a(unknown:UTRAN-Iu-21:NONE)[0x557e0d5e37e0]{MSC_A_ST_VALIDATE_L3}: RAN decode: RANAP InitialUE RAN PDU (msc_a.c:1775) 
20230629191815680 DMM DEBUG msc_a(TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5e37e0]{MSC_A_ST_VALIDATE_L3}: Rx CM SERVICE REQUEST cm_service_type=MO-Call (gsm_04_08.c:780)
20230629191815680 DMM DEBUG Tx AUTH REQ (rand = f1f271983573e6def1e99e17c5c9953f) (gsm_04_08.c:645)
20230629191815680 DMM DEBUG    AUTH REQ (autn = 2f3fe7ec4727000047fe37955a25412d) (gsm_04_08.c:647)
20230629191815680 DIUCS DEBUG msc_a(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5e37e0]{MSC_A_ST_AUTH_CIPH}: Sending DTAP: MM GSM48_MT_MM_AUTH_REQ (msc_a.c:1838)
20230629191815680 DIUCS DEBUG msc_a(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5e37e0]{MSC_A_ST_AUTH_CIPH}: RAN encode: RANAP: DirectTransfer (ran_msg_iu.c:417)
20230629191815938 DIUCS DEBUG (UTRAN-Iu-21) sccp_ran_sap_up(N-DATA.indication) (sccp_ran.c:108)
20230629191815938 DIUCS DEBUG msc_i(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5e36b0]{READY}: RAN decode: RANAP: dir=1 proc=20 (ran_msg_iu.c:274)
20230629191815938 DIUCS DEBUG msc_a(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5e37e0]{MSC_A_ST_AUTH_CIPH}: RAN decode: RANAP: dir=1 proc=20 (ran_msg_iu.c:274)
20230629191815938 DIUCS DEBUG msc_a(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5e37e0]{MSC_A_ST_AUTH_CIPH}: RAN decode: RANAP DirectTransfer RAN PDU (msc_a.c:1775)
20230629191815938 DMM DEBUG msc_a(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5e37e0]{MSC_A_ST_AUTH_CIPH}: MM R99 AUTHENTICATION SYNCH (AUTS = f1a7ba8457c1e6319e166cef8357) (gsm_04_08.c:1208)
20230629191815945 DMM DEBUG Tx AUTH REQ (rand = 944ccb46af58c5d6b18d42d11dc51239) (gsm_04_08.c:645)
20230629191815945 DMM DEBUG    AUTH REQ (autn = 39c8a61e63de00008f3e162f9aa8fa38) (gsm_04_08.c:647)
20230629191815945 DIUCS DEBUG msc_a(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5e37e0]{MSC_A_ST_AUTH_CIPH}: Sending DTAP: MM GSM48_MT_MM_AUTH_REQ (msc_a.c:1838)
20230629191815945 DIUCS DEBUG msc_a(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5e37e0]{MSC_A_ST_AUTH_CIPH}: RAN encode: RANAP: DirectTransfer (ran_msg_iu.c:417)
20230629191816158 DIUCS DEBUG (UTRAN-Iu-21) sccp_ran_sap_up(N-DATA.indication) (sccp_ran.c:108)
20230629191816158 DIUCS DEBUG msc_i(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5e36b0]{READY}: RAN decode: RANAP: dir=1 proc=20 (ran_msg_iu.c:274)
20230629191816158 DIUCS DEBUG msc_a(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5e37e0]{MSC_A_ST_AUTH_CIPH}: RAN decode: RANAP: dir=1 proc=20 (ran_msg_iu.c:274)
20230629191816158 DIUCS DEBUG msc_a(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5e37e0]{MSC_A_ST_AUTH_CIPH}: RAN decode: RANAP DirectTransfer RAN PDU (msc_a.c:1775)
20230629191816159 DMM DEBUG msc_a(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5e37e0]{MSC_A_ST_AUTH_CIPH}: MM UMTS AUTHENTICATION RESPONSE (res = fc8da61773a104ad) (gsm_04_08.c:1132)
20230629191816159 DIUCS DEBUG msc_a(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5e37e0]{MSC_A_ST_AUTH_CIPH}: RAN encode: RANAP: SecurityModeCommand (ran_msg_iu.c:423)
20230629191816159 DIUCS DEBUG msc_a(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5e37e0]{MSC_A_ST_AUTH_CIPH}: RAN encode: RANAP: Tx RANAP SECURITY MODE COMMAND to RNC, IK=3be7c31d1aa530628f8c57783bbcff97, CK=3be7c31d1aa530628f8c57783bbcff97 (ran_msg_iu.c:388)
20230629191816278 DIUCS DEBUG (UTRAN-Iu-21) sccp_ran_sap_up(N-DATA.indication) (sccp_ran.c:108)                                
20230629191816278 DIUCS DEBUG msc_i(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5e36b0]{READY}: RAN decode: RANAP: dir=2 proc=6 (ran_msg_iu.c:274)
20230629191816278 DIUCS DEBUG msc_a(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5e37e0]{MSC_A_ST_AUTH_CIPH}: RAN decode: RANAP: dir=2 proc=6 (ran_msg_iu.c:274)
20230629191816278 DIUCS DEBUG msc_a(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5e37e0]{MSC_A_ST_AUTH_CIPH}: RAN decode: RANAP SecurityModeControl successfulOutcome (msc_a.c:1775)
20230629191816278 DIUCS DEBUG msc_a(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5e37e0]{MSC_A_ST_AUTH_CIPH}: RAN encode: RANAP: CommonId (ran_msg_iu.c:431)
20230629191816418 DIUCS DEBUG (UTRAN-Iu-21) sccp_ran_sap_up(N-DATA.indication) (sccp_ran.c:108)
20230629191816419 DIUCS DEBUG msc_i(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5e36b0]{READY}: RAN decode: RANAP: dir=1 proc=20 (ran_msg_iu.c:274)
20230629191816419 DIUCS DEBUG msc_a(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5e37e0]{MSC_A_ST_AUTHENTICATED}: RAN decode: RANAP: dir=1 proc=20 (ran_msg_iu.c:274)
20230629191816419 DIUCS DEBUG msc_a(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5e37e0]{MSC_A_ST_AUTHENTICATED}: RAN decode: RANAP DirectTransfer RAN PDU (msc_a.c:1775)
20230629191816419 DCC DEBUG trans(CC:NULL IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C callref-0x80000003 tid-8) New transaction (transaction.c:224)
20230629191816419 DCC DEBUG trans(CC:NULL IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ callref-0x80000003 tid-8) rx SETUP in state NULL (gsm_04_08_cc.c:2577)
20230629191816419 DCC DEBUG trans(CC:NULL IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ callref-0x80000003 tid-8) starting guard timer with 180 seconds (gsm_04_08_cc.c:124)
20230629191816420 DCC NOTICE LCLS disabled globally (transaction.c:128)
20230629191816420 DCC DEBUG trans(CC:NULL IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ callref-0x80000003 tid-8) codecs: :0{AMR:octet-align=1#112,AMR-WB/16000:octet-align=1#113} (from: MS={AMR-WB/16000:octet-align=1#113,AMR:octet-align=1#112,GSM-EFR#110,GSM#3,GSM-HR-08#111} RAN={AMR:octet-align=1#112,AMR-WB/16000:octet-align=1#113}) (transaction_cc.c:55)
20230629191816420 DCC INFO trans(CC:NULL IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ callref-0x80000003 tid-8) SETUP to 46740 (gsm_04_08_cc.c:681)
20230629191816420 DCC DEBUG trans(CC:NULL IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ callref-0x80000003 tid-8) new state NULL -> INITIATED (gsm_04_08_cc.c:194)
20230629191816420 DIUCS DEBUG msc_a(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5e37e0]{MSC_A_ST_COMMUNICATING}: Starting call assignment (msc_a.c:1938)
20230629191816420 DCC DEBUG call_leg(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5de9a0]{ESTABLISHING}: Allocated (fsm.c:456)
20230629191816420 DCC DEBUG call_leg(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5de9a0]{ESTABLISHING}: is child of msc_a(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5e37e0] (fsm.c:486)
20230629191816420 DCC DEBUG trans(CC:INITIATED IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ callref-0x80000003 tid-8) codecs: :0{AMR:octet-align=1#112,AMR-WB/16000:octet-align=1#113} (from: MS={AMR-WB/16000:octet-align=1#113,AMR:octet-align=1#112,GSM-EFR#110,GSM#3,GSM-HR-08#111} RAN={AMR:octet-align=1#112,AMR-WB/16000:octet-align=1#113}) (transaction_cc.c:55)
20230629191816420 DCC DEBUG rtp_stream(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5f1b80]{UNINITIALIZED}: Allocated (fsm.c:456)
20230629191816420 DCC DEBUG rtp_stream(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5f1b80]{UNINITIALIZED}: is child of call_leg(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5de9a0] (fsm.c:486)
20230629191816421 DCC DEBUG rtp_stream(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ:trans-8:call-2147483651:RTP_TO_CN:no-CI)[0x557e0d5f1b80]{UNINITIALIZED}: setting codecs to AMR:octet-align=1#112,AMR-WB/16000:octet-align=1#113 (rtp_stream.c:421)
20230629191816421 DCC DEBUG rtp_stream(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ:trans-8:call-2147483651:RTP_TO_CN:no-CI)[0x557e0d5f1b80]{UNINITIALIZED}: State change to ESTABLISHING (X2, 30s) (rtp_stream.c:359)
20230629191816421 DCC DEBUG rtp_stream(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5e5190]{UNINITIALIZED}: Allocated (fsm.c:456)
20230629191816421 DCC DEBUG rtp_stream(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5e5190]{UNINITIALIZED}: is child of call_leg(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5de9a0] (fsm.c:486)
20230629191816421 DCC DEBUG rtp_stream(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ:trans-8:call-2147483651:RTP_TO_RAN:no-CI)[0x557e0d5e5190]{UNINITIALIZED}: setting codecs to VND.3GPP.IUFP/16000#96 (rtp_stream.c:421)
20230629191816421 DCC DEBUG rtp_stream(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ:trans-8:call-2147483651:RTP_TO_RAN:no-CI)[0x557e0d5e5190]{UNINITIALIZED}: State change to ESTABLISHING (X2, 30s) (rtp_stream.c:359)

20230629191816423 DLMGCP ERROR ptmap contains illegal mapping: codec=4294967295 maps to pt=96 (mgcp_client.c:128)

  ^^ HERE

20230629191816423 DCC DEBUG rtp_stream(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ:trans-8:call-2147483651:RTP_TO_CN:no-CI)[0x557e0d5f1b80]{ESTABLISHING}: Received Event RTP_STREAM_EV_CRCX_OK (mgcp_client_endpoint_fsm.c:513)
20230629191816424 DCC DEBUG call_leg(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5de9a0]{ESTABLISHING}: Received Event CALL_LEG_EV_RTP_STREAM_ADDR_AVAILABLE (rtp_stream.c:172)
20230629191816425 DIUCS DEBUG msc_a(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5e37e0]{MSC_A_ST_COMMUNICATING}: MGW endpoint's RTP address available for the CI RTP_TO_CN: 127.0.0.1:4014 (osmux=no:-2) (msc_a.c:789)
20230629191816425 DMNCC DEBUG trans(CC:INITIATED IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ callref-0x80000003 tid-8) tx MNCC_SETUP_IND (RTP=127.0.0.1:4014{AMR:octet-align=1#112,AMR-WB/16000:octet-align=1#113}) (gsm_04_08_cc.c:300)
20230629191816425 DMNCC DEBUG (call 80000003) Call created. (mncc_builtin.c:291)            
20230629191816425 DMNCC DEBUG (call 80000003) Received message MNCC_SETUP_IND (mncc_builtin.c:300)
20230629191816425 DMNCC DEBUG (call 80000003, remote 3) Creating new remote instance. (mncc_builtin.c:107)
20230629191816425 DMNCC DEBUG (call 80000003, remote 3) Accepting call. (mncc_builtin.c:117)              
20230629191816425 DMNCC DEBUG trans(CC:INITIATED IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ callref-0x80000003 tid-8) rx MNCC_CALL_PROC_REQ (gsm_04_08_cc.c:2369)
20230629191816425 DCC DEBUG trans(CC:INITIATED IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ callref-0x80000003 tid-8) stopping pending guard timer (gsm_04_08_cc.c:107)
20230629191816425 DCC DEBUG trans(CC:INITIATED IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ callref-0x80000003 tid-8) starting guard timer with 180 seconds (gsm_04_08_cc.c:124)
20230629191816425 DCC DEBUG trans(CC:INITIATED IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ callref-0x80000003 tid-8) new state INITIATED -> MO_CALL_PROC (gsm_04_08_cc.c:194)
20230629191816425 DIUCS DEBUG msc_a(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5e37e0]{MSC_A_ST_COMMUNICATING}: Sending DTAP: CC GSM48_MT_CC_CALL_PROC (msc_a.c:1838)
20230629191816426 DIUCS DEBUG msc_a(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5e37e0]{MSC_A_ST_COMMUNICATING}: RAN encode: RANAP: DirectTransfer (ran_msg_iu.c:417)
20230629191816426 DIUCS DEBUG msc_a(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5e37e0]{MSC_A_ST_COMMUNICATING}: Assignment for this trans already started earlier (msc_a.c:1929)
20230629191816426 DMNCC DEBUG (call 80000003, remote 3) Modify channel mode. (mncc_builtin.c:124)
20230629191816426 DMNCC DEBUG trans(CC:MO_CALL_PROC IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ callref-0x80000003 tid-8) rx MNCC_LCHAN_MODIFY (gsm_04_08_cc.c:2369)
20230629191816426 DCC DEBUG trans(CC:MO_CALL_PROC IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ callref-0x80000003 tid-8) stopping pending guard timer (gsm_04_08_cc.c:107)
20230629191816426 DCC DEBUG trans(CC:MO_CALL_PROC IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ callref-0x80000003 tid-8) starting guard timer with 180 seconds (gsm_04_08_cc.c:124)
20230629191816426 DCC DEBUG trans(CC:MO_CALL_PROC IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ callref-0x80000003 tid-8) Message 'MNCC_LCHAN_MODIFY' unhandled at state 'MO_CALL_PROC' (gsm_04_08_cc.c:2400)
20230629191816427 DMNCC DEBUG (call 80000003, remote 3) Forwarding SETUP to remote. (mncc_builtin.c:132)
20230629191816427 DCC DEBUG trans(CC:NULL IMSI-901700000046740:MSISDN-46740:TMSI-0x2373396F callref-0x3 tid-255) New transaction (transaction.c:224)
20230629191816427 DMNCC DEBUG trans(CC:NULL IMSI-901700000046740:MSISDN-46740:TMSI-0x2373396F callref-0x3 tid-255) rx MNCC_SETUP_REQ (RTP=127.0.0.1:4014{AMR:octet-align=1#112,AMR-WB/16000:octet-align=1#113}) (gsm_04_08_cc.c:2342)
20230629191816430 DCC DEBUG rtp_stream(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ:trans-8:call-2147483651:RTP_TO_RAN:no-CI)[0x557e0d5e5190]{ESTABLISHING}: Received Event RTP_STREAM_EV_CRCX_OK (mgcp_client_endpoint_fsm.c:513)
20230629191816430 DCC DEBUG call_leg(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5de9a0]{ESTABLISHING}: Received Event CALL_LEG_EV_RTP_STREAM_ADDR_AVAILABLE (rtp_stream.c:172)
20230629191816431 DIUCS DEBUG msc_a(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5e37e0]{MSC_A_ST_COMMUNICATING}: MGW endpoint's RTP address available for the CI RTP_TO_RAN: 127.0.0.1:4016 (osmux=no:-2) (msc_a.c:789)
20230629191816431 DCC DEBUG trans(CC:MO_CALL_PROC IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ callref-0x80000003 tid-8) codecs: 127.0.0.1:4014{AMR:octet-align=1#112,AMR-WB/16000:octet-align=1#113} (from: MS={AMR-WB/16000:octet-align=1#113,AMR:octet-align=1#112,GSM-EFR#110,GSM#3,GSM-HR-08#111} RAN={AMR:octet-align=1#112,AMR-WB/16000:octet-align=1#113}) (transaction_cc.c:55)
20230629191816432 DCC DEBUG trans(CC:MO_CALL_PROC IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ callref-0x80000003 tid-8) Sending Assignment Command (msc_a.c:641)
20230629191816432 DIUCS DEBUG msc_a(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5e37e0]{MSC_A_ST_COMMUNICATING}: RAN encode: RANAP: RAB AssignmentRequest (ran_msg_iu.c:427)
20230629191816432 DIUCS DEBUG msc_a(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5e37e0]{MSC_A_ST_COMMUNICATING}: RAN encode: RANAP: RAB Assignment: rab_id=3, rtp=127.0.0.1:4016, use_x213_nsap=1 (ran_msg_iu.c:371)
20230629191816578 DIUCS DEBUG (UTRAN-Iu-22 from RI=SSN_PC,PC=0.23.5,SSN=RANAP) sccp_ran_sap_up(N-CONNECT.indication) (sccp_ran.c:84)
20230629191816579 DIUCS DEBUG msc_a(unknown:UTRAN-Iu-22:NONE)[0x557e0d5e5b20]{MSC_A_ST_VALIDATE_L3}: RAN decode: RANAP: dir=1 proc=19 (ran_msg_iu.c:274)
20230629191816579 DIUCS DEBUG msc_a(unknown:UTRAN-Iu-22:NONE)[0x557e0d5e5b20]{MSC_A_ST_VALIDATE_L3}: RAN decode: RANAP InitialUE RAN PDU (msc_a.c:1775) 
20230629191816579 DMM DEBUG Tx AUTH REQ (rand = d093bb9e76662559238770cc77f2ac15) (gsm_04_08.c:645)                                                    
20230629191816579 DMM DEBUG    AUTH REQ (autn = e5b8f599fe5d00004e21b93c38f385e0) (gsm_04_08.c:647)
20230629191816579 DIUCS DEBUG msc_a(IMSI-901700000046740:MSISDN-46740:TMSI-0x2373396F:UTRAN-Iu-22:PAGING_RESP)[0x557e0d5e5b20]{MSC_A_ST_AUTH_CIPH}: Sending DTAP: MM GSM48_MT_MM_AUTH_REQ (msc_a.c:1838)
20230629191816580 DIUCS DEBUG msc_a(IMSI-901700000046740:MSISDN-46740:TMSI-0x2373396F:UTRAN-Iu-22:PAGING_RESP)[0x557e0d5e5b20]{MSC_A_ST_AUTH_CIPH}: RAN encode: RANAP: DirectTransfer (ran_msg_iu.c:417)
20230629191816798 DIUCS DEBUG (UTRAN-Iu-22) sccp_ran_sap_up(N-DATA.indication) (sccp_ran.c:108)
20230629191816798 DIUCS DEBUG msc_i(IMSI-901700000046740:MSISDN-46740:TMSI-0x2373396F:UTRAN-Iu-22:PAGING_RESP)[0x557e0d5e59f0]{READY}: RAN decode: RANAP: dir=1 proc=20 (ran_msg_iu.c:274)
20230629191816799 DIUCS DEBUG msc_a(IMSI-901700000046740:MSISDN-46740:TMSI-0x2373396F:UTRAN-Iu-22:PAGING_RESP)[0x557e0d5e5b20]{MSC_A_ST_AUTH_CIPH}: RAN decode: RANAP: dir=1 proc=20 (ran_msg_iu.c:274)
20230629191816799 DIUCS DEBUG msc_a(IMSI-901700000046740:MSISDN-46740:TMSI-0x2373396F:UTRAN-Iu-22:PAGING_RESP)[0x557e0d5e5b20]{MSC_A_ST_AUTH_CIPH}: RAN decode: RANAP DirectTransfer RAN PDU (msc_a.c:1775)
20230629191816799 DMM DEBUG msc_a(IMSI-901700000046740:MSISDN-46740:TMSI-0x2373396F:UTRAN-Iu-22:PAGING_RESP)[0x557e0d5e5b20]{MSC_A_ST_AUTH_CIPH}: MM UMTS AUTHENTICATION RESPONSE (res = 01d8d80d2931bee3) (gsm_04_08.c:1132)
20230629191816799 DIUCS DEBUG msc_a(IMSI-901700000046740:MSISDN-46740:TMSI-0x2373396F:UTRAN-Iu-22:PAGING_RESP)[0x557e0d5e5b20]{MSC_A_ST_AUTH_CIPH}: RAN encode: RANAP: SecurityModeCommand (ran_msg_iu.c:423)
20230629191816799 DIUCS DEBUG msc_a(IMSI-901700000046740:MSISDN-46740:TMSI-0x2373396F:UTRAN-Iu-22:PAGING_RESP)[0x557e0d5e5b20]{MSC_A_ST_AUTH_CIPH}: RAN encode: RANAP: Tx RANAP SECURITY MODE COMMAND to RNC, IK=6dbb0b9f33ab491ff3a5caad05ec0f2b, CK=6dbb0b9f33ab491ff3a5caad05ec0f2b (ran_msg_iu.c:388)
20230629191816898 DIUCS DEBUG (UTRAN-Iu-22) sccp_ran_sap_up(N-DATA.indication) (sccp_ran.c:108)                             
20230629191816898 DIUCS DEBUG msc_i(IMSI-901700000046740:MSISDN-46740:TMSI-0x2373396F:UTRAN-Iu-22:PAGING_RESP)[0x557e0d5e59f0]{READY}: RAN decode: RANAP: dir=2 proc=6 (ran_msg_iu.c:274)
20230629191816899 DIUCS DEBUG msc_a(IMSI-901700000046740:MSISDN-46740:TMSI-0x2373396F:UTRAN-Iu-22:PAGING_RESP)[0x557e0d5e5b20]{MSC_A_ST_AUTH_CIPH}: RAN decode: RANAP: dir=2 proc=6 (ran_msg_iu.c:274)
20230629191816899 DIUCS DEBUG msc_a(IMSI-901700000046740:MSISDN-46740:TMSI-0x2373396F:UTRAN-Iu-22:PAGING_RESP)[0x557e0d5e5b20]{MSC_A_ST_AUTH_CIPH}: RAN decode: RANAP SecurityModeControl successfulOutcome (msc_a.c:1775)
20230629191816899 DIUCS DEBUG msc_a(IMSI-901700000046740:MSISDN-46740:TMSI-0x2373396F:UTRAN-Iu-22:PAGING_RESP)[0x557e0d5e5b20]{MSC_A_ST_AUTH_CIPH}: RAN encode: RANAP: CommonId (ran_msg_iu.c:431)
20230629191816899 DCC DEBUG trans(CC:NULL IMSI-901700000046740:MSISDN-46740:TMSI-0x2373396F callref-0x3 tid-255) Paging succeeded (gsm_04_08_cc.c:379)
20230629191816899 DCC NOTICE LCLS disabled globally (transaction.c:128)                                                                               
20230629191816899 DCC DEBUG trans(CC:NULL IMSI-901700000046740:MSISDN-46740:TMSI-0x2373396F:UTRAN-Iu-22:PAGING_RESP callref-0x3 tid-0) starting timer T303 with 30 seconds (gsm_04_08_cc.c:565)
20230629191816900 DCC DEBUG trans(CC:NULL IMSI-901700000046740:MSISDN-46740:TMSI-0x2373396F:UTRAN-Iu-22:PAGING_RESP callref-0x3 tid-0) codecs: :0{AMR:octet-align=1#112,AMR-WB/16000:octet-align=1#113} (from: remote=127.0.0.1:4014{AMR:octet-align=1#112,AMR-WB/16000:octet-align=1#113} RAN={AMR:octet-align=1#112,AMR-WB/16000:octet-align=1#113}) (transaction_cc.c:55)
20230629191816900 DCC DEBUG trans(CC:NULL IMSI-901700000046740:MSISDN-46740:TMSI-0x2373396F:UTRAN-Iu-22:PAGING_RESP callref-0x3 tid-0) new state NULL -> CALL_PRESENT (gsm_04_08_cc.c:194)
20230629191816900 DIUCS DEBUG msc_a(IMSI-901700000046740:MSISDN-46740:TMSI-0x2373396F:UTRAN-Iu-22:PAGING_RESP)[0x557e0d5e5b20]{MSC_A_ST_COMMUNICATING}: Sending DTAP: CC GSM48_MT_CC_SETUP (msc_a.c:1838)
20230629191816900 DIUCS DEBUG msc_a(IMSI-901700000046740:MSISDN-46740:TMSI-0x2373396F:UTRAN-Iu-22:PAGING_RESP)[0x557e0d5e5b20]{MSC_A_ST_COMMUNICATING}: RAN encode: RANAP: DirectTransfer (ran_msg_iu.c:417)
20230629191817038 DIUCS DEBUG (UTRAN-Iu-22) sccp_ran_sap_up(N-DATA.indication) (sccp_ran.c:108)
20230629191817038 DIUCS DEBUG msc_i(IMSI-901700000046740:MSISDN-46740:TMSI-0x2373396F:UTRAN-Iu-22:PAGING_RESP)[0x557e0d5e59f0]{READY}: RAN decode: RANAP: dir=1 proc=20 (ran_msg_iu.c:274)
20230629191817038 DIUCS DEBUG msc_a(IMSI-901700000046740:MSISDN-46740:TMSI-0x2373396F:UTRAN-Iu-22:PAGING_RESP)[0x557e0d5e5b20]{MSC_A_ST_COMMUNICATING}: RAN decode: RANAP: dir=1 proc=20 (ran_msg_iu.c:274)
20230629191817038 DIUCS DEBUG msc_a(IMSI-901700000046740:MSISDN-46740:TMSI-0x2373396F:UTRAN-Iu-22:PAGING_RESP)[0x557e0d5e5b20]{MSC_A_ST_COMMUNICATING}: RAN decode: RANAP DirectTransfer RAN PDU (msc_a.c:1775)
20230629191817039 DCC DEBUG trans(CC:CALL_PRESENT IMSI-901700000046740:MSISDN-46740:TMSI-0x2373396F:UTRAN-Iu-22:PAGING_RESP callref-0x3 tid-0) rx RELEASE_COMPL in state CALL_PRESENT (gsm_04_08_cc.c:2577)
20230629191817039 DCC DEBUG trans(CC:CALL_PRESENT IMSI-901700000046740:MSISDN-46740:TMSI-0x2373396F:UTRAN-Iu-22:PAGING_RESP callref-0x3 tid-0) stopping pending timer T303 (gsm_04_08_cc.c:228)
20230629191817039 DMNCC DEBUG trans(CC:CALL_PRESENT IMSI-901700000046740:MSISDN-46740:TMSI-0x2373396F:UTRAN-Iu-22:PAGING_RESP callref-0x3 tid-0) tx MNCC_REJ_IND (gsm_04_08_cc.c:300)
20230629191817039 DMNCC DEBUG (call 3) Received message MNCC_REJ_IND (mncc_builtin.c:300)
20230629191817039 DMNCC DEBUG (call 3, remote 80000003) Releasing remote with cause 88 (mncc_builtin.c:234)
20230629191817039 DMNCC DEBUG (call 3) Call removed. (mncc_builtin.c:49)                                   
20230629191817039 DMNCC DEBUG trans(CC:MO_CALL_PROC IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ callref-0x80000003 tid-8) rx MNCC_REL_REQ (gsm_04_08_cc.c:2369)
20230629191817039 DCC DEBUG trans(CC:MO_CALL_PROC IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ callref-0x80000003 tid-8) stopping pending guard timer (gsm_04_08_cc.c:107)
20230629191817039 DCC DEBUG trans(CC:MO_CALL_PROC IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ callref-0x80000003 tid-8) starting guard timer with 180 seconds (gsm_04_08_cc.c:124)
20230629191817039 DCC DEBUG trans(CC:MO_CALL_PROC IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ callref-0x80000003 tid-8) starting timer T308 with 10 seconds (gsm_04_08_cc.c:565)
20230629191817039 DCC DEBUG trans(CC:MO_CALL_PROC IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ callref-0x80000003 tid-8) new state MO_CALL_PROC -> RELEASE_REQ (gsm_04_08_cc.c:194)
20230629191817039 DIUCS DEBUG msc_a(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5e37e0]{MSC_A_ST_COMMUNICATING}: Sending DTAP: CC GSM48_MT_CC_RELEASE (msc_a.c:1838)
20230629191817039 DIUCS DEBUG msc_a(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5e37e0]{MSC_A_ST_COMMUNICATING}: RAN encode: RANAP: DirectTransfer (ran_msg_iu.c:417)
20230629191817040 DCC DEBUG trans(CC:CALL_PRESENT IMSI-901700000046740:MSISDN-46740:TMSI-0x2373396F:UTRAN-Iu-22:PAGING_RESP callref-0x0 tid-0) Freeing transaction (transaction.c:236)
20230629191817040 DCC DEBUG trans(CC:CALL_PRESENT IMSI-901700000046740:MSISDN-46740:TMSI-0x2373396F:UTRAN-Iu-22:PAGING_RESP callref-0x0 tid-0) new state CALL_PRESENT -> NULL (gsm_04_08_cc.c:194)
20230629191817040 DIUCS DEBUG msc_a(IMSI-901700000046740:MSISDN-46740:TMSI-0x2373396F:UTRAN-Iu-22:PAGING_RESP)[0x557e0d5e5b20]{MSC_A_ST_RELEASING}: Releasing: msc_a use is 0 (-) (msc_a.c:880)
20230629191817040 DIUCS DEBUG msc_a(IMSI-901700000046740:MSISDN-46740:TMSI-0x2373396F:UTRAN-Iu-22:PAGING_RESP)[0x557e0d5e5b20]{MSC_A_ST_RELEASING}: RAN encode: RANAP: Iu Release (ran_msg_iu.c:435)
20230629191817043 DIUCS DEBUG (UTRAN-Iu-22) sccp_ran_sap_up(N-DISCONNECT.indication) (sccp_ran.c:116)
20230629191817043 DIUCS DEBUG msc_i(IMSI-901700000046740:MSISDN-46740:TMSI-0x2373396F:UTRAN-Iu-22:PAGING_RESP)[0x557e0d5e59f0]{READY}: RAN decode: RANAP: dir=2 proc=1 (ran_msg_iu.c:274)
20230629191817044 DIUCS DEBUG msc_a(IMSI-901700000046740:MSISDN-46740:TMSI-0x2373396F:UTRAN-Iu-22:PAGING_RESP)[0x557e0d5e5b20]{MSC_A_ST_RELEASING}: RAN decode: RANAP: dir=2 proc=1 (ran_msg_iu.c:274)
20230629191817044 DIUCS DEBUG msc_a(IMSI-901700000046740:MSISDN-46740:TMSI-0x2373396F:UTRAN-Iu-22:PAGING_RESP)[0x557e0d5e5b20]{MSC_A_ST_RELEASING}: RAN decode: RANAP Iu Release successfulOutcome (msc_a.c:1775)
20230629191817044 DIUCS DEBUG msc_a(IMSI-901700000046740:MSISDN-46740:TMSI-0x2373396F:UTRAN-Iu-22:PAGING_RESP)[0x557e0d5e5b20]{MSC_A_ST_RELEASED}: Released: msc_a use is 1 (msc_a_ran_dec) (msc_a.c:973)
20230629191817044 DIUCS DEBUG ran_peer(UTRAN-Iu:RI-SSN_PC:PC-0-23-5:SSN-RANAP)[0x557e0d5e1300]{READY}: Closing UTRAN-Iu-22 (ran_conn.c:142)
20230629191817158 DIUCS DEBUG (UTRAN-Iu-21) sccp_ran_sap_up(N-DATA.indication) (sccp_ran.c:108)                                            
20230629191817158 DIUCS DEBUG msc_i(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5e36b0]{READY}: RAN decode: RANAP: dir=1 proc=20 (ran_msg_iu.c:274)
20230629191817159 DIUCS DEBUG msc_a(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5e37e0]{MSC_A_ST_COMMUNICATING}: RAN decode: RANAP: dir=1 proc=20 (ran_msg_iu.c:274)
20230629191817159 DIUCS DEBUG msc_a(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5e37e0]{MSC_A_ST_COMMUNICATING}: RAN decode: RANAP DirectTransfer RAN PDU (msc_a.c:1775)
20230629191817159 DCC DEBUG trans(CC:RELEASE_REQ IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ callref-0x80000003 tid-8) rx RELEASE_COMPL in state RELEASE_REQ (gsm_04_08_cc.c:2577)
20230629191817159 DCC DEBUG trans(CC:RELEASE_REQ IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ callref-0x80000003 tid-8) stopping pending timer T308 (gsm_04_08_cc.c:228)
20230629191817159 DMNCC DEBUG trans(CC:RELEASE_REQ IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ callref-0x80000003 tid-8) tx MNCC_REL_CNF (gsm_04_08_cc.c:300)
20230629191817159 DMNCC DEBUG (call 80000003) Received message MNCC_REL_CNF (mncc_builtin.c:300)
20230629191817159 DMNCC DEBUG (call 80000003) Call removed. (mncc_builtin.c:49)                 
20230629191817159 DCC DEBUG trans(CC:RELEASE_REQ IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ callref-0x0 tid-8) Freeing transaction (transaction.c:236)
20230629191817159 DCC DEBUG trans(CC:RELEASE_REQ IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ callref-0x0 tid-8) new state RELEASE_REQ -> NULL (gsm_04_08_cc.c:194)
20230629191817159 DCC DEBUG trans(CC:NULL IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ callref-0x0 tid-8) stopping pending guard timer (gsm_04_08_cc.c:107)
20230629191817159 DIUCS DEBUG msc_a(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5e37e0]{MSC_A_ST_RELEASING}: Releasing: msc_a use is 0 (-) (msc_a.c:880)
20230629191817159 DCC DEBUG call_leg(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5de9a0]{ESTABLISHING}: State change to RELEASING (X2, 30s) (call_leg.c:120)
20230629191817160 DCC DEBUG rtp_stream(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ:trans-8:call-2147483651:RTP_TO_RAN:CI-99CCA3A0:no-remote-port:local-127-0-0-1-4016)[0x557e0d5e5190]{ESTABLISHING}: Terminating (cause = OSMO_FSM_TERM_PARENT) (call_leg.c:196)
20230629191817160 DCC DEBUG rtp_stream(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ:trans-8:call-2147483651:RTP_TO_RAN:CI-99CCA3A0:no-remote-port:local-127-0-0-1-4016)[0x557e0d5e5190]{ESTABLISHING}: Removing from parent call_leg(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5de9a0] (call_leg.c:196)
20230629191817160 DCC DEBUG rtp_stream(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ:trans-8:call-2147483651:RTP_TO_RAN:CI-99CCA3A0:no-remote-port:local-127-0-0-1-4016)[0x557e0d5e5190]{ESTABLISHING}: Freeing instance (call_leg.c:196)
20230629191817160 DCC DEBUG rtp_stream(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ:trans-8:call-2147483651:RTP_TO_RAN:CI-99CCA3A0:no-remote-port:local-127-0-0-1-4016)[0x557e0d5e5190]{ESTABLISHING}: Deallocated (fsm.c:568)
20230629191817160 DCC DEBUG rtp_stream(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ:trans-8:call-2147483651:RTP_TO_CN:CI-EB91CD03:no-remote-port:local-127-0-0-1-4014)[0x557e0d5f1b80]{ESTABLISHING}: Terminating (cause = OSMO_FSM_TERM_PARENT) (call_leg.c:196)
20230629191817160 DCC DEBUG rtp_stream(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ:trans-8:call-2147483651:RTP_TO_CN:CI-EB91CD03:no-remote-port:local-127-0-0-1-4014)[0x557e0d5f1b80]{ESTABLISHING}: Removing from parent call_leg(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5de9a0] (call_leg.c:196)
20230629191817160 DCC DEBUG call_leg(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5de9a0]{RELEASING}: Received Event CALL_LEG_EV_MGW_ENDPOINT_GONE (mgcp_client_endpoint_fsm.c:869)
20230629191817160 DCC DEBUG rtp_stream(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ:trans-8:call-2147483651:RTP_TO_CN:CI-EB91CD03:no-remote-port:local-127-0-0-1-4014)[0x557e0d5f1b80]{ESTABLISHING}: Freeing instance (call_leg.c:196)
20230629191817160 DCC DEBUG rtp_stream(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ:trans-8:call-2147483651:RTP_TO_CN:CI-EB91CD03:no-remote-port:local-127-0-0-1-4014)[0x557e0d5f1b80]{ESTABLISHING}: Deallocated (fsm.c:568)
20230629191817160 DCC DEBUG call_leg(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5de9a0]{RELEASING}: Terminating (cause = OSMO_FSM_TERM_REGULAR) (call_leg.c:197)
20230629191817160 DCC DEBUG call_leg(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5de9a0]{RELEASING}: Removing from parent msc_a(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5e37e0] (call_leg.c:197)
20230629191817160 DCC DEBUG call_leg(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5de9a0]{RELEASING}: Freeing instance (call_leg.c:197)
20230629191817160 DCC DEBUG call_leg(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5de9a0]{RELEASING}: Deallocated (fsm.c:568)
20230629191817161 DIUCS DEBUG msc_a(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5e37e0]{MSC_A_ST_RELEASING}: RAN encode: RANAP: Iu Release (ran_msg_iu.c:435)
20230629191817163 DIUCS DEBUG (UTRAN-Iu-21) sccp_ran_sap_up(N-DISCONNECT.indication) (sccp_ran.c:116)
20230629191817164 DIUCS DEBUG msc_i(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5e36b0]{READY}: RAN decode: RANAP: dir=2 proc=1 (ran_msg_iu.c:274)
20230629191817164 DIUCS DEBUG msc_a(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5e37e0]{MSC_A_ST_RELEASING}: RAN decode: RANAP: dir=2 proc=1 (ran_msg_iu.c:274)
20230629191817164 DIUCS DEBUG msc_a(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5e37e0]{MSC_A_ST_RELEASING}: RAN decode: RANAP Iu Release successfulOutcome (msc_a.c:1775)
20230629191817164 DIUCS DEBUG msc_a(IMSI-901700000046968:MSISDN-46968:TMSI-0x4975067C:UTRAN-Iu-21:CM_SERVICE_REQ)[0x557e0d5e37e0]{MSC_A_ST_RELEASED}: Released: msc_a use is 1 (msc_a_ran_dec) (msc_a.c:973)
20230629191817165 DIUCS DEBUG ran_peer(UTRAN-Iu:RI-SSN_PC:PC-0-23-5:SSN-RANAP)[0x557e0d5e1300]{READY}: Closing UTRAN-Iu-21 (ran_conn.c:142)
Actions
Copy link
 #2

Updated by neels 10 months ago

  • Related to Bug #6074: Current master as of 2023-06-25 broken in my environment added
Actions
Copy link
 #3

Updated by neels 10 months ago

  • Status changed from New to Resolved

The same error was also reported in #6047 and a fix was merged: https://gerrit.osmocom.org/c/osmo-mgw/+/33527
Testing with this, i no longer see the error.

Actions
Copy link
 #4

Updated by keith 9 months ago

For future referece, ^^ that should be #6074

Actions
Copy link

Also available in: Atom PDF

Add picture from clipboard (Maximum size: 48.8 MB)