ZENworks for Desktops 6.5 SP2
Netware 6.5 SP2
Sybase DB 8.0.2 (4339)
ZENworks Agents (still) 4.01xxx

ZENworks Inventory Service Console Massages:

Starting the Upgrade service.
The database has already been set to the Ready state.
The Upgrade service is trying to free the resources.
Stopping the upgrade service.
Starting Storer Service
Obtaining dbdir from service object: VOL1:\\Zenworks\\ScanDir\\DbDir
Trying to connect to the database -> MW_DBA
jdbc:sybase:Tds:xxx.xxx.xxx.xxx:2638?ServiceName=m gmtdb&JCONNECT_VERSION=4
Successfully connected to the database
Storer: Database is initialized.
Storer: started storing 0008028F9BBE_1060751520000_75.STR (2686 bytes)
Starting STRConverter service
Storer: Successfully stored the information for
CN=WKSTA2.OU=Workstations.OU=BO2.O=CORP time taken: 12486
Storer: started storing 000BCDC3AF5E_1070456883000_81.STR (95778 bytes)
Receiver Service Started
Starting Selector Service
Inventory Sync Service started
Storer: Full scan being processed for CN=WKSTA1.OU=Workstations.OU=BO1.O=CORP
Error in parsing:Could not process 000BCDC3AF5E_1070456883000_81.STR due to
DB Operation failure..will retry
TCP Receiver Service Started


There are several workstations that send .STR files to the Inventory
Service (Leaf->Root) that causes Storer in Root DB server to stop. It says
"..will retry" but it never does that. So, I have to manually stop the Inv
Service & db, remove the "corrupt" .STR file from the
\ZENworks\ScanDir\DBDir\temp folder, and start the db and InvService again.
Then the process continues until the next "corrupt" .STR file. They seem to
be Full Scan files according to the size of them.


Question: What can be wrong? How can make Storer just to skip those corrupt
..STR files?


Below: Part of Storer debug log file from root db server.

