[cisco-voip] MGCP Fallback time...

Jonathan Charles jonvoip at gmail.com
Fri May 25 20:34:52 EDT 2007


I have a new SRST router (MGCP back to CCM)...

When we yank the WAN, it takes about 13 minutes for the router to
realize that CCM is down and kill the PRI... and revert to H.323 mode.

If you look at the attached log file, you can see that the phones are
registering to the router, and a full 13 minutes later the PRI goes
down...

Is there a way to change this to make it quicker?

IOS is 12.4.3g




Jonathan
-------------- next part --------------
AMLIDAL2811#
*May 26 00:03:48.123: %IPPHONE-6-REG_ALARM: 14: Name=SEP001AA17BE81E Load= SCCP4
1.8-2-1S Last=CM-closed-TCP
*May 26 00:03:48.143: %IPPHONE-6-REGISTER_NEW: ephone-13:SEP001AA17BE81E IP:172.
27.128.23 Socket:18 DeviceType:Phone has registered.
AMLIDAL2811#
*May 26 00:03:51.003: %IPPHONE-6-REG_ALARM: 14: Name=SEP001AA193EE46 Load= SCCP4
1.8-2-1S Last=CM-closed-TCP
*May 26 00:03:51.003: %IPPHONE-6-REGISTER_NEW: ephone-11:SEP001AA193EE46 IP:172.
27.128.30 Socket:19 DeviceType:Phone has registered.
*May 26 00:03:51.255: %IPPHONE-6-REG_ALARM: 14: Name=SEP001AA1B4835B Load= SCCP4
1.8-2-1S Last=CM-closed-TCP
*May 26 00:03:51.255: %IPPHONE-6-REG_ALARM: 14: Name=SEP001AA18DD988 Load= SCCP4
1.8-2-1S Last=CM-closed-TCP
*May 26 00:03:51.255: %IPPHONE-6-REGISTER_NEW: ephone-2:SEP001AA1B4835B IP:172.2
7.128.21 Socket:20 DeviceType:Phone has registered.
AMLIDAL2811#
*May 26 00:03:51.255: %IPPHONE-6-REGISTER_NEW: ephone-22:SEP001AA18DD988 IP:172.
27.128.45 Socket:21 DeviceType:Phone has registered.
*May 26 00:03:51.771: %IPPHONE-6-REG_ALARM: 14: Name=SEP001AA18DE3CB Load= SCCP4
1.8-2-1S Last=CM-closed-TCP
*May 26 00:03:51.771: %IPPHONE-6-REG_ALARM: 14: Name=SEP001AA163B6DC Load= SCCP4
1.8-2-1S Last=CM-closed-TCP
*May 26 00:03:51.779: %IPPHONE-6-REGISTER_NEW: ephone-12:SEP001AA18DE3CB IP:172.
27.128.51 Socket:22 DeviceType:Phone has registered.
*May 26 00:03:52.031: %IPPHONE-6-REGISTER_NEW: ephone-29:SEP001AA163B6DC IP:172.
27.128.44 Socket:23 DeviceType:Phone has registered.
AMLIDAL2811#
*May 26 00:03:52.323: %IPPHONE-6-REG_ALARM: 14: Name=SEP001AA1B48CEB Load= SCCP4
1.8-2-1S Last=CM-closed-TCP
*May 26 00:03:52.623: %IPPHONE-6-REGISTER_NEW: ephone-24:SEP001AA1B48CEB IP:172.
27.128.35 Socket:24 DeviceType:Phone has registered.
*May 26 00:03:53.171: %IPPHONE-6-REG_ALARM: 14: Name=SEP001AA1A804FE Load= SCCP4
1.8-2-1S Last=CM-closed-TCP
*May 26 00:03:53.171: %IPPHONE-6-REGISTER_NEW: ephone-3:SEP001AA1A804FE IP:172.2
7.128.27 Socket:25 DeviceType:Phone has registered.
AMLIDAL2811#
*May 26 00:04:03.083: %IPPHONE-6-REG_ALARM: 14: Name=SEP001AA193EF47 Load= SCCP4
1.8-2-1S Last=CM-closed-TCP
*May 26 00:04:03.083: %IPPHONE-6-REGISTER_NEW: ephone-9:SEP001AA193EF47 IP:172.2
7.128.34 Socket:26 DeviceType:Phone has registered.
AMLIDAL2811#
*May 26 00:05:21.987: %IPPHONE-6-REG_ALARM: Name=ATA001B53F0BABA Load=ATA030203S
CCP051201A.zup Last=Initialized
*May 26 00:05:22.239: %IPPHONE-6-REGISTER_NEW: ephone-4:ATA001B53F0BABA IP:172.2
7.128.50 Socket:27 DeviceType:Phone has registered.
AMLIDAL2811#
*May 26 00:05:26.103: %IPPHONE-6-REG_ALARM: Name=ATA001B53F0BC07 Load=ATA030203S
CCP051201A.zup Last=Initialized
*May 26 00:05:26.103: %IPPHONE-6-REG_ALARM: Name=ATA001B53C64188 Load=ATA030203S
CCP051201A.zup Last=Initialized
*May 26 00:05:26.103: %IPPHONE-6-REGISTER_NEW: ephone-5:ATA001B53F0BC07 IP:172.2
7.128.49 Socket:28 DeviceType:Phone has registered.
*May 26 00:05:26.103: %IPPHONE-6-REGISTER_NEW: ephone-6:ATA001B53C64188 IP:172.2
7.128.54 Socket:29 DeviceType:Phone has registered.
AMLIDAL2811#
*May 26 00:10:51.891: ISDN Se0/0/0:23 Q931: Applying typeplan for sw-type 0xD is
 0x0 0x0, Calling num 6714
