RME 4.3.1 - Inventory Collection : Sybase -638 Error

lo.mueller · ‎12-08-2009

Hello all,

with certain Routers Cisco803ISDN we are actually unable to get inventory data (other devices are collected correctly)

In IC_Server.log the following Sybase error is shown

IC_Server.log
[ Tue Dec 08 10:15:12 CET 2009 ],ERROR,[Thread-26],com.cisco.nm.rmeng.util.logger.RMELogger,770,com.cisco.nm.rmeng.inventory.ics.invchange.AddInvChange,effect,33,Unexpected error :com.sybase.jdbc2.jdbc.SybSQLException: SQL Anywhere Error -638: Right truncation of string data

It seems that the description of the IOS-SW is source of the problem, doing a octal dump (od) I discovered that

at the of each line of system-description a additional blank is added (<blank>\r\n).

Devices where inventory is collected correctly do have end-of-line characters (\r\n) without the blank.

Is that a problem to IC_Server or a bug in IOS-Image?

Thanks for any feedback

Lothar

Please find attached complete error-message in IC_Server.log

[ Tue Dec 08 10:15:12 CET 2009 ],DEBUG,[Thread-26],com.cisco.nm.rmeng.util.logger.RMELogger,734,com.cisco.n
m.rmeng.inventory.ics.dbrep.DBRecord,insert,60,Insert Query :
INSERT INTO SoftwareElement(SoftwareElementID, NetworkElementID, ProductName, Manufacturer, Version, BuildTime, PartOrImageID, SerialNumber, LogicalId, EnableToRun, FeatureSet,
SoftwareMedia, NumberRunning, Description, ElementName, ModuleId) VALUES(?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?) : SoftwareElementID = 1 NetworkElementID = 1455 Pro ductName = null Manufacturer = null Version = SOFTWARE (fc1)
TAC:Home:SW:IOS:Specials for info
Copyright (c) 1986-1998 by cisco Systems BuildTime = null PartOrImageID = null SerialNumber = null LogicalId = 2 EnableToRun = null FeatureSet = null SoftwareMedia = n ull NumberRunning = null Description = Cisco Internetwork Operating System Software
IOS (tm) C800 Software (C800-G3N-MW), Version 12.0(1)XB1, RELEASE SOFTWARE
(fc1)
TAC:Home:SW:IOS:Specials for info
Copyright (c) 1986-1998 by cisco Systems, Inc.
Compiled Wed 30-Dec-98 11:11 by ayeh ElementName = null ModuleId = null

[ Tue Dec 08 10:15:12 CET 2009 ],ERROR,[Thread-26],com.cisco.nm.rmeng.util.logger.RMELogger,770,com.cisco.n
m.rmeng.inventory.ics.invchange.AddInvChange,effect,33,Unexpected
error :com.sybase.jdbc2.jdbc.SybSQLException: SQL Anywhere Error -638: Right truncation of string data
        at com.sybase.jdbc2.tds.Tds.processEed(Tds.java:2884)
        at com.sybase.jdbc2.tds.Tds.nextResult(Tds.java:2206)
        at
com.sybase.jdbc2.jdbc.ResultGetter.nextResult(ResultGetter.java:69)
        at
com.sybase.jdbc2.jdbc.SybStatement.nextResult(SybStatement.java:220)
        at
com.sybase.jdbc2.jdbc.SybStatement.nextResult(SybStatement.java:203)
        at
com.sybase.jdbc2.jdbc.SybStatement.executeLoop(SybStatement.java:1766)
        at
com.sybase.jdbc2.jdbc.SybStatement.execute(SybStatement.java:1758)
        at com.sybase.jdbc2.jdbc.SybPreparedStatement.execute(SybPreparedStatement.java
:630)
        at
