02-28-2020 02:57 PM
phones 7821,7841 when connected in ports in Data Vlan still able to register with the cucm ver 11.5 ip 172.16.50.3 .data vlan DHCP is on with Network id 172.16.10.0/24 ,no option 150 configured and routing between vlans is enabled.why phones registered and how to prevent the registration when data vlan? attached console log of phones
1308 INF Feb 27 15:02:01.137921 (452:459) rlogcoll-rlogcoll_setLogProfile() over
1309 NOT Feb 27 15:02:01.138806 (349:381) CDP-cdpSetSwportCfgRemote: Value Sent to IOCTL LOCAL[0] 1 1
1310 NOT Feb 27 15:02:01.142316 (318:318) PAE: -paeNetsdRcvMsg(318): LINK change: status: 0x0 : Network is down
1311 NOT Feb 27 15:02:01.143781 (538:585) JAVA-Calling handleNetSDEvent
1312 NOT Feb 27 15:02:01.146467 (538:898) JAVA-configmgr MQThread|cip.cfg.TimeDateProperty:? - setTimeZone tz:Africa/Cairo ctz:Africa/Cairo
1313 NOT Feb 27 15:02:01.145826 (349:381) CDP-cdpSetPcportCfgRemote 7
1314 NOT Feb 27 15:02:01.161422 (538:898) JAVA-configmgr MQThread|cip.cfg.SipConfig:? - customerUUID is
1315 NOT Feb 27 15:02:01.162063 (538:898) JAVA-configmgr MQThread|cip.cfg.SipConfig: - Entering setProtocolConfigProperties() at 1582808521161 millisecs....<RemoveItLater>
1316 NOT Feb 27 15:02:01.211902 (349:381) CDP-cprSetPortCfg port:1:1 ret:0
1317 NOT Feb 27 15:02:01.219746 (349:381) CDP-cdpSetPcportCfgRemote Value Sent to IOCTL LOCAL[0] 1 1
1318 NOT Feb 27 15:02:01.327971 (538:898) JAVA-configmgr MQThread|cip.cfg.SipConfig:? - embrace feature hack, update line 1, featureId = 9, name = 4015
1319 NOT Feb 27 15:02:01.338074 (336:358) vieo-TCPIF PCPORT Link Change, but no status change
1320 NOT Feb 27 15:02:01.365634 (538:898) JAVA-configmgr MQThread|cip.cfg.SipConfig: - Exiting setProtocolConfigProperties() at 1582808521365 millisecs....<RemoveItLater>
1321 NOT Feb 27 15:02:01.434304 (538:898) JAVA-configmgr MQThread|cip.cfg.Config: - CUCM in config file: #0 XmlCallAgentObject: IPv4-name=[172.16.50.3] IPv6-name=[] ethernetPhonePort=2000 sipPort=5060 securedSipPort=5061 priority=0
1322 NOT Feb 27 15:02:01.447276 (538:898) JAVA-configmgr MQThread|cip.cfg.Config: - CUCM in config file: #1 XmlCallAgentObject: IPv4-name=[] IPv6-name=[] ethernetPhonePort=0 sipPort=0 securedSipPort=0 priority=32767
1323 NOT Feb 27 15:02:01.448802 (538:898) JAVA-configmgr MQThread|cip.cfg.Config: - CUCM in config file: #2 XmlCallAgentObject: IPv4-name=[] IPv6-name=[] ethernetPhonePort=0 sipPort=0 securedSipPort=0 priority=32767
1324 NOT Feb 27 15:02:01.450907 (538:898) JAVA-configmgr MQThread|cip.cfg.Config: - CUCM in config file: #3 XmlCallAgentObject: IPv4-name=[] IPv6-name=[] ethernetPhonePort=0 sipPort=0 securedSipPort=0 priority=32767
1325 NOT Feb 27 15:02:01.452372 (538:898) JAVA-configmgr MQThread|cip.cfg.Config: - CUCM in config file: #4 XmlCallAgentObject: IPv4-name=[] IPv6-name=[] ethernetPhonePort=0 sipPort=0 securedSipPort=0 priority=32767
1326 NOT Feb 27 15:02:01.568228 (336:358) vieo-TCPIF PCPORT Link Change, but no status change
1327 WRN Feb 27 15:02:01.622798 (314:1610) SECUREAPP-SEC_CAPF_N_IN_USE: CAPF not in use, user cancel ignored
1328 NOT Feb 27 15:02:01.673340 (538:898) JAVA-configmgr MQThread|cip.sec.CapfProperty:? - CapfProp 96
1329 NOT Feb 27 15:02:01.677887 (318:318) PAE: -paeNetsdRcvMsg(318): LINK change: status: 0x0 : Network is down
1330 ERR Feb 27 15:02:01.827712 (538:898) JAVA-configmgr MQThread|cip.cfg.SipConfig:? - processConfigNoError: no config file in RAM, not to store to flash
1331 NOT Feb 27 15:02:01.828994 (538:898) JAVA-configmgr MQThread|cip.cfg.Config: - [processConfigObject] result:0,isConfigFromFlash:true
1332 NOT Feb 27 15:02:01.829665 (538:898) JAVA-configmgr MQThread|cip.cfg.Config: - Sending update notice to Metmand
1333 NOT Feb 27 15:02:01.834426 (538:898) JAVA-configmgr MQThread|cip.cfg.Config: - Sending update notice to Metmand - COMPLETE
1334 NOT Feb 27 15:02:01.835495 (538:898) JAVA-configmgr MQThread|cip.sipcc.SipCcAdapter$CcMgmtListener: - mgmtState=MGMT_INITIALIZING(1)
1335 ERR Feb 27 15:02:01.857347 (532:532) metmand-getMetricReportString INVALID metric report type requested
1336 NOT Feb 27 15:02:01.910300 (538:898) JAVA-configmgr MQThread|cip.cfg.Config: - [SipConfig] register() => ipmode: 0(IPv4 Only), ipv4-stack-state: 1(DHCP BOUND), ipv6-stack-state: 199(IPV6 STACK TURNED OFF), ipv4@: 172.16.10.37, ipv6@: ::, ipaddress-valid?true
1337 NOT Feb 27 15:02:01.911307 (538:898) JAVA-configmgr MQThread|cip.cfg.Config: - [SipConfig] commiting CM_CHANGED property, current value:false
1338 NOT Feb 27 15:02:01.912467 (538:889) JAVA-System P7-display MQThread|cip.sipcc.SipCcAdapter: - propertyChanged(): device.settings.config.callmanager.changed
1339 NOT Feb 27 15:02:01.915214 (538:889) JAVA-System P7-display MQThread|cip.sipcc.SipCcAdapter: - [addCcmsToCAgentList] [0] ipmode: IPv4 Only, cmIPv4Name:"172.16.50.3", cmIPv6Name:"", cmIPv4@: , cmIPv6@: , cmPort: 5060, cmSecurePort: 5061
1340 NOT Feb 27 15:02:01.968808 (538:889) JAVA-System P7-display MQThread|cip.sipcc.SipCcAdapter: - cm.namev4="172.16.50.3",cm.namev6="",cm.ipv4=,cm.ipv6=,port=5060,is.valid=true,security-level=0
1341 NOT Feb 27 15:02:01.970090 (538:889) JAVA-System P7-display MQThread|cip.sipcc.SipCcAdapter: - [addCcmsToCAgentList] [1] ipmode: IPv4 Only, cmIPv4Name:"", cmIPv6Name:"", cmIPv4@: , cmIPv6@: , cmPort: 0, cmSecurePort: 0
1342 NOT Feb 27 15:02:01.970914 (538:889) JAVA-System P7-display MQThread|cip.sipcc.SipCcAdapter: - [addCcmsToCAgentList] [2] ipmode: IPv4 Only, cmIPv4Name:"", cmIPv6Name:"", cmIPv4@: , cmIPv6@: , cmPort: 0, cmSecurePort: 0
1343 NOT Feb 27 15:02:01.971524 (538:889) JAVA-System P7-display MQThread|cip.sipcc.SipCcAdapter: - [addTftpToCAgentList] tftpv4: , tftpv6: ::, secure-mode: Non Secure, ipmode:IPv4 Only
1344 NOT Feb 27 15:02:01.975034 (538:889) JAVA-System P7-display MQThread|cip.sipcc.SipCcAdapter$CcMgmtListener: - cfgDlndDone(): mgmt_state=1config-fetch-requested?true
1345 NOT Feb 27 15:02:01.976224 (538:889) JAVA-System P7-display MQThread|cip.sipcc.SipCcAdapter: - downloadADRFile(): bluetooth not supported.
1346 NOT Feb 27 15:02:01.979490 (302:302) downd-DDFORK - execing [/usr/sbin/dgetfile][-L620][ ]
1347 NOT Feb 27 15:02:01.982389 (538:889) JAVA-System P7-display MQThread|cip.sipcc.SipCcAdapter: - propertyChanged(): device.settings.config.callmanager.changed
1348 NOT Feb 27 15:02:02.340790 (1616:1616) dgetfile-GETXXTP [GT1616][src=SK72f64050-7ad5-4b47-9bfa-5e9ad9cd4aa9.xml][dest=/tmp/cache/SK-727818856][serv=][serv6=][sec=2]
1349 NOT Feb 27 15:02:02.343873 (1616:1616) dgetfile-In normal mode, call - > makeXXTPrequest (V6...)
1350 NOT Feb 27 15:02:02.347199 (1616:1616) dgetfile-EMCC mode is false
1351 NOT Feb 27 15:02:02.411536 (1616:1616) dgetfile-parseDhcpInfoIntoTftpList(): no valid load server
1352 WRN Feb 27 15:02:02.411750 (1616:1616) dgetfile-XXTP wired servers not configured - file not requested
1353 NOT Feb 27 15:02:02.523332 (1616:1616) dgetfile-DDGETTFTP.RESULT [_17_ Don't have a server
]
1354 NOT Feb 27 15:02:02.533648 (302:302) downd-SOCKET accept errno=4 "Interrupted system call"
1355 NOT Feb 27 15:02:02.537646 (538:585) JAVA-Thread-0|cip.setg.IpStacksStateProperty:? - IpStacksStateProperty changed from "IPv4-stack-state:1 (DHCP BOUND), IPv6-stack-state:199 (IPV6 STACK TURNED OFF)" to "IPv4-stack-state:1 (DHCP BOUND), IPv6-stack-state:199 (IPV6 STACK TURNED OFF)"
1356 NOT Feb 27 15:02:02.538501 (538:585) JAVA-Calling handleNetSDEvent
1357 NOT Feb 27 15:02:02.836136 (538:898) JAVA-configmgr MQThread|ConfigManager:? - --->ConfigManager PropertyChanged: device.config.io.dscp.config
1358 ERR Feb 27 15:02:02.843369 (538:889) JAVA-System P7-display MQThread|cip.sipcc.FeatureKeyHandler: - Error in downloading softkey file errorCode=16
1359 NOT Feb 27 15:02:02.845231 (538:889) JAVA-System P7-display MQThread|cip.sipcc.SipCcAdapter: - skDnldDone():mgmtState=MGMT_INITIALIZING(1)nativeInit=true,configFileTftpTimeout:false
1360 WRN Feb 27 15:02:02.846635 (538:889) JAVA-System P7-display MQThread|cip.cfg.SipConfig:? - waitingForConfigFile: configFileRequestPending=true, configFileAvailableInRam = false
1361 WRN Feb 27 15:02:02.847489 (538:889) JAVA-System P7-display MQThread|cip.cfg.SipConfig:? - waitingForConfigFile: looking for file=/usr/local/flash0/sip-SEP005F869051F9.cnf.xml
1362 WRN Feb 27 15:02:02.848435 (538:889) JAVA-System P7-display MQThread|cip.cfg.SipConfig:? - waitingForConfigFile: notify sipcc using config-file in flash
1363 NOT Feb 27 15:02:02.849381 (538:889) JAVA-System P7-display MQThread|cip.cfg.SipConfig:? - generateConfigFetchResponse called...configFileAvailable=false configFileRequestPending=true
1364 NOT Feb 27 15:02:02.852037 (538:889) JAVA-System P7-display MQThread|cip.cfg.SipConfig:? - generateConfigFetchResponse: looking for file=/usr/local/flash0/sip-SEP005F869051F9.cnf.xml
1365 NOT Feb 27 15:02:02.852830 (538:889) JAVA-System P7-display MQThread|cip.cfg.SipConfig:? - generateConfigFetchResponse: configFilename= /usr/local/flash0/sip-SEP005F869051F9.cnf.xml
1366 NOT Feb 27 15:02:02.854570 (538:898) JAVA-configmgr MQThread|ConfigManager:? - <---ConfigManager PropertyChanged: device.config.io.dscp.config
1367 NOT Feb 27 15:02:02.855608 (538:889) JAVA-System P7-display MQThread|cip.cfg.SipConfig:? - syncHFUOnOffInfoToSIP, supportBtHFP: false user_enabled_bt:false, admin_enabled_bt:false, user_enabled_hfu:true, admin_enabled_hfu:true
1368 NOT Feb 27 15:02:02.856401 (538:889) JAVA-SIPCC-CC_API: CCAPI_Device_UserEnableHFU: user enabled hfu: 0
1369 NOT Feb 27 15:02:02.876789 (538:585) JAVA-Thread-0|cip.setg.IpStacksStateProperty:? - IpStacksStateProperty changed from "IPv4-stack-state:1 (DHCP BOUND), IPv6-stack-state:199 (IPV6 STACK TURNED OFF)" to "IPv4-stack-state:1 (DHCP BOUND), IPv6-stack-state:199 (IPV6 STACK TURNED OFF)"
1370 NOT Feb 27 15:02:02.889943 (538:889) JAVA-SIPCC-CC_API: CCAPI_Config_response: from_memory:0, received new cfg file sz:45, previous cfg file sz:0, current g_cfg_p buf sz:257
1371 NOT Feb 27 15:02:02.890187 (538:889) JAVA-SIPCC-CC_API: CCAPI_Config_response: Phone not registered. do parse and register.
1372 NOT Feb 27 15:02:02.892263 (538:889) JAVA-CFG : config_parser_main : Starting config file parse.
1373 ERR Feb 27 15:02:02.892659 (538:889) JAVA-CFG : config_set_value : natAddress size error entry size=48, len=4
1374 NOT Feb 27 15:02:02.893544 (538:889) JAVA-SIPCC-CC_API: preConfigParse: HFU feature disabled.
1375 NOT Feb 27 15:02:02.918022 (302:302) downd-DDFORK - execing [/usr/sbin/dgetserver][-L60][ ]
1376 NOT Feb 27 15:02:03.026430 (1638:1638) dgetserver-parseDhcpInfoIntoTftpList(): no valid load server
1377 NOT Feb 27 15:02:03.027346 (1638:1638) dgetserver-GETSRVR [ip=] resolved.
1378 NOT Feb 27 15:02:03.028750 (302:302) downd-DDFORK - execing [/usr/sbin/dgetserver][-L60][ ]
1379 NOT Feb 27 15:02:03.140607 (1638:1638) dgetserver-dgetserver.RESULT [_0_ [PASS] No error
]
1380 NOT Feb 27 15:02:03.153578 (302:302) downd-SOCKET accept errno=4 "Interrupted system call"
1381 NOT Feb 27 15:02:03.175614 (1644:1644) dgetserver-parseDhcpInfoIntoTftpList(): no valid load server
1382 NOT Feb 27 15:02:03.176438 (1644:1644) dgetserver-GETSRVR [ip=] resolved.
1383 ERR Feb 27 15:02:03.177506 (538:889) JAVA-CFG : config_process_ccm_properties : No valid IPv4 TFTP server configured
1384 NOT Feb 27 15:02:03.178086 (538:889) JAVA-ccm0=172.16.50.3 ccm1= ccm2= sip_port_0=5060 sip_port_1=5060 sip_port_2=5060 length=0
1385 NOT Feb 27 15:02:03.178238 (538:889) JAVA-ccm0=172.16.50.3 ccm1= ccm2= sec_sip_port_0=5061 sec_sip_port_1=5061 sec_sip_port_2=5061 length=0
1386 NOT Feb 27 15:02:03.179063 (538:889) JAVA-ccm0_v6= ccm1_v6= ccm2_v6= lenght=0
1387 NOT Feb 27 15:02:03.179185 (538:889) JAVA-device ip_mode is IPv4
1388 NOT Feb 27 15:02:03.180741 (538:889) JAVA-config_process_ccm_properties: is in Edge mode = FALSE
1389 NOT Feb 27 15:02:03.185899 (538:889) JAVA-CFG : config_set_srst_properties : SRST is not configured.
1390 NOT Feb 27 15:02:03.189043 (538:889) JAVA-CFG : update_sipline_properties : lineMode:0
1391 NOT Feb 27 15:02:03.189500 (538:889) JAVA-CFG : update_sipline_properties : HFU feature is disabled.
1392 NOT Feb 27 15:02:03.193224 (538:889) JAVA-CFG : config_parse_element : versionStamp new=1572178795-d0d420a2-3c7e-47b3-902b-a84aeff8b1cd old=
1393 NOT Feb 27 15:02:03.198718 (538:889) JAVA-CFG : compare_or_set_multi_level_config_value : compare_or_set: CONFIG_PARSER_APPLY
1394 NOT Feb 27 15:02:03.199206 (538:889) JAVA-CFG : config_parser_main : Release memory for xml doc.
1395 ERR Feb 27 15:02:03.201831 (538:889) JAVA-CFG : config_set_string : Parse function failed. ID: 104 myIpv6Addr:
1396 NOT Feb 27 15:02:03.207172 (538:889) JAVA-CFG : postConfigParse : Set CFG: dev_name:SEP005F869051F9 signaling_ip:172.16.10.37 signaling_ipv6: media_ip:172.16.10.37
1397 NOT Feb 27 15:02:03.207660 (538:889) JAVA-CFG : postConfigParse : old CFG: timer_register_expires:0, timer_invite_expires:0, timer_t1:0, voip_control_port:0
1398 NOT Feb 27 15:02:03.208179 (538:889) JAVA-CFG : postConfigParse : Set CFG: dev_name:SEP005F869051F9 signaling_ip:172.16.10.37 media_ip:172.16.10.37
1399 NOT Feb 27 15:02:03.209430 (538:889) JAVA-MED : cc_media_update_video_cap : updating device video capability from [1] to [0]
1400 NOT Feb 27 15:02:03.210834 (538:889) JAVA-MED : updatePresentationCapTblValues : enter...
1401 NOT Feb 27 15:02:03.211262 (538:889) JAVA-MED : updatePresentationCapTblValues : orig gcap[1,0,0,0]
1402 NOT Feb 27 15:02:03.211719 (538:889) JAVA-MED : updatePresentationCapTblValues : new gcap[1,0,0,0]
1403 NOT Feb 27 15:02:03.212177 (538:889) JAVA-MED : updateFeccCapTblValues : enter...
1404 NOT Feb 27 15:02:03.212635 (538:889) JAVA-MED : updateFeccCapTblValues : orig gcap[0]
1405 NOT Feb 27 15:02:03.213093 (538:889) JAVA-MED : updateFeccCapTblValues : new gcap[0]
1406 NOT Feb 27 15:02:03.213612 (538:889) JAVA-MED : updateVidCapTbl : video capability disabled
1407 NOT Feb 27 15:02:03.214802 (336:358) vieo-TCPIF stopVieoServer
1408 NOT Feb 27 15:02:03.220265 (538:915) JAVA-SIPCC-SIP_EVT: SIPTaskProcessListEvent: !!!sip_taskInited is false. So not executing cmd=0x55
1409 NOT Feb 27 15:02:03.224752 (538:889) JAVA-CFG : config_parser_main : Completed config file parse. rtn_result:[2]
1410 NOT Feb 27 15:02:03.227193 (538:914) JAVA-SIPCC-SIP_CC_PROV: ccsnap_gen_deviceEvent: event type : CONFIG_CHANGED
1411 NOT Feb 27 15:02:03.228322 (538:914) JAVA-Thread-5|cip.sipcc.SipCcAdapter$CcMgmtListener:? - ccReady called...mgmtState=MGMT_INITIALIZING(1), deviceEvent:0, nativeSideInitialized:true
1412 NOT Feb 27 15:02:03.229391 (538:914) JAVA-Thread-5|cip.sipcc.SipCcAdapter$CcMgmtListener:? - ccReady: oldccMode=-1 newccMode=0
1413 NOT Feb 27 15:02:03.231954 (538:914) JAVA-Thread-5|cip.sipcc.SipCcAdapter$CcMgmtListener:? - initializeLinePlane called...
1414 NOT Feb 27 15:02:03.240439 (538:889) JAVA-SIPCC-CC_API: CCAPI_Config_response: send event EV_CC_CONFIG_RECEIVED successfully
1415 NOT Feb 27 15:02:03.243277 (538:914) JAVA-Thread-5|cip.sipcc.SipCcAdapter$CcMgmtListener: - initializeLinePlane(): Mgmt Interface is in Service now..
1416 NOT Feb 27 15:02:03.284083 (538:914) JAVA-Thread-5|cip.sipcc.SipCcAdapter$CcMgmtListener:? - calling initializeLines...
1417 NOT Feb 27 15:02:03.284541 (538:914) JAVA-Thread-5|cip.sipcc.SipCcAdapter$CcMgmtListener:? - initializeLines called...
1418 NOT Feb 27 15:02:03.285273 (538:914) JAVA-Thread-5|cip.sipcc.SipCcAdapter$CcMgmtListener:? - returned from InfogetLines...
1419 NOT Feb 27 15:02:03.285640 (538:914) JAVA-Thread-5|cip.sipcc.SipCcAdapter$CcMgmtListener:? - entering line loop...
1420 NOT Feb 27 15:02:03.286128 (538:914) JAVA-Thread-5|cip.sipcc.SipCcAdapter$CcMgmtListener:? - instidx=0 inst=1 calling getLineInfo.....
1421 NOT Feb 27 15:02:03.393224 (538:889) JAVA-System P7-display MQThread|cip.sipcc.SipCcAdapter: - skDnldDone(): SIPCC waiting on config file
1422 NOT Feb 27 15:02:03.393743 (538:889) JAVA-System P7-display MQThread|cip.sipcc.SipCcAdapter: - UpdateMgmtState [MGMT_INITIALIZING(1)] --> [MGMT_AWAITING_CFG_SYNC(8)]
1423 NOT Feb 27 15:02:03.396520 (538:914) JAVA-Thread-5|cip.sipcc.SipCcAdapter$CcMgmtListener:? - initializeLine called: ref=40126184 lineFeature=9 button=1
1424 NOT Feb 27 15:02:03.490492 (538:914) JAVA-Thread-5|cip.sipcc.SipCcAdapter$CcMgmtListener:? - returned from InfogetFeatures...
1425 WRN Feb 27 15:02:03.492904 (538:914) JAVA-Thread-5|cip.sipcc.SipCcAdapter$CcMgmtListener:? - features is empty...
1426 NOT Feb 27 15:02:03.496230 (538:914) JAVA-Thread-5|cip.sipcc.SipCcAdapter: - UpdateMgmtState [MGMT_AWAITING_CFG_SYNC(8)] --> [MGMT_REGISTERING(4)]
1427 NOT Feb 27 15:02:03.497329 (538:914) JAVA-SIPCC-SIP_DEVICE_MGR: registration_processEvent: Event EV_CC_CONFIG_RECEIVED, current State MGMT_STATE_CREATED
1428 NOT Feb 27 15:02:03.497512 (538:914) JAVA-SIPCC-SIP_DEVICE_MGR: setState: new registration state = MGMT_STATE_REGISTERING
1429 NOT Feb 27 15:02:03.497817 (538:914) JAVA-SIPCC-SIP_CC_PROV: ccsnap_gen_deviceEvent: event type : STATE
1430 NOT Feb 27 15:02:03.499191 (538:914) JAVA-SIPCC-SIP_DEVICE_MGR: action: cmd: CMD_INSERVICE cfg: signaling_ip=[v4:172.16.10.37,v6:] media_ip=172.16.10.37 pending: signaling_ip=[v4:172.16.10.37,v6:] media_ip=172.16.10.37
1431 NOT Feb 27 15:02:03.499374 (538:914) JAVA-SIPCC-SIP_DEVICE_MGR: action: Setting New Signaling IP [v4:172.16.10.37,v6:], New Media IP 172.16.10.37
1432 ERR Feb 27 15:02:03.499496 (538:914) JAVA-CFG : config_set_string : Parse function failed. ID: 104 myIpv6Addr:
1433 NOT Feb 27 15:02:03.512498 (538:915) JAVA-SIP : sip_transport_init_ti_addrs : Admin has not configured a valid cucm for cucm index=VISITING_CCM=0.
1434 NOT Feb 27 15:02:03.513688 (538:915) JAVA-SIPCC-SIP_TRANS: sip_transport_init_ti_addr: Entered
1435 NOT Feb 27 15:02:03.514359 (538:915) JAVA-SIPCC-SIP_TRANS: sip_transport_init_ti_addr: Entered
1436 NOT Feb 27 15:02:03.514512 (538:915) JAVA-SIPCC-SIP_TRANS: sip_transport_init_ti_addr: Unexpected value specified for ip_type : 0
1437 NOT Feb 27 15:02:03.515794 (538:915) JAVA-SIP : sip_transport_init_ti_addrs : Admin has not configured a valid cucm for cucm index=SECONDARY_CCM=2.
1438 NOT Feb 27 15:02:03.516954 (538:915) JAVA-SIP : sip_transport_init_ti_addrs : Admin has not configured a valid cucm for cucm index=TERTIARY_CCM=3.
1439 NOT Feb 27 15:02:03.517900 (538:915) JAVA-SIP : sip_transport_init_ti_addrs : Admin has not configured a valid cucm for cucm index=SRST_CCM=4.
1440 NOT Feb 27 15:02:03.521410 (538:915) JAVA-sip_tcp_init_conn_table() called
1441 NOT Feb 27 15:02:03.521684 (538:915) JAVA-SIP : sip_tcp_get_free_conn_entry : returned index=0
1442 NOT Feb 27 15:02:03.525255 (538:914) JAVA-SIPCC-SIP_CC_PROV: ccsnap_gen_deviceEvent: event type : SERVER_TRANSPORT
1443 NOT Feb 27 15:02:03.525896 (538:915) JAVA-set_active_ccm: ccm=PRIMARY_CCM port=49987
1444 NOT Feb 27 15:02:03.526415 (538:915) JAVA-SIP : sip_transport_init_ti_addrs : Admin has not configured a valid cucm for cucm index=SECONDARY_CCM=2.
1445 NOT Feb 27 15:02:03.526537 (538:915) JAVA-SIPCC-SIP_CC_CONN: sip_transport_setup_cc_conn: <SECONDARY_CCM>: CC address/port not configured2.
1446 NOT Feb 27 15:02:03.527239 (538:915) JAVA-SIP : sip_transport_init_ti_addrs : Admin has not configured a valid cucm for cucm index=TERTIARY_CCM=3.
1447 NOT Feb 27 15:02:03.527361 (538:915) JAVA-SIPCC-SIP_CC_CONN: sip_transport_setup_cc_conn: <TERTIARY_CCM>: CC address/port not configured2.
1448 NOT Feb 27 15:02:03.527941 (538:915) JAVA-SIP : sip_transport_init_ti_addrs : Admin has not configured a valid cucm for cucm index=SRST_CCM=4.
1449 NOT Feb 27 15:02:03.528063 (538:915) JAVA-SIPCC-SIP_CC_CONN: sip_transport_setup_cc_conn: <SRST_CCM>: CC address/port not configured2.
1450 NOT Feb 27 15:02:03.528948 (538:915) JAVA-SIPCC-SIP_CC_CONN: sip_regmgr_setup_cc_conns: NO VALID STANDBY CALL CONTROL AVAILABLE!
1451 NOT Feb 27 15:02:03.530535 (538:915) JAVA-SIPCC-SIP_REG: sip_sm_init: Disabling mass reg state
1452 WRN Feb 27 15:02:03.949946 (538:894) JAVA-callagent MQThread|DisplayTask:? - Line 1 property added with dn 4015
1453 NOT Feb 27 15:02:03.961757 (322:392) EWCLIENT-ewclWriteData: Cannot update secret
1454 NOT Feb 27 15:02:04.115550 (538:915) JAVA-SIPCC-SIP_REG: ccsip_register_all_lines: Disabling mass reg state
1455 NOT Feb 27 15:02:04.117228 (538:915) JAVA-SIPCC-UI_API: ui_update_registration_state_all_lines: ***********ALL LINES UN-REGISTERED****************
1456 NOT Feb 27 15:02:04.118876 (538:914) JAVA-Thread-5|cip.sipcc.SipCcAdapter$CcMgmtListener: - lineNotify():mgmtState=MGMT_REGISTERING(4) line=1 registered=false inService=true regRequired = true
1457 NOT Feb 27 15:02:04.121318 (538:915) JAVA-MED : updatePresentationCapTblValues : enter...
1458 NOT Feb 27 15:02:04.121471 (538:915) JAVA-MED : updatePresentationCapTblValues : orig gcap[1,0,0,0]
1459 NOT Feb 27 15:02:04.121562 (538:915) JAVA-MED : updatePresentationCapTblValues : new gcap[1,0,0,0]
1460 NOT Feb 27 15:02:04.121684 (538:915) JAVA-MED : updateFeccCapTblValues : enter...
1461 NOT Feb 27 15:02:04.121776 (538:915) JAVA-MED : updateFeccCapTblValues : orig gcap[0]
1462 NOT Feb 27 15:02:04.121867 (538:915) JAVA-MED : updateFeccCapTblValues : new gcap[0]
1463 NOT Feb 27 15:02:04.121989 (538:915) JAVA-SIP : SIPTaskProcessListEvent : sip_taskInited is set to true
1464 NOT Feb 27 15:02:04.140119 (538:915) JAVA-SIPCC-SIP_MSG_SEND: ccsip_dump_send_msg_info: <172.16.50.3:5060>:REFER s: <sip:172.16.50.3> :1000 REFER::005f8690-51f90002-5595771d-3248496c@172.16.10.37
1465 NOT Feb 27 15:02:04.151411 (538:915) JAVA-SIPCC-SIP_MSG_SEND: ccsip_dump_send_msg_info: <172.16.50.3:5060>:REFER s: <sip:172.16.50.3> :1000 REFER::005f8690-51f90003-3b1d33e0-736f701b@172.16.10.37
1466 NOT Feb 27 15:02:04.161819 (538:915) JAVA-SIPCC-SIP_MSG_SEND: ccsip_dump_send_msg_info: <172.16.50.3:5060>:REFER s: <sip:172.16.50.3> :1000 REFER::005f8690-51f90004-0b47a177-200a5902@172.16.10.37
1467 NOT Feb 27 15:02:04.171982 (538:915) JAVA-ccsip_messaging: sipSPIAddContactHeader: CFGID_DEVICE_NAME = SEP005F869051F9
1468 NOT Feb 27 15:02:04.172226 (538:915) JAVA-ccsip_messaging: sipSPIAddContactHeader: ccb->call_mode = 0, display_name = 4015
1469 NOT Feb 27 15:02:04.201037 (538:915) JAVA-SIPCC-SIP_REG: addDefaultOptionInd: support bfcp 1
1470 NOT Feb 27 15:02:04.201281 (538:915) JAVA-SIPCC-SIP_REG: addDefaultOptionInd: frame_rcc_options_ind_msg: check mobility refresh 0
1471 NOT Feb 27 15:02:04.201403 (538:915) JAVA-SIPCC-SIP_REG: addDefaultOptionInd: support flex_dscp=0
1472 NOT Feb 27 15:02:04.208423 (538:915) JAVA-SIPCC-SIP_REG: xmlEncodeEventData: returned content after encoding:
<?xml version="1.0" encoding="UTF-8"?>
<x-cisco-remotecc-request>
<optionsind>
<combine max="6">
<remotecc>
<status></status>
</remotecc>
<service-control></service-control>
</combine>
<dialog usage="hook status">
<unot></unot>
<sub></sub>
</dialog>
<dialog usage="shared line">
<unot></unot>
<sub></sub>
</dialog>
<presence usage="blf speed dial">
<unot></unot>
<sub></sub>
</presence>
<joinreq></joinreq>
<cfwdall-anyline></cfwdall-anyline>
<coaching></coaching>
<oosalarm></oosalarm>
<rpid-orig-called></rpid-orig-called>
<bfcp></bfcp>
<ix></ix>
<gatewayrecording></gatewayrecording>
<conferenceDisplayInstance></conferenceDisplayInstance>
</optionsind>
</x-cisco-remotecc-request>
1473 NOT Feb 27 15:02:04.216389 (538:915) JAVA-SIPCC-SIP_MSG_RECV: ccsip_dump_recv_msg_info: <172.16.50.3:0 >:202 Acc: "Na2b R2es far3 elnozom" <sip:4015@172.16.10.37>;tag=005f869051f9000232ec81ce-220800a2 :1000 REFER::005f8690-51f90002-5595771d-3248496c@172.16.10.37
1474 NOT Feb 27 15:02:04.220936 (538:915) JAVA-SIPCC-SIP_MSG_RECV: ccsip_dump_recv_msg_info: <172.16.50.3:0 >:202 Acc: "Na2b R2es far3 elnozom" <sip:4015@172.16.10.37>;tag=005f869051f900033f8843ed-771a8b5c :1000 REFER::005f8690-51f90003-3b1d33e0-736f701b@172.16.10.37
1475 NOT Feb 27 15:02:04.224874 (538:915) JAVA-SIPCC-SIP_MSG_RECV: ccsip_dump_recv_msg_info: <172.16.50.3:0 >:202 Acc: "Na2b R2es far3 elnozom" <sip:4015@172.16.10.37>;tag=005f869051f9000441a8725b-40837788 :1000 REFER::005f8690-51f90004-0b47a177-200a5902@172.16.10.37
1476 NOT Feb 27 15:02:04.308774 (1644:1644) dgetserver-dgetserver.RESULT [_0_ [PASS] No error
]
1477 NOT Feb 27 15:02:04.341400 (325:333) PWRMAN-setMode(): NORMAL
1478 NOT Feb 27 15:02:04.341980 (538:585) JAVA-Calling handlePowerManEvent
1479 NOT Feb 27 15:02:04.342255 (538:585) JAVA-Calling handlePowerManEvent
1480 WRN Feb 27 15:02:04.345795 (538:914) JAVA-Thread-5|DisplayTask:? - resetCurrentPowerState(): Energywise is disabled
1481 DEB Feb 27 15:02:04.357759 kernel: [ 106.725866] Set LCD backlight 1
1482 DEB Feb 27 15:02:04.357881 kernel: [ 106.729986] Set LCD backlight 1
1483 NOT Feb 27 15:02:04.349092 (325:333) PWRMAN-setMode(): NORMAL
1484 WRN Feb 27 15:02:04.349855 (538:914) JAVA-Thread-5|DisplayTask:? - resetCurrentPowerState(): Energywise null domain
1485 WRN Feb 27 15:02:04.350312 (538:914) JAVA-Thread-5|DisplayTask:? - resetCurrentPowerState(): Energywise null secret
1486 ERR Feb 27 15:02:04.351167 (538:914) JAVA-[API]LED ID error
1487 NOT Feb 27 15:02:04.354951 (538:915) JAVA-Thread-7|JPlatUi:setUnregReason - old-unregister-reason:25, new unregister-reason:25, cc-server-type:0
1488 NOT Feb 27 15:02:04.355684 (538:915) JAVA-Thread-7|JPlatUi:isThisFailureFromNewCause - old unregReason =25 newUnregReason=25 unregReason ignored
1489 NOT Feb 27 15:02:04.358553 (538:585) JAVA-Calling handlePowerManEvent
1490 NOT Feb 27 15:02:04.358828 (538:585) JAVA-Calling handlePowerManEvent
1491 WRN Feb 27 15:02:04.359499 (538:914) JAVA-Thread-5|DisplayTask:? - resetCurrentPowerState(): energywise is not available now
1492 NOT Feb 27 15:02:04.360018 (538:914) JAVA-Thread-5|cip.cfg.TimeDateProperty:setTime() - nativeTimeProperty.commit() failed, timeshift = 668
1493 NOT Feb 27 15:02:04.376560 (538:915) JAVA-Thread-7|JPlatUi:setUnregReason - set to unregister-reason:25 after phone registered
1494 NOT Feb 27 15:02:04.424080 (302:302) downd-SOCKET accept errno=4 "Interrupted system call"
1495 NOT Feb 27 15:02:04.637387 (538:915) JAVA-Thread-7|cip.sipcc.SipEnhancedAlarmInfo:setLastDeregistrationReason - new unreg-reason=25(LastTimeInitialized), old unreg-reason=25
1496 NOT Feb 27 15:02:04.646543 (538:915) JAVA-Thread-7|cip.sipcc.SipEnhancedAlarmInfo:getLastUnregistrationTimeReason - TimeStamp=1582808524637; Reasons =25
1497 NOT Feb 27 15:02:04.648130 (538:915) JAVA-SIPCC-UI_API: ui_update_registration_state_all_lines: ***********ALL LINES UN-REGISTERED****************
1498 NOT Feb 27 15:02:04.649656 (538:914) JAVA-Thread-5|cip.sipcc.SipCcAdapter$CcMgmtListener: - lineNotify():mgmtState=MGMT_REGISTERING(4) line=1 registered=false inService=true regRequired = true
1499 NOT Feb 27 15:02:04.651640 (538:914) JAVA-SIPCC-SIP_CC_PROV: ccsnap_gen_deviceEvent: event type : DND
1500 NOT Feb 27 15:02:04.656615 (538:914) JAVA-SIPCC-SIP_DEVICE_MGR: registration_processEvent: Event EV_CC_INSERVICE, current State MGMT_STATE_REGISTERING
1501 NOT Feb 27 15:02:04.656767 (538:914) JAVA-SIPCC-SIP_DEVICE_MGR: setState: new registration state = MGMT_STATE_REGISTERED
1502 NOT Feb 27 15:02:04.657195 (538:914) JAVA-SIPCC-SIP_CC_PROV: ccsnap_gen_deviceEvent: event type : STATE
1503 NOT Feb 27 15:02:04.658110 (538:914) JAVA-Thread-5|cip.sipcc.SipCcAdapter$CcMgmtListener:? - ccReady called...mgmtState=MGMT_REGISTERING(4), deviceEvent:1, nativeSideInitialized:true
1504 NOT Feb 27 15:02:04.658843 (538:914) JAVA-Thread-5|cip.sipcc.SipCcAdapter$CcMgmtListener:? - initializeLinePlane called...
1505 NOT Feb 27 15:02:04.660033 (538:915) JAVA-SIPCC-UI_API: ui_set_ccm_conn_status: ***********CUCM 172.16.50.3 ACTIVE***********
1506 NOT Feb 27 15:02:04.660369 (538:915) JAVA-SIPCC-UI_API: ui_set_ccm_conn_status: ***********CUCM 172.16.50.3 ACTIVE***********
1507 NOT Feb 27 15:02:04.680726 (538:914) JAVA-Thread-5|cip.sipcc.SipCcAdapter$CcMgmtListener: - initializeLinePlane(): Mgmt Interface is in Service now..
1508 NOT Feb 27 15:02:04.682466 (538:914) JAVA-Thread-5|cip.sipcc.SipCcAdapter$CcMgmtListener:? - calling initializeLines...
1509 NOT Feb 27 15:02:04.682771 (538:914) JAVA-Thread-5|cip.sipcc.SipCcAdapter$CcMgmtListener:? - initializeLines called...
1510 NOT Feb 27 15:02:04.683229 (538:914) JAVA-Thread-5|cip.sipcc.SipCcAdapter$CcMgmtListener:? - returned from InfogetLines...
1511 NOT Feb 27 15:02:04.683473 (538:914) JAVA-Thread-5|cip.sipcc.SipCcAdapter$CcMgmtListener:? - entering line loop...
1512 NOT Feb 27 15:02:04.683747 (538:914) JAVA-Thread-5|cip.sipcc.SipCcAdapter$CcMgmtListener:? - instidx=0 inst=1 calling getLineInfo.....
1513 NOT Feb 27 15:02:04.684510 (538:915) JAVA-SIPCC-UI_API: ui_is_server_side_adr: server side application dial rules set = 0
1514 NOT Feb 27 15:02:04.693148 (538:915) JAVA-SIPCC-SIP_MSG_RECV: ccsip_dump_recv_msg_info: <172.16.50.3:0 >:REFER s: <sip:4015@172.16.50.3>;tag=1892967648 :101 REFER::59164a00-e571bdcd-32579-33210ac@172.16.50.3
1515 NOT Feb 27 15:02:04.723210 (538:917) JAVA-SIPCC-RCC_INFO: 0/0, rcc_receive_request: SUB 458756: REQ=35
1516 NOT Feb 27 15:02:04.841202 (538:915) JAVA-SIPCC-SIP_MSG_SEND: ccsip_dump_send_msg_info: <172.16.50.3:5060>:200 OK^M: <sip:4015@172.16.10.37>;tag=005f869051f90006780d03c2-341c685a :101 REFER::59164a00-e571bdcd-32579-33210ac@172.16.50.3
1517 NOT Feb 27 15:02:04.917472 (538:914) JAVA-Thread-5|cip.sipcc.SipCcAdapter$CcMgmtListener:? - initializeLine called: ref=41206536 lineFeature=9 button=1
1518 NOT Feb 27 15:02:04.918937 (538:914) JAVA-Thread-5|cip.sipcc.SipCcAdapter$CcMgmtListener:? - returned from InfogetFeatures...
1519 WRN Feb 27 15:02:04.919212 (538:914) JAVA-Thread-5|cip.sipcc.SipCcAdapter$CcMgmtListener:? - features is empty...
1520 NOT Feb 27 15:02:04.919853 (538:914) JAVA-Thread-5|cip.sipcc.SipCcAdapter: - UpdateMgmtState [MGMT_REGISTERING(4)] --> [MGMT_REGISTERING(4)]
1521 NOT Feb 27 15:02:05.001831 (538:914) JAVA-Thread-5|cip.sipcc.SipCcAdapter$CcMgmtListener: - lineNotify():mgmtState=MGMT_REGISTERING(4) line=1 registered=true inService=true regRequired = true
1522 NOT Feb 27 15:02:05.012757 (325:333) PWRMAN-setMode(): NORMAL
1523 NOT Feb 27 15:02:05.013123 (538:585) JAVA-Calling handlePowerManEvent
1524 NOT Feb 27 15:02:05.013367 (538:585) JAVA-Calling handlePowerManEvent
1525 DEB Feb 27 15:02:05.050663 kernel: [ 107.397070] Set LCD backlight 1
1526 NOT Feb 27 15:02:05.035800 (538:898) JAVA-configmgr MQThread|ConfigManager:? - --->ConfigManager PropertyChanged: device.settings.fullyregistered
1527 NOT Feb 27 15:02:05.036654 (538:898) JAVA-configmgr MQThread|ConfigManager:? - <---ConfigManager PropertyChanged: device.settings.fullyregistered
1528 ERR Feb 27 15:02:05.043430 (538:906) JAVA-set_sys_console: error opening/dev/console
1529 NOT Feb 27 15:02:05.053105 (538:914) JAVA-Thread-5|cip.sipcc.SipEnhancedAlarmInfo:propertyChanged - name=device.settings.fullyregistered value=true
1530 NOT Feb 27 15:02:05.055669 (538:914) JAVA-Thread-5|cip.sipcc.SipCcAdapter: - UpdateMgmtState [MGMT_REGISTERING(4)] --> [MGMT_REGTD(5)]
1531 NOT Feb 27 15:02:05.079108 (538:914) JAVA-SIPCC-SIP_CC_PROV: ccsnap_gen_deviceEvent: event type : SERVER_STATUS
1532 NOT Feb 27 15:02:05.103036 (538:914) JAVA-SIPCC-SIP_CC_PROV: ccsnap_gen_deviceEvent: event type : SERVER_STATUS
1533 NOT Feb 27 15:02:05.127086 (538:893) JAVA-mediacontrolui MQThread|cip.msui.MediaControl$3:execute - [TR] executing the state-event handlerFunction=NoAudioRTPTxSessionEndedFunc
1534 WRN Feb 27 15:02:05.207904 (538:894) JAVA-callagent MQThread|DisplayTask:? - Line 1 property added with dn 4015
08-09-2023 08:56 PM
Were you able to find the resolution or reason for this??
I am experiencing the same issue
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