*May 26 00:10:51.891: ISDN Se0/0/0:23 Q931: Applying typeplan for sw-type 0xD is
 0x0 0x0, Called num 13126567496
*May 26 00:10:51.891: ISDN Se0/0/0:23 Q931: TX -> SETUP pd = 8  callref = 0x0086

        Bearer Capability i = 0x8090A2
                Standard = CCITT
                Transfer Capability = Speech
                Transfer Mode = Circuit
                Transfer Rate = 64 kbit/s
        Channel ID i = 0xA98397
                Exclusive, Channel 23
        Progress Ind i = 0x8183 - Origination address is non-ISDN
AMLIDAL2811#
        Calling Party Number i = 0x0080, '6714'
                Plan:Unknown, Type:Unknown
        Called Party Number i = 0x80, '[removed]'
                Plan:Unknown, Type:Unknown
*May 26 00:10:51.923: ISDN Se0/0/0:23 Q931: RX <- RELEASE pd = 8  callref = 0x80
01
        Cause i = 0x80A9 - Temporary failure
*May 26 00:10:51.923: ISDN Se0/0/0:23 **ERROR**: L3_BadPeerMsg: event 0x4D cr 0x
1 callid 0x0
*May 26 00:10:51.923: ISDN Se0/0/0:23 Q931: RX <- RELEASE_COMP pd = 8  callref =
 0x8086
        Cause i = 0x8091 - User busy
*May 26 00:10:51.927: ISDN Se0/0/0:23 Q931: TX -> RELEASE_COMP pd = 8  callref =
 0x0001
        Cause i = 0x80D1 - Invalid call reference value
AMLIDAL2811#
*May 26 00:13:57.415: ISDN Se0/0/0:23 Q931: Applying typeplan for sw-type 0xD is
 0x0 0x0, Calling num 6788
*May 26 00:13:57.415: ISDN Se0/0/0:23 Q931: Applying typeplan for sw-type 0xD is
 0x0 0x0, Called num 13126567496
*May 26 00:13:57.419: ISDN Se0/0/0:23 Q931: TX -> SETUP pd = 8  callref = 0x0087

        Bearer Capability i = 0x8090A2
                Standard = CCITT
                Transfer Capability = Speech
                Transfer Mode = Circuit
                Transfer Rate = 64 kbit/s
        Channel ID i = 0xA98397
                Exclusive, Channel 23
        Progress Ind i = 0x8183 - Origination address is non-ISDN
AMLIDAL2811#
        Calling Party Number i = 0x0080, '6788'
                Plan:Unknown, Type:Unknown
        Called Party Number i = 0x80, '13126567496'
                Plan:Unknown, Type:Unknown
*May 26 00:13:57.495: ISDN Se0/0/0:23 Q931: RX <- CALL_PROC pd = 8  callref = 0x
8087
        Channel ID i = 0xA98397
                Exclusive, Channel 23
AMLIDAL2811#
*May 26 00:13:59.015: ISDN Se0/0/0:23 Q931: RX <- PROGRESS pd = 8  callref = 0x8
087
        Progress Ind i = 0x8288 - In-band info or appropriate now available
AMLIDAL2811#
*May 26 00:14:04.231: ISDN Se0/0/0:23 Q931: TX -> DISCONNECT pd = 8  callref = 0
x0087
        Cause i = 0x8090 - Normal call clearing
