Dealy to start the message

Status
Not open for further replies.

flaviost

Joined
Aug 17, 2007
Messages
18
Reaction score
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
 
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.
 
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.
 
Same problem

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

01:43:33.296 StratInOut::onHangUp [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::onConnected [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::onIncoming [CM103002] Call(2): Incoming call from 0731390275 (Ln:10000@engin 9.95) to sip:[email protected]

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.
 
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
 
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?
 
Re: Same problem

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

01:43:33.296 StratInOut::onHangUp [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::onConnected [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::onIncoming [CM103002] Call(2): Incoming call from 0731390275 (Ln:10000@engin 9.95) to sip:[email protected]

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.

Good information. We will try to investigate it.

Thanks
 
flaviost said:
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

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.
 
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:[email protected]:5060>;tag=4RHUD51EWY30000E1D01006l00Z47EQ1QU0CD5 to "315230784044"<sip:[email protected]: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:[email protected]:5060>
			To: <sip:[email protected]:5060>;tag=4RHUD51EWY30000E1D01006l00Z47EQ1QU0CD5
			From: "315230784044"<sip:[email protected]:5060>;tag=466a2119
			Call-ID: YWRjOTI0ODNhNWQ3NDVkM2MwOGIwNDk2N2FjY2U1ZjI.
			CSeq: 3 BYE
			Content-Length: 0
05-apr-2013 12:00:31.789	SendMsg from "315230784044"<sip:[email protected]:5060>;tag=466a2119 to <sip:[email protected]: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:[email protected]: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:[email protected]:5060>;tag=7613b128
			From: <sip:[email protected]>;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:[email protected]>;tag=95ffcd055e0f78f7d5d397020e89288dd6f599e5 to <sip:[email protected]: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:[email protected]:5060>
			To: <sip:[email protected]:5060>;tag=7613b128
			From: <sip:[email protected]>;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:[email protected]:5060>;tag=7613b128 to <sip:[email protected]>;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:[email protected]: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:[email protected]:40600;rinstance=3999fcfb77aacc27>
			To: <sip:[email protected]:5060;nf=e>;tag=5e5f273a
			From: <sip:[email protected]: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:[email protected]:5060>;tag=d227a531 to <sip:[email protected]: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:[email protected]:5060>
			To: <sip:[email protected]:5060;nf=e>;tag=5e5f273a
			From: <sip:[email protected]:5060>;tag=d227a531
			Call-ID: YmY3MDVhOWMyMWYwNjBiMzNiOTE3M2VkOWM1NDkxZGE.
			CSeq: 5 BYE
			Content-Length: 0
05-apr-2013 12:00:26.739	SendMsg from <sip:[email protected]:5060;nf=e>;tag=5e5f273a to <sip:[email protected]: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:[email protected]:5060>
05-apr-2013 12:00:26.537	~Target=VoIPline:31612412526@([email protected])
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:[email protected]: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:[email protected]:5060>;tag=4RHUD51EWY30000E1D01006l00Z47EQ1QU0CD5
			From: "315230784044"<sip:[email protected]: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:[email protected]>
			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:[email protected]:5060>;tag=4RHUD51EWY30000E1D01006l00Z47EQ1QU0CD5 to "315230784044"<sip:[email protected]: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:[email protected]:5060>;tag=4RHUD51EWY30000E1D01006l00Z47EQ1QU0CD5
			From: "315230784044"<sip:[email protected]: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:[email protected]>
			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:[email protected]:5060]
05-apr-2013 12:00:26.537	[CM503002]: Call(C:27): Alerting Line:10000>>31612412526 by contact <sip:[email protected]: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:[email protected]:5060>;tag=4RHUD51EWY30000E1D01006l00Z47EQ1QU0CD5 to "315230784044"<sip:[email protected]: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:[email protected]:5060>
			To: <sip:[email protected]:5060>;tag=4RHUD51EWY30000E1D01006l00Z47EQ1QU0CD5
			From: "315230784044"<sip:[email protected]:5060>;tag=466a2119
			Call-ID: YWRjOTI0ODNhNWQ3NDVkM2MwOGIwNDk2N2FjY2U1ZjI.
			CSeq: 2 ACK
			Proxy-Authorization: Digest username="sip3wvp00420",realm="sip3.nowhere.nl",nonce="515ea0b400008f00526bd05e9525d54050bd52b33fd520fc",uri="sip:[email protected]:5060",response="7346d2b7f3f994a3a9ca05e5c66e6995",algorithm=MD5
			Content-Length: 0
05-apr-2013 12:00:26.529	SendMsg from "315230784044"<sip:[email protected]:5060>;tag=466a2119 to <sip:[email protected]: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:[email protected]:5060>;tag=4RHUD51EWY30000E1D01006l00Z47EQ1QU0CD5
			From: "315230784044"<sip:[email protected]: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:[email protected]>
			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:[email protected]:5060>;tag=4RHUD51EWY30000E1D01006l00Z47EQ1QU0CD5
			From: "315230784044"<sip:[email protected]: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:[email protected]>
			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:[email protected]:5060>;tag=c8598deb78957a18ce3b310bd9f5d802.1b3b
			From: "315230784044"<sip:[email protected]: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:[email protected]: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:[email protected]:5060 SIP/2.0
			Via: SIP/2.0/ ;branch=z9hG4bK-d8754z-cf718717c91c653a-1---d8754z-;rport
			Max-Forwards: 70
			Contact: <sip:[email protected]:5060>
			To: <sip:[email protected]:5060>
			From: "315230784044"<sip:[email protected]: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:[email protected]: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:[email protected]:5060 / sip3wvp00420]: PBX contact is public IP: <sip:[email protected]: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:[email protected]:5060]
05-apr-2013 12:00:18.099	[CM503027]: Call(C:27): From: Line:10000<<0523610878 (<sip:[email protected]:5060>)  to  T:Line:10000>>31612412526@[Dev:sip:[email protected]: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:[email protected]:5060]
05-apr-2013 12:00:18.099	Line limit check: Current # of calls for line Lc:10000(@nowhere.Comm[<sip:[email protected]: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:[email protected]: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:[email protected]: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:[email protected]:5060>
05-apr-2013 12:00:18.098	[CM503010]: Call(C:27): Making route(s) from Line:10000<<0523610878 to <sip:[email protected]: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:[email protected]: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:[email protected]:5060;nf=e>; dst=<sip:[email protected]:5060>
05-apr-2013 12:00:18.098	[Flow] Refer: RefTo=<sip:[email protected]:5060>; was call from=<sip:[email protected]:5060> to=<sip:[email protected]: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:[email protected]: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:[email protected]:40600;rinstance=3999fcfb77aacc27>
			To: <sip:[email protected]:5060;nf=e>;tag=5e5f273a
			From: <sip:[email protected]:5060>;tag=d227a531
			Call-ID: YmY3MDVhOWMyMWYwNjBiMzNiOTE3M2VkOWM1NDkxZGE.
			CSeq: 3 REFER
			User-Agent: 3CX IVR
			Refer-To: <sip:[email protected]:5060>
			Referred-By: <sip:[email protected]:5060>
			Content-Length: 0
05-apr-2013 12:00:18.098	Refer from <sip:[email protected]:5060>;tag=d227a531 to <sip:[email protected]: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:[email protected]:5060>
			To: <sip:[email protected]:5060;nf=e>;tag=5e5f273a
			From: <sip:[email protected]: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:[email protected]:5060;nf=e>;tag=5e5f273a to <sip:[email protected]: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:[email protected]: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:[email protected]:40600;rinstance=3999fcfb77aacc27>
			To: <sip:[email protected]:5060;nf=e>;tag=5e5f273a
			From: <sip:[email protected]: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:[email protected]: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:[email protected]:5060>;tag=7613b128
			From: <sip:[email protected]>;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:[email protected]>;tag=95ffcd055e0f78f7d5d397020e89288dd6f599e5 to <sip:[email protected]:5060>;tag=7613b128
05-apr-2013 11:59:59.673	[CM503007]: Call(C:27): Ivr:800 has joined, contact <sip:[email protected]:40600>
05-apr-2013 11:59:59.666	[CM503007]: Call(C:27): Line:10000<<0523610878 has joined, contact <sip:[email protected]: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:[email protected]:5060>
			To: <sip:[email protected]:5060>;tag=7613b128
			From: <sip:[email protected]>;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:[email protected]>;tag=95ffcd055e0f78f7d5d397020e89288dd6f599e5 to <sip:[email protected]: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:[email protected]:5060>
			To: <sip:[email protected]:5060>;tag=7613b128
			From: <sip:[email protected]>;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:[email protected]:5060>;tag=7613b128 to <sip:[email protected]>;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:[email protected]: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:[email protected]:40600;rinstance=3999fcfb77aacc27>
			To: <sip:[email protected]:5060>;tag=d227a531
			From: <sip:[email protected]: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:[email protected]:5060>;tag=d227a531 to <sip:[email protected]: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:[email protected]:40600;rinstance=3999fcfb77aacc27>
			To: <sip:[email protected]:5060>;tag=d227a531
			From: <sip:[email protected]: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:[email protected]:40600;rinstance=3999fcfb77aacc27 SIP/2.0
			Via: SIP/2.0/ ;branch=z9hG4bK-d8754z-84133e0c5a0ef106-1---d8754z-;rport
			Max-Forwards: 70
			Contact: <sip:[email protected]:5060>
			To: <sip:[email protected]:5060>;tag=d227a531
			From: <sip:[email protected]:5060;nf=e>;tag=5e5f273a
			Call-ID: YmY3MDVhOWMyMWYwNjBiMzNiOTE3M2VkOWM1NDkxZGE.
			CSeq: 1 ACK
			Content-Length: 0
05-apr-2013 11:59:59.658	SendMsg from <sip:[email protected]:5060;nf=e>;tag=5e5f273a to <sip:[email protected]: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:[email protected]:5060;rinstance=0e4b38e92874cb54>
			To: <sip:[email protected]:5060>;tag=7613b128
			From: <sip:[email protected]>;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:[email protected]:5060>;tag=7613b128 to <sip:[email protected]>;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:[email protected]:40600;rinstance=3999fcfb77aacc27>
			To: <sip:[email protected]:5060>;tag=d227a531
			From: <sip:[email protected]: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:[email protected]:5060>;tag=d227a531 to <sip:[email protected]: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:[email protected]:5060]
