Calls not being completed

[marvdias]

I am currently trying to make 'internal' calls between clients, I already check and both clients have credits, however it does not complete the dial. OpenBSC log:

<0004> abis_rsl.c:1852 BTS 0 CHAN RQD: reason: call re-establishment (ra=0x4d, neci=0x01, chreq_reason=0x02)
<0000> chan_alloc.c:352 (bts=0,trx=0,ts=3,pchan=TCH/F) Allocating lchan=0 as TCH_F
<0004> abis_rsl.c:1922 (bts=0,trx=0,ts=3,ss=0) Activating ARFCN(65) SS(0) lctype TCH_F r=CALL ra=0x4d ta=0
<0004> abis_rsl.c:595 (bts=0,trx=0,ts=3,pchan=TCH/F) Tx RSL Channel Activate with act_type=INITIAL
<0004> abis_rsl.c:1231 (bts=0,trx=0,ts=3,ss=0) state NONE -> ACTIVATION REQUESTED
<0004> abis_rsl.c:1603 (bts=0,trx=0,ts=3,ss=0) CHANNEL ACTIVATE ACK
<0004> abis_rsl.c:1231 (bts=0,trx=0,ts=3,ss=0) state ACTIVATION REQUESTED -> ACTIVE
<0000> abis_rsl.c:2125 (bts=0,trx=0,ts=3,ss=0) SAPI=0 ESTABLISH INDICATION
<0000> gsm_04_08.c:4007 Dispatching 04.08 message, pdisc=5
<0002> gsm_04_08.c:1024 <- CM SERVICE REQUEST serv_type=0x01 MI(TMSI)=608646690
<000d> db.c:1307 Sync Equipment IMEI=355320084208080, classmark1=33, classmark2=33 19 82 , classmark3=60 14 04 62 88 10 01 27 e0 00
<0002> gsm_04_08_utils.c:667 -> CM SERVICE ACK
<0000> abis_rsl.c:2125 (bts=0,trx=0,ts=3,ss=0) SAPI=0 DATA INDICATION
<0003> bsc_api.c:605 GPRS SUSPENSION REQUEST
<0000> abis_rsl.c:2125 (bts=0,trx=0,ts=3,ss=0) SAPI=0 DATA INDICATION
<0000> gsm_04_08.c:4007 Dispatching 04.08 message, pdisc=3
<0001> gsm_04_08.c:3902 (bts 0 trx 0 ts 3 ti 8 sub 15555581408) Received 'SETUP' from MS in state 0 (NULL)
<0001> gsm_04_08.c:3907 Unknown transaction ID 8, creating new trans.
<0001> transaction.c:71 subscr=0x557d746ddbc0, net=0x557d7453bdb0
<0001> gsm_04_08.c:1631 new state NULL -> INITIATED
<0001> gsm_04_08.c:2310 Subscriber Marcus Dias (15555581408) sends SETUP to 15555579368
<0001> gsm_04_08.c:1693 (bts 0 trx 0 ts 3 ti 8 sub 15555581408) Sending 'MNCC_SETUP_IND' to MNCC.
<0006> gsm_04_08.c:3593 receive message MNCC_RTP_CREATE
<0006> gsm_04_08.c:3424 RTP create: codec=SPEECH_V1, chan_type=TCH_F
<000a> bsc_api.c:415 Sending (bts=0,trx=0,ts=3,ss=0) ChanModify for speech: SPEECH_V1 on channel TCH_F
<0003> gsm_04_08_utils.c:517 -> CHANNEL MODE MODIFY mode=0x01
<0000> abis_rsl.c:2125 (bts=0,trx=0,ts=3,ss=0) SAPI=0 DATA INDICATION
<0003> gsm_04_08_utils.c:542 CHANNEL MODE MODIFY ACK
<0004> abis_rsl.c:2342 (bts=0,trx=0,ts=3,ss=0) IPAC_BIND speech_mode=0x10 RTP_PAYLOAD=3
<0003> osmo_msc.c:76 MSC assign complete (do nothing).
<0004> abis_rsl.c:1624 (bts=0,trx=0,ts=3,ss=0) CHANNEL MODE MODIFY ACK
<0004> abis_rsl.c:2523 (bts=0,trx=0,ts=3,ss=0) IPAC_CRCX_ACK LOCAL_IP=200.239.93.157 LOCAL_PORT=39406 CON_ID=0 <0006> gsm_04_08.c:3500 (bts=0,trx=0,ts=3,ss=0) sending pending RTP create ind.
<0001> gsm_04_08.c:1701 (bts - trx - ts - ti -- sub -) Sending 'MNCC_RTP_CREATE' to MNCC.

