debug-log

This is merely a historical archive of years 2008-2021, before the migration to mailman3.

A maintained and still updated list archive can be found at https://lists.osmocom.org/hyperkitty/list/baseband-devel@lists.osmocom.org/.

Erich Dachleger edachleger at yahoo.com
Sun Mar 17 11:07:15 UTC 2013


Hi list, below is the debug-log. It seems quite normal but something is surely wrong somewhere since phones cannot see the network. Are there any obvious errors in it?

regard erich




tail -f messages

oot at bt:/var/log# tail -f messages
Mar 17 09:48:05 bt openbts: INFO 3043371888 TRXManager.cpp:274:sendCommandPacket: response RSP SETPOWER 0 6
Mar 17 09:48:11 bt openbts: INFO 3043371888 PowerManager.cpp:49:increasePower: power increased to -5 dB
Mar 17 09:48:11 bt openbts: INFO 3043371888 TRXManager.cpp:260:sendCommandPacket: command CMD SETPOWER 5
Mar 17 09:48:11 bt openbts: INFO 3043371888 TRXManager.cpp:274:sendCommandPacket: response RSP SETPOWER 0 5
Mar 17 09:48:17 bt openbts: INFO 3043371888 PowerManager.cpp:49:increasePower: power increased to -4 dB
Mar 17 09:48:17 bt openbts: INFO 3043371888 TRXManager.cpp:260:sendCommandPacket: command CMD SETPOWER 4
Mar 17 09:48:17 bt openbts: INFO 3043371888 TRXManager.cpp:274:sendCommandPacket: response RSP SETPOWER 0 4
Mar 17 09:48:23 bt openbts: INFO 3043371888 PowerManager.cpp:49:increasePower: power increased to -3 dB
Mar 17 09:48:23 bt openbts: INFO 3043371888 TRXManager.cpp:260:sendCommandPacket: command CMD SETPOWER 3
Mar 17 09:48:23 bt openbts: INFO 3043371888 TRXManager.cpp:274:sendCommandPacket: response RSP SETPOWER 0 3

root at bt:/var/log# tail -f user.log
Mar 17 09:47:11 bt OpenBTS: DEBUG 3074303696 GSML3RRMessages.cpp:333:writeBody: primitive=UNIT_DATA raw=(061b000a00f11003e85100052f6040af3152)
Mar 17 09:47:11 bt OpenBTS: DEBUG 3074303696 GSML3RRMessages.cpp:335:writeBody: primitive=UNIT_DATA raw=(061b000a00f11003e85100052f6040e10400)
Mar 17 09:47:11 bt OpenBTS: DEBUG 3074303696 GSML3RRMessages.cpp:337:writeBody: primitive=UNIT_DATA raw=(061b000a00f11003e85100052f6040e10400)
Mar 17 09:47:11 bt OpenBTS: DEBUG 3074303696 GSMConfig.cpp:109:regenerateBeacon: mSI3Frame primitive=DATA raw=(49061b000a00f11003e85100052f6040e104002b2b2b2b)
Mar 17 09:47:11 bt OpenBTS: INFO 3074303696 GSMConfig.cpp:113:regenerateBeacon: RR System Information Type 4 LAI=(MCC=001 MNC=01 LAC=0x3e8) cellSelectionParameters=(CELL-RESELECT-HYSTERESIS=3 MS-TXPWR-MAX-CCH=0 ACS=0 NECI=1 RXLEV-ACCESS-MIN=0) RACHControlParameters=(maxRetrans=3 txInteger=8 cellBarAccess=0 RE=1 AC=0x400)
Mar 17 09:47:11 bt OpenBTS: DEBUG 3074303696 GSMConfig.cpp:118:regenerateBeacon: mSI4Frame primitive=DATA raw=(31061c00f11003e86040e104002b2b2b2b2b2b2b2b2b2b)
Mar 17 09:47:11 bt OpenBTS: INFO 3074303696 GSMConfig.cpp:122:regenerateBeacon: RR System Information Type 5 BCCHFrequencyList=(EXT-IND=0 BA-IND=0  ARFCNs=(0 ))
Mar 17 09:47:11 bt OpenBTS: DEBUG 3074303696 GSMConfig.cpp:124:regenerateBeacon: mSI5Frame primitive=UNIT_DATA raw=(061d8e000000000000000000000000000000)
Mar 17 09:47:11 bt OpenBTS: INFO 3074303696 GSMConfig.cpp:128:regenerateBeacon: RR System Information Type 6 CI=10 LAI=(MCC=001 MNC=01 LAC=0x3e8) cellOptions=(PWRC=0 DTX=2 RADIO_LINK_TIMEOUT=15) NCCPermitted=(0x1)
Mar 17 09:47:11 bt OpenBTS: DEBUG 3074303696 GSMConfig.cpp:130:regenerateBeacon: mSI6Frame primitive=UNIT_DATA raw=(061e000a00f11003e82f01)