05-apr-2013 11:59:59.657	[CM503002]: Call(C:27): Alerting Ivr:800 by contact <sip:[email protected]: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:[email protected]:5060>;tag=d227a531 to <sip:[email protected]:5060;nf=e>;tag=5e5f273a
05-apr-2013 11:59:59.504	[CM503025]: Call(C:27): Calling T:Ivr:800@[Dev:sip:[email protected]: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:[email protected]:40600;rinstance=3999fcfb77aacc27 SIP/2.0
			Via: SIP/2.0/ ;branch=z9hG4bK-d8754z-895c3d121608ed2f-1---d8754z-;rport
			Max-Forwards: 70
			Contact: <sip:[email protected]:5060>
			To: <sip:[email protected]:5060>
			From: <sip:[email protected]: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:[email protected]: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:[email protected]:40600;rinstance=3999fcfb77aacc27]
05-apr-2013 11:59:59.464	[CM503027]: Call(C:27): From: Line:10000<<0523610878 (<sip:[email protected]:5060>)  to  T:Ivr:800@[Dev:sip:[email protected]: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:[email protected]: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:[email protected]:5060>
05-apr-2013 11:59:59.464	[CM503010]: Call(C:27): Making route(s) from Line:10000<<0523610878 to <sip:[email protected]: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:[email protected]: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:[email protected]: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:[email protected]: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:[email protected]:5060>
			To: <sip:[email protected]:5060>
			From: <sip:[email protected]>;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:[email protected]>
			Content-Length: 370
			Remote-Party-ID: <sip:[email protected]>;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:[email protected]:5060>
05-apr-2013 11:59:59.456	Line limit check: Current # of calls for line Lc:10000(@nowhere.Comm[<sip:[email protected]: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:[email protected]:5060 / sip3wvp00420]: PBX contact is public IP: <sip:[email protected]: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:[email protected]:5060 / sip3wvp00420]: Outbound is overriden with topmost RR: <sip:@89.146.10.230:5060>
05-apr-2013 11:59:59.448	Dev(1):[sip:[email protected]:5060 / sip3wvp00420]: PBX contact is public IP: <sip:[email protected]: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:[email protected]:5060> to <sip:[email protected]: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:[email protected]>;tag=95ffcd055e0f78f7d5d397020e89288dd6f599e5 to <sip:[email protected]:5060>;tag=7613b128
 
Status
Not open for further replies.