<0006> gsm_04_08.c:3593 receive message MNCC_CALL_PROC_REQ
<0001> gsm_04_08.c:3804 (bts 0 trx 0 ts 3 ti 08 sub 15555581408) Received 'MNCC_CALL_PROC_REQ' from MNCC in state 1 (INITIATED)
<0001> gsm_04_08.c:1631 new state INITIATED -> MO_CALL_PROC
<0001> gsm_04_08.c:144 (bts 0 trx 0 ts 3 ti 80) Sending 'CALL_PROC' to MS.
<0006> gsm_04_08.c:3593 receive message MNCC_DISC_REQ
<0001> gsm_04_08.c:3804 (bts 0 trx 0 ts 3 ti 08 sub 15555581408) Received 'MNCC_DISC_REQ' from MNCC in state 3 (MO_CALL_PROC)
<0001> gsm_04_08.c:2234 starting timer T306 with 30 seconds
<0001> gsm_04_08.c:1631 new state MO_CALL_PROC -> DISCONNECT_IND
<0001> gsm_04_08.c:144 (bts 0 trx 0 ts 3 ti 80) Sending 'DISCONNECT' to MS.
<0000> abis_rsl.c:2125 (bts=0,trx=0,ts=3,ss=0) SAPI=0 DATA INDICATION
<0000> gsm_04_08.c:4007 Dispatching 04.08 message, pdisc=3
<0001> gsm_04_08.c:3902 (bts 0 trx 0 ts 3 ti 8 sub 15555581408) Received 'RELEASE' from MS in state 12 (DISCONNECT_IND)
<0001> gsm_04_08.c:1673 stopping pending timer T306
<0001> gsm_04_08.c:144 (bts 0 trx 0 ts 3 ti 80) Sending 'RELEASE_COMPL' to MS.
<0001> gsm_04_08.c:1693 (bts 0 trx 0 ts 3 ti 8 sub 15555581408) Sending 'MNCC_REL_IND' to MNCC.
<0001> gsm_04_08.c:1631 new state DISCONNECT_IND -> NULL
<0000> chan_alloc.c:486 (bts=0,trx=0,ts=3,ss=0) starting release sequence
<0004> abis_rsl.c:1231 (bts=0,trx=0,ts=3,ss=0) state ACTIVE -> RELEASE REQUESTED
<0003> gsm_04_08_utils.c:251 Sending Channel Release: Chan: Number: 0 Type: 2
<0004> abis_rsl.c:777 (bts=0,trx=0,ts=3,ss=0) DEACTivate SACCH CMD
<0004> abis_rsl.c:1445 (bts=0,trx=0,ts=3,ss=0): MEAS RES for inactive channel
<0000> abis_rsl.c:2125 (bts=0,trx=0,ts=3,ss=0) SAPI=0 RELEASE INDICATION
<0004> abis_rsl.c:1731 (bts=0,trx=0,ts=3,ss=0) T3111 expired: releasing RF Channel
<0004> abis_rsl.c:869 (bts=0,trx=0,ts=3,ss=0) RF Channel Release
<0004> abis_rsl.c:2542 (bts=0,trx=0,ts=3,ss=0) IPAC_DLCX_IND
<0004> abis_rsl.c:939 (bts=0,trx=0,ts=3,ss=0) RF CHANNEL RELEASE ACK
<0004> abis_rsl.c:1231 (bts=0,trx=0,ts=3,ss=0) state RELEASE REQUESTED -> NONE

freeswitch log:

2017-11-06 18:17:03.428847 [ERR] mod_smpp_gateway.c:297 Unrecognized Command ID: 258
2017-11-06 18:17:03.428847 [ERR] mod_smpp_gateway.c:379 Unknown command_id[258]
2017-11-06 18:24:31.428836 [DEBUG] switch_rtp.c:1459  [  zrtp cache]:   Storing ZRTP cache to </var/lib/freeswitch/db/zrtp.dat>...
2017-11-06 18:24:31.428836 [DEBUG] switch_rtp.c:1320 Saving ZRTP cache: OK

Any ideas in how to solve this? Thanks