[11/11/05 09:34:28.208] ZENInv - Storer: Total Memory = 8126464 Free Memory
= 5182912
[11/11/05 09:34:28.208] ZENInv - Storer: Unlocking
VOL1:\Zenworks\ScanDir\DbDir\temp\0008028F9BBE_106 0751520000_75.STR
[11/11/05 09:34:28.801] ZENInv - Storer: Loading Storer test properties file
[11/11/05 09:34:28.810] ZENInv - Storer: Storer: started storing
000BCDC3AF5E_1070456883000_81.STR (95778 bytes)
[11/11/05 09:34:28.848] ZENInv - Storer: dn:
CN=WKSTA1.OU=Workstations.OU=BO1.O=CORP tree: TREE123
[11/11/05 09:34:28.848] ZENInv - Storer: tree: TREE123wsdn:
CN=WKSTA1.OU=Workstations.OU=BO1.O=CORPtime: 1131612609000
[11/11/05 09:34:28.848] ZENInv - Storer: Initial WS statusrecord is found
[11/11/05 09:34:28.848] ZENInv - Storer: got the status log
[11/11/05 09:34:29.138] ZENInv - Storer: [FULL]DELETING ALL PRODUCTS
[11/11/05 09:34:32.091] ZENInv - SendRec Common: entPushDir =
VOL1:\Zenworks\ScanDir\EntPushDir
[11/11/05 09:34:32.091] ZENInv - SendRec Common: entMergeDirD =
VOL1:\Zenworks\ScanDir\EntMergeDir
[11/11/05 09:34:32.091] ZENInv - SendRec Common: dbDirD =
VOL1:\Zenworks\ScanDir\DbDir
[11/11/05 09:34:32.091] ZENInv - SendRec Common: serverName = SERVER01
[11/11/05 09:34:32.091] ZENInv - SendRec Common: serviceDN =
CN=SERVER01_ZenInvService.O=CORP
[11/11/05 09:34:32.092] ZENInv - SendRec Common: treeName = TREE123
[11/11/05 09:34:32.092] ZENInv - SendRec Common: hasSSD = false
[11/11/05 09:34:32.092] ZENInv - SendRec Common: hasISD = true
[11/11/05 09:34:32.092] ZENInv - SendRec Common: hasESD = true
[11/11/05 09:34:32.092] ZENInv - SendRec Common: hasDB = true
[11/11/05 09:34:32.092] ZENInv - SendRec Common: securityDir =
SYS:\PUBLIC\ZENWORKS\WMINV\PROPERTIES
[11/11/05 09:34:32.109] Service Manager: start(ServiceDataAccessor,
String[]) not found in
'com.novell.zenworks.desktop.inventory.selector.Se lectorServiceInit'
[11/11/05 09:34:32.162] ZENInv - Selector: Selector Services Started
Successfully
[11/11/05 09:34:32.164] Service Manager: start(ServiceDataAccessor,
String[]) not found in
'com.novell.zenworks.common.inventory.scancollecto r.ScanCollector'
[11/11/05 09:34:32.184] ZENInv - Selector: Selector StrFileDelay Not Set
[11/11/05 09:34:32.185] ZENInv - Selector: Selector Code Profiling disabled
[11/11/05 09:34:32.276] ZENInv - IFS Server: zenInvScanCollector:
FileServiceController: Startup Properties: {chunksize=4096,
lockfactory=com.novell.zenworks.common.inventory.i fs.utils.MemoryFileLockFactory,
lockseed=ScanSelectorLock, transfers=100,
rootdirectory=VOL1:\Zenworks\ScanDir, timeout=60000,
servicename=zenInvScanCollector, portnumber=0}
[11/11/05 09:34:32.429] ZENInv - CascadedBaseTime Server:
zenInvCascadeBaseTimeService: CBTServiceController: Startup Properties:
{basetime=Sat Jan 01 00:05:09 EET 2005,
servicename=zenInvCascadeBaseTimeService, portnumber=0}
[11/11/05 09:34:32.436] Service Manager: start(ServiceDataAccessor,
String[]) not found in
'com.novell.zenworks.desktop.inventory.InvSyncServ ice.ManagableSyncService'
[11/11/05 09:34:32.457] ZENInv - Inventory Sync Service: SyncService thread
started
[11/11/05 09:34:32.466] ZENInv - Inventory Sync Service: NEW
SyncServiceTable Constructor Invoked
[11/11/05 09:34:32.466] ZENInv - Inventory Sync Service: Creating-Verifying
Serialize-Deserialize Location VOL1:\Zenworks\ScanDir\stable\
[11/11/05 09:34:32.467] ZENInv - Inventory Sync Service: Checking for
VOL1:\Zenworks\ScanDir\stable\
[11/11/05 09:34:32.469] Service Manager: start(ServiceDataAccessor,
String[]) not found in
'com.novell.zenworks3x.desktop.inventory.senderrec eiver.control.ReceiverServiceInit'
[11/11/05 09:34:32.472] ZENInv - Inventory Sync Service: synchTableDir
exists. Check wether this is a directory or File
[11/11/05 09:34:32.474] ZENInv - Inventory Sync Service: Directory
ExistsVOL1:\Zenworks\ScanDir\stable\
[11/11/05 09:34:32.478] ZENInv - Inventory Sync Service: Directory
Existence ConfirmedVOL1:\Zenworks\ScanDir\stable\
[11/11/05 09:34:32.478] ZENInv - Inventory Sync Service:
Serialize-Deserialize File VOL1:\Zenworks\ScanDir\stable\STABLE.SER
[11/11/05 09:34:32.478] ZENInv - Inventory Sync Service: Initializing
SyncServiceTable
[11/11/05 09:34:32.478] ZENInv - Inventory Sync Service: SynchTable Does
not Exist
[11/11/05 09:34:32.478] ZENInv - Inventory Sync Service: Attempting to Load
SynchTable From Serialized File
[11/11/05 09:34:32.479] ZENInv - Inventory Sync Service: DeSerializing
hashTable FromVOL1:\Zenworks\ScanDir\stable\STABLE.SER
[11/11/05 09:34:32.480] ZENInv - Inventory Sync Service: DeSerializing
SyncService HashTable
[11/11/05 09:34:32.483] ZENInv - Inventory Sync Service: SynchTable Loaded
Sucessfully From Serialized File
[11/11/05 09:34:32.487] ZENInv - IFS Server: zeninvReceiverService:
FileServiceController: Startup Properties: {chunksize=4096, transfers=100,
rootdirectory=VOL1:\Zenworks\ScanDir\EntPushDir\Zi pDir, timeout=60000,
servicename=zeninvReceiverService, portnumber=0}
[11/11/05 09:34:38.169] ZENInv - Storer: Products=379 Sw_Times = 2361 379 0
0 1354 379 0 0 944 379 0 0 TotalTime=8983
[11/11/05 09:34:40.136] ZENInv - Storer: ws deletetime : 1774
[11/11/05 09:34:40.435] ZENInv - Storer: Some Database Exception
com.novell.zenworks.desktop.inventory.storer.Datab aseException: ASA Error
-194: No primary key value for foreign key 'id$' in table 't$LockTable'
at
com.novell.zenworks.desktop.inventory.storer.Datab aseOperator.connectEx(DatabaseOperator.java:1164)
at
com.novell.zenworks.desktop.inventory.storer.Datab aseOperator.reTryExecute(DatabaseOperator.java:122 7)
at
com.novell.zenworks.desktop.inventory.storer.Datab aseOperator.updateLockTable(DatabaseOperator.java: 6130)
at
com.novell.zenworks.desktop.inventory.storer.Parse .writeToDB(Parse.java:2360)
at com.novell.zenworks.desktop.inventory.storer.Parse .parse(Parse.java:4113)
at
com.novell.zenworks.desktop.inventory.storer.MainT hread.run(MainThread.java:976)