com.cisco.nm.rmeng.inventory.ics.dbrep.DBRecord.insert(DBRecord.java:61)
        at com.cisco.nm.rmeng.inventory.ics.util.ICSDatabaseConnection.insert(ICSDataba
seConnection.java:92)
        at com.cisco.nm.rmeng.inventory.ics.invchange.AddInvChange.effect(AddInvChange.
java:29)
        at com.cisco.nm.rmeng.inventory.ics.server.InvDataProcessor.processInvData(InvD
ataProcessor.java:404)
        at com.cisco.nm.rmeng.inventory.ics.core.CollectionController.run(CollectionCon
troller.java:462)
        at java.lang.Thread.run(Thread.java:595)

[ Tue Dec 08 10:15:12 CET 2009 ],ERROR,[Thread-26],com.cisco.nm.rmeng.inventory.ics.server.InvDataProcessor
,458,SQL Anywhere Error -638: Right truncation of string data
com.sybase.jdbc2.jdbc.SybSQLException: SQL Anywhere Error -638: Right truncation of string data
        at com.sybase.jdbc2.tds.Tds.processEed(Tds.java:2884)
        at com.sybase.jdbc2.tds.Tds.nextResult(Tds.java:2206)
        at
com.sybase.jdbc2.jdbc.ResultGetter.nextResult(ResultGetter.java:69)
        at
com.sybase.jdbc2.jdbc.SybStatement.nextResult(SybStatement.java:220)
        at
com.sybase.jdbc2.jdbc.SybStatement.nextResult(SybStatement.java:203)
        at
com.sybase.jdbc2.jdbc.SybStatement.executeLoop(SybStatement.java:1766)
        at
com.sybase.jdbc2.jdbc.SybStatement.execute(SybStatement.java:1758)
        at com.sybase.jdbc2.jdbc.SybPreparedStatement.execute(SybPreparedStatement.java
:630)
        at
com.cisco.nm.rmeng.inventory.ics.dbrep.DBRecord.insert(DBRecord.java:61)
        at com.cisco.nm.rmeng.inventory.ics.util.ICSDatabaseConnection.insert(ICSDataba
seConnection.java:92)
        at com.cisco.nm.rmeng.inventory.ics.invchange.AddInvChange.effect(AddInvChange.
java:29)
        at com.cisco.nm.rmeng.inventory.ics.server.InvDataProcessor.processInvData(InvD
ataProcessor.java:404)
        at com.cisco.nm.rmeng.inventory.ics.core.CollectionController.run(CollectionCon
troller.java:462)
        at java.lang.Thread.run(Thread.java:595)
[ Tue Dec 08 10:15:12 CET 2009 ],ERROR,[Thread-26],com.cisco.nm.rmeng.inventory.ics.core.CollectionControll
er,468, Exception occured in process method while processing: 10.1 63.63.144 SQL Anywhere Error -638: Right truncation of string data ICSException :: SQL Anywhere Error -638: Right truncation of string data
        at com.cisco.nm.rmeng.inventory.ics.server.InvDataProcessor.processInvData(InvD
ataProcessor.java:473)
        at com.cisco.nm.rmeng.inventory.ics.core.CollectionController.run(CollectionCon
troller.java:462)
        at java.lang.Thread.run(Thread.java:595)
[ Tue Dec 08 10:15:12 CET 2009 ],DEBUG,[Thread-26],com.cisco.nm.rmeng.util.logger.RMELogger,734,com.cisco.n
m.rmeng.common.notification.Notification,refreshPrefsCache,233,Obt
ained Notification Configuration values from CCR
[ Tue Dec 08 10:15:12 CET 2009 ],DEBUG,[Thread-26],com.cisco.nm.rmeng.util.logger.RMELogger,734,com.cisco.n
m.rmeng.common.notification.Notification,getCCRValue,88,is_notific
ation_enabled CfgDisabled:InvDisabled
[ Tue Dec 08 10:15:12 CET 2009 ],INFO ,[Thread-26],com.cisco.nm.rmeng.inventory.ics.core.CollectionController,596,
No Trap
[ Tue Dec 08 10:15:12 CET 2009 ],INFO ,[Thread-26],com.cisco.nm.rmeng.inventory.ics.core.CollectionController,602,
CALLING SELF TEST

