Strange issue... all other outbound dial rules work but we can't dial any 800/855/866 numbers etc. We have a long distance + 800 number dial rule that gets matched but the call never goes all the way out, just rings twice then hangs up. Trying to go live tomorrow, so far not good...
Stuff we tried...
- Resetting the configuration of the Patton gateway through the 3CX add gateway wizard
- Updating the caller ID on the virtual extensions for the voice gateway
- Ran various debugs on the Patton gateway and reviewed the 3CX logs which don't indicate much
Call path...
Source: Extension 405
Destination: 1-800-553-2447 Cisco ;-)
Latest debug log from the Patton...
02:04:46 ISDN > # 259 [e1t1 0 0][0] from CC key: 8388671 L3SetupReq
02:04:46 ISDN > # 260 Service:Transparent cing: sub: ced: sub:
02:04:46 ISDN > # 261 cause : Transparent
02:04:46 ISDN > # 262 hex:04 03 90 90 A2 1C 14 9F A1 11 02 01 01 02 01 00 80 09 4B 69 6D 20 48 6F 67 61 6E 1E 02 85 83 6C 0C
02:04:46 ISDN > # 263 IE: Bearer
02:04:46 ISDN > # 264 IE: Facility
02:04:46 ISDN > # 265 IE: ProgressInd
02:04:46 ISDN > # 266 IE: CallingPartyNbr 2817309500
02:04:46 ISDN > # 267 IE: CalledPartyNbr 18005532447
02:04:46 ISDN > # 268 *newPc PR-U, tei: 0, sapi: 0
02:04:46 ISDN > # 269 key: 8388671, Stack:2V01b
02:04:46 ISDN > # 270 BellcoreT1
02:04:46 ISDN > # 271 ALLOC bchan BCh1 cref : 0x0016
02:04:46 ISDN > # 272 ---> Layer2 tei: 0 sapi: 0 Setup
02:04:46 ISDN > # 273 hex:08 02 00 16 05 04 03 90 90 A2 18 03 A1 83 81 1C 14 9F A1 11 02 01 01 02 01 00 80 09 4B 69 6D 20 48
02:04:46 ISDN > # 274 IE: Bearer
02:04:46 ISDN > # 275 IE: ChannelId BCh1 pref otherIf
02:04:46 ISDN > # 276 IE: Facility
02:04:46 ISDN > # 277 IE: ProgressInd
02:04:46 ISDN > # 278 IE: CallingPartyNbr 2817309500
02:04:46 ISDN > # 279 IE: CalledPartyNbr 18005532447
02:04:46 ISDN > # 280 new call state : L3PcSt01U
02:04:46 ISDN > # 281 [e1t1 0 0][0] <--- Layer2 tei: 0 sapi: 0 CallProc
02:04:46 ISDN > # 282 hex:08 02 80 16 02 18 03 A9 83 81
02:04:46 ISDN > # 283 IE: ChannelId BCh1 excl otherIf
02:04:46 ISDN > # 284 to CC key: 8388671 L3ProceedingInd
02:04:46 ISDN > # 285 new call state : L3PcSt03U
02:04:46 ISDN > # 286 [e1t1 0 0] Activate b-channel 1
02:04:46 ISDN > # 287 [e1t1 0 0][0] <--- Layer2 tei: 0 sapi: 0 Disconnect
02:04:46 ISDN > # 288 hex:08 02 80 16 45 08 02 82 B9
02:04:46 ISDN > # 289 IE: Cause BearerCapNotAuthorized
02:04:46 ISDN > # 290 to CC key: 8388671 L3DisconnectInd
02:04:46 ISDN > # 291 new call state : L3PcSt12U
02:04:46 ISDN > # 292 [e1t1 0 0] Deactivate b-channel 1
02:04:46 ISDN > # 293 [e1t1 0 0][0] from CC key: 8388671 L3ReleaseReq
02:04:46 ISDN > # 294 cause : BearerCapNotAuthorized
02:04:46 ISDN > # 295 ---> Layer2 tei: 0 sapi: 0 Release
02:04:46 ISDN > # 296 hex:08 02 00 16 4D 08 02 80 B9
02:04:46 ISDN > # 297 IE: Cause BearerCapNotAuthorized
02:04:46 ISDN > # 298 new call state : L3PcSt19U
02:04:46 ISDN > # 299 [e1t1 0 0][0] <--- Layer2 tei: 0 sapi: 0 ReleaseCom
02:04:46 ISDN > # 300 hex:08 02 80 16 5A
02:04:46 ISDN > # 301 to CC key: 8388671 L3ReleaseConf
02:04:46 ISDN > # 302 DEALLOC bchan BCh1 cref : 0x0016
02:04:46 ISDN > # 303 new call state : L3PcSt00U
02:04:46 ISDN > # 304 *delPc U, tei: 0 sapi: 0
3CX system activity log...
28-Nov-2012 20:04:56.564 Leg L:117.1[Extn] is terminated: Cause: BYE from PBX
28-Nov-2012 20:04:56.514 [CM503020]: Call(C:117): Normal call termination. Call originator: Extn:405. Reason: Server Failure
28-Nov-2012 20:04:56.514 L:117.1[Extn] failed to reach Line:10000>>18005532447, reason Server Failure
28-Nov-2012 20:04:56.514 Leg L:117.5[Line:10000>>18005532447] is terminated: Cause: 503 Service Unavailable/INVITE from 10.10.1.16:5066
28-Nov-2012 20:04:56.514 Call to T:Line:10000>>18005532447@[Dev:sip:[email protected]:5066] from L:117.1[Extn] failed, cause: Cause: 503 Service Unavailable/INVITE from 10.10.1.16:5066
28-Nov-2012 20:04:56.513 [CM503003]: Call(C:117): Call to <sip:[email protected]:5066> has failed; Cause: 503 Service Unavailable/INVITE from 10.10.1.16:5066
28-Nov-2012 20:04:52.379 Leg L:117.4[Line:10000>>18005532447] is terminated: Cause: 503 Service Unavailable/INVITE from 10.10.1.16:5064
28-Nov-2012 20:04:52.379 [CM503025]: Call(C:117): Calling T:Line:10000>>18005532447@[Dev:sip:[email protected]:5066] for L:117.1[Extn]
28-Nov-2012 20:04:52.375 Call to T:Line:10000>>18005532447@[Dev:sip:[email protected]:5064,Dev:sip:[email protected]:5066] from L:117.1[Extn] failed, cause: Cause: 503 Service Unavailable/INVITE from 10.10.1.16:5064
28-Nov-2012 20:04:52.374 [CM503003]: Call(C:117): Call to <sip:[email protected]:5064> has failed; Cause: 503 Service Unavailable/INVITE from 10.10.1.16:5064
28-Nov-2012 20:04:48.238 Leg L:117.3[Line:10000>>18005532447] is terminated: Cause: 403 Forbidden/INVITE from 10.10.1.16:5062
28-Nov-2012 20:04:48.235 [CM503025]: Call(C:117): Calling T:Line:10000>>18005532447@[Dev:sip:[email protected]:5064,Dev:sip:[email protected]:5066] for L:117.1[Extn]
28-Nov-2012 20:04:48.230 Call to T:Line:10000>>18005532447@[Dev:sip:[email protected]:5062,Dev:sip:[email protected]:5064,Dev:sip:[email protected]:5066] from L:117.1[Extn] failed, cause: Cause: 403 Forbidden/INVITE from 10.10.1.16:5062
28-Nov-2012 20:04:48.230 [CM503003]: Call(C:117): Call to <sip:[email protected]:5062> has failed; Cause: 403 Forbidden/INVITE from 10.10.1.16:5062
28-Nov-2012 20:04:47.899 Leg L:117.2[Line:10000>>18005532447] is terminated: Cause: 403 Forbidden/INVITE from 10.10.1.16:5060
28-Nov-2012 20:04:47.896 [CM503025]: Call(C:117): Calling T:Line:10000>>18005532447@[Dev:sip:[email protected]:5062,Dev:sip:[email protected]:5064,Dev:sip:[email protected]:5066] for L:117.1[Extn]
28-Nov-2012 20:04:47.892 Call to T:Line:10000>>18005532447@[Dev:sip:[email protected]:5060,Dev:sip:[email protected]:5062,Dev:sip:[email protected]:5064,Dev:sip:[email protected]:5066] from L:117.1[Extn] failed, cause: Cause: 403 Forbidden/INVITE from 10.10.1.16:5060
28-Nov-2012 20:04:47.891 [CM503003]: Call(C:117): Call to <sip:[email protected]:5060> has failed; Cause: 403 Forbidden/INVITE from 10.10.1.16:5060
28-Nov-2012 20:04:47.595 [CM503025]: Call(C:117): Calling T:Line:10000>>18005532447@[Dev:sip:[email protected]:5060,Dev:sip:[email protected]:5062,Dev:sip:[email protected]:5064,Dev:sip:[email protected]:5066] for L:117.1[Extn]
28-Nov-2012 20:04:47.550 [CM503027]: Call(C:117): From: Extn:405 ("Kim Hogan" <sip:[email protected]:5060>) to T:Line:10000>>18005532447@[Dev:sip:[email protected]:5060,Dev:sip:[email protected]:5062,Dev:sip:[email protected]:5064,Dev:sip:[email protected]:5066]
28-Nov-2012 20:04:47.550 [CM503004]: Call(C:117): Route 1: from L:117.1[Extn] to T:Line:10000>>18005532447@[Dev:sip:[email protected]:5060,Dev:sip:[email protected]:5062,Dev:sip:[email protected]:5064,Dev:sip:[email protected]:5066]
28-Nov-2012 20:04:47.550 Line limit check: Current # of calls for line Lc:10003(@Patton4970[<sip:[email protected]:5066>]) is 0; limit is 23
28-Nov-2012 20:04:47.550 Line limit check: Current # of calls for line Lc:10002(@Patton4970[<sip:[email protected]:5064>]) is 0; limit is 23
28-Nov-2012 20:04:47.549 Line limit check: Current # of calls for line Lc:10001(@Patton4970[<sip:[email protected]:5062>]) is 0; limit is 23
28-Nov-2012 20:04:47.549 Line limit check: Current # of calls for line Lc:10000(@Patton4970[<sip:[email protected]:5060>]) is 0; limit is 23
28-Nov-2012 20:04:47.549 Call(C:117): Call from Extn:405 to 18005532447 matches outbound rule 'Long Distance and 800 Number Calls'
28-Nov-2012 20:04:47.548 [CM503001]: Call(C:117): Incoming call from Extn:405 to <sip:[email protected]:5060>
Stuff we tried...
- Resetting the configuration of the Patton gateway through the 3CX add gateway wizard
- Updating the caller ID on the virtual extensions for the voice gateway
- Ran various debugs on the Patton gateway and reviewed the 3CX logs which don't indicate much
Call path...
Source: Extension 405
Destination: 1-800-553-2447 Cisco ;-)
Latest debug log from the Patton...
02:04:46 ISDN > # 259 [e1t1 0 0][0] from CC key: 8388671 L3SetupReq
02:04:46 ISDN > # 260 Service:Transparent cing: sub: ced: sub:
02:04:46 ISDN > # 261 cause : Transparent
02:04:46 ISDN > # 262 hex:04 03 90 90 A2 1C 14 9F A1 11 02 01 01 02 01 00 80 09 4B 69 6D 20 48 6F 67 61 6E 1E 02 85 83 6C 0C
02:04:46 ISDN > # 263 IE: Bearer
02:04:46 ISDN > # 264 IE: Facility
02:04:46 ISDN > # 265 IE: ProgressInd
02:04:46 ISDN > # 266 IE: CallingPartyNbr 2817309500
02:04:46 ISDN > # 267 IE: CalledPartyNbr 18005532447
02:04:46 ISDN > # 268 *newPc PR-U, tei: 0, sapi: 0
02:04:46 ISDN > # 269 key: 8388671, Stack:2V01b
02:04:46 ISDN > # 270 BellcoreT1
02:04:46 ISDN > # 271 ALLOC bchan BCh1 cref : 0x0016
02:04:46 ISDN > # 272 ---> Layer2 tei: 0 sapi: 0 Setup
02:04:46 ISDN > # 273 hex:08 02 00 16 05 04 03 90 90 A2 18 03 A1 83 81 1C 14 9F A1 11 02 01 01 02 01 00 80 09 4B 69 6D 20 48
02:04:46 ISDN > # 274 IE: Bearer
02:04:46 ISDN > # 275 IE: ChannelId BCh1 pref otherIf
02:04:46 ISDN > # 276 IE: Facility
02:04:46 ISDN > # 277 IE: ProgressInd
02:04:46 ISDN > # 278 IE: CallingPartyNbr 2817309500
02:04:46 ISDN > # 279 IE: CalledPartyNbr 18005532447
02:04:46 ISDN > # 280 new call state : L3PcSt01U
02:04:46 ISDN > # 281 [e1t1 0 0][0] <--- Layer2 tei: 0 sapi: 0 CallProc
02:04:46 ISDN > # 282 hex:08 02 80 16 02 18 03 A9 83 81
02:04:46 ISDN > # 283 IE: ChannelId BCh1 excl otherIf
02:04:46 ISDN > # 284 to CC key: 8388671 L3ProceedingInd
02:04:46 ISDN > # 285 new call state : L3PcSt03U
02:04:46 ISDN > # 286 [e1t1 0 0] Activate b-channel 1
02:04:46 ISDN > # 287 [e1t1 0 0][0] <--- Layer2 tei: 0 sapi: 0 Disconnect
02:04:46 ISDN > # 288 hex:08 02 80 16 45 08 02 82 B9
02:04:46 ISDN > # 289 IE: Cause BearerCapNotAuthorized
02:04:46 ISDN > # 290 to CC key: 8388671 L3DisconnectInd
02:04:46 ISDN > # 291 new call state : L3PcSt12U
02:04:46 ISDN > # 292 [e1t1 0 0] Deactivate b-channel 1
02:04:46 ISDN > # 293 [e1t1 0 0][0] from CC key: 8388671 L3ReleaseReq
02:04:46 ISDN > # 294 cause : BearerCapNotAuthorized
02:04:46 ISDN > # 295 ---> Layer2 tei: 0 sapi: 0 Release
02:04:46 ISDN > # 296 hex:08 02 00 16 4D 08 02 80 B9
02:04:46 ISDN > # 297 IE: Cause BearerCapNotAuthorized
02:04:46 ISDN > # 298 new call state : L3PcSt19U
02:04:46 ISDN > # 299 [e1t1 0 0][0] <--- Layer2 tei: 0 sapi: 0 ReleaseCom
02:04:46 ISDN > # 300 hex:08 02 80 16 5A
02:04:46 ISDN > # 301 to CC key: 8388671 L3ReleaseConf
02:04:46 ISDN > # 302 DEALLOC bchan BCh1 cref : 0x0016
02:04:46 ISDN > # 303 new call state : L3PcSt00U
02:04:46 ISDN > # 304 *delPc U, tei: 0 sapi: 0
3CX system activity log...
28-Nov-2012 20:04:56.564 Leg L:117.1[Extn] is terminated: Cause: BYE from PBX
28-Nov-2012 20:04:56.514 [CM503020]: Call(C:117): Normal call termination. Call originator: Extn:405. Reason: Server Failure
28-Nov-2012 20:04:56.514 L:117.1[Extn] failed to reach Line:10000>>18005532447, reason Server Failure
28-Nov-2012 20:04:56.514 Leg L:117.5[Line:10000>>18005532447] is terminated: Cause: 503 Service Unavailable/INVITE from 10.10.1.16:5066
28-Nov-2012 20:04:56.514 Call to T:Line:10000>>18005532447@[Dev:sip:[email protected]:5066] from L:117.1[Extn] failed, cause: Cause: 503 Service Unavailable/INVITE from 10.10.1.16:5066
28-Nov-2012 20:04:56.513 [CM503003]: Call(C:117): Call to <sip:[email protected]:5066> has failed; Cause: 503 Service Unavailable/INVITE from 10.10.1.16:5066
28-Nov-2012 20:04:52.379 Leg L:117.4[Line:10000>>18005532447] is terminated: Cause: 503 Service Unavailable/INVITE from 10.10.1.16:5064
28-Nov-2012 20:04:52.379 [CM503025]: Call(C:117): Calling T:Line:10000>>18005532447@[Dev:sip:[email protected]:5066] for L:117.1[Extn]
28-Nov-2012 20:04:52.375 Call to T:Line:10000>>18005532447@[Dev:sip:[email protected]:5064,Dev:sip:[email protected]:5066] from L:117.1[Extn] failed, cause: Cause: 503 Service Unavailable/INVITE from 10.10.1.16:5064
28-Nov-2012 20:04:52.374 [CM503003]: Call(C:117): Call to <sip:[email protected]:5064> has failed; Cause: 503 Service Unavailable/INVITE from 10.10.1.16:5064
28-Nov-2012 20:04:48.238 Leg L:117.3[Line:10000>>18005532447] is terminated: Cause: 403 Forbidden/INVITE from 10.10.1.16:5062
28-Nov-2012 20:04:48.235 [CM503025]: Call(C:117): Calling T:Line:10000>>18005532447@[Dev:sip:[email protected]:5064,Dev:sip:[email protected]:5066] for L:117.1[Extn]
28-Nov-2012 20:04:48.230 Call to T:Line:10000>>18005532447@[Dev:sip:[email protected]:5062,Dev:sip:[email protected]:5064,Dev:sip:[email protected]:5066] from L:117.1[Extn] failed, cause: Cause: 403 Forbidden/INVITE from 10.10.1.16:5062
28-Nov-2012 20:04:48.230 [CM503003]: Call(C:117): Call to <sip:[email protected]:5062> has failed; Cause: 403 Forbidden/INVITE from 10.10.1.16:5062
28-Nov-2012 20:04:47.899 Leg L:117.2[Line:10000>>18005532447] is terminated: Cause: 403 Forbidden/INVITE from 10.10.1.16:5060
28-Nov-2012 20:04:47.896 [CM503025]: Call(C:117): Calling T:Line:10000>>18005532447@[Dev:sip:[email protected]:5062,Dev:sip:[email protected]:5064,Dev:sip:[email protected]:5066] for L:117.1[Extn]
28-Nov-2012 20:04:47.892 Call to T:Line:10000>>18005532447@[Dev:sip:[email protected]:5060,Dev:sip:[email protected]:5062,Dev:sip:[email protected]:5064,Dev:sip:[email protected]:5066] from L:117.1[Extn] failed, cause: Cause: 403 Forbidden/INVITE from 10.10.1.16:5060
28-Nov-2012 20:04:47.891 [CM503003]: Call(C:117): Call to <sip:[email protected]:5060> has failed; Cause: 403 Forbidden/INVITE from 10.10.1.16:5060
28-Nov-2012 20:04:47.595 [CM503025]: Call(C:117): Calling T:Line:10000>>18005532447@[Dev:sip:[email protected]:5060,Dev:sip:[email protected]:5062,Dev:sip:[email protected]:5064,Dev:sip:[email protected]:5066] for L:117.1[Extn]
28-Nov-2012 20:04:47.550 [CM503027]: Call(C:117): From: Extn:405 ("Kim Hogan" <sip:[email protected]:5060>) to T:Line:10000>>18005532447@[Dev:sip:[email protected]:5060,Dev:sip:[email protected]:5062,Dev:sip:[email protected]:5064,Dev:sip:[email protected]:5066]
28-Nov-2012 20:04:47.550 [CM503004]: Call(C:117): Route 1: from L:117.1[Extn] to T:Line:10000>>18005532447@[Dev:sip:[email protected]:5060,Dev:sip:[email protected]:5062,Dev:sip:[email protected]:5064,Dev:sip:[email protected]:5066]
28-Nov-2012 20:04:47.550 Line limit check: Current # of calls for line Lc:10003(@Patton4970[<sip:[email protected]:5066>]) is 0; limit is 23
28-Nov-2012 20:04:47.550 Line limit check: Current # of calls for line Lc:10002(@Patton4970[<sip:[email protected]:5064>]) is 0; limit is 23
28-Nov-2012 20:04:47.549 Line limit check: Current # of calls for line Lc:10001(@Patton4970[<sip:[email protected]:5062>]) is 0; limit is 23
28-Nov-2012 20:04:47.549 Line limit check: Current # of calls for line Lc:10000(@Patton4970[<sip:[email protected]:5060>]) is 0; limit is 23
28-Nov-2012 20:04:47.549 Call(C:117): Call from Extn:405 to 18005532447 matches outbound rule 'Long Distance and 800 Number Calls'
28-Nov-2012 20:04:47.548 [CM503001]: Call(C:117): Incoming call from Extn:405 to <sip:[email protected]:5060>
