10 Jul
2021
10 Jul
'21
5:03 p.m.
Hi,
after long time (may years), I do a "compileathlon"/"configathlon"
with
a osmo-bsc/osmo-stp/osmo-msc/osmo-sip-connector setup. If I interpret
this the shown osmo-bsc output correctly, it attaches successfully
through the osmo-stp with the osmo-msc. Then I start an ipaccess
nanobts. It connects via OML, comes to a point where provisioning stops
or times out.
I use a fresh debian installation with am64 and todays master branches
from git.osmocom.org repository.
A pcap file of the OML connection is attached to this message. (The
order of packets in the trace is messed up, due to my switch's port
mirroring.) Also attached is the osmo-bsc.cfg.
Any idea?
Thank you,
Andreas
<0004> fsm.c:461 NM_BTS_SM_OP[0x558f2b1d17e0]{DISABLED_NOTINSTALLED}:
Allocated
<0004> fsm.c:461 NM_BTS_OP[0x558f2b1d5120]{DISABLED_NOTINSTALLED}: Allocated
<0004> fsm.c:461 NM_GPRS_CELL_OP[0x558f2b1d5250]{DISABLED_NOTINSTALLED}:
Allocated
<0004> fsm.c:461 NM_RCARRIER_OP[0x558f2b1da770]{DISABLED_NOTINSTALLED}:
Allocated
<0004> fsm.c:461 NM_BB_TRANSC_OP[0x558f2b1da940]{DISABLED_NOTINSTALLED}:
Allocated
<0004> fsm.c:461 NM_CHAN_OP[0x558f2b1dac40]{DISABLED_NOTINSTALLED}:
Allocated
<0004> fsm.c:461 NM_CHAN_OP[0x558f2b1db340]{DISABLED_NOTINSTALLED}:
Allocated
<0004> fsm.c:461 NM_CHAN_OP[0x558f2b1dbb40]{DISABLED_NOTINSTALLED}:
Allocated
<0004> fsm.c:461 NM_CHAN_OP[0x558f2b1dc340]{DISABLED_NOTINSTALLED}:
Allocated
<0004> fsm.c:461 NM_CHAN_OP[0x558f2b1dcb40]{DISABLED_NOTINSTALLED}:
Allocated
<0004> fsm.c:461 NM_CHAN_OP[0x558f2b1dd3d0]{DISABLED_NOTINSTALLED}:
Allocated
<0004> fsm.c:461 NM_CHAN_OP[0x558f2b1ddc60]{DISABLED_NOTINSTALLED}:
Allocated
<0004> fsm.c:461 NM_CHAN_OP[0x558f2b1de4f0]{DISABLED_NOTINSTALLED}:
Allocated
<0004> fsm.c:461 NM_GPRS_NSE_OP[0x558f2b1debd0]{DISABLED_NOTINSTALLED}:
Allocated
<0004> fsm.c:461 NM_GPRS_NSVC_OP[0x558f2b1ded90]{DISABLED_NOTINSTALLED}:
Allocated
<0004> fsm.c:461 NM_GPRS_NSVC_OP[0x558f2b1defc0]{DISABLED_NOTINSTALLED}:
Allocated
<0015> telnet_interface.c:104 Available via telnet 127.0.0.1 4242
<0017> input/ipaccess.c:1035 enabling ipaccess BSC mode on 0.0.0.0 with
OML 3002 and RSL 3003 TCP ports
<001c> control_if.c:922 CTRL at 127.0.0.1 4249
<0025> mgcp_client.c:782 MGCP client: using endpoint domain '@mgw'
<0007> osmo_bsc_sigtran.c:548 Initializing SCCP connection for A/m3ua on
cs7 instance 0
<0022> sccp_user.c:548 A-0-m3ua: Using SS7 instance 0, pc:1.23.3
<0022> sccp_user.c:555 A-0-m3ua: Creating AS instance
<0022> sccp_user.c:566 A-0-m3ua: Using AS instance as-clnt-A-0-m3ua
<0022> sccp_user.c:571 A-0-m3ua: Creating default route
<0022> sccp_user.c:605 A-0-m3ua: ASP my-asp for m3ua is not associated
with any AS, using it
<0022> sccp_user.c:638 A-0-m3ua: Using ASP instance my-asp
<0021> osmo_ss7.c:456 0: Creating SCCP instance
<0007> osmo_bsc_sigtran.c:600 A-0-m3ua msc-0: local (BSC) SCCP address:
RI=SSN_PC,PC=1.23.3,SSN=BSSAP
<0007> osmo_bsc_sigtran.c:602 A-0-m3ua msc-0: remote (MSC) SCCP address:
RI=SSN_PC,PC=0.23.1,SSN=BSSAP
<0007> osmo_bsc_sigtran.c:607 A-0-m3ua msc-0: binding SCCP user
<0021> m3ua.c:507 XUA_AS(as-clnt-A-0-m3ua)[0x558f2b1e2c10]{AS_DOWN}:
Event AS-TRANSFER.req not permitted
<0024> m3ua.c:622 0: asp-my-asp: Received NOTIFY Type State Change:AS
Inactive ()
<0021> xua_default_lm_fsm.c:361
xua_default_lm(my-asp)[0x558f2b1e2f40]{ACTIVE}: Ignoring primitive
M-ASP_ACTIVE.confirm
<0024> m3ua.c:622 0: asp-my-asp: Received NOTIFY Type State Change:AS
Active ()
<0007> osmo_bsc_bssap.c:81 RESET ACK from MSC: RI=SSN_PC,PC=0.23.1,SSN=BSSAP
<0014> bssmap_reset.c:83 bssmap_reset(msc-0)[0x558f2b1e3d50]{CONN}: link up
<0007> a_reset.c:44 (msc0) BSSMAP assocation is up
<0017> input/ipa.c:284 0.0.0.0:3002 accept()ed new link from 10.0.0.96:48280
<0004> abis_nm.c:258 OC=SITE-MANAGER(00) INST=(ff,ff,ff): STATE CHG:
OP_STATE=Disabled AVAIL=Not installed(07)
<0004> bts_ipaccess_nanobts.c:156
NM_BTS_SM_OP(bts_sm)[0x558f2b1d17e0]{DISABLED_NOTINSTALLED}: Received
Event STATE_CHG_REP
<0004> abis_nm.c:258 OC=BTS(01) INST=(00,ff,ff): STATE CHG:
OP_STATE=Disabled AVAIL=Not installed(07) ADM=Locked
<0004> bts_ipaccess_nanobts.c:160
NM_BTS_OP(bts0)[0x558f2b1d5120]{DISABLED_NOTINSTALLED}: Received Event
STATE_CHG_REP
<0004> abis_nm.c:258 OC=BASEBAND-TRANSCEIVER(04) INST=(00,00,ff): STATE
CHG: OP_STATE=Disabled AVAIL=Not installed(07) ADM=Locked
<0004> bts_ipaccess_nanobts.c:164
NM_BB_TRANSC_OP(bts0-trx0)[0x558f2b1da940]{DISABLED_NOTINSTALLED}:
Received Event STATE_CHG_REP
<0004> abis_nm.c:258 OC=CHANNEL(03) INST=(00,00,00): STATE CHG:
OP_STATE=Disabled AVAIL=Not installed(07) ADM=Locked
<0004> bts_ipaccess_nanobts.c:169
NM_CHAN_OP(bts0-trx0-ts0)[0x558f2b1dac40]{DISABLED_NOTINSTALLED}:
Received Event STATE_CHG_REP
<0004> abis_nm.c:258 OC=CHANNEL(03) INST=(00,00,01): STATE CHG:
OP_STATE=Disabled AVAIL=Not installed(07) ADM=Locked
<0004> bts_ipaccess_nanobts.c:169
NM_CHAN_OP(bts0-trx0-ts1)[0x558f2b1db340]{DISABLED_NOTINSTALLED}:
Received Event STATE_CHG_REP
<0004> abis_nm.c:258 OC=CHANNEL(03) INST=(00,00,02): STATE CHG:
OP_STATE=Disabled AVAIL=Not installed(07) ADM=Locked
<0004> bts_ipaccess_nanobts.c:169
NM_CHAN_OP(bts0-trx0-ts2)[0x558f2b1dbb40]{DISABLED_NOTINSTALLED}:
Received Event STATE_CHG_REP
<0004> abis_nm.c:258 OC=CHANNEL(03) INST=(00,00,03): STATE CHG:
OP_STATE=Disabled AVAIL=Not installed(07) ADM=Locked
<0004> bts_ipaccess_nanobts.c:169
NM_CHAN_OP(bts0-trx0-ts3)[0x558f2b1dc340]{DISABLED_NOTINSTALLED}:
Received Event STATE_CHG_REP
<0004> abis_nm.c:258 OC=CHANNEL(03) INST=(00,00,04): STATE CHG:
OP_STATE=Disabled AVAIL=Not installed(07) ADM=Locked
<0004> bts_ipaccess_nanobts.c:169
NM_CHAN_OP(bts0-trx0-ts4)[0x558f2b1dcb40]{DISABLED_NOTINSTALLED}:
Received Event STATE_CHG_REP
<0004> abis_nm.c:258 OC=CHANNEL(03) INST=(00,00,05): STATE CHG:
OP_STATE=Disabled AVAIL=Not installed(07) ADM=Locked
<0004> bts_ipaccess_nanobts.c:169
NM_CHAN_OP(bts0-trx0-ts5)[0x558f2b1dd3d0]{DISABLED_NOTINSTALLED}:
Received Event STATE_CHG_REP
<0004> abis_nm.c:258 OC=CHANNEL(03) INST=(00,00,06): STATE CHG:
OP_STATE=Disabled AVAIL=Not installed(07) ADM=Locked
<0004> bts_ipaccess_nanobts.c:169
NM_CHAN_OP(bts0-trx0-ts6)[0x558f2b1ddc60]{DISABLED_NOTINSTALLED}:
Received Event STATE_CHG_REP
<0004> abis_nm.c:258 OC=CHANNEL(03) INST=(00,00,07): STATE CHG:
OP_STATE=Disabled AVAIL=Not installed(07) ADM=Locked
<0004> bts_ipaccess_nanobts.c:169
NM_CHAN_OP(bts0-trx0-ts7)[0x558f2b1de4f0]{DISABLED_NOTINSTALLED}:
Received Event STATE_CHG_REP
<0004> abis_nm.c:258 OC=RADIO-CARRIER(02) INST=(00,00,ff): STATE CHG:
OP_STATE=Disabled AVAIL=Not installed(07) ADM=Locked
<0004> bts_ipaccess_nanobts.c:173
NM_RCARRIER_OP(bts0-trx0)[0x558f2b1da770]{DISABLED_NOTINSTALLED}:
Received Event STATE_CHG_REP
<0004> abis_nm.c:258 OC=GPRS-NSE(f0) INST=(00,ff,ff): STATE CHG:
OP_STATE=Disabled AVAIL=Not installed(07) ADM=Locked
<0004> bts_ipaccess_nanobts.c:177
NM_GPRS_NSE_OP(nse0)[0x558f2b1debd0]{DISABLED_NOTINSTALLED}: Received
Event STATE_CHG_REP
<0004> abis_nm.c:258 OC=GPRS-CELL(f1) INST=(00,00,ff): STATE CHG:
OP_STATE=Disabled AVAIL=Not installed(07) ADM=Locked
<0004> bts_ipaccess_nanobts.c:181
NM_GPRS_CELL_OP(gprs-cell0)[0x558f2b1d5250]{DISABLED_NOTINSTALLED}:
Received Event STATE_CHG_REP
<0004> abis_nm.c:258 OC=GPRS-NSVC(f2) INST=(00,00,ff): STATE CHG:
OP_STATE=Disabled AVAIL=Not installed(07) ADM=Locked
<0004> bts_ipaccess_nanobts.c:188
NM_GPRS_NSVC_OP(nsvc0)[0x558f2b1ded90]{DISABLED_NOTINSTALLED}: Received
Event STATE_CHG_REP
<0004> abis_nm.c:258 OC=GPRS-NSVC(f2) INST=(00,01,ff): STATE CHG:
OP_STATE=Disabled AVAIL=Not installed(07) ADM=Locked
<0004> abis_nm.c:724 OC=SITE-MANAGER(00) INST=(ff,ff,ff): Software
Activate Request, ACKing and Activating
<0004> abis_nm.c:743 OC=SITE-MANAGER(00) INST=(ff,ff,ff): Found SW
config: 42 12 00 08 31 32 30 61 30 30 32 00 13 00 09 76 32 36 37 62 35
64 30 00
<0004> abis_nm.c:755 OC=SITE-MANAGER(00) INST=(ff,ff,ff): Selected sw
description 0 of 1
<0004> abis_nm.c:258 OC=SITE-MANAGER(00) INST=(ff,ff,ff): STATE CHG:
OP_STATE=Enabled AVAIL=OK(ff)
<0004> bts_ipaccess_nanobts.c:156
NM_BTS_SM_OP(bts_sm)[0x558f2b1d17e0]{DISABLED_NOTINSTALLED}: Received
Event STATE_CHG_REP
<0004> abis_nm.c:2186 OC=SITE-MANAGER(00) INST=(ff,ff,ff): Sending OPSTART
<0004> nm_bts_sm_fsm.c:83
NM_BTS_SM_OP(bts_sm)[0x558f2b1d17e0]{DISABLED_NOTINSTALLED}: state_chg
to ENABLED
<0004> abis_nm.c:478 OC=SITE-MANAGER(00) INST=(ff,ff,ff): Software
Activated Report
<0004> bts_ipaccess_nanobts.c:211
NM_BTS_SM_OP(bts_sm)[0x558f2b1d17e0]{ENABLED}: Received Event SW_ACT_REP
<0004> bts_ipaccess_nanobts.c:211
NM_BTS_SM_OP(bts_sm)[0x558f2b1d17e0]{ENABLED}: Event SW_ACT_REP not
permitted
<0004> abis_nm.c:724 OC=BTS(01) INST=(00,ff,ff): Software Activate
Request, ACKing and Activating
<0004> abis_nm.c:743 OC=BTS(01) INST=(00,ff,ff): Found SW config: 42 12
00 08 31 32 30 61 30 30 32 00 13 00 09 76 32 36 37 62 35 64 30 00
<0004> abis_nm.c:755 OC=BTS(01) INST=(00,ff,ff): Selected sw description
0 of 1
<0004> abis_nm.c:724 OC=GPRS-NSE(f0) INST=(00,ff,ff): Software Activate
Request, ACKing and Activating
<0004> abis_nm.c:743 OC=GPRS-NSE(f0) INST=(00,ff,ff): Found SW config:
42 12 00 08 31 32 30 61 30 30 32 00 13 00 09 76 32 36 37 62 35 64 30 00
<0004> abis_nm.c:755 OC=GPRS-NSE(f0) INST=(00,ff,ff): Selected sw
description 0 of 1
<0004> abis_nm.c:839 OC=SITE-MANAGER(00) INST=(ff,ff,ff): Opstart ACK
<0004> bts_ipaccess_nanobts.c:271
NM_BTS_SM_OP(bts_sm)[0x558f2b1d17e0]{ENABLED}: Received Event OPSTART_ACK
<0004> abis_nm.c:258 OC=BTS(01) INST=(00,ff,ff): STATE CHG:
OP_STATE=Disabled AVAIL=Dependency(05)
<0004> bts_ipaccess_nanobts.c:160
NM_BTS_OP(bts0)[0x558f2b1d5120]{DISABLED_NOTINSTALLED}: Received Event
STATE_CHG_REP
<0004> nm_bts_fsm.c:77
NM_BTS_OP(bts0)[0x558f2b1d5120]{DISABLED_NOTINSTALLED}: state_chg to
DISABLED_DEPENDENCY
<0004> nm_bts_fsm.c:153
NM_BTS_OP(bts0)[0x558f2b1d5120]{DISABLED_DEPENDENCY}: state_chg to
DISABLED_OFFLINE
<0004> abis_nm.c:1835 OC=BTS(01) INST=(00,ff,ff): Tx Get Attributes
(Request)
<0004> abis_nm.c:478 OC=BTS(01) INST=(00,ff,ff): Software Activated Report
<0004> bts_ipaccess_nanobts.c:214
NM_BTS_OP(bts0)[0x558f2b1d5120]{DISABLED_OFFLINE}: Received Event SW_ACT_REP
<0004> bts_ipaccess_nanobts.c:214
NM_BTS_OP(bts0)[0x558f2b1d5120]{DISABLED_OFFLINE}: Event SW_ACT_REP not
permitted
<0004> abis_nm.c:724 OC=BASEBAND-TRANSCEIVER(04) INST=(00,00,ff):
Software Activate Request, ACKing and Activating
<0004> abis_nm.c:743 OC=BASEBAND-TRANSCEIVER(04) INST=(00,00,ff): Found
SW config: 42 12 00 08 31 32 30 61 30 30 31 00 13 00 09 76 32 36 37 62
35 64 30 00 42 12 00 08 31 32 30 61 30 30 32 00 13 00 09 76 32 36 37 62
35 64 30 00
<0004> abis_nm.c:755 OC=BASEBAND-TRANSCEIVER(04) INST=(00,00,ff):
Selected sw description 0 of 2
<0004> abis_nm.c:724 OC=RADIO-CARRIER(02) INST=(00,00,ff): Software
Activate Request, ACKing and Activating
<0004> abis_nm.c:743 OC=RADIO-CARRIER(02) INST=(00,00,ff): Found SW
config: 42 12 00 08 31 32 30 61 30 30 31 00 13 00 09 76 32 36 37 62 35
64 30 00 42 12 00 08 31 32 30 61 30 30 32 00 13 00 09 76 32 36 37 62 35
64 30 00
<0004> abis_nm.c:755 OC=RADIO-CARRIER(02) INST=(00,00,ff): Selected sw
description 0 of 2
<0004> abis_nm.c:258 OC=GPRS-NSE(f0) INST=(00,ff,ff): STATE CHG:
OP_STATE=Disabled AVAIL=Dependency(05)
<0004> bts_ipaccess_nanobts.c:177
NM_GPRS_NSE_OP(nse0)[0x558f2b1debd0]{DISABLED_NOTINSTALLED}: Received
Event STATE_CHG_REP
<0004> nm_gprs_nse_fsm.c:76
NM_GPRS_NSE_OP(nse0)[0x558f2b1debd0]{DISABLED_NOTINSTALLED}: state_chg
to DISABLED_DEPENDENCY
<0004> nm_gprs_nse_fsm.c:131
NM_GPRS_NSE_OP(nse0)[0x558f2b1debd0]{DISABLED_DEPENDENCY}: state_chg to
DISABLED_OFFLINE
<0004> abis_nm.c:478 OC=GPRS-NSE(f0) INST=(00,ff,ff): Software Activated
Report
<0004> bts_ipaccess_nanobts.c:232
NM_GPRS_NSE_OP(nse0)[0x558f2b1debd0]{DISABLED_OFFLINE}: Received Event
SW_ACT_REP
<0004> bts_ipaccess_nanobts.c:232
NM_GPRS_NSE_OP(nse0)[0x558f2b1debd0]{DISABLED_OFFLINE}: Event SW_ACT_REP
not permitted
<0004> abis_nm.c:724 OC=GPRS-CELL(f1) INST=(00,00,ff): Software Activate
Request, ACKing and Activating
<0004> abis_nm.c:743 OC=GPRS-CELL(f1) INST=(00,00,ff): Found SW config:
42 12 00 08 31 32 30 61 30 30 32 00 13 00 09 76 32 36 37 62 35 64 30 00
<0004> abis_nm.c:755 OC=GPRS-CELL(f1) INST=(00,00,ff): Selected sw
description 0 of 1
<0004> abis_nm.c:724 OC=GPRS-NSVC(f2) INST=(00,00,ff): Software Activate
Request, ACKing and Activating
<0004> abis_nm.c:743 OC=GPRS-NSVC(f2) INST=(00,00,ff): Found SW config:
42 12 00 08 31 32 30 61 30 30 32 00 13 00 09 76 32 36 37 62 35 64 30 00
<0004> abis_nm.c:755 OC=GPRS-NSVC(f2) INST=(00,00,ff): Selected sw
description 0 of 1
<0004> abis_nm.c:724 OC=GPRS-NSVC(f2) INST=(00,01,ff): Software Activate
Request, ACKing and Activating
<0004> abis_nm.c:743 OC=GPRS-NSVC(f2) INST=(00,01,ff): Found SW config:
42 12 00 08 31 32 30 61 30 30 32 00 13 00 09 76 32 36 37 62 35 64 30 00
<0004> abis_nm.c:755 OC=GPRS-NSVC(f2) INST=(00,01,ff): Selected sw
description 0 of 1
<0004> abis_nm.c:698 OC=BTS(01) INST=(00,ff,ff): Get Attributes Response
<0004> abis_nm.c:592 OC=BTS(01) INST=(00,ff,ff): Get Attributes
Response: reported unexpectedly long (13 bytes) feature vector - most
likely it was compiled against newer BSC headers. Consider upgrading
your BSC to later version.
<0004> abis_nm.c:610 OC=BTS(01) INST=(00,ff,ff): Get Attributes
Response: reported feature 'MULTI_TSC' is not supported, while we
thought it is.
<0004> abis_nm.c:602 OC=BTS(01) INST=(00,ff,ff): Get Attributes
Response: unknown feature 0x17. Consider upgrading osmo-bsc.
<0004> abis_nm.c:602 OC=BTS(01) INST=(00,ff,ff): Get Attributes
Response: unknown feature 0x1a. Consider upgrading osmo-bsc.
<0004> abis_nm.c:602 OC=BTS(01) INST=(00,ff,ff): Get Attributes
Response: unknown feature 0x1c. Consider upgrading osmo-bsc.
<0004> abis_nm.c:602 OC=BTS(01) INST=(00,ff,ff): Get Attributes
Response: unknown feature 0x1d. Consider upgrading osmo-bsc.
<0004> abis_nm.c:602 OC=BTS(01) INST=(00,ff,ff): Get Attributes
Response: unknown feature 0x1e. Consider upgrading osmo-bsc.
<0004> abis_nm.c:602 OC=BTS(01) INST=(00,ff,ff): Get Attributes
Response: unknown feature 0x21. Consider upgrading osmo-bsc.
<0004> abis_nm.c:602 OC=BTS(01) INST=(00,ff,ff): Get Attributes
Response: unknown feature 0x22. Consider upgrading osmo-bsc.
<0004> abis_nm.c:602 OC=BTS(01) INST=(00,ff,ff): Get Attributes
Response: unknown feature 0x24. Consider upgrading osmo-bsc.
<0004> abis_nm.c:602 OC=BTS(01) INST=(00,ff,ff): Get Attributes
Response: unknown feature 0x27. Consider upgrading osmo-bsc.
<0004> abis_nm.c:602 OC=BTS(01) INST=(00,ff,ff): Get Attributes
Response: unknown feature 0x29. Consider upgrading osmo-bsc.
<0004> abis_nm.c:602 OC=BTS(01) INST=(00,ff,ff): Get Attributes
Response: unknown feature 0x2a. Consider upgrading osmo-bsc.
<0004> abis_nm.c:602 OC=BTS(01) INST=(00,ff,ff): Get Attributes
Response: unknown feature 0x2b. Consider upgrading osmo-bsc.
<0004> abis_nm.c:602 OC=BTS(01) INST=(00,ff,ff): Get Attributes
Response: unknown feature 0x31. Consider upgrading osmo-bsc.
<0004> abis_nm.c:602 OC=BTS(01) INST=(00,ff,ff): Get Attributes
Response: unknown feature 0x32. Consider upgrading osmo-bsc.
<0004> abis_nm.c:602 OC=BTS(01) INST=(00,ff,ff): Get Attributes
Response: unknown feature 0x37. Consider upgrading osmo-bsc.
<0004> abis_nm.c:602 OC=BTS(01) INST=(00,ff,ff): Get Attributes
Response: unknown feature 0x39. Consider upgrading osmo-bsc.
<0004> abis_nm.c:602 OC=BTS(01) INST=(00,ff,ff): Get Attributes
Response: unknown feature 0x3a. Consider upgrading osmo-bsc.
<0004> abis_nm.c:602 OC=BTS(01) INST=(00,ff,ff): Get Attributes
Response: unknown feature 0x3e. Consider upgrading osmo-bsc.
<0004> abis_nm.c:602 OC=BTS(01) INST=(00,ff,ff): Get Attributes
Response: unknown feature 0x3f. Consider upgrading osmo-bsc.
<0004> abis_nm.c:602 OC=BTS(01) INST=(00,ff,ff): Get Attributes
Response: unknown feature 0x41. Consider upgrading osmo-bsc.
<0004> abis_nm.c:602 OC=BTS(01) INST=(00,ff,ff): Get Attributes
Response: unknown feature 0x42. Consider upgrading osmo-bsc.
<0004> abis_nm.c:602 OC=BTS(01) INST=(00,ff,ff): Get Attributes
Response: unknown feature 0x46. Consider upgrading osmo-bsc.
<0004> abis_nm.c:602 OC=BTS(01) INST=(00,ff,ff): Get Attributes
Response: unknown feature 0x47. Consider upgrading osmo-bsc.
<0004> abis_nm.c:602 OC=BTS(01) INST=(00,ff,ff): Get Attributes
Response: unknown feature 0x49. Consider upgrading osmo-bsc.
<0004> abis_nm.c:602 OC=BTS(01) INST=(00,ff,ff): Get Attributes
Response: unknown feature 0x4a. Consider upgrading osmo-bsc.
<0004> abis_nm.c:602 OC=BTS(01) INST=(00,ff,ff): Get Attributes
Response: unknown feature 0x4d. Consider upgrading osmo-bsc.
<0004> abis_nm.c:602 OC=BTS(01) INST=(00,ff,ff): Get Attributes
Response: unknown feature 0x4f. Consider upgrading osmo-bsc.
<0004> abis_nm.c:602 OC=BTS(01) INST=(00,ff,ff): Get Attributes
Response: unknown feature 0x51. Consider upgrading osmo-bsc.
<0004> abis_nm.c:602 OC=BTS(01) INST=(00,ff,ff): Get Attributes
Response: unknown feature 0x52. Consider upgrading osmo-bsc.
<0004> abis_nm.c:602 OC=BTS(01) INST=(00,ff,ff): Get Attributes
Response: unknown feature 0x53. Consider upgrading osmo-bsc.
<0004> abis_nm.c:602 OC=BTS(01) INST=(00,ff,ff): Get Attributes
Response: unknown feature 0x56. Consider upgrading osmo-bsc.
<0004> abis_nm.c:602 OC=BTS(01) INST=(00,ff,ff): Get Attributes
Response: unknown feature 0x57. Consider upgrading osmo-bsc.
<0004> abis_nm.c:602 OC=BTS(01) INST=(00,ff,ff): Get Attributes
Response: unknown feature 0x59. Consider upgrading osmo-bsc.
<0004> abis_nm.c:602 OC=BTS(01) INST=(00,ff,ff): Get Attributes
Response: unknown feature 0x5a. Consider upgrading osmo-bsc.
<0004> abis_nm.c:602 OC=BTS(01) INST=(00,ff,ff): Get Attributes
Response: unknown feature 0x5b. Consider upgrading osmo-bsc.
<0004> abis_nm.c:602 OC=BTS(01) INST=(00,ff,ff): Get Attributes
Response: unknown feature 0x5e. Consider upgrading osmo-bsc.
<0004> abis_nm.c:602 OC=BTS(01) INST=(00,ff,ff): Get Attributes
Response: unknown feature 0x5f. Consider upgrading osmo-bsc.
<0004> abis_nm.c:633 OC=BTS(01) INST=(00,ff,ff): ARI reported sw[0/2]:
120a004 is v267b5d0
<0004> abis_nm.c:633 OC=BTS(01) INST=(00,ff,ff): ARI reported sw[1/2]:
120a002 is v267b5d0
<0004> bts_ipaccess_nanobts.c:361
NM_BTS_OP(bts0)[0x558f2b1d5120]{DISABLED_OFFLINE}: Received Event
GET_ATTR_REP
<0004> nm_bts_fsm.c:139
NM_GPRS_NSVC_OP(nsvc0)[0x558f2b1ded90]{DISABLED_NOTINSTALLED}: Received
Event FEATURE_NEGOTIATED
<0004> abis_nm.c:1847 OC=BTS(01) INST=(00,ff,ff): Set BTS Attr
<0004> abis_nm.c:258 OC=GPRS-CELL(f1) INST=(00,00,ff): STATE CHG:
OP_STATE=Disabled AVAIL=Dependency(05)
<0004> bts_ipaccess_nanobts.c:181
NM_GPRS_CELL_OP(gprs-cell0)[0x558f2b1d5250]{DISABLED_NOTINSTALLED}:
Received Event STATE_CHG_REP
<0004> nm_gprs_cell_fsm.c:75
NM_GPRS_CELL_OP(gprs-cell0)[0x558f2b1d5250]{DISABLED_NOTINSTALLED}:
state_chg to DISABLED_DEPENDENCY
<0004> nm_gprs_cell_fsm.c:130
NM_GPRS_CELL_OP(gprs-cell0)[0x558f2b1d5250]{DISABLED_DEPENDENCY}:
state_chg to DISABLED_OFFLINE
<0004> abis_nm.c:478 OC=GPRS-CELL(f1) INST=(00,00,ff): Software
Activated Report
<0004> bts_ipaccess_nanobts.c:235
NM_GPRS_CELL_OP(gprs-cell0)[0x558f2b1d5250]{DISABLED_OFFLINE}: Received
Event SW_ACT_REP
<0004> bts_ipaccess_nanobts.c:235
NM_GPRS_CELL_OP(gprs-cell0)[0x558f2b1d5250]{DISABLED_OFFLINE}: Event
SW_ACT_REP not permitted
<0004> abis_nm.c:258 OC=GPRS-NSVC(f2) INST=(00,00,ff): STATE CHG:
OP_STATE=Disabled AVAIL=Off line(03)
<0004> bts_ipaccess_nanobts.c:188
NM_GPRS_NSVC_OP(nsvc0)[0x558f2b1ded90]{DISABLED_NOTINSTALLED}: Received
Event STATE_CHG_REP
<0004> nm_gprs_nsvc_fsm.c:83
NM_GPRS_NSVC_OP(nsvc0)[0x558f2b1ded90]{DISABLED_NOTINSTALLED}: state_chg
to DISABLED_OFFLINE
<0004> abis_nm.c:258 OC=GPRS-NSVC(f2) INST=(00,01,ff): STATE CHG:
OP_STATE=Disabled AVAIL=Off line(03)
<0004> abis_nm.c:478 OC=GPRS-NSVC(f2) INST=(00,00,ff): Software
Activated Report
<0004> bts_ipaccess_nanobts.c:240
NM_GPRS_NSVC_OP(nsvc0)[0x558f2b1ded90]{DISABLED_OFFLINE}: Received Event
SW_ACT_REP
<0004> bts_ipaccess_nanobts.c:240
NM_GPRS_NSVC_OP(nsvc0)[0x558f2b1ded90]{DISABLED_OFFLINE}: Event
SW_ACT_REP not permitted
<0004> abis_nm.c:478 OC=GPRS-NSVC(f2) INST=(00,01,ff): Software
Activated Report
<0004> bts_ipaccess_nanobts.c:240
NM_GPRS_NSVC_OP(nsvc1)[0x558f2b1defc0]{DISABLED_NOTINSTALLED}: Received
Event SW_ACT_REP
<0004> abis_nm.c:2852 OC=GPRS-NSE(f0) INST=(00,ff,ff): Rx
IPACCESS(0xf6): 9d 00 02 00 00 a0 00 07 03 03 03 03 1e 03 0a a1 00 0b 03
03 03 03 03 0a 03 0a 03 0a 03
<0004> abis_nm.c:2909 OC=GPRS-NSE(f0) INST=(00,ff,ff): SET ATTR ACK
<0004> bts_ipaccess_nanobts.c:431
NM_GPRS_NSE_OP(nse0)[0x558f2b1debd0]{DISABLED_OFFLINE}: Received Event
SET_ATTR_ACK
<0004> abis_nm.c:871 OC=BTS(01) INST=(00,ff,ff): Set BTS Attributes ACK
<0004> bts_ipaccess_nanobts.c:383
NM_BTS_OP(bts0)[0x558f2b1d5120]{DISABLED_OFFLINE}: Received Event
SET_ATTR_ACK
<0004> abis_nm.c:780 OC=GPRS-NSE(f0) INST=(00,ff,ff): Rx Change
Administrative State ACK Unlocked
<0004> bts_ipaccess_nanobts.c:177
NM_GPRS_NSE_OP(nse0)[0x558f2b1debd0]{DISABLED_OFFLINE}: Received Event
STATE_CHG_REP
<0004> abis_nm.c:2186 OC=GPRS-NSE(f0) INST=(00,ff,ff): Sending OPSTART
<0004> abis_nm.c:258 OC=GPRS-NSE(f0) INST=(00,ff,ff): STATE CHG:
OP_STATE=Disabled AVAIL=Dependency(05) ADM=Unlocked (No State change
detected)
<0004> abis_nm.c:780 OC=BTS(01) INST=(00,ff,ff): Rx Change
Administrative State ACK Unlocked
<0004> bts_ipaccess_nanobts.c:160
NM_BTS_OP(bts0)[0x558f2b1d5120]{DISABLED_OFFLINE}: Received Event
STATE_CHG_REP
<0004> abis_nm.c:2186 OC=BTS(01) INST=(00,ff,ff): Sending OPSTART
<0004> abis_nm.c:258 OC=BTS(01) INST=(00,ff,ff): STATE CHG:
OP_STATE=Disabled AVAIL=Dependency(05) ADM=Unlocked (No State change
detected)
<0004> abis_nm.c:839 OC=GPRS-NSE(f0) INST=(00,ff,ff): Opstart ACK
<0004> bts_ipaccess_nanobts.c:290
NM_GPRS_NSE_OP(nse0)[0x558f2b1debd0]{DISABLED_OFFLINE}: Received Event
OPSTART_ACK
<0004> abis_nm.c:839 OC=BTS(01) INST=(00,ff,ff): Opstart ACK
<0004> bts_ipaccess_nanobts.c:274
NM_BTS_OP(bts0)[0x558f2b1d5120]{DISABLED_OFFLINE}: Received Event
OPSTART_ACK
After a while the OML connection is lost.
<0004> abis_nm.c:258 OC=BASEBAND-TRANSCEIVER(04) INST=(00,00,ff): STATE
CHG: OP_STATE=Disabled AVAIL=Dependency(05)
<0004> bts_ipaccess_nanobts.c:164
NM_BB_TRANSC_OP(bts0-trx0)[0x56372d474940]{DISABLED_NOTINSTALLED}:
Received Event STATE_CHG_REP
<0004> nm_bb_transc_fsm.c:75
NM_BB_TRANSC_OP(bts0-trx0)[0x56372d474940]{DISABLED_NOTINSTALLED}:
state_chg to DISABLED_DEPENDENCY
<0004> nm_bb_transc_fsm.c:132
NM_BB_TRANSC_OP(bts0-trx0)[0x56372d474940]{DISABLED_DEPENDENCY}:
state_chg to DISABLED_OFFLINE
<0004> abis_nm.c:1835 OC=BASEBAND-TRANSCEIVER(04) INST=(00,00,ff): Tx
Get Attributes (Request)
<0004> abis_nm.c:698 OC=BASEBAND-TRANSCEIVER(04) INST=(00,00,ff): Get
Attributes Response
<0004> abis_nm.c:633 OC=BASEBAND-TRANSCEIVER(04) INST=(00,00,ff): ARI
reported sw[0/3]: 120a004 is v267b5d0
<0004> abis_nm.c:633 OC=BASEBAND-TRANSCEIVER(04) INST=(00,00,ff): ARI
reported sw[1/3]: 120a002 is v267b5d0
<0004> abis_nm.c:633 OC=BASEBAND-TRANSCEIVER(04) INST=(00,00,ff): ARI
reported sw[2/3]: 120a001 is v267b5d0
<0004> abis_nm.c:551 OC=BASEBAND-TRANSCEIVER(04) INST=(00,00,ff): Get
Attributes Response Info: 2 bytes total with 1 unreported attributes
<0004> abis_nm.c:556 OC=BASEBAND-TRANSCEIVER(04) INST=(00,00,ff):
Attribute Manufacturer Dependent State is unreported
<0004> bts_ipaccess_nanobts.c:366
NM_BB_TRANSC_OP(bts0-trx0)[0x56372d474940]{DISABLED_OFFLINE}: Received
Event GET_ATTR_REP
<0004> abis_nm.c:945 OC=BASEBAND-TRANSCEIVER(04) INST=(00,00,ff): CHANGE
ADMINISTRATIVE STATE NACK CAUSE=Message cannot be performed
<0004> osmo_bsc_main.c:229 Got CHANGE ADMINISTRATIVE STATE NACK going to
drop the OML links.
<0017> bts_ipaccess_nanobts.c:620 (bts=0) Deferring Drop of OML link.
<0017> bts_ipaccess_nanobts.c:555 (bts=0) Dropping OML link: Deferred
link drop
<0019> osmo_bsc_main.c:405 (bts=0,trx=0) Lost E1 OML link
<0019> osmo_bsc_main.c:405 (bts=0,trx=0) Lost E1 OSMO link
<0004> bts_ipaccess_nanobts.c:568
NM_BB_TRANSC_OP(bts0-trx0)[0x56372d474940]{DISABLED_OFFLINE}: Received
Event OML_DOWN
<0004> nm_bb_transc_fsm.c:291
NM_BB_TRANSC_OP(bts0-trx0)[0x56372d474940]{DISABLED_OFFLINE}: state_chg
to DISABLED_NOTINSTALLED
<0004> bts_ipaccess_nanobts.c:569
NM_RCARRIER_OP(bts0-trx0)[0x56372d474770]{DISABLED_NOTINSTALLED}:
Received Event OML_DOWN
<0004> bts_ipaccess_nanobts.c:572
NM_CHAN_OP(bts0-trx0-ts0)[0x56372d474c40]{DISABLED_NOTINSTALLED}:
Received Event OML_DOWN
<0004> bts_ipaccess_nanobts.c:572
NM_CHAN_OP(bts0-trx0-ts1)[0x56372d475340]{DISABLED_NOTINSTALLED}:
Received Event OML_DOWN
<0004> bts_ipaccess_nanobts.c:572
NM_CHAN_OP(bts0-trx0-ts2)[0x56372d475b40]{DISABLED_NOTINSTALLED}:
Received Event OML_DOWN
<0004> bts_ipaccess_nanobts.c:572
NM_CHAN_OP(bts0-trx0-ts3)[0x56372d476340]{DISABLED_NOTINSTALLED}:
Received Event OML_DOWN
<0004> bts_ipaccess_nanobts.c:572
NM_CHAN_OP(bts0-trx0-ts4)[0x56372d476b40]{DISABLED_NOTINSTALLED}:
Received Event OML_DOWN
<0004> bts_ipaccess_nanobts.c:572
NM_CHAN_OP(bts0-trx0-ts5)[0x56372d4773d0]{DISABLED_NOTINSTALLED}:
Received Event OML_DOWN
<0004> bts_ipaccess_nanobts.c:572
NM_CHAN_OP(bts0-trx0-ts6)[0x56372d477c60]{DISABLED_NOTINSTALLED}:
Received Event OML_DOWN
<0004> bts_ipaccess_nanobts.c:572
NM_CHAN_OP(bts0-trx0-ts7)[0x56372d4784f0]{DISABLED_NOTINSTALLED}:
Received Event OML_DOWN
<0004> bts_ipaccess_nanobts.c:576
NM_BTS_SM_OP(bts_sm)[0x56372d46b7e0]{ENABLED}: Received Event OML_DOWN
<0004> nm_bts_sm_fsm.c:216
NM_BTS_SM_OP(bts_sm)[0x56372d46b7e0]{ENABLED}: state_chg to
DISABLED_NOTINSTALLED
<0004> bts_ipaccess_nanobts.c:577
NM_GPRS_NSE_OP(nse0)[0x56372d478bd0]{DISABLED_OFFLINE}: Received Event
OML_DOWN
<0004> nm_gprs_nse_fsm.c:298
NM_GPRS_NSE_OP(nse0)[0x56372d478bd0]{DISABLED_OFFLINE}: state_chg to
DISABLED_NOTINSTALLED
<0004> bts_ipaccess_nanobts.c:579
NM_GPRS_NSVC_OP(nsvc0)[0x56372d478d90]{DISABLED_OFFLINE}: Received Event
OML_DOWN
<0004> nm_gprs_nsvc_fsm.c:307
NM_GPRS_NSVC_OP(nsvc0)[0x56372d478d90]{DISABLED_OFFLINE}: state_chg to
DISABLED_NOTINSTALLED
<0004> bts_ipaccess_nanobts.c:579
NM_GPRS_NSVC_OP(nsvc1)[0x56372d478fc0]{DISABLED_NOTINSTALLED}: Received
Event OML_DOWN
<0004> bts_ipaccess_nanobts.c:581
NM_BTS_OP(bts0)[0x56372d46f120]{DISABLED_OFFLINE}: Received Event OML_DOWN
<0004> nm_bts_fsm.c:319
NM_BTS_OP(bts0)[0x56372d46f120]{DISABLED_OFFLINE}: state_chg to
DISABLED_NOTINSTALLED
<0004> bts_ipaccess_nanobts.c:582
NM_GPRS_CELL_OP(gprs-cell0)[0x56372d46f250]{DISABLED_OFFLINE}: Received
Event OML_DOWN
<0004> nm_gprs_cell_fsm.c:296
NM_GPRS_CELL_OP(gprs-cell0)[0x56372d46f250]{DISABLED_OFFLINE}: state_chg
to DISABLED_NOTINSTALLED
^Csignal 2 received
<0004> bsc_init.c:66 shutting down OML for BTS 0
12 Jul
12 Jul
11:38 a.m.
Hi Andreas,
It would be great if you could provide a proper pcap file since as you
may know order of such messages is rather important :)
I'm having difficulties matching 100% the log file vs the pcap. Using
gmstap logging here may use in order to have all the info in the same
place and more or less ordrered.
There seems to be an issue configuring the BTS object in OML. From pcap
file, this is what looks like:
frame 10: BTS => BSC: BTS State Changed Event Report(Not installed, Locked)
frame 18: BTS => BSC: Software Activate Request
frame 21: BTS <= BSC: Software Activate Request ACK
frame 22: BTS <= BSC: Activate Software
frame 27: BTS => BSC: Activate Software ACK
frame 27: BTS => BSC: BTS State Changed Event Report(Disabled, Dependency)
frame 27: BTS => BSC: Software Activated Report
frame 29: BTS <= BSC: Get Attributes
frame 39: BTS => BSC: Get Attributes Response
frame 48: BTS <= BSC: Set BTS Attributes
frame 49: BTS => BSC: Set BTS Attributes ACK
frame 52: BTS <= BSC: Change Administrative State (Unlocked)
frame 55: BTS => BSC: Change Administrative State ACK (Unlocked)
frame 55: BTS => BSC: BTS State Changed Event Report(Dependency, Unlocked)
frame 61: BTS <= BSC: Opstart
frame 160: BTS => BSC: BTS State Changed Event Report(Enabled)
frame 200: BTS => BSC: Get Attributes Response ?!?!?!?! where does this
come from?!?!?!
frame 219: BTS <= BSC: Set BTS Attributes
frame238: BTS => BSC: Opstart ACK
Some of those, specially at the end, look really weird, but it could be
due to your setup as you mentioned.
In any case, according to pcap the BSC receives a "BTS State Changed
Event Report(Enabled)" at frame 160, but I never see that message being
processed in the log file (NM_BTS_OP(bts0) FSM is still in state
DISABLED_OFFLINE when receiving the OPSTART_ACK but it should have moved
to ENABLED already when receiving such report afaict from nm_bts_fsm.c:230.
Feel free to create a ticket if you can sort out the proper recording of
pcap file and you still find issues.
Regards,
Pau
--
- 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
13 Jul
13 Jul
4:02 p.m.
Pau Espin Pedrol wrote:
Some of those, specially at the end, look really
weird, but it could
be due to your setup as you mentioned.
In any case, according to pcap the BSC receives a "BTS State Changed
Event Report(Enabled)" at frame 160, but I never see that message
being processed in the log file (NM_BTS_OP(bts0) FSM is still in state
DISABLED_OFFLINE when receiving the OPSTART_ACK but it should have
moved to ENABLED already when receiving such report afaict from
nm_bts_fsm.c:230.
Hi Pau,
it is not a Software issue. The BTS crashes and reboots when it starts
transmitting. Maybe a faulty solder connection. The other BTS works well!
Regards,
Andreas
1025
days inactive
1028
days old
4 comments
3 participants
participants (3)
-
Andreas Eversberg -
Neels Hofmeyr -
Pau Espin Pedrol