Bug #2624
Updated by pespin over 6 years ago
While testing today the new osmo-bsc/msc/mgw current master. The issue appears while placing a call between 2 MS.
In sysmobts I'm running 201705-nightly updated from today:
<pre>
root@sysmobts-v2:~# opkg list_installed | grep osmo
libosmo-abis - 0.4.0+gitr2+e2d33bf02d-r2.18.0.5
libosmo-sigtran0 - 0.8.1+gitr2+67ca594140-r1.18.0.0
libosmocodec0 - 0.10.2+gitr2+4a73d5e843-r1.0
libosmocore - 0.10.2+gitr2+4a73d5e843-r1.0
libosmoctrl0 - 0.10.2+gitr2+4a73d5e843-r1.0
libosmogb4 - 0.9.6+gitr0+657c5b6cad-r0.0
libosmogb5 - 0.10.2+gitr2+4a73d5e843-r1.0
libosmogsm6 - 0.9.6+gitr0+657c5b6cad-r0.0
libosmogsm8 - 0.10.2+gitr2+4a73d5e843-r1.0
libosmonetif3 - 0.4.0+gitr1+5994198208-r2.18.0.0
libosmonetif4 - 0.1.1+gitr0+1274b37430-r2.18.1.5
libosmovty3 - 0.9.6+gitr0+657c5b6cad-r0.0
libosmovty4 - 0.10.2+gitr2+4a73d5e843-r1.0
osmo-bsc - 1.1.2+gitr3+6a12c76196-r0.18.0.0
osmo-bts - 0.7.0+git2+3b0b064196-r80117acba6-r0.18.0
osmo-bts-remote - 0.7.0+git2+3b0b064196-r80117acba6-r0.18.0
osmo-ggsn - 1.1.0+gitr1+fc6676c4a0-r0.1
osmo-hlr - 0.1.0+gitr1+87a04b6b95-r0.18.0.0
osmo-iuh - 0.1.0+gitr0+5a3df8fa9f-r0.18.0.0
osmo-mgw - 1.1.0+gitr3+54dd4b3f72-r0.18.0.1
osmo-msc - 1.1.2+gitr0+84ad185713-r2.18.0.6
osmo-pcu - 0.4+git3+bfc54b551b-r0.18.5
osmo-sgsn - 1.2.0+gitr0+fea0609f4b-r2.18.0.5
osmo-stp - 0.8.1+gitr2+67ca594140-r1.18.0.0
packagegroup-osmocom - 1.0-r2.8
</pre>
<pre>
Nov 08 13:13:28 sysmobts-v2 osmo-bts-sysmo[1794]: <0007> ../../../git/src/common/l1sap.c:1175 RACH for packet access (toa=0, ra=120)
Nov 08 13:13:30 sysmobts-v2 osmo-bts-sysmo[1794]: <0007> ../../../git/src/common/l1sap.c:1175 RACH for packet access (toa=0, ra=120)
Nov 08 13:13:32 sysmobts-v2 osmo-bts-sysmo[1794]: <0007> ../../../git/src/common/l1sap.c:1175 RACH for packet access (toa=0, ra=118)
Nov 08 13:13:33 sysmobts-v2 osmo-bts-sysmo[1794]: <0007> ../../../git/src/common/l1sap.c:1175 RACH for packet access (toa=0, ra=123)
Nov 08 13:13:34 sysmobts-v2 osmo-bts-sysmo[1794]: <0007> ../../../git/src/common/l1sap.c:1175 RACH for packet access (toa=0, ra=122)
Nov 08 13:13:37 sysmobts-v2 osmo-bts-sysmo[1794]: <0007> ../../../git/src/common/l1sap.c:1175 RACH for packet access (toa=0, ra=113)
Nov 08 13:13:38 sysmobts-v2 osmo-bts-sysmo[1794]: <0007> ../../../git/src/common/l1sap.c:1175 RACH for packet access (toa=0, ra=120)
Nov 08 13:13:38 sysmobts-v2 osmo-bts-sysmo[1794]: <0007> ../../../git/src/common/l1sap.c:1175 RACH for packet access (toa=0, ra=123)
Nov 08 13:13:40 sysmobts-v2 osmo-bts-sysmo[1794]: <0007> ../../../git/src/common/l1sap.c:1175 RACH for packet access (toa=0, ra=122)
Nov 08 13:13:42 sysmobts-v2 osmo-bts-sysmo[1794]: <0007> ../../../git/src/common/l1sap.c:1175 RACH for packet access (toa=0, ra=116)
Nov 08 13:13:44 sysmobts-v2 osmo-bts-sysmo[1794]: <0007> ../../../git/src/common/l1sap.c:1175 RACH for packet access (toa=0, ra=123)
Nov 08 13:13:46 sysmobts-v2 osmo-bts-sysmo[1794]: <0007> ../../../git/src/common/l1sap.c:1175 RACH for packet access (toa=0, ra=122)
Nov 08 13:13:47 sysmobts-v2 osmo-bts-sysmo[1794]: <0007> ../../../git/src/common/l1sap.c:1175 RACH for packet access (toa=0, ra=120)
Nov 08 13:13:49 sysmobts-v2 osmo-bts-sysmo[1794]: <0007> ../../../git/src/common/l1sap.c:1175 RACH for packet access (toa=0, ra=118)
Nov 08 13:13:49 sysmobts-v2 osmo-bts-sysmo[1794]: <0007> ../../../git/src/common/l1sap.c:1175 RACH for packet access (toa=0, ra=122)
Nov 08 13:13:53 sysmobts-v2 osmo-bts-sysmo[1794]: <0007> ../../../git/src/common/l1sap.c:1175 RACH for packet access (toa=0, ra=123)
Nov 08 13:14:01 sysmobts-v2 osmo-bts-sysmo[1794]: <0007> ../../../git/src/common/l1sap.c:1175 RACH for packet access (toa=0, ra=123)
Nov 08 13:14:06 sysmobts-v2 osmo-bts-sysmo[1794]: <0007> ../../../git/src/common/l1sap.c:1175 RACH for packet access (toa=0, ra=115)
Nov 08 13:14:17 sysmobts-v2 osmo-bts-sysmo[1794]: <0007> ../../../git/src/common/l1sap.c:1184 RACH for RR access (toa=0, ra=250)
Nov 08 13:14:17 sysmobts-v2 osmo-bts-sysmo[1794]: <0000> ../../../git/src/common/rsl.c:2367 (bts=0,trx=0,ts=0,ss=4) Fwd RLL msg CHAN_RQD from LAPDm to A-bis
Nov 08 13:14:17 sysmobts-v2 osmo-bts-sysmo[1794]: <0000> ../../../git/src/common/rsl.c:2448 (bts=0,trx=0,ts=1,ss=0) Rx RSL CHAN_ACTIV
Nov 08 13:14:17 sysmobts-v2 osmo-bts-sysmo[1794]: <0000> ../../../git/src/common/rsl.c:972 chan_nr=0x09 type=0x00 mode=0x00
Nov 08 13:14:17 sysmobts-v2 osmo-bts-sysmo[1794]: <0007> ../../../git/src/common/l1sap.c:1328 activating channel chan_nr=0x09 trx=0
Nov 08 13:14:17 sysmobts-v2 osmo-bts-sysmo[1794]: <0006> ../../../git/src/osmo-bts-sysmo/oml.c:938 (bts=0,trx=0,ts=1,ss=0): lchan2lch_par tch_mode=0x00
Nov 08 13:14:17 sysmobts-v2 osmo-bts-sysmo[1794]: <0006> ../../../git/src/osmo-bts-sysmo/oml.c:1084 (bts=0,trx=0,ts=1,ss=0) MPH-ACTIVATE.req (hL2=0x000100bb, TCH/F TxDL)
Nov 08 13:14:17 sysmobts-v2 osmo-bts-sysmo[1794]: <0007> ../../../git/src/osmo-bts-sysmo/l1_if.c:167 Tx L1 prim MPH-ACTIVATE.req
Nov 08 13:14:17 sysmobts-v2 osmo-bts-sysmo[1794]: <0006> ../../../git/src/osmo-bts-sysmo/oml.c:817 (bts=0,trx=0,ts=1,ss=0) MPH-ACTIVATE.conf (TCH/F TxDL)
Nov 08 13:14:17 sysmobts-v2 osmo-bts-sysmo[1794]: <0006> ../../../git/src/osmo-bts-sysmo/oml.c:938 (bts=0,trx=0,ts=1,ss=0): lchan2lch_par tch_mode=0x00
Nov 08 13:14:17 sysmobts-v2 osmo-bts-sysmo[1794]: <0006> ../../../git/src/osmo-bts-sysmo/oml.c:1084 (bts=0,trx=0,ts=1,ss=0) MPH-ACTIVATE.req (hL2=0x000100bb, TCH/F RxUL)
Nov 08 13:14:17 sysmobts-v2 osmo-bts-sysmo[1794]: <0007> ../../../git/src/osmo-bts-sysmo/l1_if.c:167 Tx L1 prim MPH-ACTIVATE.req
Nov 08 13:14:17 sysmobts-v2 osmo-bts-sysmo[1794]: <0006> ../../../git/src/osmo-bts-sysmo/oml.c:817 (bts=0,trx=0,ts=1,ss=0) MPH-ACTIVATE.conf (TCH/F RxUL)
Nov 08 13:14:17 sysmobts-v2 osmo-bts-sysmo[1794]: <0006> ../../../git/src/osmo-bts-sysmo/oml.c:1084 (bts=0,trx=0,ts=1,ss=0) MPH-ACTIVATE.req (hL2=0x000100bb, FACCH/F TxDL
)
Nov 08 13:14:17 sysmobts-v2 osmo-bts-sysmo[1794]: <0007> ../../../git/src/osmo-bts-sysmo/l1_if.c:167 Tx L1 prim MPH-ACTIVATE.req
Nov 08 13:14:17 sysmobts-v2 osmo-bts-sysmo[1794]: <0006> ../../../git/src/osmo-bts-sysmo/oml.c:817 (bts=0,trx=0,ts=1,ss=0) MPH-ACTIVATE.conf (FACCH/F TxDL)
Nov 08 13:14:17 sysmobts-v2 osmo-bts-sysmo[1794]: <0006> ../../../git/src/osmo-bts-sysmo/oml.c:1084 (bts=0,trx=0,ts=1,ss=0) MPH-ACTIVATE.req (hL2=0x000100bb, FACCH/F RxUL
)
Nov 08 13:14:17 sysmobts-v2 osmo-bts-sysmo[1794]: <0007> ../../../git/src/osmo-bts-sysmo/l1_if.c:167 Tx L1 prim MPH-ACTIVATE.req
Nov 08 13:14:17 sysmobts-v2 osmo-bts-sysmo[1794]: <0006> ../../../git/src/osmo-bts-sysmo/oml.c:817 (bts=0,trx=0,ts=1,ss=0) MPH-ACTIVATE.conf (FACCH/F RxUL)
Nov 08 13:14:17 sysmobts-v2 osmo-bts-sysmo[1794]: <0006> ../../../git/src/osmo-bts-sysmo/oml.c:1084 (bts=0,trx=0,ts=1,ss=0) MPH-ACTIVATE.req (hL2=0x000100bb, SACCH TxDL)
Nov 08 13:14:17 sysmobts-v2 osmo-bts-sysmo[1794]: <0007> ../../../git/src/osmo-bts-sysmo/l1_if.c:167 Tx L1 prim MPH-ACTIVATE.req
Nov 08 13:14:17 sysmobts-v2 osmo-bts-sysmo[1794]: <0006> ../../../git/src/osmo-bts-sysmo/oml.c:817 (bts=0,trx=0,ts=1,ss=0) MPH-ACTIVATE.conf (SACCH TxDL)
Nov 08 13:14:17 sysmobts-v2 osmo-bts-sysmo[1794]: <0006> ../../../git/src/osmo-bts-sysmo/oml.c:1084 (bts=0,trx=0,ts=1,ss=0) MPH-ACTIVATE.req (hL2=0x000100bb, SACCH RxUL)
Nov 08 13:14:17 sysmobts-v2 osmo-bts-sysmo[1794]: <0007> ../../../git/src/osmo-bts-sysmo/l1_if.c:167 Tx L1 prim MPH-ACTIVATE.req
Nov 08 13:14:17 sysmobts-v2 osmo-bts-sysmo[1794]: <0006> ../../../git/src/osmo-bts-sysmo/oml.c:817 (bts=0,trx=0,ts=1,ss=0) MPH-ACTIVATE.conf (SACCH RxUL)
Nov 08 13:14:17 sysmobts-v2 osmo-bts-sysmo[1794]: <0007> ../../../git/src/common/l1sap.c:575 activate confirm chan_nr=0x09 trx=0
Nov 08 13:14:17 sysmobts-v2 osmo-bts-sysmo[1794]: <0000> ../../../git/src/common/rsl.c:603 (bts=0,trx=0,ts=1,ss=0) Tx CHAN ACT ACK
Nov 08 13:14:17 sysmobts-v2 osmo-bts-sysmo[1794]: <0006> ../../../git/src/osmo-bts-sysmo/oml.c:1425 (bts=0,trx=0,ts=1,ss=0) SET_CIPHERING (ALG=0 TxDL)
Nov 08 13:14:17 sysmobts-v2 osmo-bts-sysmo[1794]: <0007> ../../../git/src/osmo-bts-sysmo/l1_if.c:167 Tx L1 prim MPH-CONFIG.req
Nov 08 13:14:17 sysmobts-v2 osmo-bts-sysmo[1794]: <0006> ../../../git/src/osmo-bts-sysmo/oml.c:1270 (bts=0,trx=0,ts=1,ss=0) MPH-CONFIG.conf (Configure ciphering params)
Nov 08 13:14:17 sysmobts-v2 osmo-bts-sysmo[1794]: <0006> ../../../git/src/osmo-bts-sysmo/oml.c:1425 (bts=0,trx=0,ts=1,ss=0) SET_CIPHERING (ALG=0 RxUL)
Nov 08 13:14:17 sysmobts-v2 osmo-bts-sysmo[1794]: <0007> ../../../git/src/osmo-bts-sysmo/l1_if.c:167 Tx L1 prim MPH-CONFIG.req
Nov 08 13:14:17 sysmobts-v2 osmo-bts-sysmo[1794]: <0000> ../../../git/src/common/rsl.c:2394 (bts=0,trx=0,ts=0,ss=0) Rx RSL IMM_ASS_CMD
Nov 08 13:14:17 sysmobts-v2 osmo-bts-sysmo[1794]: <0006> ../../../git/src/osmo-bts-sysmo/oml.c:1270 (bts=0,trx=0,ts=1,ss=0) MPH-CONFIG.conf (Configure ciphering params)
Nov 08 13:14:17 sysmobts-v2 osmo-bts-sysmo[1794]: <0011> ../../../git/src/gsm/lapd_core.c:917 Store content res. (dl=0xb6a20a44)
Nov 08 13:14:17 sysmobts-v2 osmo-bts-sysmo[1794]: <0000> ../../../git/src/common/rsl.c:2367 (bts=0,trx=0,ts=1,ss=0) Fwd RLL msg EST_IND from LAPDm to A-bis
Nov 08 13:14:17 sysmobts-v2 osmo-bts-sysmo[1794]: <0000> ../../../git/src/common/rsl.c:2367 (bts=0,trx=0,ts=1,ss=0) Fwd RLL msg DATA_IND from LAPDm to A-bis
Nov 08 13:14:17 sysmobts-v2 osmo-bts-sysmo[1794]: <0000> ../../../git/src/common/rsl.c:2367 (bts=0,trx=0,ts=1,ss=0) Fwd RLL msg DATA_IND from LAPDm to A-bis
Nov 08 13:14:18 sysmobts-v2 osmo-bts-sysmo[1794]: <0000> ../../../git/src/common/rsl.c:2344 (bts=0,trx=0,ts=1,ss=0) Handing RLL msg UNIT_DATA_IND from LAPDm to MEAS REP
Nov 08 13:14:18 sysmobts-v2 osmo-bts-sysmo[1794]: <0000> ../../../git/src/common/rsl.c:2367 (bts=0,trx=0,ts=1,ss=0) Fwd RLL msg DATA_IND from LAPDm to A-bis
Nov 08 13:14:18 sysmobts-v2 osmo-bts-sysmo[1794]: <0000> ../../../git/src/common/rsl.c:2448 (bts=0,trx=0,ts=1,ss=0) Rx RSL MODE_MODIFY_REQ
Nov 08 13:14:18 sysmobts-v2 osmo-bts-sysmo[1794]: <0007> ../../../git/src/common/l1sap.c:1395 modifying channel chan_nr=0x09 trx=0
Nov 08 13:14:18 sysmobts-v2 osmo-bts-sysmo[1794]: <0006> ../../../git/src/osmo-bts-sysmo/oml.c:938 (bts=0,trx=0,ts=1,ss=0): lchan2lch_par tch_mode=0x01
Nov 08 13:14:18 sysmobts-v2 osmo-bts-sysmo[1794]: <0006> ../../../git/src/osmo-bts-sysmo/oml.c:1354 (bts=0,trx=0,ts=1,ss=0) MPH-CONFIG.req (TCH/F) cfgParams Tn=1, subCh=3
1, dir=0x2 amrCmiPhase=0x00 amrInitCodec=0x04 (0 0 0 0 )
Nov 08 13:14:18 sysmobts-v2 osmo-bts-sysmo[1794]: <0007> ../../../git/src/osmo-bts-sysmo/l1_if.c:167 Tx L1 prim MPH-CONFIG.req
Nov 08 13:14:18 sysmobts-v2 osmo-bts-sysmo[1794]: <0000> ../../../git/src/common/rsl.c:1258 (bts=0,trx=0,ts=1,ss=0) Tx MODE MODIF ACK
Nov 08 13:14:18 sysmobts-v2 osmo-bts-sysmo[1794]: <0000> ../../../git/src/common/rsl.c:2547 (bts=0,trx=0,ts=1,ss=0) Rx RSL IPAC_CRCX
Nov 08 13:14:18 sysmobts-v2 osmo-bts-sysmo[1794]: <0000> ../../../git/src/common/rsl.c:1636 CRCX does not specify a remote IP
Nov 08 13:14:18 sysmobts-v2 osmo-bts-sysmo[1794]: <0000> ../../../git/src/common/rsl.c:1643 CRCX does not specify a remote port
Nov 08 13:14:18 sysmobts-v2 osmo-bts-sysmo[1794]: <0000> ../../../git/src/common/rsl.c:1647 speech mode: 16
Nov 08 13:14:18 sysmobts-v2 osmo-bts-sysmo[1794]: <0000> ../../../git/src/common/rsl.c:1653 payload type: 3
Nov 08 13:14:18 sysmobts-v2 osmo-bts-sysmo[1794]: <0000> ../../../git/src/common/rsl.c:1706 (bts=0,trx=0,ts=1,ss=0) IPAC set RTP socket parameters: 1
Nov 08 13:14:18 sysmobts-v2 osmo-bts-sysmo[1794]: <0000> ../../../git/src/common/rsl.c:1463 (bts=0,trx=0,ts=1,ss=0) RSL Tx IPAC_CRCX_ACK (local 192.168.30.100:49108, remo
te 192.168.30.1:0)
Nov 08 13:14:18 sysmobts-v2 osmo-bts-sysmo[1794]: <0006> ../../../git/src/osmo-bts-sysmo/oml.c:1270 (bts=0,trx=0,ts=1,ss=0) MPH-CONFIG.conf (Set logical channel params) a
mrCmiPhase=0x00 amrInitCodec=0x04 (0 0 0 0 )
Nov 08 13:14:18 sysmobts-v2 osmo-bts-sysmo[1794]: <0006> ../../../git/src/osmo-bts-sysmo/oml.c:938 (bts=0,trx=0,ts=1,ss=0): lchan2lch_par tch_mode=0x01
Nov 08 13:14:18 sysmobts-v2 osmo-bts-sysmo[1794]: <0006> ../../../git/src/osmo-bts-sysmo/oml.c:1354 (bts=0,trx=0,ts=1,ss=0) MPH-CONFIG.req (TCH/F) cfgParams Tn=1, subCh=3
1, dir=0x4 amrCmiPhase=0x00 amrInitCodec=0x04 (0 0 0 0 )
Nov 08 13:14:18 sysmobts-v2 osmo-bts-sysmo[1794]: <0007> ../../../git/src/osmo-bts-sysmo/l1_if.c:167 Tx L1 prim MPH-CONFIG.req
Nov 08 13:14:18 sysmobts-v2 osmo-bts-sysmo[1794]: <0006> ../../../git/src/osmo-bts-sysmo/oml.c:1270 (bts=0,trx=0,ts=1,ss=0) MPH-CONFIG.conf (Set logical channel params) a
mrCmiPhase=0x00 amrInitCodec=0x04 (0 0 0 0 )
Nov 08 13:14:18 sysmobts-v2 osmo-bts-sysmo[1794]: <0000> ../../../git/src/common/rsl.c:2547 (bts=0,trx=0,ts=1,ss=0) Rx RSL IPAC_MDCX
Nov 08 13:14:18 sysmobts-v2 osmo-bts-sysmo[1794]: <0000> ../../../git/src/common/rsl.c:1633 connect_ip 18786496
Nov 08 13:14:18 sysmobts-v2 osmo-bts-sysmo[1794]: <0000> ../../../git/src/common/rsl.c:1640 connect_port 35390
Nov 08 13:14:18 sysmobts-v2 osmo-bts-sysmo[1794]: <0000> ../../../git/src/common/rsl.c:1647 speech mode: 0
Nov 08 13:14:18 sysmobts-v2 osmo-bts-sysmo[1794]: <0000> ../../../git/src/common/rsl.c:1653 payload type: 3
Nov 08 13:14:18 sysmobts-v2 osmo-bts-sysmo[1794]: <0000> ../../../git/src/common/rsl.c:1463 (bts=0,trx=0,ts=1,ss=0) RSL Tx IPAC_MDCX_ACK (local 192.168.30.100:49108, remo
te 192.168.30.1:16010)
Nov 08 13:14:18 sysmobts-v2 osmo-bts-sysmo[1794]: msgb(0xff208): Not enough tailroom msgb_put (348 < 1488)
Nov 08 13:14:18 sysmobts-v2 osmo-bts-sysmo[1794]: ((*))
Nov 08 13:14:18 sysmobts-v2 osmo-bts-sysmo[1794]: |
Nov 08 13:14:18 sysmobts-v2 osmo-bts-sysmo[1794]: / \ OsmoBTS
Nov 08 13:14:18 sysmobts-v2 osmo-bts-sysmo[1794]: backtrace() returned 0 addresses
Nov 08 13:14:18 sysmobts-v2 systemd[1]: osmo-bts-sysmo.service: Main process exited, code=dumped, status=6/ABRT
fpgadl: Bitstream loaded
</pre>