*May 26 00:14:04.267: ISDN Se0/0/0:23 Q931: RX <- RELEASE pd = 8  callref = 0x80
87
*May 26 00:14:04.271: ISDN Se0/0/0:23 Q931: TX -> RELEASE_COMP pd = 8  callref =
 0x0087
AMLIDAL2811#
*May 26 00:14:38.011: ISDN Se0/0/0:23 Q931: Applying typeplan for sw-type 0xD is
 0x0 0x0, Calling num 6788
*May 26 00:14:38.015: ISDN Se0/0/0:23 Q931: Applying typeplan for sw-type 0xD is
 0x0 0x0, Called num 16302481953
*May 26 00:14:38.015: ISDN Se0/0/0:23 Q931: TX -> SETUP pd = 8  callref = 0x0088

        Bearer Capability i = 0x8090A2
                Standard = CCITT
                Transfer Capability = Speech
                Transfer Mode = Circuit
                Transfer Rate = 64 kbit/s
        Channel ID i = 0xA98397
                Exclusive, Channel 23
        Progress Ind i = 0x8183 - Origination address is non-ISDN
AMLIDAL2811#
        Calling Party Number i = 0x0080, '6788'
                Plan:Unknown, Type:Unknown
        Called Party Number i = 0x80, '[removed]'
                Plan:Unknown, Type:Unknown
*May 26 00:14:38.075: ISDN Se0/0/0:23 Q931: RX <- CALL_PROC pd = 8  callref = 0x
8088
        Channel ID i = 0xA98397
                Exclusive, Channel 23
AMLIDAL2811#
*May 26 00:14:39.835: ISDN Se0/0/0:23 Q931: RX <- PROGRESS pd = 8  callref = 0x8
088
        Progress Ind i = 0x8288 - In-band info or appropriate now available
AMLIDAL2811#
*May 26 00:14:50.123: ISDN Se0/0/0:23 Q931: TX -> DISCONNECT pd = 8  callref = 0
x0088
        Cause i = 0x8090 - Normal call clearing
*May 26 00:14:50.171: ISDN Se0/0/0:23 Q931: RX <- RELEASE pd = 8  callref = 0x80
88
*May 26 00:14:50.175: ISDN Se0/0/0:23 Q931: TX -> RELEASE_COMP pd = 8  callref =
 0x0088
