Skip to content

Instantly share code, notes, and snippets.

@antonmry
Last active April 26, 2016 11:58
Show Gist options
  • Star 0 You must be signed in to star a gist
  • Fork 0 You must be signed in to fork a gist
  • Save antonmry/61ec970be3ff9fd923538899768bbc76 to your computer and use it in GitHub Desktop.
Save antonmry/61ec970be3ff9fd923538899768bbc76 to your computer and use it in GitHub Desktop.
Restcomm using Amazon ECS
19:35:02,214 INFO [gov.nist.javax.sip.stack.SIPTransactionStack] (SIP-TCP-Core-PipelineThreadpool-9) <message
from="91.116.135.52:49532"
to="172.17.0.3:5063"
time="1461612902214"
isSender="false"
transactionId="z9hg4bk-363539-444588cfc4915bd2042802134f4b13bb"
callId="1461612902182"
firstLine="REGISTER sip:ec2-54-194-81-211.eu-west-1.compute.amazonaws.com SIP/2.0"
>
<![CDATA[REGISTER sip:ec2-54-194-81-211.eu-west-1.compute.amazonaws.com SIP/2.0
Call-ID: 1461612902182
CSeq: 1 REGISTER
From: <sip:alice@ec2-54-194-81-211.eu-west-1.compute.amazonaws.com>;tag=1461612902182
To: <sip:alice@ec2-54-194-81-211.eu-west-1.compute.amazonaws.com>
Via: SIP/2.0/WSS 91.116.135.52:49532;branch=z9hG4bK-363539-444588cfc4915bd2042802134f4b13bb;rport=49532;received=91.116.135.52
Max-Forwards: 70
User-Agent: TelScale RTM Olympus/1.0.0
Expires: 3600
Allow: INVITE,ACK,CANCEL,BYE,OPTIONS,MESSAGE
Contact: <sip:alice@91.116.135.52:49532;transport=wss>
Content-Length: 0
]]>
</message>
19:35:02,221 INFO [org.mobicents.servlet.sip.core.dispatchers.InitialRequestDispatcher] (SIP-TCP-Core-PipelineThreadpool-9) Request event dispatched to RestComm
19:35:02,225 INFO [org.mobicents.servlet.sip.core.SipApplicationDispatcherImpl] (RestComm-akka.actor.default-dispatcher-98) transaction gov.nist.javax.sip.stack.SIPServerTransactionImpl@4e24240c terminated => REGISTER sip:ec2-54-194-81-211.eu-west-1.compute.amazonaws.com SIP/2.0
Call-ID: 1461612902182
CSeq: 1 REGISTER
From: <sip:alice@ec2-54-194-81-211.eu-west-1.compute.amazonaws.com>;tag=1461612902182
To: <sip:alice@ec2-54-194-81-211.eu-west-1.compute.amazonaws.com>
Via: SIP/2.0/WSS 91.116.135.52:49532;branch=z9hG4bK-363539-444588cfc4915bd2042802134f4b13bb;rport=49532;received=91.116.135.52
Max-Forwards: 70
User-Agent: TelScale RTM Olympus/1.0.0
Expires: 3600
Allow: INVITE,ACK,CANCEL,BYE,OPTIONS,MESSAGE
Contact: <sip:alice@91.116.135.52:49532;transport=wss>
Content-Length: 0
19:35:02,226 INFO [org.mobicents.servlet.sip.core.SipApplicationDispatcherImpl] (MSS-Executor-Thread-2) transaction gov.nist.javax.sip.stack.SIPServerTransactionImpl@4e24240c terminated => REGISTER sip:ec2-54-194-81-211.eu-west-1.compute.amazonaws.com SIP/2.0
Call-ID: 1461612902182
CSeq: 1 REGISTER
From: <sip:alice@ec2-54-194-81-211.eu-west-1.compute.amazonaws.com>;tag=1461612902182
To: <sip:alice@ec2-54-194-81-211.eu-west-1.compute.amazonaws.com>
Via: SIP/2.0/WSS 91.116.135.52:49532;branch=z9hG4bK-363539-444588cfc4915bd2042802134f4b13bb;rport=49532;received=91.116.135.52
Max-Forwards: 70
User-Agent: TelScale RTM Olympus/1.0.0
Expires: 3600
Allow: INVITE,ACK,CANCEL,BYE,OPTIONS,MESSAGE
Contact: <sip:alice@91.116.135.52:49532;transport=wss>
Content-Length: 0
19:35:02,226 INFO [gov.nist.javax.sip.stack.SIPTransactionStack] (RestComm-akka.actor.default-dispatcher-98) <message
from="172.17.0.3:5063"
to="91.116.135.52:49532"
time="1461612902226"
isSender="true"
transactionId="z9hg4bk-363539-444588cfc4915bd2042802134f4b13bb"
callId="1461612902182"
firstLine="SIP/2.0 407 Proxy Authentication required"
>
<![CDATA[SIP/2.0 407 Proxy Authentication required
To: <sip:alice@ec2-54-194-81-211.eu-west-1.compute.amazonaws.com>;tag=14396227_48e9fc4b_57a5b08a_4c14283e
Via: SIP/2.0/WSS 91.116.135.52:49532;branch=z9hG4bK-363539-444588cfc4915bd2042802134f4b13bb;rport=49532;received=91.116.135.52
CSeq: 1 REGISTER
Call-ID: 1461612902182
From: <sip:alice@ec2-54-194-81-211.eu-west-1.compute.amazonaws.com>;tag=1461612902182
Server: Restcomm 7.6.0.873
Proxy-Authenticate: Digest realm="ec2-54-194-81-211.eu-west-1.compute.amazonaws.com",nonce="36366662323261392d356364622d343"
Content-Length: 0
]]>
</message>
19:35:02,289 INFO [gov.nist.javax.sip.stack.SIPTransactionStack] (SIP-TCP-Core-PipelineThreadpool-10) <message
from="91.116.135.52:49532"
to="172.17.0.3:5063"
time="1461612902289"
isSender="false"
transactionId="z9hg4bk-363539-b06baa7f25971e0819dfb745e0629c5e"
callId="1461612902182"
firstLine="REGISTER sip:ec2-54-194-81-211.eu-west-1.compute.amazonaws.com SIP/2.0"
>
<![CDATA[REGISTER sip:ec2-54-194-81-211.eu-west-1.compute.amazonaws.com SIP/2.0
CSeq: 2 REGISTER
User-Agent: TelScale RTM Olympus/1.0.0
Expires: 3600
Allow: INVITE,ACK,CANCEL,BYE,OPTIONS,MESSAGE
Contact: <sip:alice@91.116.135.52:49532;transport=wss>
Call-ID: 1461612902182
Via: SIP/2.0/WSS 91.116.135.52:49532;branch=z9hG4bK-363539-b06baa7f25971e0819dfb745e0629c5e;rport=49532;received=91.116.135.52
From: <sip:alice@ec2-54-194-81-211.eu-west-1.compute.amazonaws.com>;tag=1461612902182
To: <sip:alice@ec2-54-194-81-211.eu-west-1.compute.amazonaws.com>
Max-Forwards: 70
Proxy-Authorization: Digest username="alice",realm="ec2-54-194-81-211.eu-west-1.compute.amazonaws.com",nonce="36366662323261392d356364622d343",response="a7866f07a8905abfd3c2e46cd5046e9c",uri="sip:ec2-54-194-81-211.eu-west-1.compute.amazonaws.com",algorithm=MD5
Content-Length: 0
]]>
</message>
19:35:02,296 INFO [org.mobicents.servlet.sip.core.dispatchers.InitialRequestDispatcher] (SIP-TCP-Core-PipelineThreadpool-10) Request event dispatched to RestComm
19:35:02,300 INFO [org.mobicents.servlet.restcomm.telephony.ua.UserAgentManager] (RestComm-akka.actor.default-dispatcher-99) Patching URI: sip:alice@91.116.135.52:49532;transport=wss with IP: 91.116.135.52 and PORT: 49532 for USER: alice
19:35:02,300 INFO [com.telestax.servlet.MonitoringService] (RestComm-akka.actor.default-dispatcher-100) MonitoringService Processing Message: "org.mobicents.servlet.restcomm.telephony.UserRegistration sender : class akka.actor.RepointableActorRef self is terminated: false
19:35:02,303 INFO [org.mobicents.servlet.restcomm.telephony.ua.UserAgentManager] (RestComm-akka.actor.default-dispatcher-101) The user agent manager updated alice at address sip:alice@91.116.135.52:49532;transport=wss
19:35:02,307 INFO [org.mobicents.servlet.sip.core.SipApplicationDispatcherImpl] (RestComm-akka.actor.default-dispatcher-98) transaction gov.nist.javax.sip.stack.SIPServerTransactionImpl@491d0bb terminated => REGISTER sip:ec2-54-194-81-211.eu-west-1.compute.amazonaws.com SIP/2.0
CSeq: 2 REGISTER
User-Agent: TelScale RTM Olympus/1.0.0
Expires: 3600
Allow: INVITE,ACK,CANCEL,BYE,OPTIONS,MESSAGE
Contact: <sip:alice@91.116.135.52:49532;transport=wss>
Call-ID: 1461612902182
Via: SIP/2.0/WSS 91.116.135.52:49532;branch=z9hG4bK-363539-b06baa7f25971e0819dfb745e0629c5e;rport=49532;received=91.116.135.52
From: <sip:alice@ec2-54-194-81-211.eu-west-1.compute.amazonaws.com>;tag=1461612902182
To: <sip:alice@ec2-54-194-81-211.eu-west-1.compute.amazonaws.com>
Max-Forwards: 70
Proxy-Authorization: Digest username="alice",realm="ec2-54-194-81-211.eu-west-1.compute.amazonaws.com",nonce="36366662323261392d356364622d343",response="a7866f07a8905abfd3c2e46cd5046e9c",uri="sip:ec2-54-194-81-211.eu-west-1.compute.amazonaws.com",algorithm=MD5
Content-Length: 0
19:35:02,307 INFO [org.mobicents.servlet.sip.core.SipApplicationDispatcherImpl] (MSS-Executor-Thread-3) transaction gov.nist.javax.sip.stack.SIPServerTransactionImpl@491d0bb terminated => REGISTER sip:ec2-54-194-81-211.eu-west-1.compute.amazonaws.com SIP/2.0
CSeq: 2 REGISTER
User-Agent: TelScale RTM Olympus/1.0.0
Expires: 3600
Allow: INVITE,ACK,CANCEL,BYE,OPTIONS,MESSAGE
Contact: <sip:alice@91.116.135.52:49532;transport=wss>
Call-ID: 1461612902182
Via: SIP/2.0/WSS 91.116.135.52:49532;branch=z9hG4bK-363539-b06baa7f25971e0819dfb745e0629c5e;rport=49532;received=91.116.135.52
From: <sip:alice@ec2-54-194-81-211.eu-west-1.compute.amazonaws.com>;tag=1461612902182
To: <sip:alice@ec2-54-194-81-211.eu-west-1.compute.amazonaws.com>
Max-Forwards: 70
Proxy-Authorization: Digest username="alice",realm="ec2-54-194-81-211.eu-west-1.compute.amazonaws.com",nonce="36366662323261392d356364622d343",response="a7866f07a8905abfd3c2e46cd5046e9c",uri="sip:ec2-54-194-81-211.eu-west-1.compute.amazonaws.com",algorithm=MD5
Content-Length: 0
19:35:02,308 INFO [gov.nist.javax.sip.stack.SIPTransactionStack] (RestComm-akka.actor.default-dispatcher-98) <message
from="172.17.0.3:5063"
to="91.116.135.52:49532"
time="1461612902307"
isSender="true"
transactionId="z9hg4bk-363539-b06baa7f25971e0819dfb745e0629c5e"
callId="1461612902182"
firstLine="SIP/2.0 200 OK"
>
<![CDATA[SIP/2.0 200 OK
To: <sip:alice@ec2-54-194-81-211.eu-west-1.compute.amazonaws.com>;tag=91293835_48e9fc4b_57a5b08a_ec22ef6f
Via: SIP/2.0/WSS 91.116.135.52:49532;branch=z9hG4bK-363539-b06baa7f25971e0819dfb745e0629c5e;rport=49532;received=91.116.135.52
CSeq: 2 REGISTER
Call-ID: 1461612902182
From: <sip:alice@ec2-54-194-81-211.eu-west-1.compute.amazonaws.com>;tag=1461612902182
Server: Restcomm 7.6.0.873
Contact: <sip:alice@91.116.135.52:49532;transport=wss>;expires=3600
Content-Length: 0
]]>
</message>
19:35:02,308 INFO [org.mobicents.servlet.sip.core.session.SipApplicationSessionImpl] (RestComm-akka.actor.default-dispatcher-98) Invalidating the following sip application session ec22ef6f;RestComm
19:35:02,309 INFO [org.mobicents.servlet.sip.core.session.SipSessionImpl] (RestComm-akka.actor.default-dispatcher-98) Invalidating the sip session (1461612902182;1461612902182;ec22ef6f;RestComm)
19:35:02,310 INFO [org.mobicents.servlet.sip.core.session.SipApplicationSessionImpl] (RestComm-akka.actor.default-dispatcher-98) The following sip application session ec22ef6f;RestComm has been invalidated
19:35:02,310 ERROR [org.mobicents.servlet.sip.core.SipApplicationDispatcherImpl] (MSS-Executor-Thread-3) Problem handling transaction termination: java.lang.NullPointerException
at org.mobicents.servlet.sip.core.session.SipSessionImpl.removeOngoingTransaction(SipSessionImpl.java:1568) [sip-servlets-impl-3.1.691.jar:3.1.691]
at org.mobicents.servlet.sip.core.SipApplicationDispatcherImpl$6.run(SipApplicationDispatcherImpl.java:1608) [sip-servlets-impl-3.1.691.jar:3.1.691]
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145) [rt.jar:1.7.0_80]
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) [rt.jar:1.7.0_80]
at java.lang.Thread.run(Thread.java:745) [rt.jar:1.7.0_80]
19:36:02,212 INFO [gov.nist.javax.sip.stack.UDPMessageChannel] (Restcomm-SIP-Servlets-UDPMessageChannelThread-13) Setting SIPMessage peerPacketSource to: /5.10.112.121:5060
19:36:02,213 INFO [gov.nist.javax.sip.stack.SIPTransactionStack] (Restcomm-SIP-Servlets-UDPMessageChannelThread-13) <message
from="5.10.112.121:5060"
to="172.17.0.3:5060"
time="1461612962211"
isSender="false"
transactionId="z9hg4bk83c4.672fd7de86cc2693da5b81fdb852300f.0"
callId="0ba0902e484d73b21269fccd11a7e1bf@sip.nexmo.com"
firstLine="INVITE sip:34986160292@54.194.81.211 SIP/2.0"
>
<![CDATA[INVITE sip:34986160292@54.194.81.211 SIP/2.0
Record-Route: <sip:5.10.112.121;r2=on;lr=on;ftag=as58cf6c6b;nat=yes>
Record-Route: <sip:10.112.247.244;r2=on;lr=on;ftag=as58cf6c6b;nat=yes>
Via: SIP/2.0/UDP 5.10.112.121;branch=z9hG4bK83c4.672fd7de86cc2693da5b81fdb852300f.0
Via: SIP/2.0/UDP 159.8.174.148:5060;received=10.112.247.227;branch=z9hG4bK1644df37;rport=5060
Max-Forwards: 69
From: "986410091" <sip:986410091@sip.nexmo.com>;tag=as58cf6c6b
To: <sip:34986160292@sip.nexmo.com>
Contact: <sip:986410091@159.8.174.148:5060;alias=10.112.247.227~5060~1>
Call-ID: 0ba0902e484d73b21269fccd11a7e1bf@sip.nexmo.com
CSeq: 102 INVITE
User-Agent: Nexmo Media 3-1
Date: Mon, 25 Apr 2016 19:36:02 GMT
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,REFER,SUBSCRIBE,NOTIFY,INFO,PUBLISH,MESSAGE
Supported: replaces,timer
P-Asserted-Identity: "986410091" <sip:986410091@sip.nexmo.com>
Content-Type: application/sdp
Content-Length: 394
v=0
o=Nexmo 1339079178 1339079178 IN IP4 159.8.174.148
s=Nexmo
c=IN IP4 159.8.174.148
t=0 0
m=audio 11664 RTP/AVP 8 0 97 18 9 117 101
a=rtpmap:8 PCMA/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:97 iLBC/8000
a=fmtp:97 mode=30
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:9 G722/8000
a=rtpmap:117 speex/16000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=sendrecv
]]>
</message>
19:36:02,219 INFO [org.mobicents.servlet.sip.core.dispatchers.InitialRequestDispatcher] (Restcomm-SIP-Servlets-UDPMessageChannelThread-13) Request event dispatched to RestComm
19:36:02,234 INFO [org.mobicents.servlet.restcomm.telephony.CallManager] (RestComm-akka.actor.default-dispatcher-105) ToHost: sip.nexmo.com
19:36:02,234 INFO [org.mobicents.servlet.restcomm.telephony.CallManager] (RestComm-akka.actor.default-dispatcher-105) ruri: 54.194.81.211
19:36:02,234 INFO [org.mobicents.servlet.restcomm.telephony.CallManager] (RestComm-akka.actor.default-dispatcher-105) myHostIp: 172.17.0.3
19:36:02,234 INFO [org.mobicents.servlet.restcomm.telephony.CallManager] (RestComm-akka.actor.default-dispatcher-105) mediaExternalIp: 54.194.81.211
19:36:02,235 INFO [org.mobicents.servlet.restcomm.telephony.CallManager] (RestComm-akka.actor.default-dispatcher-105) proxyIp: 127.0.0.1
19:36:02,242 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-106) ********** Call's akka://RestComm/user/$z Current State: "uninitialized direction: null
19:36:02,242 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-110) ********** Call akka://RestComm/user/$z Processing Message: "org.mobicents.servlet.sip.message.Servlet3SipServletRequestImpl sender : akka://RestComm/user/$f
19:36:02,247 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-106) ********** VoiceInterpreter's akka://RestComm/user/$y Current State: uninitialized
19:36:02,247 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-106) ********** VoiceInterpreter's akka://RestComm/user/$y Processing Message: org.mobicents.servlet.restcomm.interpreter.StartInterpreter
19:36:02,248 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-106) ********** VoiceInterpreter's akka://RestComm/user/$y Current State: acquiring asr info
19:36:02,248 INFO [gov.nist.javax.sip.stack.SIPTransactionStack] (RestComm-akka.actor.default-dispatcher-105) <message
from="172.17.0.3:5060"
to="5.10.112.121:5060"
time="1461612962247"
isSender="true"
transactionId="z9hg4bk83c4.672fd7de86cc2693da5b81fdb852300f.0"
callId="0ba0902e484d73b21269fccd11a7e1bf@sip.nexmo.com"
firstLine="SIP/2.0 180 Ringing"
>
<![CDATA[SIP/2.0 180 Ringing
To: <sip:34986160292@sip.nexmo.com>;tag=36539627_48e9fc4b_57a5b08a_454bd439
Via: SIP/2.0/UDP 5.10.112.121;branch=z9hG4bK83c4.672fd7de86cc2693da5b81fdb852300f.0
Via: SIP/2.0/UDP 159.8.174.148:5060;received=10.112.247.227;branch=z9hG4bK1644df37;rport=5060
Record-Route: <sip:5.10.112.121;r2=on;lr=on;ftag=as58cf6c6b;nat=yes>
Record-Route: <sip:10.112.247.244;r2=on;lr=on;ftag=as58cf6c6b;nat=yes>
CSeq: 102 INVITE
Call-ID: 0ba0902e484d73b21269fccd11a7e1bf@sip.nexmo.com
From: "986410091" <sip:986410091@sip.nexmo.com>;tag=as58cf6c6b
Server: Restcomm 7.6.0.873
Contact: <sip:54.194.81.211:5060>
X-RestComm-CallSid: CA4230dadd85064a649bc4e3f8b585afba
Content-Length: 0
]]>
</message>
19:36:02,248 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-106) ********** VoiceInterpreter's akka://RestComm/user/$y Processing Message: org.mobicents.servlet.restcomm.asr.AsrResponse
19:36:02,249 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-103) ********** VoiceInterpreter's akka://RestComm/user/$y Current State: acquiring tts info
19:36:02,249 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-103) ********** VoiceInterpreter's akka://RestComm/user/$y Processing Message: org.mobicents.servlet.restcomm.tts.api.SpeechSynthesizerResponse
19:36:02,250 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-111) ********** Call's akka://RestComm/user/$z Current State: "ringing direction: inbound
19:36:02,250 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-111) ********** Call akka://RestComm/user/$z Processing Message: "org.mobicents.servlet.restcomm.telephony.GetCallInfo sender : akka://RestComm/user/$y
19:36:02,250 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-111) ********** VoiceInterpreter's akka://RestComm/user/$y Current State: acquiring call info
19:36:02,251 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-111) ********** VoiceInterpreter's akka://RestComm/user/$y Processing Message: org.mobicents.servlet.restcomm.telephony.CallResponse
19:36:02,251 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-111) ********** Call's akka://RestComm/user/$z Current State: "ringing direction: inbound
19:36:02,251 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-111) ********** Call akka://RestComm/user/$z Processing Message: "org.mobicents.servlet.restcomm.patterns.Observe sender : akka://RestComm/user/$y
19:36:02,251 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-111) ********** Call's akka://RestComm/user/$z Current State: "ringing direction: inbound
19:36:02,252 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-111) ********** Call akka://RestComm/user/$z Processing Message: "org.mobicents.servlet.restcomm.patterns.Observe sender : akka://RestComm/user/$y
19:36:02,252 INFO [com.telestax.servlet.MonitoringService] (RestComm-akka.actor.default-dispatcher-111) MonitoringService Processing Message: "org.mobicents.servlet.restcomm.patterns.Observing sender : class akka.actor.RepointableActorRef self is terminated: false
19:36:02,252 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-111) ********** Call's akka://RestComm/user/$z Current State: "ringing direction: inbound
19:36:02,252 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-111) ********** Call akka://RestComm/user/$z Processing Message: "org.mobicents.servlet.restcomm.telephony.GetCallInfo sender : akka://RestComm/user/$a
19:36:02,252 INFO [com.telestax.servlet.MonitoringService] (RestComm-akka.actor.default-dispatcher-111) MonitoringService Processing Message: "org.mobicents.servlet.restcomm.telephony.CallResponse sender : class akka.actor.RepointableActorRef self is terminated: false
19:36:02,255 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-111) status callback is null
19:36:02,256 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-105) ********** VoiceInterpreter's akka://RestComm/user/$y Current State: downloading rcml
19:36:02,256 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-105) ********** VoiceInterpreter's akka://RestComm/user/$y Processing Message: org.mobicents.servlet.restcomm.patterns.Observing
19:36:02,322 INFO [org.mobicents.servlet.restcomm.rvd.http.resources.RvdController] (http-/172.17.0.3:443-2) Received Restcomm POST request
19:36:02,329 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-110) ********** VoiceInterpreter's akka://RestComm/user/$y Current State: downloading rcml
19:36:02,329 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-110) ********** VoiceInterpreter's akka://RestComm/user/$y Processing Message: org.mobicents.servlet.restcomm.http.client.DownloaderResponse
19:36:02,329 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-110) Downloader response is success, moving to Ready state
19:36:02,330 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-110) ********** VoiceInterpreter's akka://RestComm/user/$y Current State: ready
19:36:02,330 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-110) ********** VoiceInterpreter's akka://RestComm/user/$y Processing Message: org.mobicents.servlet.restcomm.interpreter.rcml.Tag
19:36:02,330 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-110) ********** Call's akka://RestComm/user/$z Current State: "ringing direction: inbound
19:36:02,330 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-110) ********** Call akka://RestComm/user/$z Processing Message: "org.mobicents.servlet.restcomm.telephony.Answer sender : akka://RestComm/user/$y
19:36:02,331 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-110) ExternalSipUri stored in the session was null, will use the message InitialRemoteAddr: 5.10.112.121
19:36:02,331 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-108) ********** Call Controller Current State: "uninitialized
19:36:02,331 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-108) ********** Call Controller Processing Message: "org.mobicents.servlet.restcomm.patterns.Observe sender : class akka.actor.RepointableActorRef
19:36:02,332 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-108) ********** Call Controller Current State: "uninitialized
19:36:02,332 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-108) ********** Call's akka://RestComm/user/$z Current State: "initializing direction: inbound
19:36:02,332 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-108) ********** Call Controller Processing Message: "org.mobicents.servlet.restcomm.mscontrol.messages.CreateMediaSession sender : class akka.actor.RepointableActorRef
19:36:02,332 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-108) ********** Call akka://RestComm/user/$z Processing Message: "org.mobicents.servlet.restcomm.patterns.Observing sender : akka://RestComm/user/$A
19:36:02,333 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-105) ********** Call Controller Current State: "acquiring media gateway info
19:36:02,333 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-105) ********** Call Controller Processing Message: "org.mobicents.servlet.restcomm.mgcp.MediaGatewayResponse sender : class akka.actor.RepointableActorRef
19:36:02,333 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-105) ********** Call Controller Current State: "acquiring media session
19:36:02,334 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-105) ********** Call Controller Processing Message: "org.mobicents.servlet.restcomm.mgcp.MediaGatewayResponse sender : class akka.actor.RepointableActorRef
19:36:02,334 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-105) ********** Call Controller Current State: "acquiring media bridge
19:36:02,334 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-106) ********** Call Controller Processing Message: "org.mobicents.servlet.restcomm.mgcp.MediaGatewayResponse sender : class akka.actor.RepointableActorRef
19:36:02,334 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-106) ********** Media Group akka://RestComm/user/$A/$a Current State: "uninitialized
19:36:02,335 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-106) ********** Media Group akka://RestComm/user/$A/$a Processing Message: "org.mobicents.servlet.restcomm.patterns.Observe sender : class akka.actor.RepointableActorRef
19:36:02,335 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-106) ********** Media Group akka://RestComm/user/$A/$a Current State: "uninitialized
19:36:02,335 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-106) ********** Media Group akka://RestComm/user/$A/$a Processing Message: "org.mobicents.servlet.restcomm.mscontrol.messages.StartMediaGroup sender : class akka.actor.RepointableActorRef
19:36:02,336 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-106) MediaGroup: akka://RestComm/user/$A/$a got StartMediaGroup from: akka://RestComm/user/$A endpoint: akka://RestComm/user/$b/$u isTerminated: false
19:36:02,336 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-106) MediaGroup :akka://RestComm/user/$A/$a state: uninitialized session: 6 will ask to get IvrEndpoint
19:36:02,336 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-106) ********** Media Group akka://RestComm/user/$A/$a Current State: "acquiring ivr
19:36:02,336 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-106) ********** Media Group akka://RestComm/user/$A/$a Processing Message: "org.mobicents.servlet.restcomm.mgcp.MediaGatewayResponse sender : class akka.actor.RepointableActorRef
19:36:02,337 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-106) MediaGroup :akka://RestComm/user/$A/$a state: acquiring ivr session: 6 ivr endpoint: akka://RestComm/user/$b/$v will ask to get Link
19:36:02,337 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-106) ********** Media Group akka://RestComm/user/$A/$a Current State: "acquiring link
19:36:02,337 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-106) ********** Media Group akka://RestComm/user/$A/$a Processing Message: "org.mobicents.servlet.restcomm.patterns.Observing sender : class akka.actor.LocalActorRef
19:36:02,338 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-106) ********** Media Group akka://RestComm/user/$A/$a Current State: "acquiring link
19:36:02,338 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-106) ********** Media Group akka://RestComm/user/$A/$a Processing Message: "org.mobicents.servlet.restcomm.mgcp.MediaGatewayResponse sender : class akka.actor.RepointableActorRef
19:36:02,338 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-106) MediaGroup :akka://RestComm/user/$A/$a state: acquiring link session: 6 link: akka://RestComm/user/$b/$w endpoint: akka://RestComm/user/$b/$u initializeLink sent, endpoint isTerminated: false
19:36:02,338 INFO [org.mobicents.servlet.restcomm.mgcp.Link] (RestComm-akka.actor.default-dispatcher-106) Link: akka://RestComm/user/$b/$w ,received InitializeLink message from sender: akka://RestComm/user/$A/$a
19:36:02,342 INFO [org.mobicents.servlet.restcomm.mgcp.Link] (RestComm-akka.actor.default-dispatcher-106) Link: akka://RestComm/user/$b/$w ,state: uninitialized ,primaryEndpoint: akka://RestComm/user/$b/$u ,secondaryEndpoint: akka://RestComm/user/$b/$v
19:36:02,342 INFO [org.mobicents.servlet.restcomm.mgcp.Link] (RestComm-akka.actor.default-dispatcher-106) Link: akka://RestComm/user/$b/$w ,state: uninitialized InviteEndpoint sent to primaryEndpoint: akka://RestComm/user/$b/$u
19:36:02,342 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-106) ********** Media Group akka://RestComm/user/$A/$a Current State: "initializing link
19:36:02,342 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-106) ********** Media Group akka://RestComm/user/$A/$a Processing Message: "org.mobicents.servlet.restcomm.patterns.Observing sender : class akka.actor.LocalActorRef
19:36:02,342 INFO [org.mobicents.servlet.restcomm.mgcp.Link] (RestComm-akka.actor.default-dispatcher-106) Link: akka://RestComm/user/$b/$w ,state: initializing primary ,primaryEndpointId: mobicents/bridge/$@172.17.0.3:2427 ,secondaryEndpoint: akka://RestComm/user/$b/$v secondaryEndpoint isTerminated: false
19:36:02,342 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-106) ********** Media Group akka://RestComm/user/$A/$a Current State: "initializing link
19:36:02,343 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-106) ********** Media Group akka://RestComm/user/$A/$a Processing Message: "org.mobicents.servlet.restcomm.mgcp.LinkStateChanged sender : class akka.actor.LocalActorRef
19:36:02,343 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-106) MediaGroup :akka://RestComm/user/$A/$a state: initializing link session: 6 link: akka://RestComm/user/$b/$w will ask to open Link
19:36:02,343 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-106) ********** Call Controller Current State: "creating media group
19:36:02,343 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-106) ********** Call Controller Processing Message: "org.mobicents.servlet.restcomm.patterns.Observing sender : class akka.actor.LocalActorRef
19:36:02,343 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-106) ********** Call Controller Current State: "creating media group
19:36:02,344 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-106) ********** Call Controller Processing Message: "org.mobicents.servlet.restcomm.patterns.Observing sender : class akka.actor.LocalActorRef
19:36:02,350 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-106) ********** Media Group akka://RestComm/user/$A/$a Current State: "opening link
19:36:02,351 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-106) ********** Media Group akka://RestComm/user/$A/$a Processing Message: "org.mobicents.servlet.restcomm.mgcp.LinkStateChanged sender : class akka.actor.LocalActorRef
19:36:02,371 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-106) ********** Media Group akka://RestComm/user/$A/$a Current State: "updating link
19:36:02,371 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-106) ********** Media Group akka://RestComm/user/$A/$a Processing Message: "org.mobicents.servlet.restcomm.mgcp.LinkStateChanged sender : class akka.actor.LocalActorRef
19:36:02,371 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-106) ********** Call Controller Current State: "creating media group
19:36:02,371 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-106) ********** Call Controller Processing Message: "org.mobicents.servlet.restcomm.mscontrol.messages.MediaGroupStateChanged sender : class akka.actor.LocalActorRef
19:36:02,372 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-106) ********** Call Controller Current State: "acquiring connection
19:36:02,372 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-109) ********** Call Controller Processing Message: "org.mobicents.servlet.restcomm.mgcp.MediaGatewayResponse sender : class akka.actor.RepointableActorRef
19:36:02,373 INFO [org.mobicents.servlet.restcomm.mgcp.Connection] (RestComm-akka.actor.default-dispatcher-109) ********** Connection Current State: uninitialized
19:36:02,373 INFO [org.mobicents.servlet.restcomm.mgcp.Connection] (RestComm-akka.actor.default-dispatcher-109) ********** Connection Processing Message: org.mobicents.servlet.restcomm.patterns.Observe
19:36:02,373 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-109) ********** Call Controller Current State: "initializing connection
19:36:02,373 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-109) ********** Call Controller Processing Message: "org.mobicents.servlet.restcomm.patterns.Observing sender : class akka.actor.LocalActorRef
19:36:02,373 INFO [org.mobicents.servlet.restcomm.mgcp.Connection] (RestComm-akka.actor.default-dispatcher-109) ********** Connection Current State: uninitialized
19:36:02,374 INFO [org.mobicents.servlet.restcomm.mgcp.Connection] (RestComm-akka.actor.default-dispatcher-109) ********** Connection Processing Message: org.mobicents.servlet.restcomm.mgcp.InitializeConnection
19:36:02,374 INFO [org.mobicents.servlet.restcomm.mgcp.Connection] (RestComm-akka.actor.default-dispatcher-109) ********** Connection Current State: initializing
19:36:02,374 INFO [org.mobicents.servlet.restcomm.mgcp.Connection] (RestComm-akka.actor.default-dispatcher-109) ********** Connection Processing Message: org.mobicents.servlet.restcomm.mgcp.EndpointCredentials
19:36:02,374 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-109) ********** Call Controller Current State: "initializing connection
19:36:02,374 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-109) ********** Call Controller Processing Message: "org.mobicents.servlet.restcomm.mgcp.ConnectionStateChanged sender : class akka.actor.LocalActorRef
19:36:02,374 INFO [org.mobicents.servlet.restcomm.mgcp.Connection] (RestComm-akka.actor.default-dispatcher-109) ********** Connection Current State: closed
19:36:02,375 INFO [org.mobicents.servlet.restcomm.mgcp.Connection] (RestComm-akka.actor.default-dispatcher-109) ********** Connection Processing Message: org.mobicents.servlet.restcomm.mgcp.OpenConnection
19:36:02,391 INFO [org.mobicents.servlet.restcomm.mgcp.Connection] (RestComm-akka.actor.default-dispatcher-109) ********** Connection Current State: opening
19:36:02,392 INFO [org.mobicents.servlet.restcomm.mgcp.Connection] (RestComm-akka.actor.default-dispatcher-109) ********** Connection Processing Message: jain.protocol.ip.mgcp.message.CreateConnectionResponse
19:36:02,392 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-109) ********** Call Controller Current State: "opening connection
19:36:02,392 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-109) ********** Call Controller Processing Message: "org.mobicents.servlet.restcomm.mgcp.ConnectionStateChanged sender : class akka.actor.LocalActorRef
19:36:02,393 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-109) ********** Call's akka://RestComm/user/$z Current State: "initializing direction: inbound
19:36:02,393 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-109) ********** Call akka://RestComm/user/$z Processing Message: "org.mobicents.servlet.restcomm.mscontrol.messages.MediaServerControllerStateChanged sender : akka://RestComm/user/$A
19:36:02,398 INFO [gov.nist.javax.sip.stack.SIPTransactionStack] (RestComm-akka.actor.default-dispatcher-111) <message
from="172.17.0.3:5060"
to="5.10.112.121:5060"
time="1461612962398"
isSender="true"
transactionId="z9hg4bk83c4.672fd7de86cc2693da5b81fdb852300f.0"
callId="0ba0902e484d73b21269fccd11a7e1bf@sip.nexmo.com"
firstLine="SIP/2.0 200 OK"
>
<![CDATA[SIP/2.0 200 OK
To: <sip:34986160292@sip.nexmo.com>;tag=36539627_48e9fc4b_57a5b08a_454bd439
Via: SIP/2.0/UDP 5.10.112.121;branch=z9hG4bK83c4.672fd7de86cc2693da5b81fdb852300f.0
Via: SIP/2.0/UDP 159.8.174.148:5060;received=10.112.247.227;branch=z9hG4bK1644df37;rport=5060
Record-Route: <sip:5.10.112.121;r2=on;lr=on;ftag=as58cf6c6b;nat=yes>
Record-Route: <sip:10.112.247.244;r2=on;lr=on;ftag=as58cf6c6b;nat=yes>
CSeq: 102 INVITE
Call-ID: 0ba0902e484d73b21269fccd11a7e1bf@sip.nexmo.com
From: "986410091" <sip:986410091@sip.nexmo.com>;tag=as58cf6c6b
Server: Restcomm 7.6.0.873
Contact: <sip:54.194.81.211:5060>
Content-Type: application/sdp
X-RestComm-CallSid: CA4230dadd85064a649bc4e3f8b585afba
Content-Length: 386
v=0
o=- 1461612962389 1 IN IP4 54.194.81.211
s=Mobicents Media Server
c=IN IP4 54.194.81.211
t=0 0
m=audio 65040 RTP/AVP 8 0 18 97 101
c=IN IP4 54.194.81.211
a=sendrecv
a=rtcp:65041 IN IP4 172.17.0.3
a=ptime:20
a=rtpmap:0 pcmu/8000
a=rtpmap:101 telephone-event/8000
a=rtpmap:18 g729/8000
a=rtpmap:97 l16/8000
a=rtpmap:8 pcma/8000
a=ssrc:2972044963 cname:vXaGhWYE+gGeeXeq
]]>
</message>
19:36:02,399 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-111) current state: initializing , will wait for ACK to move to inProgress
19:36:02,410 INFO [gov.nist.javax.sip.stack.UDPMessageChannel] (Restcomm-SIP-Servlets-UDPMessageChannelThread-14) Setting SIPMessage peerPacketSource to: /5.10.112.121:5060
19:36:02,411 INFO [gov.nist.javax.sip.stack.SIPTransactionStack] (Restcomm-SIP-Servlets-UDPMessageChannelThread-14) <message
from="5.10.112.121:5060"
to="172.17.0.3:5060"
time="1461612962410"
isSender="false"
transactionId="z9hg4bk83c4.d6b55d7c37359bb5f950e7e79ed9e322.0"
callId="0ba0902e484d73b21269fccd11a7e1bf@sip.nexmo.com"
firstLine="ACK sip:54.194.81.211:5060 SIP/2.0"
>
<![CDATA[ACK sip:54.194.81.211:5060 SIP/2.0
Via: SIP/2.0/UDP 5.10.112.121;branch=z9hG4bK83c4.d6b55d7c37359bb5f950e7e79ed9e322.0
Via: SIP/2.0/UDP 159.8.174.148:5060;received=10.112.247.227;branch=z9hG4bK5751cb36;rport=5060
Max-Forwards: 69
From: "986410091" <sip:986410091@sip.nexmo.com>;tag=as58cf6c6b
To: <sip:34986160292@sip.nexmo.com>;tag=36539627_48e9fc4b_57a5b08a_454bd439
Contact: <sip:986410091@159.8.174.148:5060;alias=10.112.247.227~5060~1>
Call-ID: 0ba0902e484d73b21269fccd11a7e1bf@sip.nexmo.com
CSeq: 102 ACK
User-Agent: Nexmo Media 3-1
Content-Length: 0
]]>
</message>
19:36:02,414 INFO [org.mobicents.servlet.restcomm.telephony.util.B2BUAHelper] (RestComm-akka.actor.default-dispatcher-106) SIP SESSION is NULL
19:36:02,415 INFO [org.mobicents.servlet.restcomm.telephony.CallManager] (RestComm-akka.actor.default-dispatcher-106) Linked Response couldn't be found for ACK request
19:36:02,415 INFO [org.mobicents.servlet.restcomm.telephony.CallManager] (RestComm-akka.actor.default-dispatcher-106) Will send ACK to call actor: akka://RestComm/user/$z
19:36:02,416 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-106) ********** Call's akka://RestComm/user/$z Current State: "initializing direction: inbound
19:36:02,417 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-106) ********** Call akka://RestComm/user/$z Processing Message: "org.mobicents.servlet.sip.message.Servlet3SipServletRequestImpl sender : akka://RestComm/user/$f
19:36:02,418 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-106) ACK received moving state to inProgress
19:36:02,418 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-103) ********** VoiceInterpreter's akka://RestComm/user/$y Current State: initializing call
19:36:02,418 INFO [com.telestax.servlet.MonitoringService] (RestComm-akka.actor.default-dispatcher-103) MonitoringService Processing Message: "org.mobicents.servlet.restcomm.telephony.CallStateChanged sender : class akka.actor.RepointableActorRef self is terminated: false
19:36:02,418 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-103) ********** VoiceInterpreter's akka://RestComm/user/$y Processing Message: org.mobicents.servlet.restcomm.telephony.CallStateChanged
19:36:02,418 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-103) VoiceInterpreter received CallStateChanged event: in-progress
19:36:02,418 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-103) status callback is null
19:36:02,419 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-103) ********** VoiceInterpreter's akka://RestComm/user/$y Current State: ready
19:36:02,419 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-103) ********** VoiceInterpreter's akka://RestComm/user/$y Processing Message: org.mobicents.servlet.restcomm.interpreter.rcml.Tag
19:36:02,419 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-103) Checking cache for hash: b1552a3c202286c41271e83c0415925248956292fb61798b8bafc782764df15f
19:36:02,419 ERROR [org.mobicents.servlet.restcomm.cache.DiskCache] (RestComm-akka.actor.default-dispatcher-103) Error while chaching WARNING arguments left: 1
19:36:02,419 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-103) ********** VoiceInterpreter's akka://RestComm/user/$y Current State: checkingCache
19:36:02,420 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-103) ********** VoiceInterpreter's akka://RestComm/user/$y Processing Message: org.mobicents.servlet.restcomm.cache.DiskCacheResponse
19:36:02,601 ERROR [org.mobicents.servlet.restcomm.tts.VoiceRSSSpeechSynthesizer] (RestComm-akka.actor.default-dispatcher-111) VoiceRSSSpeechSynthesizer error: ERROR: The API key is not available!
19:36:02,601 ERROR [org.mobicents.servlet.restcomm.tts.VoiceRSSSpeechSynthesizer] (RestComm-akka.actor.default-dispatcher-111) There was an exception while trying to synthesize message: org.mobicents.servlet.restcomm.tts.api.SpeechSynthesizerException: ERROR: The API key is not available!
19:36:02,602 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-111) ********** VoiceInterpreter's akka://RestComm/user/$y Current State: synthesizing
19:36:02,602 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-111) ********** VoiceInterpreter's akka://RestComm/user/$y Processing Message: org.mobicents.servlet.restcomm.tts.api.SpeechSynthesizerResponse
19:36:02,602 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-111) ********** Call's akka://RestComm/user/$z Current State: "in progress direction: inbound
19:36:02,602 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-111) ********** Call akka://RestComm/user/$z Processing Message: "org.mobicents.servlet.restcomm.telephony.Hangup sender : akka://RestComm/user/$y
19:36:02,603 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-111) Checking RURI, realInetUri: null byeRURI: /159.8.174.148
19:36:02,603 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-111) Will sent out BYE to: sip:986410091@159.8.174.148:5060;alias=10.112.247.227~5060~1
19:36:02,607 INFO [gov.nist.javax.sip.stack.SIPTransactionStack] (RestComm-akka.actor.default-dispatcher-110) <message
from="172.17.0.3:5060"
to="5.10.112.121:5060"
time="1461612962607"
isSender="true"
transactionId="z9hg4bk454bd439_57a5b08a_7bb25412-6f79-4310-9ff5-510b9fd2f5c4"
callId="0ba0902e484d73b21269fccd11a7e1bf@sip.nexmo.com"
firstLine="BYE sip:986410091@159.8.174.148:5060;alias=10.112.247.227~5060~1 SIP/2.0"
>
<![CDATA[BYE sip:986410091@159.8.174.148:5060;alias=10.112.247.227~5060~1 SIP/2.0
CSeq: 1 BYE
From: <sip:34986160292@sip.nexmo.com>;tag=36539627_48e9fc4b_57a5b08a_454bd439
To: "986410091" <sip:986410091@sip.nexmo.com>;tag=as58cf6c6b
Call-ID: 0ba0902e484d73b21269fccd11a7e1bf@sip.nexmo.com
Max-Forwards: 70
User-Agent: Restcomm 7.6.0.873
Via: SIP/2.0/UDP 54.194.81.211:5060;branch=z9hG4bK454bd439_57a5b08a_7bb25412-6f79-4310-9ff5-510b9fd2f5c4
Route: <sip:5.10.112.121;r2=on;lr=on;ftag=as58cf6c6b;nat=yes>
Route: <sip:10.112.247.244;r2=on;lr=on;ftag=as58cf6c6b;nat=yes>
Content-Length: 0
]]>
</message>
19:36:02,608 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-110) ********** Call Controller Current State: "active
19:36:02,608 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-110) ********** Call Controller Processing Message: "org.mobicents.servlet.restcomm.mscontrol.messages.CloseMediaSession sender : class akka.actor.RepointableActorRef
19:36:02,609 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-110) ********** Media Group akka://RestComm/user/$A/$a Current State: "active
19:36:02,609 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-110) ********** Media Group akka://RestComm/user/$A/$a Processing Message: "org.mobicents.servlet.restcomm.mscontrol.messages.StopMediaGroup sender : class akka.actor.RepointableActorRef
19:36:02,620 INFO [gov.nist.javax.sip.stack.UDPMessageChannel] (Restcomm-SIP-Servlets-UDPMessageChannelThread-15) Setting SIPMessage peerPacketSource to: /5.10.112.121:5060
19:36:02,621 INFO [gov.nist.javax.sip.stack.SIPTransactionStack] (Restcomm-SIP-Servlets-UDPMessageChannelThread-15) <message
from="5.10.112.121:5060"
to="172.17.0.3:5060"
time="1461612962620"
isSender="false"
transactionId="z9hg4bk454bd439_57a5b08a_7bb25412-6f79-4310-9ff5-510b9fd2f5c4"
callId="0ba0902e484d73b21269fccd11a7e1bf@sip.nexmo.com"
firstLine="SIP/2.0 200 OK"
>
<![CDATA[SIP/2.0 200 OK
Via: SIP/2.0/UDP 54.194.81.211:5060;rport=5060;branch=z9hG4bK454bd439_57a5b08a_7bb25412-6f79-4310-9ff5-510b9fd2f5c4
From: <sip:34986160292@sip.nexmo.com>;tag=36539627_48e9fc4b_57a5b08a_454bd439
To: "986410091" <sip:986410091@sip.nexmo.com>;tag=as58cf6c6b
Call-ID: 0ba0902e484d73b21269fccd11a7e1bf@sip.nexmo.com
CSeq: 1 BYE
Server: Nexmo Media 3-1
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,REFER,SUBSCRIBE,NOTIFY,INFO,PUBLISH,MESSAGE
Supported: replaces,timer
Content-Length: 0
]]>
</message>
19:36:02,622 INFO [gov.nist.javax.sip.stack.SIPTransactionStack] (Restcomm-SIP-Servlets-UDPMessageChannelThread-15) <message
from="5.10.112.121:5060"
to="172.17.0.3:5060"
time="1461612962622"
isSender="false"
transactionId="z9hg4bk454bd439_57a5b08a_7bb25412-6f79-4310-9ff5-510b9fd2f5c4"
callId="0ba0902e484d73b21269fccd11a7e1bf@sip.nexmo.com"
firstLine="SIP/2.0 200 OK"
>
<![CDATA[SIP/2.0 200 OK
Via: SIP/2.0/UDP 54.194.81.211:5060;rport=5060;branch=z9hG4bK454bd439_57a5b08a_7bb25412-6f79-4310-9ff5-510b9fd2f5c4
From: <sip:34986160292@sip.nexmo.com>;tag=36539627_48e9fc4b_57a5b08a_454bd439
To: "986410091" <sip:986410091@sip.nexmo.com>;tag=as58cf6c6b
Call-ID: 0ba0902e484d73b21269fccd11a7e1bf@sip.nexmo.com
CSeq: 1 BYE
Server: Nexmo Media 3-1
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,REFER,SUBSCRIBE,NOTIFY,INFO,PUBLISH,MESSAGE
Supported: replaces,timer
Content-Length: 0
]]>
</message>
19:36:02,631 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-109) ********** Media Group akka://RestComm/user/$A/$a Current State: "deactivating
19:36:02,631 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-109) ********** Call Controller Current State: "stopping
19:36:02,631 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-109) ********** Call Controller Processing Message: "org.mobicents.servlet.restcomm.mgcp.EndpointStateChanged sender : class akka.actor.LocalActorRef
19:36:02,631 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-109) ********** Media Group akka://RestComm/user/$A/$a Processing Message: "org.mobicents.servlet.restcomm.mgcp.EndpointStateChanged sender : class akka.actor.LocalActorRef
19:36:02,631 INFO [org.mobicents.servlet.restcomm.mgcp.BridgeEndpoint] (RestComm-akka.actor.default-dispatcher-109) Bridge: akka://RestComm/user/$b/$u bridge id: mobicents/bridge/6@172.17.0.3:2427 at postStop, sender: akka://RestComm/deadLetters
19:36:02,632 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-108) MediaGroup :akka://RestComm/user/$A/$a at postStop, about to stop ivr endpoint :akka://RestComm/user/$b/$v
19:36:02,632 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-108) ********** Call Controller Current State: "stopping
19:36:02,632 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-108) ********** Call Controller Processing Message: "org.mobicents.servlet.restcomm.mscontrol.messages.MediaGroupStateChanged sender : class akka.actor.LocalActorRef
19:36:02,632 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-108) De-activating Call Controller
19:36:02,633 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-108) ********** Call's akka://RestComm/user/$z Current State: "stopping direction: inbound
19:36:02,633 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-108) ********** Call akka://RestComm/user/$z Processing Message: "org.mobicents.servlet.restcomm.mscontrol.messages.MediaServerControllerStateChanged sender : akka://RestComm/user/$A
19:36:02,633 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-108) Completing Call sid: CA4230dadd85064a649bc4e3f8b585afba from: sip:986410091@sip.nexmo.com to: sip:34986160292@sip.nexmo.com direction: inbound current external state: in-progress
19:36:02,633 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-108) Call sid: CA4230dadd85064a649bc4e3f8b585afba from: sip:986410091@sip.nexmo.com to: sip:34986160292@sip.nexmo.com direction: inbound new external state: completed
19:36:02,633 INFO [com.telestax.servlet.MonitoringService] (RestComm-akka.actor.default-dispatcher-108) MonitoringService Processing Message: "org.mobicents.servlet.restcomm.telephony.CallStateChanged sender : class akka.actor.RepointableActorRef self is terminated: false
19:36:02,633 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-108) ********** VoiceInterpreter's akka://RestComm/user/$y Current State: hanging up
19:36:02,634 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-108) ********** VoiceInterpreter's akka://RestComm/user/$y Processing Message: org.mobicents.servlet.restcomm.telephony.CallStateChanged
19:36:02,634 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-108) VoiceInterpreter received CallStateChanged event: completed
19:36:02,634 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-108) At Finished state, state: hanging up
19:36:02,634 INFO [org.mobicents.servlet.restcomm.mgcp.MediaGateway] (RestComm-akka.actor.default-dispatcher-105) Gateway: akka://RestComm/user/$b about to stop endpoint path: akka://RestComm/user/$b/$v isTerminated: true sender: akka://RestComm/deadLetters
19:36:02,636 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-105) Proceeding to execute Dial Action attribute
19:36:02,637 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-109) Trying to get inbound call Info
19:36:02,638 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-109) ********** Call's akka://RestComm/user/$z Current State: "completed direction: inbound
19:36:02,638 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-109) ********** Call akka://RestComm/user/$z Processing Message: "org.mobicents.servlet.restcomm.telephony.GetCallInfo sender : akka://RestComm/temp/$f
19:36:02,638 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-109) status callback is null
19:36:02,639 INFO [org.mobicents.servlet.restcomm.telephony.CallManager] (RestComm-akka.actor.default-dispatcher-107) About to destroy call: akka://RestComm/user/$z
19:36:02,640 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-105) Sent stop observing for call, from: sip:986410091@sip.nexmo.com to: sip:34986160292@sip.nexmo.com direction: inbound to observer: akka://RestComm/user/$y observer is terminated: false
19:36:02,640 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-105) Sent stop observing for call, from: sip:986410091@sip.nexmo.com to: sip:34986160292@sip.nexmo.com direction: inbound to observer: akka://RestComm/user/$a observer is terminated: false
19:36:02,640 INFO [com.telestax.servlet.MonitoringService] (RestComm-akka.actor.default-dispatcher-105) MonitoringService Processing Message: "org.mobicents.servlet.restcomm.patterns.StopObserving sender : class akka.actor.RepointableActorRef self is terminated: false
19:36:02,640 INFO [com.telestax.servlet.MonitoringService] (RestComm-akka.actor.default-dispatcher-105) Received stop observing
19:36:02,642 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-110) VoiceIntepreter: akka://RestComm/user/$yAt the postStop() method. Will clean up Voice Interpreter. Keep calls: false
19:36:02,643 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-110) At postStop(), will clean up call
19:36:02,643 INFO [org.mobicents.servlet.restcomm.telephony.CallManager] (RestComm-akka.actor.default-dispatcher-110) About to destroy call: akka://RestComm/user/$z
19:36:07,625 INFO [org.mobicents.servlet.sip.core.SipApplicationDispatcherImpl] (DefaultSipTimerThread) transaction gov.nist.javax.sip.stack.SIPClientTransactionImpl@fe15a24b terminated => BYE sip:986410091@159.8.174.148:5060;alias=10.112.247.227~5060~1 SIP/2.0
CSeq: 1 BYE
From: <sip:34986160292@sip.nexmo.com>;tag=36539627_48e9fc4b_57a5b08a_454bd439
To: "986410091" <sip:986410091@sip.nexmo.com>;tag=as58cf6c6b
Call-ID: 0ba0902e484d73b21269fccd11a7e1bf@sip.nexmo.com
Max-Forwards: 70
User-Agent: Restcomm 7.6.0.873
Via: SIP/2.0/UDP 54.194.81.211:5060;branch=z9hG4bK454bd439_57a5b08a_7bb25412-6f79-4310-9ff5-510b9fd2f5c4
Route: <sip:5.10.112.121;r2=on;lr=on;ftag=as58cf6c6b;nat=yes>
Route: <sip:10.112.247.244;r2=on;lr=on;ftag=as58cf6c6b;nat=yes>
Content-Length: 0
19:36:07,625 INFO [org.mobicents.servlet.sip.core.SipApplicationDispatcherImpl] (MSS-Executor-Thread-6) transaction gov.nist.javax.sip.stack.SIPClientTransactionImpl@fe15a24b terminated => BYE sip:986410091@159.8.174.148:5060;alias=10.112.247.227~5060~1 SIP/2.0
CSeq: 1 BYE
From: <sip:34986160292@sip.nexmo.com>;tag=36539627_48e9fc4b_57a5b08a_454bd439
To: "986410091" <sip:986410091@sip.nexmo.com>;tag=as58cf6c6b
Call-ID: 0ba0902e484d73b21269fccd11a7e1bf@sip.nexmo.com
Max-Forwards: 70
User-Agent: Restcomm 7.6.0.873
Via: SIP/2.0/UDP 54.194.81.211:5060;branch=z9hG4bK454bd439_57a5b08a_7bb25412-6f79-4310-9ff5-510b9fd2f5c4
Route: <sip:5.10.112.121;r2=on;lr=on;ftag=as58cf6c6b;nat=yes>
Route: <sip:10.112.247.244;r2=on;lr=on;ftag=as58cf6c6b;nat=yes>
Content-Length: 0
19:36:07,629 INFO [org.mobicents.servlet.sip.core.session.SipSessionImpl] (MSS-Executor-Thread-6) Invalidating the sip session (as58cf6c6b;0ba0902e484d73b21269fccd11a7e1bf@sip.nexmo.com;454bd439;RestComm)
19:36:07,631 INFO [org.mobicents.servlet.sip.core.session.SipApplicationSessionImpl] (MSS-Executor-Thread-6) Invalidating the following sip application session 454bd439;RestComm
19:36:07,632 INFO [org.mobicents.servlet.sip.core.session.SipApplicationSessionImpl] (MSS-Executor-Thread-6) The following sip application session 454bd439;RestComm has been invalidated
11:47:29,502 INFO [org.mobicents.servlet.restcomm.rvd.http.resources.ProjectRestService] (http-/172.17.0.3:443-3) running /uploadwav
11:47:35,433 INFO [org.mobicents.servlet.restcomm.rvd.http.resources.ProjectRestService] (http-/172.17.0.3:443-3) Saving project AP3365639b7b1243a7a5729018037abdba
11:47:41,619 INFO [gov.nist.javax.sip.stack.UDPMessageChannel] (Restcomm-SIP-Servlets-UDPMessageChannelThread-13) Setting SIPMessage peerPacketSource to: /5.10.112.121:5060
11:47:41,619 INFO [gov.nist.javax.sip.stack.SIPTransactionStack] (Restcomm-SIP-Servlets-UDPMessageChannelThread-13) <message
from="5.10.112.121:5060"
to="172.17.0.3:5060"
time="1461671261616"
isSender="false"
transactionId="z9hg4bk90bf.a75b5a21fc871de48effaca09a7a05dc.0"
callId="1f1e1ff55e5d47cb0c36bee8077d9ec7@sip.nexmo.com"
firstLine="INVITE sip:34986160292@54.194.81.211 SIP/2.0"
>
<![CDATA[INVITE sip:34986160292@54.194.81.211 SIP/2.0
Record-Route: <sip:5.10.112.121;r2=on;lr=on;ftag=as03abd276;nat=yes>
Record-Route: <sip:10.112.247.244;r2=on;lr=on;ftag=as03abd276;nat=yes>
Via: SIP/2.0/UDP 5.10.112.121;branch=z9hG4bK90bf.a75b5a21fc871de48effaca09a7a05dc.0
Via: SIP/2.0/UDP 159.8.174.148:5060;received=10.112.247.227;branch=z9hG4bK252d718a;rport=5060
Max-Forwards: 69
From: "986410091" <sip:986410091@sip.nexmo.com>;tag=as03abd276
To: <sip:34986160292@sip.nexmo.com>
Contact: <sip:986410091@159.8.174.148:5060;alias=10.112.247.227~5060~1>
Call-ID: 1f1e1ff55e5d47cb0c36bee8077d9ec7@sip.nexmo.com
CSeq: 102 INVITE
User-Agent: Nexmo Media 3-1
Date: Tue, 26 Apr 2016 11:47:41 GMT
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,REFER,SUBSCRIBE,NOTIFY,INFO,PUBLISH,MESSAGE
Supported: replaces,timer
P-Asserted-Identity: "986410091" <sip:986410091@sip.nexmo.com>
Content-Type: application/sdp
Content-Length: 394
v=0
o=Nexmo 1833112922 1833112922 IN IP4 159.8.174.148
s=Nexmo
c=IN IP4 159.8.174.148
t=0 0
m=audio 19310 RTP/AVP 8 0 97 18 9 117 101
a=rtpmap:8 PCMA/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:97 iLBC/8000
a=fmtp:97 mode=30
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:9 G722/8000
a=rtpmap:117 speex/16000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=sendrecv
]]>
</message>
11:47:41,622 INFO [org.mobicents.servlet.sip.core.dispatchers.InitialRequestDispatcher] (Restcomm-SIP-Servlets-UDPMessageChannelThread-13) Request event dispatched to RestComm
11:47:41,634 INFO [org.mobicents.servlet.restcomm.telephony.CallManager] (RestComm-akka.actor.default-dispatcher-38) ToHost: sip.nexmo.com
11:47:41,635 INFO [org.mobicents.servlet.restcomm.telephony.CallManager] (RestComm-akka.actor.default-dispatcher-38) ruri: 54.194.81.211
11:47:41,635 INFO [org.mobicents.servlet.restcomm.telephony.CallManager] (RestComm-akka.actor.default-dispatcher-38) myHostIp: 172.17.0.3
11:47:41,636 INFO [org.mobicents.servlet.restcomm.telephony.CallManager] (RestComm-akka.actor.default-dispatcher-38) mediaExternalIp: 54.194.81.211
11:47:41,636 INFO [org.mobicents.servlet.restcomm.telephony.CallManager] (RestComm-akka.actor.default-dispatcher-38) proxyIp: 127.0.0.1
11:47:41,640 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-40) ********** Call's akka://RestComm/user/$s Current State: "uninitialized direction: null
11:47:41,641 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-42) ********** Call akka://RestComm/user/$s Processing Message: "org.mobicents.servlet.sip.message.Servlet3SipServletRequestImpl sender : akka://RestComm/user/$f
11:47:41,644 INFO [gov.nist.javax.sip.stack.SIPTransactionStack] (RestComm-akka.actor.default-dispatcher-39) <message
from="172.17.0.3:5060"
to="5.10.112.121:5060"
time="1461671261643"
isSender="true"
transactionId="z9hg4bk90bf.a75b5a21fc871de48effaca09a7a05dc.0"
callId="1f1e1ff55e5d47cb0c36bee8077d9ec7@sip.nexmo.com"
firstLine="SIP/2.0 180 Ringing"
>
<![CDATA[SIP/2.0 180 Ringing
To: <sip:34986160292@sip.nexmo.com>;tag=34276615_0d2e2b5f_57a5b08a_b7364acd
Via: SIP/2.0/UDP 5.10.112.121;branch=z9hG4bK90bf.a75b5a21fc871de48effaca09a7a05dc.0
Via: SIP/2.0/UDP 159.8.174.148:5060;received=10.112.247.227;branch=z9hG4bK252d718a;rport=5060
Record-Route: <sip:5.10.112.121;r2=on;lr=on;ftag=as03abd276;nat=yes>
Record-Route: <sip:10.112.247.244;r2=on;lr=on;ftag=as03abd276;nat=yes>
CSeq: 102 INVITE
Call-ID: 1f1e1ff55e5d47cb0c36bee8077d9ec7@sip.nexmo.com
From: "986410091" <sip:986410091@sip.nexmo.com>;tag=as03abd276
Server: Restcomm 7.6.0.879
Contact: <sip:54.194.81.211:5060>
X-RestComm-CallSid: CA12ae7b5d03e844e99afbd44ddb330dc3
Content-Length: 0
]]>
</message>
11:47:41,645 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-39) ********** VoiceInterpreter's akka://RestComm/user/$r Current State: uninitialized
11:47:41,645 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-39) ********** VoiceInterpreter's akka://RestComm/user/$r Processing Message: org.mobicents.servlet.restcomm.interpreter.StartInterpreter
11:47:41,645 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-39) ********** VoiceInterpreter's akka://RestComm/user/$r Current State: acquiring asr info
11:47:41,645 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-39) ********** VoiceInterpreter's akka://RestComm/user/$r Processing Message: org.mobicents.servlet.restcomm.asr.AsrResponse
11:47:41,646 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-39) ********** VoiceInterpreter's akka://RestComm/user/$r Current State: acquiring tts info
11:47:41,646 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-39) ********** VoiceInterpreter's akka://RestComm/user/$r Processing Message: org.mobicents.servlet.restcomm.tts.api.SpeechSynthesizerResponse
11:47:41,646 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-39) ********** Call's akka://RestComm/user/$s Current State: "ringing direction: inbound
11:47:41,646 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-39) ********** Call akka://RestComm/user/$s Processing Message: "org.mobicents.servlet.restcomm.telephony.GetCallInfo sender : akka://RestComm/user/$r
11:47:41,647 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-39) ********** VoiceInterpreter's akka://RestComm/user/$r Current State: acquiring call info
11:47:41,647 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-39) ********** VoiceInterpreter's akka://RestComm/user/$r Processing Message: org.mobicents.servlet.restcomm.telephony.CallResponse
11:47:41,647 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-39) ********** Call's akka://RestComm/user/$s Current State: "ringing direction: inbound
11:47:41,647 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-39) ********** Call akka://RestComm/user/$s Processing Message: "org.mobicents.servlet.restcomm.patterns.Observe sender : akka://RestComm/user/$r
11:47:41,651 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-42) ********** Call's akka://RestComm/user/$s Current State: "ringing direction: inbound
11:47:41,655 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-42) ********** Call akka://RestComm/user/$s Processing Message: "org.mobicents.servlet.restcomm.patterns.Observe sender : akka://RestComm/user/$r
11:47:41,655 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-42) status callback is null
11:47:41,655 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-42) ********** VoiceInterpreter's akka://RestComm/user/$r Current State: downloading rcml
11:47:41,656 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-42) ********** VoiceInterpreter's akka://RestComm/user/$r Processing Message: org.mobicents.servlet.restcomm.patterns.Observing
11:47:41,656 INFO [com.telestax.servlet.MonitoringService] (RestComm-akka.actor.default-dispatcher-41) MonitoringService Processing Message: "org.mobicents.servlet.restcomm.patterns.Observing sender : class akka.actor.RepointableActorRef self is terminated: false
11:47:41,657 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-41) ********** Call's akka://RestComm/user/$s Current State: "ringing direction: inbound
11:47:41,657 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-41) ********** Call akka://RestComm/user/$s Processing Message: "org.mobicents.servlet.restcomm.telephony.GetCallInfo sender : akka://RestComm/user/$a
11:47:41,657 INFO [com.telestax.servlet.MonitoringService] (RestComm-akka.actor.default-dispatcher-41) MonitoringService Processing Message: "org.mobicents.servlet.restcomm.telephony.CallResponse sender : class akka.actor.RepointableActorRef self is terminated: false
11:47:41,726 INFO [org.mobicents.servlet.restcomm.rvd.http.resources.RvdController] (http-/172.17.0.3:443-2) Received Restcomm POST request
11:47:41,732 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-36) ********** VoiceInterpreter's akka://RestComm/user/$r Current State: downloading rcml
11:47:41,733 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-36) ********** VoiceInterpreter's akka://RestComm/user/$r Processing Message: org.mobicents.servlet.restcomm.http.client.DownloaderResponse
11:47:41,733 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-36) Downloader response is success, moving to Ready state
11:47:41,734 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-36) ********** VoiceInterpreter's akka://RestComm/user/$r Current State: ready
11:47:41,734 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-36) ********** VoiceInterpreter's akka://RestComm/user/$r Processing Message: org.mobicents.servlet.restcomm.interpreter.rcml.Tag
11:47:41,734 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-36) ********** Call's akka://RestComm/user/$s Current State: "ringing direction: inbound
11:47:41,735 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-36) ********** Call akka://RestComm/user/$s Processing Message: "org.mobicents.servlet.restcomm.telephony.Answer sender : akka://RestComm/user/$r
11:47:41,735 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-36) ExternalSipUri stored in the session was null, will use the message InitialRemoteAddr: 5.10.112.121
11:47:41,735 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-36) ********** Call Controller Current State: "uninitialized
11:47:41,736 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-36) ********** Call Controller Processing Message: "org.mobicents.servlet.restcomm.patterns.Observe sender : class akka.actor.RepointableActorRef
11:47:41,736 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-36) ********** Call Controller Current State: "uninitialized
11:47:41,736 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-36) ********** Call Controller Processing Message: "org.mobicents.servlet.restcomm.mscontrol.messages.CreateMediaSession sender : class akka.actor.RepointableActorRef
11:47:41,736 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-36) ********** Call's akka://RestComm/user/$s Current State: "initializing direction: inbound
11:47:41,737 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-36) ********** Call akka://RestComm/user/$s Processing Message: "org.mobicents.servlet.restcomm.patterns.Observing sender : akka://RestComm/user/$t
11:47:41,737 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-36) ********** Call Controller Current State: "acquiring media gateway info
11:47:41,737 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-36) ********** Call Controller Processing Message: "org.mobicents.servlet.restcomm.mgcp.MediaGatewayResponse sender : class akka.actor.RepointableActorRef
11:47:41,738 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-36) ********** Call Controller Current State: "acquiring media session
11:47:41,738 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-36) ********** Call Controller Processing Message: "org.mobicents.servlet.restcomm.mgcp.MediaGatewayResponse sender : class akka.actor.RepointableActorRef
11:47:41,738 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-36) ********** Call Controller Current State: "acquiring media bridge
11:47:41,738 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-36) ********** Call Controller Processing Message: "org.mobicents.servlet.restcomm.mgcp.MediaGatewayResponse sender : class akka.actor.RepointableActorRef
11:47:41,739 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-36) ********** Media Group akka://RestComm/user/$t/$a Current State: "uninitialized
11:47:41,739 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-36) ********** Media Group akka://RestComm/user/$t/$a Processing Message: "org.mobicents.servlet.restcomm.patterns.Observe sender : class akka.actor.RepointableActorRef
11:47:41,739 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-36) ********** Media Group akka://RestComm/user/$t/$a Current State: "uninitialized
11:47:41,739 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-41) ********** Media Group akka://RestComm/user/$t/$a Processing Message: "org.mobicents.servlet.restcomm.mscontrol.messages.StartMediaGroup sender : class akka.actor.RepointableActorRef
11:47:41,740 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-41) MediaGroup: akka://RestComm/user/$t/$a got StartMediaGroup from: akka://RestComm/user/$t endpoint: akka://RestComm/user/$b/$m isTerminated: false
11:47:41,740 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-41) MediaGroup :akka://RestComm/user/$t/$a state: uninitialized session: 4 will ask to get IvrEndpoint
11:47:41,740 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-41) ********** Call Controller Current State: "creating media group
11:47:41,740 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-41) ********** Call Controller Processing Message: "org.mobicents.servlet.restcomm.patterns.Observing sender : class akka.actor.LocalActorRef
11:47:41,740 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-41) ********** Call Controller Current State: "creating media group
11:47:41,740 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-41) ********** Call Controller Processing Message: "org.mobicents.servlet.restcomm.patterns.Observing sender : class akka.actor.LocalActorRef
11:47:41,741 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-41) ********** Media Group akka://RestComm/user/$t/$a Current State: "acquiring ivr
11:47:41,741 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-41) ********** Media Group akka://RestComm/user/$t/$a Processing Message: "org.mobicents.servlet.restcomm.mgcp.MediaGatewayResponse sender : class akka.actor.RepointableActorRef
11:47:41,741 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-41) MediaGroup :akka://RestComm/user/$t/$a state: acquiring ivr session: 4 ivr endpoint: akka://RestComm/user/$b/$n will ask to get Link
11:47:41,741 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-41) ********** Media Group akka://RestComm/user/$t/$a Current State: "acquiring link
11:47:41,741 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-41) ********** Media Group akka://RestComm/user/$t/$a Processing Message: "org.mobicents.servlet.restcomm.patterns.Observing sender : class akka.actor.LocalActorRef
11:47:41,742 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-41) ********** Media Group akka://RestComm/user/$t/$a Current State: "acquiring link
11:47:41,742 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-41) ********** Media Group akka://RestComm/user/$t/$a Processing Message: "org.mobicents.servlet.restcomm.mgcp.MediaGatewayResponse sender : class akka.actor.RepointableActorRef
11:47:41,743 INFO [org.mobicents.servlet.restcomm.mgcp.Link] (RestComm-akka.actor.default-dispatcher-41) Link: akka://RestComm/user/$b/$o ,received InitializeLink message from sender: akka://RestComm/user/$t/$a
11:47:41,743 INFO [org.mobicents.servlet.restcomm.mgcp.Link] (RestComm-akka.actor.default-dispatcher-41) Link: akka://RestComm/user/$b/$o ,state: uninitialized ,primaryEndpoint: akka://RestComm/user/$b/$m ,secondaryEndpoint: akka://RestComm/user/$b/$n
11:47:41,743 INFO [org.mobicents.servlet.restcomm.mgcp.Link] (RestComm-akka.actor.default-dispatcher-41) Link: akka://RestComm/user/$b/$o ,state: uninitialized InviteEndpoint sent to primaryEndpoint: akka://RestComm/user/$b/$m
11:47:41,743 INFO [org.mobicents.servlet.restcomm.mgcp.Link] (RestComm-akka.actor.default-dispatcher-41) Link: akka://RestComm/user/$b/$o ,state: initializing primary ,primaryEndpointId: mobicents/bridge/$@172.17.0.3:2427 ,secondaryEndpoint: akka://RestComm/user/$b/$n secondaryEndpoint isTerminated: false
11:47:41,744 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-41) MediaGroup :akka://RestComm/user/$t/$a state: acquiring link session: 4 link: akka://RestComm/user/$b/$o endpoint: akka://RestComm/user/$b/$m initializeLink sent, endpoint isTerminated: false
11:47:41,744 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-41) ********** Media Group akka://RestComm/user/$t/$a Current State: "initializing link
11:47:41,744 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-41) ********** Media Group akka://RestComm/user/$t/$a Processing Message: "org.mobicents.servlet.restcomm.patterns.Observing sender : class akka.actor.LocalActorRef
11:47:41,744 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-41) ********** Media Group akka://RestComm/user/$t/$a Current State: "initializing link
11:47:41,744 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-41) ********** Media Group akka://RestComm/user/$t/$a Processing Message: "org.mobicents.servlet.restcomm.mgcp.LinkStateChanged sender : class akka.actor.LocalActorRef
11:47:41,745 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-41) MediaGroup :akka://RestComm/user/$t/$a state: initializing link session: 4 link: akka://RestComm/user/$b/$o will ask to open Link
11:47:41,749 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-41) ********** Media Group akka://RestComm/user/$t/$a Current State: "opening link
11:47:41,749 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-41) ********** Media Group akka://RestComm/user/$t/$a Processing Message: "org.mobicents.servlet.restcomm.mgcp.LinkStateChanged sender : class akka.actor.LocalActorRef
11:47:41,765 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-41) ********** Media Group akka://RestComm/user/$t/$a Current State: "updating link
11:47:41,766 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-41) ********** Media Group akka://RestComm/user/$t/$a Processing Message: "org.mobicents.servlet.restcomm.mgcp.LinkStateChanged sender : class akka.actor.LocalActorRef
11:47:41,767 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-41) ********** Call Controller Current State: "creating media group
11:47:41,767 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-41) ********** Call Controller Processing Message: "org.mobicents.servlet.restcomm.mscontrol.messages.MediaGroupStateChanged sender : class akka.actor.LocalActorRef
11:47:41,767 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-41) ********** Call Controller Current State: "acquiring connection
11:47:41,767 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-41) ********** Call Controller Processing Message: "org.mobicents.servlet.restcomm.mgcp.MediaGatewayResponse sender : class akka.actor.RepointableActorRef
11:47:41,768 INFO [org.mobicents.servlet.restcomm.mgcp.Connection] (RestComm-akka.actor.default-dispatcher-41) ********** Connection Current State: uninitialized
11:47:41,768 INFO [org.mobicents.servlet.restcomm.mgcp.Connection] (RestComm-akka.actor.default-dispatcher-41) ********** Connection Processing Message: org.mobicents.servlet.restcomm.patterns.Observe
11:47:41,768 INFO [org.mobicents.servlet.restcomm.mgcp.Connection] (RestComm-akka.actor.default-dispatcher-41) ********** Connection Current State: uninitialized
11:47:41,768 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-41) ********** Call Controller Current State: "initializing connection
11:47:41,768 INFO [org.mobicents.servlet.restcomm.mgcp.Connection] (RestComm-akka.actor.default-dispatcher-41) ********** Connection Processing Message: org.mobicents.servlet.restcomm.mgcp.InitializeConnection
11:47:41,768 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-41) ********** Call Controller Processing Message: "org.mobicents.servlet.restcomm.patterns.Observing sender : class akka.actor.LocalActorRef
11:47:41,769 INFO [org.mobicents.servlet.restcomm.mgcp.Connection] (RestComm-akka.actor.default-dispatcher-41) ********** Connection Current State: initializing
11:47:41,769 INFO [org.mobicents.servlet.restcomm.mgcp.Connection] (RestComm-akka.actor.default-dispatcher-41) ********** Connection Processing Message: org.mobicents.servlet.restcomm.mgcp.EndpointCredentials
11:47:41,769 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-41) ********** Call Controller Current State: "initializing connection
11:47:41,769 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-41) ********** Call Controller Processing Message: "org.mobicents.servlet.restcomm.mgcp.ConnectionStateChanged sender : class akka.actor.LocalActorRef
11:47:41,769 INFO [org.mobicents.servlet.restcomm.mgcp.Connection] (RestComm-akka.actor.default-dispatcher-41) ********** Connection Current State: closed
11:47:41,770 INFO [org.mobicents.servlet.restcomm.mgcp.Connection] (RestComm-akka.actor.default-dispatcher-41) ********** Connection Processing Message: org.mobicents.servlet.restcomm.mgcp.OpenConnection
11:47:41,786 INFO [org.mobicents.servlet.restcomm.mgcp.Connection] (RestComm-akka.actor.default-dispatcher-43) ********** Connection Current State: opening
11:47:41,789 INFO [org.mobicents.servlet.restcomm.mgcp.Connection] (RestComm-akka.actor.default-dispatcher-43) ********** Connection Processing Message: jain.protocol.ip.mgcp.message.CreateConnectionResponse
11:47:41,789 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-43) ********** Call Controller Current State: "opening connection
11:47:41,790 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-43) ********** Call Controller Processing Message: "org.mobicents.servlet.restcomm.mgcp.ConnectionStateChanged sender : class akka.actor.LocalActorRef
11:47:41,790 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-43) ********** Call's akka://RestComm/user/$s Current State: "initializing direction: inbound
11:47:41,790 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-43) ********** Call akka://RestComm/user/$s Processing Message: "org.mobicents.servlet.restcomm.mscontrol.messages.MediaServerControllerStateChanged sender : akka://RestComm/user/$t
11:47:41,789 INFO [gov.nist.javax.sip.stack.SIPTransactionStack] (RestComm-akka.actor.default-dispatcher-38) <message
from="172.17.0.3:5060"
to="5.10.112.121:5060"
time="1461671261788"
isSender="true"
transactionId="z9hg4bk90bf.a75b5a21fc871de48effaca09a7a05dc.0"
callId="1f1e1ff55e5d47cb0c36bee8077d9ec7@sip.nexmo.com"
firstLine="SIP/2.0 200 OK"
>
<![CDATA[SIP/2.0 200 OK
To: <sip:34986160292@sip.nexmo.com>;tag=34276615_0d2e2b5f_57a5b08a_b7364acd
Via: SIP/2.0/UDP 5.10.112.121;branch=z9hG4bK90bf.a75b5a21fc871de48effaca09a7a05dc.0
Via: SIP/2.0/UDP 159.8.174.148:5060;received=10.112.247.227;branch=z9hG4bK252d718a;rport=5060
Record-Route: <sip:5.10.112.121;r2=on;lr=on;ftag=as03abd276;nat=yes>
Record-Route: <sip:10.112.247.244;r2=on;lr=on;ftag=as03abd276;nat=yes>
CSeq: 102 INVITE
Call-ID: 1f1e1ff55e5d47cb0c36bee8077d9ec7@sip.nexmo.com
From: "986410091" <sip:986410091@sip.nexmo.com>;tag=as03abd276
Server: Restcomm 7.6.0.879
Contact: <sip:54.194.81.211:5060>
Content-Type: application/sdp
X-RestComm-CallSid: CA12ae7b5d03e844e99afbd44ddb330dc3
Content-Length: 386
v=0
o=- 1461671261785 1 IN IP4 54.194.81.211
s=Mobicents Media Server
c=IN IP4 54.194.81.211
t=0 0
m=audio 65044 RTP/AVP 8 0 18 97 101
c=IN IP4 54.194.81.211
a=sendrecv
a=rtcp:65045 IN IP4 172.17.0.3
a=ptime:20
a=rtpmap:0 pcmu/8000
a=rtpmap:101 telephone-event/8000
a=rtpmap:18 g729/8000
a=rtpmap:97 l16/8000
a=rtpmap:8 pcma/8000
a=ssrc:1399594841 cname:uH4wHTRUjtjz/UPb
]]>
</message>
11:47:41,791 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-38) current state: initializing , will wait for ACK to move to inProgress
11:47:41,801 INFO [gov.nist.javax.sip.stack.UDPMessageChannel] (Restcomm-SIP-Servlets-UDPMessageChannelThread-14) Setting SIPMessage peerPacketSource to: /5.10.112.121:5060
11:47:41,802 INFO [gov.nist.javax.sip.stack.SIPTransactionStack] (Restcomm-SIP-Servlets-UDPMessageChannelThread-14) <message
from="5.10.112.121:5060"
to="172.17.0.3:5060"
time="1461671261800"
isSender="false"
transactionId="z9hg4bk90bf.0902f03ddcace60cf9b05522a56cb48c.0"
callId="1f1e1ff55e5d47cb0c36bee8077d9ec7@sip.nexmo.com"
firstLine="ACK sip:54.194.81.211:5060 SIP/2.0"
>
<![CDATA[ACK sip:54.194.81.211:5060 SIP/2.0
Via: SIP/2.0/UDP 5.10.112.121;branch=z9hG4bK90bf.0902f03ddcace60cf9b05522a56cb48c.0
Via: SIP/2.0/UDP 159.8.174.148:5060;received=10.112.247.227;branch=z9hG4bK56c61a6f;rport=5060
Max-Forwards: 69
From: "986410091" <sip:986410091@sip.nexmo.com>;tag=as03abd276
To: <sip:34986160292@sip.nexmo.com>;tag=34276615_0d2e2b5f_57a5b08a_b7364acd
Contact: <sip:986410091@159.8.174.148:5060;alias=10.112.247.227~5060~1>
Call-ID: 1f1e1ff55e5d47cb0c36bee8077d9ec7@sip.nexmo.com
CSeq: 102 ACK
User-Agent: Nexmo Media 3-1
Content-Length: 0
]]>
</message>
11:47:41,803 INFO [org.mobicents.servlet.restcomm.telephony.util.B2BUAHelper] (RestComm-akka.actor.default-dispatcher-43) SIP SESSION is NULL
11:47:41,803 INFO [org.mobicents.servlet.restcomm.telephony.CallManager] (RestComm-akka.actor.default-dispatcher-38) Linked Response couldn't be found for ACK request
11:47:41,803 INFO [org.mobicents.servlet.restcomm.telephony.CallManager] (RestComm-akka.actor.default-dispatcher-43) Will send ACK to call actor: akka://RestComm/user/$s
11:47:41,804 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-42) ********** Call's akka://RestComm/user/$s Current State: "initializing direction: inbound
11:47:41,804 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-42) ********** Call akka://RestComm/user/$s Processing Message: "org.mobicents.servlet.sip.message.Servlet3SipServletRequestImpl sender : akka://RestComm/user/$f
11:47:41,804 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-42) ACK received moving state to inProgress
11:47:41,805 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-39) ********** VoiceInterpreter's akka://RestComm/user/$r Current State: initializing call
11:47:41,805 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-39) ********** VoiceInterpreter's akka://RestComm/user/$r Processing Message: org.mobicents.servlet.restcomm.telephony.CallStateChanged
11:47:41,807 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-40) VoiceInterpreter received CallStateChanged event: in-progress
11:47:41,807 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-40) status callback is null
11:47:41,807 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-40) ********** VoiceInterpreter's akka://RestComm/user/$r Current State: ready
11:47:41,808 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-40) ********** VoiceInterpreter's akka://RestComm/user/$r Processing Message: org.mobicents.servlet.restcomm.interpreter.rcml.Tag
11:47:41,810 INFO [com.telestax.servlet.MonitoringService] (RestComm-akka.actor.default-dispatcher-38) MonitoringService Processing Message: "org.mobicents.servlet.restcomm.telephony.CallStateChanged sender : class akka.actor.RepointableActorRef self is terminated: false
11:47:41,879 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-42) ********** VoiceInterpreter's akka://RestComm/user/$r Current State: caching
11:47:41,879 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-42) ********** VoiceInterpreter's akka://RestComm/user/$r Processing Message: org.mobicents.servlet.restcomm.cache.DiskCacheResponse
11:47:41,879 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-42) ********** Call's akka://RestComm/user/$s Current State: "in progress direction: inbound
11:47:41,880 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-42) ********** Call akka://RestComm/user/$s Processing Message: "org.mobicents.servlet.restcomm.mscontrol.messages.Play sender : akka://RestComm/user/$r
11:47:41,880 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-42) ********** Call Controller Current State: "active
11:47:41,880 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-42) ********** Call Controller Processing Message: "org.mobicents.servlet.restcomm.mscontrol.messages.Play sender : class akka.actor.RepointableActorRef
11:47:41,880 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-42) ********** Media Group akka://RestComm/user/$t/$a Current State: "active
11:47:41,880 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-42) ********** Media Group akka://RestComm/user/$t/$a Processing Message: "org.mobicents.servlet.restcomm.mscontrol.messages.Play sender : class akka.actor.RepointableActorRef
11:47:48,870 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-39) ********** Media Group akka://RestComm/user/$t/$a Current State: "active
11:47:48,870 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-39) ********** Media Group akka://RestComm/user/$t/$a Processing Message: "org.mobicents.servlet.restcomm.mgcp.IvrEndpointResponse sender : class akka.actor.LocalActorRef
11:47:48,871 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-39) ********** VoiceInterpreter's akka://RestComm/user/$r Current State: playing
11:47:48,871 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-39) ********** VoiceInterpreter's akka://RestComm/user/$r Processing Message: org.mobicents.servlet.restcomm.mscontrol.messages.MediaGroupResponse
11:47:48,871 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-39) MediaGroupResponse, succeeded: true null
11:47:48,872 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-39) ********** VoiceInterpreter's akka://RestComm/user/$r Current State: ready
11:47:48,872 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-39) ********** VoiceInterpreter's akka://RestComm/user/$r Processing Message: org.mobicents.servlet.restcomm.interpreter.rcml.End
11:47:48,872 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-39) End tag received will move to hangup the call
11:47:48,872 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-39) ********** Call's akka://RestComm/user/$s Current State: "in progress direction: inbound
11:47:48,872 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-39) ********** Call akka://RestComm/user/$s Processing Message: "org.mobicents.servlet.restcomm.telephony.Hangup sender : akka://RestComm/user/$r
11:47:48,873 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-40) Checking RURI, realInetUri: null byeRURI: /159.8.174.148
11:47:48,873 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-40) Will sent out BYE to: sip:986410091@159.8.174.148:5060;alias=10.112.247.227~5060~1
11:47:48,873 INFO [gov.nist.javax.sip.stack.SIPTransactionStack] (RestComm-akka.actor.default-dispatcher-41) <message
from="172.17.0.3:5060"
to="5.10.112.121:5060"
time="1461671268872"
isSender="true"
transactionId="z9hg4bkb7364acd_57a5b08a_5100ca09-c9c4-4682-b94b-631f3779efc2"
callId="1f1e1ff55e5d47cb0c36bee8077d9ec7@sip.nexmo.com"
firstLine="BYE sip:986410091@159.8.174.148:5060;alias=10.112.247.227~5060~1 SIP/2.0"
>
<![CDATA[BYE sip:986410091@159.8.174.148:5060;alias=10.112.247.227~5060~1 SIP/2.0
CSeq: 1 BYE
From: <sip:34986160292@sip.nexmo.com>;tag=34276615_0d2e2b5f_57a5b08a_b7364acd
To: "986410091" <sip:986410091@sip.nexmo.com>;tag=as03abd276
Call-ID: 1f1e1ff55e5d47cb0c36bee8077d9ec7@sip.nexmo.com
Max-Forwards: 70
User-Agent: Restcomm 7.6.0.879
Via: SIP/2.0/UDP 54.194.81.211:5060;branch=z9hG4bKb7364acd_57a5b08a_5100ca09-c9c4-4682-b94b-631f3779efc2
Route: <sip:5.10.112.121;r2=on;lr=on;ftag=as03abd276;nat=yes>
Route: <sip:10.112.247.244;r2=on;lr=on;ftag=as03abd276;nat=yes>
Content-Length: 0
]]>
</message>
11:47:48,874 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-41) ********** Call Controller Current State: "active
11:47:48,874 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-41) ********** Call Controller Processing Message: "org.mobicents.servlet.restcomm.mscontrol.messages.CloseMediaSession sender : class akka.actor.RepointableActorRef
11:47:48,874 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-41) ********** Media Group akka://RestComm/user/$t/$a Current State: "active
11:47:48,874 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-41) ********** Media Group akka://RestComm/user/$t/$a Processing Message: "org.mobicents.servlet.restcomm.mscontrol.messages.StopMediaGroup sender : class akka.actor.RepointableActorRef
11:47:48,885 INFO [gov.nist.javax.sip.stack.UDPMessageChannel] (Restcomm-SIP-Servlets-UDPMessageChannelThread-15) Setting SIPMessage peerPacketSource to: /5.10.112.121:5060
11:47:48,886 INFO [gov.nist.javax.sip.stack.SIPTransactionStack] (Restcomm-SIP-Servlets-UDPMessageChannelThread-15) <message
from="5.10.112.121:5060"
to="172.17.0.3:5060"
time="1461671268885"
isSender="false"
transactionId="z9hg4bkb7364acd_57a5b08a_5100ca09-c9c4-4682-b94b-631f3779efc2"
callId="1f1e1ff55e5d47cb0c36bee8077d9ec7@sip.nexmo.com"
firstLine="SIP/2.0 200 OK"
>
<![CDATA[SIP/2.0 200 OK
Via: SIP/2.0/UDP 54.194.81.211:5060;rport=5060;branch=z9hG4bKb7364acd_57a5b08a_5100ca09-c9c4-4682-b94b-631f3779efc2
From: <sip:34986160292@sip.nexmo.com>;tag=34276615_0d2e2b5f_57a5b08a_b7364acd
To: "986410091" <sip:986410091@sip.nexmo.com>;tag=as03abd276
Call-ID: 1f1e1ff55e5d47cb0c36bee8077d9ec7@sip.nexmo.com
CSeq: 1 BYE
Server: Nexmo Media 3-1
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,REFER,SUBSCRIBE,NOTIFY,INFO,PUBLISH,MESSAGE
Supported: replaces,timer
Content-Length: 0
]]>
</message>
11:47:48,886 INFO [gov.nist.javax.sip.stack.SIPTransactionStack] (Restcomm-SIP-Servlets-UDPMessageChannelThread-15) <message
from="5.10.112.121:5060"
to="172.17.0.3:5060"
time="1461671268886"
isSender="false"
transactionId="z9hg4bkb7364acd_57a5b08a_5100ca09-c9c4-4682-b94b-631f3779efc2"
callId="1f1e1ff55e5d47cb0c36bee8077d9ec7@sip.nexmo.com"
firstLine="SIP/2.0 200 OK"
>
<![CDATA[SIP/2.0 200 OK
Via: SIP/2.0/UDP 54.194.81.211:5060;rport=5060;branch=z9hG4bKb7364acd_57a5b08a_5100ca09-c9c4-4682-b94b-631f3779efc2
From: <sip:34986160292@sip.nexmo.com>;tag=34276615_0d2e2b5f_57a5b08a_b7364acd
To: "986410091" <sip:986410091@sip.nexmo.com>;tag=as03abd276
Call-ID: 1f1e1ff55e5d47cb0c36bee8077d9ec7@sip.nexmo.com
CSeq: 1 BYE
Server: Nexmo Media 3-1
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,REFER,SUBSCRIBE,NOTIFY,INFO,PUBLISH,MESSAGE
Supported: replaces,timer
Content-Length: 0
]]>
</message>
11:47:48,888 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-40) ********** Call Controller Current State: "stopping
11:47:48,888 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-40) ********** Media Group akka://RestComm/user/$t/$a Current State: "deactivating
11:47:48,888 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-40) ********** Media Group akka://RestComm/user/$t/$a Processing Message: "org.mobicents.servlet.restcomm.mgcp.EndpointStateChanged sender : class akka.actor.LocalActorRef
11:47:48,888 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MgcpMediaGroup] (RestComm-akka.actor.default-dispatcher-40) MediaGroup :akka://RestComm/user/$t/$a at postStop, about to stop ivr endpoint :akka://RestComm/user/$b/$n
11:47:48,888 INFO [org.mobicents.servlet.restcomm.mgcp.MediaGateway] (RestComm-akka.actor.default-dispatcher-43) Gateway: akka://RestComm/user/$b about to stop endpoint path: akka://RestComm/user/$b/$n isTerminated: true sender: akka://RestComm/deadLetters
11:47:48,894 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-43) ********** Call Controller Processing Message: "org.mobicents.servlet.restcomm.mgcp.EndpointStateChanged sender : class akka.actor.LocalActorRef
11:47:48,894 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-43) ********** Call Controller Current State: "stopping
11:47:48,895 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-43) ********** Call Controller Processing Message: "org.mobicents.servlet.restcomm.mscontrol.messages.MediaGroupStateChanged sender : class akka.actor.LocalActorRef
11:47:48,895 INFO [org.mobicents.servlet.restcomm.mgcp.BridgeEndpoint] (RestComm-akka.actor.default-dispatcher-43) Bridge: akka://RestComm/user/$b/$m bridge id: mobicents/bridge/4@172.17.0.3:2427 at postStop, sender: akka://RestComm/deadLetters
11:47:48,895 INFO [org.mobicents.servlet.restcomm.mscontrol.mgcp.MmsCallController] (RestComm-akka.actor.default-dispatcher-43) De-activating Call Controller
11:47:48,896 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-43) ********** Call's akka://RestComm/user/$s Current State: "stopping direction: inbound
11:47:48,896 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-43) ********** Call akka://RestComm/user/$s Processing Message: "org.mobicents.servlet.restcomm.mscontrol.messages.MediaServerControllerStateChanged sender : akka://RestComm/user/$t
11:47:48,896 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-43) Completing Call sid: CA12ae7b5d03e844e99afbd44ddb330dc3 from: sip:986410091@sip.nexmo.com to: sip:34986160292@sip.nexmo.com direction: inbound current external state: in-progress
11:47:48,896 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-43) Call sid: CA12ae7b5d03e844e99afbd44ddb330dc3 from: sip:986410091@sip.nexmo.com to: sip:34986160292@sip.nexmo.com direction: inbound new external state: completed
11:47:48,896 INFO [com.telestax.servlet.MonitoringService] (RestComm-akka.actor.default-dispatcher-43) MonitoringService Processing Message: "org.mobicents.servlet.restcomm.telephony.CallStateChanged sender : class akka.actor.RepointableActorRef self is terminated: false
11:47:48,896 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-43) ********** VoiceInterpreter's akka://RestComm/user/$r Current State: hanging up
11:47:48,897 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-43) ********** VoiceInterpreter's akka://RestComm/user/$r Processing Message: org.mobicents.servlet.restcomm.telephony.CallStateChanged
11:47:48,897 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-43) VoiceInterpreter received CallStateChanged event: completed
11:47:48,897 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-43) At Finished state, state: hanging up
11:47:48,897 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-36) Proceeding to execute Dial Action attribute
11:47:48,898 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-36) Trying to get inbound call Info
11:47:48,899 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-36) ********** Call's akka://RestComm/user/$s Current State: "completed direction: inbound
11:47:48,899 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-36) ********** Call akka://RestComm/user/$s Processing Message: "org.mobicents.servlet.restcomm.telephony.GetCallInfo sender : akka://RestComm/temp/$c
11:47:48,899 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-36) status callback is null
11:47:48,900 INFO [org.mobicents.servlet.restcomm.telephony.CallManager] (RestComm-akka.actor.default-dispatcher-36) About to destroy call: akka://RestComm/user/$s
11:47:48,900 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-36) Sent stop observing for call, from: sip:986410091@sip.nexmo.com to: sip:34986160292@sip.nexmo.com direction: inbound to observer: akka://RestComm/user/$r observer is terminated: false
11:47:48,900 INFO [org.mobicents.servlet.restcomm.telephony.Call] (RestComm-akka.actor.default-dispatcher-36) Sent stop observing for call, from: sip:986410091@sip.nexmo.com to: sip:34986160292@sip.nexmo.com direction: inbound to observer: akka://RestComm/user/$a observer is terminated: false
11:47:48,900 INFO [com.telestax.servlet.MonitoringService] (RestComm-akka.actor.default-dispatcher-36) MonitoringService Processing Message: "org.mobicents.servlet.restcomm.patterns.StopObserving sender : class akka.actor.RepointableActorRef self is terminated: false
11:47:48,901 INFO [com.telestax.servlet.MonitoringService] (RestComm-akka.actor.default-dispatcher-36) Received stop observing
11:47:48,901 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-36) VoiceIntepreter: akka://RestComm/user/$rAt the postStop() method. Will clean up Voice Interpreter. Keep calls: false
11:47:48,901 INFO [org.mobicents.servlet.restcomm.interpreter.VoiceInterpreter] (RestComm-akka.actor.default-dispatcher-36) At postStop(), will clean up call
11:47:48,901 INFO [org.mobicents.servlet.restcomm.telephony.CallManager] (RestComm-akka.actor.default-dispatcher-36) About to destroy call: akka://RestComm/user/$s
11:47:50,144 INFO [org.mobicents.servlet.sip.core.session.SipSessionImpl] (MSS-Executor-Thread-10) Invalidating the sip session (as03abd276;1f1e1ff55e5d47cb0c36bee8077d9ec7@sip.nexmo.com;b7364acd;RestComm)
11:47:50,145 INFO [org.mobicents.servlet.sip.core.session.SipApplicationSessionImpl] (MSS-Executor-Thread-10) Invalidating the following sip application session b7364acd;RestComm
11:47:50,145 INFO [org.mobicents.servlet.sip.core.session.SipApplicationSessionImpl] (MSS-Executor-Thread-10) The following sip application session b7364acd;RestComm has been invalidated
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment