PITAMPURA_POP#sh debug PITAMPURA_POP#sh debugging AC: Attachment Circuit events debugging is on Attachment Circuit errors debugging is on Xconnect: Xconnect author events debugging is on Xconnect author errors debugging is on PITAMPURA_POP# *Apr 25 10:49:35.858: Fa0/0.103 ACMGR: Receive msg *Apr 25 10:49:35.858: Fa0/0.103 ACMGR: request disconnect event, FSP state chg c onnected to down, action is circuit disc, reset *Apr 25 10:49:35.858: ACLIB: pthru_intf_disconnect hdl is E4000010, type 4, id 1 03, idb Fa0/0.103 *Apr 25 10:49:35.862: ACLIB [71.5.254.255, 103]: Setting new AC state to Ac-Idle *Apr 25 10:49:35.862: ACLIB [71.5.254.255, 103]: pthru_intf_handle_circuit_up() calling acmgr_circuit_up *Apr 25 10:49:35.862: ACLIB [71.5.254.255, 103]: Setting new AC state to Ac-Conn ecting *Apr 25 10:49:35.862: Fa0/0.103 ACMGR: Receive msg *Apr 25 10:49:35.862: Fa0/0.103 ACMGR: circuit up delayed event, FSP down state no chg, action is fsp early conflict *Apr 25 10:49:35.862: Fa0/0.103 ACMGR: circuit up delayed event, SIP down state no chg, action is start service delay timer *Apr 25 10:49:35.862: ACLIB: pthru_intf_response hdl is E4000010, response is 1 *Apr 25 10:49:35.862: Fa0/0.103 ACMGR: Try SIP service request after 10 seconds delay *Apr 25 10:49:35.866: Fa0/0.109 ACMGR: Receive msg *Apr 25 10:49:35.866: Fa0/0.109 ACMGR: request disconnect event, FSP state chg s ip up to down, action is circuit disc, reset *Apr 25 10:49:35.866: ACLIB: pthru_intf_disconnect hdl is 3A000012, type 4, id 1 09, idb Fa0/0.109 *Apr 25 10:49:35.866: ACLIB [71.5.254.255, 109]: Setting new AC state to Ac-Idle *Apr 25 10:49:35.866: Fa0/0.104 ACMGR: Receive msg *Apr 25 10:49:35.866: Fa0/0.104 ACMGR: request disconnect event, FSP state chg c onnected to down, action is circuit disc, reset *Apr 25 10:49:35.866: ACLIB: pthru_intf_disconnect hdl is 7000011, type 4, id 10 4, idb Fa0/0.104 *Apr 25 10:49:35.866: ACLIB [71.5.254.255, 104]: Setting new AC state to Ac-Idle *Apr 25 10:49:35.866: ACLIB [71.5.254.255, 104]: pthru_intf_handle_circuit_up() calling acmgr_circuit_up *Apr 25 10:49:35.866: ACLIB [71.5.254.255, 104]: Setting new AC state to Ac-Conn ecting *Apr 25 10:49:35.866: Fa0/0.104 ACMGR: Receive msg *Apr 25 10:49:35.870: Fa0/0.104 ACMGR: circuit up delayed event, FSP down state no chg, action is fsp early conflict *Apr 25 10:49:35.870: Fa0/0.104 ACMGR: circuit up delayed event, SIP down state no chg, action is start service delay timer *Apr 25 10:49:35.870: ACLIB: pthru_intf_response hdl is 7000011, response is 1 *Apr 25 10:49:35.870: Fa0/0.104 ACMGR: Try SIP service request after 10 seconds delay *Apr 25 10:49:35.874: XC AUTH [71.5.254.255, 103]: Event: start xconnect authori zation, state changed from IDLE to AUTHORIZING *Apr 25 10:49:35.874: XC AUTH [71.5.254.255, 103]: Event: found xconnect authori zation, state changed from AUTHORIZING to DONE *Apr 25 10:49:35.874: XC AUTH [71.5.254.255, 109]: Event: start xconnect authori zation, state changed from IDLE to AUTHORIZING *Apr 25 10:49:35.874: XC AUTH [71.5.254.255, 109]: Event: found xconnect authori zation, state changed from AUTHORIZING to DONE *Apr 25 10:49:35.874: XC AUTH [71.5.254.255, 104]: Event: start xconnect authori zation, state changed from IDLE to AUTHORIZING *Apr 25 10:49:35.874: XC AUTH [71.5.254.255, 104]: Event: found xconnect authori zation, state changed from AUTHORIZING to DONE *Apr 25 10:49:35.874: XC AUTH [71.5.254.255, 103]: Event: free xconnect authoriz ation request, state changed from DONE to END *Apr 25 10:49:35.878: XC AUTH [71.5.254.255, 109]: Event: free xconnect authoriz ation request, state changed from DONE to END *Apr 25 10:49:35.878: XC AUTH [71.5.254.255, 104]: Event: free xconnect authoriz ation request, state changed from DONE to END *Apr 25 10:49:35.878: Fa0/0.103 ACMGR: Receive msg *Apr 25 10:49:35.878: Fa0/0.103 ACMGR: request connect event, SIP state chg down to sip up, action is sip early conflict *Apr 25 10:49:35.878: ACLIB: pthru_intf_connect hdl is E4000010, type 4, id 103, idb Fa0/0.103 *Apr 25 10:49:35.878: ACLIB [71.5.254.255, 103]: Setting new AC state to Ac-Conn ected *Apr 25 10:49:35.878: Fa0/0.109 ACMGR: Receive msg *Apr 25 10:49:35.878: Fa0/0.109 ACMGR: request connect event, FSP state chg down to sip up, action is circuit connect req *Apr 25 10:49:35.878: ACLIB: pthru_intf_connect hdl is 3A000012, type 4, id 109, idb Fa0/0.109 *Apr 25 10:49:35.878: ACLIB [71.5.254.255, 109]: Connect() from ACMgr found inte rface Fa0/0.109 down. *Apr 25 10:49:35.882: ACLIB [71.5.254.255, 109]: Setting new AC state to Ac-Idle *Apr 25 10:49:35.882: Fa0/0.104 ACMGR: Receive msg *Apr 25 10:49:35.882: Fa0/0.104 ACMGR: request connect event, SIP state chg down to sip up, action is sip early conflict *Apr 25 10:49:35.882: ACLIB: pthru_intf_connect hdl is 7000011, type 4, id 104, idb Fa0/0.104 *Apr 25 10:49:35.882: ACLIB [71.5.254.255, 104]: Setting new AC state to Ac-Conn ected *Apr 25 10:49:35.882: Fa0/0.103 ACMGR: Receive msg *Apr 25 10:49:35.882: Fa0/0.103 ACMGR: circuit up event, FSP state chg sip up to connected, action is send connected msg *Apr 25 10:49:35.882: ACLIB: pthru_intf_response hdl is E4000010, response is 2 *Apr 25 10:49:35.882: ACLIB [71.5.254.255, 103]: Setting new AC state to Ac-Conn ected *Apr 25 10:49:35.882: Fa0/0.104 ACMGR: Receive msg *Apr 25 10:49:35.882: Fa0/0.104 ACMGR: circuit up event, FSP state chg sip up to connected, action is send connected msg *Apr 25 10:49:35.882: ACLIB: pthru_intf_response hdl is 7000011, response is 2 *Apr 25 10:49:35.882: ACLIB [71.5.254.255, 104]: Setting new AC state to Ac-Conn ected *Apr 25 10:49:39.450: ACLIB [71.5.254.255, 103]: SW AC interface UNPROVISIONED f or VLAN interface Fa0/0.103 *Apr 25 10:49:39.450: ACLIB [71.5.254.255, 103]: Setting new AC state to Ac-Unpr ovisioning *Apr 25 10:49:39.450: ACLIB: Unbinding SWSB subblock *Apr 25 10:49:39.450: ACLIB [71.5.254.255, 103]: Deleting AC sublock structure. *Apr 25 10:49:39.450: ACLIB: SW AC interface PROVISIONED for VLAN interface Fa0/ 0.103 *Apr 25 10:49:39.450: ACLIB [0.0.0.0, 0]: Setting new AC state to Ac-Idle *Apr 25 10:49:39.450: ACLIB [0.0.0.0, 0]: AC attached subblock to FastEthernet0/ 0.103 *Apr 25 10:49:39.450: ACLIB [71.5.254.255, 103]: Setting new AC state to Ac-Idle *Apr 25 10:49:39.450: ACLIB [71.5.254.255, 103]: pthru_intf_handle_circuit_up() calling acmgr_circuit_up *Apr 25 10:49:39.454: ACLIB [71.5.254.255, 103]: Setting new AC state to Ac-Conn ecting *Apr 25 10:49:39.454: ACLIB [71.5.254.255, 109]: SW AC interface UNPROVISIONED f or VLAN interface Fa0/0.109 *Apr 25 10:49:39.454: ACLIB [71.5.254.255, 109]: Setting new AC state to Ac-Unpr ovisioning *Apr 25 10:49:39.454: ACLIB: Unbinding SWSB subblock *Apr 25 10:49:39.454: ACLIB [71.5.254.255, 109]: Deleting AC sublock structure. *Apr 25 10:49:39.454: ACLIB: SW AC interface PROVISIONED for VLAN interface Fa0/ 0.109 *Apr 25 10:49:39.454: ACLIB [0.0.0.0, 0]: Setting new AC state to Ac-Idle *Apr 25 10:49:39.454: ACLIB [0.0.0.0, 0]: AC attached subblock to FastEthernet0/ 0.109 *Apr 25 10:49:39.454: ACLIB [71.5.254.255, 109]: Setting new AC state to Ac-Idle *Apr 25 10:49:39.454: ACLIB [71.5.254.255, 109]: Vlan interface Fa0/0.109 not up *Apr 25 10:49:39.454: ACLIB [71.5.254.255, 104]: SW AC interface UNPROVISIONED f or VLAN interface Fa0/0.104 *Apr 25 10:49:39.454: ACLIB [71.5.254.255, 104]: Setting new AC state to Ac-Unpr ovisioning *Apr 25 10:49:39.454: ACLIB: Unbinding SWSB subblock *Apr 25 10:49:39.454: ACLIB [71.5.254.255, 104]: Deleting AC sublock structure. *Apr 25 10:49:39.454: ACLIB: SW AC interface PROVISIONED for VLAN interface Fa0/ 0.104 *Apr 25 10:49:39.458: ACLIB [0.0.0.0, 0]: Setting new AC state to Ac-Idle *Apr 25 10:49:39.458: ACLIB [0.0.0.0, 0]: AC attached subblock to FastEthernet0/ 0.104 *Apr 25 10:49:39.458: ACLIB [71.5.254.255, 104]: Setting new AC state to Ac-Idle *Apr 25 10:49:39.458: ACLIB [71.5.254.255, 104]: pthru_intf_handle_circuit_up() calling acmgr_circuit_up *Apr 25 10:49:39.458: ACLIB [71.5.254.255, 104]: Setting new AC state to Ac-Conn ecting *Apr 25 10:49:39.458: %SYS-5-CONFIG_I: Configured from console by administrator on vty1 (71.5.249.41) *Apr 25 10:49:39.462: Fa0/0.103 ACMGR: Receive msg *Apr 25 10:49:39.462: Fa0/0.103 ACMGR: unprovision event, FSP state chg connecte d to end, action is send disconnected msg *Apr 25 10:49:39.462: ACMGR: Receive msg *Apr 25 10:49:39.462: Fa0/0.103 ACMGR: circuit up event, SIP state chg down to s ip up, action is service req, resp fwding *Apr 25 10:49:39.462: Fa0/0.103 ACMGR: Sent a sip service request *Apr 25 10:49:39.462: ACLIB: pthru_intf_response hdl is FC000013, response is 1 *Apr 25 10:49:39.462: Fa0/0.109 ACMGR: Receive msg *Apr 25 10:49:39.462: Fa0/0.109 ACMGR: unprovision event, FSP state chg sip up t o end, action is send disconnected msg *Apr 25 10:49:39.462: Fa0/0.104 ACMGR: Receive msg *Apr 25 10:49:39.462: Fa0/0.104 ACMGR: unprovision event, FSP state chg connecte d to end, action is send disconnected msg *Apr 25 10:49:39.462: ACMGR: Receive msg *Apr 25 10:49:39.462: Fa0/0.104 ACMGR: circuit up event, SIP state chg down to s ip up, action is service req, resp fwding *Apr 25 10:49:39.462: Fa0/0.104 ACMGR: Sent a sip service request *Apr 25 10:49:39.462: ACLIB: pthru_intf_response hdl is DB000014, response is 1 *Apr 25 10:49:39.466: XC AUTH [Fa0/0.103, 103]: Event: start xconnect authorizat ion, state changed from IDLE to AUTHORIZING *Apr 25 10:49:39.466: XC AUTH [Fa0/0.103, 103]: Event: found xconnect authorizat ion, state changed from AUTHORIZING to DONE *Apr 25 10:49:39.470: XC AUTH [Fa0/0.104, 104]: Event: start xconnect authorizat ion, state changed from IDLE to AUTHORIZING *Apr 25 10:49:39.470: XC AUTH [Fa0/0.104, 104]: Event: found xconnect authorizat ion, state changed from AUTHORIZING to DONE *Apr 25 10:49:39.470: XC AUTH [Fa0/0.103, 103]: Event: free xconnect authorizati on request, state changed from DONE to END *Apr 25 10:49:39.470: XC AUTH [Fa0/0.104, 104]: Event: free xconnect authorizati on request, state changed from DONE to END *Apr 25 10:49:39.930: Fa0/0.103 ACMGR: Rcv SIP msg: resp connect forwarding, hdl FC000013, sss_hdl AD0002F6 *Apr 25 10:49:39.930: Fa0/0.104 ACMGR: Rcv SIP msg: resp connect forwarding, hdl DB000014, sss_hdl F60002F8 *Apr 25 10:49:40.186: Fa0/0.103 ACMGR: Rcv SIP msg: resp connect forwarded, hdl FC000013, sss_hdl AD0002F6 *Apr 25 10:49:40.186: Fa0/0.103 ACMGR: service connected event, SIP state chg si p up to connected, action is respond forwarded *Apr 25 10:49:40.186: ACLIB: pthru_intf_response hdl is FC000013, response is 2 *Apr 25 10:49:40.186: ACLIB [71.5.254.255, 103]: Setting new AC state to Ac-Conn ected *Apr 25 10:49:40.186: Fa0/0.104 ACMGR: Rcv SIP msg: resp connect forwarded, hdl DB000014, sss_hdl F60002F8 *Apr 25 10:49:40.190: Fa0/0.104 ACMGR: service connected event, SIP state chg si p up to connected, action is respond forwarded *Apr 25 10:49:40.190: ACLIB: pthru_intf_response hdl is DB000014, response is 2 *Apr 25 10:49:40.190: ACLIB [71.5.254.255, 104]: Setting new AC state to Ac-Conn ected *Apr 25 10:49:40.478: XC AUTH [71.5.254.255, 109]: Event: start xconnect authori zation, state changed from IDLE to AUTHORIZING *Apr 25 10:49:40.478: XC AUTH [71.5.254.255, 109]: Event: found xconnect authori zation, state changed from AUTHORIZING to DONE *Apr 25 10:49:40.478: XC AUTH [71.5.254.255, 109]: Event: free xconnect authoriz ation request, state changed from DONE to END *Apr 25 10:49:40.482: ACMGR: Receive msg *Apr 25 10:49:40.482: Fa0/0.109 ACMGR: request connect event, FSP state chg down to sip up, action is circuit connect req *Apr 25 10:49:40.482: ACLIB: pthru_intf_connect hdl is CD000015, type 4, id 109, idb Fa0/0.109 *Apr 25 10:49:40.482: ACLIB [71.5.254.255, 109]: Connect() from ACMgr found inte rface Fa0/0.109 down. *Apr 25 10:49:40.482: ACLIB [71.5.254.255, 109]: Setting new AC state to Ac-Idle PITAMPURA_POP#