01-04-2016 11:17 PM - edited 03-17-2019 05:24 AM
Hi folks,
we have multiple ATA190's (ver 1.2.1(004)) which we just bought for Analogue to IP conversion. CUCM is 9.1.2.11900-12.
The ATA190's fail to register to CUCM. I've attached the log file from the ATA and cnf.xml (renamed to .txt to bypass Cisco Forum policies) from CUCM.
Can anyone help us to understand why it's not working?
thanks
Dave
01-05-2016 12:13 AM
I brief glance of the ATA log file shows lines such as:
REGISTER Warning: 399 APDCPTC0003 \"Database error\"
and
SIP/2.0 401 Unauthorized
so I'd start by checking CUCM. e.g. Is Database replication OK? Does the device actually have a line associated with the device? Have you tried deleting and re-adding the ATA?
GTG
01-05-2016 05:57 PM
Hi Gordon,
replication seems to be fine...
System Reports
|
The device does have a line associated with it. Does it need a user also for authentication? I've tried adding both Digest user and Owner User Id to the device to no avail. I made the user ID the same as the DN. However there's nothing in any Cisco documentation that says a User ID is required, I was just taking a stab in the dark.
01-05-2016 06:01 PM
Yes I've also tried to delete the device then re-add.
This is the second ATA190 I've tried to add to CUCM.
01-05-2016 09:12 PM
Can you make sure that ATAs are added to CUCM with correct name (based on the port mac address)?
ATA 190 has two FXS ports, and each port has its MAC address. The first ATA 190 port uses the MAC address and the second ATA 190 port uses the shifted MAC address (example, AABBCCDDEEFF to BBCCDDEEFF01)
CUCM is sending error 404 not found which indicates that the named requested by ATA isn't configured in CUCM.
Also, you can use auto registration to register ATA ports with CUCM if you are interested
01-05-2016 11:13 PM
Hi Mohammed,
thanks for replying. Here's what is entered into CUCM...is that correct?
Product Type: Cisco ATA 190
Device Protocol: SIP
MAC Address 34DBFD1922A1
Description ATA34DBFD1922A1
And yes the secondary port ends with 01 however I've not enabled it. And the secondary port I don't think needs another device added, as when you add the ATA 190 in CUCM it has two lines for DN's. Please correct me if I'm wrong.
rgds
Dave
01-06-2016 01:46 AM
Hi Dave,
Try to enable auto register and see if ata registers.
FYI you need to add second device for second port
01-06-2016 05:54 PM
Hi Mohammed,
Will enabling auto-registration restart devices or cause any outages? this is on a production system.
I'm getting the warning from CUCM when I'm about to de-select "auto-registration disabled on this cisco unified communications manager"
Apply Configuration
thanks
Dave
01-06-2016 09:42 PM
Hi,
Try to do the change off hours. Also, you don't need to apply it. Just save it and repower the ATA. Finally, you need to enable auto-registration on two locations (CCM Group and CCM Server)
01-06-2016 09:51 PM
But will it cause an outage? If so I'll need to go through change control.
01-06-2016 11:00 PM
If you save without apply no outage. If you apply, it will reset all endpoints registered with CUCM Group.
I suggest to go through CR any way for precautions
01-07-2016 04:54 PM
Thanks Again Mohammed,
I've enabled auto-registration. However the ATA is still not registering. Here's the logs from the ATA...
I'm getting the error...
XMLDefault with auto reg disabled, not expected
Maybe I've not configured auto-registration properly ???
Jan 8 09:42:57 ATA190 daemon.debug sprvoip: [cucm_prov_dld_file: 543]--pfnm=CTLSEP34DBFD1922A1.tlv---nsta=1
Jan 8 09:42:57 ATA190 daemon.debug sprvoip: [cucm_prov_dld_file: 545]--ptab=0x165f70--
Jan 8 09:42:57 ATA190 daemon.debug sprvoip: [cucm_prov_dld_file: 560]max_tries ====== 2
Jan 8 09:42:57 ATA190 daemon.debug sprvoip: [ctftp_prepare_newsta_round: 283] enter ...
Jan 8 09:42:57 ATA190 daemon.debug sprvoip: [cucm_prov_dld_file: 563]nsta === 1, tries === 1
Jan 8 09:42:57 ATA190 daemon.debug sprvoip: [cucm_prov_dld_file: 580]--fname=/tmp/CTLSEP34DBFD1922A1.tlv--
Jan 8 09:42:57 ATA190 daemon.debug sprvoip: [prov_tftp_download: 407]downloading cucm profile: [server: e01600a][port:69][file:CTLSEP34DBFD1922A1.tlv]
Jan 8 09:42:57 ATA190 daemon.debug sprvoip: [prov_tftp_download: 466]download [CTLSEP34DBFD1922A1.tlv] data len=0
Jan 8 09:42:57 ATA190 daemon.debug sprvoip: [prov_tftp_download_file: 520]Download loads file [CTLSEP34DBFD1922A1.tlv] fail !!
Jan 8 09:42:57 ATA190 daemon.debug sprvoip: [cucm_prov_dld_file: 584]cret=-1752-
Jan 8 09:42:57 ATA190 daemon.debug sprvoip: [cucm_prov_dld_file: 614]Download file error, file not found, csta=1
Jan 8 09:42:57 ATA190 daemon.debug sprvoip: [ctftp_active_next_addr: 247]The tftp addresses for this round is used out
Jan 8 09:42:57 ATA190 daemon.debug sprvoip: <159>[prov_dld_ctl_fail: 713]Download [CTLSEP34DBFD1922A1.tlv] FAIL, File Not Found!
Jan 8 09:42:57 ATA190 daemon.debug sprvoip: [cucm_prov_dld_file: 638]dld fail, nsta======2-
Jan 8 09:42:57 ATA190 daemon.debug sprvoip: [cucm_prov_dld_file: 640]dld fail, csta=1, nsta======2-
Jan 8 09:42:57 ATA190 daemon.debug sprvoip: [cucm_prov_dld_file: 543]--pfnm=ATA34DBFD1922A1.cnf.xml---nsta=2
Jan 8 09:42:57 ATA190 daemon.debug sprvoip: [cucm_prov_dld_file: 545]--ptab=0x165f84--
Jan 8 09:42:57 ATA190 daemon.debug sprvoip: [cucm_prov_dld_file: 560]max_tries ====== 2
Jan 8 09:42:57 ATA190 daemon.debug sprvoip: [ctftp_prepare_newsta_round: 283] enter ...
Jan 8 09:42:57 ATA190 daemon.debug sprvoip: [cucm_prov_dld_file: 563]nsta === 2, tries === 1
Jan 8 09:42:57 ATA190 daemon.debug sprvoip: [prov_tftp_download: 407]downloading cucm profile: [server: e01600a][port:69][file:ATA34DBFD1922A1.cnf.xml]
Jan 8 09:42:57 ATA190 daemon.debug sprvoip: [prov_tftp_download: 466]download [ATA34DBFD1922A1.cnf.xml] data len=0
Jan 8 09:42:57 ATA190 daemon.debug sprvoip: [prov_tftp_download_buff: 553]Download loads file [ATA34DBFD1922A1.cnf.xml] fail!
Jan 8 09:42:57 ATA190 daemon.debug sprvoip: [cucm_prov_dld_file: 584]cret=-1752-
Jan 8 09:42:57 ATA190 daemon.debug sprvoip: [cucm_prov_dld_file: 614]Download file error, file not found, csta=2
Jan 8 09:42:57 ATA190 daemon.debug sprvoip: [ctftp_active_next_addr: 247]The tftp addresses for this round is used out
Jan 8 09:42:57 ATA190 daemon.debug sprvoip: [cucm_prov_dld_file: 638]dld fail, nsta======3-
Jan 8 09:42:57 ATA190 daemon.debug sprvoip: [cucm_prov_dld_file: 640]dld fail, csta=2, nsta======3-
Jan 8 09:42:57 ATA190 daemon.debug sprvoip: [cucm_prov_dld_file: 543]--pfnm=XMLDefault.cnf.xml---nsta=3
Jan 8 09:42:57 ATA190 daemon.debug sprvoip: [cucm_prov_dld_file: 545]--ptab=0x165f98--
Jan 8 09:42:57 ATA190 daemon.debug sprvoip: [cucm_prov_dld_file: 560]max_tries ====== 2
Jan 8 09:42:57 ATA190 daemon.debug sprvoip: [ctftp_prepare_newsta_round: 283] enter ...
Jan 8 09:42:57 ATA190 daemon.debug sprvoip: [cucm_prov_dld_file: 563]nsta === 3, tries === 1
Jan 8 09:42:57 ATA190 daemon.debug sprvoip: [prov_tftp_download: 407]downloading cucm profile: [server: e01600a][port:69][file:XMLDefault.cnf.xml]
Jan 8 09:42:59 ATA190 daemon.debug sprvoip: [prov_tftp_download: 466]download [XMLDefault.cnf.xml] data len=9856
Jan 8 09:42:59 ATA190 daemon.debug sprvoip: [prov_tftp_download: 476]download [XMLDefault.cnf.xml] OK!
Jan 8 09:42:59 ATA190 daemon.debug sprvoip: [cucm_prov_dld_file: 584]cret=9856-
Jan 8 09:42:59 ATA190 daemon.debug sprvoip: <159>[prov_dld_cnf_def_ok: 847]Download file [XMLDefault.cnf.xml] OK!
Jan 8 09:42:59 ATA190 daemon.debug sprvoip: <159>[prov_dld_cnf_def_ok: 889]XMLDefault with auto reg disabled, not expected
Jan 8 09:42:59 ATA190 daemon.debug sprvoip: [cucm_prov_dld_file: 599]dld success, nsta======0-
Jan 8 09:42:59 ATA190 daemon.debug sprvoip: [cucm_prov_dld_file: 533]Download file process error, enter a invalide state, csta=3, retry???
Jan 8 09:42:59 ATA190 daemon.debug sprvoip: <159>[cucm_line_enable: 346]line=0, enable=0
Jan 8 09:42:59 ATA190 daemon.debug sprvoip: [cucm_line_enable: 394]cucm_info.profile_ready[0] = 0
Jan 8 09:42:59 ATA190 daemon.debug sprvoip: <159>[cucm_prov_monitor: 304]line 0 profile is currently not valid
Jan 8 09:43:04 ATA190 daemon.debug sprvoip: <159>[cucm_prov_monitor: 304]line 1 profile is currently not valid
Jan 8 09:43:10 ATA190 daemon.debug sprvoip: [cucm_prov_dld_file: 543]--pfnm=CTLSEP34DBFD1922A1.tlv---nsta=1
Jan 8 09:43:10 ATA190 daemon.debug sprvoip: [cucm_prov_dld_file: 545]--ptab=0x165f70--
Jan 8 09:43:10 ATA190 daemon.debug sprvoip: [cucm_prov_dld_file: 560]max_tries ====== 2
Jan 8 09:43:10 ATA190 daemon.debug sprvoip: [ctftp_prepare_newsta_round: 283] enter ...
Jan 8 09:43:10 ATA190 daemon.debug sprvoip: [cucm_prov_dld_file: 563]nsta === 1, tries === 1
Jan 8 09:43:10 ATA190 daemon.debug sprvoip: [cucm_prov_dld_file: 580]--fname=/tmp/CTLSEP34DBFD1922A1.tlv--
Jan 8 09:43:10 ATA190 daemon.debug sprvoip: [prov_tftp_download: 407]downloading cucm profile: [server: e01600a][port:69][file:CTLSEP34DBFD1922A1.tlv]
Jan 8 09:43:10 ATA190 daemon.debug sprvoip: [prov_tftp_download: 466]download [CTLSEP34DBFD1922A1.tlv] data len=0
Jan 8 09:43:10 ATA190 daemon.debug sprvoip: [prov_tftp_download_file: 520]Download loads file [CTLSEP34DBFD1922A1.tlv] fail !!
Jan 8 09:43:10 ATA190 daemon.debug sprvoip: [cucm_prov_dld_file: 584]cret=-1752-
Jan 8 09:43:10 ATA190 daemon.debug sprvoip: [cucm_prov_dld_file: 614]Download file error, file not found, csta=1
Jan 8 09:43:10 ATA190 daemon.debug sprvoip: [ctftp_active_next_addr: 247]The tftp addresses for this round is used out
Jan 8 09:43:10 ATA190 daemon.debug sprvoip: <159>[prov_dld_ctl_fail: 713]Download [CTLSEP34DBFD1922A1.tlv] FAIL, File Not Found!
Jan 8 09:43:10 ATA190 daemon.debug sprvoip: [cucm_prov_dld_file: 638]dld fail, nsta======2-
Jan 8 09:43:10 ATA190 daemon.debug sprvoip: [cucm_prov_dld_file: 640]dld fail, csta=1, nsta======2-
Jan 8 09:43:10 ATA190 daemon.debug sprvoip: [cucm_prov_dld_file: 543]--pfnm=ATA34DBFD1922A1.cnf.xml---nsta=2
Jan 8 09:43:10 ATA190 daemon.debug sprvoip: [cucm_prov_dld_file: 545]--ptab=0x165f84--
Jan 8 09:43:10 ATA190 daemon.debug sprvoip: [cucm_prov_dld_file: 560]max_tries ====== 2
Jan 8 09:43:10 ATA190 daemon.debug sprvoip: [ctftp_prepare_newsta_round: 283] enter ...
Jan 8 09:43:10 ATA190 daemon.debug sprvoip: [cucm_prov_dld_file: 563]nsta === 2, tries === 1
Jan 8 09:43:10 ATA190 daemon.debug sprvoip: [prov_tftp_download: 407]downloading cucm profile: [server: e01600a][port:69][file:ATA34DBFD1922A1.cnf.xml]
Jan 8 09:43:10 ATA190 daemon.debug sprvoip: [prov_tftp_download: 466]download [ATA34DBFD1922A1.cnf.xml] data len=0
Jan 8 09:43:10 ATA190 daemon.debug sprvoip: [prov_tftp_download_buff: 553]Download loads file [ATA34DBFD1922A1.cnf.xml] fail!
Jan 8 09:43:10 ATA190 daemon.debug sprvoip: [cucm_prov_dld_file: 584]cret=-1752-
Jan 8 09:43:10 ATA190 daemon.debug sprvoip: [cucm_prov_dld_file: 614]Download file error, file not found, csta=2
Jan 8 09:43:10 ATA190 daemon.debug sprvoip: [ctftp_active_next_addr: 247]The tftp addresses for this round is used out
Jan 8 09:43:10 ATA190 daemon.debug sprvoip: [cucm_prov_dld_file: 638]dld fail, nsta======3-
Jan 8 09:43:10 ATA190 daemon.debug sprvoip: [cucm_prov_dld_file: 640]dld fail, csta=2, nsta======3-
Jan 8 09:43:10 ATA190 daemon.debug sprvoip: [cucm_prov_dld_file: 543]--pfnm=XMLDefault.cnf.xml---nsta=3
Jan 8 09:43:10 ATA190 daemon.debug sprvoip: [cucm_prov_dld_file: 545]--ptab=0x165f98--
Jan 8 09:43:10 ATA190 daemon.debug sprvoip: [cucm_prov_dld_file: 560]max_tries ====== 2
Jan 8 09:43:10 ATA190 daemon.debug sprvoip: [ctftp_prepare_newsta_round: 283] enter ...
Jan 8 09:43:10 ATA190 daemon.debug sprvoip: [cucm_prov_dld_file: 563]nsta === 3, tries === 1
Jan 8 09:43:10 ATA190 daemon.debug sprvoip: [prov_tftp_download: 407]downloading cucm profile: [server: e01600a][port:69][file:XMLDefault.cnf.xml]
Jan 8 09:43:14 ATA190 daemon.debug sprvoip: [prov_tftp_download: 466]download [XMLDefault.cnf.xml] data len=9856
Jan 8 09:43:14 ATA190 daemon.debug sprvoip: [prov_tftp_download: 476]download [XMLDefault.cnf.xml] OK!
Jan 8 09:43:14 ATA190 daemon.debug sprvoip: [cucm_prov_dld_file: 584]cret=9856-
Jan 8 09:43:14 ATA190 daemon.debug sprvoip: <159>[prov_dld_cnf_def_ok: 847]Download file [XMLDefault.cnf.xml] OK!
Jan 8 09:43:14 ATA190 daemon.debug sprvoip: <159>[prov_dld_cnf_def_ok: 889]XMLDefault with auto reg disabled, not expected
Jan 8 09:43:14 ATA190 daemon.debug sprvoip: [cucm_prov_dld_file: 599]dld success, nsta======0-
Jan 8 09:43:14 ATA190 daemon.debug sprvoip: [cucm_prov_dld_file: 533]Download file process error, enter a invalide state, csta=3, retry???
Jan 8 09:43:14 ATA190 daemon.debug sprvoip: <159>[cucm_line_enable: 346]line=0, enable=0
Jan 8 09:43:14 ATA190 daemon.debug sprvoip: [cucm_line_enable: 394]cucm_info.profile_ready[0] = 0
Jan 8 09:43:14 ATA190 daemon.debug sprvoip: <159>[cucm_prov_monitor: 304]line 0 profile is currently not valid
Jan 8 09:43:19 ATA190 daemon.debug sprvoip: <159>[cucm_prov_monitor: 304]line 1 profile is currently not valid
01-08-2016 03:23 AM
Hi,
Navigate to System > CUCM Group > #Select your CCM-GRP# > Check the box 'Auto-registration Cisco Unified Communications Manager Group'
Navigate to System > Cisco Unified CM > #Select Each Server in the GRP# > Uncheck 'Auto-registration Disabled on this Cisco Unified Communications Manager'. Also, configure start and end DNs
Discover and save your favorite ideas. Come back to expert answers, step-by-step guides, recent topics, and more.
New here? Get started with these tips. How to use Community New member guide