[kheimerl]

Does it make it to FreeSwitch? Check the log there.

On Mon, Nov 6, 2017 at 10:32 AM, marvdias notifications@github.com wrote:

I am currently trying to make 'internal' calls between clients, I already check and both clients have credits, however it does not complete the dial. OpenBSC log:

<0004> abis_rsl.c:1852 BTS 0 CHAN RQD: reason: call re-establishment (ra=0x4d, neci=0x01, chreq_reason=0x02) <0000> chan_alloc.c:352 (bts=0,trx=0,ts=3,pchan=TCH/F) Allocating lchan=0 as TCH_F <0004> abis_rsl.c:1922 (bts=0,trx=0,ts=3,ss=0) Activating ARFCN(65) SS(0) lctype TCH_F r=CALL ra=0x4d ta=0 <0004> abis_rsl.c:595 (bts=0,trx=0,ts=3,pchan=TCH/F) Tx RSL Channel Activate with act_type=INITIAL <0004> abis_rsl.c:1231 (bts=0,trx=0,ts=3,ss=0) state NONE -> ACTIVATION REQUESTED <0004> abis_rsl.c:1603 (bts=0,trx=0,ts=3,ss=0) CHANNEL ACTIVATE ACK <0004> abis_rsl.c:1231 (bts=0,trx=0,ts=3,ss=0) state ACTIVATION REQUESTED -> ACTIVE <0000> abis_rsl.c:2125 (bts=0,trx=0,ts=3,ss=0) SAPI=0 ESTABLISH INDICATION <0000> gsm_04_08.c:4007 Dispatching 04.08 message, pdisc=5 <0002> gsm_04_08.c:1024 <- CM SERVICE REQUEST serv_type=0x01 MI(TMSI)=608646690 <000d> db.c:1307 Sync Equipment IMEI=355320084208080, classmark1=33, classmark2=33 19 82 , classmark3=60 14 04 62 88 10 01 27 e0 00 <0002> gsm_04_08_utils.c:667 -> CM SERVICE ACK <0000> abis_rsl.c:2125 (bts=0,trx=0,ts=3,ss=0) SAPI=0 DATA INDICATION <0003> bsc_api.c:605 GPRS SUSPENSION REQUEST <0000> abis_rsl.c:2125 (bts=0,trx=0,ts=3,ss=0) SAPI=0 DATA INDICATION <0000> gsm_04_08.c:4007 Dispatching 04.08 message, pdisc=3 <0001> gsm_04_08.c:3902 (bts 0 trx 0 ts 3 ti 8 sub 15555581408) Received 'SETUP' from MS in state 0 (NULL) <0001> gsm_04_08.c:3907 Unknown transaction ID 8, creating new trans. <0001> transaction.c:71 subscr=0x557d746ddbc0, net=0x557d7453bdb0 <0001> gsm_04_08.c:1631 new state NULL -> INITIATED <0001> gsm_04_08.c:2310 Subscriber Marcus Dias (15555581408) sends SETUP to 15555579368 <0001> gsm_04_08.c:1693 (bts 0 trx 0 ts 3 ti 8 sub 15555581408) Sending 'MNCC_SETUP_IND' to MNCC. <0006> gsm_04_08.c:3593 receive message MNCC_RTP_CREATE <0006> gsm_04_08.c:3424 RTP create: codec=SPEECH_V1, chan_type=TCH_F <000a> bsc_api.c:415 Sending (bts=0,trx=0,ts=3,ss=0) ChanModify for speech: SPEECH_V1 on channel TCH_F <0003> gsm_04_08_utils.c:517 -> CHANNEL MODE MODIFY mode=0x01 <0000> abis_rsl.c:2125 (bts=0,trx=0,ts=3,ss=0) SAPI=0 DATA INDICATION <0003> gsm_04_08_utils.c:542 CHANNEL MODE MODIFY ACK <0004> abis_rsl.c:2342 (bts=0,trx=0,ts=3,ss=0) IPAC_BIND speech_mode=0x10 RTP_PAYLOAD=3 <0003> osmo_msc.c:76 MSC assign complete (do nothing). <0004> abis_rsl.c:1624 (bts=0,trx=0,ts=3,ss=0) CHANNEL MODE MODIFY ACK <0004> abis_rsl.c:2523 (bts=0,trx=0,ts=3,ss=0) IPAC_CRCX_ACK LOCAL_IP=200.239.93.157 LOCAL_PORT=39406 CON_ID=0 <0006> gsm_04_08.c:3500 (bts=0,trx=0,ts=3,ss=0) sending pending RTP create ind. <0001> gsm_04_08.c:1701 (bts - trx - ts - ti -- sub -) Sending 'MNCC_RTP_CREATE' to MNCC. <0006> gsm_04_08.c:3593 receive message MNCC_CALL_PROC_REQ <0001> gsm_04_08.c:3804 (bts 0 trx 0 ts 3 ti 08 sub 15555581408) Received 'MNCC_CALL_PROC_REQ' from MNCC in state 1 (INITIATED) <0001> gsm_04_08.c:1631 new state INITIATED -> MO_CALL_PROC <0001> gsm_04_08.c:144 (bts 0 trx 0 ts 3 ti 80) Sending 'CALL_PROC' to MS. <0006> gsm_04_08.c:3593 receive message MNCC_DISC_REQ <0001> gsm_04_08.c:3804 (bts 0 trx 0 ts 3 ti 08 sub 15555581408) Received 'MNCC_DISC_REQ' from MNCC in state 3 (MO_CALL_PROC) <0001> gsm_04_08.c:2234 starting timer T306 with 30 seconds <0001> gsm_04_08.c:1631 new state MO_CALL_PROC -> DISCONNECT_IND <0001> gsm_04_08.c:144 (bts 0 trx 0 ts 3 ti 80) Sending 'DISCONNECT' to MS. <0000> abis_rsl.c:2125 (bts=0,trx=0,ts=3,ss=0) SAPI=0 DATA INDICATION <0000> gsm_04_08.c:4007 Dispatching 04.08 message, pdisc=3 <0001> gsm_04_08.c:3902 (bts 0 trx 0 ts 3 ti 8 sub 15555581408) Received 'RELEASE' from MS in state 12 (DISCONNECT_IND) <0001> gsm_04_08.c:1673 stopping pending timer T306 <0001> gsm_04_08.c:144 (bts 0 trx 0 ts 3 ti 80) Sending 'RELEASE_COMPL' to MS. <0001> gsm_04_08.c:1693 (bts 0 trx 0 ts 3 ti 8 sub 15555581408) Sending 'MNCC_REL_IND' to MNCC. <0001> gsm_04_08.c:1631 new state DISCONNECT_IND -> NULL <0000> chan_alloc.c:486 (bts=0,trx=0,ts=3,ss=0) starting release sequence <0004> abis_rsl.c:1231 (bts=0,trx=0,ts=3,ss=0) state ACTIVE -> RELEASE REQUESTED <0003> gsm_04_08_utils.c:251 Sending Channel Release: Chan: Number: 0 Type: 2 <0004> abis_rsl.c:777 (bts=0,trx=0,ts=3,ss=0) DEACTivate SACCH CMD <0004> abis_rsl.c:1445 (bts=0,trx=0,ts=3,ss=0): MEAS RES for inactive channel <0000> abis_rsl.c:2125 (bts=0,trx=0,ts=3,ss=0) SAPI=0 RELEASE INDICATION <0004> abis_rsl.c:1731 (bts=0,trx=0,ts=3,ss=0) T3111 expired: releasing RF Channel <0004> abis_rsl.c:869 (bts=0,trx=0,ts=3,ss=0) RF Channel Release <0004> abis_rsl.c:2542 (bts=0,trx=0,ts=3,ss=0) IPAC_DLCX_IND <0004> abis_rsl.c:939 (bts=0,trx=0,ts=3,ss=0) RF CHANNEL RELEASE ACK <0004> abis_rsl.c:1231 (bts=0,trx=0,ts=3,ss=0) state RELEASE REQUESTED -> NONE freeswitch log: 2017-11-06 18:17:03.428847 [ERR] mod_smpp_gateway.c:297 Unrecognized Command ID: 258 2017-11-06 18:17:03.428847 [ERR] mod_smpp_gateway.c:379 Unknown command_id[258] 2017-11-06 18:24:31.428836 [DEBUG] switch_rtp.c:1459 [ zrtp cache]: Storing ZRTP cache to ... 2017-11-06 18:24:31.428836 [DEBUG] switch_rtp.c:1320 Saving ZRTP cache: OK Any ideas in how to solve this? Thanks — You are receiving this because you are subscribed to this thread. Reply to this email directly, view it on GitHub , or mute the thread .