[11/11/05 09:34:40.440] ZENInv - Storer: DatabaseException:DB operation
failed..could not process 000BCDC3AF5E_1070456883000_81.STR due to
com.novell.zenworks.desktop.inventory.storer.Datab aseException: ASA Error
-194: No primary key value for foreign key 'id$' in table 't$LockTable'
at
com.novell.zenworks.desktop.inventory.storer.Datab aseOperator.connectEx(DatabaseOperator.java:1164)
at
com.novell.zenworks.desktop.inventory.storer.Datab aseOperator.reTryExecute(DatabaseOperator.java:122 7)
at
com.novell.zenworks.desktop.inventory.storer.Datab aseOperator.updateLockTable(DatabaseOperator.java: 6130)
at
com.novell.zenworks.desktop.inventory.storer.Parse .writeToDB(Parse.java:2360)
at com.novell.zenworks.desktop.inventory.storer.Parse .parse(Parse.java:4113)
at
com.novell.zenworks.desktop.inventory.storer.MainT hread.run(MainThread.java:976)

[11/11/05 09:34:40.444] ZENInv - Storer: MainThread-1 position:
com.novell.zenworks.desktop.inventory.storer.Datab aseException: ASA Error
-194: No primary key value for foreign key 'id$' in table 't$LockTable'
at
com.novell.zenworks.desktop.inventory.storer.Datab aseOperator.connectEx(DatabaseOperator.java:1164)
at
com.novell.zenworks.desktop.inventory.storer.Datab aseOperator.reTryExecute(DatabaseOperator.java:122 7)
at
com.novell.zenworks.desktop.inventory.storer.Datab aseOperator.updateLockTable(DatabaseOperator.java: 6130)
at
com.novell.zenworks.desktop.inventory.storer.Parse .writeToDB(Parse.java:2360)
at com.novell.zenworks.desktop.inventory.storer.Parse .parse(Parse.java:4113)
at
com.novell.zenworks.desktop.inventory.storer.MainT hread.run(MainThread.java:976)

