Re: replacing ATA190 with ATA191 and will not register

brian.koomen · ‎02-23-2024

Had to replace a couple ATA190 with ATA191 but running into a weird situation. The ATA191 are the enterprise version (ATA191-K9). We had one ATA191 that was showing the same behavior but for some unknown reason it ended up registering with CM.

We also have other ATA191 currently registered to CM, so I know that they do work in our environment.

The current ATA 191 (with firmware: 12-0-1-29) that we are having issue with does get an IP from the correct IP segment and the log file from the ATA191 shows it is hitting the correct TFTP server. We are able to get to the web interface of the ATA191 to check the log files but that is about it. Factory reset did not yield any results. I can plug another ATA191 (or Phone) on the same switch interface without any issue. So.... the interface configuration should not be an issue.

However, I am unable to decipher the rest of the log entries. Any help would be appreciated.

Feb 23 22:47:35 ATA191 local1.info Telephony: [prov_tftp_download: 680(tick=0x4da)]server address: 172.20.100.101
Feb 23 22:47:35 ATA191 local1.info Telephony: [prov_tftp_download: 697(tick=0x4da)]downloading cucm profile: [server: 172.20.100.101][port:69][file:ATABD9722654C01.cnf.xml]
Feb 23 22:47:35 ATA191 local1.info Telephony: [prov_tftp_download: 756(tick=0x4da)]download [ATABD9722654C01.cnf.xml] data len=0
Feb 23 22:47:35 ATA191 local1.info Telephony: [prov_tftp_download_buff: 851(tick=0x4da)]Download loads file [ATABD9722654C01.cnf.xml] fail!
Feb 23 22:47:35 ATA191 local1.info Telephony: [cucm_prov_dld_file: 653(tick=0x4da)]cret=-1752-
Feb 23 22:47:35 ATA191 local1.info Telephony: [cucm_prov_dld_file: 683(tick=0x4da)]Download file error, file not found, csta=3
Feb 23 22:47:35 ATA191 local1.info Telephony: [ctftp_active_next_addr: 513(tick=0x4da)] curr = 0, entcnt=2
Feb 23 22:47:35 ATA191 local1.info Telephony: [cucm_prov_dld_file: 709(tick=0x4da)]dld fail, csta=3, nsta======11-
Feb 23 22:47:35 ATA191 local1.info Telephony: [prov_tftp_download: 680(tick=0x4da)]server address: 172.20.100.100
Feb 23 22:47:35 ATA191 local1.info Telephony: [prov_tftp_download: 697(tick=0x4da)]downloading cucm profile: [server: 172.20.100.100][port:69][file:ATABD9722654C01.cnf.xml]
Feb 23 22:47:35 ATA191 local1.info Telephony: [prov_tftp_download: 756(tick=0x4da)]download [ATABD9722654C01.cnf.xml] data len=0
Feb 23 22:47:35 ATA191 local1.info Telephony: [prov_tftp_download_buff: 851(tick=0x4da)]Download loads file [ATABD9722654C01.cnf.xml] fail!
Feb 23 22:47:35 ATA191 local1.info Telephony: [cucm_prov_dld_file: 653(tick=0x4da)]cret=-1752-
Feb 23 22:47:35 ATA191 local1.info Telephony: [cucm_prov_dld_file: 683(tick=0x4da)]Download file error, file not found, csta=3
Feb 23 22:47:35 ATA191 local1.info Telephony: [ctftp_active_next_addr: 504(tick=0x4da)]The tftp addresses for this round is used out
Feb 23 22:47:35 ATA191 local1.info Telephony: [cucm_prov_dld_file: 707(tick=0x4da)]dld fail, nsta======4-
Feb 23 22:47:35 ATA191 local1.info Telephony: [cucm_prov_dld_file: 709(tick=0x4da)]dld fail, csta=3, nsta======4-
Feb 23 22:47:35 ATA191 local1.info Telephony: [cucm_prov_dld_file: 612(tick=0x4da)]--pfnm=XMLDefault.cnf.xml---nsta=4
Feb 23 22:47:35 ATA191 local1.info Telephony: [cucm_prov_dld_file: 614(tick=0x4da)]--ptab=0x1bdcb0--
Feb 23 22:47:35 ATA191 local1.info Telephony: [cucm_prov_dld_file: 629(tick=0x4da)]max_tries ====== 2
Feb 23 22:47:35 ATA191 local1.info Telephony: [ctftp_prepare_newsta_round: 540(tick=0x4da)] enter ...
Feb 23 22:47:35 ATA191 local1.info Telephony: [cucm_prov_dld_file: 632(tick=0x4da)]nsta === 4, tries === 1
Feb 23 22:47:35 ATA191 local1.info Telephony: [prov_tftp_download: 680(tick=0x4da)]server address: 172.20.100.100
Feb 23 22:47:35 ATA191 local1.info Telephony: [prov_tftp_download: 697(tick=0x4db)]downloading cucm profile: [server: 172.20.100.100][port:69][file:XMLDefault.cnf.xml]
Feb 23 22:47:35 ATA191 local1.info Telephony: [prov_tftp_download: 756(tick=0x4dc)]download [XMLDefault.cnf.xml] data len=15721
Feb 23 22:47:35 ATA191 local1.info Telephony: [prov_tftp_download: 766(tick=0x4dc)]download [XMLDefault.cnf.xml] OK!
Feb 23 22:47:35 ATA191 local1.info Telephony: [cucm_prov_dld_file: 653(tick=0x4dc)]cret=15721-
Feb 23 22:47:35 ATA191 local1.info Telephony: [prov_dld_cnf_def_ok: 1006(tick=0x4dc)]Download file [XMLDefault.cnf.xml] OK!
Feb 23 22:47:35 ATA191 local1.info Telephony: [prov_dld_cnf_def_ok: 1048(tick=0x4dc)]XMLDefault with auto reg disabled, not expected
Feb 23 22:47:35 ATA191 local1.info Telephony: [cucm_prov_dld_file: 668(tick=0x4dc)]dld success, nsta======0-
Feb 23 22:47:35 ATA191 local1.info Telephony: [cucm_prov_dld_file: 602(tick=0x4dc)]Download file process error, enter a invalide state, csta=4, retry???
Feb 23 22:47:35 ATA191 local1.info Telephony: [cucm_line_enable: 457(tick=0x4dc)]line=1, enable=0
Feb 23 22:47:35 ATA191 local1.info Telephony: [cucm_line_enable: 505(tick=0x4dc)]cucm_info.profile_ready[1] = 0
Feb 23 22:47:35 ATA191 local1.info Telephony: [cucm_prov_monitor: 323(tick=0x4dc)]line 1 profile is currently not valid
Feb 23 22:47:36 ATA191 local1.debug Telephony: SAFE_MON_main() ccTick:1178->1278, cc_init=1
Feb 23 22:47:37 ATA191 daemon.info Web[758]: Web URL /Log_Module.asp Session ID 03818907c98fe6a0bf2e84a0bad9d664
Feb 23 22:47:37 ATA191 daemon.err Web[758]: ignore
Feb 23 22:47:37 ATA191 daemon.err Web[758]: ignore
Feb 23 22:47:37 ATA191 daemon.err Web[758]: ignore
Feb 23 22:47:37 ATA191 daemon.err Web[758]: ignore
Feb 23 22:47:37 ATA191 daemon.err Web[758]: ignore
Feb 23 22:47:37 ATA191 daemon.err Web[758]: ignore
Feb 23 22:47:37 ATA191 daemon.err Web[758]: ignore