[marvdias]

I tried the following commands on fs_cli

sofia global siptrace on
sofia loglevel all 9
sofia tracelevel debug

When I try to make the calls nothing appears! How do I look for it?

[kheimerl]

That probably means it's not making it to FS, that's not great. Issue is with Osmo stack alone. I'm not as good at debugging that but you can probably simplify the problem by trying to call 888 for the credit check. That should make it simpler to debug than a two-sided call.

On Mon, Nov 6, 2017 at 10:42 AM, marvdias notifications@github.com wrote:

I tried the following commands on fs_cli

sofia global siptrace on sofia loglevel all 9 sofia tracelevel debug

When I try to make the calls nothing appears! How do I look for it?

— You are receiving this because you commented. Reply to this email directly, view it on GitHub https://github.com/facebookincubator/CommunityCellularManager/issues/88#issuecomment-342244643, or mute the thread https://github.com/notifications/unsubscribe-auth/AA_rn293ubgOXYMzjOGfG9VcpXKYxYkoks5sz1L6gaJpZM4QTrh4 .

[marvdias]

OpenBSC log while calling to 888:

<0004> abis_rsl.c:1852 BTS 0 CHAN RQD: reason: call re-establishment (ra=0x49, neci=0x01, chreq_reason=0x02)
<0000> chan_alloc.c:352 (bts=0,trx=0,ts=3,pchan=TCH/F) Allocating lchan=0 as TCH_F
<0004> abis_rsl.c:1922 (bts=0,trx=0,ts=3,ss=0) Activating ARFCN(65) SS(0) lctype TCH_F r=CALL ra=0x49 ta=0
<0004> abis_rsl.c:595 (bts=0,trx=0,ts=3,pchan=TCH/F) Tx RSL Channel Activate with act_type=INITIAL
<0004> abis_rsl.c:1231 (bts=0,trx=0,ts=3,ss=0) state NONE -> ACTIVATION REQUESTED
<0004> abis_rsl.c:1603 (bts=0,trx=0,ts=3,ss=0) CHANNEL ACTIVATE ACK
<0004> abis_rsl.c:1231 (bts=0,trx=0,ts=3,ss=0) state ACTIVATION REQUESTED -> ACTIVE
<0000> abis_rsl.c:2125 (bts=0,trx=0,ts=3,ss=0) SAPI=0 ESTABLISH INDICATION
<0000> gsm_04_08.c:4007 Dispatching 04.08 message, pdisc=5
<0002> gsm_04_08.c:1024 <- CM SERVICE REQUEST serv_type=0x01 MI(TMSI)=966238291
<000d> db.c:1307 Sync Equipment IMEI=355302046072440, classmark1=33, classmark2=33 59 a6 , classmark3=60 14 20 00
<0002> gsm_04_08_utils.c:667 -> CM SERVICE ACK
<0000> abis_rsl.c:2125 (bts=0,trx=0,ts=3,ss=0) SAPI=0 DATA INDICATION
<0000> gsm_04_08.c:4007 Dispatching 04.08 message, pdisc=3
<0001> gsm_04_08.c:3902 (bts 0 trx 0 ts 3 ti 8 sub 15555579368) Received 'SETUP' from MS in state 0 (NULL)
<0001> gsm_04_08.c:3907 Unknown transaction ID 8, creating new trans.
<0001> transaction.c:71 subscr=0x557d746a9a90, net=0x557d7453bdb0
<0001> gsm_04_08.c:1631 new state NULL -> INITIATED
<0001> gsm_04_08.c:2310 Subscriber 724050047114287 (15555579368) sends SETUP to 888
<0001> gsm_04_08.c:1693 (bts 0 trx 0 ts 3 ti 8 sub 15555579368) Sending 'MNCC_SETUP_IND' to MNCC.
<0006> gsm_04_08.c:3593 receive message MNCC_RTP_CREATE
<0006> gsm_04_08.c:3424 RTP create: codec=SPEECH_V1, chan_type=TCH_F
<000a> bsc_api.c:415 Sending (bts=0,trx=0,ts=3,ss=0) ChanModify for speech: SPEECH_V1 on channel TCH_F
<0003> gsm_04_08_utils.c:517 -> CHANNEL MODE MODIFY mode=0x01
<0000> abis_rsl.c:2125 (bts=0,trx=0,ts=3,ss=0) SAPI=0 DATA INDICATION
<0003> gsm_04_08_utils.c:542 CHANNEL MODE MODIFY ACK
<0004> abis_rsl.c:2342 (bts=0,trx=0,ts=3,ss=0) IPAC_BIND speech_mode=0x10 RTP_PAYLOAD=3
<0003> osmo_msc.c:76 MSC assign complete (do nothing).
<0004> abis_rsl.c:1624 (bts=0,trx=0,ts=3,ss=0) CHANNEL MODE MODIFY ACK
<0004> abis_rsl.c:2523 (bts=0,trx=0,ts=3,ss=0) IPAC_CRCX_ACK LOCAL_IP=200.239.93.157 LOCAL_PORT=62302 CON_ID=0 <0006> gsm_04_08.c:3500 (bts=0,trx=0,ts=3,ss=0) sending pending RTP create ind.
<0001> gsm_04_08.c:1701 (bts - trx - ts - ti -- sub -) Sending 'MNCC_RTP_CREATE' to MNCC.

