Dealy to start the message

Discussion in '3CX Phone System - General' started by flaviost, Aug 27, 2007.

  1. flaviost

    Joined:
    Aug 17, 2007
    Messages:
    18
    Likes Received:
    0
    Why some times take so long time to begin the message after the system answer the call?
    It usually happens. Some timee I call my system to check if everything is working well, and take from 6 to 8 seconds after asnwer to start to play the message of the first Digital Receptionist.
    Exist any way to improve it?"

    Thanks
     
  2. gbarnes

    Joined:
    Aug 3, 2007
    Messages:
    83
    Likes Received:
    0
    improve

    Please could you turn logging to verbose and replicate the call, then send in the log?

    Do you have a slow system? How much ram?

    Does it seem to be accessing disk a lot when it answers?

    Or could your .wav file simply have a bit of silence before it..

    Moving on from there what equipment are you using, gateway or voip provider?

    Has anyone else had this problem and fixed it I wonder?

    Graeme.
     
  3. gbarnes

    Joined:
    Aug 3, 2007
    Messages:
    83
    Likes Received:
    0
    Logs

    Actually the logs would probably tell whats going on.

    I have tryed to access my DR while opening a large file at the same time and it does increase by 3-4 secs or so.

    Ill await them and have a look.

    Graeme.
     
  4. todd

    Joined:
    Jun 9, 2007
    Messages:
    35
    Likes Received:
    0
    Same problem

    Dear gbarnes,
    I got same problem with my system.
    verbose log:

    01:43:33.296 StratInOut::eek:nHangUp [CM104007] Call(2): Call from Ln:10000@engin 9.95 to 4000 has been terminated by Ln:10000@engin 9.95; cause: BYE; from IP:203.161.160.69
    01:43:22.015 CallLegImpl::eek:nConnected [CM103001] Call(2): Created audio channel for Ln:10000@engin 9.95 (203.161.160.79:20366) with Media Server (60.241.248.251:24799)
    01:43:21.937 CallConf::eek:nIncoming [CM103002] Call(2): Incoming call from 0731390275 (Ln:10000@engin 9.95) to sip:0733331518@voice.mibroadband.com.au

    Do you have a slow system? How much ram?
    My system is: HP ML G2 Server, 2 of Intel Xeon 3.0 Ghz CPU 2.0GB ram, running Windows 2003 Enterprise SP2, and only 3CX and Symantec AntiVirus software running.

    Does it seem to be accessing disk a lot when it answers?
    Looks not, the Disks are SATA Host RAID with 250GB each HDD.

    Or could your .wav file simply have a bit of silence before it..
    No, the wav file no silence before it. I cut all silence.

    Moving on from there what equipment are you using, gateway or voip provider?
    I using SPA2000, SPA3000, GrandStream IP phones. Engin (Australian Voip provider) , if I use SPA2000 setup to Voip provider Account, It’s working fine.
     
  5. flaviost

    Joined:
    Aug 17, 2007
    Messages:
    18
    Likes Received:
    0
    Sorry but I don't know how to get the verbose log.

    Any way I think that the problem could be RAM memory that I would like to update. If it should be a solution I will buy some Gbytes.

    But looking the tood problem we can check that the delays is happening, because he has a machine working only with the 3CX, crazy and it is not a bad machine.

    Some one can tell how much is the minimum system configuration to run the 3CX in an acceptable performance.

    Thanks
     
  6. gbarnes

    Joined:
    Aug 3, 2007
    Messages:
    83
    Likes Received:
    0
    More

    So your 2000 when configured direct to SIP provider does not have the delay, but when configured through 3cx it does?

    How long is the delay?

    When Manage pstn --> PBX delevers audio is unset does this change anything?

    It cant be a jitter setting, because that would affect your sip direct link.

    Itfarmer, could you put your hardware expertise towards this please, its getting me. :roll: Does it always delay or intermittent?
     
  7. SY

    SY Well-Known Member
    3CX Staff

    Joined:
    Jan 26, 2007
    Messages:
    1,821
    Likes Received:
    1
    Re: Same problem

    Good information. We will try to investigate it.

    Thanks
     
  8. SY

    SY Well-Known Member
    3CX Staff

    Joined:
    Jan 26, 2007
    Messages:
    1,821
    Likes Received:
    1
    It seems the delay is happening, at least it described here, but we still don't have any useful information to investigate a problem.

    todd just described his system, and I'm agree that his system is cool enough to handle 3CX PBX.

    Anybody, who has a problem with "long delay in case of 'bla-bla-bla'", could you please provide any (even trial) information that is related to your system?

    Thanks :)
    P.S. log level can be set on "General Settings" page.
     
  9. masterkiwi

    Joined:
    Apr 5, 2013
    Messages:
    1
    Likes Received:
    0
    Hi there,
    I have the same problem, you can resolve it by installing ping plotter to ping every 5 minutes or so to your pbx. that way it keeps it fresh.

    However the next problem i have is that it takes a very long time for the IVR to forward to an extension (or anything)..
    example: (ivr)welcome to us. press 1 for me ---TAKES LONGG---> (ivr)you'll be transfered to me --> (ext)music and forwarding to mobile.

    Here's my verbose:

    Code:
    05-apr-2013 12:00:31.789	L:27.3[Line:10000>>31612412526]: Terminating targets, reason:
    05-apr-2013 12:00:31.789	Leg L:27.3[Line:10000>>31612412526] is terminated: Cause: BYE from PBX
    05-apr-2013 12:00:31.789	Terminated from <sip:31612412526@sip3.nowhere.nl:5060>;tag=4RHUD51EWY30000E1D01006l00Z47EQ1QU0CD5 to "315230784044"<sip:315230784044@sip3.nowhere.nl:5060>;tag=466a2119; reason: LocalBye
    05-apr-2013 12:00:31.789	L:27.3[Line:10000>>31612412526] Sending: OnSendReq Send Req BYE from 0.0.0.0:0 tid=0f1e6f7efb6e565b Call-ID=YWRjOTI0ODNhNWQ3NDVkM2MwOGIwNDk2N2FjY2U1ZjI.:
    			BYE sip:31.276.32.18:5060 SIP/2.0
    			Via: SIP/2.0/ ;branch=z9hG4bK-d8754z-0f1e6f7efb6e565b-1---d8754z-;rport
    			Max-Forwards: 70
    			Route: <sip:89.146.10.230;lr;ftag=466a2119;did=4dc.eb3dfa27>
    			Contact: <sip:sip3wvp00420@187.132.114.36:5060>
    			To: <sip:31612412526@sip3.nowhere.nl:5060>;tag=4RHUD51EWY30000E1D01006l00Z47EQ1QU0CD5
    			From: "315230784044"<sip:315230784044@sip3.nowhere.nl:5060>;tag=466a2119
    			Call-ID: YWRjOTI0ODNhNWQ3NDVkM2MwOGIwNDk2N2FjY2U1ZjI.
    			CSeq: 3 BYE
    			Content-Length: 0
    05-apr-2013 12:00:31.789	SendMsg from "315230784044"<sip:315230784044@sip3.nowhere.nl:5060>;tag=466a2119 to <sip:31612412526@sip3.nowhere.nl:5060>;tag=4RHUD51EWY30000E1D01006l00Z47EQ1QU0CD5
    05-apr-2013 12:00:31.788	[CM503008]: Call(C:27): Call is terminated
    05-apr-2013 12:00:31.788	L:27.3[Line:10000>>31612412526]: Terminating targets, reason: SIP ;cause=200 ;text="Call terminated on user request"
    05-apr-2013 12:00:31.783	Blocking refers for the Call(C:27)
    05-apr-2013 12:00:31.783	Call(C:27) is terminated
    05-apr-2013 12:00:31.782	L:27.1[Line:10000<<0523610878]: Terminating targets, reason: SIP ;cause=200 ;text="User hangup"
    05-apr-2013 12:00:31.782	Leg L:27.1[Line:10000<<0523610878] is terminated: Cause: BYE from 89.146.10.230:5060
    05-apr-2013 12:00:31.777	L:27.1[Line:10000<<0523610878] got Terminated Recv Req BYE from 89.146.10.230:5060 tid=4e32.4ce8d5c3.0 Call-ID=5ddb-4f9-35201395947-HLF-IMG-02-1-31.276.32.22:
    			BYE sip:sip3wvp00420@187.132.114.36:5060 SIP/2.0
    			Via: SIP/2.0/UDP 89.146.10.230:5060;branch=z9hG4bK4e32.4ce8d5c3.0
    			Via: SIP/2.0/UDP 31.276.32.22:5060;received=31.276.32.22;rport=5060;branch=z9hG4bK-6fba-1365156019-3143-173
    			Max-Forwards: 69
    			Record-Route: <sip:89.146.10.230;lr;ftag=95ffcd055e0f78f7d5d397020e89288dd6f599e5>
    			To: <sip:315230784044@89.146.10.230:5060>;tag=7613b128
    			From: <sip:0523610878@sip3.nowhere.nl>;tag=95ffcd055e0f78f7d5d397020e89288dd6f599e5
    			Call-ID: 5ddb-4f9-35201395947-HLF-IMG-02-1-31.276.32.22
    			CSeq: 2 BYE
    			Reason: Q.850 ;cause=16 ;text="Normal call clearing"
    			Content-Length: 0
    05-apr-2013 12:00:31.777	Terminated from <sip:0523610878@sip3.nowhere.nl>;tag=95ffcd055e0f78f7d5d397020e89288dd6f599e5 to <sip:315230784044@89.146.10.230:5060>;tag=7613b128; reason: RemoteBye
    05-apr-2013 12:00:31.777	L:27.1[Line:10000<<0523610878] Sending: OnSendResp Send 200/BYE from 0.0.0.0:0 tid=4e32.4ce8d5c3.0 Call-ID=5ddb-4f9-35201395947-HLF-IMG-02-1-31.276.32.22:
    			SIP/2.0 200 OK
    			Via: SIP/2.0/UDP 89.146.10.230:5060;branch=z9hG4bK4e32.4ce8d5c3.0
    			Via: SIP/2.0/UDP 31.276.32.22:5060;received=31.276.32.22;rport=5060;branch=z9hG4bK-6fba-1365156019-3143-173
    			Record-Route: <sip:89.146.10.230;lr;ftag=95ffcd055e0f78f7d5d397020e89288dd6f599e5>
    			Contact: <sip:sip3wvp00420@187.132.114.36:5060>
    			To: <sip:315230784044@89.146.10.230:5060>;tag=7613b128
    			From: <sip:0523610878@sip3.nowhere.nl>;tag=95ffcd055e0f78f7d5d397020e89288dd6f599e5
    			Call-ID: 5ddb-4f9-35201395947-HLF-IMG-02-1-31.276.32.22
    			CSeq: 2 BYE
    			Content-Length: 0
    05-apr-2013 12:00:31.777	SendMsg from <sip:315230784044@89.146.10.230:5060>;tag=7613b128 to <sip:0523610878@sip3.nowhere.nl>;tag=95ffcd055e0f78f7d5d397020e89288dd6f599e5
    05-apr-2013 12:00:26.744	L:27.2[Ivr]: Terminating targets, reason: SIP ;cause=200 ;text="User hangup"
    05-apr-2013 12:00:26.744	Leg L:27.2[Ivr] is terminated: Cause: BYE from 127.0.0.1:40600
    05-apr-2013 12:00:26.740	L:27.2[Ivr] got Terminated Recv Req BYE from 127.0.0.1:40600 tid=29229f138c0ed904 Call-ID=YmY3MDVhOWMyMWYwNjBiMzNiOTE3M2VkOWM1NDkxZGE.:
    			BYE sip:0523610878@127.0.0.1:5060 SIP/2.0
    			Via: SIP/2.0/UDP 127.0.0.1:40600;branch=z9hG4bK-d8754z-29229f138c0ed904-1---d8754z-;rport=40600
    			Max-Forwards: 70
    			Contact: <sip:800@127.0.0.1:40600;rinstance=3999fcfb77aacc27>
    			To: <sip:0523610878@127.0.0.1:5060;nf=e>;tag=5e5f273a
    			From: <sip:800@127.0.0.1:5060>;tag=d227a531
    			Call-ID: YmY3MDVhOWMyMWYwNjBiMzNiOTE3M2VkOWM1NDkxZGE.
    			CSeq: 5 BYE
    			User-Agent: 3CX IVR
    			Reason: SIP;description="User Hung Up"
    			Content-Length: 0
    05-apr-2013 12:00:26.740	Terminated from <sip:800@127.0.0.1:5060>;tag=d227a531 to <sip:0523610878@127.0.0.1:5060;nf=e>;tag=5e5f273a; reason: RemoteBye
    05-apr-2013 12:00:26.740	L:27.2[Ivr] Sending: OnSendResp Send 200/BYE from 0.0.0.0:0 tid=29229f138c0ed904 Call-ID=YmY3MDVhOWMyMWYwNjBiMzNiOTE3M2VkOWM1NDkxZGE.:
    			SIP/2.0 200 OK
    			Via: SIP/2.0/UDP 127.0.0.1:40600;branch=z9hG4bK-d8754z-29229f138c0ed904-1---d8754z-;rport=40600
    			Contact: <sip:0523610878@127.0.0.1:5060>
    			To: <sip:0523610878@127.0.0.1:5060;nf=e>;tag=5e5f273a
    			From: <sip:800@127.0.0.1:5060>;tag=d227a531
    			Call-ID: YmY3MDVhOWMyMWYwNjBiMzNiOTE3M2VkOWM1NDkxZGE.
    			CSeq: 5 BYE
    			Content-Length: 0
    05-apr-2013 12:00:26.739	SendMsg from <sip:0523610878@127.0.0.1:5060;nf=e>;tag=5e5f273a to <sip:800@127.0.0.1:5060>;tag=d227a531
    05-apr-2013 12:00:26.563	FilePlayEndEventHandler
    05-apr-2013 12:00:26.551	[CM503007]: Call(C:27): Line:10000>>31612412526 has joined, contact <sip:sip3wvp00420@sip3.nowhere.nl:5060>
    05-apr-2013 12:00:26.537	~Target=VoIPline:31612412526@(Ln.10000@nowhere.Comm)
    05-apr-2013 12:00:26.537	L:27.1[Line:10000<<0523610878]: Terminating targets, reason: SIP ;cause=200 ;text="Call completed elsewhere"
    05-apr-2013 12:00:26.537	~Route=Dev:sip:sip3wvp00420@sip3.nowhere.nl:5060
    05-apr-2013 12:00:26.537	L:27.3[Line:10000>>31612412526] has joined to L:27.1[Line:10000<<0523610878]
    05-apr-2013 12:00:26.537	Session 43121 of leg L:27.3[Line:10000>>31612412526] is connected
    05-apr-2013 12:00:26.537	L:27.3[Line:10000>>31612412526] got Connected.UAC Recv 200/INVITE from 89.146.10.230:5060 tid=0a48f05cbb62cd26 Call-ID=YWRjOTI0ODNhNWQ3NDVkM2MwOGIwNDk2N2FjY2U1ZjI.:
    			SIP/2.0 200 Ok
    			Via: SIP/2.0/UDP 192.168.1.8:5060;received=187.132.114.36;branch=z9hG4bK-d8754z-0a48f05cbb62cd26-1---d8754z-;rport=5060
    			Record-Route: <sip:89.146.10.230;lr;ftag=466a2119;did=4dc.eb3dfa27>
    			Contact: <sip:31.276.32.18:5060>
    			To: <sip:31612412526@sip3.nowhere.nl:5060>;tag=4RHUD51EWY30000E1D01006l00Z47EQ1QU0CD5
    			From: "315230784044"<sip:315230784044@sip3.nowhere.nl:5060>;tag=466a2119
    			Call-ID: YWRjOTI0ODNhNWQ3NDVkM2MwOGIwNDk2N2FjY2U1ZjI.
    			CSeq: 2 INVITE
    			Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, INFO, REFER, NOTIFY, SUBSCRIBE, UPDATE
    			Content-Type: application/sdp
    			Supported: timer, replaces, from-change, x-diversion
    			Allow-Events: refer
    			P-Asserted-Identity: <sip:0612412526@sip3.nowhere.nl>
    			Content-Length: 229
    			
    			v=0
    			o=- 1547671413798960455 1 IN IP4 31.276.32.18
    			s=-
    			c=IN IP4 31.276.32.34
    			t=0 0
    			m=audio 35540 RTP/AVP 0 101
    			a=rtpmap:0 PCMU/8000
    			a=rtpmap:101 telephone-event/8000
    			a=fmtp:101 0-15
    			a=ptime:20
    			a=silenceSupp:off - - - -
    05-apr-2013 12:00:26.537	Connected(UAC) from <sip:31612412526@sip3.nowhere.nl:5060>;tag=4RHUD51EWY30000E1D01006l00Z47EQ1QU0CD5 to "315230784044"<sip:315230784044@sip3.nowhere.nl:5060>;tag=466a2119
    05-apr-2013 12:00:26.537	Remote SDP is set for leg L:27.3[Line:10000>>31612412526]
    05-apr-2013 12:00:26.537	Answer SDP arrived on Leg L:27.3[Line:10000>>31612412526];
    OnAnswer Recv 200/INVITE from 89.146.10.230:5060 tid=0a48f05cbb62cd26 Call-ID=YWRjOTI0ODNhNWQ3NDVkM2MwOGIwNDk2N2FjY2U1ZjI.:
    			SIP/2.0 200 Ok
    			Via: SIP/2.0/UDP 192.168.1.8:5060;received=187.132.114.36;branch=z9hG4bK-d8754z-0a48f05cbb62cd26-1---d8754z-;rport=5060
    			Record-Route: <sip:89.146.10.230;lr;ftag=466a2119;did=4dc.eb3dfa27>
    			Contact: <sip:31.276.32.18:5060>
    			To: <sip:31612412526@sip3.nowhere.nl:5060>;tag=4RHUD51EWY30000E1D01006l00Z47EQ1QU0CD5
    			From: "315230784044"<sip:315230784044@sip3.nowhere.nl:5060>;tag=466a2119
    			Call-ID: YWRjOTI0ODNhNWQ3NDVkM2MwOGIwNDk2N2FjY2U1ZjI.
    			CSeq: 2 INVITE
    			Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, INFO, REFER, NOTIFY, SUBSCRIBE, UPDATE
    			Content-Type: application/sdp
    			Supported: timer, replaces, from-change, x-diversion
    			Allow-Events: refer
    			P-Asserted-Identity: <sip:0612412526@sip3.nowhere.nl>
    			Content-Length: 229
    			
    			v=0
    			o=- 1547671413798960455 1 IN IP4 31.276.32.18
    			s=-
    			c=IN IP4 31.276.32.34
    			t=0 0
    			m=audio 35540 RTP/AVP 0 101
    			a=rtpmap:0 PCMU/8000
    			a=rtpmap:101 telephone-event/8000
    			a=fmtp:101 0-15
    			a=ptime:20
    			a=silenceSupp:off - - - -
    05-apr-2013 12:00:26.537	[CM505003]: Provider:[nowhere.Comm] Device info: Device Not Identified: User Agent not matched; Capabilities:[reinvite, replaces, able-no-sdp, recvonly] UserAgent: [] PBX contact: [sip:sip3wvp00420@187.132.114.36:5060]
    05-apr-2013 12:00:26.537	[CM503002]: Call(C:27): Alerting Line:10000>>31612412526 by contact <sip:sip3wvp00420@sip3.nowhere.nl:5060>
    05-apr-2013 12:00:26.529	UacSession 43121 has formed leg L:27.3[Line:10000>>31612412526]
    05-apr-2013 12:00:26.529	Answer from <sip:31612412526@sip3.nowhere.nl:5060>;tag=4RHUD51EWY30000E1D01006l00Z47EQ1QU0CD5 to "315230784044"<sip:315230784044@sip3.nowhere.nl:5060>;tag=466a2119
    05-apr-2013 12:00:26.529	L:27.3[Line:10000>>31612412526] Sending: OnSendReq Send Req ACK from 0.0.0.0:0 tid=d21f262ce84c9509 Call-ID=YWRjOTI0ODNhNWQ3NDVkM2MwOGIwNDk2N2FjY2U1ZjI.:
    			ACK sip:31.276.32.18:5060 SIP/2.0
    			Via: SIP/2.0/ ;branch=z9hG4bK-d8754z-d21f262ce84c9509-1---d8754z-;rport
    			Max-Forwards: 70
    			Route: <sip:89.146.10.230;lr;ftag=466a2119;did=4dc.eb3dfa27>
    			Contact: <sip:sip3wvp00420@187.132.114.36:5060>
    			To: <sip:31612412526@sip3.nowhere.nl:5060>;tag=4RHUD51EWY30000E1D01006l00Z47EQ1QU0CD5
    			From: "315230784044"<sip:315230784044@sip3.nowhere.nl:5060>;tag=466a2119
    			Call-ID: YWRjOTI0ODNhNWQ3NDVkM2MwOGIwNDk2N2FjY2U1ZjI.
    			CSeq: 2 ACK
    			Proxy-Authorization: Digest username="sip3wvp00420",realm="sip3.nowhere.nl",nonce="515ea0b400008f00526bd05e9525d54050bd52b33fd520fc",uri="sip:31612412526@sip3.nowhere.nl:5060",response="7346d2b7f3f994a3a9ca05e5c66e6995",algorithm=MD5
    			Content-Length: 0
    05-apr-2013 12:00:26.529	SendMsg from "315230784044"<sip:315230784044@sip3.nowhere.nl:5060>;tag=466a2119 to <sip:31612412526@sip3.nowhere.nl:5060>;tag=4RHUD51EWY30000E1D01006l00Z47EQ1QU0CD5
    05-apr-2013 12:00:26.233	Currently active calls - 1: [27]
    05-apr-2013 12:00:22.943	Provisional response (malformed) arrived to Leg L:27.3[Line:10000>>31612412526]
    05-apr-2013 12:00:22.943	L:27.3[Line:10000>>31612412526] got Provisional Recv 183/INVITE from 89.146.10.230:5060 tid=0a48f05cbb62cd26 Call-ID=YWRjOTI0ODNhNWQ3NDVkM2MwOGIwNDk2N2FjY2U1ZjI.:
    			SIP/2.0 183 Session Progress
    			Via: SIP/2.0/UDP 192.168.1.8:5060;received=187.132.114.36;branch=z9hG4bK-d8754z-0a48f05cbb62cd26-1---d8754z-;rport=5060
    			To: <sip:31612412526@sip3.nowhere.nl:5060>;tag=4RHUD51EWY30000E1D01006l00Z47EQ1QU0CD5
    			From: "315230784044"<sip:315230784044@sip3.nowhere.nl:5060>;tag=466a2119
    			Call-ID: YWRjOTI0ODNhNWQ3NDVkM2MwOGIwNDk2N2FjY2U1ZjI.
    			CSeq: 2 INVITE
    			Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, INFO, REFER, NOTIFY, SUBSCRIBE, UPDATE
    			Content-Type: application/sdp
    			P-Asserted-Identity: <sip:0612412526@sip3.nowhere.nl>
    			Content-Length: 229
    			
    			v=0
    			o=- 1547671413798960455 1 IN IP4 31.276.32.18
    			s=-
    			c=IN IP4 31.276.32.34
    			t=0 0
    			m=audio 35540 RTP/AVP 0 101
    			a=rtpmap:0 PCMU/8000
    			a=rtpmap:101 telephone-event/8000
    			a=fmtp:101 0-15
    			a=ptime:20
    			a=silenceSupp:off - - - -
    05-apr-2013 12:00:22.943	Provisional(183) malformed
    05-apr-2013 12:00:22.829	Provisional response (malformed) arrived to Leg L:27.3[Line:10000>>31612412526]
    05-apr-2013 12:00:22.829	L:27.3[Line:10000>>31612412526] got Provisional Recv 183/INVITE from 89.146.10.230:5060 tid=0a48f05cbb62cd26 Call-ID=YWRjOTI0ODNhNWQ3NDVkM2MwOGIwNDk2N2FjY2U1ZjI.:
    			SIP/2.0 183 Session Progress
    			Via: SIP/2.0/UDP 192.168.1.8:5060;received=187.132.114.36;branch=z9hG4bK-d8754z-0a48f05cbb62cd26-1---d8754z-;rport=5060
    			To: <sip:31612412526@sip3.nowhere.nl:5060>;tag=4RHUD51EWY30000E1D01006l00Z47EQ1QU0CD5
    			From: "315230784044"<sip:315230784044@sip3.nowhere.nl:5060>;tag=466a2119
    			Call-ID: YWRjOTI0ODNhNWQ3NDVkM2MwOGIwNDk2N2FjY2U1ZjI.
    			CSeq: 2 INVITE
    			Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, INFO, REFER, NOTIFY, SUBSCRIBE, UPDATE
    			Content-Type: application/sdp
    			Supported: x-diversion
    			P-Asserted-Identity: <sip:0612412526@sip3.nowhere.nl>
    			Content-Length: 229
    			
    			v=0
    			o=- 1547671413798960455 1 IN IP4 31.276.32.18
    			s=-
    			c=IN IP4 31.276.32.34
    			t=0 0
    			m=audio 35540 RTP/AVP 0 101
    			a=rtpmap:0 PCMU/8000
    			a=rtpmap:101 telephone-event/8000
    			a=fmtp:101 0-15
    			a=ptime:20
    			a=silenceSupp:off - - - -
    05-apr-2013 12:00:22.829	Provisional(183) malformed
    05-apr-2013 12:00:18.220	Provisional response (malformed) arrived to Leg L:27.3[Line:10000>>31612412526]
    05-apr-2013 12:00:18.220	L:27.3[Line:10000>>31612412526] got Provisional Recv 180/INVITE from 89.146.10.230:5060 tid=0a48f05cbb62cd26 Call-ID=YWRjOTI0ODNhNWQ3NDVkM2MwOGIwNDk2N2FjY2U1ZjI.:
    			SIP/2.0 180 Ringing
    			Via: SIP/2.0/UDP 192.168.1.8:5060;received=187.132.114.36;branch=z9hG4bK-d8754z-0a48f05cbb62cd26-1---d8754z-;rport=5060
    			To: <sip:31612412526@sip3.nowhere.nl:5060>;tag=c8598deb78957a18ce3b310bd9f5d802.1b3b
    			From: "315230784044"<sip:315230784044@sip3.nowhere.nl:5060>;tag=466a2119
    			Call-ID: YWRjOTI0ODNhNWQ3NDVkM2MwOGIwNDk2N2FjY2U1ZjI.
    			CSeq: 2 INVITE
    			Content-Length: 0
    05-apr-2013 12:00:18.220	Provisional(180) malformed
    05-apr-2013 12:00:18.161	[CM503025]: Call(C:27): Calling T:Line:10000>>31612412526@[Dev:sip:sip3wvp00420@sip3.nowhere.nl:5060] for L:27.1[Line:10000<<0523610878]
    05-apr-2013 12:00:18.161	Route to L:27.3[Line:10000>>31612412526] sends Invite-OUT Send Req INVITE from 0.0.0.0:0 tid=cf718717c91c653a Call-ID=YWRjOTI0ODNhNWQ3NDVkM2MwOGIwNDk2N2FjY2U1ZjI.:
    			INVITE sip:31612412526@sip3.nowhere.nl:5060 SIP/2.0
    			Via: SIP/2.0/ ;branch=z9hG4bK-d8754z-cf718717c91c653a-1---d8754z-;rport
    			Max-Forwards: 70
    			Contact: <sip:sip3wvp00420@187.132.114.36:5060>
    			To: <sip:31612412526@sip3.nowhere.nl:5060>
    			From: "315230784044"<sip:315230784044@sip3.nowhere.nl:5060>;tag=466a2119
    			Call-ID: YWRjOTI0ODNhNWQ3NDVkM2MwOGIwNDk2N2FjY2U1ZjI.
    			CSeq: 1 INVITE
    			Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REGISTER, SUBSCRIBE, NOTIFY, REFER, INFO, MESSAGE
    			Content-Type: application/sdp
    			Supported: replaces
    			Content-Length: 234
    			Remote-Party-ID: "315230784044"<sip:315230784044@sip3.nowhere.nl:5060>;party=calling
    			
    			v=0
    			o=3cxPS 125392912384 42278584321 IN IP4 187.132.114.36
    			s=3cxPS Audio call
    			c=IN IP4 187.132.114.36
    			t=0 0
    			m=audio 9026 RTP/AVP 0 8 101
    			a=rtpmap:0 PCMU/8000
    			a=rtpmap:8 PCMA/8000
    			a=rtpmap:101 telephone-event/8000
    			a=sendrecv
    05-apr-2013 12:00:18.161	Dev(1):[sip:sip3wvp00420@sip3.nowhere.nl:5060 / sip3wvp00420]: PBX contact is public IP: <sip:sip3wvp00420@187.132.114.36:5060>
    05-apr-2013 12:00:18.148	Outbound URI is used: sip:89.146.10.230;lr;ftag=95ffcd055e0f78f7d5d397020e89288dd6f599e5;did=0b3.bda59fd4
    05-apr-2013 12:00:18.148	Added leg L:27.3[Line:10000>>31612412526]
    05-apr-2013 12:00:18.099	[Flow] Call(C:27): making call from L:27.1[Line:10000<<0523610878] to T:Line:10000>>31612412526@[Dev:sip:sip3wvp00420@sip3.nowhere.nl:5060]
    05-apr-2013 12:00:18.099	[CM503027]: Call(C:27): From: Line:10000<<0523610878 (<sip:0523610878@192.168.1.8:5060>)  to  T:Line:10000>>31612412526@[Dev:sip:sip3wvp00420@sip3.nowhere.nl:5060]
    05-apr-2013 12:00:18.099	[CM503004]: Call(C:27): Route 1: from L:27.1[Line:10000<<0523610878] to T:Line:10000>>31612412526@[Dev:sip:sip3wvp00420@sip3.nowhere.nl:5060]
    05-apr-2013 12:00:18.099	Line limit check: Current # of calls for line Lc:10000(@nowhere.Comm[<sip:sip3wvp00420@sip3.nowhere.nl:5060>]) is 1; limit is 2
    05-apr-2013 12:00:18.099	Leg L:27.1[Line:10000<<0523610878]: Refreshing OutCID from endpoint Extn:200 = []
    05-apr-2013 12:00:18.099	[Flow] Call(C:27):  applied forwarding rule (Fwd[Custom 2/AllCalls]) Extn:200 -> Out#:>>Rule{Rule for nowhere.Comm}>>31612412526
    05-apr-2013 12:00:18.099	[Flow] Target endpoint for 31612412526 is Out#:>>Rule{Rule for nowhere.Comm}>>31612412526
    05-apr-2013 12:00:18.098	Selected prefix: 31
    05-apr-2013 12:00:18.098	Looking for outbound rule: dialed = [31612412526], processed: [31612412526]; from-ext: 200
    05-apr-2013 12:00:18.098	[Flow] Building target endpoint to 31612412526 from <sip:0523610878@192.168.1.8:5060> on behalf of 200
    05-apr-2013 12:00:18.098	[Flow] Target endpoint for 31612412526 is Out#:>>Rule{Rule for nowhere.Comm}>>31612412526
    05-apr-2013 12:00:18.098	Selected prefix: 31
    05-apr-2013 12:00:18.098	Looking for outbound rule: dialed = [31612412526], processed: [31612412526]; from-ext: 200
    05-apr-2013 12:00:18.098	[Flow] Building target endpoint to 31612412526 from <sip:0523610878@192.168.1.8:5060> on behalf of 200
    05-apr-2013 12:00:18.098	[Flow] Call(C:27): has built target endpoint: Extn:200 for call from L:27.1[Line:10000<<0523610878]
    05-apr-2013 12:00:18.098	[Flow] Target endpoint for 200 is Extn:200
    05-apr-2013 12:00:18.098	[Flow] Building target endpoint to 200 from <sip:0523610878@192.168.1.8:5060>
    05-apr-2013 12:00:18.098	[CM503010]: Call(C:27): Making route(s) from Line:10000<<0523610878 to <sip:200@127.0.0.1:5060>
    05-apr-2013 12:00:18.098	[CM505003]: Provider:[nowhere.Comm] Device info: Device Not Identified: User Agent not matched; Capabilities:[reinvite, replaces, able-no-sdp, recvonly] UserAgent: [] PBX contact: [sip:sip3wvp00420@187.132.114.36:5060]
    05-apr-2013 12:00:18.098	L:27.1[Line:10000<<0523610878]:  Updated OutCID: '315230784044' and DNName: ''
    05-apr-2013 12:00:18.098	Call(C:27): Referred(i): src=<sip:0523610878@192.168.1.8:5060;nf=e>; dst=<sip:800@192.168.1.8:5060>
    05-apr-2013 12:00:18.098	[Flow] Refer: RefTo=<sip:200@127.0.0.1:5060>; was call from=<sip:800@127.0.0.1:5060> to=<sip:0523610878@127.0.0.1:5060>
    05-apr-2013 12:00:18.098	Call transfer requested on Leg L:27.2[Ivr];
    Refer Recv Req REFER from 127.0.0.1:40600 tid=c4403f0d660ed766 Call-ID=YmY3MDVhOWMyMWYwNjBiMzNiOTE3M2VkOWM1NDkxZGE.:
    			REFER sip:0523610878@127.0.0.1:5060 SIP/2.0
    			Via: SIP/2.0/UDP 127.0.0.1:40600;branch=z9hG4bK-d8754z-c4403f0d660ed766-1---d8754z-;rport=40600
    			Max-Forwards: 70
    			Contact: <sip:800@127.0.0.1:40600;rinstance=3999fcfb77aacc27>
    			To: <sip:0523610878@127.0.0.1:5060;nf=e>;tag=5e5f273a
    			From: <sip:800@127.0.0.1:5060>;tag=d227a531
    			Call-ID: YmY3MDVhOWMyMWYwNjBiMzNiOTE3M2VkOWM1NDkxZGE.
    			CSeq: 3 REFER
    			User-Agent: 3CX IVR
    			Refer-To: <sip:200@127.0.0.1:5060>
    			Referred-By: <sip:800@127.0.0.1:5060>
    			Content-Length: 0
    05-apr-2013 12:00:18.098	Refer from <sip:800@127.0.0.1:5060>;tag=d227a531 to <sip:0523610878@127.0.0.1:5060;nf=e>;tag=5e5f273a
    05-apr-2013 12:00:17.894	L:27.2[Ivr] Sending: OnSendResp Send 200/INVITE from 0.0.0.0:0 tid=fe00d63365512c39 Call-ID=YmY3MDVhOWMyMWYwNjBiMzNiOTE3M2VkOWM1NDkxZGE.:
    			SIP/2.0 200 OK
    			Via: SIP/2.0/UDP 127.0.0.1:40600;branch=z9hG4bK-d8754z-fe00d63365512c39-1---d8754z-;rport=40600
    			Contact: <sip:0523610878@127.0.0.1:5060>
    			To: <sip:0523610878@127.0.0.1:5060;nf=e>;tag=5e5f273a
    			From: <sip:800@127.0.0.1:5060>;tag=d227a531
    			Call-ID: YmY3MDVhOWMyMWYwNjBiMzNiOTE3M2VkOWM1NDkxZGE.
    			CSeq: 2 INVITE
    			Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REGISTER, SUBSCRIBE, NOTIFY, REFER, INFO, MESSAGE
    			Content-Type: application/sdp
    			Supported: replaces
    			Content-Length: 351
    			
    			v=0
    			o=3cxPS 203557961728 136650424322 IN IP4 127.0.0.1
    			s=3cxPS Audio call
    			c=IN IP4 127.0.0.1
    			t=0 0
    			m=audio 7050 RTP/AVP 0 8 3 13 9 110 99 101
    			a=rtpmap:0 PCMU/8000
    			a=rtpmap:8 PCMA/8000
    			a=rtpmap:3 GSM/8000
    			a=rtpmap:13 CN/8000
    			a=rtpmap:9 G722/8000
    			a=rtpmap:110 iLBC/8000
    			a=rtpmap:99 SPEEX/8000
    			a=rtpmap:101 telephone-event/8000
    			a=recvonly
    05-apr-2013 12:00:17.894	SendMsg from <sip:0523610878@127.0.0.1:5060;nf=e>;tag=5e5f273a to <sip:800@127.0.0.1:5060>;tag=d227a531
    05-apr-2013 12:00:17.890	Answer to offerer immediateily, other party (L:27.1[Line:10000<<0523610878]) doesn't support re-invite
    05-apr-2013 12:00:17.890	Reneg. from L:27.2[Ivr], offer
    05-apr-2013 12:00:17.890	Leg L:27.2[Ivr] raised event RecvdRemoteSdp
    05-apr-2013 12:00:17.890	Remote SDP is set for leg L:27.2[Ivr]
    05-apr-2013 12:00:17.890	Offer SDP arrived on Leg L:27.2[Ivr];
    OnOffer Recv Req INVITE from 127.0.0.1:40600 tid=fe00d63365512c39 Call-ID=YmY3MDVhOWMyMWYwNjBiMzNiOTE3M2VkOWM1NDkxZGE.:
    			INVITE sip:0523610878@127.0.0.1:5060 SIP/2.0
    			Via: SIP/2.0/UDP 127.0.0.1:40600;branch=z9hG4bK-d8754z-fe00d63365512c39-1---d8754z-;rport=40600
    			Max-Forwards: 70
    			Contact: <sip:800@127.0.0.1:40600;rinstance=3999fcfb77aacc27>
    			To: <sip:0523610878@127.0.0.1:5060;nf=e>;tag=5e5f273a
    			From: <sip:800@127.0.0.1:5060>;tag=d227a531
    			Call-ID: YmY3MDVhOWMyMWYwNjBiMzNiOTE3M2VkOWM1NDkxZGE.
    			CSeq: 2 INVITE
    			Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REGISTER, SUBSCRIBE, NOTIFY, REFER, INFO, MESSAGE
    			Content-Type: application/sdp
    			Supported: replaces
    			User-Agent: 3CX IVR
    			Content-Length: 360
    			
    			v=0
    			o=3cxVCE 283021470 255282256 IN IP4 127.0.0.1
    			s=3cxVCE Audio Call
    			c=IN IP4 127.0.0.1
    			t=0 0
    			m=audio 40654 RTP/AVP 0 8 3 13 9 110 99 101
    			a=rtpmap:0 PCMU/8000
    			a=rtpmap:8 PCMA/8000
    			a=rtpmap:3 GSM/8000
    			a=rtpmap:13 CN/8000
    			a=rtpmap:9 G722/8000
    			a=rtpmap:110 iLBC/8000
    			a=rtpmap:99 SPEEX/8000
    			a=rtpmap:101 telephone-event/8000
    			a=ptime:20
    			a=sendonly
    05-apr-2013 11:59:59.772	Session 43102 of leg L:27.1[Line:10000<<0523610878] is confirmed
    05-apr-2013 11:59:59.772	L:27.1[Line:10000<<0523610878] got Confirmed Recv Req ACK from 89.146.10.230:5060 tid=7e32.f7c19841.2 Call-ID=5ddb-4f9-35201395947-HLF-IMG-02-1-31.276.32.22:
    			ACK sip:sip3wvp00420@187.132.114.36:5060 SIP/2.0
    			Via: SIP/2.0/UDP 89.146.10.230:5060;branch=z9hG4bK7e32.f7c19841.2
    			Via: SIP/2.0/UDP 31.276.32.22:5060;received=31.276.32.22;rport=5060;branch=z9hG4bK-a76-1365155987-3143-173
    			Max-Forwards: 69
    			Record-Route: <sip:89.146.10.230;lr;ftag=95ffcd055e0f78f7d5d397020e89288dd6f599e5>
    			To: <sip:315230784044@89.146.10.230:5060>;tag=7613b128
    			From: <sip:0523610878@sip3.nowhere.nl>;tag=95ffcd055e0f78f7d5d397020e89288dd6f599e5
    			Call-ID: 5ddb-4f9-35201395947-HLF-IMG-02-1-31.276.32.22
    			CSeq: 1 ACK
    			Content-Length: 0
    05-apr-2013 11:59:59.772	ConnCfmd from <sip:0523610878@sip3.nowhere.nl>;tag=95ffcd055e0f78f7d5d397020e89288dd6f599e5 to <sip:315230784044@89.146.10.230:5060>;tag=7613b128
    05-apr-2013 11:59:59.673	[CM503007]: Call(C:27): Ivr:800 has joined, contact <sip:800@127.0.0.1:40600>
    05-apr-2013 11:59:59.666	[CM503007]: Call(C:27): Line:10000<<0523610878 has joined, contact <sip:sip3wvp00420@sip3.nowhere.nl:5060>
    05-apr-2013 11:59:59.665	Session 43102 of leg L:27.1[Line:10000<<0523610878] is connected
    05-apr-2013 11:59:59.665	L:27.1[Line:10000<<0523610878] got Connected.UAS Send 200/INVITE from 0.0.0.0:0 tid=7e32.f7c19841.0 Call-ID=5ddb-4f9-35201395947-HLF-IMG-02-1-31.276.32.22:
    			SIP/2.0 200 OK
    			Via: SIP/2.0/UDP 89.146.10.230:5060;branch=z9hG4bK7e32.f7c19841.0
    			Via: SIP/2.0/UDP 31.276.32.22:5060;received=31.276.32.22;rport=5060;branch=z9hG4bK-456a-1365155987-3143-173
    			Record-Route: <sip:89.146.10.230;lr;ftag=95ffcd055e0f78f7d5d397020e89288dd6f599e5;did=0b3.bda59fd4>
    			Contact: <sip:sip3wvp00420@187.132.114.36:5060>
    			To: <sip:315230784044@89.146.10.230:5060>;tag=7613b128
    			From: <sip:0523610878@sip3.nowhere.nl>;tag=95ffcd055e0f78f7d5d397020e89288dd6f599e5
    			Call-ID: 5ddb-4f9-35201395947-HLF-IMG-02-1-31.276.32.22
    			CSeq: 1 INVITE
    			Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REGISTER, SUBSCRIBE, NOTIFY, REFER, INFO, MESSAGE
    			Content-Type: application/sdp
    			Supported: replaces
    			User-Agent: 3CXPhoneSystem 11.0.28976.849 (28862)
    			Content-Length: 252
    			
    			v=0
    			o=3cxPS 200974270464 403475267585 IN IP4 187.132.114.36
    			s=3cxPS Audio call
    			c=IN IP4 187.132.114.36
    			t=0 0
    			m=audio 9024 RTP/AVP 8 0 101
    			a=rtpmap:8 PCMA/8000
    			a=rtpmap:0 PCMU/8000
    			a=rtpmap:101 telephone-event/8000
    			a=fmtp:101 0-15
    			a=sendrecv
    05-apr-2013 11:59:59.665	Connected(UAS) from <sip:0523610878@sip3.nowhere.nl>;tag=95ffcd055e0f78f7d5d397020e89288dd6f599e5 to <sip:315230784044@89.146.10.230:5060>;tag=7613b128
    05-apr-2013 11:59:59.665	L:27.1[Line:10000<<0523610878] Sending: OnSendResp Send 200/INVITE from 0.0.0.0:0 tid=7e32.f7c19841.0 Call-ID=5ddb-4f9-35201395947-HLF-IMG-02-1-31.276.32.22:
    			SIP/2.0 200 OK
    			Via: SIP/2.0/UDP 89.146.10.230:5060;branch=z9hG4bK7e32.f7c19841.0
    			Via: SIP/2.0/UDP 31.276.32.22:5060;received=31.276.32.22;rport=5060;branch=z9hG4bK-456a-1365155987-3143-173
    			Record-Route: <sip:89.146.10.230;lr;ftag=95ffcd055e0f78f7d5d397020e89288dd6f599e5;did=0b3.bda59fd4>
    			Contact: <sip:sip3wvp00420@187.132.114.36:5060>
    			To: <sip:315230784044@89.146.10.230:5060>;tag=7613b128
    			From: <sip:0523610878@sip3.nowhere.nl>;tag=95ffcd055e0f78f7d5d397020e89288dd6f599e5
    			Call-ID: 5ddb-4f9-35201395947-HLF-IMG-02-1-31.276.32.22
    			CSeq: 1 INVITE
    			Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REGISTER, SUBSCRIBE, NOTIFY, REFER, INFO, MESSAGE
    			Content-Type: application/sdp
    			Supported: replaces
    			Content-Length: 252
    			
    			v=0
    			o=3cxPS 200974270464 403475267585 IN IP4 187.132.114.36
    			s=3cxPS Audio call
    			c=IN IP4 187.132.114.36
    			t=0 0
    			m=audio 9024 RTP/AVP 8 0 101
    			a=rtpmap:8 PCMA/8000
    			a=rtpmap:0 PCMU/8000
    			a=rtpmap:101 telephone-event/8000
    			a=fmtp:101 0-15
    			a=sendrecv
    05-apr-2013 11:59:59.665	SendMsg from <sip:315230784044@89.146.10.230:5060>;tag=7613b128 to <sip:0523610878@sip3.nowhere.nl>;tag=95ffcd055e0f78f7d5d397020e89288dd6f599e5
    05-apr-2013 11:59:59.658	~Target=Ext:Ext.800
    05-apr-2013 11:59:59.658	L:27.1[Line:10000<<0523610878]: Terminating targets, reason: SIP ;cause=200 ;text="Call completed elsewhere"
    05-apr-2013 11:59:59.658	~Route=Dev:sip:800@127.0.0.1:40600;rinstance=3999fcfb77aacc27
    05-apr-2013 11:59:59.658	L:27.2[Ivr] has joined to L:27.1[Line:10000<<0523610878]
    05-apr-2013 11:59:59.658	Session 43105 of leg L:27.2[Ivr] is connected
    05-apr-2013 11:59:59.658	L:27.2[Ivr] got Connected.UAC Recv 200/INVITE from 127.0.0.1:40600 tid=9a08090dac0a9b1e Call-ID=YmY3MDVhOWMyMWYwNjBiMzNiOTE3M2VkOWM1NDkxZGE.:
    			SIP/2.0 200 OK
    			Via: SIP/2.0/UDP 127.0.0.1:5060;branch=z9hG4bK-d8754z-9a08090dac0a9b1e-1---d8754z-;rport=5060
    			Contact: <sip:800@127.0.0.1:40600;rinstance=3999fcfb77aacc27>
    			To: <sip:800@127.0.0.1:5060>;tag=d227a531
    			From: <sip:0523610878@127.0.0.1:5060;nf=e>;tag=5e5f273a
    			Call-ID: YmY3MDVhOWMyMWYwNjBiMzNiOTE3M2VkOWM1NDkxZGE.
    			CSeq: 1 INVITE
    			Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REGISTER, SUBSCRIBE, NOTIFY, REFER, INFO, MESSAGE
    			Content-Type: application/sdp
    			Supported: replaces
    			User-Agent: 3CX IVR
    			Content-Length: 336
    			
    			v=0
    			o=3cxVCE 283021470 255282255 IN IP4 127.0.0.1
    			s=3cxVCE Audio Call
    			c=IN IP4 127.0.0.1
    			t=0 0
    			m=audio 40654 RTP/AVP 0 8 3 13 9 110 99 101
    			a=rtpmap:0 PCMU/8000
    			a=rtpmap:8 PCMA/8000
    			a=rtpmap:3 GSM/8000
    			a=rtpmap:13 CN/8000
    			a=rtpmap:9 G722/8000
    			a=rtpmap:110 iLBC/8000
    			a=rtpmap:99 SPEEX/8000
    			a=rtpmap:101 telephone-event/8000
    05-apr-2013 11:59:59.658	Connected(UAC) from <sip:800@127.0.0.1:5060>;tag=d227a531 to <sip:0523610878@127.0.0.1:5060;nf=e>;tag=5e5f273a
    05-apr-2013 11:59:59.658	Remote SDP is set for leg L:27.2[Ivr]
    05-apr-2013 11:59:59.658	Answer SDP arrived on Leg L:27.2[Ivr];
    OnAnswer Recv 200/INVITE from 127.0.0.1:40600 tid=9a08090dac0a9b1e Call-ID=YmY3MDVhOWMyMWYwNjBiMzNiOTE3M2VkOWM1NDkxZGE.:
    			SIP/2.0 200 OK
    			Via: SIP/2.0/UDP 127.0.0.1:5060;branch=z9hG4bK-d8754z-9a08090dac0a9b1e-1---d8754z-;rport=5060
    			Contact: <sip:800@127.0.0.1:40600;rinstance=3999fcfb77aacc27>
    			To: <sip:800@127.0.0.1:5060>;tag=d227a531
    			From: <sip:0523610878@127.0.0.1:5060;nf=e>;tag=5e5f273a
    			Call-ID: YmY3MDVhOWMyMWYwNjBiMzNiOTE3M2VkOWM1NDkxZGE.
    			CSeq: 1 INVITE
    			Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REGISTER, SUBSCRIBE, NOTIFY, REFER, INFO, MESSAGE
    			Content-Type: application/sdp
    			Supported: replaces
    			User-Agent: 3CX IVR
    			Content-Length: 336
    			
    			v=0
    			o=3cxVCE 283021470 255282255 IN IP4 127.0.0.1
    			s=3cxVCE Audio Call
    			c=IN IP4 127.0.0.1
    			t=0 0
    			m=audio 40654 RTP/AVP 0 8 3 13 9 110 99 101
    			a=rtpmap:0 PCMU/8000
    			a=rtpmap:8 PCMA/8000
    			a=rtpmap:3 GSM/8000
    			a=rtpmap:13 CN/8000
    			a=rtpmap:9 G722/8000
    			a=rtpmap:110 iLBC/8000
    			a=rtpmap:99 SPEEX/8000
    			a=rtpmap:101 telephone-event/8000
    05-apr-2013 11:59:59.658	L:27.2[Ivr] Sending: OnSendReq Send Req ACK from 0.0.0.0:0 tid=84133e0c5a0ef106 Call-ID=YmY3MDVhOWMyMWYwNjBiMzNiOTE3M2VkOWM1NDkxZGE.:
    			ACK sip:800@127.0.0.1:40600;rinstance=3999fcfb77aacc27 SIP/2.0
    			Via: SIP/2.0/ ;branch=z9hG4bK-d8754z-84133e0c5a0ef106-1---d8754z-;rport
    			Max-Forwards: 70
    			Contact: <sip:0523610878@127.0.0.1:5060>
    			To: <sip:800@127.0.0.1:5060>;tag=d227a531
    			From: <sip:0523610878@127.0.0.1:5060;nf=e>;tag=5e5f273a
    			Call-ID: YmY3MDVhOWMyMWYwNjBiMzNiOTE3M2VkOWM1NDkxZGE.
    			CSeq: 1 ACK
    			Content-Length: 0
    05-apr-2013 11:59:59.658	SendMsg from <sip:0523610878@127.0.0.1:5060;nf=e>;tag=5e5f273a to <sip:800@127.0.0.1:5060>;tag=d227a531
    05-apr-2013 11:59:59.657	L:27.1[Line:10000<<0523610878] Sending: OnSendResp Send 180/INVITE from 0.0.0.0:0 tid=7e32.f7c19841.0 Call-ID=5ddb-4f9-35201395947-HLF-IMG-02-1-31.276.32.22:
    			SIP/2.0 180 Ringing
    			Via: SIP/2.0/UDP 89.146.10.230:5060;branch=z9hG4bK7e32.f7c19841.0
    			Via: SIP/2.0/UDP 31.276.32.22:5060;received=31.276.32.22;rport=5060;branch=z9hG4bK-456a-1365155987-3143-173
    			Record-Route: <sip:89.146.10.230;lr;ftag=95ffcd055e0f78f7d5d397020e89288dd6f599e5;did=0b3.bda59fd4>
    			Contact: <sip:sip3wvp00420@187.132.114.36:5060;rinstance=0e4b38e92874cb54>
    			To: <sip:315230784044@89.146.10.230:5060>;tag=7613b128
    			From: <sip:0523610878@sip3.nowhere.nl>;tag=95ffcd055e0f78f7d5d397020e89288dd6f599e5
    			Call-ID: 5ddb-4f9-35201395947-HLF-IMG-02-1-31.276.32.22
    			CSeq: 1 INVITE
    			Content-Length: 0
    05-apr-2013 11:59:59.657	SendMsg from <sip:315230784044@89.146.10.230:5060>;tag=7613b128 to <sip:0523610878@sip3.nowhere.nl>;tag=95ffcd055e0f78f7d5d397020e89288dd6f599e5
    05-apr-2013 11:59:59.657	Provisional response arrived for session 43105 of Leg L:27.2[Ivr]
    05-apr-2013 11:59:59.657	L:27.2[Ivr] got Provisional Recv 180/INVITE from 127.0.0.1:40600 tid=9a08090dac0a9b1e Call-ID=YmY3MDVhOWMyMWYwNjBiMzNiOTE3M2VkOWM1NDkxZGE.:
    			SIP/2.0 180 Ringing
    			Via: SIP/2.0/UDP 127.0.0.1:5060;branch=z9hG4bK-d8754z-9a08090dac0a9b1e-1---d8754z-;rport=5060
    			Contact: <sip:800@127.0.0.1:40600;rinstance=3999fcfb77aacc27>
    			To: <sip:800@127.0.0.1:5060>;tag=d227a531
    			From: <sip:0523610878@127.0.0.1:5060;nf=e>;tag=5e5f273a
    			Call-ID: YmY3MDVhOWMyMWYwNjBiMzNiOTE3M2VkOWM1NDkxZGE.
    			CSeq: 1 INVITE
    			User-Agent: 3CX IVR
    			Content-Length: 0
    05-apr-2013 11:59:59.657	Provisional(180) from <sip:800@127.0.0.1:5060>;tag=d227a531 to <sip:0523610878@127.0.0.1:5060;nf=e>;tag=5e5f273a
    05-apr-2013 11:59:59.657	[CM505001]: Endpoint Ivr:800: Device info: Device Identified: [Man: 3CX Ltd.;Mod: 3CX IVR;Rev: General] Capabilities:[reinvite, replaces, able-no-sdp, recvonly] UserAgent: [3CX IVR] PBX contact: [sip:800@127.0.0.1:5060]
    05-apr-2013 11:59:59.657	[CM503002]: Call(C:27): Alerting Ivr:800 by contact <sip:800@127.0.0.1:40600>
    05-apr-2013 11:59:59.650	UacSession 43105 has formed leg L:27.2[Ivr]
    05-apr-2013 11:59:59.650	Answer from <sip:800@127.0.0.1:5060>;tag=d227a531 to <sip:0523610878@127.0.0.1:5060;nf=e>;tag=5e5f273a
    05-apr-2013 11:59:59.504	[CM503025]: Call(C:27): Calling T:Ivr:800@[Dev:sip:800@127.0.0.1:40600;rinstance=3999fcfb77aacc27] for L:27.1[Line:10000<<0523610878]
    05-apr-2013 11:59:59.504	Route to L:27.2[Ivr] sends Invite-OUT Send Req INVITE from 0.0.0.0:0 tid=895c3d121608ed2f Call-ID=YmY3MDVhOWMyMWYwNjBiMzNiOTE3M2VkOWM1NDkxZGE.:
    			INVITE sip:800@127.0.0.1:40600;rinstance=3999fcfb77aacc27 SIP/2.0
    			Via: SIP/2.0/ ;branch=z9hG4bK-d8754z-895c3d121608ed2f-1---d8754z-;rport
    			Max-Forwards: 70
    			Contact: <sip:0523610878@127.0.0.1:5060>
    			To: <sip:800@127.0.0.1:5060>
    			From: <sip:0523610878@127.0.0.1:5060;nf=e>;tag=5e5f273a
    			Call-ID: YmY3MDVhOWMyMWYwNjBiMzNiOTE3M2VkOWM1NDkxZGE.
    			CSeq: 1 INVITE
    			Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REGISTER, SUBSCRIBE, NOTIFY, REFER, INFO, MESSAGE
    			Content-Type: application/sdp
    			Supported: replaces
    			Content-Length: 351
    			
    			v=0
    			o=3cxPS 203557961728 136650424321 IN IP4 127.0.0.1
    			s=3cxPS Audio call
    			c=IN IP4 127.0.0.1
    			t=0 0
    			m=audio 7050 RTP/AVP 0 8 3 13 9 110 99 101
    			a=rtpmap:0 PCMU/8000
    			a=rtpmap:8 PCMA/8000
    			a=rtpmap:3 GSM/8000
    			a=rtpmap:13 CN/8000
    			a=rtpmap:9 G722/8000
    			a=rtpmap:110 iLBC/8000
    			a=rtpmap:99 SPEEX/8000
    			a=rtpmap:101 telephone-event/8000
    			a=sendrecv
    05-apr-2013 11:59:59.495	Outbound URI is used: sip:800@127.0.0.1:40600;rinstance=3999fcfb77aacc27
    05-apr-2013 11:59:59.495	Added leg L:27.2[Ivr]
    05-apr-2013 11:59:59.464	[Flow] Call(C:27): making call from L:27.1[Line:10000<<0523610878] to T:Ivr:800@[Dev:sip:800@127.0.0.1:40600;rinstance=3999fcfb77aacc27]
    05-apr-2013 11:59:59.464	[CM503027]: Call(C:27): From: Line:10000<<0523610878 (<sip:0523610878@192.168.1.8:5060>)  to  T:Ivr:800@[Dev:sip:800@127.0.0.1:40600;rinstance=3999fcfb77aacc27]
    05-apr-2013 11:59:59.464	[CM503004]: Call(C:27): Route 1: from L:27.1[Line:10000<<0523610878] to T:Ivr:800@[Dev:sip:800@127.0.0.1:40600;rinstance=3999fcfb77aacc27]
    05-apr-2013 11:59:59.464	[Flow] Endpoint Ivr:800 has no forwarding rule on reason 'All calls'
    05-apr-2013 11:59:59.464	[Flow] Call(C:27): has built target endpoint: Ivr:800 for call from L:27.1[Line:10000<<0523610878]
    05-apr-2013 11:59:59.464	[Flow] Target endpoint for 800 is Ivr:800
    05-apr-2013 11:59:59.464	[Flow] Building target endpoint to 800 from <sip:0523610878@192.168.1.8:5060>
    05-apr-2013 11:59:59.464	[CM503010]: Call(C:27): Making route(s) from Line:10000<<0523610878 to <sip:800@192.168.1.8:5060>
    05-apr-2013 11:59:59.463	Remote SDP is set for leg L:27.1[Line:10000<<0523610878]
    05-apr-2013 11:59:59.463	OnOffer from <sip:0523610878@192.168.1.8:5060;nf=e>
    05-apr-2013 11:59:59.463	[CM505003]: Provider:[nowhere.Comm] Device info: Device Not Identified: User Agent not matched; Capabilities:[reinvite, replaces, able-no-sdp, recvonly] UserAgent: [] PBX contact: [sip:sip3wvp00420@187.132.114.36:5060]
    05-apr-2013 11:59:59.463	Inbound DID: ''; Phonebook Name: ''
    05-apr-2013 11:59:59.458	[CM500002]: Call(C:27): Info on incoming INVITE from Line:10000<<0523610878:
    			Invite-IN Recv Req INVITE from 89.146.10.230:5060 tid=7e32.f7c19841.0 Call-ID=5ddb-4f9-35201395947-HLF-IMG-02-1-31.276.32.22:
    			INVITE sip:sip3wvp00420@187.132.114.36:5060;rinstance=0e4b38e92874cb54 SIP/2.0
    			Via: SIP/2.0/UDP 89.146.10.230:5060;branch=z9hG4bK7e32.f7c19841.0
    			Via: SIP/2.0/UDP 31.276.32.22:5060;received=31.276.32.22;rport=5060;branch=z9hG4bK-456a-1365155987-3143-173
    			Max-Forwards: 69
    			Record-Route: <sip:89.146.10.230;lr;ftag=95ffcd055e0f78f7d5d397020e89288dd6f599e5;did=0b3.bda59fd4>
    			Contact: <sip:31523610878@31.276.32.22:5060>
    			To: <sip:315230784044@89.146.10.230:5060>
    			From: <sip:0523610878@sip3.nowhere.nl>;tag=95ffcd055e0f78f7d5d397020e89288dd6f599e5
    			Call-ID: 5ddb-4f9-35201395947-HLF-IMG-02-1-31.276.32.22
    			CSeq: 1 INVITE
    			Expires: 300
    			Allow: INVITE, BYE, REGISTER, ACK, OPTIONS, CANCEL, SUBSCRIBE, NOTIFY, INFO, REFER, UPDATE
    			Content-Type: application/sdp
    			Supported: path, replaces, tdialog
    			P-Asserted-Identity: <sip:0523610878@sip3.nowhere.nl>
    			Content-Length: 370
    			Remote-Party-ID: <sip:0523610878@31.276.32.22>;party=calling;screen=no;privacy=off
    			
    			v=0
    			o=Dialogic_SDP 512222 0 IN IP4 31.276.32.22
    			s=Dialogic-SIP
    			c=IN IP4 31.276.32.42
    			t=0 0
    			m=audio 8996 RTP/AVP 8 0 18 98 3 101
    			a=rtpmap:0 PCMU/8000
    			a=rtpmap:8 PCMA/8000
    			a=rtpmap:3 GSM/8000
    			a=rtpmap:18 G729/8000
    			a=fmtp:18 annexb=yes
    			a=rtpmap:98 G726-32/8000
    			a=rtpmap:101 telephone-event/8000
    			a=fmtp:101 0-15
    			a=silenceSupp:off - - - -
    			a=direction:passive
    05-apr-2013 11:59:59.458	[CM503001]: Call(C:27): Incoming call from Line:10000<<0523610878 to <sip:800@192.168.1.8:5060>
    05-apr-2013 11:59:59.456	Line limit check: Current # of calls for line Lc:10000(@nowhere.Comm[<sip:sip3wvp00420@sip3.nowhere.nl:5060>]) is 1; limit is 2
    05-apr-2013 11:59:59.456	Blacklist check: number '0523610878', list: ''; result = false
    05-apr-2013 11:59:59.456	Dev(1):[sip:sip3wvp00420@sip3.nowhere.nl:5060 / sip3wvp00420]: PBX contact is public IP: <sip:sip3wvp00420@187.132.114.36:5060>
    05-apr-2013 11:59:59.448	Outbound URI is used: sip:89.146.10.230;lr;ftag=95ffcd055e0f78f7d5d397020e89288dd6f599e5;did=0b3.bda59fd4
    05-apr-2013 11:59:59.448	Dev(1):[sip:sip3wvp00420@sip3.nowhere.nl:5060 / sip3wvp00420]: Outbound is overriden with topmost RR: <sip:@89.146.10.230:5060>
    05-apr-2013 11:59:59.448	Dev(1):[sip:sip3wvp00420@sip3.nowhere.nl:5060 / sip3wvp00420]: PBX contact is public IP: <sip:sip3wvp00420@187.132.114.36:5060>
    05-apr-2013 11:59:59.446	[CM503012]: Inbound out-of-office hours rule (unnamed) for 10000 forwards to DN:800
    05-apr-2013 11:59:59.446	[Flow] Looking for inbound target: called=315230784044; caller=<sip:0523610878@:5060>
    05-apr-2013 11:59:59.446	CallerNameAddr: <sip:0523610878;nf=e>
    05-apr-2013 11:59:59.446	Tenant's phonebook has failed to load!
    05-apr-2013 11:59:59.446	Looking for phone number 0523610878 in tenant's 'default' phonebook
    05-apr-2013 11:59:59.446	No inbound caller ID reformat rule is defined, or it is disabled (0,,,,,)
    05-apr-2013 11:59:59.446	Line 10000 has been updated from DB
    05-apr-2013 11:59:59.445	IncomingCall: C:27 from <sip:0523610878@sip3.nowhere.nl:5060> to <sip:sip3wvp00420@187.132.114.36:5060>
    05-apr-2013 11:59:59.445	Added leg L:C:27.1[No endpoint yet]
    05-apr-2013 11:59:59.445	UasSession 43102 started
    05-apr-2013 11:59:59.445	Call from <sip:0523610878@sip3.nowhere.nl>;tag=95ffcd055e0f78f7d5d397020e89288dd6f599e5 to <sip:315230784044@89.146.10.230:5060>;tag=7613b128
     

Share This Page