Maren Mahoney · ‎02-23-2024

When you say you replaced the units, you physically swapped out the ATAs I imagine. Did you also change the phone model in CUCM? Or build new phones with the correct phone model? CUCM registration is device-model-specific, so a ATA191 will not register to a device in CUCM listed as an ATA190 even if you put in the new MAC address.

If this is the case, there is a technique you can use to update the phone model in CUCM that I can share.

Maren

brian.koomen · ‎02-23-2024

Thanks for your reply....On the first ATA190 replacement, I did try just changing the MAC on the ATA190....Then figured that was the problem. So then copied a working/registered ATA191 and entered the MAC of the new ATA191 and changed the phone # tied to it.... Like I mentioned the 1st had the same entries in the log file even after changing the , as the 2nd one I am trying to replace, but somehow the first one ended up registering to the CM...

I would "assume" copying another ATA191 should work, right?

At this point, l will try deleting the config that is not registering and recopy a registered ATA191 (or start from scratch) and see what happens.

Nithin Eluvathingal · ‎02-24-2024

Have you checked the logs? They indicate a ‘Load file download failure.’ It appears that the ATAs (Analog Telephone Adapters) that are not functioning are unable to locate the file on the TFTP server that they are attempting to download

Feb 23 22:47:35 ATA191 local1.info Telephony: [prov_tftp_download_buff: 851(tick=0x4da)]Download loads file [ATABD9722654C01.cnf.xml] fail!
Feb 23 22:47:35 ATA191 local1.info Telephony: [cucm_prov_dld_file: 653(tick=0x4da)]cret=-1752-
Feb 23 22:47:35 ATA191 local1.info Telephony: [cucm_prov_dld_file: 683(tick=0x4da)]Download file error, file not found, csta=3

Maren Mahoney · ‎02-26-2024

@Nithin Eluvathingal That's what made me think of the model issue. The ATA is finding the TFTP server, but unable to download the file.

So, see if the file exists on the server: http://<ip.of.cucm.tftp.server>:6970/SEP<MACADDRESS>.cnf.xml

If it does not exists, but you know for a fact that the phone exists in CUCM do a "Save" in CUCM and then restart the Cisco Tftp Service on your TFTP server and try the phone again.

Maren