From: voipas <vo...@gm...> - 2010-02-11 13:12:15
|
Hello, My OpenBTS version is 2.5.1Lacassine. I've two mob phones : Qtek S200 and Sony Ericsson P900. I've noticed that after ~29 secs of talking the call was dropped. Config is: OpenBTS> config Asterisk.IP: 127.0.0.1 Asterisk.Port: 5060 Control.FailedRegistrationWelcomeMessage: It's been fun. See you next year. Control.FailedRegistrationWelcomeShortCode: 666 Control.NormalRegistrationWelcomeMessage: Welcome to OpenBTS! Control.NormalRegistrationWelcomeShortCode: 0000 Control.OpenRegistration: 0 Control.OpenRegistrationWelcomeShortCode: 23 GSM.ARFCN: 513 GSM.AssignmentType: 1 GSM.BCC: 0 GSM.Band: 1800 GSM.CCD.ATT: 1 GSM.CCD.CCCH_CONF: 1 GSM.CI: 10 GSM.CS.CELL_RESELECT_HYSTERESIS: 7 GSM.CS.MS_TXPWR_MAX_CCH: 0 GSM.CS.RXLEV_ACCESS_MIN: 0 GSM.LAC: 666 GSM.LURejectCause: 0x04 GSM.MCC: 460 GSM.MNC: 02 GSM.MaxRACHDelay: 20 GSM.NCC: 0 GSM.NCCsPermitted: 1 GSM.Neighbors: 29 GSM.NumC1s: 5 GSM.NumC7s: 1 GSM.PowerAttenDB: 0 GSM.RACH.AC: 0 GSM.RACH.CellBarAccess: 0 GSM.RACH.MaxRetrans: 3 GSM.RACH.TxInteger: 14 GSM.RADIO_LINK_TIMEOUT: 15 GSM.ShortName: OpenBTS GSM.T3122Max: 255000 GSM.T3122Min: 2000 GSM.T3212: 6 LogLevel: INFO Messenger.IP: 127.0.0.1 Messenger.Port: 5063 PBX.Emergency: 2101 RTP.Range: 98 RTP.Start: 16484 SIP.IP: 127.0.0.1 SIP.Port: 5062 SIP.RegistrationPeriod: 3600 SIP.Timer.A: 1000 SMS.DefaultDestSMSC: 0000 SMS.FakeSrcSMSC: 0000 SMS.HTTP.AccessString: sendmsg?user=xxxx&password=xxxx&api_id=xxxx SMSLoopback.Port: 5064 TRX.IP: 127.0.0.1 TRX.LogLevel: NOTICE TRX.Path: ../Transceiver52M/transceiver TRX.Port: 5700 TestCall.Port: 28670 Wireshark.Port: 4729 The log: OpenBTS> 1265889540.8620 INFO 3074206608 RadioResource.cpp:152:AccessGrantResponder: RA=0xf9 when=0:129819 age=24 TOA=1.0000 1265889540.8621 INFO 3074206608 GSMLogicalChannel.cpp:42:open: 1265889540.8622 INFO 3074206608 GSMLogicalChannel.cpp:42:open: 1265889540.8625 INFO 3074206608 RadioResource.cpp:207:AccessGrantResponder: sending PageMode=(0) DedicatedModeOrTBF=(TMA=0 Downlink=0 DMOrTBF=0) ChannelDescription=(typeAndOffset=SDCCH/4-0 TN=0 TSC=0 ARFCN=513) RequestReference=(RA=249 T1'=1 T2=1 T3=24) TimingAdvance=1 1265889541.1719 INFO 3072076688 GSML3Message.cpp:162:parseL3: L3 recv MM CM Service Request serviceType=MOC mobileIdentity=(TMSI=0x4b73ee61) 1265889541.1720 INFO 3072076688 MobilityManagement.cpp:59:CMServiceResponder: MM CM Service Request serviceType=MOC mobileIdentity=(TMSI=0x4b73ee61) 1265889541.1722 INFO 3072076688 CallControl.cpp:569:MOCStarter: MOC: MM CM Service Request serviceType=MOC mobileIdentity=(TMSI=0x4b73ee61) 1265889541.1723 INFO 3072076688 GSMLogicalChannel.cpp:42:open: 1265889541.1723 INFO 3072076688 GSMLogicalChannel.cpp:42:open: 1265889541.1724 INFO 3072076688 GSMLogicalChannel.cpp:76:send: L3 SAP0 sending MM CM Service Accept 1265889541.8781 INFO 3072076688 GSML3Message.cpp:162:parseL3: L3 recv CC Setup TI=(0,0) CalledPartyBCDNumber=(type=unknown plan=E.164/ISDN digits=33333333921) 1265889541.8782 INFO 3072076688 CallControl.cpp:609:MOCStarter: MOC: CC Setup TI=(0,0) CalledPartyBCDNumber=(type=unknown plan=E.164/ISDN digits=33333333921) 1265889541.8784 INFO 3072076688 ControlCommon.cpp:239:add: new transaction 1804289383 TI=(0,0) IMSI=460029179918532 MOC to=33333333921 Q.931State=MOC initiated SIPState=Null 1265889541.8786 INFO 3072076688 SIPEngine.cpp:226:MOCSendINVITE: SIP send INVITE IMSI460029179918532 1265889541.8786 INFO 3072076688 SIPInterface.cpp:107:addCall: creating SIP message FIFO callID 211078733 1265889541.8792 INFO 3072076688 SIPInterface.cpp:167:write: write INVITE sip:33333333921@127.0.0.1 <sip%3A33333333921@127.0.0.1> SIP/2.0 1265889541.8819 INFO 3074739088 SIPInterface.cpp:192:drive: read SIP/2.0 100 Trying 1265889541.8825 INFO 3074739088 SIPInterface.cpp:192:drive: read INVITE sip:IMSI460020148034588@127.0.0.1:5062 SIP/2.0 1265889541.8830 INFO 3074739088 SIPInterface.cpp:288:checkInvite: set up MTC paging for channel=TCH/F 1265889541.8831 INFO 3074739088 SIPInterface.cpp:303:checkInvite: INVITE to IMSI460020148034588 1265889541.8832 INFO 3074739088 SIPInterface.cpp:107:addCall: creating SIP message FIFO callID 789cba7063517465127b5b7d20f85c79 1265889541.8832 INFO 3074739088 SIPInterface.cpp:334:checkInvite: make new transaction 1265889541.8836 INFO 3074739088 ControlCommon.cpp:239:add: new transaction 1804289385 TI=(1,0) IMSI=460020148034588 MTC from=33333333920 Q.931State=MTC paging SIPState=Null 1265889541.8837 INFO 3074739088 RadioResource.cpp:343:addID: IMSI=460020148034588 added to table 1265889541.8839 INFO 3043589008 RadioResource.cpp:389:pageAll: paging 1 mobile(s) 1265889541.8857 INFO 3072076688 GSMLogicalChannel.cpp:42:open: 1265889541.8858 INFO 3072076688 GSMLogicalChannel.cpp:42:open: 1265889541.8859 INFO 3072076688 CallControl.cpp:178:assignTCHF: sending AssignmentCommand for 0x9aa8048 on 0xbfebe410 1265889541.8861 INFO 3072076688 GSMLogicalChannel.cpp:76:send: L3 SAP0 sending RR Assignment Command channelDescription=(typeAndOffset=TCH/F TN=2 TSC=0 ARFCN=513) powerCommand=0 mode1=speech1 1265889542.2730 INFO 3074206608 RadioResource.cpp:152:AccessGrantResponder: RA=0x2a when=0:130125 age=24 TOA=1.0000 1265889542.2731 INFO 3074206608 GSMLogicalChannel.cpp:42:open: 1265889542.2732 INFO 3074206608 GSMLogicalChannel.cpp:42:open: 1265889542.2732 INFO 3074206608 RadioResource.cpp:207:AccessGrantResponder: sending PageMode=(0) DedicatedModeOrTBF=(TMA=0 Downlink=0 DMOrTBF=0) ChannelDescription=(typeAndOffset=TCH/F TN=3 TSC=0 ARFCN=513) RequestReference=(RA=42 T1'=2 T2=21 T3=24) TimingAdvance=1 1265889542.3548 INFO 3043589008 RadioResource.cpp:389:pageAll: paging 1 mobile(s) 1265889542.5108 INFO 3051043728 GSML3Message.cpp:162:parseL3: L3 recv RR Paging Response mobileID=(IMSI=460020148034588) 1265889542.5110 INFO 3051043728 RadioResource.cpp:222:PagingResponseHandler: RR Paging Response mobileID=(IMSI=460020148034588) 1265889542.5111 INFO 3051043728 RadioResource.cpp:353:removeID: IMSI=460020148034588 1265889542.5113 INFO 3051043728 CallControl.cpp:826:MTCStarter: MTC on FACCH transaction: 1804289385 TI=(1,0) IMSI=460020148034588 MTC from=33333333920 Q.931State=MTC paging SIPState=Null 1265889542.5114 INFO 3051043728 CallControl.cpp:851:MTCStarter: MTC: sending GSM Setup to call type=national plan=E.164/ISDN digits=33333333920 1265889542.5115 INFO 3051043728 GSMLogicalChannel.cpp:76:send: L3 SAP0 sending CC Setup TI=(0,0) CallingPartyBCDNumber=(type=national plan=E.164/ISDN digits=33333333920) 1265889542.5116 INFO 3051043728 SIPEngine.cpp:474:MTCSendTrying: SIP send Trying IMSI460020148034588 1265889542.5120 INFO 3051043728 SIPInterface.cpp:167:write: write SIP/2.0 100 Trying 1265889542.5886 INFO 3052907408 GSML3Message.cpp:162:parseL3: L3 recv RR Assignment Complete cause=0x0 1265889542.5888 INFO 3052907408 RadioResource.cpp:298:AssignmentCompleteHandler: service=MOC 1265889542.5889 INFO 3052907408 CallControl.cpp:699:MOCController: MOC: transaction: 1804289383 TI=(0,0) IMSI=460029179918532 MOC to=33333333921 Q.931State=MOC initiated SIPState=Starting 1265889542.5890 INFO 3052907408 GSMLogicalChannel.cpp:76:send: L3 SAP0 sending CC Call Proceeding TI=(1,0) 1265889542.5891 INFO 3052907408 CallControl.cpp:718:MOCController: MOC A: wait for Ringing or OK 1265889542.5893 INFO 3052907408 GSMLogicalChannel.cpp:76:send: L3 SAP0 sending CC 0x3 TI=(1,0) prog_ind=(location=1 progress=0x0) 1265889542.8112 INFO 3051043728 GSML3Message.cpp:162:parseL3: L3 recv CC Call Confirmed TI=(0,0) 1265889542.8114 INFO 3051043728 CallControl.cpp:254:callManagementDispatchGSM: GSM Call Confirmed IMSI=460020148034588 1265889542.8115 INFO 3051043728 SIPEngine.cpp:554:MTCWaitForACK: received sip_method=INVITE 1265889542.8116 NOTICE 3051043728 SIPEngine.cpp:558:MTCWaitForACK: received duplicate INVITE 1265889542.8117 INFO 3051043728 GSMLogicalChannel.cpp:76:send: L3 SAP0 sending RR Channel Mode Modify description=(typeAndOffset=TCH/F TN=3 TSC=0 ARFCN=513) mode=(speech1) 1265889542.8258 INFO 3043589008 RadioResource.cpp:389:pageAll: paging 0 mobile(s) 1265889542.8288 INFO 3052907408 CallControl.cpp:718:MOCController: MOC A: wait for Ringing or OK 1265889543.1899 INFO 3051043728 GSML3Message.cpp:162:parseL3: L3 recv RR Channel Mode Modify Acknowledge description=(typeAndOffset=TCH/F TN=3 TSC=0 ARFCN=513) mode=(speech1) 1265889543.1901 INFO 3051043728 CallControl.cpp:922:MTCController: MTC:: waiting for GSM Alerting and Connect 1265889543.5724 INFO 3051043728 GSML3Message.cpp:162:parseL3: L3 recv CC Alerting TI=(0,0) 1265889543.5725 INFO 3051043728 CallControl.cpp:265:callManagementDispatchGSM: GSM Alerting IMSI=460020148034588 1265889543.5727 INFO 3051043728 SIPEngine.cpp:487:MTCSendRinging: SIP send Ringing IMSI460020148034588 1265889543.5730 INFO 3051043728 SIPInterface.cpp:167:write: write SIP/2.0 180 Ringing 1265889543.5741 INFO 3074739088 SIPInterface.cpp:192:drive: read SIP/2.0 180 Ringing 1265889543.5746 INFO 3052907408 CallControl.cpp:729:MOCController: MOC A: SIP:Ringing, send Alerting and move on 1265889543.5747 INFO 3052907408 GSMLogicalChannel.cpp:76:send: L3 SAP0 sending CC Alerting TI=(1,0) 1265889543.5748 INFO 3052907408 CallControl.cpp:759:MOCController: MOC: wait for SIP OKAY 1265889544.5761 NOTICE 3051043728 SIPEngine.cpp:537:MTCWaitForACK: timeout 1265889545.5764 INFO 3051043728 SIPEngine.cpp:487:MTCSendRinging: SIP send Ringing IMSI460020148034588 1265889545.5769 INFO 3051043728 SIPInterface.cpp:167:write: write SIP/2.0 180 Ringing 1265889546.5775 NOTICE 3051043728 SIPEngine.cpp:537:MTCWaitForACK: timeout 1265889546.9374 INFO 3072076688 CallControl.cpp:185:assignTCHF: completing normally 1265889547.5778 INFO 3051043728 SIPEngine.cpp:487:MTCSendRinging: SIP send Ringing IMSI460020148034588 1265889547.5783 INFO 3051043728 SIPInterface.cpp:167:write: write SIP/2.0 180 Ringing 1265889548.5790 NOTICE 3051043728 SIPEngine.cpp:537:MTCWaitForACK: timeout 1265889549.5792 INFO 3051043728 SIPEngine.cpp:487:MTCSendRinging: SIP send Ringing IMSI460020148034588 1265889549.5797 INFO 3051043728 SIPInterface.cpp:167:write: write SIP/2.0 180 Ringing 1265889550.5804 NOTICE 3051043728 SIPEngine.cpp:537:MTCWaitForACK: timeout 1265889551.5806 INFO 3051043728 SIPEngine.cpp:487:MTCSendRinging: SIP send Ringing IMSI460020148034588 1265889551.5811 INFO 3051043728 SIPInterface.cpp:167:write: write SIP/2.0 180 Ringing 1265889552.5817 NOTICE 3051043728 SIPEngine.cpp:537:MTCWaitForACK: timeout 1265889553.5820 INFO 3051043728 SIPEngine.cpp:487:MTCSendRinging: SIP send Ringing IMSI460020148034588 1265889553.5825 INFO 3051043728 SIPInterface.cpp:167:write: write SIP/2.0 180 Ringing 1265889554.5831 NOTICE 3051043728 SIPEngine.cpp:537:MTCWaitForACK: timeout 1265889554.5833 INFO 3051043728 GSML3Message.cpp:162:parseL3: L3 recv CC Connect TI=(0,0) 1265889554.5834 INFO 3051043728 CallControl.cpp:243:callManagementDispatchGSM: GSM Connect IMSI=460020148034588 1265889554.5835 INFO 3051043728 CallControl.cpp:937:MTCController: MTC:: allocating port and sending SIP OKAY 1265889554.5836 INFO 3051043728 SIPEngine.cpp:513:MTCSendOK: SIP send INVITE-OK IMSI460020148034588 1265889554.5841 INFO 3051043728 SIPInterface.cpp:167:write: write SIP/2.0 200 OK 1265889554.5857 INFO 3074739088 SIPInterface.cpp:192:drive: read ACK sip:IMSI460020148034588@127.0.0.1:5062 SIP/2.0 1265889554.5860 INFO 3074739088 SIPInterface.cpp:192:drive: read SIP/2.0 200 OK 1265889554.5872 INFO 3052907408 CallControl.cpp:796:MOCController: MOC: sending Connect to handset 1265889554.5873 INFO 3052907408 GSMLogicalChannel.cpp:76:send: L3 SAP0 sending CC Connect TI=(1,0) 1265889554.5888 INFO 3052907408 SIPEngine.cpp:333:MOCSendACK: SIP send Ack IMSI460029179918532 1265889554.5892 INFO 3052907408 SIPInterface.cpp:167:write: write ACK sip:33333333921@127.0.0.1 <sip%3A33333333921@127.0.0.1> SIP/2.0 1265889554.5898 INFO 3051043728 SIPEngine.cpp:554:MTCWaitForACK: received sip_method=ACK 1265889554.5899 INFO 3051043728 SIPEngine.cpp:562:MTCWaitForACK: received ACK 1265889554.5907 INFO 3051043728 GSMLogicalChannel.cpp:76:send: L3 SAP0 sending CC Connect Acknowledge TI=(0,0) 1265889554.5909 INFO 3051043728 CallControl.cpp:550:callManagementLoop: MOC MTC connected, IMSI=460020148034588 entering callManagementLoop 1265889554.8105 INFO 3052907408 GSML3Message.cpp:162:parseL3: L3 recv CC Connect Acknowledge TI=(0,0) 1265889554.8107 INFO 3052907408 CallControl.cpp:233:callManagementDispatchGSM: GSM Connect Acknowledge IMSI=460029179918532 1265889554.8108 INFO 3052907408 CallControl.cpp:550:callManagementLoop: MOC MTC connected, IMSI=460029179918532 entering callManagementLoop 1265889576.6317 INFO 3074206608 RadioResource.cpp:152:AccessGrantResponder: RA=0xd6 when=0:137569 age=25 TOA=1.0000 1265889576.6319 NOTICE 3074206608 RadioResource.cpp:173:AccessGrantResponder: RACH burst for unsupported service 1265889576.6320 INFO 3074206608 GSMLogicalChannel.cpp:42:open: 1265889576.6320 INFO 3074206608 GSMLogicalChannel.cpp:42:open: 1265889576.6323 INFO 3074206608 RadioResource.cpp:207:AccessGrantResponder: sending PageMode=(0) DedicatedModeOrTBF=(TMA=0 Downlink=0 DMOrTBF=0) ChannelDescription=(typeAndOffset=SDCCH/4-0 TN=0 TSC=0 ARFCN=513) RequestReference=(RA=214 T1'=7 T2=3 T3=22) TimingAdvance=1 1265889576.9508 WARNING 3072076688 GSML3MMMessages.cpp:92:L3MMFactory: no L3 MM factory support for message CM Re-establishment Request 1265889576.9509 NOTICE 3072076688 ControlCommon.cpp:479:getMessage: unparsed message 1265889576.9511 NOTICE 3072076688 DCCHDispatch.cpp:150:DCCHDispatcher: UnsupportedMessage 1265889576.9512 INFO 3072076688 GSMLogicalChannel.cpp:76:send: L3 SAP0 sending RR Channel Release cause=0x61 1265889583.1460 INFO 3051043728 CallControl.cpp:115:forceSIPClearing: SIP state Active 1265889583.1462 INFO 3051043728 SIPEngine.cpp:375:MODSendBYE: SIP send BYE IMSI460020148034588 1265889583.1465 INFO 3051043728 SIPInterface.cpp:167:write: write BYE sip:33333333920@127.0.0.1 <sip%3A33333333920@127.0.0.1> SIP/2.0 1265889583.1487 INFO 3074739088 SIPInterface.cpp:192:drive: read SIP/2.0 200 OK 1265889583.1497 INFO 3074739088 SIPInterface.cpp:192:drive: read BYE sip:IMSI460029179918532@127.0.0.1:5062 SIP/2.0 1265889583.1501 INFO 3051043728 SIPInterface.cpp:114:removeCall: removing SIP message FIFO callID 789cba7063517465127b5b7d20f85c79 1265889583.1502 INFO 3051043728 SIPInterface.cpp:114:removeCall: removing SIP message FIFO callID 789cba7063517465127b5b7d20f85c79 1265889583.1666 INFO 3052907408 GSMLogicalChannel.cpp:76:send: L3 SAP0 sending CC Disconnect TI=(1,0) cause=(location=1 cause=0x10) 1265889583.3897 INFO 3052907408 GSML3Message.cpp:162:parseL3: L3 recv CC Release TI=(0,0) 1265889583.3898 INFO 3052907408 CallControl.cpp:293:callManagementDispatchGSM: GSM Release IMSI=460029179918532 1265889583.3899 INFO 3052907408 GSMLogicalChannel.cpp:76:send: L3 SAP0 sending CC Release Complete TI=(1,0) 1265889583.3900 INFO 3052907408 GSMLogicalChannel.cpp:76:send: L3 SAP0 sending RR Channel Release cause=0x0 1265889583.6293 INFO 3052907408 SIPEngine.cpp:459:MTDSendOK: SIP send BYE-OK IMSI460029179918532 1265889583.6298 INFO 3052907408 SIPInterface.cpp:167:write: write SIP/2.0 200 OK 1265889583.6303 INFO 3052907408 SIPInterface.cpp:114:removeCall: removing SIP message FIFO callID 211078733 I hope this helps you. -- Best Regards, Giedrius |