root at bt:/var/log# tail -f debug
Mar 17 09:48:27 bt openbts: DEBUG 3046034288 GSML1FEC.cpp:277:resync: obj: 0x859f150 L1Encoder next=6:1493973 now=0:1493973 delta=0
Mar 17 09:48:27 bt openbts: DEBUG 3053755248 GSMLogicalChannel.cpp:243:serviceLoop: obj: 0x85872c0 SACCH sleeping
Mar 17 09:48:27 bt openbts: DEBUG 3046300528 GSMLogicalChannel.cpp:243:serviceLoop: obj: 0x85a37a0 SACCH sleeping
Mar 17 09:48:27 bt openbts: DEBUG 3064671088 GSML1FEC.cpp:943:generate: obj: 0x8560060 SCHL1Encoder 0:1493984
Mar 17 09:48:27 bt openbts: DEBUG 3064671088 TRXManager.cpp:181:writeHighSide: transmit at time 0:1493974: time=0:1493984 data=(0000011011110000110001010111101011100000101011100101100010000001000000111100101101010001010111011000011011011001001111110000001101000110101110011000)
Mar 17 09:48:27 bt openbts: DEBUG 3064671088 GSML1FEC.cpp:277:resync: obj: 0x8560060 L1Encoder next=0:1493995 now=0:1493974 delta=21
Mar 17 09:48:27 bt openbts: DEBUG 3064671088 GSML1FEC.cpp:943:generate: obj: 0x8560060 SCHL1Encoder 0:1493995
Mar 17 09:48:27 bt openbts: DEBUG 3064671088 TRXManager.cpp:181:writeHighSide: transmit at time 0:1493984: time=0:1493995 data=(0000011011110000110001010111101011100111101011100101100010000001000000111100101101010001010111011000011011100001000110010100101111001100000110000000)
Mar 17 09:48:27 bt openbts: DEBUG 3064671088 GSML1FEC.cpp:277:resync: obj: 0x8560060 L1Encoder next=0:1494005 now=0:1493984 delta=21
Mar 17 09:48:27 bt openbts: DEBUG 3051891568 GSMLogicalChannel.cpp:243:serviceLoop: obj: 0x8590a40 SACCH sleeping

root at bt:/var/log# cat debug | grep OpenBTS
Mar 17 09:47:11 bt OpenBTS: DEBUG 3074303696 GSMConfig.cpp:91:regenerateBeacon: mSI1Frame primitive=DATA raw=(5506198e000000000000000000000000000000e104002b)
Mar 17 09:47:11 bt OpenBTS: DEBUG 3074303696 GSMConfig.cpp:100:regenerateBeacon: mSI2Frame primitive=DATA raw=(59061a8e00000000000000000000000000000001e10400)
Mar 17 09:47:11 bt OpenBTS: DEBUG 3074303696 GSML3RRMessages.cpp:323:writeBody: primitive=UNIT_DATA raw=(061b554f9a21d5781da5b153bcad39af3152)
Mar 17 09:47:11 bt OpenBTS: DEBUG 3074303696 GSML3RRMessages.cpp:325:writeBody: primitive=UNIT_DATA raw=(061b000a9a21d5781da5b153bcad39af3152)
Mar 17 09:47:11 bt OpenBTS: DEBUG 3074303696 GSML3RRMessages.cpp:327:writeBody: primitive=UNIT_DATA raw=(061b000a00f11003e8a5b153bcad39af3152)
Mar 17 09:47:11 bt OpenBTS: DEBUG 3074303696 GSML3RRMessages.cpp:329:writeBody: primitive=UNIT_DATA raw=(061b000a00f11003e8510005bcad39af3152)
Mar 17 09:47:11 bt OpenBTS: DEBUG 3074303696 GSML3RRMessages.cpp:331:writeBody: primitive=UNIT_DATA raw=(061b000a00f11003e85100052fad39af3152)
tail -f messages

