Configuration is Network In The Box with everything running on a LimeNET Micro (RPi CM3+), using Raspbian 10 and osmocom:latest packages via OBS. UEs can register fine and send/receive SMS, but when I attempt to make a call I see the Rx RR Assignment Failure error from osmo-bsc.
The same hardware and CNI configuration works fine when used with an old RPi image that has packages from late 2019. Configs and error log attached. Would appreciate any suggestions for things to try. Regards, Andrew //
config.tar
Description: Unix tar archive
-- versions:
Linux raspberrypi 5.10.103-v7+ #1529 SMP Tue Mar 8 12:21:37 GMT 2022 armv7l
GNU/Linux
ii libosmo-gsup-client0:armhf 1.4.0
armhf Osmocom GSUP (General Subscriber Update Protocol) client library
ii libosmo-mgcp-client9:armhf 1.9.0
armhf libosmo-mgcp-client: Osmocom's Media Gateway Control Protocol
client utilities
ii libosmo-mslookup0:armhf 1.4.0
armhf Osmocom MS lookup library
ii libosmo-ranap5:armhf 1.2.0
armhf Osmocom code for the Iuh interface (HNBAP, RUA, RANAP)
ii libosmo-sigtran7:armhf 1.5.0
armhf Osmocom SIGTRAN library (SCCP, SUA, M3UA and more)
ii libosmoabis10:armhf 1.2.0
armhf GSM A-bis handling
ii libosmocodec0:armhf 1.6.0
armhf Osmo codec library
ii libosmocoding0:armhf 1.6.0
armhf Osmo coding library
ii libosmocore18:armhf 1.6.0
armhf Osmo Core library
ii libosmoctrl0:armhf 1.6.0
armhf Osmo control library
ii libosmogb12:armhf 1.6.0
armhf Osmo GPRS GB library
ii libosmogsm17:armhf 1.6.0
armhf Osmo GSM utility library
ii libosmonetif8:armhf 1.1.0
armhf Common/shared code regarding network interface for OpenBSC
ii libosmotrau2:armhf 1.2.0
armhf GSM trau handling
ii libosmovty9:armhf 1.6.0
armhf Osmo VTY library
ii osmo-bsc 1.8.1
armhf OsmoBSC: Osmocom's Base Station Controller for 2G
circuit-switched mobile networks
ii osmo-bts-trx 1.4.1
armhf osmo-bts-trx GSM BTS with osmo-trx
ii osmo-hlr 1.4.0
armhf Osmocom Home Location Register
ii osmo-mgw 1.9.0
armhf OsmoMGW: Osmocom's Media Gateway for 2G and 3G circuit-switched
mobile networks
ii osmo-msc 1.8.0
armhf OsmoMSC: Osmocom's Mobile Switching Center for 2G and 3G
circuit-switched mobile networks
ii osmo-pcu 1.0.0
armhf Osmocom GPRS/EDGE Packet Control Unit (PCU)
ii osmo-stp:armhf 1.5.0
armhf Osmocom SIGTRAN STP (Signaling Transfer Point)
ii osmo-trx-lms 1.4.0
armhf SDR transceiver that implements Layer 1 of a GSM BTS (LimeSuite)
ii osmocom-latest 1.0.0
armhf Dummy package, which conflicts with: osmocom-nightly osmocom-next
-- osmo-msc:
Apr 09 07:24:44 raspberrypi osmo-msc[354]: <0001> transaction.c:128 LCLS
disabled globally
Apr 09 07:24:45 raspberrypi osmo-msc[354]: <0011> msc_a.c:1350
msc_a(IMSI-999990000035204:MSISDN-1111:TMSI-0x6E6502B2:GERAN-A-5:CM_SERVICE_REQ)[0x1787198]{MSC_A_ST_COMMUNICATING}:
Assignment Failure, releasing call
-- osmo-bsc:
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229676 DLMGCP DEBUG MGW
pool is empty -- using (single) MGW mgw (mgcp_client_pool.c:168)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229676 DLMGCP DEBUG
mgw-endp(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18bbe68]{UNUSED}:
Allocated (fsm.c:461)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229676 DLMGCP DEBUG
mgw-endp(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18bbe68]{UNUSED}:
is child of
SUBSCR_CONN(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18ba338]
(fsm.c:491)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229676 DLMGCP DEBUG
mgw-endp(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18bbe68]{UNUSED}:
rtpbridge/*@mgw CI[0] to-BTS: CRCX: notify=lchan_rtp(0-0-1-TCH_F-0)[0x18bb578]
(mgcp_client_endpoint_fsm.c:665)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229676 DLMGCP DEBUG
mgw-endp(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18bbe68]{UNUSED}:
rtpbridge/*@mgw CI[0] to-BTS: CRCX: Scheduling (mgcp_client_endpoint_fsm.c:712)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229676 DLMGCP DEBUG
mgw-endp(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18bbe68]{UNUSED}:
state_chg to WAIT_MGW_RESPONSE (mgcp_client_endpoint_fsm.c:715)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229676 DLMGCP DEBUG
mgw-endp(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18bbe68]{WAIT_MGW_RESPONSE}:
rtpbridge/*@mgw CI[0] to-BTS: CRCX: Sending (mgcp_client_endpoint_fsm.c:764)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229676 DLMGCP DEBUG
MGCP_CONN(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18bbf78]{ST_CRCX}:
Allocated (fsm.c:461)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229676 DLMGCP DEBUG
MGCP_CONN(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18bbf78]{ST_CRCX}:
is child of
mgw-endp(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18bbe68]
(fsm.c:491)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229676 DLMGCP DEBUG
MGCP_CONN(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18bbf78]{ST_CRCX}:
Received Event EV_CRCX (mgcp_client_fsm.c:651)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229676 DLMGCP DEBUG
MGCP_CONN(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18bbf78]{ST_CRCX}:
MGW/CRCX: creating connection on MGW endpoint:rtpbridge/*@mgw...
(mgcp_client_fsm.c:221)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229676 DLMGCP DEBUG
MGW(mgw) Queued 75 bytes for MGW (mgcp_client.c:1121)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229677 DLMGCP DEBUG
MGCP_CONN(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18bbf78]{ST_CRCX}:
state_chg to ST_CRCX_RESP (mgcp_client_fsm.c:239)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229677 DLMGCP DEBUG
mgw-endp(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18bbe68]{WAIT_MGW_RESPONSE}:
rtpbridge/*@mgw Sent messages: 1 (mgcp_client_endpoint_fsm.c:920)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229677 DLMGCP DEBUG
MGW(mgw) Tx MGCP: r=127.0.0.1:12427<->l=127.0.0.1:2727: len=75 'CRCX 1
rtpbridge/*@mgw MGCP 1.0\r\nC: 5\r\nL: '... (mgcp_client.c:747)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229677 DLMI DEBUG
E1TS(0:2) TX 2: 08 21 01 09 03 01 06 04 00 01 08 01 05 06 64 09 e3 6c 72 00 04
00 0d 07 18 04 1f 00 60 01 40 (ipaccess.c:516)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229679 DLMI DEBUG RX 2:
08 22 01 09 08 e8 2a (ipaccess.c:391)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229679 DCHAN DEBUG
lchan(0-0-1-TCH_F-0)[0x18aa528]{WAIT_ACTIV_ACK}: (type=TCH_F) Rx CHAN_ACTIV_ACK
(abis_rsl.c:1521)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229679 DCHAN DEBUG
lchan(0-0-1-TCH_F-0)[0x18aa528]{WAIT_ACTIV_ACK}: Received Event
LCHAN_EV_RSL_CHAN_ACTIV_ACK (abis_rsl.c:1533)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229679 DCHAN INFO
lchan(0-0-1-TCH_F-0)[0x18aa528]{WAIT_ACTIV_ACK}: (type=TCH_F) Rx Activ ACK
SPEECH_V1 (lchan_fsm.c:929)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229679 DAS DEBUG
assignment(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46_0-0-1-TCH_F-0)[0x18bb358]{WAIT_LCHAN_ACTIVE}:
Received Event ASSIGNMENT_EV_LCHAN_ACTIVE (lchan_fsm.c:964)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229679 DAS DEBUG
assignment(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46_0-0-1-TCH_F-0)[0x18bb358]{WAIT_LCHAN_ACTIVE}:
state_chg to WAIT_RR_ASS_COMPLETE (assignment_fsm.c:674)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229679 DRR DEBUG ->
ASSIGNMENT COMMAND tch_mode=0x01 (gsm_04_08_rr.c:611)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229679 DCHAN DEBUG
lchan(0-0-1-TCH_F-0)[0x18aa528]{WAIT_ACTIV_ACK}: state_chg to
WAIT_RLL_RTP_ESTABLISH (lchan_fsm.c:993)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229679 DCHAN DEBUG
lchan_rtp(0-0-1-TCH_F-0)[0x18bb578]{WAIT_MGW_ENDPOINT_AVAILABLE}: Received
Event LCHAN_RTP_EV_LCHAN_READY (lchan_fsm.c:1000)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229679 DLMGCP DEBUG
MGW(mgw) MGCP client: Rx 200 1 OK (mgcp_client.c:684)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229679 DLMGCP DEBUG
MGCP_CONN(to-BTS)[0x18bbf78]{ST_CRCX_RESP}: MGW/CRCX: MGW responded with CI:
A8920AAB (mgcp_client_fsm.c:287)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229679 DLMGCP DEBUG
MGCP_CONN(to-BTS)[0x18bbf78]{ST_CRCX_RESP}: MGW/CRCX: MGW responded with
address 127.0.0.1:16004 (mgcp_client_fsm.c:295)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229679 DLMGCP DEBUG
MGCP_CONN(to-BTS)[0x18bbf78]{ST_CRCX_RESP}: Received Event EV_CRCX_RESP
(mgcp_client_fsm.c:324)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229679 DLMGCP DEBUG
MGCP_CONN(to-BTS)[0x18bbf78]{ST_CRCX_RESP}: state_chg to ST_READY
(mgcp_client_fsm.c:334)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229679 DLMGCP DEBUG
mgw-endp(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18bbe68]{WAIT_MGW_RESPONSE}:
Received Event MGW Response for CI #0 (mgcp_client_fsm.c:341)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229679 DLMGCP DEBUG
mgw-endp(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18bbe68]{WAIT_MGW_RESPONSE}:
rtpbridge/1@mgw CI[0] to-BTS CI=A8920AAB: received successful response to
CRCX: RTP=rtpbridge/1@mgw:127.0.0.1:16004 (mgcp_client_endpoint_fsm.c:510)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229679 DCHAN DEBUG
lchan_rtp(0-0-1-TCH_F-0)[0x18bb578]{WAIT_MGW_ENDPOINT_AVAILABLE}: Received
Event LCHAN_RTP_EV_MGW_ENDPOINT_AVAILABLE (mgcp_client_endpoint_fsm.c:513)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229680 DCHAN DEBUG
lchan_rtp(0-0-1-TCH_F-0)[0x18bb578]{WAIT_MGW_ENDPOINT_AVAILABLE}: MGW endpoint:
rtpbridge/1@mgw:127.0.0.1:16004 (lchan_rtp_fsm.c:185)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229680 DCHAN DEBUG
lchan_rtp(0-0-1-TCH_F-0)[0x18bb578]{WAIT_MGW_ENDPOINT_AVAILABLE}: state_chg to
WAIT_LCHAN_READY (lchan_rtp_fsm.c:186)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229680 DCHAN DEBUG
lchan_rtp(0-0-1-TCH_F-0)[0x18bb578]{WAIT_LCHAN_READY}: Activ Ack received
earlier, no need to wait (lchan_rtp_fsm.c:215)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229680 DCHAN DEBUG
lchan_rtp(0-0-1-TCH_F-0)[0x18bb578]{WAIT_LCHAN_READY}: state_chg to
WAIT_IPACC_CRCX_ACK (lchan_rtp_fsm.c:255)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229680 DCHAN DEBUG
lchan(0-0-1-TCH_F-0)[0x18aa528]{WAIT_RLL_RTP_ESTABLISH}: (type=TCH_F) Sending
IPACC CRCX to BTS: speech_mode=0x10 RTP_PAYLOAD=3 (abis_rsl.c:2730)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229680 DLMGCP DEBUG
mgw-endp(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18bbe68]{WAIT_MGW_RESPONSE}:
rtpbridge/1@mgw CI[0] to-BTS CI=A8920AAB: CRCX: done
(rtpbridge/1@mgw:127.0.0.1:16004) (mgcp_client_endpoint_fsm.c:846)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229680 DLMGCP DEBUG
mgw-endp(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18bbe68]{WAIT_MGW_RESPONSE}:
rtpbridge/1@mgw CI in use: 1, waiting for response: 0
(mgcp_client_endpoint_fsm.c:864)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229680 DLMGCP DEBUG
mgw-endp(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18bbe68]{WAIT_MGW_RESPONSE}:
state_chg to IN_USE (mgcp_client_endpoint_fsm.c:875)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229680 DLMGCP DEBUG
mgw-endp(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18bbe68]{IN_USE}:
rtpbridge/1@mgw CI[0] to-BTS CI=A8920AAB: CRCX: done
(rtpbridge/1@mgw:127.0.0.1:16004) (mgcp_client_endpoint_fsm.c:846)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229680 DLMI DEBUG
E1TS(0:2) TX 2: 03 01 01 28 02 00 0b 00 08 06 2e 09 e3 6c 07 63 01
(ipaccess.c:516)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229680 DLMI DEBUG
E1TS(0:2) TX 2: 7e 70 01 09 f4 10 f2 03 (ipaccess.c:516)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229682 DLMI DEBUG RX 2:
7e 71 01 09 f8 00 00 f5 7f 00 00 01 f3 40 00 (ipaccess.c:391)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229682 DCHAN DEBUG
lchan(0-0-1-TCH_F-0)[0x18aa528]{WAIT_RLL_RTP_ESTABLISH}: (type=TCH_F) Rx
IPAC_CRCX_ACK (abis_rsl.c:2913)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229682 DCHAN DEBUG
lchan(0-0-1-TCH_F-0)[0x18aa528]{WAIT_RLL_RTP_ESTABLISH}: (type=TCH_F) Rx IPACC
CRCX ACK: BTS=127.0.0.1:16384 conn_id=0 rtp_payload2=0x00 speech_mode=0x10
(abis_rsl.c:2703)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229682 DCHAN DEBUG
lchan_rtp(0-0-1-TCH_F-0)[0x18bb578]{WAIT_IPACC_CRCX_ACK}: Received Event
LCHAN_RTP_EV_IPACC_CRCX_ACK (abis_rsl.c:2822)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229682 DCHAN DEBUG
lchan_rtp(0-0-1-TCH_F-0)[0x18bb578]{WAIT_IPACC_CRCX_ACK}: state_chg to
WAIT_MGW_ENDPOINT_CONFIGURED (lchan_rtp_fsm.c:247)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229682 DCHAN DEBUG
lchan_rtp(0-0-1-TCH_F-0)[0x18bb578]{WAIT_MGW_ENDPOINT_CONFIGURED}: Sending BTS
side RTP port info 127.0.0.1:16384 to MGW rtpbridge/1@mgw:127.0.0.1:16004
(lchan_rtp_fsm.c:435)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229682 DLMGCP DEBUG
mgw-endp(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18bbe68]{IN_USE}:
rtpbridge/1@mgw CI[0] to-BTS CI=A8920AAB: MDCX:
notify=lchan_rtp(0-0-1-TCH_F-0)[0x18bb578] (mgcp_client_endpoint_fsm.c:665)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229683 DLMGCP DEBUG
mgw-endp(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18bbe68]{IN_USE}:
rtpbridge/1@mgw CI[0] to-BTS CI=A8920AAB: MDCX 127.0.0.1:16384: Scheduling
(mgcp_client_endpoint_fsm.c:712)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229683 DLMGCP DEBUG
mgw-endp(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18bbe68]{IN_USE}:
state_chg to WAIT_MGW_RESPONSE (mgcp_client_endpoint_fsm.c:715)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229683 DLMGCP DEBUG
mgw-endp(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18bbe68]{WAIT_MGW_RESPONSE}:
rtpbridge/1@mgw CI[0] to-BTS CI=A8920AAB: MDCX 127.0.0.1:16384: Sending
(mgcp_client_endpoint_fsm.c:779)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229683 DLMGCP DEBUG
MGCP_CONN(to-BTS)[0x18bbf78]{ST_READY}: Received Event EV_MDCX
(mgcp_client_fsm.c:709)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229684 DLMGCP DEBUG
MGW(mgw) Queued 168 bytes for MGW (mgcp_client.c:1121)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229684 DLMGCP DEBUG
MGCP_CONN(to-BTS)[0x18bbf78]{ST_READY}: state_chg to ST_MDCX_RESP
(mgcp_client_fsm.c:390)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229684 DLMGCP DEBUG
mgw-endp(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18bbe68]{WAIT_MGW_RESPONSE}:
rtpbridge/1@mgw Sent messages: 1 (mgcp_client_endpoint_fsm.c:920)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229684 DLMGCP DEBUG
mgw-endp(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18bbe68]{WAIT_MGW_RESPONSE}:
rtpbridge/1@mgw CI[0] to-BTS CI=A8920AAB: MDCX 127.0.0.1:16384: waiting for
response (mgcp_client_endpoint_fsm.c:844)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229684 DLMGCP DEBUG
mgw-endp(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18bbe68]{WAIT_MGW_RESPONSE}:
rtpbridge/1@mgw CI in use: 1, waiting for response: 1
(mgcp_client_endpoint_fsm.c:864)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229684 DLMGCP DEBUG
MGW(mgw) Tx MGCP: r=127.0.0.1:12427<->l=127.0.0.1:2727: len=168 'MDCX 2
rtpbridge/1@mgw MGCP 1.0\r\nC: 5\r\nI: '... (mgcp_client.c:747)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229685 DLMGCP DEBUG
MGW(mgw) MGCP client: Rx 200 2 OK (mgcp_client.c:684)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229685 DLMGCP DEBUG
MGCP_CONN(to-BTS)[0x18bbf78]{ST_MDCX_RESP}: MGW/MDCX: MGW responded with
address 127.0.0.1:16004 (mgcp_client_fsm.c:418)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229685 DLMGCP DEBUG
MGCP_CONN(to-BTS)[0x18bbf78]{ST_MDCX_RESP}: Received Event EV_MDCX_RESP
(mgcp_client_fsm.c:429)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229685 DLMGCP DEBUG
MGCP_CONN(to-BTS)[0x18bbf78]{ST_MDCX_RESP}: state_chg to ST_READY
(mgcp_client_fsm.c:439)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229685 DLMGCP DEBUG
mgw-endp(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18bbe68]{WAIT_MGW_RESPONSE}:
Received Event MGW Response for CI #0 (mgcp_client_fsm.c:446)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229685 DLMGCP DEBUG
mgw-endp(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18bbe68]{WAIT_MGW_RESPONSE}:
rtpbridge/1@mgw CI[0] to-BTS CI=A8920AAB: received successful response to
MDCX: RTP=rtpbridge/1@mgw:127.0.0.1:16004 (mgcp_client_endpoint_fsm.c:510)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229685 DCHAN DEBUG
lchan_rtp(0-0-1-TCH_F-0)[0x18bb578]{WAIT_MGW_ENDPOINT_CONFIGURED}: Received
Event LCHAN_RTP_EV_MGW_ENDPOINT_CONFIGURED (mgcp_client_endpoint_fsm.c:513)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229685 DCHAN DEBUG
lchan_rtp(0-0-1-TCH_F-0)[0x18bb578]{WAIT_MGW_ENDPOINT_CONFIGURED}: state_chg to
WAIT_IPACC_MDCX_ACK (lchan_rtp_fsm.c:480)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229685 DCHAN DEBUG
lchan(0-0-1-TCH_F-0)[0x18aa528]{WAIT_RLL_RTP_ESTABLISH}: (type=TCH_F) Sending
IPACC MDCX to BTS: 127.0.0.1:16004 rtp_payload=3 rtp_payload2=0 conn_id=0
speech_mode=0x00 (abis_rsl.c:2792)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229685 DLMGCP DEBUG
mgw-endp(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18bbe68]{WAIT_MGW_RESPONSE}:
rtpbridge/1@mgw CI[0] to-BTS CI=A8920AAB: MDCX 127.0.0.1:16384: done
(rtpbridge/1@mgw:127.0.0.1:16004) (mgcp_client_endpoint_fsm.c:846)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229685 DLMGCP DEBUG
mgw-endp(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18bbe68]{WAIT_MGW_RESPONSE}:
rtpbridge/1@mgw CI in use: 1, waiting for response: 0
(mgcp_client_endpoint_fsm.c:864)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229685 DLMGCP DEBUG
mgw-endp(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18bbe68]{WAIT_MGW_RESPONSE}:
state_chg to IN_USE (mgcp_client_endpoint_fsm.c:875)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229685 DLMGCP DEBUG
mgw-endp(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18bbe68]{IN_USE}:
rtpbridge/1@mgw CI[0] to-BTS CI=A8920AAB: MDCX 127.0.0.1:16384: done
(rtpbridge/1@mgw:127.0.0.1:16004) (mgcp_client_endpoint_fsm.c:846)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229686 DLMI DEBUG
E1TS(0:2) TX 2: 7e 73 01 09 f8 00 00 f0 7f 00 00 01 f1 3e 84 f4 00 f2 03
(ipaccess.c:516)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229687 DLMI DEBUG RX 2:
7e 74 01 09 f8 00 00 f5 7f 00 00 01 f3 40 00 (ipaccess.c:391)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229687 DCHAN DEBUG
lchan(0-0-1-TCH_F-0)[0x18aa528]{WAIT_RLL_RTP_ESTABLISH}: (type=TCH_F) Rx
IPAC_MDCX_ACK (abis_rsl.c:2913)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229687 DCHAN DEBUG
lchan(0-0-1-TCH_F-0)[0x18aa528]{WAIT_RLL_RTP_ESTABLISH}: (type=TCH_F) Rx IPACC
MDCX ACK: BTS=127.0.0.1:16384 conn_id=0 rtp_payload2=0x00 speech_mode=0x00
(abis_rsl.c:2703)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229687 DCHAN DEBUG
lchan_rtp(0-0-1-TCH_F-0)[0x18bb578]{WAIT_IPACC_MDCX_ACK}: Received Event
LCHAN_RTP_EV_IPACC_MDCX_ACK (abis_rsl.c:2860)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229687 DCHAN DEBUG
lchan_rtp(0-0-1-TCH_F-0)[0x18bb578]{WAIT_IPACC_MDCX_ACK}: state_chg to READY
(lchan_rtp_fsm.c:369)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229687 DCHAN DEBUG
lchan(0-0-1-TCH_F-0)[0x18aa528]{WAIT_RLL_RTP_ESTABLISH}: Received Event
LCHAN_EV_RTP_READY (lchan_rtp_fsm.c:506)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229758 DLMI DEBUG RX 2:
08 28 01 28 1b 01 19 03 3b 3b 00 04 00 0a 38 04 0b 00 12 06 15 26 26 01 c0 00
00 00 00 00 00 00 00 00 00 00 00 25 3f (ipaccess.c:391)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229758 DCHAN DEBUG
lchan(0-0-0-CCCH_SDCCH4-1)[0x18b8650]{ESTABLISHED}: (type=SDCCH) Rx MEAS_RES
(abis_rsl.c:1521)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229758 DRSL DEBUG
(bts=0,trx=0,ts=0,ss=1): meas_rep_count++=2 meas_rep_last_seen_nr=1
(abis_rsl.c:1449)
Apr 09 07:42:29 raspberrypi osmo-bsc[359]: 20220409074229758 DMEAS DEBUG
[subscr-IMSI-999990000035204-TMSI-0x531bba46] MEASUREMENT RESULT NR=1
RXL-FULL-ul=-51dBm RXL-SUB-ul=-51dBm RXQ-FULL-ul=0 RXQ-SUB-ul=0 BS_POWER=0dB
MS_TO=0 L1_MS_PWR= 16dBm L1_FPC=0 L1_TA=4 RXL-FULL-dl=-72dBm RXL-SUB-dl=-72dBm
RXQ-FULL-dl=0 RXQ-SUB-dl=0 NUM_NEIGH=0 (abis_rsl.c:1342)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230132 DLMI DEBUG RX 2:
08 28 01 09 1b 00 19 03 1c 1d 3f 04 00 (ipaccess.c:391)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230132 DCHAN DEBUG
lchan(0-0-1-TCH_F-0)[0x18aa528]{WAIT_RLL_RTP_ESTABLISH}: (type=TCH_F) Rx
MEAS_RES (abis_rsl.c:1521)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230132 DRSL DEBUG
(bts=0,trx=0,ts=1,ss=0): meas_rep_count++=1 meas_rep_last_seen_nr=0
(abis_rsl.c:1449)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230132 DMEAS DEBUG
[subscr-IMSI-999990000035204-TMSI-0x531bba46] MEASUREMENT RESULT NR=0
RXL-FULL-ul=-82dBm RXL-SUB-ul=-81dBm RXQ-FULL-ul=7 RXQ-SUB-ul=7 BS_POWER=0dB
NOT VALID NUM_NEIGH=0 (abis_rsl.c:1342)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230174 DPAG INFO (bts=0)
Going to send paging commands: subscr-IMSI-999990000036116-TMSI-0x1511e3f2 for
ch. type 0 (attempt 0) (paging.c:85)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230174 DLMI DEBUG
E1TS(0:2) TX 2: 0c 15 01 90 0e 06 0c 05 f4 15 11 e3 f2 28 00 (ipaccess.c:516)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230229 DLMI DEBUG RX 2:
08 28 01 28 1b 02 19 03 3d 3d 00 04 00 0a 38 04 0b 00 12 06 15 a6 26 00 00 00
00 00 00 00 00 00 00 00 00 00 00 25 3f (ipaccess.c:391)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230229 DCHAN DEBUG
lchan(0-0-0-CCCH_SDCCH4-1)[0x18b8650]{ESTABLISHED}: (type=SDCCH) Rx MEAS_RES
(abis_rsl.c:1521)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230229 DRSL DEBUG
(bts=0,trx=0,ts=0,ss=1): meas_rep_count++=3 meas_rep_last_seen_nr=2
(abis_rsl.c:1449)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230229 DMEAS DEBUG
[subscr-IMSI-999990000035204-TMSI-0x531bba46] MEASUREMENT RESULT NR=2
RXL-FULL-ul=-49dBm RXL-SUB-ul=-49dBm RXQ-FULL-ul=0 RXQ-SUB-ul=0 BS_POWER=0dB
MS_TO=0 L1_MS_PWR= 16dBm L1_FPC=0 L1_TA=4 BA1 RXL-FULL-dl=-72dBm
RXL-SUB-dl=-72dBm RXQ-FULL-dl=0 RXQ-SUB-dl=0 NUM_NEIGH=0 (abis_rsl.c:1342)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230529 DLMI DEBUG RX 2:
0c 12 01 90 0f ff ff (ipaccess.c:391)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230530 DHODEC DEBUG (BTS
0) No congestion check: Assignment and Handover both disabled
(handover_decision_2.c:1963)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230531 DHODEC DEBUG HO
algorithm 2: next periodical congestion check in 10 seconds
(handover_decision_2.c:213)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230606 DLMI DEBUG RX 2:
03 02 01 28 02 00 0b 00 03 06 2f 0a (ipaccess.c:391)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230606 DCHAN DEBUG
lchan(0-0-0-CCCH_SDCCH4-1)[0x18b8650]{ESTABLISHED}: (type=SDCCH) SAPI=0 DATA
INDICATION (abis_rsl.c:2481)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230607 DCHAN DEBUG
lchan(0-0-0-CCCH_SDCCH4-1)[0x18b8650]{ESTABLISHED}: (type=SDCCH) Rx ASSIGNMENT
FAILURE (gsm_04_08_rr.c:969)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230607 DAS DEBUG
assignment(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46_0-0-1-TCH_F-0)[0x18bb358]{WAIT_RR_ASS_COMPLETE}:
Received Event ASSIGNMENT_EV_RR_ASSIGNMENT_FAIL (gsm_04_08_rr.c:1015)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230607 DAS DEBUG
assignment(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46_0-0-1-TCH_F-0)[0x18bb358]{WAIT_RR_ASS_COMPLETE}:
(bts=0,trx=0,ts=1,ss=0) incrementing rate counter: assignment:failed Received
Assignment Failure message (assignment_fsm.c:726)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230607 DAS ERROR
assignment(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46_0-0-1-TCH_F-0)[0x18bb358]{WAIT_RR_ASS_COMPLETE}:
(bts=0,trx=0,ts=1,ss=0) Assignment failed in state WAIT_RR_ASS_COMPLETE, cause
RADIO INTERFACE MESSAGE FAILURE: Rx RR Assignment Failure (assignment_fsm.c:727)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230607 DAS DEBUG
assignment(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46_0-0-1-TCH_F-0)[0x18bb358]{WAIT_RR_ASS_COMPLETE}:
(bts=0,trx=0,ts=1,ss=0) result rate counter already recorded, NOT counting as:
assignment:error Assignment failed for other reason (assignment_fsm.c:727)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230607 DMSC INFO Tx MSC:
BSSMAP: ASSIGNMENT FAIL (osmo_bsc_sigtran.c:380)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230607 DMSC DEBUG Sending
connection (id=5) oriented data to MSC: RI=SSN_PC,PC=0.23.1,SSN=BSSAP (00 04 03
04 01 00 ) (osmo_bsc_sigtran.c:408)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230607 DLSCCP DEBUG
Received SCCP User Primitive (N-DATA.request) (sccp_scoc.c:1732)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230607 DLSCCP DEBUG
SCCP-SCOC(5)[0x18bb888]{ACTIVE}: Received Event N-DATA.req (sccp_scoc.c:1772)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230607 DLSS7 DEBUG
sccp_scrc_rx_scoc_conn_msg: HDR=(CO:CODT,V=0,LEN=0), PART(T=Routing
Context,L=4,D=00000000), PART(T=Destination Reference,L=4,D=00000005),
PART(T=Data,L=6,D=000403040100) (sccp_scrc.c:401)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230607 DLSS7 DEBUG
m3ua_hmdc_rx_from_l2(): dpc=185=0.23.1 not local, message is for routing
(osmo_ss7_hmrt.c:281)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230607 DLSS7 DEBUG Found
route for dpc=185=0.23.1: pc=0=0.0.0 mask=0x0=0.0.0 via AS as-clnt-A-0-m3ua
proto=m3ua (osmo_ss7_hmrt.c:228)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230607 DLSS7 DEBUG
rt->dest.as proto is M3UA for dpc=185=0.23.1 (osmo_ss7_hmrt.c:236)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230607 DLSS7 DEBUG
XUA_AS(as-clnt-A-0-m3ua)[0x18a88c0]{AS_ACTIVE}: Received Event AS-TRANSFER.req
(m3ua.c:508)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230607 DAS ERROR
assignment(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46_0-0-1-TCH_F-0)[0x18bb358]{WAIT_RR_ASS_COMPLETE}:
(bts=0,trx=0,ts=1,ss=0) Assignment failed (assignment_fsm.c:151)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230607 DAS DEBUG
assignment(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46_0-0-1-TCH_F-0)[0x18bb358]{WAIT_RR_ASS_COMPLETE}:
Terminating (cause = OSMO_FSM_TERM_ERROR) (assignment_fsm.c:152)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230607 DAS DEBUG
assignment(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46_0-0-1-TCH_F-0)[0x18bb358]{WAIT_RR_ASS_COMPLETE}:
Removing from parent
SUBSCR_CONN(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18ba338]
(assignment_fsm.c:152)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230607 DCHAN DEBUG
lchan_rtp(0-0-1-TCH_F-0)[0x18bb578]{READY}: Received Event
LCHAN_RTP_EV_ROLLBACK (lchan_fsm.c:1825)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230607 DCHAN DEBUG
lchan_rtp(0-0-1-TCH_F-0)[0x18bb578]{READY}: state_chg to ROLLBACK
(lchan_rtp_fsm.c:522)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230607 DCHAN DEBUG
lchan_rtp(0-0-1-TCH_F-0)[0x18bb578]{ROLLBACK}: Terminating (cause =
OSMO_FSM_TERM_REQUEST) (lchan_rtp_fsm.c:536)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230607 DCHAN DEBUG
lchan_rtp(0-0-1-TCH_F-0)[0x18bb578]{ROLLBACK}: Removing from parent
lchan(0-0-1-TCH_F-0)[0x18aa528] (lchan_rtp_fsm.c:536)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230607 DLMGCP DEBUG
mgw-endp(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18bbe68]{IN_USE}:
rtpbridge/1@mgw CI[0] to-BTS CI=A8920AAB: DLCX: notify=NULL
(mgcp_client_endpoint_fsm.c:665)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230607 DLMGCP DEBUG
mgw-endp(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18bbe68]{IN_USE}:
rtpbridge/1@mgw CI[0] to-BTS CI=A8920AAB: DLCX: Scheduling
(mgcp_client_endpoint_fsm.c:712)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230607 DLMGCP DEBUG
mgw-endp(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18bbe68]{IN_USE}:
state_chg to WAIT_MGW_RESPONSE (mgcp_client_endpoint_fsm.c:715)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230607 DLMGCP DEBUG
mgw-endp(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18bbe68]{WAIT_MGW_RESPONSE}:
rtpbridge/1@mgw CI[0] to-BTS CI=A8920AAB: Sending MGCP: DLCX A8920AAB
(mgcp_client_endpoint_fsm.c:791)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230608 DLMGCP DEBUG
MGCP_CONN(to-BTS)[0x18bbf78]{ST_READY}: Received Event EV_DLCX
(mgcp_client_fsm.c:738)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230608 DLMGCP DEBUG
MGW(mgw) Queued 52 bytes for MGW (mgcp_client.c:1121)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230608 DLMGCP DEBUG
MGCP_CONN(to-BTS)[0x18bbf78]{ST_READY}: state_chg to ST_DLCX_RESP
(mgcp_client_fsm.c:390)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230608 DLMGCP DEBUG
mgw-endp(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18bbe68]{WAIT_MGW_RESPONSE}:
rtpbridge/1@mgw Sent messages: 1 (mgcp_client_endpoint_fsm.c:920)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230608 DLMGCP DEBUG
mgw-endp(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18bbe68]{WAIT_MGW_RESPONSE}:
rtpbridge/1@mgw CI in use: 0, waiting for response: 0
(mgcp_client_endpoint_fsm.c:864)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230608 DLMGCP DEBUG
mgw-endp(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18bbe68]{WAIT_MGW_RESPONSE}:
Terminating (cause = OSMO_FSM_TERM_REGULAR) (mgcp_client_endpoint_fsm.c:869)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230608 DLMGCP DEBUG
mgw-endp(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18bbe68]{WAIT_MGW_RESPONSE}:
Removing from parent
SUBSCR_CONN(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18ba338]
(mgcp_client_endpoint_fsm.c:869)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230608 DLMGCP DEBUG
mgw-endp(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18bbe68]{WAIT_MGW_RESPONSE}:
Freeing instance (mgcp_client_endpoint_fsm.c:869)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230608 DLMGCP DEBUG
mgw-endp(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18bbe68]{WAIT_MGW_RESPONSE}:
Deallocated (fsm.c:573)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230608 DMSC DEBUG
SUBSCR_CONN(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18ba338]{ASSIGNMENT}:
Received Event FORGET_MGW_ENDPOINT (mgcp_client_endpoint_fsm.c:869)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230608 DCHAN DEBUG
lchan_rtp(0-0-1-TCH_F-0)[0x18bb578]{ROLLBACK}: Freeing instance
(lchan_rtp_fsm.c:536)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230608 DCHAN DEBUG
lchan_rtp(0-0-1-TCH_F-0)[0x18bb578]{ROLLBACK}: Deallocated (fsm.c:573)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230608 DCHAN DEBUG
lchan(0-0-1-TCH_F-0)[0x18aa528]{WAIT_RLL_RTP_ESTABLISH}: Received Event
LCHAN_EV_RTP_RELEASED (lchan_rtp_fsm.c:536)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230608 DRSL DEBUG
(bts=0,trx=0,ts=1,ss=0) DEACTivate SACCH CMD (abis_rsl.c:853)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230608 DCHAN DEBUG
lchan(0-0-1-TCH_F-0)[0x18aa528]{WAIT_RLL_RTP_ESTABLISH}: state_chg to
WAIT_RF_RELEASE_ACK (lchan_fsm.c:1836)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230608 DCHAN DEBUG
lchan(0-0-1-TCH_F-0)[0x18aa528]{WAIT_RF_RELEASE_ACK}: lchan detaches from conn
SUBSCR_CONN(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18ba338]
(lchan_fsm.c:1885)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230608 DMSC DEBUG
SUBSCR_CONN(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18ba338]{ASSIGNMENT}:
lchan lchan(0-0-1-TCH_F-0)[0x18aa528] detaches from conn (lchan_fsm.c:1888)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230608 DAS DEBUG
assignment(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46_0-0-1-TCH_F-0)[0x18bb358]{WAIT_RR_ASS_COMPLETE}:
Freeing instance (assignment_fsm.c:152)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230608 DAS DEBUG
assignment(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46_0-0-1-TCH_F-0)[0x18bb358]{WAIT_RR_ASS_COMPLETE}:
Deallocated (fsm.c:573)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230608 DMSC DEBUG
SUBSCR_CONN(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18ba338]{ASSIGNMENT}:
Received Event ASSIGNMENT_END (assignment_fsm.c:152)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230608 DMSC DEBUG
SUBSCR_CONN(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18ba338]{ASSIGNMENT}:
state_chg to ACTIVE (bsc_subscr_conn_fsm.c:457)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230609 DLMGCP DEBUG
MGW(mgw) Tx MGCP: r=127.0.0.1:12427<->l=127.0.0.1:2727: len=52 'DLCX 3
rtpbridge/1@mgw MGCP 1.0\r\nC: 5\r\nI: '... (mgcp_client.c:747)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230609 DLMI DEBUG
E1TS(0:2) TX 2: 08 25 01 09 (ipaccess.c:516)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230609 DLINP DEBUG
[CONNECTED] osmo_stream_cli_fd_cb(): connected write (stream.c:417)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230609 DLINP DEBUG
[CONNECTED] osmo_stream_cli_write(): sending 48 bytes of data (stream.c:350)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230611 DLMGCP DEBUG
MGW(mgw) MGCP client: Rx 250 3 OK (mgcp_client.c:684)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230611 DLMGCP DEBUG
MGCP_CONN(to-BTS)[0x18bbf78]{ST_DLCX_RESP}: Received Event EV_DLCX_RESP
(mgcp_client_fsm.c:472)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230611 DLMGCP DEBUG
MGCP_CONN(to-BTS)[0x18bbf78]{ST_DLCX_RESP}: Terminating (cause =
OSMO_FSM_TERM_REGULAR) (mgcp_client_fsm.c:488)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230611 DLMGCP DEBUG
MGCP_CONN(to-BTS)[0x18bbf78]{ST_DLCX_RESP}: Freeing instance
(mgcp_client_fsm.c:488)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230611 DLMGCP DEBUG
MGCP_CONN(to-BTS)[0x18bbf78]{ST_DLCX_RESP}: Deallocated (fsm.c:573)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230611 DLINP DEBUG
[CONNECTED] osmo_stream_cli_fd_cb(): connected write (stream.c:417)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230611 DLMI DEBUG
E1TS(0:2) TX 2: 08 2e 01 09 (ipaccess.c:516)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230612 DLMI DEBUG RX 2:
7e 76 01 09 f8 00 00 f6 1c 00 00 00 2f 00 00 08 43 00 00 00 00 00 00 00 00 00
00 00 00 00 00 00 00 00 00 00 00 1a 01 0f (ipaccess.c:391)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230613 DCHAN DEBUG
lchan(0-0-1-TCH_F-0)[0x18aa528]{WAIT_RF_RELEASE_ACK}: (type=TCH_F) Rx
IPAC_DLCX_IND (abis_rsl.c:2913)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230613 DCHAN NOTICE
lchan(0-0-1-TCH_F-0)[0x18aa528]{WAIT_RF_RELEASE_ACK}: (type=TCH_F) Rx IPACC
DLCX IND (abis_rsl.c:2887)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230613 DLINP DEBUG
[CONNECTED] osmo_stream_cli_fd_cb(): connected read (stream.c:413)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230613 DLINP DEBUG
[CONNECTED] osmo_stream_cli_read(): message received (stream.c:322)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230613 DLSS7 DEBUG 0:
asp-asp-clnt-A-0-m3ua: xua_cli_read_cb(): sctp_recvmsg() returned 48
(flags=0x80) (osmo_ss7.c:1934)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230613 DLM3UA DEBUG 0:
asp-asp-clnt-A-0-m3ua: Received M3UA Message (XFER:DATA) (m3ua.c:715)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230613 DLM3UA DEBUG 0:
asp-asp-clnt-A-0-m3ua: m3ua_rx_xfer (m3ua.c:543)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230613 DLM3UA DEBUG 0:
asp-asp-clnt-A-0-m3ua: m3ua_rx_xfer(): M3UA data header: opc=185=0.23.1
dpc=187=0.23.3 (m3ua.c:569)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230613 DLSS7 DEBUG
m3ua_hmdc_rx_from_l2(): found dpc=187=0.23.3 as local (osmo_ss7_hmrt.c:277)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230613 DLSS7 DEBUG
scrc_rx_mtp_xfer_ind_xua: HDR=(CO:CODT,V=0,LEN=0), PART(T=Destination
Reference,L=4,D=00000005), PART(T=Segmentation,L=4,D=00000000),
PART(T=Data,L=9,D=018006832d0802e1af) (sccp_scrc.c:472)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230613 DLSCCP DEBUG
Received CO:CODT for local reference 5 (sccp_scoc.c:1665)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230613 DLSCCP DEBUG
SCCP-SCOC(5)[0x18bb888]{ACTIVE}: Received Event RCOC-DT1.ind (sccp_scoc.c:1698)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230613 DLSCCP DEBUG
Delivering N-DATA.indication to SCCP User 'msc-0' (sccp_user.c:176)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230613 DMSC DEBUG
N-DATA.ind(5, 01 80 06 83 2d 08 02 e1 af ) (osmo_bsc_sigtran.c:250)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230613 DRESET DEBUG
bssmap_reset(msc-0)[0x18a99d0]{CONN}: Received Event
BSSMAP_RESET_EV_CONN_CFM_SUCCESS (a_reset.c:118)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230613 DMSC DEBUG Rx MSC
DTAP: 01 80 06 83 2d 08 02 e1 af (osmo_bsc_bssap.c:1238)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230613 DMSC INFO Rx MSC
DTAP, SAPI: RR/MM/CC CHAN: 2 (osmo_bsc_bssap.c:1262)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230613 DMSC DEBUG
SUBSCR_CONN(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18ba338]{ACTIVE}:
Received Event MT_DTAP (osmo_bsc_bssap.c:1281)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230614 DLMI DEBUG RX 2:
08 33 01 09 (ipaccess.c:391)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230614 DCHAN DEBUG
lchan(0-0-1-TCH_F-0)[0x18aa528]{WAIT_RF_RELEASE_ACK}: (type=TCH_F) Rx
RF_CHAN_REL_ACK (abis_rsl.c:1521)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230614 DCHAN DEBUG
lchan(0-0-1-TCH_F-0)[0x18aa528]{WAIT_RF_RELEASE_ACK}: Received Event
LCHAN_EV_RSL_RF_CHAN_REL_ACK (abis_rsl.c:1553)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230614 DCHAN DEBUG
lchan(0-0-1-TCH_F-0)[0x18aa528]{WAIT_RF_RELEASE_ACK}: state_chg to
WAIT_AFTER_ERROR (lchan_fsm.c:1412)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230614 DLMI DEBUG
E1TS(0:2) TX 2: 03 01 01 28 02 00 0b 00 06 83 2d 08 02 e1 af (ipaccess.c:516)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230614 DLINP DEBUG
[CONNECTED] osmo_stream_cli_fd_cb(): connected read (stream.c:413)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230614 DLINP DEBUG
[CONNECTED] osmo_stream_cli_read(): message received (stream.c:322)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230614 DLSS7 DEBUG 0:
asp-asp-clnt-A-0-m3ua: xua_cli_read_cb(): sctp_recvmsg() returned 48
(flags=0x80) (osmo_ss7.c:1934)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230614 DLM3UA DEBUG 0:
asp-asp-clnt-A-0-m3ua: Received M3UA Message (XFER:DATA) (m3ua.c:715)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230614 DLM3UA DEBUG 0:
asp-asp-clnt-A-0-m3ua: m3ua_rx_xfer (m3ua.c:543)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230614 DLM3UA DEBUG 0:
asp-asp-clnt-A-0-m3ua: m3ua_rx_xfer(): M3UA data header: opc=185=0.23.1
dpc=187=0.23.3 (m3ua.c:569)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230615 DLSS7 DEBUG
m3ua_hmdc_rx_from_l2(): found dpc=187=0.23.3 as local (osmo_ss7_hmrt.c:277)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230615 DLSS7 DEBUG
scrc_rx_mtp_xfer_ind_xua: HDR=(CO:CODT,V=0,LEN=0), PART(T=Destination
Reference,L=4,D=00000005), PART(T=Segmentation,L=4,D=00000000),
PART(T=Data,L=6,D=000420040109) (sccp_scrc.c:472)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230615 DLSCCP DEBUG
Received CO:CODT for local reference 5 (sccp_scoc.c:1665)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230615 DLSCCP DEBUG
SCCP-SCOC(5)[0x18bb888]{ACTIVE}: Received Event RCOC-DT1.ind (sccp_scoc.c:1698)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230615 DLSCCP DEBUG
Delivering N-DATA.indication to SCCP User 'msc-0' (sccp_user.c:176)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230615 DMSC DEBUG
N-DATA.ind(5, 00 04 20 04 01 09 ) (osmo_bsc_sigtran.c:250)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230615 DRESET DEBUG
bssmap_reset(msc-0)[0x18a99d0]{CONN}: Received Event
BSSMAP_RESET_EV_CONN_CFM_SUCCESS (a_reset.c:118)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230615 DMSC INFO Rx MSC
DT1 BSSMAP CLEAR COMMAND (osmo_bsc_bssap.c:1158)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230615 DMSC DEBUG
SUBSCR_CONN(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18ba338]{ACTIVE}:
Received Event CLEAR_CMD (osmo_bsc_bssap.c:444)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230615 DMSC DEBUG
SUBSCR_CONN(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18ba338]{ACTIVE}:
state_chg to CLEARING (bsc_subscr_conn_fsm.c:865)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230615 DMSC DEBUG
SUBSCR_CONN(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18ba338]{CLEARING}:
Releasing all lchans (if any) after BSSMAP Clear Command
(bsc_subscr_conn_fsm.c:866)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230616 DCHAN DEBUG
lchan(0-0-0-CCCH_SDCCH4-1)[0x18b8650]{ESTABLISHED}: lchan detaches from conn
SUBSCR_CONN(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18ba338]
(lchan_fsm.c:1885)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230616 DMSC DEBUG
SUBSCR_CONN(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18ba338]{CLEARING}:
lchan lchan(0-0-0-CCCH_SDCCH4-1)[0x18b8650] detaches from conn
(lchan_fsm.c:1888)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230616 DCHAN DEBUG
lchan(0-0-0-CCCH_SDCCH4-1)[0x18b8650]{ESTABLISHED}: state_chg to
WAIT_RLL_RTP_RELEASED (lchan_fsm.c:1850)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230616 DCHAN DEBUG
lchan(0-0-0-CCCH_SDCCH4-1)[0x18b8650]{WAIT_RLL_RTP_RELEASED}: (type=SDCCH)
SAPI[0] = 1 (lchan_fsm.c:1328)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230616 DRR DEBUG Sending
Channel Release: Chan: Number: 1 Type: 1 RR-Cause: 0x0 'Normal event'
(gsm_04_08_rr.c:329)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230616 DRSL DEBUG
(bts=0,trx=0,ts=0,ss=1) DEACTivate SACCH CMD (abis_rsl.c:853)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230616 DCHAN DEBUG
lchan(0-0-0-CCCH_SDCCH4-1)[0x18b8650]{WAIT_RLL_RTP_RELEASED}: state_chg to
WAIT_BEFORE_RF_RELEASE (lchan_fsm.c:1358)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230616 DMSC INFO Tx MSC:
BSSMAP: CLEAR COMPLETE (osmo_bsc_sigtran.c:380)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230616 DMSC DEBUG Sending
connection (id=5) oriented data to MSC: RI=SSN_PC,PC=0.23.1,SSN=BSSAP (00 01 21
) (osmo_bsc_sigtran.c:408)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230616 DLSCCP DEBUG
Received SCCP User Primitive (N-DATA.request) (sccp_scoc.c:1732)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230616 DLSCCP DEBUG
SCCP-SCOC(5)[0x18bb888]{ACTIVE}: Received Event N-DATA.req (sccp_scoc.c:1772)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230616 DLSS7 DEBUG
sccp_scrc_rx_scoc_conn_msg: HDR=(CO:CODT,V=0,LEN=0), PART(T=Routing
Context,L=4,D=00000000), PART(T=Destination Reference,L=4,D=00000005),
PART(T=Data,L=3,D=000121) (sccp_scrc.c:401)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230616 DLSS7 DEBUG
m3ua_hmdc_rx_from_l2(): dpc=185=0.23.1 not local, message is for routing
(osmo_ss7_hmrt.c:281)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230616 DLSS7 DEBUG Found
route for dpc=185=0.23.1: pc=0=0.0.0 mask=0x0=0.0.0 via AS as-clnt-A-0-m3ua
proto=m3ua (osmo_ss7_hmrt.c:228)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230616 DLSS7 DEBUG
rt->dest.as proto is M3UA for dpc=185=0.23.1 (osmo_ss7_hmrt.c:236)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230616 DLSS7 DEBUG
XUA_AS(as-clnt-A-0-m3ua)[0x18a88c0]{AS_ACTIVE}: Received Event AS-TRANSFER.req
(m3ua.c:508)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230616 DLINP DEBUG
[CONNECTED] osmo_stream_cli_fd_cb(): connected write (stream.c:417)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230616 DLINP DEBUG
[CONNECTED] osmo_stream_cli_write(): sending 44 bytes of data (stream.c:350)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230617 DLMI DEBUG
E1TS(0:2) TX 2: 03 01 01 28 02 00 0b 00 03 06 0d 00 (ipaccess.c:516)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230618 DLINP DEBUG
[CONNECTED] osmo_stream_cli_fd_cb(): connected write (stream.c:417)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230619 DLINP DEBUG
[CONNECTED] osmo_stream_cli_fd_cb(): connected read (stream.c:413)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230619 DLINP DEBUG
[CONNECTED] osmo_stream_cli_read(): message received (stream.c:322)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230619 DLSS7 DEBUG 0:
asp-asp-clnt-A-0-m3ua: xua_cli_read_cb(): sctp_recvmsg() returned 44
(flags=0x80) (osmo_ss7.c:1934)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230619 DLM3UA DEBUG 0:
asp-asp-clnt-A-0-m3ua: Received M3UA Message (XFER:DATA) (m3ua.c:715)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230619 DLM3UA DEBUG 0:
asp-asp-clnt-A-0-m3ua: m3ua_rx_xfer (m3ua.c:543)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230619 DLM3UA DEBUG 0:
asp-asp-clnt-A-0-m3ua: m3ua_rx_xfer(): M3UA data header: opc=185=0.23.1
dpc=187=0.23.3 (m3ua.c:569)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230619 DLSS7 DEBUG
m3ua_hmdc_rx_from_l2(): found dpc=187=0.23.3 as local (osmo_ss7_hmrt.c:277)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230619 DLSS7 DEBUG
scrc_rx_mtp_xfer_ind_xua: HDR=(CO:RELRE,V=0,LEN=0), PART(T=Destination
Reference,L=4,D=00000005), PART(T=Source Reference,L=4,D=00000005),
PART(T=Cause,L=4,D=00000300) (sccp_scrc.c:472)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230619 DLSCCP DEBUG
Received CO:RELRE for local reference 5 (sccp_scoc.c:1665)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230619 DLSCCP DEBUG
SCCP-SCOC(5)[0x18bb888]{ACTIVE}: Received Event RCOC-RELEASED.ind
(sccp_scoc.c:1698)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230619 DLSCCP DEBUG
Delivering N-DISCONNECT.indication to SCCP User 'msc-0' (sccp_user.c:176)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230619 DMSC DEBUG
N-DISCONNECT.ind(5, , cause=768) (osmo_bsc_sigtran.c:263)
Apr 09 07:42:30 raspberrypi osmo-bsc[359]: 20220409074230619 DMSC DEBUG
SUBSCR_CONN(msc0-conn5_subscr-IMSI-999990000035204-TMSI-0x531bba46)[0x18ba338]{CLEARING}:
Received Event DISCONNET.ind (osmo_bsc_sigtran.c:270)