<0006> gsm_04_08.c:3593 receive message MNCC_CALL_PROC_REQ
<0001> gsm_04_08.c:3804 (bts 0 trx 0 ts 3 ti 08 sub 15555579368) Received 'MNCC_CALL_PROC_REQ' from MNCC in state 1 (INITIATED)
<0001> gsm_04_08.c:1631 new state INITIATED -> MO_CALL_PROC
<0001> gsm_04_08.c:144 (bts 0 trx 0 ts 3 ti 80) Sending 'CALL_PROC' to MS.
<0006> gsm_04_08.c:3593 receive message MNCC_DISC_REQ
<0001> gsm_04_08.c:3804 (bts 0 trx 0 ts 3 ti 08 sub 15555579368) Received 'MNCC_DISC_REQ' from MNCC in state 3 (MO_CALL_PROC)
<0001> gsm_04_08.c:2234 starting timer T306 with 30 seconds
<0001> gsm_04_08.c:1631 new state MO_CALL_PROC -> DISCONNECT_IND
<0001> gsm_04_08.c:144 (bts 0 trx 0 ts 3 ti 80) Sending 'DISCONNECT' to MS.
<0000> abis_rsl.c:2125 (bts=0,trx=0,ts=3,ss=0) SAPI=0 DATA INDICATION
<0000> gsm_04_08.c:4007 Dispatching 04.08 message, pdisc=3
<0001> gsm_04_08.c:3902 (bts 0 trx 0 ts 3 ti 8 sub 15555579368) Received 'RELEASE' from MS in state 12 (DISCONNECT_IND)
<0001> gsm_04_08.c:1673 stopping pending timer T306
<0001> gsm_04_08.c:144 (bts 0 trx 0 ts 3 ti 80) Sending 'RELEASE_COMPL' to MS.
<0001> gsm_04_08.c:1693 (bts 0 trx 0 ts 3 ti 8 sub 15555579368) Sending 'MNCC_REL_IND' to MNCC.
<0001> gsm_04_08.c:1631 new state DISCONNECT_IND -> NULL
<0000> chan_alloc.c:486 (bts=0,trx=0,ts=3,ss=0) starting release sequence
<0004> abis_rsl.c:1231 (bts=0,trx=0,ts=3,ss=0) state ACTIVE -> RELEASE REQUESTED
<0003> gsm_04_08_utils.c:251 Sending Channel Release: Chan: Number: 0 Type: 2
<0004> abis_rsl.c:777 (bts=0,trx=0,ts=3,ss=0) DEACTivate SACCH CMD
<0000> abis_rsl.c:2125 (bts=0,trx=0,ts=3,ss=0) SAPI=0 RELEASE INDICATION
<0004> abis_rsl.c:1731 (bts=0,trx=0,ts=3,ss=0) T3111 expired: releasing RF Channel
<0004> abis_rsl.c:869 (bts=0,trx=0,ts=3,ss=0) RF Channel Release
<0004> abis_rsl.c:2542 (bts=0,trx=0,ts=3,ss=0) IPAC_DLCX_IND
<0004> abis_rsl.c:939 (bts=0,trx=0,ts=3,ss=0) RF CHANNEL RELEASE ACK
<0004> abis_rsl.c:1231 (bts=0,trx=0,ts=3,ss=0) state RELEASE REQUESTED -> NONE

The call does not work :/