Troubleshooting guide

7-16
Cisco Broadband Local Integrated Services Solution Troubleshooting Guide
OL-5169-01
Chapter 7 Troubleshooting the CMTS
Troubleshooting the Cisco uBR7246VXR
Problems getting TOD (Time of Day) or Timing Offset would also result in the cable modem not
achieving online status:
3d21h: 338322.500 CMAC_LOG_STATE_CHANGE dhcp_state
3d21h: 338334.260 CMAC_LOG_RNG_REQ_TRANSMITTED
3d21h: 338334.260 CMAC_LOG_RNG_RSP_MSG_RCVD
3d21h: 338335.424 CMAC_LOG_DHCP_ASSIGNED_IP_ADDRESS 10.1.1.20
3d21h: 338335.424 CMAC_LOG_DHCP_TFTP_SERVER_ADDRESS 172.17.110.136
3d21h: 338335.424 CMAC_LOG_DHCP_ERROR_ACQUIRING_TOD_ADDRESS
3d21h: 338335.424 CMAC_LOG_DHCP_SET_GATEWAY_ADDRESS
3d21h: 338335.424 CMAC_LOG_DHCP_ERROR_ACQUIRING_TZ_OFFSET
3d21h: 338335.424 CMAC_LOG_DHCP_CONFIG_FILE_NAME platinum.cm
3d21h: 338335.428 CMAC_LOG_DHCP_ERROR_ACQUIRING_SEC_SVR_ADDR
3d21h: 338335.428 CMAC_LOG_DHCP_ERROR_ACQUIRING_LOG_ADDRESS
3d21h: 338335.428 CMAC_LOG_DHCP_COMPLETE
3d21h: 338335.428 CMAC_LOG_RESET_DHCP_FAILED
3d21h: 338335.432 CMAC_LOG_STATE_CHANGE reset_interface_state
3d21h: 338335.432 CMAC_LOG_STATE_CHANGE reset_hardware_state
3d21h: 338336.016 CMAC_LOG_STATE_CHANGE wait_for_link_up_state
Note: prior to IOS version 12.1(1) TOD needed to be specified in the DHCP server in order for the cable
modem to go online, however, after 12.1(1) TOD is not required but the cable modem still needs to get
the timing offset, as shown in the following debugs:
344374.528 CMAC_LOG_STATE_CHANGE dhcp_state
344377.292 CMAC_LOG_RNG_REQ_TRANSMITTED
344377.292 CMAC_LOG_RNG_RSP_MSG_RCVD
344387.412 CMAC_LOG_DHCP_ASSIGNED_IP_ADDRESS 10.1.1.20
344387.412 CMAC_LOG_DHCP_TFTP_SERVER_ADDRESS 172.17.110.136
NOTE— TOD server IP address obtained:
344387.412 CMAC_LOG_DHCP_TOD_SERVER_ADDRESS 172.17.110.136
344387.412 CMAC_LOG_DHCP_SET_GATEWAY_ADDRESS
NOTE— Timing offset not specified in DHCP server:
344387.412 CMAC_LOG_DHCP_ERROR_ACQUIRING_TZ_OFFSET
344387.412 CMAC_LOG_DHCP_CONFIG_FILE_NAME platinum.cm
344387.412 CMAC_LOG_DHCP_ERROR_ACQUIRING_SEC_SVR_ADDR
344387.412 CMAC_LOG_DHCP_ERROR_ACQUIRING_LOG_ADDRESS
344387.412 CMAC_LOG_DHCP_COMPLETE
344387.412 CMAC_LOG_RESET_DHCP_FAILED
NOTE—Modem resetting:
344387.412 CMAC_LOG_STATE_CHANGE reset_interface_state
In the debug below there is no time-server specified, but there is a timing offset configured in the DHCP
server, and therefore the cable modem goes online:
3d23h: 345297.516 CMAC_LOG_DHCP_ASSIGNED_IP_ADDRESS 10.1.1.20
3d23h: 345297.516 CMAC_LOG_DHCP_TFTP_SERVER_ADDRESS 172.17.110.136
3d23h: 345297.516 CMAC_LOG_DHCP_ERROR_ACQUIRING_TOD_ADDRESS
3d23h: 345297.516 CMAC_LOG_DHCP_SET_GATEWAY_ADDRESS
3d23h: 345297.516 CMAC_LOG_DHCP_TZ_OFFSET 0
3d23h: 345297.516 CMAC_LOG_DHCP_CONFIG_FILE_NAME platinum.cm
3d23h: 345297.520 CMAC_LOG_DHCP_ERROR_ACQUIRING_SEC_SVR_ADDR
3d23h: 345297.520 CMAC_LOG_DHCP_ERROR_ACQUIRING_LOG_ADDRESS
3d23h: 345297.520 CMAC_LOG_DHCP_COMPLETE
3d23h: 345297.532 CMAC_LOG_STATE_CHANGE establish_tod_state
3d23h: 345297.532 CMAC_LOG_TOD_NOT_REQUESTED_NO_TIME_ADDR
3d23h: 345297.532 CMAC_LOG_STATE_CHANGE security_association_state
3d23h: 345297.536 CMAC_LOG_SECURITY_BYPASSED
3d23h: 345297.536 CMAC_LOG_STATE_CHANGE configuration_file
3d23h: 345297.536 CMAC_LOG_LOADING_CONFIG_FILE platinum.cm
3d23h: 345297.568 CMAC_LOG_CONFIG_FILE_PROCESS_COMPLETE
3d23h: 345297.568 CMAC_LOG_STATE_CHANGE registration_state
3d23h: 345297.592 CMAC_LOG_REG_RSP_MSG_RCVD
3d23h: 345297.592 CMAC_LOG_COS_ASSIGNED_SID 1/7