|
OK, I had a user report their first dropped call of the day. Details: Caller 4328 dials into auto attendant 4310, then goes through the motions to get to the helpdesk. Call is directed-pickup'd by extension 4467 dialing *794694 (I changed it to *79 a while back for testing, haven't changed it back to *78 yet). About 4 minutes later the calling user reports stuttered audio then the call drops. I've posted a couple lines of the sipxbridge.log log file that seem relevant and will post a bug with a debug snapshot if Ranga desires: "2009-11-16T19:42:49.785000Z":54354:OUTGOING:INFO:it2.ippbx.co.brazos.tx.us:Timer-1:00000000:sipXbridge:"Sent SIP Message :\n----Remote Host:10.200.24.251---- Port: 5060----\nSIP/2.0 200 OK\r\nFrom: \"CARRIE ALLEN\" <sip:[email protected]:5080;transport=UDP>;tag=2b7f6b0-0-13c4-16026f-399f8903-16026f\r\nTo: <sip:[email protected]:5080>;tag=506795695\r\nCall-ID: [email protected]\r\ncseq: 1 INVITE\r\nVia: SIP/2.0/UDP 10.200.24.251:5060;branch=z9hG4bK-16026f-55f98348-7554c3e2\r\nServer: sipXecs/4.0.2 sipXecs/sipxbridge (Linux)\r\nSupported: replaces\r\nContact: <sip:[email protected]:5080;transport=udp>\r\nContent-Type: application/sdp\r\nContent-Length: 252\r\n\r\nv=0\r\no=sipxbridge 7122649445887174313 2 IN IP4 10.200.24.250\r\ns=-\r\nc=IN IP4 10.200.24.250\r\nt=0 0\r\nm=audio 31500 RTP/AVP 0 101\r\na=rtpmap:0 PCMU/8000\r\na=silenceSupp:off - - - -\r\na=rtpmap:101 telephone-event/8000\r\na=fmtp:101 0-15\r\na=ptime:10\r\na=sendrecv\r\n--------------------END--------------------\n" "2009-11-16T19:42:58.791000Z":54355:JAVA:DEBUG:it2.ippbx.co.brazos.tx.us:Timer-1:00000000:SipListenerImpl:"DialogTerminatedEvent: dialog created at [SipUtilities.java:1833][DialogContext.java:340][DialogContext.java:398][BackToBackUserAgentFactory.java:129][CallControlManager.java:510][CallControlManager.java:2722][SipListenerImpl.java:325][EventScanner.java:223][SipProviderImpl.java:189][DialogFilter.java:1056][SIPServerTransaction.java:809][UDPMessageChannel.java:462][UDPMessageChannel.java:422][UDPMessageChannel.java:266][Thread.java:619]" "2009-11-16T19:42:58.792000Z":54356:JAVA:DEBUG:it2.ippbx.co.brazos.tx.us:Timer-1:00000000:SipListenerImpl:"DialogTerminatedEvent: dialog inserted at [SipUtilities.java:1833][DialogContext.java:993][BackToBackUserAgent.java:635][BackToBackUserAgent.java:1111][CallControlManager.java:572][CallControlManager.java:2722][SipListenerImpl.java:325][EventScanner.java:223][SipProviderImpl.java:189][DialogFilter.java:1056][SIPServerTransaction.java:809][UDPMessageChannel.java:462][UDPMessageChannel.java:422][UDPMessageChannel.java:266][Thread.java:619]" "2009-11-16T19:42:58.792000Z":54357:JAVA:DEBUG:it2.ippbx.co.brazos.tx.us:Timer-1:00000000:DialogContext:"cancelSessionTimer gov.nist.javax.sip.stack.sipdia...@28cc6a8" "2009-11-16T19:42:58.792000Z":54358:JAVA:DEBUG:it2.ippbx.co.brazos.tx.us:Timer-1:00000000:BackToBackUserAgent:"Remove Dialog gov.nist.javax.sip.stack.sipdia...@28cc6a8 Dialog table size = 1" "2009-11-16T19:43:05.991000Z":54359:JAVA:DEBUG:it2.ippbx.co.brazos.tx.us:Timer-0:00000000:CrLfTimerTask:"sending heartbeat to 10.200.24.251" "2009-11-16T19:43:05.992000Z":54360:JAVA:INFO:it2.ippbx.co.brazos.tx.us:Timer-0:00000000:sipXbridge:"[UDPMessageChannel.java:585][ListeningPointImpl.java:253][CrLfTimerTask.java:40][Timer.java:512][Timer.java:462]" "2009-11-16T19:43:06.795000Z":54361:JAVA:DEBUG:it2.ippbx.co.brazos.tx.us:Timer-0:00000000:BackToBackUserAgent:"tearing down gov.nist.javax.sip.stack.sipdia...@20ac2837 dialogState = Confirmed Dialog dialog.isServer false" "2009-11-16T19:43:06.797000Z":54362:JAVA:INFO:it2.ippbx.co.brazos.tx.us:Timer-0:00000000:sipXbridge:"[IOHandler.java:181][TCPMessageChannel.java:320][MessageChannel.java:249][SIPTransaction.java:733][SIPClientTransaction.java:473][SIPDialog.java:2021][SIPDialog.java:1842][BackToBackUserAgent.java:2229][BackToBackUserAgent.java:2169][BackToBackUserAgent.java:603][Timer.java:512][Timer.java:462]" "2009-11-16T19:43:06.797000Z":54363:OUTGOING:INFO:it2.ippbx.co.brazos.tx.us:Timer-0:00000000:sipXbridge:"Sent SIP Message :\n----Remote Host:10.200.24.250---- Port: 5060----\nBYE sip:[email protected]:15060;transport=udp;x-sipX-nonat SIP/2.0\r\nVia: SIP/2.0/TCP 10.200.24.240:5090;branch=z9hG4bKa34f1104a1c04a93e2a55952e60c5c39393737\r\nCSeq: 5 BYE\r\nFrom: \"CARRIE ALLEN\" <sip:[email protected]:5080;transport=UDP>;tag=2b7f6b0-0-13c4-16026f-399f8903-16026f\r\nTo: <sip:[email protected]>;tag=ByBa9Sta6D4mD\r\nCall-ID: [email protected]\r\nallow: INVITE,ACK,BYE,CANCEL,OPTIONS,PRACK,MESSAGE,SUBSCRIBE,NOTIFY,REFER,UPDATE,REGISTER,INFO\r\nSupported: timer,precondition,path,replaces\r\nDate: Mon, 16 Nov 2009 19:42:09 GMT\r\nMax-Forwards: 70\r\nRoute: <sip:10.200.24.250:5060;lr;sipXecs-rs=%2Aauth%7E.%2Afrom%7EMmI3ZjZiMC0wLTEzYzQtMTYwMjZmLTM5OWY4OTAzLTE2MDI2Zg%60%60.900_ntap%2Aid%7ENjc5OC0zNzQ%60%212677e17acb679001d4be29b35dcb7f5e;x-sipX-done>\r\nUser-Agent: sipXecs/4.0.2 sipXecs/sipxbridge (Linux)\r\nReason: ~~id~bridge;cause=212;text=\"Call Termination Detected\"\r\nContent-Length: 0\r\n\r\n--------------------END--------------------\n" "2009-11-16T19:43:06.801000Z":54364:INCOMING:INFO:it2.ippbx.co.brazos.tx.us:PipelineThread-12:00000000:sipXbridge:"Read SIP Message :\n----Remote Host:10.200.24.250---- Port: 5060----\nSIP/2.0 200 OK\r\nVia: SIP/2.0/TCP 10.200.24.240:5090;branch=z9hG4bKa34f1104a1c04a93e2a55952e60c5c39393737\r\nFrom: \"CARRIE ALLEN\" <sip:[email protected]:5080;transport=UDP>;tag=2b7f6b0-0-13c4-16026f-399f8903-16026f\r\nTo: <sip:[email protected]>;tag=ByBa9Sta6D4mD\r\nCall-ID: [email protected]\r\ncseq: 5 BYE\r\nUser-Agent: FreeSWITCH-mod_sofia/1.0.3-12163\r\nAllow: INVITE,ACK,BYE,CANCEL,OPTIONS,PRACK,MESSAGE,SUBSCRIBE,NOTIFY,REFER,UPDATE,REGISTER,INFO\r\nSupported: timer,precondition,path,replaces\r\nDate: Mon, 16 Nov 2009 19:43:06 GMT\r\nContent-Length: 0\r\n\r\n====================END====================\n" "2009-11-16T19:43:06.802000Z":54365:JAVA:DEBUG:it2.ippbx.co.brazos.tx.us:PipelineThread-12:00000000:ItspAccountInfo:"removeFailureCounter [email protected]" "2009-11-16T19:43:06.802000Z":54366:JAVA:DEBUG:it2.ippbx.co.brazos.tx.us:PipelineThread-12:00000000:CallControlManager:"CallControlManager: processByeResponse" "2009-11-16T19:43:14.799000Z":54367:JAVA:DEBUG:it2.ippbx.co.brazos.tx.us:Timer-1:00000000:SipListenerImpl:"DialogTerminatedEvent: dialog created at [SipUtilities.java:1833][DialogContext.java:340][DialogContext.java:398][BackToBackUserAgent.java:1254][CallControlManager.java:572][CallControlManager.java:2722][SipListenerImpl.java:325][EventScanner.java:223][SipProviderImpl.java:189][DialogFilter.java:1056][SIPServerTransaction.java:809][UDPMessageChannel.java:462][UDPMessageChannel.java:422][UDPMessageChannel.java:266][Thread.java:619]" "2009-11-16T19:43:14.800000Z":54368:JAVA:DEBUG:it2.ippbx.co.brazos.tx.us:Timer-1:00000000:SipListenerImpl:"DialogTerminatedEvent: dialog inserted at [SipUtilities.java:1833][DialogContext.java:993][BackToBackUserAgent.java:635][BackToBackUserAgent.java:1263][CallControlManager.java:572][CallControlManager.java:2722][SipListenerImpl.java:325][EventScanner.java:223][SipProviderImpl.java:189][DialogFilter.java:1056][SIPServerTransaction.java:809][UDPMessageChannel.java:462][UDPMessageChannel.java:422][UDPMessageChannel.java:266][Thread.java:619]" "2009-11-16T19:43:14.800000Z":54369:JAVA:DEBUG:it2.ippbx.co.brazos.tx.us:Timer-1:00000000:DialogContext:"cancelSessionTimer gov.nist.javax.sip.stack.sipdia...@20ac2837" "2009-11-16T19:43:14.800000Z":54370:JAVA:DEBUG:it2.ippbx.co.brazos.tx.us:Timer-1:00000000:BackToBackUserAgent:"Remove Dialog gov.nist.javax.sip.stack.sipdia...@20ac2837 Dialog table size = 0" "2009-11-16T19:43:15.802000Z":54371:JAVA:DEBUG:it2.ippbx.co.brazos.tx.us:Timer-0:00000000:BackToBackUserAgent:"Dialog table is empty -- tearing down bridge." "2009-11-16T19:43:15.803000Z":54372:JAVA:DEBUG:it2.ippbx.co.brazos.tx.us:Timer-0:00000000:sipxbridge:"destroyBridge bridge:1205888832295179421" "2009-11-16T19:43:25.993000Z":54373:JAVA:DEBUG:it2.ippbx.co.brazos.tx.us:Timer-0:00000000:CrLfTimerTask:"sending heartbeat to 10.200.24.251" "2009-11-16T19:43:25.993000Z":54374:JAVA:INFO:it2.ippbx.co.brazos.tx.us:Timer-0:00000000:sipXbridge:"[UDPMessageChannel.java:585][ListeningPointImpl.java:253][CrLfTimerTask.java:40][Timer.java:512][Timer.java:462]" "2009-11-16T19:43:26.308000Z":54375:INCOMING:INFO:it2.ippbx.co.brazos.tx.us:Thread-2631:00000000:sipXbridge:"Read SIP Message :\n----Remote Host:10.200.24.251---- Port: 5060----\nBYE sip:[email protected]:5080;transport=udp SIP/2.0\r\nFrom: \"CARRIE ALLEN\" <sip:[email protected]:5080;transport=UDP>;tag=2b7f6b0-0-13c4-16026f-399f8903-16026f\r\nTo: <sip:[email protected]:5080>;tag=506795695\r\nCall-ID: [email protected]\r\ncseq: 2 BYE\r\nVia: SIP/2.0/UDP 10.200.24.251:5060;branch=z9hG4bK-1602d7-55fb1a61-553a0f13\r\nMax-Forwards: 70\r\nSupported: 100rel,replaces\r\nAllow: ACK,BYE,CANCEL,INFO,INVITE,NOTIFY,OPTIONS,PRACK,REFER,REGISTER\r\nUser-Agent: ADTRAN_Total_Access_908e_2nd_Gen/A2.03.00.E\r\nContent-Length: 0\r\n\r\n====================END====================\n" "2009-11-16T19:43:26.309000Z":54376:JAVA:INFO:it2.ippbx.co.brazos.tx.us:Thread-2631:00000000:sipXbridge:"[UDPMessageChannel.java:585][SIPServerTransaction.java:479][SIPServerTransaction.java:1071][SIPServerTransaction.java:1380][DialogFilter.java:612][SIPServerTransaction.java:809][UDPMessageChannel.java:462][UDPMessageChannel.java:422][UDPMessageChannel.java:266][Thread.java:619]" "2009-11-16T19:43:26.309000Z":54377:OUTGOING:INFO:it2.ippbx.co.brazos.tx.us:Thread-2631:00000000:sipXbridge:"Sent SIP Message :\n----Remote Host:10.200.24.251---- Port: 5060----\nSIP/2.0 481 Dialog Not Found\r\nFrom: \"CARRIE ALLEN\" <sip:[email protected]:5080;transport=UDP>;tag=2b7f6b0-0-13c4-16026f-399f8903-16026f\r\nTo: <sip:[email protected]:5080>;tag=506795695\r\nCall-ID: [email protected]\r\ncseq: 2 BYE\r\nVia: SIP/2.0/UDP 10.200.24.251:5060;branch=z9hG4bK-1602d7-55fb1a61-553a0f13\r\nServer: sipXecs/4.0.2 sipXecs/sipxbridge (Linux)\r\nContent-Length: 0\r\n\r\n--------------------END--------------------\n" "2009-11-16T19:43:31.332000Z":54378:INCOMING:INFO:it2.ippbx.co.brazos.tx.us:Thread-2632:00000000:sipXbridge:"Read SIP Message :\n----Remote Host:10.200.24.250---- Port: 5060----\nBYE sip:[email protected]:5090 SIP/2.0\r\nVia: SIP/2.0/UDP 10.200.24.250;branch=z9hG4bK-sipXecs-76fc285f75e602c3b34072fc35a912d70088\r\nVia: SIP/2.0/UDP 10.200.25.164;branch=z9hG4bK541e4cea1B7F1601\r\nFrom: \"Courtney Dainty\" <sip:[email protected]>;tag=8A566DB3-A4D849FA\r\nTo: <sip:*[email protected];user=phone>;tag=bb294023\r\nCSeq: 3 BYE\r\nCall-ID: [email protected]\r\ncontact: <sip:[email protected];x-sipX-nonat>\r\nUser-Agent: PolycomSoundPointIP-SPIP_650-UA/3.1.3.0439\r\nAccept-Language: en\r\nMax-Forwards: 20\r\nDate: Mon, 16 Nov 2009 19:43:31 GMT\r\nContent-Length: 0\r\n\r\n====================END====================\n" "2009-11-16T19:43:31.334000Z":54379:JAVA:DEBUG:it2.ippbx.co.brazos.tx.us:Thread-2632:00000000:SipListenerImpl:"Gateway: got an incoming request BYE sip:[email protected]:5090 SIP/2.0\r\nVia: SIP/2.0/UDP 10.200.24.250;branch=z9hG4bK-sipXecs-76fc285f75e602c3b34072fc35a912d70088\r\nVia: SIP/2.0/UDP 10.200.25.164;branch=z9hG4bK541e4cea1B7F1601\r\nFrom: \"Courtney Dainty\" <sip:[email protected]>;tag=8A566DB3-A4D849FA\r\nTo: <sip:*[email protected];user=phone>;tag=bb294023\r\nCSeq: 3 BYE\r\nCall-ID: [email protected]\r\ncontact: <sip:[email protected];x-sipX-nonat>\r\nUser-Agent: PolycomSoundPointIP-SPIP_650-UA/3.1.3.0439\r\nAccept-Language: en\r\nMax-Forwards: 20\r\nDate: Mon, 16 Nov 2009 19:43:31 GMT\r\nContent-Length: 0\r\n\r\n" "2009-11-16T19:43:31.334000Z":54380:JAVA:DEBUG:it2.ippbx.co.brazos.tx.us:Thread-2632:00000000:CallControlManager:"serverTransaction Not found -- stray request -- discarding " Tony Graziano wrote: But this is straight to your adtran and no freeswitch or asterisk media gateway? |
_______________________________________________ sipx-users mailing list [email protected] List Archive: http://list.sipfoundry.org/archive/sipx-users Unsubscribe: http://list.sipfoundry.org/mailman/listinfo/sipx-users sipXecs IP PBX -- http://www.sipfoundry.org/
