Hi Craig,

Verify that both UEs are successfully attached (verify by running some USSD code configured in the HLR, e.g. *#100#). According to the nano3G trace it looks like that worked fine.

One thing that could still go wrong is the Paging. I have noted at occasions that a nano3G may fail to Page by IMSI, when the UE has only attached using a TMSI. You can make the phones attempt an attach at some other random operator and fail, it usually will forget its previous TMSI. If you now re-attach to your own network, it will be using its IMSI to attach. You can try to set an ACL in the nano3G's dmi to force using an IMSI like: set csgAccessMode=CSG_ACCESS_MODE_CLOSED_ACCESS set accessControlList = ({"901700000014701",1,"14701"},{"901700000014705",1,"14705"},{"901700000014706",1,"14706"})

Other than that, the most interesting logs are the osmo-msc and osmo-hlr logs. I'm not familiar with the nano3G's logs, and the HNBGW is just a plain forwarding element, it's logs aren't very revealing.

Ideally also examine a network trace, you can filter by 'sctp' or 'ranap || hnbap'. See whether you are getting a Paging Response.

~N

On Fri, Apr 10, 2020 at 01:21:15PM -0500, Craig Comstock wrote:

Hi,

I am setting up a nitb/nano3g right now and have the basics working with the nano3g talking to hnbgw and services running on my nitb box (rpi 3-something).

I have two of the same phones: ZTE Obsidian with Android 5.1 which are able to connect to my network.

When I try to call the other phone I don't get connected. It takes about 1 minute for the call to fail.

Once the phone mentioned some problem with "access configuration for normal calls".

Attached are my configs and logs from nano3g trace log and hnbgw journal during a failed call.

Any help would be appreciated. I am sure I did something obviously wrong.

I'll try and read the configs carefully to make sure that matches with what is up on the wiki.

Thanks, Craig

-- Logs begin at Wed 2020-04-08 10:17:13 CDT. -- Apr 10 12:57:42 nitb osmo-hnbgw[17756]: <0000> hnbgw_cn.c:364 sccp_sap_up(N-DATA.indication) Apr 10 12:57:42 nitb osmo-hnbgw[17756]: <0002> hnbgw_rua.c:126 transmitting RUA (cn=cs) payload of 37 bytes Apr 10 12:57:42 nitb osmo-hnbgw[17756]: <0000> rua_decoder.c:126 Decoding message RUA_DisconnectIEs (rua_decoder.c:126) Apr 10 12:57:42 nitb osmo-hnbgw[17756]: <0002> hnbgw_rua.c:388 RUA Disconnect.req(ctx=0x18,cause=radio(normal)) Apr 10 12:57:42 nitb osmo-hnbgw[17756]: <0002> hnbgw_rua.c:229 rua_to_scu() IuCS to RI=2,PC=185,SSN=142, rua_ctx_id 24 scu_conn_id 1009 Apr 10 12:57:47 nitb osmo-hnbgw[17756]: <0000> rua_decoder.c:327 Decoding message RUA_DirectTransferIEs (rua_decoder.c:327) Apr 10 12:57:47 nitb osmo-hnbgw[17756]: <0002> hnbgw_rua.c:417 RUA Data.req(ctx=0x17) Apr 10 12:57:47 nitb osmo-hnbgw[17756]: <0002> hnbgw_rua.c:229 rua_to_scu() IuPS to RI=2,PC=188,SSN=142, rua_ctx_id 23 scu_conn_id 1000 Apr 10 12:57:47 nitb osmo-hnbgw[17756]: <0011> sccp_scoc.c:1657 SCCP-SCOC(1000)[0x716740]{CONN_PEND_OUT}: Event N-DATA.req not permitted Apr 10 12:58:01 nitb osmo-hnbgw[17756]: <0000> context_map.c:151 Running context mapper garbage collection Apr 10 12:58:24 nitb osmo-hnbgw[17756]: <0000> context_map.c:151 Running context mapper garbage collection Apr 10 12:58:36 nitb osmo-hnbgw[17756]: <0000> hnbgw_cn.c:364 sccp_sap_up(N-DISCONNECT.indication) Apr 10 12:58:36 nitb osmo-hnbgw[17756]: <0000> hnbgw_cn.c:334 handle_cn_disc_ind() conn_id=1000 originator=2 Apr 10 12:58:36 nitb osmo-hnbgw[17756]: <0000> hnbgw_cn.c:336 handle_cn_disc_ind() responding_addr=0.0.0.0 Apr 10 12:58:36 nitb osmo-hnbgw[17756]: <0002> rua_common.c:214 Error in ANY_fromType_aper Apr 10 12:58:39 nitb osmo-hnbgw[17756]: <0000> hnbgw_cn.c:364 sccp_sap_up(N-DISCONNECT.indication) Apr 10 12:58:39 nitb osmo-hnbgw[17756]: <0000> hnbgw_cn.c:334 handle_cn_disc_ind() conn_id=1002 originator=2 Apr 10 12:58:39 nitb osmo-hnbgw[17756]: <0000> hnbgw_cn.c:336 handle_cn_disc_ind() responding_addr=0.0.0.0 Apr 10 12:58:39 nitb osmo-hnbgw[17756]: <0002> rua_common.c:214 Error in ANY_fromType_aper Apr 10 12:58:47 nitb osmo-hnbgw[17756]: <0000> context_map.c:151 Running context mapper garbage collection Apr 10 12:58:57 nitb osmo-hnbgw[17756]: <0000> rua_decoder.c:21 Decoding message RUA_ConnectIEs (rua_decoder.c:21) Apr 10 12:58:57 nitb osmo-hnbgw[17756]: <0002> hnbgw_rua.c:359 RUA IuCS Connect.req(ctx=0x18, normal) Apr 10 12:58:57 nitb osmo-hnbgw[17756]: <0000> context_map.c:93 Creating new Mapping RUA CTX 0x712cf0/24 <-> SCU Conn ID 0x713cd0/1010 Apr 10 12:58:57 nitb osmo-hnbgw[17756]: <0002> hnbgw_rua.c:229 rua_to_scu() IuCS to RI=2,PC=185,SSN=142, rua_ctx_id 24 scu_conn_id 1010 Apr 10 12:58:57 nitb osmo-hnbgw[17756]: <0002> hnbgw_rua.c:241 RUA to SCCP N_CONNECT: called_addr:RI=2,PC=185,SSN=142 Apr 10 12:58:57 nitb osmo-hnbgw[17756]: <0002> hnbgw_rua.c:243 RUA to SCCP N_CONNECT: calling_addr:RI=2,PC=189,SSN=142 Apr 10 12:58:57 nitb osmo-hnbgw[17756]: <0000> hnbgw_cn.c:364 sccp_sap_up(N-CONNECT.confirm) Apr 10 12:58:57 nitb osmo-hnbgw[17756]: <0000> hnbgw_cn.c:296 handle_cn_conn_conf() conn_id=1010 Apr 10 12:58:57 nitb osmo-hnbgw[17756]: <0000> hnbgw_cn.c:298 handle_cn_conn_conf() called_addr=0.0.0.0 Apr 10 12:58:57 nitb osmo-hnbgw[17756]: <0000> hnbgw_cn.c:300 handle_cn_conn_conf() calling_addr=0.0.0.0 Apr 10 12:58:57 nitb osmo-hnbgw[17756]: <0000> hnbgw_cn.c:302 handle_cn_conn_conf() responding_addr=0.0.0.0 Apr 10 12:58:57 nitb osmo-hnbgw[17756]: <0000> hnbgw_cn.c:364 sccp_sap_up(N-DATA.indication) Apr 10 12:58:57 nitb osmo-hnbgw[17756]: <0002> hnbgw_rua.c:126 transmitting RUA (cn=cs) payload of 78 bytes Apr 10 12:58:57 nitb osmo-hnbgw[17756]: <0000> rua_decoder.c:21 Decoding message RUA_ConnectIEs (rua_decoder.c:21) Apr 10 12:58:57 nitb osmo-hnbgw[17756]: <0002> hnbgw_rua.c:359 RUA IuPS Connect.req(ctx=0x18, normal) Apr 10 12:58:57 nitb osmo-hnbgw[17756]: <0002> hnbgw_rua.c:229 rua_to_scu() IuPS to RI=2,PC=188,SSN=142, rua_ctx_id 24 scu_conn_id 1002 Apr 10 12:58:57 nitb osmo-hnbgw[17756]: <0002> hnbgw_rua.c:241 RUA to SCCP N_CONNECT: called_addr:RI=2,PC=188,SSN=142 Apr 10 12:58:57 nitb osmo-hnbgw[17756]: <0002> hnbgw_rua.c:243 RUA to SCCP N_CONNECT: calling_addr:RI=2,PC=189,SSN=142 Apr 10 12:58:57 nitb osmo-hnbgw[17756]: <0000> rua_decoder.c:327 Decoding message RUA_DirectTransferIEs (rua_decoder.c:327) Apr 10 12:58:57 nitb osmo-hnbgw[17756]: <0002> hnbgw_rua.c:417 RUA Data.req(ctx=0x18) Apr 10 12:58:57 nitb osmo-hnbgw[17756]: <0002> hnbgw_rua.c:229 rua_to_scu() IuCS to RI=2,PC=185,SSN=142, rua_ctx_id 24 scu_conn_id 1010 Apr 10 12:58:57 nitb osmo-hnbgw[17756]: <0000> hnbgw_cn.c:364 sccp_sap_up(N-DATA.indication) Apr 10 12:58:57 nitb osmo-hnbgw[17756]: <0002> hnbgw_rua.c:126 transmitting RUA (cn=cs) payload of 58 bytes Apr 10 12:58:58 nitb osmo-hnbgw[17756]: <0000> rua_decoder.c:327 Decoding message RUA_DirectTransferIEs (rua_decoder.c:327) Apr 10 12:58:58 nitb osmo-hnbgw[17756]: <0002> hnbgw_rua.c:417 RUA Data.req(ctx=0x18) Apr 10 12:58:58 nitb osmo-hnbgw[17756]: <0002> hnbgw_rua.c:229 rua_to_scu() IuCS to RI=2,PC=185,SSN=142, rua_ctx_id 24 scu_conn_id 1010 Apr 10 12:58:58 nitb osmo-hnbgw[17756]: <0000> hnbgw_cn.c:364 sccp_sap_up(N-DATA.indication) Apr 10 12:58:58 nitb osmo-hnbgw[17756]: <0002> hnbgw_rua.c:126 transmitting RUA (cn=cs) payload of 44 bytes Apr 10 12:58:58 nitb osmo-hnbgw[17756]: <0000> hnbgw_cn.c:364 sccp_sap_up(N-DATA.indication) Apr 10 12:58:58 nitb osmo-hnbgw[17756]: <0002> hnbgw_rua.c:126 transmitting RUA (cn=cs) payload of 55 bytes Apr 10 12:58:58 nitb osmo-hnbgw[17756]: <0000> rua_decoder.c:327 Decoding message RUA_DirectTransferIEs (rua_decoder.c:327) Apr 10 12:58:58 nitb osmo-hnbgw[17756]: <0002> hnbgw_rua.c:417 RUA Data.req(ctx=0x18) Apr 10 12:58:58 nitb osmo-hnbgw[17756]: <0002> hnbgw_rua.c:229 rua_to_scu() IuCS to RI=2,PC=185,SSN=142, rua_ctx_id 24 scu_conn_id 1010 Apr 10 12:58:58 nitb osmo-hnbgw[17756]: <0000> hnbgw_cn.c:364 sccp_sap_up(N-DATA.indication) Apr 10 12:58:58 nitb osmo-hnbgw[17756]: <0002> hnbgw_rua.c:126 transmitting RUA (cn=cs) payload of 37 bytes Apr 10 12:58:58 nitb osmo-hnbgw[17756]: <0000> rua_decoder.c:126 Decoding message RUA_DisconnectIEs (rua_decoder.c:126) Apr 10 12:58:58 nitb osmo-hnbgw[17756]: <0002> hnbgw_rua.c:388 RUA Disconnect.req(ctx=0x18,cause=radio(normal)) Apr 10 12:58:58 nitb osmo-hnbgw[17756]: <0002> hnbgw_rua.c:229 rua_to_scu() IuCS to RI=2,PC=185,SSN=142, rua_ctx_id 24 scu_conn_id 1010 Apr 10 12:58:59 nitb osmo-hnbgw[17756]: <0000> rua_decoder.c:21 Decoding message RUA_ConnectIEs (rua_decoder.c:21) Apr 10 12:58:59 nitb osmo-hnbgw[17756]: <0002> hnbgw_rua.c:359 RUA IuCS Connect.req(ctx=0x18, normal) Apr 10 12:58:59 nitb osmo-hnbgw[17756]: <0000> context_map.c:93 Creating new Mapping RUA CTX 0x712cf0/24 <-> SCU Conn ID 0x713cd0/1011 Apr 10 12:58:59 nitb osmo-hnbgw[17756]: <0002> hnbgw_rua.c:229 rua_to_scu() IuCS to RI=2,PC=185,SSN=142, rua_ctx_id 24 scu_conn_id 1011 Apr 10 12:58:59 nitb osmo-hnbgw[17756]: <0002> hnbgw_rua.c:241 RUA to SCCP N_CONNECT: called_addr:RI=2,PC=185,SSN=142 Apr 10 12:58:59 nitb osmo-hnbgw[17756]: <0002> hnbgw_rua.c:243 RUA to SCCP N_CONNECT: calling_addr:RI=2,PC=189,SSN=142 Apr 10 12:58:59 nitb osmo-hnbgw[17756]: <0000> hnbgw_cn.c:364 sccp_sap_up(N-CONNECT.confirm) Apr 10 12:58:59 nitb osmo-hnbgw[17756]: <0000> hnbgw_cn.c:296 handle_cn_conn_conf() conn_id=1011 Apr 10 12:58:59 nitb osmo-hnbgw[17756]: <0000> hnbgw_cn.c:298 handle_cn_conn_conf() called_addr=0.0.0.0 Apr 10 12:58:59 nitb osmo-hnbgw[17756]: <0000> hnbgw_cn.c:300 handle_cn_conn_conf() calling_addr=0.0.0.0 Apr 10 12:58:59 nitb osmo-hnbgw[17756]: <0000> hnbgw_cn.c:302 handle_cn_conn_conf() responding_addr=0.0.0.0 Apr 10 12:58:59 nitb osmo-hnbgw[17756]: <0000> hnbgw_cn.c:364 sccp_sap_up(N-DATA.indication) Apr 10 12:58:59 nitb osmo-hnbgw[17756]: <0002> hnbgw_rua.c:126 transmitting RUA (cn=cs) payload of 78 bytes Apr 10 12:58:59 nitb osmo-hnbgw[17756]: <0000> rua_decoder.c:327 Decoding message RUA_DirectTransferIEs (rua_decoder.c:327) Apr 10 12:58:59 nitb osmo-hnbgw[17756]: <0002> hnbgw_rua.c:417 RUA Data.req(ctx=0x18) Apr 10 12:58:59 nitb osmo-hnbgw[17756]: <0002> hnbgw_rua.c:229 rua_to_scu() IuCS to RI=2,PC=185,SSN=142, rua_ctx_id 24 scu_conn_id 1011 Apr 10 12:58:59 nitb osmo-hnbgw[17756]: <0000> hnbgw_cn.c:364 sccp_sap_up(N-DATA.indication) Apr 10 12:58:59 nitb osmo-hnbgw[17756]: <0002> hnbgw_rua.c:126 transmitting RUA (cn=cs) payload of 58 bytes Apr 10 12:58:59 nitb osmo-hnbgw[17756]: <0000> rua_decoder.c:327 Decoding message RUA_DirectTransferIEs (rua_decoder.c:327) Apr 10 12:58:59 nitb osmo-hnbgw[17756]: <0002> hnbgw_rua.c:417 RUA Data.req(ctx=0x18) Apr 10 12:58:59 nitb osmo-hnbgw[17756]: <0002> hnbgw_rua.c:229 rua_to_scu() IuCS to RI=2,PC=185,SSN=142, rua_ctx_id 24 scu_conn_id 1011 Apr 10 12:58:59 nitb osmo-hnbgw[17756]: <0000> hnbgw_cn.c:364 sccp_sap_up(N-DATA.indication) Apr 10 12:58:59 nitb osmo-hnbgw[17756]: <0002> hnbgw_rua.c:126 transmitting RUA (cn=cs) payload of 44 bytes Apr 10 12:59:00 nitb osmo-hnbgw[17756]: <0000> rua_decoder.c:327 Decoding message RUA_DirectTransferIEs (rua_decoder.c:327) Apr 10 12:59:00 nitb osmo-hnbgw[17756]: <0002> hnbgw_rua.c:417 RUA Data.req(ctx=0x18) Apr 10 12:59:00 nitb osmo-hnbgw[17756]: <0002> hnbgw_rua.c:229 rua_to_scu() IuCS to RI=2,PC=185,SSN=142, rua_ctx_id 24 scu_conn_id 1011 Apr 10 12:59:00 nitb osmo-hnbgw[17756]: <0000> hnbgw_cn.c:364 sccp_sap_up(N-DATA.indication) Apr 10 12:59:00 nitb osmo-hnbgw[17756]: <0002> hnbgw_rua.c:126 transmitting RUA (cn=cs) payload of 43 bytes Apr 10 12:59:00 nitb osmo-hnbgw[17756]: <0000> hnbgw_cn.c:364 sccp_sap_up(N-UNITDATA.indication) Apr 10 12:59:00 nitb osmo-hnbgw[17756]: <0003> ranap_decoder.c:714 Decoding message RANAP_PagingIEs (ranap_decoder.c:714) Apr 10 12:59:00 nitb osmo-hnbgw[17756]: <0002> hnbgw_rua.c:89 transmitting RUA payload of 46 bytes Apr 10 12:59:00 nitb osmo-hnbgw[17756]: <0000> hnbgw_cn.c:364 sccp_sap_up(N-DATA.indication) Apr 10 12:59:00 nitb osmo-hnbgw[17756]: <0002> hnbgw_rua.c:126 transmitting RUA (cn=cs) payload of 47 bytes Apr 10 12:59:00 nitb osmo-hnbgw[17756]: <0000> rua_decoder.c:327 Decoding message RUA_DirectTransferIEs (rua_decoder.c:327) Apr 10 12:59:00 nitb osmo-hnbgw[17756]: <0002> hnbgw_rua.c:417 RUA Data.req(ctx=0x18) Apr 10 12:59:00 nitb osmo-hnbgw[17756]: <0002> hnbgw_rua.c:229 rua_to_scu() IuCS to RI=2,PC=185,SSN=142, rua_ctx_id 24 scu_conn_id 1011 Apr 10 12:59:00 nitb osmo-hnbgw[17756]: <0000> hnbgw_cn.c:364 sccp_sap_up(N-DATA.indication) Apr 10 12:59:00 nitb osmo-hnbgw[17756]: <0002> hnbgw_rua.c:126 transmitting RUA (cn=cs) payload of 37 bytes Apr 10 12:59:00 nitb osmo-hnbgw[17756]: <0000> rua_decoder.c:126 Decoding message RUA_DisconnectIEs (rua_decoder.c:126) Apr 10 12:59:00 nitb osmo-hnbgw[17756]: <0002> hnbgw_rua.c:388 RUA Disconnect.req(ctx=0x18,cause=radio(normal)) Apr 10 12:59:00 nitb osmo-hnbgw[17756]: <0002> hnbgw_rua.c:229 rua_to_scu() IuCS to RI=2,PC=185,SSN=142, rua_ctx_id 24 scu_conn_id 1011

Apr 10 17:57:42.490 [UEContext-23] Sending RUADisconnect to HNB-GW for CSDomain Context 0x18 Apr 10 17:57:42.490 [UEContext-23] Sending RUADisconnect to HNB-GW for CSDomain Context 0x18 Apr 10 17:57:42.499 [3GAP-3] C3GAP::Send uRSL msg id 9 Apr 10 17:57:47.440 [UEContext-22] UEContextRelease from UE Apr 10 17:57:47.440 [UEContext-22] URSL> UEContextRelease Apr 10 17:57:47.442 [UEContext-22] Starting TimerIdUeContextCleanupPending Apr 10 17:57:57.427 [UEContext-22] TimerIdUeContextCleanupPending Timeout Apr 10 17:57:57.427 [UEContext-22] TimerIdUeContextCleanupPending Timeout Apr 10 17:57:57.428 [UEContext-22] UE context destroyed. SRNTI 21, ACUEId 16, IuH CtxtId 23 Apr 10 17:57:57.428 [UEContext-22] Destroyed UEContext-22, Remaining URSLManager-4 UEContext-14 UEContext-17 UEContext-20 UEContext-21 UEContext-23 MIBCnx-1 3GAP-3 IuhClient-16 SysAgent-2 Apr 10 17:58:56.171 [URSLManager-4] UEContextRequest from UE Apr 10 17:58:56.173 [UEContext-24] Created UEContext-24, num classes 11 Apr 10 17:58:56.173 [UEContext-24] Create UE context. SRNTI 23, ACUEId 18, cause 12 Apr 10 17:58:56.173 [UEContext-24] Create UE context. SRNTI 23, ACUEId 18, cause 12 Apr 10 17:58:56.174 [3GAP-3] C3GAP::Send uRSL msg id 2 Apr 10 17:58:56.992 [UEContext-24] URSL InitialDirectTransfer received for CSDomain in state IncPending Apr 10 17:58:56.992 [UEContext-24] Sending RUA Connect to HNB-GW for CSDomain with Context 0x18 Apr 10 17:58:56.993 [UEContext-24] Sending RUA Connect to HNB-GW for CSDomain with Context 0x18 Apr 10 17:58:56.993 [UEContext-24] URSL InitialDirectTransfer from UE, CSDomain, NAS len 20 Apr 10 17:58:57.040 [UEContext-24] RUA DirectTransferInd, domain 0, RANAP length 54 Apr 10 17:58:57.041 [UEContext-24] HNB-GW> RANAP DirectTransfer CSDomain Apr 10 17:58:57.045 [3GAP-3] C3GAP::Send uRSL msg id 7 Apr 10 17:58:57.614 [UEContext-24] URSL> InitialDirectTransfer Apr 10 17:58:57.614 [UEContext-24] URSL InitialDirectTransfer received for PSDomain in state Active Apr 10 17:58:57.614 [UEContext-24] Sending RUA Connect to HNB-GW for PSDomain with Context 0x18 Apr 10 17:58:57.614 [UEContext-24] Sending RUA Connect to HNB-GW for PSDomain with Context 0x18 Apr 10 17:58:57.614 [UEContext-24] URSL InitialDirectTransfer from UE, PSDomain, NAS len 91 Apr 10 17:58:57.753 [UEContext-24] URSL> UplinkDirectTransfer Apr 10 17:58:57.753 [UEContext-24] URSL Uplink DirectTransfer from UE, CSDomain, NAS len 12 Apr 10 17:58:57.831 [UEContext-24] RUA DirectTransferInd, domain 0, RANAP length 34 Apr 10 17:58:57.831 [UEContext-24] RANAP SecurityModeControl request from CSDomain Apr 10 17:58:57.832 [UEContext-24] HNB-GW> RANAP SecurityModeControl, CSDomain Apr 10 17:58:57.839 [3GAP-3] C3GAP::Send uRSL msg id 10 Apr 10 17:58:58.090 [UEContext-24] URSL SecurityModeComp, CSDomain Apr 10 17:58:58.091 [UEContext-24] URSL SecurityModeComp, CSDomain, URSL ChosenIntAlgo 0 Apr 10 17:58:58.098 [UEContext-24] RUA DirectTransferInd, domain 0, RANAP length 20 Apr 10 17:58:58.098 [UEContext-24] RANAP CommonId from CSDomain Apr 10 17:58:58.099 [UEContext-24] HNB-GW> RANAP CommonId, CSDomain Apr 10 17:58:58.099 [UEContext-24] RANAP CommonId provided IMSI 901700000015242 Apr 10 17:58:58.298 [UEContext-24] RUA DirectTransferInd, domain 0, RANAP length 31 Apr 10 17:58:58.298 [UEContext-24] HNB-GW> RANAP DirectTransfer CSDomain Apr 10 17:58:58.304 [3GAP-3] C3GAP::Send uRSL msg id 7 Apr 10 17:58:58.562 [UEContext-24] URSL> UplinkDirectTransfer Apr 10 17:58:58.562 [UEContext-24] URSL Uplink DirectTransfer from UE, CSDomain, NAS len 2 Apr 10 17:58:58.594 [UEContext-24] RUA DirectTransferInd, domain 0, RANAP length 13 Apr 10 17:58:58.595 [UEContext-24] RANAP IuReleaseCommand Apr 10 17:58:58.595 [UEContext-24] HNB-GW> RANAP IuRelease, CSDomain Apr 10 17:58:58.595 [UEContext-24] Sending RUADisconnect to HNB-GW for CSDomain Context 0x18 Apr 10 17:58:58.595 [UEContext-24] Sending RUADisconnect to HNB-GW for CSDomain Context 0x18 Apr 10 17:58:58.601 [3GAP-3] C3GAP::Send uRSL msg id 9 Apr 10 17:58:58.993 [UEContext-24] URSL> InitialDirectTransfer Apr 10 17:58:58.993 [UEContext-24] URSL InitialDirectTransfer received for CSDomain in state Active Apr 10 17:58:58.994 [UEContext-24] Sending RUA Connect to HNB-GW for CSDomain with Context 0x18 Apr 10 17:58:58.994 [UEContext-24] Sending RUA Connect to HNB-GW for CSDomain with Context 0x18 Apr 10 17:58:58.994 [UEContext-24] URSL InitialDirectTransfer from UE, CSDomain, NAS len 16 Apr 10 17:58:59.003 [UEContext-24] RUA DirectTransferInd, domain 0, RANAP length 54 Apr 10 17:58:59.004 [UEContext-24] HNB-GW> RANAP DirectTransfer CSDomain Apr 10 17:58:59.009 [3GAP-3] C3GAP::Send uRSL msg id 7 Apr 10 17:58:59.503 [UEContext-24] URSL> UplinkDirectTransfer Apr 10 17:58:59.503 [UEContext-24] URSL Uplink DirectTransfer from UE, CSDomain, NAS len 12 Apr 10 17:58:59.510 [UEContext-24] RUA DirectTransferInd, domain 0, RANAP length 34 Apr 10 17:58:59.511 [UEContext-24] RANAP SecurityModeControl request from CSDomain Apr 10 17:58:59.511 [UEContext-24] HNB-GW> RANAP SecurityModeControl, CSDomain Apr 10 17:58:59.515 [3GAP-3] C3GAP::Send uRSL msg id 10 Apr 10 17:58:59.760 [UEContext-24] URSL SecurityModeComp, CSDomain Apr 10 17:58:59.760 [UEContext-24] URSL SecurityModeComp, CSDomain, URSL ChosenIntAlgo 0 Apr 10 17:58:59.794 [UEContext-24] RUA DirectTransferInd, domain 0, RANAP length 20 Apr 10 17:58:59.794 [UEContext-24] RANAP CommonId from CSDomain Apr 10 17:58:59.794 [UEContext-24] HNB-GW> RANAP CommonId, CSDomain Apr 10 17:58:59.795 [UEContext-24] RANAP CommonId provided IMSI 901700000015242 Apr 10 17:59:00.083 [UEContext-24] URSL> UplinkDirectTransfer Apr 10 17:59:00.083 [UEContext-24] URSL Uplink DirectTransfer from UE, CSDomain, NAS len 31 Apr 10 17:59:00.090 [UEContext-24] RUA DirectTransferInd, domain 0, RANAP length 19 Apr 10 17:59:00.091 [UEContext-24] HNB-GW> RANAP DirectTransfer CSDomain Apr 10 17:59:00.095 [3GAP-3] C3GAP::Send uRSL msg id 7 Apr 10 17:59:00.291 [RANAP ConnectionlessInd] RANAP Paging provided IMSI 901700000015240 Apr 10 17:59:00.291 [RANAP] Paging 901700000015240 Apr 10 17:59:00.295 [3GAP-3] C3GAP::Send uRSL msg id 20 Apr 10 17:59:00.297 [UEContext-24] RUA DirectTransferInd, domain 0, RANAP length 23 Apr 10 17:59:00.298 [UEContext-24] HNB-GW> RANAP DirectTransfer CSDomain Apr 10 17:59:00.302 [3GAP-3] C3GAP::Send uRSL msg id 7 Apr 10 17:59:00.803 [UEContext-24] URSL> UplinkDirectTransfer Apr 10 17:59:00.803 [UEContext-24] URSL Uplink DirectTransfer from UE, CSDomain, NAS len 2 Apr 10 17:59:00.809 [UEContext-24] RUA DirectTransferInd, domain 0, RANAP length 13 Apr 10 17:59:00.809 [UEContext-24] RANAP IuReleaseCommand Apr 10 17:59:00.810 [UEContext-24] HNB-GW> RANAP IuRelease, CSDomain Apr 10 17:59:00.810 [UEContext-24] Sending RUADisconnect to HNB-GW for CSDomain Context 0x18 Apr 10 17:59:00.810 [UEContext-24] Sending RUADisconnect to HNB-GW for CSDomain Context 0x18 Apr 10 17:59:00.816 [3GAP-3] C3GAP::Send uRSL msg id 9