26 Mar
2022
26 Mar
'22
10:52 a.m.
Hi,
I've run into problems with M3UA, getting the link up.
Our MSC sends a M3UA DAUD message ( Destination Audit ), which is unknown to HnbGw. This
might not be a big problem, but the MSC does not support registering of routing-key.
And it looks like because MSC rejects the REG-REQ, the HnbGw restarts the signalling link
by sending SCTP SHUTDOWN to MSC.
I tried to drop the line routing-key in config file, but REG_REQ was sent anyway. I also
tried to enter routing-key with context=0, same thing.
Capturing on 'eno2'
1 2022-03-26 09:26:41.480666703 10.30.50.124 -> 10.40.33.6 SCTP 86 INIT
2 2022-03-26 09:26:41.480710694 10.30.50.100 -> 10.40.2.66 SCTP 86 INIT
3 2022-03-26 09:26:41.480971008 10.40.2.66 -> 10.30.50.100 SCTP 206 INIT_ACK
4 2022-03-26 09:26:41.481112284 10.40.33.6 -> 10.30.50.124 SCTP 298 INIT_ACK
5 2022-03-26 09:26:41.481213421 10.30.50.100 -> 10.40.2.66 SCTP 86 INIT
6 2022-03-26 09:26:41.481266735 10.40.2.66 -> 10.30.50.100 SCTP 206 INIT_ACK
7 2022-03-26 09:26:41.483522819 10.30.50.124 -> 10.40.33.6 SCTP 254 COOKIE_ECHO
8 2022-03-26 09:26:41.483629506 10.30.50.100 -> 10.40.2.66 SCTP 162 COOKIE_ECHO
9 2022-03-26 09:26:41.483690725 10.40.2.66 -> 10.30.50.100 SCTP 60 COOKIE_ACK
10 2022-03-26 09:26:41.484110760 10.40.33.6 -> 10.30.50.124 SCTP 64 COOKIE_ACK
11 2022-03-26 09:26:41.484117880 10.40.33.7 -> 10.30.50.124 SCTP 130 HEARTBEAT
12 2022-03-26 09:26:41.486512775 10.30.50.124 -> 10.40.33.7 SCTP 130 HEARTBEAT_ACK
13 2022-03-26 09:26:41.486513593 10.30.50.100 -> 10.40.2.66 M3UA (RFC 3332) 74
ASPUP
14 2022-03-26 09:26:41.486682342 10.40.2.66 -> 10.30.50.100 SCTP 66 SACK
15 2022-03-26 09:26:41.486694401 10.40.2.66 -> 10.30.50.100 M3UA (RFC 3332) 74
ASPUP_ACK
16 2022-03-26 09:26:41.488189055 10.40.2.74 -> 10.30.50.100 SCTP 78 HEARTBEAT
17 2022-03-26 09:26:41.489702157 10.30.50.100 -> 10.40.2.66 SCTP 66 SACK
18 2022-03-26 09:26:41.489730294 10.40.2.66 -> 10.30.50.100 M3UA (RFC 3332) 82
DAUD
19 2022-03-26 09:26:41.492451543 10.30.50.100 -> 10.40.2.66 M3UA (RFC 3332) 118 SACK
ERR
20 2022-03-26 09:26:41.532141583 10.40.2.66 -> 10.30.50.100 SCTP 66 SACK
21 2022-03-26 09:26:42.488369158 10.40.2.74 -> 10.30.50.100 SCTP 78 HEARTBEAT
22 2022-03-26 09:26:43.491352631 10.30.50.100 -> 10.40.2.66 M3UA (RFC 3332) 110
REG_REQ
23 2022-03-26 09:26:43.491554237 10.40.2.66 -> 10.30.50.100 M3UA (RFC 3332) 142 SACK
ERR
24 2022-03-26 09:26:43.688325732 10.40.2.74 -> 10.30.50.100 SCTP 78 HEARTBEAT
25 2022-03-26 09:26:43.698031665 10.30.50.100 -> 10.40.2.66 SCTP 66 SACK
26 2022-03-26 09:26:44.888336483 10.40.2.74 -> 10.30.50.100 SCTP 78 HEARTBEAT
27 2022-03-26 09:26:46.088347715 10.40.2.74 -> 10.30.50.100 SCTP 78 HEARTBEAT
28 2022-03-26 09:26:53.501539305 10.30.50.100 -> 10.40.2.66 SCTP 60 SHUTDOWN
29 2022-03-26 09:26:53.501628420 10.40.2.66 -> 10.30.50.100 SCTP 60 SHUTDOWN_ACK
30 2022-03-26 09:26:53.504324344 10.30.50.100 -> 10.40.2.66 SCTP 60
SHUTDOWN_COMPLETE
^C30 packets captured
[root@tmabuotshark10 ~]#
Config file:
hnbgw
iuh
local-ip 10.30.50.69
local-port 29169
iucs
remote-addr msc
iups
remote-addr sgsn
cs7 instance 0
point-code 0.69.3
asp asp-clnt-OsmoHNBGW 52905 2905 m3ua
local-ip 10.30.50.100
remote-ip 10.40.2.66
remote-ip 10.40.2.74
sctp-role client
as msc-as m3ua
asp asp-clnt-OsmoHNBGW
sccp-address msc
routing-indicator PC
point-code 0.27.4
asp asp-clnt-OsmoHNBGW2 2905 2905 m3ua
local-ip 10.30.50.124
remote-ip 10.40.33.6
remote-ip 10.40.33.7
sctp-role client
as sgsn-as m3ua
asp asp-clnt-OsmoHNBGW2
sccp-address sgsn
routing-indicator PC
point-code 0.113.6
log stderr
logging filter all 1
logging print extended-timestamp 1
logging print category 1
logging print category-hex 0
logging print level 1
logging print file basename last
logging level set-all info
Log from Osmo-Hnbgw:
20220326092641479 DLGLOBAL NOTICE Available via telnet 127.0.0.1 4261
(telnet_interface.c:104)
20220326092641479 DLCTRL NOTICE CTRL at 127.0.0.1 4262 (control_if.c:1017)
20220326092641479 DRANAP NOTICE Remote IuCS SCCP addr: RI=SSN_PC,PC=0.27.4,SSN=RANAP
(hnbgw_cn.c:488)
20220326092641479 DRANAP NOTICE Remote IuPS SCCP addr: RI=SSN_PC,PC=0.113.6,SSN=RANAP
(hnbgw_cn.c:488)
20220326092641479 DRANAP NOTICE Local SCCP addr: RI=SSN_PC,PC=0.69.3,SSN=RANAP
(hnbgw_cn.c:524)
20220326092641479 DLSCCP NOTICE OsmoHNBGW: Using SS7 instance 0, pc:0.69.3
(sccp_user.c:549)
20220326092641479 DLSCCP NOTICE OsmoHNBGW: Using AS instance msc-as (sccp_user.c:567)
20220326092641479 DLSCCP NOTICE OsmoHNBGW: Creating default route (sccp_user.c:572)
20220326092641479 DLSS7 INFO 0: Creating route: pc=0=0.0.0 mask=0x0 via AS
'msc-as' (osmo_ss7.c:830)
20220326092641479 DLSS7 INFO 0: asp-asp-clnt-OsmoHNBGW: Restarting ASP asp-clnt-OsmoHNBGW,
r=(10.40.2.66|10.40.2.74):52905<->l=10.30.50.100:2905 (osmo_ss7.c:1596)
20220326092641479 DLSCCP NOTICE OsmoHNBGW: Using ASP instance asp-clnt-OsmoHNBGW
(sccp_user.c:643)
20220326092641479 DLSS7 NOTICE 0: Creating SCCP instance (osmo_ss7.c:457)
20220326092641479 DLSCCP INFO Binding user 'SCCP Maangement' to SSN=1 PC=(no PC)
(sccp_user.c:108)
20220326092641479 DLSCCP INFO Binding user 'OsmoHNBGW' to SSN=142 PC=0.69.3
(sccp_user.c:108)
20220326092641479 DRANAP NOTICE Remote SCCP addr: IuCS: RI=SSN_PC,PC=0.27.4,SSN=RANAP
(hnbgw_cn.c:549)
20220326092641479 DRANAP NOTICE Remote SCCP addr: IuPS: RI=SSN_PC,PC=0.113.6,SSN=RANAP
(hnbgw_cn.c:551)
20220326092641479 DHNBAP NOTICE Using RNC-Id 23 (hnbgw.c:660)
20220326092641479 DMAIN NOTICE Listening for Iuh at 10.30.50.69 29169 (hnbgw.c:665)
20220326092641485 DLINP INFO sizes of 'struct sctp_event_subscribe': compile-time
14, kernel: 14 (stream.c:114)
20220326092641485 DLSS7 INFO 0: asp-asp-clnt-OsmoHNBGW2: Client connected
(r=10.40.33.7:2905<->l=10.30.50.124:2905) (osmo_ss7.c:1856)
20220326092641485 DLSS7 ERROR XUA_ASP(asp-clnt-OsmoHNBGW2)[0x55fc0cbdd780]{ASP_DOWN}:
event M-ASP_UP.req not permitted in role SG (xua_asp_fsm.c:420)
20220326092641485 DLSS7 INFO 0: asp-asp-clnt-OsmoHNBGW: Client connected
(r=10.40.2.74:52905<->l=10.30.50.100:2905) (osmo_ss7.c:1856)
20220326092641490 DLM3UA ERROR 0: asp-asp-clnt-OsmoHNBGW: Rx M3UA SNM not permitted while
ASP in state ASP_INACTIVE (m3ua.c:954)
20220326092643492 DLM3UA ERROR 0: asp-asp-clnt-OsmoHNBGW: Received MGMT_ERR
'Unsupported Message Class': HDR=(MGMT:ERROR,V=1,LEN=1006632960), PART(T=Error
Code,L=4,D=00000003), PART(T=Diagnostic
Info,L=40,D=010009010000002c02070024020a0008000000010006000800000000000b000800000001020b0008)
(m3ua.c:588)
20220326092643492 DLSS7 NOTICE
xua_default_lm(asp-clnt-OsmoHNBGW)[0x55fc0cbd80f0]{RKM_REG}: Ignoring primitive
M-ERROR.indication (xua_default_lm_fsm.c:361)
20220326092653499 DLSS7 INFO 0: asp-asp-clnt-OsmoHNBGW: Restarting ASP asp-clnt-OsmoHNBGW,
r=(10.40.2.66|10.40.2.74):52905<->l=10.30.50.100:2905 (osmo_ss7.c:1596)
20220326092653499 DLGLOBAL ERROR unable to connect socket: (10.40.2.66|10.40.2.74):52905:
Cannot assign requested address (socket.c:848)
20220326092653499 DLINP INFO [WAIT_RECONNECT] osmo_stream_cli_reconnect(): retrying in 5
seconds... (stream.c:286)
20220326092653499 DLSS7 ERROR 0: asp-asp-clnt-OsmoHNBGW: Unable to open stream client for
ASP asp-clnt-OsmoHNBGW, 10.30.50.100:2905 ==> (10.40.2.66|10.40.2.74):52905
(osmo_ss7.c:1629)
20220326092658509 DLSS7 INFO 0: asp-asp-clnt-OsmoHNBGW: Client connected
(r=10.40.2.74:52905<->l=10.30.50.100:2905) (osmo_ss7.c:1856)
20220326092658515 DLM3UA ERROR 0: asp-asp-clnt-OsmoHNBGW: Rx M3UA SNM not permitted while
ASP in state ASP_INACTIVE (m3ua.c:954)
20220326092700517 DLM3UA ERROR 0: asp-asp-clnt-OsmoHNBGW: Received MGMT_ERR
'Unsupported Message Class': HDR=(MGMT:ERROR,V=1,LEN=1006632960), PART(T=Error
Code,L=4,D=00000003), PART(T=Diagnostic
Info,L=40,D=010009010000002c02070024020a0008000000010006000800000000000b000800000001020b0008)
(m3ua.c:588)
20220326092700517 DLSS7 NOTICE
xua_default_lm(asp-clnt-OsmoHNBGW)[0x55fc0cbd80f0]{RKM_REG}: Ignoring primitive
M-ERROR.indication (xua_default_lm_fsm.c:361)
20220326092710520 DLSS7 INFO 0: asp-asp-clnt-OsmoHNBGW: Restarting ASP asp-clnt-OsmoHNBGW,
r=(10.40.2.66|10.40.2.74):52905<->l=10.30.50.100:2905 (osmo_ss7.c:1596)
20220326092710520 DLGLOBAL ERROR unable to connect socket: (10.40.2.66|10.40.2.74):52905:
Cannot assign requested address (socket.c:848)
20220326092710520 DLINP INFO [WAIT_RECONNECT] osmo_stream_cli_reconnect(): retrying in 5
seconds... (stream.c:286)
20220326092710520 DLSS7 ERROR 0: asp-asp-clnt-OsmoHNBGW: Unable to open stream client for
ASP asp-clnt-OsmoHNBGW, 10.30.50.100:2905 ==> (10.40.2.66|10.40.2.74):52905
(osmo_ss7.c:1629)
20220326092715530 DLSS7 INFO 0: asp-asp-clnt-OsmoHNBGW: Client connected
(r=10.40.2.74:52905<->l=10.30.50.100:2905) (osmo_ss7.c:1856)
20220326092715536 DLM3UA ERROR 0: asp-asp-clnt-OsmoHNBGW: Rx M3UA SNM not permitted while
ASP in state ASP_INACTIVE (m3ua.c:954)
20220326092717538 DLM3UA ERROR 0: asp-asp-clnt-OsmoHNBGW: Received MGMT_ERR
'Unsupported Message Class': HDR=(MGMT:ERROR,V=1,LEN=1006632960), PART(T=Error
Code,L=4,D=00000003), PART(T=Diagnostic
Info,L=40,D=010009010000002c02070024020a0008000000010006000800000000000b000800000001020b0008)
(m3ua.c:588)
20220326092717538 DLSS7 NOTICE
xua_default_lm(asp-clnt-OsmoHNBGW)[0x55fc0cbd80f0]{RKM_REG}: Ignoring primitive
M-ERROR.indication (xua_default_lm_fsm.c:361)
^C
All ideas/help highly appreciated!
Best regards,
/Sjur
-----Original Message-----
From: Sjur Thomas Lien
Sent: Friday, March 25, 2022 10:45 AM
To: OpenBSC <openbsc(a)lists.osmocom.org>
Subject: RE: OSMO HnbGW , problems with SCTP towards real MSC and SGSN
Hi,
I figured it out by myself😊
Regards,
/Sjur
-----Original Message-----
From: Sjur Thomas Lien <sjur.lien(a)telenormaritime.com>
Sent: Friday, March 25, 2022 10:23 AM
To: OpenBSC <openbsc(a)lists.osmocom.org>
Subject: OSMO HnbGW , problems with SCTP towards real MSC and SGSN
Hi,
I'm getting closer. But SCTP does not come up, both my real MSC and SGSN sends SCTP
ABORT:
283 2022-03-25 08:14:08.200734109 10.30.50.124 -> 10.40.33.6 SCTP 86 INIT
284 2022-03-25 08:14:08.201189770 10.40.33.6 -> 10.30.50.124 SCTP 298 INIT_ACK
285 2022-03-25 08:14:08.201286756 10.30.50.100 -> 10.40.2.66 SCTP 86 INIT
286 2022-03-25 08:14:08.201405921 10.40.2.66 -> 10.30.50.100 SCTP 60 ABORT
287 2022-03-25 08:14:08.204033135 10.30.50.124 -> 10.40.33.6 SCTP 254 COOKIE_ECHO
288 2022-03-25 08:14:08.204405432 10.40.33.7 -> 10.30.50.124 SCTP 130 HEARTBEAT
289 2022-03-25 08:14:08.204423695 10.40.33.6 -> 10.30.50.124 SCTP 64 COOKIE_ACK
290 2022-03-25 08:14:08.204595511 10.40.33.6 -> 10.30.50.124 SCTP 64 ABORT
291 2022-03-25 08:14:08.207135400 10.30.50.124 -> 10.40.33.7 SCTP 60 ABORT
SCTP endpoints:
SGSN HnbGw MSC
-------------------------------------------------------------------------------
10.40.33.6| <---------> 10.30.40.124 |10.40.2.66
10.40.33.7| 10.30.40.100 <---------> |10.40.2.74
I suspect the source port on HnbGw:
Source: 10.30.50.100
Destination: 10.40.2.66
Stream Control Transmission Protocol, Src Port: 38989 (38989), Dst Port: 2905 (2905)
Source port: 38989
Destination port: 2905
The MSC sends ABORT as answer to SCTP-INIT. But our SGSN seems to accept INIT and COOKIE,
but eventually sends ABORT.
OsmoHNBGW> show version
OsmoHNBGW 1.2.1 (OsmoHNBGW).
So a few questions:
- I tried to set local port to 2905 under asp in config file, but was rejected ( no such
command ). So is there a way to set source port ?
- In MSC and SGSN we must give local and remote port for the SCTP link. Have you tested
HnbGW with real Ericsson MSC and SGSN ?
- There are many parameters and timers connected to SCTP protocol:
HBInterval 3;
MaxAssociationRetransmits 10;
MaxInitRetransmits 3;
MaxPathRetransmits 5;
RTOInitial 3000;
RTOMax 6000;
RTOMin 1000;
ValCookieLife 60000;
Are these hardcoded, or could they be configured ?
Thanks,
/Sjur
Internal
Internal
Internal