10 Apr
2020
10 Apr
'20
8:21 p.m.
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
11 Apr
11 Apr
1:57 a.m.
Hi,
It is going to be a lot easier to find possible issues if you share a
full pcap with all the messaging going during the phone call.
--
- Pau Espin Pedrol <pespin(a)sysmocom.de> http://www.sysmocom.de/
=======================================================================
* sysmocom - systems for mobile communications GmbH
* Alt-Moabit 93
* 10559 Berlin, Germany
* Sitz / Registered office: Berlin, HRB 134158 B
* Geschaeftsfuehrer / Managing Director: Harald Welte
14 Apr
14 Apr
2:21 p.m.
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
--
- Neels Hofmeyr <nhofmeyr(a)sysmocom.de> http://www.sysmocom.de/
=======================================================================
* sysmocom - systems for mobile communications GmbH
* Alt-Moabit 93
* 10559 Berlin, Germany
* Sitz / Registered office: Berlin, HRB 134158 B
* Geschäftsführer / Managing Directors: Harald Welte
5:12 p.m.
Hi Neels,
On Tue, Apr 14, 2020 at 02:21:31PM +0200, Neels Hofmeyr wrote:
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.
Maybe we aren't sending the CommonID with the mapping of TMSI<->IMSI in that
case,
or somehow send it wrong? I suppose it exists exactly for these situations, to tell
the RAN which IMSI the MS has, if it is not sent over the radio intreface.
--
- Harald Welte <laforge(a)osmocom.org> http://laforge.gnumonks.org/
============================================================================
"Privacy in residential applications is a desirable marketing option."
(ETSI EN 300 175-7 Ch. A6)
8:38 p.m.
I should be able to test again and provide pcap and more logs tonight. Thanks for the
ideas!
Craig
On April 14, 2020 10:12:43 AM CDT, Harald Welte <laforge(a)osmocom.org> wrote:
Hi Neels,
On Tue, Apr 14, 2020 at 02:21:31PM +0200, Neels Hofmeyr wrote:
--
Sent from my Android device with K-9 Mail. Please excuse my brevity.
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.
Maybe we aren't sending the CommonID with the mapping of TMSI<->IMSI in
that case,
or somehow send it wrong? I suppose it exists exactly for these
situations, to tell
the RAN which IMSI the MS has, if it is not sent over the radio
intreface.
--
- Harald Welte <laforge(a)osmocom.org>
http://laforge.gnumonks.org/
============================================================================
"Privacy in residential applications is a desirable marketing option."
(ETSI EN 300 175-7 Ch. A6)
1481
days inactive
1485
days old
4 comments
4 participants
participants (4)
-
Craig Comstock -
Harald Welte -
Neels Hofmeyr -
Pau Espin Pedrol