[11/11/05 09:34:40.448] ZENInv - Status Reporting: Messages are written
into XML file for DN=CN=SERVER01_ZenInvService.O=CORP
[11/11/05 09:34:40.485] ZENInv - Status Reporting: Number of records to add
are: 1 for DN=CN=SERVER01_ZenInvService.O=CORP
[11/11/05 09:34:40.520] ZENInv - Status Reporting: Adding record 0 for
DN=CN=SERVER01_ZenInvService.O=CORP
[11/11/05 09:34:40.661] ZENInv - Status Reporting: Number of modified
records are: 0 for DN=CN=SERVER01_ZenInvService.O=CORP
[11/11/05 09:34:40.661] ZENInv - Storer: MainThread-2 position:
[11/11/05 09:34:42.136] ZENInv - Selector: Getting ServerConfig HashTable
[11/11/05 09:34:42.136] ZENInv - Selector: Getting InvServiceObj from HashTable
[11/11/05 09:34:42.136] ZENInv - Selector: Getting NDSTree from ServiceObject
[11/11/05 09:34:42.136] ZENInv - Selector: NDSTree=null
[11/11/05 09:34:42.136] ZENInv - Selector: Getting InventoryServiceDN from
ServiceObject
[11/11/05 09:34:42.136] ZENInv - Selector:
InventoryServiceDN=CN=SERVER01_ZenInvService.O=COR P
[11/11/05 09:34:42.136] ZENInv - Selector: Getting ScanDir from ServiceObject
[11/11/05 09:34:42.136] ZENInv - Selector: ScanDir=VOL1:\Zenworks\ScanDir
[11/11/05 09:34:42.137] ZENInv - Selector: NEW SyncServiceTable Constructor
Invoked
[11/11/05 09:34:42.137] ZENInv - Selector: Creating-Verifying
Serialize-Deserialize Location VOL1:\Zenworks\ScanDir\stable\
[11/11/05 09:34:42.137] ZENInv - Selector: Checking for
VOL1:\Zenworks\ScanDir\stable\
[11/11/05 09:34:42.137] ZENInv - Selector: synchTableDir exists. Check
wether this is a directory or File
[11/11/05 09:34:42.138] ZENInv - Selector: Directory
ExistsVOL1:\Zenworks\ScanDir\stable\
[11/11/05 09:34:42.138] ZENInv - Selector: Directory Existence
ConfirmedVOL1:\Zenworks\ScanDir\stable\
[11/11/05 09:34:42.138] ZENInv - Selector: Serialize-Deserialize File
VOL1:\Zenworks\ScanDir\stable\STABLE.SER
[11/11/05 09:34:42.138] ZENInv - Selector: Initializing SyncServiceTable
[11/11/05 09:34:42.138] ZENInv - Selector: Will Use the existing
SyncServiceTable
[11/11/05 09:34:42.138] ZENInv - Selector: Getting hasDatabase status from
ServiceObject
[11/11/05 09:34:42.138] ZENInv - Selector: hasDatabase is true from
ServiceObject
[11/11/05 09:34:42.138] ZENInv - Selector: Getting isStandAlone status from
ServiceObject
[11/11/05 09:34:42.138] ZENInv - Selector: isStandAlone is true from
ServiceObject
[11/11/05 09:34:42.139] ZENInv - Selector: ConvDir VOL1:\Zenworks\ScanDir\conv\
[11/11/05 09:34:42.139] ZENInv - Selector: ConvDir exists. Check wether
this is a directory or File
[11/11/05 09:34:42.139] ZENInv - Selector: VOL1:\Zenworks\ScanDir
[11/11/05 09:34:42.139] ZENInv - Selector: VOL1:\Zenworks\ScanDir\DbDir
[11/11/05 09:34:42.139] ZENInv - Selector:
[11/11/05 09:34:42.139] ZENInv - Selector: Getting SELECTOR_STORER Synch Object
[11/11/05 09:34:42.139] ZENInv - Selector: Getting SELECTOR_COLLECTOR Synch
Object
[11/11/05 09:34:42.139] ZENInv - Selector: Getting SELECTOR_CONVERTER Synch
Object
[11/11/05 09:34:42.140] ZENInv - Selector: Getting CONVERTER_SELECTOR Synch
Object
[11/11/05 09:34:42.140] ZENInv - Selector: Getting SYNCHSERVICE_SELECTOR
Synch Object
[11/11/05 09:34:42.442] ZENInv - TCPReceiver: cascadingBaseTime = 1104530709000
[11/11/05 09:34:42.442] ZENInv - TCPReceiver: entPushDir =
VOL1:\Zenworks\ScanDir\EntPushDir
[11/11/05 09:34:42.442] ZENInv - TCPReceiver: serverName = SERVER01
[11/11/05 09:34:42.442] ZENInv - TCPReceiver: serviceDN =
CN=SERVER01_ZenInvService.O=CORP
[11/11/05 09:34:42.442] ZENInv - TCPReceiver: treeName = TREE123
[11/11/05 09:34:42.443] ZENInv - TCPReceiver: hasDB = true
[11/11/05 09:34:42.483] ZENInv - TCPReceiver: Receiver Started without CLUSTER
[11/11/05 09:34:42.484] ZENInv - TCPReceiver: Receiver Binds to Port Number
: 65432
[11/11/05 09:34:42.486] Service Manager: start(ServiceDataAccessor,
String[]) not found in
'com.novell.zenworks.common.inventory.dictionaryup date.provider.DictProvider'
[11/11/05 09:34:42.514] ZENInv - IFS Server: zenInvDictProvider:
FileServiceController: Startup Properties: {chunksize=4096, transfers=100,
rootdirectory=VOL1:\ZENWORKS\Inv\server\DictDir, timeout=60000,
servicename=zenInvDictProvider, portnumber=0}
[11/11/05 09:34:42.542] Service Manager: start(ServiceDataAccessor,
String[]) not found in
'com.novell.zenworks.common.inventory.dictionaryup date.consumer.DictConsumer'
[11/11/05 09:34:42.859] ZENInv - Dictionary Consumer:
DictConsumerUtility::getUpdatePolicyDN: getDictionaryUpdatePolicy returned
attribs.returnValue = 0
[11/11/05 09:34:42.859] ZENInv - Dictionary Consumer:
DictConsumerService::DictDownloadThread::run: UpdatePolicyNotFoundException.
com.novell.zenworks.common.inventory.dictionaryupd ate.consumer.UpdatePolicyNotFoundException
at
com.novell.zenworks.common.inventory.dictionaryupd ate.consumer.DictConsumerUtility.getUpdatePolicyDN (DictConsumerUtility.java:237)
at
com.novell.zenworks.common.inventory.dictionaryupd ate.consumer.DictConsumerService$DictDownloadThrea d.setUpdatePolicyAttribs(DictConsumerService.java: 688)
at
com.novell.zenworks.common.inventory.dictionaryupd ate.consumer.DictConsumerService$DictDownloadThrea d.getFileClientProperties(DictConsumerService.java :616)
at
com.novell.zenworks.common.inventory.dictionaryupd ate.consumer.DictConsumerService$DictDownloadThrea d.transferFiles(DictConsumerService.java:429)
at
com.novell.zenworks.common.inventory.dictionaryupd ate.consumer.DictConsumerService$DictDownloadThrea d.run(DictConsumerService.java:211)

