Library Migration - Bad Password - StreamCorruptedException

When I am trying to migrate from to the new object model my migrate log throws following error

Mon Jan 22 17:24:09.035: ERROR [main] error: exception=java.lang.NullPointerException

please help....

Here is the snapshot of log file generated my migrate tool.

Mon Jan 22 17:24:08.019: INFO [main] CmsInvokerMain: Validating Installation
Mon Jan 22 17:24:08.034: INFO [main] File 'lib/security/local_policy.jar:4368:1605592442' matches
Mon Jan 22 17:24:08.034: INFO [main] File 'lib/security/US_export_policy.jar:4355:3938255137' matches
Mon Jan 22 17:24:08.034: INFO [main] Installation Validation passed
Mon Jan 22 17:24:08.050: INFO [main] ************************************************** ***************************
Mon Jan 22 17:24:08.050: INFO [main] * Please be sure that no one else is using the database being migrated AND *
Mon Jan 22 17:24:08.050: INFO [main] * that you have a backup of the database!!! *
Mon Jan 22 17:24:08.050: INFO [main] * *
Mon Jan 22 17:24:08.050: INFO [main] * This program can make large and irreversible changes in the database *
Mon Jan 22 17:24:08.050: INFO [main] * that it is applied to! *
Mon Jan 22 17:24:08.050: INFO [main] ************************************************** ***************************
Mon Jan 22 17:24:08.050: INFO [main] Executing Library Migrate...
Mon Jan 22 17:24:08.050: INFO [main] ResourceHandler: Resource found in relative local filesys: file:/C:/worksitemp4/mpserver/config/objectmodels/worksitemp40.dat
Mon Jan 22 17:24:08.050: INFO [main] ResourceHandler: Resource found in relative local filesys: file:/C:/worksitemp4/mpserver/config/objectmodels/ToolkitOM.dat
Mon Jan 22 17:24:08.081: INFO [main] ResourceHandler: Resource found in relative local filesys: file:/C:/worksitemp4/mpserver/config/objectmodels/worksitemp40.dat
Mon Jan 22 17:24:08.081: INFO [main] ResourceHandler: Resource found in relative local filesys: file:/C:/worksitemp4/mpserver/config/objectmodels/ToolkitOM.dat
Mon Jan 22 17:24:08.237: INFO [HeapSpaceMonitor] HeapSpaceThread: total=2m used=2m free=593k
Mon Jan 22 17:24:08.347: INFO [main] Initializing Database Manager...
Mon Jan 22 17:24:08.347: INFO [main] Initializing Connection Pool Manager...
Mon Jan 22 17:24:08.347: INFO [main] EnterpriseConfig.addCluster( worksitempd )
Mon Jan 22 17:24:08.363: INFO [main] ClusterConfig.setModified( false ) for cluster worksitempd
Mon Jan 22 17:24:08.409: INFO [main] PmClient: findServiceOnServer: cluster=172.20.16.41
Mon Jan 22 17:24:08.425: INFO [main] PmClient.initialize(): pm port is 1118
Mon Jan 22 17:24:08.535: INFO [main] PmClient.initialize(): PmServer object is com.imanage.cms.fc.pm.PmServer_Stub[RemoteStub [ref: [endpoint:[001fntwedlab01:1115](remote),objID:[704baa:1104bf7f2c4:-8000, 1]]]]
Mon Jan 22 17:24:08.535: INFO [main] PmClientPool: pm server on server hostname=172.20.16.41 ipaddress=172.20.16.41 is available
Mon Jan 22 17:24:09.035: WARN [main] ClusterConfig: Bad Password
java.io.StreamCorruptedException: invalid stream header
at java.io.ObjectInputStream.readStreamHeader(Unknown Source)
at java.io.ObjectInputStream.(Unknown Source)
at com.imanage.cms.fc.config.ClusterConfig.getCluster ConfigFromEncryptedByteArray(ClusterConfig.java:26 8)
at com.imanage.cms.fc.pm.PmClient.loadConfiguration(P mClient.java:351)
at com.imanage.cms.fc.config.EnterpriseConfig.loadClu sterConfig(EnterpriseConfig.java:784)
at com.imanage.cms.fc.config.EnterpriseConfig.addClus ter(EnterpriseConfig.java:91)
at com.imanage.cms.fc.config.ClusterConfig.getLocalCl usterConfig(ClusterConfig.java:87)
at com.imanage.cms.t1.librarymigrate.ImLibraryMigrate Main.run(ImLibraryMigrateMain.java:143)
at com.imanage.cms.t1.librarymigrate.ImLibraryMigrate Main.main(ImLibraryMigrateMain.java:42)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Nativ e Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(Unknow n Source)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(Un known Source)
at java.lang.reflect.Method.invoke(Unknown Source)
at com.imanage.cms.fc.main.CmsInvokerMain.executeMain Method(CmsInvokerMain.java:103)
at com.imanage.cms.fc.main.CmsInvokerMain.execute(Cms InvokerMain.java:43)
at com.imanage.cms.fc.main.CmsInvokerMain.main(CmsInv okerMain.java:27)
Mon Jan 22 17:24:09.035: WARN [main] warn: exception=java.lang.IllegalArgumentException: Bad Password
at com.imanage.cms.fc.config.ClusterConfig.getCluster ConfigFromEncryptedByteArray(ClusterConfig.java:27 5)
at com.imanage.cms.fc.pm.PmClient.loadConfiguration(P mClient.java:351)
at com.imanage.cms.fc.config.EnterpriseConfig.loadClu sterConfig(EnterpriseConfig.java:784)
at com.imanage.cms.fc.config.EnterpriseConfig.addClus ter(EnterpriseConfig.java:91)
at com.imanage.cms.fc.config.ClusterConfig.getLocalCl usterConfig(ClusterConfig.java:87)
at com.imanage.cms.t1.librarymigrate.ImLibraryMigrate Main.run(ImLibraryMigrateMain.java:143)
at com.imanage.cms.t1.librarymigrate.ImLibraryMigrate Main.main(ImLibraryMigrateMain.java:42)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Nativ e Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(Unknow n Source)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(Un known Source)
at java.lang.reflect.Method.invoke(Unknown Source)
at com.imanage.cms.fc.main.CmsInvokerMain.executeMain Method(CmsInvokerMain.java:103)
at com.imanage.cms.fc.main.CmsInvokerMain.execute(Cms InvokerMain.java:43)
at com.imanage.cms.fc.main.CmsInvokerMain.main(CmsInv okerMain.java:27)