Joe Clarke · ‎12-08-2009

This is an IOS bug. The image description is longer than the allowed 255 characters. You can workaround this by going to RME > Admin > Inventory > Inventory Change Filter, and check the boxes Image:Description and Image:System Description. Inventory should work then.

lo.mueller · ‎12-10-2009

Hi Joe,

thanks for your feedback.

I activated InvFilter, but (sorry) still collection is not possible - same error message in IC_Server.log.

What further can be done?

Thanks a lot

Lothar

-----------------------------------

IC_Server.log

[ Thu Dec 10 09:07:24 CET 2009 ],DEBUG,[Thread-39],com.cisco.nm.rmeng.inventory.ics.server.InvDataProcessor
,389,
Inventory Update
[ Thu Dec 10 09:07:24 CET 2009 ],DEBUG,[Thread-39],com.cisco.nm.rmeng.inventory.ics.server.InvDataProcessor
,390,================

[ Thu Dec 10 09:07:24 CET 2009 ],DEBUG,[Thread-39],com.cisco.nm.rmeng.util.logger.RMELogger,734,com.cisco.n
m.rmeng.inventory.ics.dbrep.DBRecord,update,82,Update Query : UPDATE ElementInventoryInfo SET UptimeTimestamp = '2009-04-15 04:10:43.057' WHERE NetworkElementID = '19' [ Thu Dec 10 09:07:24 CET 2009 ],DEBUG,[Thread-39],com.cisco.nm.rmeng.util.logger.RMELogger,734,com.cisco.n
m.rmeng.inventory.ics.dbrep.DBRecord,update,82,Update Query : UPDATE PhysicalElement SET NumberOfCommunicationConnectors = '2' WHERE PhysicalElementID = '1' AND NetworkElementID = '19' [ Thu Dec 10 09:07:24 CET 2009 ],DEBUG,[Thread-39],com.cisco.nm.rmeng.util.logger.RMELogger,734,com.cisco.n
m.rmeng.inventory.ics.dbrep.DBRecord,update,82,Update Query : UPDATE PhysicalElement SET NumberOfCommunicationConnectors = '2' WHERE PhysicalElementID = '2' AND NetworkElementID = '19' [ Thu Dec 10 09:07:24 CET 2009 ],DEBUG,[Thread-39],com.cisco.nm.rmeng.util.logger.RMELogger,734,com.cisco.n
m.rmeng.inventory.ics.dbrep.DBRecord,update,82,Update Query : UPDATE MemoryPool SET Allocated = '2537420' , Free = '6453120' WHERE PoolID = '2' AND NetworkElementID = '19' [ Thu Dec 10 09:07:24 CET 2009 ],DEBUG,[Thread-39],com.cisco.nm.rmeng.util.logger.RMELogger,734,com.cisco.n
m.rmeng.inventory.ics.dbrep.DBRecord,update,82,Update Query : UPDATE SoftwareElement SET Version = 'SOFTWARE (fc1)
TAC:Home:SW:IOS:Specials for info
Copyright (c) 1986-1998 by cisco Systems' WHERE SoftwareElementID = '1' AND NetworkElementID = '19' [ Thu Dec 10 09:07:24 CET 2009 ],ERROR,[Thread-39],com.cisco.nm.rmeng.util.logger.RMELogger,770,com.cisco.n
m.rmeng.inventory.ics.invchange.UpdateInvChange,effect,43,Unexpected error
:com.sybase.jdbc2.jdbc.SybSQLException: SQL Anywhere Error -638: Right truncation of string data
        at com.sybase.jdbc2.tds.Tds.processEed(Tds.java:2884)
        at com.sybase.jdbc2.tds.Tds.nextResult(Tds.java:2206)
        at com.sybase.jdbc2.jdbc.ResultGetter.nextResult(ResultGetter.java:69)
        at com.sybase.jdbc2.jdbc.SybStatement.nextResult(SybStatement.java:220)
        at com.sybase.jdbc2.jdbc.SybStatement.nextResult(SybStatement.java:203)
        at com.sybase.jdbc2.jdbc.SybStatement.updateLoop(SybStatement.java:1702)
        at com.sybase.jdbc2.jdbc.SybStatement.executeUpdate(SybStatement.java:1685)
        at com.sybase.jdbc2.jdbc.SybStatement.executeUpdate(SybStatement.java:431)
        at com.cisco.nm.rmeng.inventory.ics.dbrep.DBRecord.update(DBRecord.java:83)
        at com.cisco.nm.rmeng.inventory.ics.util.ICSDatabaseConnection.update(ICSDatabaseConnection.java:140)
        at com.cisco.nm.rmeng.inventory.ics.invchange.UpdateInvChange.effect(UpdateInvChange.java:37)
        at com.cisco.nm.rmeng.inventory.ics.server.InvDataProcessor.processInvData(InvDataProcessor.java:404)
        at com.cisco.nm.rmeng.inventory.ics.core.CollectionController.run(CollectionController.java:462)
        at java.lang.Thread.run(Thread.java:595)