AMLIDAL2811#
*May 26 00:16:34.463: %IPPHONE-6-UNREGISTER_NORMAL: ephone-25:SEP001AA1B4899D IP
:172.27.128.36 Socket:5 DeviceType:Phone has unregistered normally.
*May 26 00:16:34.719: %IPPHONE-6-UNREGISTER_NORMAL: ephone-10:SEP001AA18DE1E1 IP
:172.27.128.52 Socket:14 DeviceType:Phone has unregistered normally.
AMLIDAL2811#
*May 26 00:16:36.735: %IPPHONE-6-UNREGISTER_NORMAL: ephone-19:SEP001AA1B48E8B IP
:172.27.128.32 Socket:6 DeviceType:Phone has unregistered normally.
*May 26 00:16:36.995: %IPPHONE-6-UNREGISTER_NORMAL: ephone-14:SEP001AA1B2B954 IP
:172.27.128.37 Socket:16 DeviceType:Phone has unregistered normally.
AMLIDAL2811#
*May 26 00:16:39.787: [S] mgcp_msg_ack:6059,Updating (*)=172.28.2.5
AMLIDAL2811#
*May 26 00:16:40.271: %IPPHONE-6-UNREGISTER_NORMAL: ephone-18:SEP001AA1B2B91C IP
:172.27.128.39 Socket:13 DeviceType:Phone has unregistered normally.
*May 26 00:16:40.779: %IPPHONE-6-UNREGISTER_NORMAL: ephone-29:SEP001AA163B6DC IP
:172.27.128.44 Socket:23 DeviceType:Phone has unregistered normally.
AMLIDAL2811#
*May 26 00:16:41.539: %IPPHONE-6-UNREGISTER_NORMAL: ephone-17:SEP001AA1B2B9AF IP
:172.27.128.31 Socket:15 DeviceType:Phone has unregistered normally.
*May 26 00:16:42.047: %IPPHONE-6-UNREGISTER_NORMAL: ephone-8:SEP001AA18DE037 IP:
172.27.128.48 Socket:17 DeviceType:Phone has unregistered normally.
AMLIDAL2811#
*May 26 00:16:44.731: ISDN Se0/0/0:23 Q931: L3_ShutDown: Shutting down ISDN Laye
r 3
*May 26 00:16:44.731: %ISDN-6-LAYER2DOWN: Layer 2 for Interface Se0/0/0:23, TEI
0 changed to down
*May 26 00:16:44.735: ISDN Se0/0/0:23 Q931: Ux_DLRelInd: DL_REL_IND received fro
m L2
AMLIDAL2811#
*May 26 00:16:44.823: %IPPHONE-6-UNREGISTER_NORMAL: ephone-2:SEP001AA1B4835B IP:
172.27.128.21 Socket:20 DeviceType:Phone has unregistered normally.
*May 26 00:16:44.827: %IPPHONE-6-UNREGISTER_NORMAL: ephone-22:SEP001AA18DD988 IP
:172.27.128.45 Socket:21 DeviceType:Phone has unregistered normally.
*May 26 00:16:45.583: %IPPHONE-6-UNREGISTER_NORMAL: ephone-12:SEP001AA18DE3CB IP
:172.27.128.51 Socket:22 DeviceType:Phone has unregistered normally.
AMLIDAL2811#
*May 26 00:16:45.839: %IPPHONE-6-UNREGISTER_NORMAL: ephone-28:SEP001AA18DDD39 IP
:172.27.128.25 Socket:9 DeviceType:Phone has unregistered normally.
*May 26 00:16:46.727: %LINK-5-CHANGED: Interface Serial0/0/0:23, changed state t
o administratively down
AMLIDAL2811#
*May 26 00:16:46.851: %IPPHONE-6-UNREGISTER_NORMAL: ephone-9:SEP001AA193EF47 IP:
172.27.128.34 Socket:26 DeviceType:Phone has unregistered normally.
*May 26 00:16:47.615: %IPPHONE-6-UNREGISTER_NORMAL: ephone-3:SEP001AA1A804FE IP:
172.27.128.27 Socket:25 DeviceType:Phone has unregistered normally.
AMLIDAL2811#
*May 26 00:16:50.639: %IPPHONE-6-UNREGISTER_NORMAL: ephone-23:SEP001AA1B48A4F IP
:172.27.128.46 Socket:2 DeviceType:Phone has unregistered normally.
*May 26 00:16:51.135: %LINK-3-UPDOWN: Interface Serial0/0/0:23, changed state to
 up
*May 26 00:16:51.135: %LINK-3-UPDOWN: Interface Serial0/0/0:0, changed state to
down
*May 26 00:16:51.135: %LINK-3-UPDOWN: Interface Serial0/0/0:1, changed state to
down
*May 26 00:16:51.135: %LINK-3-UPDOWN: Interface Serial0/0/0:2, changed state to
down
*May 26 00:16:51.135: %LINK-3-UPDOWN: Interface Serial0/0/0:3, changed state to
down
*May 26 00:16:51.135: %LINK-3-UPDOWN: Interface Serial0/0/0:4, changed state to
down
*May 26 00:16:51.135: %LINK-3-UPDOWN: Interface Serial0/0/0:5, changed state to
down
*May 26 00:16:51.135: %LINK-3-UPDOWN: Interface Serial0/0/0:6, changed state to
down
*May 26 00:16:51.135: %LINK-3-UPDOWN: Interface Serial0/0/0:7, changed state to
down
*May 26 00:16:51.135: %LINK-3-UPDOWN: Interface Serial0/0/0:8, changed state to
down
*May 26 00:16:51.135: %LINK-3-UPDOWN: Interface Serial0/0/0:9, changed state to
down
*May 26 00:16:51.135: %LINK-3-UPDOWN: Interface Serial0/0/0:10, changed state to
 down
*May 26 00:16:51.135: %LINK-3-UPDOWN: Interface Serial0/0/0:11, changed state to
 down
*May 26 00:16:51.135: %LINK-3-UPDOWN: Interface Serial0/0/0:12, changed state to
 down
*May 26 00:16:51.135: %LINK-3-UPDOWN: Interface Serial0/0/0:13, changed state to
 down
*May 26 00:16:51.135: %LINK-3-UPDOWN: Interface Serial0/0/0:14, changed state to
 down
*May 26 00:16:51.135: %LINK-3-UPDOWN: Interface Serial0/0/0:15, changed state to
 down
*May 26 00:16:51.135: %LINK-3-UPDOWN: Interface Serial0/0/0:16, changed state to
 down
*May 26 00:16:51.135: %LINK-3-UPDOWN: Interface Serial0/0/0:17, changed state to
 down