oot at bt:/var/log# tail -f messages
Mar 17 09:48:05 bt openbts: INFO 3043371888 TRXManager.cpp:274:sendCommandPacket: response RSP SETPOWER 0 6
Mar 17 09:48:11 bt openbts: INFO 3043371888 PowerManager.cpp:49:increasePower: power increased to -5 dB
Mar 17 09:48:11 bt openbts: INFO 3043371888 TRXManager.cpp:260:sendCommandPacket: command CMD SETPOWER 5
Mar 17 09:48:11 bt openbts: INFO 3043371888 TRXManager.cpp:274:sendCommandPacket: response RSP SETPOWER 0 5
Mar 17 09:48:17 bt openbts: INFO 3043371888 PowerManager.cpp:49:increasePower: power increased to -4 dB
Mar 17 09:48:17 bt openbts: INFO 3043371888 TRXManager.cpp:260:sendCommandPacket: command CMD SETPOWER 4
Mar 17 09:48:17 bt openbts: INFO 3043371888 TRXManager.cpp:274:sendCommandPacket: response RSP SETPOWER 0 4
Mar 17 09:48:23 bt openbts: INFO 3043371888 PowerManager.cpp:49:increasePower: power increased to -3 dB
Mar 17 09:48:23 bt openbts: INFO 3043371888 TRXManager.cpp:260:sendCommandPacket: command CMD SETPOWER 3
Mar 17 09:48:23 bt openbts: INFO 3043371888 TRXManager.cpp:274:sendCommandPacket: response RSP SETPOWER 0 3

root at bt:/var/log# tail -f user.log
Mar 17 09:47:11 bt OpenBTS: DEBUG 3074303696 GSML3RRMessages.cpp:333:writeBody: primitive=UNIT_DATA raw=(061b000a00f11003e85100052f6040af3152)
Mar 17 09:47:11 bt OpenBTS: DEBUG 3074303696 GSML3RRMessages.cpp:335:writeBody: primitive=UNIT_DATA raw=(061b000a00f11003e85100052f6040e10400)
Mar 17 09:47:11 bt OpenBTS: DEBUG 3074303696 GSML3RRMessages.cpp:337:writeBody: primitive=UNIT_DATA raw=(061b000a00f11003e85100052f6040e10400)
Mar 17 09:47:11 bt OpenBTS: DEBUG 3074303696 GSMConfig.cpp:109:regenerateBeacon: mSI3Frame primitive=DATA raw=(49061b000a00f11003e85100052f6040e104002b2b2b2b)
Mar 17 09:47:11 bt OpenBTS: INFO 3074303696 GSMConfig.cpp:113:regenerateBeacon: RR System Information Type 4 LAI=(MCC=001 MNC=01 LAC=0x3e8) cellSelectionParameters=(CELL-RESELECT-HYSTERESIS=3 MS-TXPWR-MAX-CCH=0 ACS=0 NECI=1 RXLEV-ACCESS-MIN=0) RACHControlParameters=(maxRetrans=3 txInteger=8 cellBarAccess=0 RE=1 AC=0x400)
Mar 17 09:47:11 bt OpenBTS: DEBUG 3074303696 GSMConfig.cpp:118:regenerateBeacon: mSI4Frame primitive=DATA raw=(31061c00f11003e86040e104002b2b2b2b2b2b2b2b2b2b)
Mar 17 09:47:11 bt OpenBTS: INFO 3074303696 GSMConfig.cpp:122:regenerateBeacon: RR System Information Type 5 BCCHFrequencyList=(EXT-IND=0 BA-IND=0  ARFCNs=(0 ))
Mar 17 09:47:11 bt OpenBTS: DEBUG 3074303696 GSMConfig.cpp:124:regenerateBeacon: mSI5Frame primitive=UNIT_DATA raw=(061d8e000000000000000000000000000000)
Mar 17 09:47:11 bt OpenBTS: INFO 3074303696 GSMConfig.cpp:128:regenerateBeacon: RR System Information Type 6 CI=10 LAI=(MCC=001 MNC=01 LAC=0x3e8) cellOptions=(PWRC=0 DTX=2 RADIO_LINK_TIMEOUT=15) NCCPermitted=(0x1)
Mar 17 09:47:11 bt OpenBTS: DEBUG 3074303696 GSMConfig.cpp:130:regenerateBeacon: mSI6Frame primitive=UNIT_DATA raw=(061e000a00f11003e82f01)