Mon Jan 22 17:24:09.035: ERROR [main] LibrarayMigrate ended with error(s)...
Mon Jan 22 17:24:09.035: ERROR [main] error: exception=java.lang.NullPointerException
at com.imanage.cms.t1.librarymigrate.ImLibraryMigrate Main.run(ImLibraryMigrateMain.java:145)
at com.imanage.cms.t1.librarymigrate.ImLibraryMigrate Main.main(ImLibraryMigrateMain.java:42)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Nativ e Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(Unknow n Source)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(Un known Source)
at java.lang.reflect.Method.invoke(Unknown Source)
at com.imanage.cms.fc.main.CmsInvokerMain.executeMain Method(CmsInvokerMain.java:103)
at com.imanage.cms.fc.main.CmsInvokerMain.execute(Cms InvokerMain.java:43)
at com.imanage.cms.fc.main.CmsInvokerMain.main(CmsInv okerMain.java:27)

Find more posts tagged with

Comments

ericamell

I am also seeing the same behavior. Anyone have any ideas?

Thank you,
Eric Amell

Piyush

see dbguy's reply at

http://devnet.interwoven.com/forums_vb/showthread.php?t=19316&forumid=48

Arc

Hi,

Has anyone tried resetting the PM password.

IPPMPASSWORD expects an entry of min 5 chars. I have to reset the pwd (make it empty) so that i can do libmigrate successfully.

Thanks for your help/suggestions.

mlesiw