*May 26 00:16:51.135: %LINK-3-UPDOWN: Interface Serial0/0/0:18, changed state to
 down
*May 26 00:16:51.135: %LINK-3-UPDOWN: Interface Serial0/0/0:19, changed state to
 down
*May 26 00:16:51.139: %LINK-3-UPDOWN: Interface Serial0/0/0:20, changed state to
 down
*May 26 00:16:51.139: %LINK-3-UPDOWN: Interface Serial0/0/0:21, changed state to
 down
*May 26 00:16:51.139: %LINK-3-UPDOWN: Interface Serial0/0/0:22, changed state to
 down
AMLIDAL2811#
*May 26 00:16:51.647: %IPPHONE-6-UNREGISTER_NORMAL: ephone-11:SEP001AA193EE46 IP
:172.27.128.30 Socket:19 DeviceType:Phone has unregistered normally.
*May 26 00:16:51.903: %IPPHONE-6-UNREGISTER_NORMAL: ephone-21:SEP001A6C3117EF IP
:172.27.128.33 Socket:4 DeviceType:Phone has unregistered normally.
AMLIDAL2811#
*May 26 00:16:52.663: %IPPHONE-6-UNREGISTER_NORMAL: ephone-1:SEP001AA1B483DC IP:
172.27.128.28 Socket:12 DeviceType:Phone has unregistered normally.
AMLIDAL2811#
*May 26 00:16:54.431: %IPPHONE-6-UNREGISTER_NORMAL: ephone-15:SEP001AA12736BB IP
:172.27.128.40 Socket:3 DeviceType:Phone has unregistered normally.
*May 26 00:16:54.959: %ISDN-6-LAYER2UP: Layer 2 for Interface Se0/0/0:23, TEI 0
changed to up
*May 26 00:16:55.119: ISDN Se0/0/0:23 **ERROR**: L2_AdvanceVA: TX_ack_queue empt
y
AMLIDAL2811#
*May 26 00:16:55.439: %IPPHONE-6-UNREGISTER_NORMAL: ephone-16:SEP001AA193E981 IP
:172.27.128.29 Socket:8 DeviceType:Phone has unregistered normally.
AMLIDAL2811#
*May 26 00:16:56.703: %IPPHONE-6-UNREGISTER_NORMAL: ephone-20:SEP001AA1B48C5D IP
:172.27.128.22 Socket:10 DeviceType:Phone has unregistered normally.
*May 26 00:16:56.959: %IPPHONE-6-UNREGISTER_NORMAL: ephone-27:SEP001A6C744902 IP
:172.27.128.26 Socket:7 DeviceType:Phone has unregistered normally.
*May 26 00:16:57.215: %IPPHONE-6-UNREGISTER_NORMAL: ephone-7:SEP001AA1B483F1 IP:
172.27.128.24 Socket:11 DeviceType:Phone has unregistered normally.
AMLIDAL2811#
*May 26 00:16:57.971: %IPPHONE-6-UNREGISTER_NORMAL: ephone-13:SEP001AA17BE81E IP
:172.27.128.23 Socket:18 DeviceType:Phone has unregistered normally.
*May 26 00:16:58.727: %IPPHONE-6-UNREGISTER_NORMAL: ephone-26:SEP001AA163B83B IP
:172.27.128.53 Socket:1 DeviceType:Phone has unregistered normally.
AMLIDAL2811#
*May 26 00:17:16.371: %IPPHONE-6-UNREGISTER_NORMAL: ephone-24:SEP001AA1B48CEB IP
:172.27.128.35 Socket:24 DeviceType:Phone has unregistered normally.
AMLIDAL2811#sh clock
*00:17:41.119 UTC Sat May 26 2007
AMLIDAL2811#
*May 26 00:18:34.503: %IPPHONE-6-UNREGISTER_NORMAL: ephone-5:ATA001B53F0BC07 IP:
172.27.128.49 Socket:28 DeviceType:Phone has unregistered normally.
AMLIDAL2811#
*May 26 00:18:35.511: %IPPHONE-6-UNREGISTER_NORMAL: ephone-4:ATA001B53F0BABA IP:
172.27.128.50 Socket:27 DeviceType:Phone has unregistered normally.
AMLIDAL2811#
*May 26 00:18:43.835: %IPPHONE-6-UNREGISTER_NORMAL: ephone-6:ATA001B53C64188 IP:
172.27.128.54 Socket:29 DeviceType:Phone has unregistered normally.
AMLIDAL2811#


More information about the cisco-voip mailing list