[11/11/05 09:34:42.862] ZENInv - Status Reporting: Messages are written
into XML file for DN=CN=SERVER01_ZenInvService.O=CORP
[11/11/05 09:34:42.955] ZENInv - Status Reporting: Number of records to add
are: 1 for DN=CN=SERVER01_ZenInvService.O=CORP
[11/11/05 09:34:42.989] ZENInv - Status Reporting: Adding record 0 for
DN=CN=SERVER01_ZenInvService.O=CORP
[11/11/05 09:34:43.132] ZENInv - Status Reporting: Number of modified
records are: 0 for DN=CN=SERVER01_ZenInvService.O=CORP
[11/11/05 09:34:43.134] ZENInv - Dictionary Consumer:
DictConsumerService::FileDownloadListener::downloa dFailed.
[11/11/05 09:39:25.639] Service Manager: Stopping Service Server
Configuration Service
[11/11/05 09:39:25.640] Service Manager: Service Server Configuration
Service stopped successfully
[11/11/05 09:39:25.645] Service Manager: Stopping Service Dictionary
Consumer Service
[11/11/05 09:39:25.645] Service Manager: Service Dictionary Consumer
Service stopped successfully
[11/11/05 09:39:25.652] Service Manager: Stopping Service TCPReceiver Service
[11/11/05 09:39:25.656] Service Manager: Service TCPReceiver Service
stopped successfully
[11/11/05 09:39:25.659] Service Manager: Stopping Service STRConverter Service
[11/11/05 09:39:25.969] ZENInv - STRConverter: STRConverter service is stopped
[11/11/05 09:39:25.969] Service Manager: Service STRConverter Service
stopped successfully
[11/11/05 09:39:25.975] Service Manager: Stopping Service Selector Service
[11/11/05 09:39:28.894] ZENInv - Selector: Selector Will Now Serialize
SynchTable[Stop Slector Invoked]
[11/11/05 09:39:28.894] ZENInv - Selector: Serializing hashTable
ToVOL1:\Zenworks\ScanDir\stable\STABLE.SER
[11/11/05 09:39:28.896] ZENInv - Selector: Selector Services are stopped -
Exiting
[11/11/05 09:39:28.896] ZENInv - Selector: STOP_PENDING message sent to
StatusChangeListener
[11/11/05 09:39:28.896] ZENInv - Selector: STOPPED message sent to
StatusChangeListener
[11/11/05 09:39:28.896] ZENInv - Selector: Selector Services Stopped
[11/11/05 09:39:28.896] Service Manager: Service Selector Service stopped
successfully
[11/11/05 09:39:28.900] Service Manager: Stopping Service Scan Collector
Service
[11/11/05 09:39:28.923] Service Manager: Service Scan Collector Service
stopped successfully
[11/11/05 09:39:28.928] Service Manager: Stopping Service Receiver Service
[11/11/05 09:39:29.001] Service Manager: Service Receiver Service stopped
successfully
[11/11/05 09:39:29.002] Service Manager: Stopping Service InventorySync
Scheduler Service
[11/11/05 09:39:29.002] Service Manager: Service InventorySync Scheduler
Service stopped successfully
[11/11/05 09:39:29.009] Service Manager: Stopping Service Storer Service
[11/11/05 09:39:29.009] Service Manager: Service Storer Service stopped
successfully
[11/11/05 09:39:29.016] Service Manager: Stopping Service InvDBSync Service
[11/11/05 09:39:29.016] ZENInv - Inventory Sync Service: Cleanup()
operation completed
[11/11/05 09:39:29.016] Service Manager: Service InvDBSync Service stopped
successfully
[11/11/05 09:39:29.022] Service Manager: Stopping Service Dictionary
Provider Service
[11/11/05 09:39:29.050] Service Manager: Service Dictionary Provider
Service stopped successfully