Skip to content

Instantly share code, notes, and snippets.

@tpowell01
Created June 15, 2012 19:36
Show Gist options
  • Save tpowell01/2938349 to your computer and use it in GitHub Desktop.
Save tpowell01/2938349 to your computer and use it in GitHub Desktop.
Transfer Hangs Up
00447 7ef3 7:34:37 PM Processing events: continue
00448 7ef3 7:34:37 PM Sending TropoML Payload on Tropo-Thread-393fcf3b7a1f6b094926e1f9b00cc4cc [url=http://97.76.29.90:9292/activation/redirect.json]: {"result":{"sessionId":"393fcf3b7a1f6b094926e1f9b00cc4cc","callId":"23f9f563434dbbde6ab20b76dc56a896","state":"ANSWERED","sessionDuration":9,"sequence":1,"complete":true,"error":null,"actions":{"name":"start","attempts":1,"disposition":"SUCCESS","confidence":100,"interpretation":"2","utterance":"2","value":"2","xml":"<?xml version=\"1.0\"?>\r\n<result grammar=\"0@65f98825.vxmlgrammar\">\r\n <interpretation grammar=\"0@65f98825.vxmlgrammar\" confidence=\"100\">\r\n \r\n <input mode=\"dtmf\">dtmf-2<\/input>\r\n <\/interpretation>\r\n<\/result>\r\n"}}}
00449 7ef3 7:34:37 PM Received new TropoML document on Tropo-Thread-393fcf3b7a1f6b094926e1f9b00cc4cc: {"tropo":[{"say":[{"value":"Please hold while I transfer you to member support","voice":"veronica"}]},{"transfer":{"to":"+18135973730"}}]}
00450 7ef3 7:34:37 PM Processing document http://97.76.29.90:9292/activation/redirect.json for instance 393fcf3b7a1f6b094926e1f9b00cc4cc callFactory for instance 393fcf3b7a1f6b094926e1f9b00cc4cc
00451 7ef3 7:34:37 PM SimpleIncomingCall[tim.powell.dev/tim.powell.dev->9996200587/990009369996200587]->prompt("Please hold while I transfer you to member support",false,"null","null",null,null,0,2000,0,0,null,*)
00452 7ef3 7:34:37 PM SimpleIncomingCall[tim.powell.dev/tim.powell.dev->9996200587/990009369996200587] buildRecognitionProperties: {Sensitivity-Level=50, Recognizer-Start-Timers=false, N-Best-List-Length=1, No-Input-Timeout=0, Voxeo-Input-Mode=dtmf voice, Dtmf-Term-Timeout=0, Confidence-Threshold=30, Speed-Vs-Accuracy=50, Dtmf-Interdigit-Timeout=2000, Speech-Language=en-US}
00453 7ef3 7:34:37 PM SimpleIncomingCall[tim.powell.dev/tim.powell.dev->9996200587/990009369996200587] buildSpeakProperties: {Kill-On-Barge-In=false, Speech-Language=veronica}
00454 7ef3 7:34:37 PM ->waitForListener(*,9223372036854775807)
00455 7ef3 7:34:37 PM Starting listener thread Tropo-Thread-393fcf3b7a1f6b094926e1f9b00cc4cc-MrcpTtsListener@47e5da56
00456 7ef3 7:34:37 PM Set logging context for Tropo-Thread-393fcf3b7a1f6b094926e1f9b00cc4cc-MrcpTtsListener@47e5da56 to accountID=139446 host=null sessionGUID=495fb6ad4f989df3c12112ca6f747ef3 sessionNumber=393fcf3b7a1f6b094926e1f9b00cc4cc callID=23f9f563434dbbde6ab20b76dc56a896
00457 7ef3 7:34:40 PM Listener com.voxeo.tropo.util.MrcpTtsListener@47e5da56 received result: com.voxeo.sipmethod.mrcp.client.MrcpTtsResult@bbc3ca1
00458 7ef3 7:34:40 PM listener is com.voxeo.tropo.util.MrcpTtsListener@47e5da56, listener's event is null, and listener's url is null
00459 7ef3 7:34:40 PM Stopping listener thread Tropo-Thread-393fcf3b7a1f6b094926e1f9b00cc4cc-MrcpTtsListener@47e5da56
00460 7ef3 7:34:40 PM listener.wait() completed
00461 7ef3 7:34:40 PM <-waitForListener()
00462 7ef3 7:34:40 PM listener is com.voxeo.tropo.util.MrcpTtsListener@47e5da56, listener's event is null, and listener's url is null
00463 7ef3 7:34:40 PM SimpleIncomingCall[tim.powell.dev/tim.powell.dev->9996200587/990009369996200587]->transfer([+18135973730]) [from:null,timeout:30000,ttsOrUrl:null,grammar:null,termChar:null,repeat:1,answerOnMedia:false,interdigitTimeout:0,allowSignals:*]
00464 7ef3 7:34:40 PM transferWithoutMedia on answered incoming call.
00465 7ef3 7:34:40 PM SimpleIncomingCall[tim.powell.dev/tim.powell.dev->9996200587/990009369996200587] : termChar with no grammar. Setting grammar to equal termChar: dtmf-a
00466 7ef3 7:34:40 PM Starting listener thread Tropo-Thread-393fcf3b7a1f6b094926e1f9b00cc4cc-MrcpHotWordListener@7212b941
00467 7ef3 7:34:40 PM >>call([+18135973730], tim.powell.dev, VOICE, SKYPE, null, false, 30000, null, null, null, {}, [])
00468 7ef3 7:34:40 PM >>call(null, tim.powell.dev, tel:+18135973730, false, {})
00469 7ef3 7:34:40 PM _inst.sessionId = 393fcf3b7a1f6b094926e1f9b00cc4cc
00470 7ef3 7:34:40 PM tgInst.sessionId = 393fcf3b7a1f6b094926e1f9b00cc4cc
00471 7ef3 7:34:40 PM Parse result for [tel:+18135973730] : CalledNumber@1cf0632e[to=tel:+18135973730 pause=0 postDial=null]
00472 7ef3 7:34:40 PM Creating outgoing call : sip:tim.powell.dev@sip.tropo.com-->sip:+18135973730@sbc-internal.tropo.com,false
00473 7ef3 7:34:40 PM From: sip:tim.powell.dev@sip.tropo.com/tim.powell.dev
00474 7ef3 7:34:40 PM To: sip:+18135973730@sbc-internal.tropo.com/tel:+18135973730
00475 7ef3 7:34:40 PM Attribute TransferPeerSession added to Sip Session ss_lkob9baexg6f in state INITIAL
00476 7ef3 7:34:40 PM Attribute TransferPeerSession added to Sip Session ss_15e70eiumd75c in state CONFIRMED
00477 7ef3 7:34:40 PM Creating SimpleOutgoingCall from original request [INVITE sip:+18135973730@sbc-internal.tropo.com SIP/2.0 To: sip:+18135973730@sbc-internal.tropo.com x-sid: 393fcf3b7a1f6b094926e1f9b00cc4cc CSeq: 1 INVITE Content-Length: 0 x-accountid: 139446 Call-ID: 1xnhov61nxbrg From: <sip:tim.powell.dev@sip.tropo.com>;tag=l0tmv1ehhz8a x-appid: 350420 ] using new request [INVITE sip:+18135973730@sbc-internal.tropo.com SIP/2.0 To: sip:+18135973730@sbc-internal.tropo.com x-sid: 393fcf3b7a1f6b094926e1f9b00cc4cc CSeq: 1 INVITE Content-Length: 0 x-accountid: 139446 Call-ID: 1xnhov61nxbrg From: <sip:tim.powell.dev@sip.tropo.com>;tag=l0tmv1ehhz8a x-appid: 350420 ]
00478 7ef3 7:34:40 PM Attribute com.voxeo.tropo.core.call.inst added to Sip Session ss_lkob9baexg6f in state INITIAL
00479 7ef3 7:34:40 PM SipSession ss_lkob9baexg6f - 1xnhov61nxbrg associated with Tropo call 8ddf69b5bc93253c3b4a0942f5a46e7d
00480 7ef3 7:34:40 PM Set logging context for Tropo-Thread-393fcf3b7a1f6b094926e1f9b00cc4cc-MrcpHotWordListener@7212b941 to accountID=139446 host=null sessionGUID=495fb6ad4f989df3c12112ca6f747ef3 sessionNumber=393fcf3b7a1f6b094926e1f9b00cc4cc callID=23f9f563434dbbde6ab20b76dc56a896
00481 7ef3 7:34:40 PM This is a direct call, will not initialize MrcpClient
00482 7ef3 7:34:40 PM SimpleOutgoingCall[tim.powell.dev/null->+18135973730/null] state is changed: NEW->ANSWERING
00483 7ef3 7:34:40 PM Call 8ddf69b5bc93253c3b4a0942f5a46e7d state changed from NEW to ANSWERING on thread Tropo-Thread-393fcf3b7a1f6b094926e1f9b00cc4cc
00484 7ef3 7:34:40 PM to uri is sip:+18135973730@sbc-internal.tropo.com
00485 7ef3 7:34:40 PM SimpleOutgoingCall[tim.powell.dev/null->+18135973730/null] will be called.
00486 7ef3 7:34:40 PM Set logging context for Tropo-Thread-393fcf3b7a1f6b094926e1f9b00cc4cc to accountID=139446 host=null sessionGUID=495fb6ad4f989df3c12112ca6f747ef3 sessionNumber=393fcf3b7a1f6b094926e1f9b00cc4cc callID=8ddf69b5bc93253c3b4a0942f5a46e7d
00487 7ef3 7:34:40 PM Registering call tim.powell.dev -> +18135973730
00488 7ef3 7:34:40 PM getFirstCall() spawning MakeCall in thread Thread-482 in group Tropo-ThreadGroup-sas_2-14-smgzs3s95j9pbptropo
00489 7ef3 7:34:40 PM Set logging context for Thread-482 to accountID=139446 host=null sessionGUID=495fb6ad4f989df3c12112ca6f747ef3 sessionNumber=393fcf3b7a1f6b094926e1f9b00cc4cc callID=8ddf69b5bc93253c3b4a0942f5a46e7d
00490 7ef3 7:34:40 PM Calling tim.powell.dev -> +18135973730
00491 7ef3 7:34:40 PM >>[tim.powell.dev/null to +18135973730/null] ring(30000, null, null, null)
00492 7ef3 7:34:40 PM SimpleOutgoingCall[tim.powell.dev/null->+18135973730/null] is calling.
00493 7ef3 7:34:40 PM SimpleOutgoingCall[tim.powell.dev/null->+18135973730/null]->sending outgoing INVITE [timeout:30000,answerOnMedia:false]: [INVITE sip:+18135973730@sbc-internal.tropo.com SIP/2.0 To: sip:+18135973730@sbc-internal.tropo.com Via: SIP/2.0/UDP 10.6.69.203:5060;branch=z9hG4bK1adv6mvta9ajc;rport x-sid: 393fcf3b7a1f6b094926e1f9b00cc4cc CSeq: 1 INVITE Content-Length: 0 x-accountid: 139446 Call-ID: 1xnhov61nxbrg Max-Forwards: 70 From: <sip:tim.powell.dev@sip.tropo.com>;tag=l0tmv1ehhz8a Contact: <sip:10.6.69.203:5060;transport=udp> x-appid: 350420 ]
00494 7ef3 7:34:40 PM Starting listener thread Thread-482-MrcpRTCListener@66319623
00495 7ef3 7:34:40 PM SimpleOutgoingCall[tim.powell.dev/null->+18135973730/null] : Calling await(30000) on Thread-482
00496 7ef3 7:34:40 PM Set logging context for Thread-482-MrcpRTCListener@66319623 to accountID=139446 host=null sessionGUID=495fb6ad4f989df3c12112ca6f747ef3 sessionNumber=393fcf3b7a1f6b094926e1f9b00cc4cc callID=8ddf69b5bc93253c3b4a0942f5a46e7d
00497 7ef3 7:34:40 PM Set logging context for udp/0.0.0.0/5060-t-4 to accountID=139446 host=null sessionGUID=495fb6ad4f989df3c12112ca6f747ef3 sessionNumber=393fcf3b7a1f6b094926e1f9b00cc4cc callID=8ddf69b5bc93253c3b4a0942f5a46e7d
00498 7ef3 7:34:40 PM do180INVITE find call: SimpleOutgoingCall[tim.powell.dev/null->+18135973730/null]
00499 7ef3 7:34:40 PM SimpleOutgoingCall[tim.powell.dev/null->+18135973730/null] state is changed: ANSWERING->RINGING
00500 7ef3 7:34:40 PM Call 8ddf69b5bc93253c3b4a0942f5a46e7d state changed from ANSWERING to RINGING on thread udp/0.0.0.0/5060-t-4
00501 7ef3 7:34:40 PM Clearing logging context for udp/0.0.0.0/5060-t-4
00502 7ef3 7:34:41 PM Set logging context for udp/0.0.0.0/5060-t-4 to accountID=139446 host=null sessionGUID=495fb6ad4f989df3c12112ca6f747ef3 sessionNumber=393fcf3b7a1f6b094926e1f9b00cc4cc callID=8ddf69b5bc93253c3b4a0942f5a46e7d
00503 7ef3 7:34:41 PM do404INVITE find call: SimpleOutgoingCall[tim.powell.dev/null->+18135973730/null]
00504 7ef3 7:34:41 PM SimpleOutgoingCall[tim.powell.dev/null->+18135973730/null] state is changed: RINGING->DISCONNECTED
00505 7ef3 7:34:41 PM Call 8ddf69b5bc93253c3b4a0942f5a46e7d state changed from RINGING to DISCONNECTED on thread udp/0.0.0.0/5060-t-4
00506 7ef3 7:34:41 PM Stopping listener
00507 7ef3 7:34:41 PM Stopping listener thread Thread-482-MrcpRTCListener@66319623
00508 7ef3 7:34:41 PM Notifying waiting threads
00509 7ef3 7:34:41 PM Stopping MRCP
00510 7ef3 7:34:41 PM MRCP stopped
00511 7ef3 7:34:41 PM Disconnect processed
00512 7ef3 7:34:41 PM Clearing logging context for udp/0.0.0.0/5060-t-4
00513 7ef3 7:34:41 PM SimpleOutgoingCall[tim.powell.dev/null->+18135973730/null] : Done awaiting on Thread-482
00514 7ef3 7:34:41 PM Listener com.voxeo.tropo.util.MrcpRTCListener@66319623 received result: null
00515 7ef3 7:34:41 PM SimpleOutgoingCall[tim.powell.dev/null->+18135973730/null] : await() returning null
00516 7ef3 7:34:41 PM listener is com.voxeo.tropo.util.MrcpRTCListener@66319623, listener's event is null, and listener's url is null
00517 7ef3 7:34:41 PM SimpleOutgoingCall[tim.powell.dev/null->+18135973730/null] can not be completed at this time.
00518 7ef3 7:34:41 PM Call from tim.powell.dev to +18135973730 failed. com.voxeo.tropo.ErrorException: Outbound call can not complete. at com.voxeo.tropo.core.SimpleOutgoingCall.ring(SimpleOutgoingCall.java:188) at sun.reflect.GeneratedMethodAccessor142.invoke(Unknown Source) at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source) at java.lang.reflect.Method.invoke(Unknown Source) at com.voxeo.tropo.sandbox.SandboxInvocationHandler.invoke(SandboxInvocationHandler.java:42) at $Proxy57.ring(Unknown Source) at com.voxeo.tropo.core.MultiCallCoordinator$MakeCall.run(MultiCallCoordinator.java:157)
00519 7ef3 7:34:41 PM Unregistering call tim.powell.dev -> +18135973730
00520 7ef3 7:34:41 PM Hanging up on call from tim.powell.dev to +18135973730 failed.
00521 7ef3 7:34:41 PM SimpleOutgoingCall[tim.powell.dev/null->+18135973730/null]->hangup(), _state=DISCONNECTED
00522 7ef3 7:34:41 PM SimpleOutgoingCall[tim.powell.dev/null->+18135973730/null]->disconnect(), headers={}
00523 7ef3 7:34:41 PM SimpleOutgoingCall[tim.powell.dev/null->+18135973730/null] state is changed: DISCONNECTED->DISCONNECTED
00524 7ef3 7:34:41 PM SimpleOutgoingCall[tim.powell.dev/null->+18135973730/null]<-hangup(), _state=DISCONNECTED
00525 7ef3 7:34:41 PM Unregistering call tim.powell.dev -> +18135973730
00526 7ef3 7:34:41 PM Transfer without media failed when calling transferee.com.voxeo.tropo.ErrorException: Outbound call can not complete.
00527 7ef3 7:34:41 PM Attribute TransferPeerSession removed from Sip Session ss_15e70eiumd75c in state CONFIRMED
00528 7ef3 7:34:41 PM Stopping listener thread Tropo-Thread-393fcf3b7a1f6b094926e1f9b00cc4cc-MrcpHotWordListener@7212b941
00529 7ef3 7:34:41 PM Interrupting call()
00530 7ef3 7:34:41 PM Failed to transfer call com.voxeo.tropo.ErrorException: Outbound call can not complete. at com.voxeo.tropo.core.SimpleOutgoingCall.ring(SimpleOutgoingCall.java:188) at sun.reflect.GeneratedMethodAccessor142.invoke(Unknown Source) at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source) at java.lang.reflect.Method.invoke(Unknown Source) at com.voxeo.tropo.sandbox.SandboxInvocationHandler.invoke(SandboxInvocationHandler.java:42) at $Proxy57.ring(Unknown Source) at com.voxeo.tropo.core.MultiCallCoordinator$MakeCall.run(MultiCallCoordinator.java:157)
00531 7ef3 7:34:41 PM Processing events: incomplete
00532 7ef3 7:34:41 PM Processing events: continue
00533 7ef3 7:34:41 PM SimpleIncomingCall[tim.powell.dev/tim.powell.dev->9996200587/990009369996200587]->hangup(), _state=ANSWERED
00534 7ef3 7:34:41 PM SimpleIncomingCall[tim.powell.dev/tim.powell.dev->9996200587/990009369996200587]->disconnect(), headers={}
00535 7ef3 7:34:41 PM SimpleIncomingCall[tim.powell.dev/tim.powell.dev->9996200587/990009369996200587] state is changed: ANSWERED->DISCONNECTED
00536 7ef3 7:34:41 PM Call 23f9f563434dbbde6ab20b76dc56a896 state changed from ANSWERED to DISCONNECTED on thread Tropo-Thread-393fcf3b7a1f6b094926e1f9b00cc4cc
00537 7ef3 7:34:41 PM Stopping MRCP
00538 7ef3 7:34:41 PM Stopping TTS
00539 7ef3 7:34:41 PM TTS stopped
00540 7ef3 7:34:41 PM Stopping ASR
00541 7ef3 7:34:41 PM ASR stopped
00542 7ef3 7:34:41 PM MRCP stopped
00543 7ef3 7:34:41 PM Logging CDR {"call":{"SipSessionID":"ss_15e70eiumd75c","SessionID":"393fcf3b7a1f6b094926e1f9b00cc4cc","CallID":"23f9f563434dbbde6ab20b76dc56a896","ParentSessionID":"none","ParentCallID":"none","DateCreated":"Fri, 15 Jun 2012 19:34:27 +0000","DateUpdated":"Fri, 15 Jun 2012 19:34:27 +0000","AccountID":"139446","Called":"9996200587","Caller":"tim.powell.dev","PhoneNumberSid":"unknown","Disposition":"Success","Status":"Success","StartTime":"Fri, 15 Jun 2012 19:34:27 +0000","EndTime":"Fri, 15 Jun 2012 19:34:41 +0000","Duration":"13501","Flags":"in","RecordingDuration":"0","Network":"SKYPE","Channel":"VOICE","ApplicationId":"350420","ApplicationType":"tropo-web","ServiceId":"1182607","StartUrl":"http://97.76.29.90:9292/activation/start.json","BrowserIP":"10.6.69.203","PPID":"410"}}
00544 7ef3 7:34:41 PM Submitting CDR [callId=23f9f563434dbbde6ab20b76dc56a896, text={"call":{"SipSessionID":"ss_15e70eiumd75c","SessionID":"393fcf3b7a1f6b094926e1f9b00cc4cc","CallID":"23f9f563434dbbde6ab20b76dc56a896","ParentSessionID":"none","ParentCallID":"none","DateCreated":"Fri, 15 Jun 2012 19:34:27 +0000","DateUpdated":"Fri, 15 Jun 2012 19:34:27 +0000","AccountID":"139446","Called":"9996200587","Caller":"tim.powell.dev","PhoneNumberSid":"unknown","Disposition":"Success","Status":"Success","StartTime":"Fri, 15 Jun 2012 19:34:27 +0000","EndTime":"Fri, 15 Jun 2012 19:34:41 +0000","Duration":"13501","Flags":"in","RecordingDuration":"0","Network":"SKYPE","Channel":"VOICE","ApplicationId":"350420","ApplicationType":"tropo-web","ServiceId":"1182607","StartUrl":"http://97.76.29.90:9292/activation/start.json","BrowserIP":"10.6.69.203","PPID":"410"}}]
00545 7ef3 7:34:41 PM Disconnect processed
00546 7ef3 7:34:41 PM SimpleIncomingCall[tim.powell.dev/tim.powell.dev->9996200587/990009369996200587]<-hangup(), _state=DISCONNECTED
00547 7ef3 7:34:41 PM Processing events: hangup
00548 7ef3 7:34:41 PM Thread Tropo-Thread-393fcf3b7a1f6b094926e1f9b00cc4cc returned engine com.tropo.rest.engine.TropoScriptEngine@3c55e637 of type tropo-web, activeEngines = 10
00549 7ef3 7:34:41 PM ApplicationInstance[http://97.76.29.90:9292/activation/start.json , sas_2-14-smgzs3s95j9pbptropo] ends execution on Thread Tropo-Thread-393fcf3b7a1f6b094926e1f9b00cc4cc
00550 7ef3 7:34:41 PM sas_2-14-smgzs3s95j9pbptropo will invalidate when ready
00551 7ef3 7:34:41 PM Account 139446 has 0 sessions
00552 7ef3 7:34:41 PM Instance 393fcf3b7a1f6b094926e1f9b00cc4cc removed
00553 7ef3 7:34:41 PM Clearing logging context for Tropo-Thread-393fcf3b7a1f6b094926e1f9b00cc4cc
00554 7ef3 7:34:41 PM
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment