3CX HT503 and Avaya 9611G Oh My!

Discussion in '3CX Phone System - General' started by crombiecrunch, Feb 2, 2014.

Thread Status:
Not open for further replies.
  1. crombiecrunch

    Joined:
    Feb 2, 2014
    Messages:
    8
    Likes Received:
    0
    Hello all

    I am having some troubles with my setup and have tried many of the bits of information I can find. But I am having one heck of a time getting things working

    I am connecting to Grandstream HT503 and when making an out going call, I get a half ring on my Avaya phone then goes silent. The number I am calling does ring and when I answer all I hear is hold music.

    When I try to call the PBX it answers direct to voicemail. Any thoughts?

    Code:
     [CM503007]: Call(C:5): Line:10000>>xx has joined, contact <sip:10000@192.168.0.35:5062>
    02-Feb-2014 02:07:48.462   [CM503007]: Call(C:5): Extn:101 has joined, contact <sip:101@0.0.0.0:5060>
    02-Feb-2014 02:07:48.460   L:5.2[Line:10000>>xx] has joined to L:5.1[Extn]
    02-Feb-2014 02:07:48.434   [CM505002]: Gateway:[Line 1] Device info: Device Not Identified: User Agent not matched; Capabilities:[reinvite, replaces, able-no-sdp, recvonly] UserAgent: [Grandstream HT-503  V1.4A 1.0.10.9  chip V2.2] PBX contact: [sip:10000@192.168.0.12:5060]
    02-Feb-2014 02:07:45.151   [CM503025]: Call(C:5): Calling T:Line:10000>>xx@[Dev:sip:10000@192.168.0.35:5062] for L:5.1[Extn]
    02-Feb-2014 02:07:45.104   [CM503027]: Call(C:5): From: Extn:101 (<sip:101@192.168.0.12:5060>)  to  T:Line:10000>>xx@[Dev:sip:10000@192.168.0.35:5062]
    02-Feb-2014 02:07:45.104   [CM503004]: Call(C:5): Route 1: from L:5.1[Extn] to T:Line:10000>>xx@[Dev:sip:10000@192.168.0.35:5062]
    02-Feb-2014 02:07:45.104   Line limit check: Current # of calls for line Lc:10003(@Line 1[<sip:10003@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 02:07:45.104   Line limit check: Current # of calls for line Lc:10002(@Line 1[<sip:10002@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 02:07:45.104   Line limit check: Current # of calls for line Lc:10001(@Line 1[<sip:10001@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 02:07:45.104   Line limit check: Current # of calls for line Lc:10000(@Line 1[<sip:10000@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 02:07:45.104   Call(C:5): Call from Extn:101 to xx matches outbound rule 'Rule for Line 1'
    02-Feb-2014 02:07:45.103   [CM503001]: Call(C:5): Incoming call from Extn:101 to <sip:xx@192.168.0.12:5060>
    02-Feb-2014 01:58:15.883   Leg L:4.2[VMail] is terminated: Cause: BYE from PBX
    02-Feb-2014 01:58:15.883   [CM503008]: Call(C:4): Call is terminated
    02-Feb-2014 01:58:15.882   Leg L:4.1[Line:10000<<xx] is terminated: Cause: BYE from 192.168.0.35:5062
    02-Feb-2014 01:58:04.520   Currently active calls - 1: [4]
    02-Feb-2014 01:57:32.504   Currently active calls - 1: [4]
    02-Feb-2014 01:57:02.489   Currently active calls - 1: [4]
    02-Feb-2014 01:56:30.474   Currently active calls - 1: [4]
    02-Feb-2014 01:56:17.645   [CM503007]: Call(C:4): VMail:999 has joined, contact <sip:999@127.0.0.1:40600>
    02-Feb-2014 01:56:17.645   [CM503007]: Call(C:4): Line:10000<<xx has joined, contact <sip:10000@192.168.0.35:5062>
    02-Feb-2014 01:56:17.625   L:4.2[VMail] has joined to L:4.1[Line:10000<<xx]
    02-Feb-2014 01:56:17.388   [CM503025]: Call(C:4): Calling T:VMail:999@[Dev:sip:999@127.0.0.1:40600;rinstance=82ef1887c837a8cf] for L:4.1[Line:10000<<xx]
    02-Feb-2014 01:56:17.331   [CM503005]: Call(C:4): Forwarding: T:VMail:999@[Dev:sip:999@127.0.0.1:40600;rinstance=82ef1887c837a8cf]
    02-Feb-2014 01:56:17.331   L:4.1[Line:10000<<xx] forwards call from Extn:101 to VMail:999 based on rule Fwd[Available/Busy]
    02-Feb-2014 01:56:17.331   L:4.1[Line:10000<<xx] failed to reach Extn:101, reason Busy
    02-Feb-2014 01:56:17.331   Call(C:4):  from L:4.1[Line:10000<<xx] has failed, because Extn:101 is in DND mode
    02-Feb-2014 01:56:17.331   Extn:101 is in DND mode
     
  2. lneblett

    lneblett Well-Known Member

    Joined:
    Sep 7, 2010
    Messages:
    2,083
    Likes Received:
    61
    Well there are a couple of things to consider:

    The Avaya phone is h.323 by default and should have been converted to run SIP. I assume this has been done.
    The Avaya phone ext 101 shows to have "Do Not Disturb" (DND) on. This needs to be turned off.
    Call(C:4): from L:4.1[Line:10000<<xx] has failed, because Extn:101 is in DND mode
    02-Feb-2014 01:56:17.331 Extn:101 is in DND mode.

    This explains the reason for the inbound call going to VM. When in DND mode, the phone returns a busy here response. The system sees the busy and then implements the forwarding rule in-place for available and not registered or busy.

    The capture is not complete to show all that is needed to diagnose your issue.
    My guess is that you should look at the dialing stage on the HT503 and see if one or two stage dialing; it should be "1".

    You can also look on the blog and in the search box input GXW4101 which is a 4 port FXO device from Gramdstream. While different, Grandstream is fairly consistent in the user interface and settings across models for a given functionality and perhaps this will help on the dialing out issue.
     
  3. crombiecrunch

    Joined:
    Feb 2, 2014
    Messages:
    8
    Likes Received:
    0
    Thanks for the response. I have turned of DND and now the call doesnt go direct to VM but after a couple of minutes it does. Ive also got it for the outgoing call to no longer have that "half" ring and hold music playing when answered. Issue is now my cell phone will ring I can answer there is silence but the Avaya phone is still "playing" the outgoing ring tone and doesnt connect the call.

    I attached both logs

    Code:
    02-Feb-2014 10:45:12.292   [CM503008]: Call(C:27): Call is terminated
    02-Feb-2014 10:45:12.289   Leg L:27.1[Line:10000<<10000] is terminated: Cause: CANCEL from 192.168.0.35:5062
    02-Feb-2014 10:45:11.177   Currently active calls - 1: [27]
    02-Feb-2014 10:45:06.417   [CM503025]: Call(C:27): Calling T:Extn:101@[Dev:sip:101@0.0.0.0:5060;transport=udp;avaya-sc-enabled] for L:27.1[Line:10000<<10000]
    02-Feb-2014 10:45:06.370   [CM503027]: Call(C:27): From: Line:10000<<10000 ("Jonathan Adams" <sip:10000@192.168.0.12:5060>)  to  T:Extn:101@[Dev:sip:101@0.0.0.0:5060;transport=udp;avaya-sc-enabled]
    02-Feb-2014 10:45:06.370   [CM503004]: Call(C:27): Route 1: from L:27.1[Line:10000<<10000] to T:Extn:101@[Dev:sip:101@0.0.0.0:5060;transport=udp;avaya-sc-enabled]
    02-Feb-2014 10:45:06.370   [CM505002]: Gateway:[Line 1] Device info: Device Not Identified: User Agent not matched; Capabilities:[reinvite, replaces, able-no-sdp, recvonly] UserAgent: [Grandstream HT-503  V1.4A 1.0.10.9  chip V2.2] PBX contact: [sip:10000@192.168.0.12:5060]
    02-Feb-2014 10:45:06.369   [CM503001]: Call(C:27): Incoming call from Line:10000<<10000 to <sip:101@192.168.147.1:5060>
    02-Feb-2014 10:45:06.368   Line limit check: Current # of calls for line Lc:10000(@Line 1[<sip:10000@192.168.0.1:5062>]) is 1; limit is 1
    02-Feb-2014 10:45:06.364   [CM503012]: Inbound office hours rule (unnamed) for 10000 forwards to DN:101
    02-Feb-2014 10:37:03.446   Leg L:26.2[Extn] is terminated: Cause: 408 Request Timeout/INVITE from local
    02-Feb-2014 10:37:03.446   [CM503003]: Call(C:26): Call to <sip:101@192.168.0.12:5060> has failed; Cause: 408 Request Timeout/INVITE from local
    02-Feb-2014 10:36:37.274   [CM503008]: Call(C:26): Call is terminated
    02-Feb-2014 10:36:37.274   Leg L:26.1[Line:10000<<10000] is terminated: Cause: CANCEL from 192.168.0.35:5062
    02-Feb-2014 10:36:34.920   Currently active calls - 1: [26]
    02-Feb-2014 10:36:31.323   [CM503025]: Call(C:26): Calling T:Extn:101@[Dev:sip:101@0.0.0.0:5060;transport=udp;avaya-sc-enabled] for L:26.1[Line:10000<<10000]
    02-Feb-2014 10:36:31.275   [CM503027]: Call(C:26): From: Line:10000<<10000 ("Jonathan Adams" <sip:10000@192.168.0.12:5060>)  to  T:Extn:101@[Dev:sip:101@0.0.0.0:5060;transport=udp;avaya-sc-enabled]
    02-Feb-2014 10:36:31.275   [CM503004]: Call(C:26): Route 1: from L:26.1[Line:10000<<10000] to T:Extn:101@[Dev:sip:101@0.0.0.0:5060;transport=udp;avaya-sc-enabled]
    02-Feb-2014 10:36:31.275   [CM505002]: Gateway:[Line 1] Device info: Device Not Identified: User Agent not matched; Capabilities:[reinvite, replaces, able-no-sdp, recvonly] UserAgent: [Grandstream HT-503  V1.4A 1.0.10.9  chip V2.2] PBX contact: [sip:10000@192.168.0.12:5060]
    02-Feb-2014 10:36:31.274   [CM503001]: Call(C:26): Incoming call from Line:10000<<10000 to <sip:101@192.168.147.1:5060>
    02-Feb-2014 10:36:31.273   Line limit check: Current # of calls for line Lc:10000(@Line 1[<sip:10000@192.168.0.1:5062>]) is 1; limit is 1
    02-Feb-2014 10:36:31.269   [CM503012]: Inbound office hours rule (unnamed) for 10000 forwards to DN:101
    02-Feb-2014 10:31:53.654   [MS105000] C:25.2: No RTP packets were received:remoteAddr=192.168.0.1:5012,extAddr=0.0.0.0:0,localAddr=192.168.0.12:7092
    02-Feb-2014 10:31:20.530   Leg L:25.2[Line:10000>>xx] is terminated: Cause: BYE from PBX
    02-Feb-2014 10:31:20.530   [CM503008]: Call(C:25): Call is terminated
    02-Feb-2014 10:31:20.529   Leg L:25.1[Extn] is terminated: Cause: BYE from 192.168.0.8:1025
    02-Feb-2014 10:31:00.755   Currently active calls - 1: [25]
    02-Feb-2014 10:30:59.786   [CM503007]: Call(C:25): Line:10000>>xx has joined, contact <sip:10000@192.168.0.1:5062>
    02-Feb-2014 10:30:59.786   [CM503007]: Call(C:25): Extn:101 has joined, contact <sip:101@0.0.0.0:5060>
    02-Feb-2014 10:30:59.784   L:25.2[Line:10000>>xx] has joined to L:25.1[Extn]
    02-Feb-2014 10:30:59.761   [CM505002]: Gateway:[Line 1] Device info: Device Not Identified: User Agent not matched; Capabilities:[reinvite, replaces, able-no-sdp, recvonly] UserAgent: [Grandstream HT-503  V1.4A 1.0.10.9  chip V2.2] PBX contact: [sip:10000@192.168.0.12:5060]
    02-Feb-2014 10:30:57.145   [CM503025]: Call(C:25): Calling T:Line:10000>>xx@[Dev:sip:10000@192.168.0.1:5062;user=phone] for L:25.1[Extn]
    02-Feb-2014 10:30:57.097   [CM503027]: Call(C:25): From: Extn:101 (<sip:101@192.168.0.12:5060>)  to  T:Line:10000>>xx1@[Dev:sip:10000@192.168.0.1:5062;user=phone]
    02-Feb-2014 10:30:57.097   [CM503004]: Call(C:25): Route 1: from L:25.1[Extn] to T:Line:10000>>xx@[Dev:sip:10000@192.168.0.1:5062;user=phone]
    02-Feb-2014 10:30:57.097   Line limit check: Current # of calls for line Lc:10003(@Line 1[<sip:10003@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:30:57.097   Line limit check: Current # of calls for line Lc:10002(@Line 1[<sip:10002@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:30:57.097   Line limit check: Current # of calls for line Lc:10001(@Line 1[<sip:10001@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:30:57.097   Line limit check: Current # of calls for line Lc:10000(@Line 1[<sip:10000@192.168.0.1:5062>]) is 0; limit is 1
    02-Feb-2014 10:30:57.097   Call(C:25): Call from Extn:101 to xx matches outbound rule 'Rule for Line 1'
    02-Feb-2014 10:30:57.096   [CM503001]: Call(C:25): Incoming call from Extn:101 to <sip:xx@192.168.0.12:5060>
    02-Feb-2014 10:28:31.037   [CM506004]: STUN request to STUN server 173.212.195.222:3478 has timed out; used Transport: 192.168.0.12:5060
    02-Feb-2014 10:28:27.875   [CM506003]: Resolved SIP external IP:port has changed to (98.17.93.82:21761) on Transport 192.168.0.12:5060
    02-Feb-2014 10:28:27.875   [CM506003]: Resolved SIP external IP:port has changed to (98.17.93.82:21793) on Transport 192.168.0.4:5060
    02-Feb-2014 10:28:27.819   [CM506001]: STUN request to resolve SIP external IP:port mapping is sent to STUN server 198.50.247.220:3478 over Transport 192.168.0.4:5060
    02-Feb-2014 10:28:27.819   [CM506001]: STUN request to resolve SIP external IP:port mapping is sent to STUN server 198.50.247.220:3478 over Transport 192.168.0.12:5060
    02-Feb-2014 10:28:05.695   Leg L:24.2[Line:10000>>xx] is terminated: Cause: 487 Request Terminated/INVITE from 192.168.0.35:5062
    02-Feb-2014 10:28:05.582   [CM503008]: Call(C:24): Call is terminated
    02-Feb-2014 10:28:05.581   Leg L:24.1[Extn] is terminated: Cause: CANCEL from 192.168.0.8:1025
    02-Feb-2014 10:27:52.661   Currently active calls - 1: [24]
    02-Feb-2014 10:27:47.970   [CM505002]: Gateway:[Line 1] Device info: Device Not Identified: User Agent not matched; Capabilities:[reinvite, replaces, able-no-sdp, recvonly] UserAgent: [Grandstream HT-503  V1.4A 1.0.10.9  chip V2.2] PBX contact: [sip:10000@192.168.0.12:5060]
    02-Feb-2014 10:27:42.856   [CM503025]: Call(C:24): Calling T:Line:10000>>xx@[Dev:sip:10000@192.168.0.35:5062;user=phone] for L:24.1[Extn]
    02-Feb-2014 10:27:42.811   [CM503027]: Call(C:24): From: Extn:101 (<sip:101@192.168.0.12:5060>)  to  T:Line:10000>>xx@[Dev:sip:10000@192.168.0.35:5062;user=phone]
    02-Feb-2014 10:27:42.811   [CM503004]: Call(C:24): Route 1: from L:24.1[Extn] to T:Line:10000>>xx@[Dev:sip:10000@192.168.0.35:5062;user=phone]
    02-Feb-2014 10:27:42.811   Line limit check: Current # of calls for line Lc:10003(@Line 1[<sip:10003@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:27:42.811   Line limit check: Current # of calls for line Lc:10002(@Line 1[<sip:10002@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:27:42.811   Line limit check: Current # of calls for line Lc:10001(@Line 1[<sip:10001@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:27:42.811   Line limit check: Current # of calls for line Lc:10000(@Line 1[<sip:10000@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:27:42.811   Call(C:24): Call from Extn:101 to xx matches outbound rule 'Rule for Line 1'
    02-Feb-2014 10:27:42.810   [CM503001]: Call(C:24): Incoming call from Extn:101 to <sip:xx@192.168.0.12:5060>
    02-Feb-2014 10:27:33.889   Leg L:23.2[Line:10000>>xx] is terminated: Cause: BYE from PBX
    02-Feb-2014 10:27:33.889   [CM503008]: Call(C:23): Call is terminated
    02-Feb-2014 10:27:33.887   Leg L:23.1[Extn] is terminated: Cause: BYE from 192.168.0.8:1025
    02-Feb-2014 10:27:22.646   Currently active calls - 1: [23]
    02-Feb-2014 10:26:50.630   Currently active calls - 1: [23]
    02-Feb-2014 10:26:28.301   [CM503007]: Call(C:23): Line:10000>>xx has joined, contact <sip:10000@192.168.0.35:5062>
    02-Feb-2014 10:26:28.300   [CM503007]: Call(C:23): Extn:101 has joined, contact <sip:101@0.0.0.0:5060>
    02-Feb-2014 10:26:28.299   L:23.2[Line:10000>>xx has joined to L:23.1[Extn]
    02-Feb-2014 10:26:28.275   [CM505002]: Gateway:[Line 1] Device info: Device Not Identified: User Agent not matched; Capabilities:[reinvite, replaces, able-no-sdp, recvonly] UserAgent: [Grandstream HT-503  V1.4A 1.0.10.9  chip V2.2] PBX contact: [sip:10000@192.168.0.12:5060]
    02-Feb-2014 10:26:25.651   [CM503025]: Call(C:23): Calling T:Line:10000>>xx@[Dev:sip:10000@192.168.0.35:5062;user=phone] for L:23.1[Extn]
    02-Feb-2014 10:26:25.603   [CM503027]: Call(C:23): From: Extn:101 (<sip:101@192.168.0.12:5060>)  to  T:Line:10000>>xx@[Dev:sip:10000@192.168.0.35:5062;user=phone]
    02-Feb-2014 10:26:25.603   [CM503004]: Call(C:23): Route 1: from L:23.1[Extn] to T:Line:10000>>xx@[Dev:sip:10000@192.168.0.35:5062;user=phone]
    02-Feb-2014 10:26:25.603   Line limit check: Current # of calls for line Lc:10003(@Line 1[<sip:10003@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:26:25.603   Line limit check: Current # of calls for line Lc:10002(@Line 1[<sip:10002@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:26:25.603   Line limit check: Current # of calls for line Lc:10001(@Line 1[<sip:10001@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:26:25.603   Line limit check: Current # of calls for line Lc:10000(@Line 1[<sip:10000@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:26:25.603   Call(C:23): Call from Extn:101 to xx matches outbound rule 'Rule for Line 1'
    02-Feb-2014 10:26:25.602   [CM503001]: Call(C:23): Incoming call from Extn:101 to <sip:xx1@192.168.0.12:5060>
    02-Feb-2014 10:25:57.242   Leg L:22.2[Line:10000>>xx] is terminated: Cause: 487 Request Terminated/INVITE from 192.168.0.35:5062
    02-Feb-2014 10:25:57.131   [CM503008]: Call(C:22): Call is terminated
    02-Feb-2014 10:25:57.129   Leg L:22.1[Extn] is terminated: Cause: CANCEL from 192.168.0.8:1025
    02-Feb-2014 10:25:48.599   Currently active calls - 1: [22]
    02-Feb-2014 10:25:16.583   Currently active calls - 1: [22]
    02-Feb-2014 10:25:10.877   [CM505002]: Gateway:[Line 1] Device info: Device Not Identified: User Agent not matched; Capabilities:[reinvite, replaces, able-no-sdp, recvonly] UserAgent: [Grandstream HT-503  V1.4A 1.0.10.9  chip V2.2] PBX contact: [sip:10000@192.168.0.12:5060]
    02-Feb-2014 10:25:08.260   [CM503025]: Call(C:22): Calling T:Line:10000>>xx@[Dev:sip:10000@192.168.0.35:5062] for L:22.1[Extn]
    02-Feb-2014 10:25:08.212   [CM503027]: Call(C:22): From: Extn:101 (<sip:101@192.168.0.12:5060>)  to  T:Line:10000>>xx@[Dev:sip:10000@192.168.0.35:5062]
    02-Feb-2014 10:25:08.212   [CM503004]: Call(C:22): Route 1: from L:22.1[Extn] to T:Line:10000>>xx@[Dev:sip:10000@192.168.0.35:5062]
    02-Feb-2014 10:25:08.212   Line limit check: Current # of calls for line Lc:10003(@Line 1[<sip:10003@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:25:08.212   Line limit check: Current # of calls for line Lc:10002(@Line 1[<sip:10002@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:25:08.212   Line limit check: Current # of calls for line Lc:10001(@Line 1[<sip:10001@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:25:08.212   Line limit check: Current # of calls for line Lc:10000(@Line 1[<sip:10000@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:25:08.212   Call(C:22): Call from Extn:101 to xx matches outbound rule 'Rule for Line 1'
    02-Feb-2014 10:25:08.211   [CM503001]: Call(C:22): Incoming call from Extn:101 to <sip:xx@192.168.0.12:5060>
    02-Feb-2014 10:24:21.386   Leg L:21.2[Line:10000>>xx] is terminated: Cause: BYE from PBX
    02-Feb-2014 10:24:21.386   [CM503008]: Call(C:21): Call is terminated
    02-Feb-2014 10:24:21.384   Leg L:21.1[Extn] is terminated: Cause: BYE from 192.168.0.8:1025
    02-Feb-2014 10:24:14.552   Currently active calls - 1: [21]
    02-Feb-2014 10:24:11.975   [CM503007]: Call(C:21): Line:10000>>xx has joined, contact <sip:10000@192.168.0.35:5062>
    02-Feb-2014 10:24:11.974   [CM503007]: Call(C:21): Extn:101 has joined, contact <sip:101@0.0.0.0:5060>
    02-Feb-2014 10:24:11.973   L:21.2[Line:10000>>xx] has joined to L:21.1[Extn]
    02-Feb-2014 10:24:11.950   [CM505002]: Gateway:[Line 1] Device info: Device Not Identified: User Agent not matched; Capabilities:[reinvite, replaces, able-no-sdp, recvonly] UserAgent: [Grandstream HT-503  V1.4A 1.0.10.9  chip V2.2] PBX contact: [sip:10000@192.168.0.12:5060]
    02-Feb-2014 10:24:09.334   [CM503025]: Call(C:21): Calling T:Line:10000>>xx@[Dev:sip:10000@192.168.0.35:5062] for L:21.1[Extn]
    02-Feb-2014 10:24:09.288   [CM503027]: Call(C:21): From: Extn:101 (<sip:101@192.168.0.12:5060>)  to  T:Line:10000>>xx@[Dev:sip:10000@192.168.0.35:5062]
    02-Feb-2014 10:24:09.288   [CM503004]: Call(C:21): Route 1: from L:21.1[Extn] to T:Line:10000>>xx@[Dev:sip:10000@192.168.0.35:5062]
    02-Feb-2014 10:24:09.288   Line limit check: Current # of calls for line Lc:10003(@Line 1[<sip:10003@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:24:09.288   Line limit check: Current # of calls for line Lc:10002(@Line 1[<sip:10002@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:24:09.288   Line limit check: Current # of calls for line Lc:10001(@Line 1[<sip:10001@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:24:09.288   Line limit check: Current # of calls for line Lc:10000(@Line 1[<sip:10000@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:24:09.288   Call(C:21): Call from Extn:101 to xx matches outbound rule 'Rule for Line 1'
    02-Feb-2014 10:24:09.287   [CM503001]: Call(C:21): Incoming call from Extn:101 to <sip:xx@192.168.0.12:5060>
    02-Feb-2014 10:23:31.882   Leg L:20.2[Line:10000>>xx] is terminated: Cause: BYE from PBX
    02-Feb-2014 10:23:31.882   [CM503008]: Call(C:20): Call is terminated
    02-Feb-2014 10:23:31.879   Leg L:20.1[Extn] is terminated: Cause: BYE from 192.168.0.8:1025
    02-Feb-2014 10:23:19.287   [CM503007]: Call(C:20): Line:10000>>xx has joined, contact <sip:10000@192.168.0.35:5062>
    02-Feb-2014 10:23:19.286   [CM503007]: Call(C:20): Extn:101 has joined, contact <sip:101@0.0.0.0:5060>
    02-Feb-2014 10:23:19.285   L:20.2[Line:10000>>xx] has joined to L:20.1[Extn]
    02-Feb-2014 10:23:19.262   [CM505002]: Gateway:[Line 1] Device info: Device Not Identified: User Agent not matched; Capabilities:[reinvite, replaces, able-no-sdp, recvonly] UserAgent: [Grandstream HT-503  V1.4A 1.0.10.9  chip V2.2] PBX contact: [sip:10000@192.168.0.12:5060]
    02-Feb-2014 10:23:16.637   [CM503025]: Call(C:20): Calling T:Line:10000>>xx@[Dev:sip:10000@192.168.0.35:5062] for L:20.1[Extn]
    02-Feb-2014 10:23:16.590   [CM503027]: Call(C:20): From: Extn:101 (<sip:101@192.168.0.12:5060>)  to  T:Line:10000>>xx@[Dev:sip:10000@192.168.0.35:5062]
    02-Feb-2014 10:23:16.590   [CM503004]: Call(C:20): Route 1: from L:20.1[Extn] to T:Line:10000>>xx@[Dev:sip:10000@192.168.0.35:5062]
    02-Feb-2014 10:23:16.590   Line limit check: Current # of calls for line Lc:10003(@Line 1[<sip:10003@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:23:16.590   Line limit check: Current # of calls for line Lc:10002(@Line 1[<sip:10002@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:23:16.590   Line limit check: Current # of calls for line Lc:10001(@Line 1[<sip:10001@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:23:16.590   Line limit check: Current # of calls for line Lc:10000(@Line 1[<sip:10000@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:23:16.590   Call(C:20): Call from Extn:101 to xx matches outbound rule 'Rule for Line 1'
    02-Feb-2014 10:23:16.589   [CM503001]: Call(C:20): Incoming call from Extn:101 to <sip:xx@192.168.0.12:5060>
    02-Feb-2014 10:22:49.334   Leg L:19.1[Extn] is terminated: Cause: BYE from PBX
    02-Feb-2014 10:22:49.289   [CM503020]: Call(C:19): Normal call termination. Call originator: Extn:101. Reason: Not found
    02-Feb-2014 10:22:49.289   [CM503014]: Call(C:19): No known route from Extn:101 to target: <sip:9@192.168.0.12:5060>
    02-Feb-2014 10:22:49.289   Call(C:19): from Extn:101 to 9 doesn't match any outbound rule. No outbound rule could be selected.
    02-Feb-2014 10:22:49.289   [Flow] Target endpoint for 9 can not be built!
    02-Feb-2014 10:22:49.288   [CM503001]: Call(C:19): Incoming call from Extn:101 to <sip:9@192.168.0.12:5060>
    02-Feb-2014 10:22:41.900   [CM503008]: Call(C:18): Call is terminated
    02-Feb-2014 10:22:41.897   Leg L:18.1[Extn] is terminated: Cause: CANCEL from 192.168.0.8:1025
    02-Feb-2014 10:22:40.505   Currently active calls - 1: [18]
    02-Feb-2014 10:22:25.445   [CM503025]: Call(C:18): Calling T:Line:10000>>xx@[Dev:sip:10000@192.168.0.35:5062] for L:18.1[Extn]
    02-Feb-2014 10:22:25.399   [CM503027]: Call(C:18): From: Extn:101 (<sip:101@192.168.0.12:5060>)  to  T:Line:10000>>xx@[Dev:sip:10000@192.168.0.35:5062]
    02-Feb-2014 10:22:25.399   [CM503004]: Call(C:18): Route 1: from L:18.1[Extn] to T:Line:10000>>xx@[Dev:sip:10000@192.168.0.35:5062]
    02-Feb-2014 10:22:25.399   Line limit check: Current # of calls for line Lc:10003(@Line 1[<sip:10003@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:22:25.399   Line limit check: Current # of calls for line Lc:10002(@Line 1[<sip:10002@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:22:25.399   Line limit check: Current # of calls for line Lc:10001(@Line 1[<sip:10001@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:22:25.399   Line limit check: Current # of calls for line Lc:10000(@Line 1[<sip:10000@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:22:25.399   Call(C:18): Call from Extn:101 to xx matches outbound rule 'Rule for Line 1'
    02-Feb-2014 10:22:25.397   [CM503001]: Call(C:18): Incoming call from Extn:101 to <sip:xx@192.168.0.12:5060>
    02-Feb-2014 10:22:01.978   Leg L:17.2[Line:10000>>xx] is terminated: Cause: 487 Request Terminated/INVITE from 192.168.0.35:5062
    02-Feb-2014 10:22:01.869   [CM503008]: Call(C:17): Call is terminated
    02-Feb-2014 10:22:01.866   Leg L:17.1[Extn] is terminated: Cause: CANCEL from 192.168.0.8:1025
    02-Feb-2014 10:21:44.656   [CM505002]: Gateway:[Line 1] Device info: Device Not Identified: User Agent not matched; Capabilities:[reinvite, replaces, able-no-sdp, recvonly] UserAgent: [Grandstream HT-503  V1.4A 1.0.10.9  chip V2.2] PBX contact: [sip:10000@192.168.0.12:5060]
    02-Feb-2014 10:21:41.276   [CM503025]: Call(C:17): Calling T:Line:10000>>xx@[Dev:sip:10000@192.168.0.35:5062] for L:17.1[Extn]
    02-Feb-2014 10:21:41.229   [CM503027]: Call(C:17): From: Extn:101 (<sip:101@192.168.0.12:5060>)  to  T:Line:10000>>xx@[Dev:sip:10000@192.168.0.35:5062]
    02-Feb-2014 10:21:41.229   [CM503004]: Call(C:17): Route 1: from L:17.1[Extn] to T:Line:10000>>xx@[Dev:sip:10000@192.168.0.35:5062]
    02-Feb-2014 10:21:41.229   Line limit check: Current # of calls for line Lc:10003(@Line 1[<sip:10003@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:21:41.229   Line limit check: Current # of calls for line Lc:10002(@Line 1[<sip:10002@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:21:41.229   Line limit check: Current # of calls for line Lc:10001(@Line 1[<sip:10001@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:21:41.229   Line limit check: Current # of calls for line Lc:10000(@Line 1[<sip:10000@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:21:41.229   Call(C:17): Call from Extn:101 to xx matches outbound rule 'Rule for Line 1'
    02-Feb-2014 10:21:41.228   [CM503001]: Call(C:17): Incoming call from Extn:101 to <sip:xx@192.168.0.12:5060>
    02-Feb-2014 10:21:20.988   Leg L:16.2[Line:10000>>xx] is terminated: Cause: 487 Request Terminated/INVITE from 192.168.0.35:5062
    02-Feb-2014 10:21:20.877   [CM503008]: Call(C:16): Call is terminated
    02-Feb-2014 10:21:20.875   Leg L:16.1[Extn] is terminated: Cause: CANCEL from 192.168.0.8:1025
    02-Feb-2014 10:21:06.458   Currently active calls - 1: [16]
    02-Feb-2014 10:20:50.489   [CM505002]: Gateway:[Line 1] Device info: Device Not Identified: User Agent not matched; Capabilities:[reinvite, replaces, able-no-sdp, recvonly] UserAgent: [Grandstream HT-503  V1.4A 1.0.10.9  chip V2.2] PBX contact: [sip:10000@192.168.0.12:5060]
    02-Feb-2014 10:20:47.870   [CM503025]: Call(C:16): Calling T:Line:10000>>xx@[Dev:sip:10000@192.168.0.35:5062] for L:16.1[Extn]
    02-Feb-2014 10:20:47.824   [CM503027]: Call(C:16): From: Extn:101 (<sip:101@192.168.0.12:5060>)  to  T:Line:10000>>xx@[Dev:sip:10000@192.168.0.35:5062]
    02-Feb-2014 10:20:47.824   [CM503004]: Call(C:16): Route 1: from L:16.1[Extn] to T:Line:10000>>xx@[Dev:sip:10000@192.168.0.35:5062]
    02-Feb-2014 10:20:47.824   Line limit check: Current # of calls for line Lc:10003(@Line 1[<sip:10003@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:20:47.824   Line limit check: Current # of calls for line Lc:10002(@Line 1[<sip:10002@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:20:47.824   Line limit check: Current # of calls for line Lc:10001(@Line 1[<sip:10001@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:20:47.824   Line limit check: Current # of calls for line Lc:10000(@Line 1[<sip:10000@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:20:47.824   Call(C:16): Call from Extn:101 to xx matches outbound rule 'Rule for Line 1'
    02-Feb-2014 10:20:47.822   [CM503001]: Call(C:16): Incoming call from Extn:101 to <sip:xx@192.168.0.12:5060>
    02-Feb-2014 10:20:04.425   Leg L:15.2[Line:10000>>xx] is terminated: Cause: BYE from PBX
    02-Feb-2014 10:20:04.424   [CM503008]: Call(C:15): Call is terminated
    02-Feb-2014 10:20:04.421   Leg L:15.1[Extn] is terminated: Cause: BYE from 192.168.0.8:1025
    02-Feb-2014 10:20:02.426   Currently active calls - 1: [15]
    02-Feb-2014 10:19:51.059   [CM503007]: Call(C:15): Line:10000>>xx has joined, contact <sip:10000@192.168.0.35:5062>
    02-Feb-2014 10:19:51.059   [CM503007]: Call(C:15): Extn:101 has joined, contact <sip:101@0.0.0.0:5060>
    02-Feb-2014 10:19:51.057   L:15.2[Line:10000>>xx] has joined to L:15.1[Extn]
    02-Feb-2014 10:19:51.034   [CM505002]: Gateway:[Line 1] Device info: Device Not Identified: User Agent not matched; Capabilities:[reinvite, replaces, able-no-sdp, recvonly] UserAgent: [Grandstream HT-503  V1.4A 1.0.10.9  chip V2.2] PBX contact: [sip:10000@192.168.0.12:5060]
    02-Feb-2014 10:19:47.748   [CM503025]: Call(C:15): Calling T:Line:10000>>xx@[Dev:sip:10000@192.168.0.35:5062] for L:15.1[Extn]
    02-Feb-2014 10:19:47.727   [CM503027]: Call(C:15): From: Extn:101 (<sip:101@192.168.0.12:5060>)  to  T:Line:10000>>xx@[Dev:sip:10000@192.168.0.35:5062]
    02-Feb-2014 10:19:47.727   [CM503004]: Call(C:15): Route 1: from L:15.1[Extn] to T:Line:10000>>xx@[Dev:sip:10000@192.168.0.35:5062]
    02-Feb-2014 10:19:47.727   Line limit check: Current # of calls for line Lc:10003(@Line 1[<sip:10003@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:19:47.726   Line limit check: Current # of calls for line Lc:10002(@Line 1[<sip:10002@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:19:47.726   Line limit check: Current # of calls for line Lc:10001(@Line 1[<sip:10001@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:19:47.726   Line limit check: Current # of calls for line Lc:10000(@Line 1[<sip:10000@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:19:47.726   Call(C:15): Call from Extn:101 to xx matches outbound rule 'Rule for Line 1'
    02-Feb-2014 10:19:47.725   [CM503001]: Call(C:15): Incoming call from Extn:101 to <sip:xx@192.168.0.12:5060>
    02-Feb-2014 10:19:11.848   Leg L:14.2[Line:10000>>xx] is terminated: Cause: BYE from PBX
    02-Feb-2014 10:19:11.848   [CM503008]: Call(C:14): Call is terminated
    02-Feb-2014 10:19:11.845   Leg L:14.1[Extn] is terminated: Cause: BYE from 192.168.0.8:1025
    02-Feb-2014 10:19:00.395   Currently active calls - 1: [14]
    02-Feb-2014 10:18:58.468   [CM503007]: Call(C:14): Line:10000>>xx has joined, contact <sip:10000@192.168.0.35:5062>
    02-Feb-2014 10:18:58.468   [CM503007]: Call(C:14): Extn:101 has joined, contact <sip:101@0.0.0.0:5060>
    02-Feb-2014 10:18:58.466   L:14.2[Line:10000>>xx] has joined to L:14.1[Extn]
    02-Feb-2014 10:18:58.443   [CM505002]: Gateway:[Line 1] Device info: Device Not Identified: User Agent not matched; Capabilities:[reinvite, replaces, able-no-sdp, recvonly] UserAgent: [Grandstream HT-503  V1.4A 1.0.10.9  chip V2.2] PBX contact: [sip:10000@192.168.0.12:5060]
    02-Feb-2014 10:18:55.148   [CM503025]: Call(C:14): Calling T:Line:10000>>xx@[Dev:sip:10000@192.168.0.35:5062] for L:14.1[Extn]
    02-Feb-2014 10:18:55.100   [CM503027]: Call(C:14): From: Extn:101 (<sip:101@192.168.0.12:5060>)  to  T:Line:10000>>xx@[Dev:sip:10000@192.168.0.35:5062]
    02-Feb-2014 10:18:55.100   [CM503004]: Call(C:14): Route 1: from L:14.1[Extn] to T:Line:10000>>xx@[Dev:sip:10000@192.168.0.35:5062]
    02-Feb-2014 10:18:55.100   Line limit check: Current # of calls for line Lc:10003(@Line 1[<sip:10003@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:18:55.100   Line limit check: Current # of calls for line Lc:10002(@Line 1[<sip:10002@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:18:55.100   Line limit check: Current # of calls for line Lc:10001(@Line 1[<sip:10001@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:18:55.100   Line limit check: Current # of calls for line Lc:10000(@Line 1[<sip:10000@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:18:55.100   Call(C:14): Call from Extn:101 to xx matches outbound rule 'Rule for Line 1'
    02-Feb-2014 10:18:55.099   [CM503001]: Call(C:14): Incoming call from Extn:101 to <sip:xx@192.168.0.12:5060>
    02-Feb-2014 10:17:38.754   Leg L:13.2[Line:10000>>xx] is terminated: Cause: 487 Request Terminated/INVITE from 192.168.0.35:5062
    02-Feb-2014 10:17:38.643   [CM503008]: Call(C:13): Call is terminated
    02-Feb-2014 10:17:38.642   Leg L:13.1[Extn] is terminated: Cause: CANCEL from 192.168.0.8:1025
    02-Feb-2014 10:17:26.348   Currently active calls - 1: [13]
    02-Feb-2014 10:17:05.773   [CM505002]: Gateway:[Line 1] Device info: Device Not Identified: User Agent not matched; Capabilities:[reinvite, replaces, able-no-sdp, recvonly] UserAgent: [Grandstream HT-503  V1.4A 1.0.10.9  chip V2.2] PBX contact: [sip:10000@192.168.0.12:5060]
    02-Feb-2014 10:17:02.335   [CM503025]: Call(C:13): Calling T:Line:10000>>xx@[Dev:sip:10000@192.168.0.35:5062] for L:13.1[Extn]
    02-Feb-2014 10:17:02.290   [CM503027]: Call(C:13): From: Extn:101 (<sip:101@192.168.0.12:5060>)  to  T:Line:10000>>xx@[Dev:sip:10000@192.168.0.35:5062]
    02-Feb-2014 10:17:02.290   [CM503004]: Call(C:13): Route 1: from L:13.1[Extn] to T:Line:10000>>xx@[Dev:sip:10000@192.168.0.35:5062]
    02-Feb-2014 10:17:02.290   Line limit check: Current # of calls for line Lc:10003(@Line 1[<sip:10003@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:17:02.290   Line limit check: Current # of calls for line Lc:10002(@Line 1[<sip:10002@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:17:02.290   Line limit check: Current # of calls for line Lc:10001(@Line 1[<sip:10001@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:17:02.290   Line limit check: Current # of calls for line Lc:10000(@Line 1[<sip:10000@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:17:02.290   Call(C:13): Call from Extn:101 to xx matches outbound rule 'Rule for Line 1'
    02-Feb-2014 10:17:02.289   [CM503001]: Call(C:13): Incoming call from Extn:101 to <sip:xx@192.168.0.12:5060>
    02-Feb-2014 10:16:22.374   Leg L:12.2[Line:10000>>xx] is terminated: Cause: BYE from PBX
    02-Feb-2014 10:16:22.374   [CM503008]: Call(C:12): Call is terminated
    02-Feb-2014 10:16:22.373   Leg L:12.1[Extn] is terminated: Cause: BYE from 192.168.0.8:1025
    02-Feb-2014 10:15:58.781   [CM503007]: Call(C:12): Line:10000>>xx has joined, contact <sip:10000@192.168.0.35:5062>
    02-Feb-2014 10:15:58.781   [CM503007]: Call(C:12): Extn:101 has joined, contact <sip:101@0.0.0.0:5060>
    02-Feb-2014 10:15:58.777   L:12.2[Line:10000>>xx] has joined to L:12.1[Extn]
    02-Feb-2014 10:15:58.753   [CM505002]: Gateway:[Line 1] Device info: Device Not Identified: User Agent not matched; Capabilities:[reinvite, replaces, able-no-sdp, recvonly] UserAgent: [Grandstream HT-503  V1.4A 1.0.10.9  chip V2.2] PBX contact: [sip:10000@192.168.0.12:5060]
    02-Feb-2014 10:15:56.585   [CM503025]: Call(C:12): Calling T:Line:10000>>xx@[Dev:sip:10000@192.168.0.35:5062;user=phone] for L:12.1[Extn]
    02-Feb-2014 10:15:56.537   [CM503027]: Call(C:12): From: Extn:101 (<sip:101@192.168.0.12:5060>)  to  T:Line:10000>>xx@[Dev:sip:10000@192.168.0.35:5062;user=phone]
    02-Feb-2014 10:15:56.537   [CM503004]: Call(C:12): Route 1: from L:12.1[Extn] to T:Line:10000>>xx@[Dev:sip:10000@192.168.0.35:5062;user=phone]
    02-Feb-2014 10:15:56.537   Line limit check: Current # of calls for line Lc:10003(@Line 1[<sip:10003@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:15:56.537   Line limit check: Current # of calls for line Lc:10002(@Line 1[<sip:10002@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:15:56.537   Line limit check: Current # of calls for line Lc:10001(@Line 1[<sip:10001@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:15:56.537   Line limit check: Current # of calls for line Lc:10000(@Line 1[<sip:10000@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:15:56.537   Call(C:12): Call from Extn:101 to xx matches outbound rule 'Rule for Line 1'
    02-Feb-2014 10:15:56.536   [CM503001]: Call(C:12): Incoming call from Extn:101 to <sip:xx@192.168.0.12:5060>
    02-Feb-2014 10:12:07.678   Leg L:11.2[Line:10000>>xx] is terminated: Cause: BYE from PBX
    02-Feb-2014 10:12:07.678   [CM503008]: Call(C:11): Call is terminated
    02-Feb-2014 10:12:07.675   Leg L:11.1[Extn] is terminated: Cause: BYE from 192.168.0.8:1025
    02-Feb-2014 10:11:42.176   Currently active calls - 1: [11]
    02-Feb-2014 10:11:27.336   [CM503007]: Call(C:11): Line:10000>>xx has joined, contact <sip:10000@192.168.0.35:5062>
    02-Feb-2014 10:11:27.335   [CM503007]: Call(C:11): Extn:101 has joined, contact <sip:101@0.0.0.0:5060>
    02-Feb-2014 10:11:27.334   L:11.2[Line:10000>>xx] has joined to L:11.1[Extn]
    02-Feb-2014 10:11:27.307   [CM505002]: Gateway:[Line 1] Device info: Device Not Identified: User Agent not matched; Capabilities:[reinvite, replaces, able-no-sdp, recvonly] UserAgent: [Grandstream HT-503  V1.4A 1.0.10.9  chip V2.2] PBX contact: [sip:10000@192.168.0.12:5060]
    02-Feb-2014 10:11:24.980   [CM503025]: Call(C:11): Calling T:Line:10000>>xx@[Dev:sip:10000@192.168.0.35:5062;user=phone] for L:11.1[Extn]
    02-Feb-2014 10:11:24.950   [CM503027]: Call(C:11): From: Extn:101 (<sip:101@192.168.0.12:5060>)  to  T:Line:10000>>xx@[Dev:sip:10000@192.168.0.35:5062;user=phone]
    02-Feb-2014 10:11:24.950   [CM503004]: Call(C:11): Route 1: from L:11.1[Extn] to T:Line:10000>>xx@[Dev:sip:10000@192.168.0.35:5062;user=phone]
    02-Feb-2014 10:11:24.950   Line limit check: Current # of calls for line Lc:10003(@Line 1[<sip:10003@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:11:24.950   Line limit check: Current # of calls for line Lc:10002(@Line 1[<sip:10002@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:11:24.950   Line limit check: Current # of calls for line Lc:10001(@Line 1[<sip:10001@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:11:24.950   Line limit check: Current # of calls for line Lc:10000(@Line 1[<sip:10000@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:11:24.950   Call(C:11): Call from Extn:101 to xx matches outbound rule 'Rule for Line 1'
    02-Feb-2014 10:11:24.949   [CM503001]: Call(C:11): Incoming call from Extn:101 to <sip:xx@192.168.0.12:5060>
    02-Feb-2014 10:08:27.736   [CM506003]: Resolved SIP external IP:port has changed to (98.17.93.82:21473) on Transport 192.168.0.12:5060
    02-Feb-2014 10:08:27.735   [CM506003]: Resolved SIP external IP:port has changed to (98.17.93.82:21505) on Transport 192.168.0.4:5060
    02-Feb-2014 10:08:27.681   [CM506001]: STUN request to resolve SIP external IP:port mapping is sent to STUN server 198.50.247.220:3478 over Transport 192.168.0.4:5060
    02-Feb-2014 10:08:27.681   [CM506001]: STUN request to resolve SIP external IP:port mapping is sent to STUN server 198.50.247.220:3478 over Transport 192.168.0.12:5060
    02-Feb-2014 10:05:38.967   Leg L:10.2[Line:10000>>x] is terminated: Cause: BYE from PBX
    02-Feb-2014 10:05:38.967   [CM503008]: Call(C:10): Call is terminated
    02-Feb-2014 10:05:38.964   Leg L:10.1[Extn] is terminated: Cause: BYE from 192.168.0.8:1025
    02-Feb-2014 10:05:28.298   [CM503007]: Call(C:10): Line:10000>>xx has joined, contact <sip:10000@192.168.0.35:5062>
    02-Feb-2014 10:05:28.297   [CM503007]: Call(C:10): Extn:101 has joined, contact <sip:101@0.0.0.0:5060>
    02-Feb-2014 10:05:28.296   L:10.2[Line:10000>>xx] has joined to L:10.1[Extn]
    02-Feb-2014 10:05:28.272   [CM505002]: Gateway:[Line 1] Device info: Device Not Identified: User Agent not matched; Capabilities:[reinvite, replaces, able-no-sdp, recvonly] UserAgent: [Grandstream HT-503  V1.4A 1.0.10.9  chip V2.2] PBX contact: [sip:10000@192.168.0.12:5060]
    02-Feb-2014 10:05:25.989   Currently active calls - 1: [10]
    02-Feb-2014 10:05:25.008   [CM503025]: Call(C:10): Calling T:Line:10000>>xx@[Dev:sip:10000@192.168.0.35:5062] for L:10.1[Extn]
    02-Feb-2014 10:05:24.960   [CM503027]: Call(C:10): From: Extn:101 (<sip:101@192.168.0.12:5060>)  to  T:Line:10000>>xx@[Dev:sip:10000@192.168.0.35:5062]
    02-Feb-2014 10:05:24.960   [CM503004]: Call(C:10): Route 1: from L:10.1[Extn] to T:Line:10000>>xx@[Dev:sip:10000@192.168.0.35:5062]
    02-Feb-2014 10:05:24.960   Line limit check: Current # of calls for line Lc:10003(@Line 1[<sip:10003@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:05:24.960   Line limit check: Current # of calls for line Lc:10002(@Line 1[<sip:10002@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:05:24.960   Line limit check: Current # of calls for line Lc:10001(@Line 1[<sip:10001@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:05:24.960   Line limit check: Current # of calls for line Lc:10000(@Line 1[<sip:10000@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:05:24.960   Call(C:10): Call from Extn:101 to xx matches outbound rule 'Rule for Line 1'
    02-Feb-2014 10:05:24.959   [CM503001]: Call(C:10): Incoming call from Extn:101 to <sip:xx@192.168.0.12:5060>
    02-Feb-2014 10:03:55.696   Leg L:6.3[VMail] is terminated: Cause: BYE from PBX
    02-Feb-2014 10:03:55.696   [CM503008]: Call(C:6): Call is terminated
    02-Feb-2014 10:03:55.694   Leg L:6.1[Line:10000<<xx] is terminated: Cause: BYE from 192.168.0.35:5062
    02-Feb-2014 10:03:51.942   Currently active calls - 1: [6]
    02-Feb-2014 10:03:21.927   Currently active calls - 1: [6]
    02-Feb-2014 10:02:57.769   Leg L:9.1[Extn] is terminated: Cause: BYE from PBX
    02-Feb-2014 10:02:57.725   [CM503020]: Call(C:9): Normal call termination. Call originator: Extn:101. Reason: Not available
    02-Feb-2014 10:02:57.725   L:9.1[Extn] failed to reach Out#:>>Rule{Rule for Line 1}>>1xx, reason Temporarily Unavailable
    02-Feb-2014 10:02:57.724   [CM503026]: Call(C:9): Route 1 to PSTNlineLine 1 is not active (Busy/Not registered)
    02-Feb-2014 10:02:57.724   Call(C:9): from L:9.1[Extn]: There are no available outbound lines on Trunk 'PSTNlineLine 1' at this time. First line: 10000
    02-Feb-2014 10:02:57.724   [CM303003]: There are no available outbound lines on gateway Line 1 at this time. First line: Lc:10000(@Line 1[<sip:10000@192.168.0.35:5062>])
    02-Feb-2014 10:02:57.724   Line limit check: Current # of calls for line Lc:10003(@Line 1[<sip:10003@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:02:57.724   Line limit check: Current # of calls for line Lc:10002(@Line 1[<sip:10002@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:02:57.724   Line limit check: Current # of calls for line Lc:10001(@Line 1[<sip:10001@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:02:57.724   Line limit check: Current # of calls for line Lc:10000(@Line 1[<sip:10000@192.168.0.35:5062>]) is 1; limit is 1
    02-Feb-2014 10:02:57.724   Call(C:9): Call from Extn:101 to 1xx9993971 matches outbound rule 'Rule for Line 1'
    02-Feb-2014 10:02:57.723   [CM503001]: Call(C:9): Incoming call from Extn:101 to <sip:xx@192.168.0.12:5060>
    02-Feb-2014 10:02:49.911   Currently active calls - 1: [6]
    02-Feb-2014 10:02:38.496   Leg L:8.1[Extn] is terminated: Cause: BYE from PBX
    02-Feb-2014 10:02:38.451   [CM503020]: Call(C:8): Normal call termination. Call originator: Extn:101. Reason: Not found
    02-Feb-2014 10:02:38.451   [CM503014]: Call(C:8): No known route from Extn:101 to target: <sip:xx@192.168.0.12:5060>
    02-Feb-2014 10:02:38.451   Call(C:8): from Extn:101 to xx doesn't match any outbound rule. No outbound rule could be selected.
    02-Feb-2014 10:02:38.451   [Flow] Target endpoint for xx can not be built!
    02-Feb-2014 10:02:38.450   [CM503001]: Call(C:8): Incoming call from Extn:101 to <sip:xx@192.168.0.12:5060>
    02-Feb-2014 10:02:26.851   Leg L:7.1[Extn] is terminated: Cause: BYE from PBX
    02-Feb-2014 10:02:26.807   [CM503020]: Call(C:7): Normal call termination. Call originator: Extn:101. Reason: Not available
    02-Feb-2014 10:02:26.807   L:7.1[Extn] failed to reach Out#:>>Rule{Rule for Line 1}>>xx, reason Temporarily Unavailable
    02-Feb-2014 10:02:26.807   [CM503026]: Call(C:7): Route 1 to PSTNlineLine 1 is not active (Busy/Not registered)
    02-Feb-2014 10:02:26.807   Call(C:7): from L:7.1[Extn]: There are no available outbound lines on Trunk 'PSTNlineLine 1' at this time. First line: 10000
    02-Feb-2014 10:02:26.806   [CM303003]: There are no available outbound lines on gateway Line 1 at this time. First line: Lc:10000(@Line 1[<sip:10000@192.168.0.35:5062>])
    02-Feb-2014 10:02:26.806   Line limit check: Current # of calls for line Lc:10003(@Line 1[<sip:10003@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:02:26.806   Line limit check: Current # of calls for line Lc:10002(@Line 1[<sip:10002@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:02:26.806   Line limit check: Current # of calls for line Lc:10001(@Line 1[<sip:10001@192.168.0.35:5062>]) is 0; limit is 1
    02-Feb-2014 10:02:26.806   Line limit check: Current # of calls for line Lc:10000(@Line 1[<sip:10000@192.168.0.35:5062>]) is 1; limit is 1
    02-Feb-2014 10:02:26.806   Call(C:7): Call from Extn:101 to xx1 matches outbound rule 'Rule for Line 1'
    02-Feb-2014 10:02:26.805   [CM503001]: Call(C:7): Incoming call from Extn:101 to <sip:xx@192.168.0.12:5060>
     
  4. lneblett

    lneblett Well-Known Member

    Joined:
    Sep 7, 2010
    Messages:
    2,083
    Likes Received:
    61
    Sorry, but I am confused.

    It is not clear to me how the cell phone comes into play given what I think is the configuration.

    You indicated an HT503 which I see is virtual port 10000 and is an FXO device (FXS side of the device, presumed to not be in use), what are virtual ports 10001 thru 10005? Are these analog FXO ports or SIP Trunks? I only see where port 10000 is ever active and only ext 101 is ever used in the scenario.

    I also see where STUN determined that the IP changed and that on one call, the RTP stream did not make it through (presumably) the firewall.

    Please describe, in detail, your configuration and then the steps to make the call inbound that results in the call going to VM after a couple of minutes.

    Then how you are trying to make the call where the cell phone comes into play?
     
  5. crombiecrunch

    Joined:
    Feb 2, 2014
    Messages:
    8
    Likes Received:
    0
    Sorry! My setup is as follows:

    Windows 8 PC running 3CX
    2 HT503 gateways, I have 2 DSL lines coming in to my house each with its own phone number.
    Both DSL modems feed my TP-LINK TL-R470T+ 5-port Load Balance Broadband Router
    From that router I have a line connected to a TP-LINK TL-SF1008P 10/100Mbps 8-Port PoE Switch which feeds to 2 Avaya 9611G phones.

    When I run the firewall checker in 3CX I am green on all ports there are no blocks.

    The cell phone comes in to play only as my "test" phone to see if the PBX system is working. So making incoming/outgoing calls to it.

    When setting up the gateway there was no option for the HT503 in 3CX so I used the GXW-4104 which created the other virtual extensions.

    The FXS side is not being used ATM and I am only trying to configure one HT503 and one 9611G to work at a time.
     
  6. lneblett

    lneblett Well-Known Member

    Joined:
    Sep 7, 2010
    Messages:
    2,083
    Likes Received:
    61
    delete the gateway and then recreate using any name you like selecting "generic" as the type. do one for each line/ht503. this then gives you 2 routes so that if one is in use the 2nd can be called by 3cx based upon your out bound rules. you simply need to match the virtual port info and passwords such that both devices register. point each port to the desired extension or other as desired for answering inbound and make outbound rules for each as well.
     
  7. crombiecrunch

    Joined:
    Feb 2, 2014
    Messages:
    8
    Likes Received:
    0
    no luck, I am even tried fully uninstalling 3CX and starting over. I thought maybe it was the Avaya phone. So I downloaded the 3CX windows softphone and I am still having the same issues with that as well.

    i followed the guide at http://www.3cx.ru/blog/grandstream-ht503-1-fxo-1-fxs/ with exception of changing the tone and left it country based, and still not working.
     
  8. lneblett

    lneblett Well-Known Member

    Joined:
    Sep 7, 2010
    Messages:
    2,083
    Likes Received:
    61
    Well when you start over, so do we as I do not know where you and how the system is now configured and still does not work isn't descriptive enough.

    1. Are the HT503 devices now configured as two individual trunk/ports to 3CX and are they both showing as registered? Are the phone lines plugged into the FXO port of each device and the Ethernet plugged into the WAN port?

    2. Are the IP addresses for each HT set statically within the HT devices themselves and/or at least reserved in the DHCP server so that no matter the situation, the HTs will always have their own internal private IP address that never changes?

    3. Does each HT have an inbound route set such that calling into the system can be accommodated? If there is any doubt about the Avaya phones, then set-up a temporary digital receptionist that can be used to answer. We can always dial 101 and have the DR forward to the Avaya, but at least if the DR answers and you can respond to it, then we know that the HT is at least working on the inbound.

    In your case, the firewall checker is not as important as you are not using the internet to facilitate the voice communications. You made no mention of a remote phones nor of a SIP trunk provider. Nevertheless it does not hurt to know that the connectivity is there should you need it. The only port you may want to consider at the moment is 5000 TCP should you want to use the web interface from a remote location to get into the management console.
     
  9. crombiecrunch

    Joined:
    Feb 2, 2014
    Messages:
    8
    Likes Received:
    0
    Ok So I have managed to get the 3CX windows soft phone working. So I can make both outgoing and incoming calls using that. When I shut down the soft phone and trial to make a call from the avaya one-X I still only get the "half" ring noise then I can no longer hear any sound on the Avaya phone.

    The test number I cam calling will ring and when I pick it up, all I have is the music on hold. Also when I hang up the test phone it does not disconnect the Avaya phone from the PBX.

    Ive attached my settings file and some screen shots of the config.
     

    Attached Files:

  10. crombiecrunch

    Joined:
    Feb 2, 2014
    Messages:
    8
    Likes Received:
    0
    additional
     

    Attached Files:

    • fxo5.PNG
      fxo5.PNG
      File size:
      54 KB
      Views:
      1,240
    • fxo6.PNG
      fxo6.PNG
      File size:
      23.1 KB
      Views:
      1,240
  11. crombiecrunch

    Joined:
    Feb 2, 2014
    Messages:
    8
    Likes Received:
    0
    confirmed as avaya phone configuration issue. I get the exact same result with Asterisk.
     
Thread Status:
Not open for further replies.