root at bt:/var/log# tail -f debug
Mar 17 09:48:27 bt openbts: DEBUG 3046034288 GSML1FEC.cpp:277:resync: obj: 0x859f150 L1Encoder next=6:1493973 now=0:1493973 delta=0
Mar 17 09:48:27 bt openbts: DEBUG 3053755248 GSMLogicalChannel.cpp:243:serviceLoop: obj: 0x85872c0 SACCH sleeping
Mar 17 09:48:27 bt openbts: DEBUG 3046300528 GSMLogicalChannel.cpp:243:serviceLoop: obj: 0x85a37a0 SACCH sleeping
Mar 17 09:48:27 bt openbts: DEBUG 3064671088 GSML1FEC.cpp:943:generate: obj: 0x8560060 SCHL1Encoder 0:1493984
Mar 17 09:48:27 bt openbts: DEBUG 3064671088 TRXManager.cpp:181:writeHighSide: transmit at time 0:1493974: time=0:1493984 data=(0000011011110000110001010111101011100000101011100101100010000001000000111100101101010001010111011000011011011001001111110000001101000110101110011000)
Mar 17 09:48:27 bt openbts: DEBUG 3064671088 GSML1FEC.cpp:277:resync: obj: 0x8560060 L1Encoder next=0:1493995 now=0:1493974 delta=21
Mar 17 09:48:27 bt openbts: DEBUG 3064671088 GSML1FEC.cpp:943:generate: obj: 0x8560060 SCHL1Encoder 0:1493995
Mar 17 09:48:27 bt openbts: DEBUG 3064671088 TRXManager.cpp:181:writeHighSide: transmit at time 0:1493984: time=0:1493995 data=(0000011011110000110001010111101011100111101011100101100010000001000000111100101101010001010111011000011011100001000110010100101111001100000110000000)
Mar 17 09:48:27 bt openbts: DEBUG 3064671088 GSML1FEC.cpp:277:resync: obj: 0x8560060 L1Encoder next=0:1494005 now=0:1493984 delta=21
Mar 17 09:48:27 bt openbts: DEBUG 3051891568 GSMLogicalChannel.cpp:243:serviceLoop: obj: 0x8590a40 SACCH sleeping