You can clear the password by deleting the password.txt file from C:\InterwovenRMServer5.1\mpserver\config\pm, very secure Smiley Very Happy

dbguy

The purpose of the password is to prevent people from connecting rogue Configuration Mangers to your cluster. If some unauthorized user has access to the server install directory where the server is running to delete the password, you are in REAL trouble. ;-)

jaylin

I already delete password.txt but it still shows me that error:

Wed May 07 17:50:06.109: ERROR [main] LibrarayMigrate ended with error(s)...
Wed May 07 17:50:06.109: ERROR [main] error: exception=java.lang.NullPointerException
at com.imanage.cms.t1.librarymigrate.ImLibraryMigrateMain.run(ImLibraryMigrateMain.java:145)
at com.imanage.cms.t1.librarymigrate.ImLibraryMigrateMain.main(ImLibraryMigrateMain.java:42)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
at java.lang.reflect.Method.invoke(Unknown Source)
at com.imanage.cms.fc.main.CmsInvokerMain.executeMainMethod(CmsInvokerMain.java:103)
at com.imanage.cms.fc.main.CmsInvokerMain.execute(CmsInvokerMain.java:43)
at com.imanage.cms.fc.main.CmsInvokerMain.main(CmsInvokerMain.java:27)

Please tell me the way to solve. Thanks a lot

ericamell

jaylin can you post a little bit more of the log file. If you could start just after the environment information is displayed that would be great. I have the feeling the real error may be "hidden" in the lines above this.

Thanks!

jaylin

here we go, thanks

