Hi friends,
I'm using CUCM 8.6 with gateway 2901, configured as MGCP. I'm Using VIC2-2FXO for PSTN termination.The outgoing calls from fxo is working fine. But the incoming calls hangs up and not ringing the ip phone.
ccm-manager mgcp
no ccm-manager fax protocol cisco
ccm-manager music-on-hold
ccm-manager config server 10.10.10.201
ccm-manager config
!
mgcp
mgcp call-agent 10.10.10.201 2427 service-type mgcp version 0.1
mgcp dtmf-relay voip codec all mode out-of-band
mgcp rtp unreachable timeout 1000 action notify
mgcp modem passthrough voip mode nse
mgcp package-capability rtp-package
mgcp package-capability sst-package
mgcp package-capability pre-package
no mgcp package-capability res-package
no mgcp timer receive-rtcp
mgcp sdp simple
mgcp fax t38 inhibit
mgcp bind control source-interface GigabitEthernet0/1.20
mgcp bind media source-interface GigabitEthernet0/1.20
voice-port 0/0/0
supervisory disconnect dualtone mid-call
cptone SA
timing hookflash-out 50
I debugged mgcp incoming calls, I got the following replay.
CME_2901#
Jan 29 07:27:30.532: //-1/xxxxxxxxxxxx/MGCP/mgcpapp_process_sys_msg(208):[lvl=0]MGCP sys msg: (EXTERNAL_EVENT)
Jan 29 07:27:30.532: //-1/xxxxxxxxxxxx/MGCP/xlate_mgcp_sys_ev(69):[lvl=0]xlate sys msg: (EXTERNAL_EVENT, 31625
454)
Jan 29 07:27:30.532: //-1/xxxxxxxxxxxx/MGCP/mgcpapp_process_sys_msg(217):[lvl=0]sys msg values: (INVALID MGCP
EVENT, 0, , 3645, CALL_IDLE)
Jan 29 07:27:30.532: //-1/xxxxxxxxxxxx/MGCP/mgcp_handle_cmapp_event(441):[lvl=0]process
Jan 29 07:27:30.532: //-1/xxxxxxxxxxxx/MGCP/mgcp_cmapp_send_keepalive(286):[lvl=0]send NTFY KeepAlive
Jan 29 07:27:30.532: //-1/xxxxxxxxxxxx/MGCP/xgcp_endpt_get_by_ifn(1330):[lvl=0]Entered
Jan 29 07:27:30.532: //-1/xxxxxxxxxxxx/MGCP/xgcp_endpt_get_tree_link_by_ifn(1149):[lvl=0]Entered
Jan 29 07:27:30.532: //-1/xxxxxxxxxxxx/MGCP/xgcp_endpt_compute_key(198):[lvl=0]type -1 slot FFFFFFFF subunit F
FFFB650
Jan 29 07:27:30.532: //-1/xxxxxxxxxxxx/MGCP/xgcp_endpt_get_tree_link_by_ifn(1161):[lvl=0]computed key 0xF0000000
Jan 29 07:27:30.532: //-1/xxxxxxxxxxxx/MGCP/send_mgcp_empty_notify_msg(3675):[lvl=1]endpt *, complete_endpt *@CME_2901
Jan 29 07:27:30.532: //-1/xxxxxxxxxxxx/MGCP/mgcp_build_packet(864):[lvl=0]Entered
Jan 29 07:27:30.532: //-1/xxxxxxxxxxxx/MGCP/mgcp_estimate_msg_buf_length(496):[lvl=1]328 bytes needed for header
Jan 29 07:27:30.532: //-1/xxxxxxxxxxxx/MGCP/mgcp_estimate_msg_buf_length(785):[lvl=1]373 bytes needed after checking parameter lines
Jan 29 07:27:30.532: //-1/xxxxxxxxxxxx/MGCP/mgcp_estimate_msg_buf_length(808):[lvl=1]373 bytes needed after cheking SDP lines
Jan 29 07:27:30.532: //-1/xxxxxxxxxxxx/MGCP/mgcp_build_parameter_lines(9542):[lvl=0]Entered
Jan 29 07:27:30.532: //-1/xxxxxxxxxxxx/MGCP/mgcp_val_mandatory_parms(13064):[lvl=0]Entered
Jan 29 07:27:30.532: //-1/xxxxxxxxxxxx/MGCP/mgcp_build_request_id(10015):[lvl=0]Entered
Jan 29 07:27:30.532: //-1/xxxxxxxxxxxx/MGCP/mgcp_build_request_id(10035):[lvl=0]SUCCESS: Request ID string building is OK
Jan 29 07:27:30.532: //-1/xxxxxxxxxxxx/MGCP/mgcp_build_obs_events(11420):[lvl=0]Entered
Jan 29 07:27:30.532: //-1/xxxxxxxxxxxx/MGCP/mgcp_build_obs_events(11428):[lvl=0]mp_head_obs_evt_list NOT NULL
Jan 29 07:27:30.532: //-1/xxxxxxxxxxxx/MGCP/mgcp_build_obs_events(11468):[lvl=0]out of for loop for next nodein list
Jan 29 07:27:30.532: //-1/xxxxxxxxxxxx/MGCP/mgcp_build_parameter_lines(9845):[lvl=0]SUCCESS: Building MGCP Parameter lines is OK
Jan 29 07:27:30.532: //-1/xxxxxxxxxxxx/MGCP/mgcp_build_packet(1018):[lvl=1]SUCCESS: MGCP message building OK -END of building
Jan 29 07:27:30.532: //-1/xxxxxxxxxxxx/MGCP/mgcp_get_ne_info(2744):[lvl=0]Entered
Jan 29 07:27:30.532: //-1/xxxxxxxxxxxx/MGCP/mgcp_get_ne_info(2768):[lvl=1]Used endpoint NE 10.10.10.201
Jan 29 07:27:30.532: //-1/xxxxxxxxxxxx/MGCP/mgcp_enq_retx_msg(911):[lvl=0]trans_id 519806332,ntfy_ent 10.10.10.201
Jan 29 07:27:30.532: //-1/xxxxxxxxxxxx/MGCP/mgcp_root_get_profile(1905):[lvl=0]Entered
Jan 29 07:27:30.532: //-1/xxxxxxxxxxxx/MGCP/MGCP_NEDB_get_next_addr(1211):[lvl=1]
NOTIFY ENTITY = 10.10.10.201next->10.10.10.201
<END>
Jan 29 07:27:30.532: //-1/xxxxxxxxxxxx/MGCP/mgcp_add_trans_id_rec(1155):[lvl=1]Add trans id (519806332, 2A1AEC30) record
Jan 29 07:27:30.532: //-1/xxxxxxxxxxxx/MGCP/mgcp_stw_timer_start(393):[lvl=0]timer type 0, duration 500
Jan 29 07:27:30.532: //-1/xxxxxxxxxxxx/MGCP/mgcp_stw_timer_start(393):[lvl=0]timer type 15, duration 20000
Jan 29 07:27:30.532: MGCP Packet sent to 10.10.10.201:2427--->NTFY 519806332 *@CME_2901 MGCP 0.1
X: 0O:
<---
Jan 29 07:27:30.532: //-1/xxxxxxxxxxxx/MGCP/send_mgcp_empty_notify_msg(3738):[lvl=2]NTFY Packet sent successfully - *
Jan 29 07:27:30.532: //-1/xxxxxxxxxxxx/MGCP/mgcp_count_active_mgc_msg_stat(239):[lvl=1]MGC stat - 10.10.10.201, total=24105, succ=23744, failed=240
Jan 29 07:27:30.532: MGCP Packet received from 10.10.10.201:2427--->200 519806332
<---
Jan 29 07:27:30.532: //-1/xxxxxxxxxxxx/MGCP/mgcpapp_process_mgcp_msg(3534):[lvl=0] : <NEW MGCP MSG From CA>
Jan 29 07:27:30.532: //-1/xxxxxxxxxxxx/MGCP/mgcp_parse_packet(312):[lvl=0]call mgcp_parse_header
Jan 29 07:27:30.532: //-1/xxxxxxxxxxxx/MGCP/mgcp_parse_packet(316):[lvl=0]out mgcp_parse_header
Jan 29 07:27:30.532: //-1/xxxxxxxxxxxx/MGCP/mgcp_parse_packet(326):[lvl=1]SUCCESS: - MGCP Header parsing was OK
Jan 29 07:27:30.532: //-1/xxxxxxxxxxxx/MGCP/mgcp_parse_packet(344):[lvl=2]SUCCESS: - END of Parsing
Jan 29 07:27:30.532: //-1/xxxxxxxxxxxx/MGCP/mgcp_msg_ack(6876):[lvl=0]Entered
Jan 29 07:27:30.532: //-1/xxxxxxxxxxxx/MGCP/mgcp_count_active_mgc_msg_stat(239):[lvl=1]MGC stat - 10.10.10.201, total=24105, succ=23745, failed=240
Jan 29 07:27:30.532: //-1/xxxxxxxxxxxx/MGCP/mgcp_msg_ack(6948):[lvl=1]Removing msg : NTFY 519806332 *@CME_2901
MGCP 0.1
X: 0
O:
Jan 29 07:27:30.532: //-1/xxxxxxxxxxxx/MGCP/mgcpapp_process_socket(3645):[lvl=0]Entered
What will be the issue,
Your replay will be highly appreciated