root at bt:/var/log# cat debug | grep OpenBTS
Mar 17 09:47:11 bt OpenBTS: DEBUG 3074303696 GSMConfig.cpp:91:regenerateBeacon: mSI1Frame primitive=DATA raw=(5506198e000000000000000000000000000000e104002b)
Mar 17 09:47:11 bt OpenBTS: DEBUG 3074303696 GSMConfig.cpp:100:regenerateBeacon: mSI2Frame primitive=DATA raw=(59061a8e00000000000000000000000000000001e10400)
Mar 17 09:47:11 bt OpenBTS: DEBUG 3074303696 GSML3RRMessages.cpp:323:writeBody: primitive=UNIT_DATA raw=(061b554f9a21d5781da5b153bcad39af3152)
Mar 17 09:47:11 bt OpenBTS: DEBUG 3074303696 GSML3RRMessages.cpp:325:writeBody: primitive=UNIT_DATA raw=(061b000a9a21d5781da5b153bcad39af3152)
Mar 17 09:47:11 bt OpenBTS: DEBUG 3074303696 GSML3RRMessages.cpp:327:writeBody: primitive=UNIT_DATA raw=(061b000a00f11003e8a5b153bcad39af3152)
Mar 17 09:47:11 bt OpenBTS: DEBUG 3074303696 GSML3RRMessages.cpp:329:writeBody: primitive=UNIT_DATA raw=(061b000a00f11003e8510005bcad39af3152)
Mar 17 09:47:11 bt OpenBTS: DEBUG 3074303696 GSML3RRMessages.cpp:331:writeBody: primitive=UNIT_DATA raw=(061b000a00f11003e85100052fad39af3152)
Mar 17 09:47:11 bt OpenBTS: DEBUG 3074303696 GSML3RRMessages.cpp:333:writeBody: primitive=UNIT_DATA raw=(061b000a00f11003e85100052f6040af3152)
Mar 17 09:47:11 bt OpenBTS: DEBUG 3074303696 GSML3RRMessages.cpp:335:writeBody: primitive=UNIT_DATA raw=(061b000a00f11003e85100052f6040e10400)
Mar 17 09:47:11 bt OpenBTS: DEBUG 3074303696 GSML3RRMessages.cpp:337:writeBody: primitive=UNIT_DATA raw=(061b000a00f11003e85100052f6040e10400)
Mar 17 09:47:11 bt OpenBTS: DEBUG 3074303696 GSMConfig.cpp:109:regenerateBeacon: mSI3Frame primitive=DATA raw=(49061b000a00f11003e85100052f6040e104002b2b2b2b)
Mar 17 09:47:11 bt OpenBTS: DEBUG 3074303696 GSMConfig.cpp:118:regenerateBeacon: mSI4Frame primitive=DATA raw=(31061c00f11003e86040e104002b2b2b2b2b2b2b2b2b2b)
Mar 17 09:47:11 bt OpenBTS: DEBUG 3074303696 GSMConfig.cpp:124:regenerateBeacon: mSI5Frame primitive=UNIT_DATA raw=(061d8e000000000000000000000000000000)
Mar 17 09:47:11 bt OpenBTS: DEBUG 3074303696 GSMConfig.cpp:130:regenerateBeacon: mSI6Frame primitive=UNIT_DATA raw=(061e000a00f11003e82f01)

Mar 17 11:37:51 bt OpenBTS: DEBUG 3074131664 GSMConfig.cpp:124:regenerateBeacon: mSI5Frame primitive=UNIT_DATA raw=(061d8e000000000000000000000000000000)
Mar 17 11:37:51 bt OpenBTS: INFO 3074131664 GSMConfig.cpp:128:regenerateBeacon: RR System Information Type 6 CI=10 LAI=(MCC=001 MNC=01 LAC=0x3e8) cellOptions=(PWRC=0 DTX=2 RADIO_LINK_TIMEOUT=15) NCCPermitted=(0x1)
Mar 17 11:37:51 bt OpenBTS: DEBUG 3074131664 GSMConfig.cpp:130:regenerateBeacon: mSI6Frame primitive=UNIT_DATA raw=(061e000a00f11003e82f01)
Mar 17 11:37:51 bt openbts: ALERT 3074131664 OpenBTS.cpp:310:main: OpenBTS starting, ver P2.8TRUNK build date Feb 26 2013
Mar 17 11:37:51 bt openbts: INFO 3074131664 OpenBTS.cpp:324:main: checking transceiver
Mar 17 11:37:56 bt openbts: NOTICE 3073956720 OpenBTS.cpp:121:startTransceiver: starting transceiver ./transceiver 1
Mar 17 11:38:01 bt openbts: INFO 3074131664 OpenBTS.cpp:362:main: tuning TRX 0 to ARFCN 650
Mar 17 11:38:01 bt openbts: INFO 3074131664 OpenBTS.cpp:504:main: system ready