Wed May 07 17:59:21.812: INFO [main] CmsInvokerMain: Validating Installation
Wed May 07 17:59:21.828: INFO [main] File 'lib/security/local_policy.jar:4368:1605592442' matches
Wed May 07 17:59:21.828: INFO [main] File 'lib/security/US_export_policy.jar:4355:3938255137' matches
Wed May 07 17:59:21.828: INFO [main] Installation Validation passed
Wed May 07 17:59:21.828: INFO [main] *****************************************************************************
Wed May 07 17:59:21.828: INFO [main] * Please be sure that no one else is using the database being migrated AND *
Wed May 07 17:59:21.828: INFO [main] * that you have a backup of the database!!! *
Wed May 07 17:59:21.828: INFO [main] * *
Wed May 07 17:59:21.828: INFO [main] * This program can make large and irreversible changes in the database *
Wed May 07 17:59:21.828: INFO [main] * that it is applied to! *
Wed May 07 17:59:21.828: INFO [main] *****************************************************************************
Wed May 07 17:59:21.828: INFO [main] Executing Library Migrate...
Wed May 07 17:59:21.843: WARN [main] File is a symlink: C:\WORKSI~1\mpserver\config\com-ams-kyawmt\objectmodels\docTemplate.dat to: C:\worksitemp4\mpserver\config\com-ams-kyawmt\objectmodels\docTemplate.dat
Wed May 07 17:59:21.843: WARN [main] File is a symlink: C:\WORKSI~1\mpserver\config\objectmodels\docTemplate.dat to: C:\worksitemp4\mpserver\config\objectmodels\docTemplate.dat
Wed May 07 17:59:21.843: INFO [main] ResourceHandler: Resource found in relative local filesys: file:/C:/WORKSI~1/mpserver/config/objectmodels/docTemplate.dat
Wed May 07 17:59:21.843: WARN [main] File is a symlink: C:\WORKSI~1\mpserver\config\com-ams-kyawmt\objectmodels\docTemplate1.dat to: C:\worksitemp4\mpserver\config\com-ams-kyawmt\objectmodels\docTemplate1.dat
Wed May 07 17:59:21.843: WARN [main] File is a symlink: C:\WORKSI~1\mpserver\config\objectmodels\docTemplate1.dat to: C:\worksitemp4\mpserver\config\objectmodels\docTemplate1.dat
Wed May 07 17:59:21.843: INFO [main] ResourceHandler: Resource found in relative local filesys: file:/C:/WORKSI~1/mpserver/config/objectmodels/docTemplate1.dat
Wed May 07 17:59:21.859: WARN [main] File is a symlink: C:\WORKSI~1\mpserver\config\com-ams-kyawmt\objectmodels\docTemplate.dat to: C:\worksitemp4\mpserver\config\com-ams-kyawmt\objectmodels\docTemplate.dat
Wed May 07 17:59:21.859: WARN [main] File is a symlink: C:\WORKSI~1\mpserver\config\objectmodels\docTemplate.dat to: C:\worksitemp4\mpserver\config\objectmodels\docTemplate.dat
Wed May 07 17:59:21.859: INFO [main] ResourceHandler: Resource found in relative local filesys: file:/C:/WORKSI~1/mpserver/config/objectmodels/docTemplate.dat
Wed May 07 17:59:21.859: WARN [main] File is a symlink: C:\WORKSI~1\mpserver\config\com-ams-kyawmt\objectmodels\docTemplate1.dat to: C:\worksitemp4\mpserver\config\com-ams-kyawmt\objectmodels\docTemplate1.dat
Wed May 07 17:59:21.859: WARN [main] File is a symlink: C:\WORKSI~1\mpserver\config\objectmodels\docTemplate1.dat to: C:\worksitemp4\mpserver\config\objectmodels\docTemplate1.dat
Wed May 07 17:59:21.859: INFO [main] ResourceHandler: Resource found in relative local filesys: file:/C:/WORKSI~1/mpserver/config/objectmodels/docTemplate1.dat
Wed May 07 17:59:22.000: INFO [main] Initializing Database Manager...
Wed May 07 17:59:22.000: INFO [main] Initializing Connection Pool Manager...
Wed May 07 17:59:22.000: INFO [main] EnterpriseConfig.addCluster( com-ams-kyawmt )
Wed May 07 17:59:22.015: INFO [main] ClusterConfig.setModified( false ) for cluster com-ams-kyawmt
Wed May 07 17:59:22.046: INFO [main] PmClient: findServiceOnServer: cluster=10.70.4.194
Wed May 07 17:59:22.046: INFO [main] PmClient.initialize(): pm port is 2664
Wed May 07 17:59:22.125: INFO [main] PmClient.initialize(): PmServer object is com.imanage.cms.fc.pm.PmServer_Stub[RemoteStub [ref: [endpoint:[com-ams-kyawmt:2661](remote),objID:[1d85f79:119c2a4dc95:-8000, 1]]]]
Wed May 07 17:59:22.125: INFO [main] PmClientPool: pm server on server hostname=10.70.4.194 ipaddress=10.70.4.194 is available
Wed May 07 17:59:22.484: INFO [main] EnterpriseConfig.updateClusterConfigIfNewer( com-ams-kyawmt ): updating cluster config because new config is newer than current one
,
Wed May 07 17:59:22.484: ERROR [main] LibrarayMigrate ended with error(s)...
Wed May 07 17:59:22.484: ERROR [main] error: exception=java.lang.NullPointerException
at com.imanage.cms.t1.librarymigrate.ImLibraryMigrateMain.run(ImLibraryMigrateMain.java:145)
at com.imanage.cms.t1.librarymigrate.ImLibraryMigrateMain.main(ImLibraryMigrateMain.java:42)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
at java.lang.reflect.Method.invoke(Unknown Source)
at com.imanage.cms.fc.main.CmsInvokerMain.executeMainMethod(CmsInvokerMain.java:103)
at com.imanage.cms.fc.main.CmsInvokerMain.execute(CmsInvokerMain.java:43)
at com.imanage.cms.fc.main.CmsInvokerMain.main(CmsInvokerMain.java:27)

ericamell

Jaylin,

The message is not very helpful Smiley Sad

. Everything looks correct and then it gives a NullPointerException without any description of why. How frustrating! What version of MP are you running (including service pack and patch information)? Also have you only tried this the one time or have you restored the database and tried again? I have found that sometimes I will get an error once but the next time I try it actually works.

Eric