[ Thu Dec 10 09:07:24 CET 2009 ],ERROR,[Thread-39],com.cisco.nm.rmeng.inventory.ics.server.InvDataProcessor
,458,SQL Anywhere Error -638: Right truncation of string data
com.sybase.jdbc2.jdbc.SybSQLException: SQL Anywhere Error -638: Right truncation of string data
        at com.sybase.jdbc2.tds.Tds.processEed(Tds.java:2884)
        at com.sybase.jdbc2.tds.Tds.nextResult(Tds.java:2206)
        at com.sybase.jdbc2.jdbc.ResultGetter.nextResult(ResultGetter.java:69)
        at com.sybase.jdbc2.jdbc.SybStatement.nextResult(SybStatement.java:220)
        at com.sybase.jdbc2.jdbc.SybStatement.nextResult(SybStatement.java:203)
        at com.sybase.jdbc2.jdbc.SybStatement.updateLoop(SybStatement.java:1702)
        at com.sybase.jdbc2.jdbc.SybStatement.executeUpdate(SybStatement.java:1685)
        at com.sybase.jdbc2.jdbc.SybStatement.executeUpdate(SybStatement.java:431)
        at com.cisco.nm.rmeng.inventory.ics.dbrep.DBRecord.update(DBRecord.java:83)
        at com.cisco.nm.rmeng.inventory.ics.util.ICSDatabaseConnection.update(ICSDatabaseConnection.java:140)
        at com.cisco.nm.rmeng.inventory.ics.invchange.UpdateInvChange.effect(UpdateInvChange.java:37)
        at com.cisco.nm.rmeng.inventory.ics.server.InvDataProcessor.processInvData(InvDataProcessor.java:404)
        at com.cisco.nm.rmeng.inventory.ics.core.CollectionController.run(CollectionController.java:462)
        at java.lang.Thread.run(Thread.java:595)
[ Thu Dec 10 09:07:24 CET 2009 ],ERROR,[Thread-39],com.cisco.nm.rmeng.inventory.ics.core.CollectionControll
er,468, Exception occured in process method while processing: R302 SQL Anywhere Error -638: Right truncation of string data ICSException :: SQL Anywhere Error -638: Right truncation of string data
        at com.cisco.nm.rmeng.inventory.ics.server.InvDataProcessor.processInvData(InvDataProcessor.java:473)
        at com.cisco.nm.rmeng.inventory.ics.core.CollectionController.run(CollectionController.java:462)
        at java.lang.Thread.run(Thread.java:595)

Joe Clarke · ‎12-10-2009

This is something different, and I suspect still a device bug. Given that this is a limited life train, I think it would be beneficial to upgrade this device to a mainline or T train to see if the problem persists. If it does, then a bug could be raised.