Mar 15 10:36:29 bt sipauthserve: opening configuration table from path /etc/OpenBTS/sipauthserve.db
Mar 15 10:36:29 bt sipauthserve: ALERT 3073963728 sipauthserve.cpp:214:main: /root/openBts/public/subscriberRegistry/trunk/sipauthserve (re)starting
Mar 15 19:21:36 bt sipauthserve: opening configuration table from path /etc/OpenBTS/sipauthserve.db
Mar 15 19:21:36 bt sipauthserve: ALERT 3074111184 sipauthserve.cpp:214:main: /root/openBts/public/subscriberRegistry/trunk/sipauthserve (re)starting
Mar 15 19:36:46 bt sipauthserve: opening configuration table from path /etc/OpenBTS/sipauthserve.db
Mar 15 19:36:46 bt sipauthserve: ALERT 3074221776 sipauthserve.cpp:214:main: ./sipauthserve (re)starting
Mar 15 22:00:43 bt sipauthserve: opening configuration table from path /etc/OpenBTS/sipauthserve.db
Mar 15 22:00:43 bt sipauthserve: ALERT 3074447056 sipauthserve.cpp:214:main: ./sipauthserve (re)starting
Mar 15 22:06:50 bt sipauthserve: opening configuration table from path /etc/OpenBTS/sipauthserve.db
Mar 15 22:06:50 bt sipauthserve: ALERT 3073894096 sipauthserve.cpp:214:main: ./sipauthserve (re)starting
Mar 15 22:11:12 bt sipauthserve: opening configuration table from path /etc/OpenBTS/sipauthserve.db
Mar 15 22:11:12 bt sipauthserve: ALERT 3073648336 sipauthserve.cpp:214:main: ./sipauthserve (re)starting
Mar 15 22:15:52 bt sipauthserve: opening configuration table from path /etc/OpenBTS/sipauthserve.db
Mar 15 22:15:52 bt sipauthserve: ALERT 3074062032 sipauthserve.cpp:214:main: ./sipauthserve (re)starting
Mar 16 11:04:18 bt sipauthserve: opening configuration table from path /etc/OpenBTS/sipauthserve.db
Mar 16 11:04:18 bt sipauthserve: ALERT 3074668240 sipauthserve.cpp:214:main: /root/openBts/public/subscriberRegistry/trunk/sipauthserve (re)starting
Mar 16 13:02:47 bt sipauthserve: opening configuration table from path /etc/OpenBTS/sipauthserve.db
Mar 16 13:02:47 bt sipauthserve: ALERT 3073836752 sipauthserve.cpp:214:main: /root/openBts/public/subscriberRegistry/trunk/sipauthserve (re)starting
Mar 16 13:08:59 bt sipauthserve: opening configuration table from path /etc/OpenBTS/sipauthserve.db
Mar 16 13:08:59 bt sipauthserve: ALERT 3074381520 sipauthserve.cpp:214:main: /root/openBts/public/subscriberRegistry/trunk/sipauthserve (re)starting
Mar 17 09:40:38 bt sipauthserve: opening configuration table from path /etc/OpenBTS/sipauthserve.db
Mar 17 09:40:38 bt sipauthserve: ALERT 3073799888 sipauthserve.cpp:214:main: /root/openBts/public/subscriberRegistry/trunk/sipauthserve (re)starting
Mar 17 09:47:10 bt sipauthserve: opening configuration table from path /etc/OpenBTS/sipauthserve.db
Mar 17 09:47:10 bt sipauthserve: ALERT 3074336464 sipauthserve.cpp:214:main: /root/openBts/public/subscriberRegistry/trunk/sipauthserve (re)starting
Mar 17 11:37:51 bt sipauthserve: opening configuration table from path /etc/OpenBTS/sipauthserve.db
Mar 17 11:37:51 bt sipauthserve: ALERT 3073787600 sipauthserve.cpp:214:main: /root/openBts/public/subscriberRegistry/trunk/sipauthserve (re)starting
Mar 17 11:37:51 bt sipauthserve: INFO 3073787600 SubscriberRegistry.cpp:275:getCLIDLocal: getCLIDLocal(IMSI001010000000000)
Mar 17 11:37:51 bt sipauthserve: INFO 3073787600 SubscriberRegistry.cpp:199:sqlLocal: select callerid from sip_buddies where name = "IMSI001010000000000"
Mar 17 11:37:51 bt sipauthserve: INFO 3073787600 SubscriberRegistry.cpp:239:sqlQuery: result = 2100
Mar 17 11:37:51 bt sipauthserve: NOTICE 3073787600 sipauthserve.cpp:241:main: binding on port 5064





________________________________
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.osmocom.org/pipermail/baseband-devel/attachments/20130317/c7825458/attachment.htm>


More information about the baseband-devel mailing list