Community Tip - You can Bookmark boards, posts or articles that you'd like to access again easily! X
Hello everyone,
I'm having trouble starting Windchill. Upon launch, the Server Manager opens and launches the Method Server who opens momentarily and closes.
The Method Server log is the following:
2017-02-09 07:51:50,556 INFO [main] wt.system.out - ------------------------------------------------------
2017-02-09 07:51:50,556 INFO [main] wt.method.server.startup - Starting MethodServer
2017-02-09 07:51:50,556 INFO [main] wt.method.server.startup - JVM id: 2892
2017-02-09 07:51:50,556 INFO [main] wt.method.server.startup - JVM: Oracle Corporation, Java HotSpot(TM) 64-Bit Server VM, 1.8.0_92 (25.92-b14), 64-bit
2017-02-09 07:51:50,556 INFO [main] wt.method.server.startup - OS: Windows Server 2012 R2, amd64, 6.3
2017-02-09 07:51:50,556 INFO [main] wt.method.server.startup - Host: WIN-9U6A5RRLNG0 (172.31.26.169)
2017-02-09 07:51:50,556 INFO [main] wt.method.server.startup - java.rmi.server.hostname: 172.31.26.169
2017-02-09 07:51:50,556 INFO [main] wt.method.server.startup - wt.rmi.server.hostname: ec2-35-156-59-114.eu-central-1.compute.amazonaws.com
2017-02-09 07:51:50,556 INFO [main] wt.method.server.startup - HeapDumpPath: D:\ptc\Windchill_11.0\Windchill\heapDumps
2017-02-09 07:51:50,556 INFO [main] wt.method.server.startup - Class path =
D:\ptc\Windchill_11.0\Windchill\codebase
D:\ptc\Windchill_11.0\Windchill\codebase\WEB-INF\lib\archiveClientWeb.jar
D:\ptc\Windchill_11.0\Windchill\codebase\WEB-INF\lib\archiveServerWeb.jar
D:\ptc\Windchill_11.0\Windchill\codebase\WEB-INF\lib\archiveWeb.jar
D:\ptc\Windchill_11.0\Windchill\codebase\WEB-INF\lib\CounterPartWeb.jar
D:\ptc\Windchill_11.0\Windchill\codebase\WEB-INF\lib\dpimplWeb.jar
D:\ptc\Windchill_11.0\Windchill\codebase\WEB-INF\lib\dpinfraWeb.jar
D:\ptc\Windchill_11.0\Windchill\codebase\WEB-INF\lib\Gantt.jar
D:\ptc\Windchill_11.0\Windchill\codebase\WEB-INF\lib\GanttExplorer.jar
D:\ptc\Windchill_11.0\Windchill\codebase\WEB-INF\lib\ie3rdpartylibs.jar
D:\ptc\Windchill_11.0\Windchill\codebase\WEB-INF\lib\ieWeb.jar
D:\ptc\Windchill_11.0\Windchill\codebase\WEB-INF\lib\install.jar
D:\ptc\Windchill_11.0\Windchill\codebase\WEB-INF\lib\jmxcoreWeb.jar
D:\ptc\Windchill_11.0\Windchill\codebase\WEB-INF\lib\jviews-chart-all.jar
D:\ptc\Windchill_11.0\Windchill\codebase\WEB-INF\lib\jviews-framework-all.jar
D:\ptc\Windchill_11.0\Windchill\codebase\WEB-INF\lib\jviews-gantt-all.jar
D:\ptc\Windchill_11.0\Windchill\codebase\WEB-INF\lib\mksapi.jar
D:\ptc\Windchill_11.0\Windchill\codebase\WEB-INF\lib\mpmlWeb.jar
D:\ptc\Windchill_11.0\Windchill\codebase\WEB-INF\lib\mylyn-integration.jar
D:\ptc\Windchill_11.0\Windchill\codebase\WEB-INF\lib\pdmlWeb.jar
D:\ptc\Windchill_11.0\Windchill\codebase\WEB-INF\lib\pjlWeb.jar
D:\ptc\Windchill_11.0\Windchill\codebase\WEB-INF\lib\ProjectManagement.jar
D:\ptc\Windchill_11.0\Windchill\codebase\WEB-INF\lib\prowtWeb.jar
D:\ptc\Windchill_11.0\Windchill\codebase\WEB-INF\lib\ptlcWeb.jar
D:\ptc\Windchill_11.0\Windchill\codebase\WEB-INF\lib\reqlWeb.jar
D:\ptc\Windchill_11.0\Windchill\codebase\WEB-INF\lib\restWeb.jar
D:\ptc\Windchill_11.0\Windchill\codebase\WEB-INF\lib\rialtoWeb.jar
D:\ptc\Windchill_11.0\Windchill\codebase\WEB-INF\lib\RMWebServices.jar
D:\ptc\Windchill_11.0\Windchill\codebase\WEB-INF\lib\TwxIEWebService.jar
D:\ptc\Windchill_11.0\Windchill\codebase\WEB-INF\lib\wc3rdpartylibs.jar
D:\ptc\Windchill_11.0\Windchill\codebase\WEB-INF\lib\wncWeb.jar
D:\ptc\Windchill_11.0\Windchill\lib\esi.jar
D:\ptc\Windchill_11.0\Windchill\lib\mpml.jar
D:\ptc\Windchill_11.0\Windchill\lib\pdml.jar
D:\ptc\Windchill_11.0\Windchill\lib\pjl.jar
D:\ptc\Windchill_11.0\Windchill\lib\reql.jar
D:\ptc\Windchill_11.0\Windchill\lib\servlet.jar
D:\ptc\Windchill_11.0\Windchill\lib\wnc.jar
D:\ptc\Windchill_11.0\Java\lib\tools.jar
D:\ptc\Windchill_11.0\Windchill\tomcat\bin\bootstrap.jar
D:\ptc\Windchill_11.0\Windchill\tomcat\bin\tomcat-juli.jar
D:\ptc\Windchill_11.0\Windchill\srclib\wnc\WtAsmAgent.jar
2017-02-09 07:51:50,556 INFO [main] wt.method.server.startup - WTContext time zone set to Europe/Berlin; offset: 1.0
2017-02-09 07:51:50,571 INFO [main] wt.method.server.startup - Setting default time zone to GMT; offset: 0.0
2017-02-09 07:51:51,399 INFO [main] wt.pom.properties - wt.pom.maxDbConnections= 15
2017-02-09 07:51:51,431 INFO [main] wt.pom.properties - wt.pom.minDbConnections= 5
2017-02-09 07:51:51,462 INFO [main] wt.pom.properties - wt.pom.dbConnectionsHardLimit= 25
2017-02-09 07:51:51,462 INFO [main] wt.pom.properties - wt.pom.dbConnectionsSoftLimitWaitTime= 500
2017-02-09 07:51:51,462 INFO [main] wt.pom.properties - wt.pom.dbConnectionsWaitTime= 0
2017-02-09 07:51:51,462 INFO [main] wt.pom.properties - wt.pom.connectionCloserThreshold= 0
2017-02-09 07:51:51,462 INFO [main] wt.pom.properties - wt.pom.connectionCloserIdleTimeout= 0
2017-02-09 07:51:51,462 INFO [main] wt.pom.properties - wt.pom.connectionMonitorSleepInterval= 10
2017-02-09 07:51:51,462 INFO [main] wt.pom.properties - wt.pom.lostConnectionCodes= 1012,3113,3114,12571,17002,17401,17008,17410
2017-02-09 07:51:51,462 INFO [main] wt.pom.properties - wt.pom.recoverableConnectionCodes= 0,28,1012,17002,17008,17410
2017-02-09 07:51:51,462 INFO [main] wt.pom.properties - wt.pom.freeConnectionImmediate= false
2017-02-09 07:51:51,462 INFO [main] wt.pom.properties - wt.pom.maxIdleStatementCaches= 0
2017-02-09 07:51:51,462 INFO [main] wt.pom.properties - wt.pom.jdbc.driver= oracle.jdbc.OracleDriver
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.jdbc.url= jdbc:oracle:thin:
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.jdbc.host= ec2-35-156-59-114.eu-central-1.compute.amazonaws.com
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.jdbc.port= 1521
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.jdbc.service= wind
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.jdbc.database=
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.dbUser= wcadmin
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.dbSchemaUser= wcadmin
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.dbConnectionPropertiesNameList=
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.dbConnectionPropertiesValueList=
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.dbConnectionRetryCount= 80
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.userDefinedFunctionsFileName= D:\ptc\Windchill_11.0\Windchill\db\userDefinedFunctions.xml
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.rowPrefetchCount= 20
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.fetchSizes= [100, 500, 2000]
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.statementCacheSize= 50
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.cachedStatementReuseLimit= 50
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.feedbackInterval= 500
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.interruptInterval= 50
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.cachedStatementRSLimit= -1
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.implicitTransactions= false
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.implicitTransactionsRollbackTime= 600
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.navigateDepthThreshold= 4
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.navigateDepthUnionLimit= 10
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.queryDepthThreshold= 3
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.queryDepthInClauseSizeLimit= 300
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.lobChunkSize= 32528
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.log.JDBCStatements= false
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.log.fileJDBC= null
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.log.filterJDBC= null
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.chunk.defaultSize= 300
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.objectReferenceQuerySize= 254
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.objectReferenceQueryChunkSize= 500
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.objectReferenceQueryArrayTableEnabled= true
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.inflateHint= RULE
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.inflateSingleTableMode= true
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.useBind= true
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.inClauseFixedSize= 5
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.inClauseSizeLimit= 1000
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.inClauseBindLimit= 300
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.inClauseUseBindOptimization= true
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.inClauseBindOptimizationThreshold=250
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.inClauseBindOptimizationTempTableUsePrimaryKey=true
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.inClauseBindOptimizationCardinality=-1
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.cardinalityValueFixedSize= 100
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.queryBindLimit= 65536
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.tempTableNumberPerThreshold= 5
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.tempTableArraySizeNumberOfThreshold=3
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.tempTableArraySizeThresholdValues=200,1000, 2000
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.tempTable.insertChunkSize=50000
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.startupQueryLimit= -1
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.queryLimit= -1
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.paging.queueInvokeTime= 600
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.paging.sessionCleanupTime= 1800
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.paging.threshold= -1
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.paging.insertChunkSize= 250
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.paging.fetchLimit= 15
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.paging.fetchSleepInterval= 1000
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.paging.closeSleepInterval= 600
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.paging.snapshotQueryLimit= -1
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.paging.pagingSessionLimit= 5
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.statementCache.summaryInterval= 2000
2017-02-09 07:51:51,478 INFO [main] wt.pom.properties - wt.pom.enableNLSSort= true
2017-02-09 07:51:51,493 INFO [main] wt.pom.properties - wt.pom.constantArrayTableLimit= 4000
2017-02-09 07:51:51,493 INFO [main] wt.pom.properties - wt.pom.traceTiming.enable= true
2017-02-09 07:51:51,493 INFO [main] wt.pom.properties - wt.pom.blobRead.handle620LV= false
2017-02-09 07:51:51,493 INFO [main] wt.pom.properties - wt.pom.blobRead.handleOldLV= false
2017-02-09 07:51:51,493 INFO [main] wt.pom.properties - wt.pom.blobRewrite.enabled= false
2017-02-09 07:51:51,493 INFO [main] wt.pom.properties - wt.pom.selectForUpdateEnabled= false
2017-02-09 07:51:51,493 INFO [main] wt.pom.properties - wt.pom.refreshCache.enabled= true
2017-02-09 07:51:51,493 INFO [main] wt.pom.properties - wt.pom.refreshCache.summeryInterval= 0
2017-02-09 07:51:51,493 INFO [main] wt.pom.properties - wt.pom.refreshCache.size= 300
2017-02-09 07:51:51,493 INFO [main] wt.pom.properties - wt.pom.enableSQL99OuterjoinSyntax= false
2017-02-09 07:51:51,493 INFO [main] wt.pom.properties - wt.pom.enableInListOptimizationWarning= false
2017-02-09 07:51:51,493 INFO [main] wt.pom.properties - wt.pom.refIntegrity.ownerQuery.chunkThreshold=-1
2017-02-09 07:51:51,493 INFO [main] wt.pom.properties - wt.pom.refIntegrity.ownerQuery.roleChunkSize=-1
2017-02-09 07:51:51,493 INFO [main] wt.pom.properties - wt.pom.refIntegrity.ownerQuery.objectChunkSize=-1
2017-02-09 07:51:51,493 INFO [main] wt.pom.properties - wt.pom.refIntegrity.removeOids.objectChunkSize=-1
2017-02-09 07:51:51,493 INFO [main] wt.pom.properties - wt.pom.batch.spec.tableExpressionThreshold=5
2017-02-09 07:51:51,493 INFO [main] wt.pom.properties - wt.pom.batch.spec.useTableType= true
2017-02-09 07:51:51,493 INFO [main] wt.pom.properties - wt.pom.batch.spec.useColumnList= true
2017-02-09 07:51:51,493 INFO [main] wt.pom.properties - wt.pom.batch.spec.delete.classChunkSize= 2000
2017-02-09 07:51:51,493 INFO [main] wt.pom.properties - wt.pom.batch.spec.delete.chunkSize= 5000
2017-02-09 07:51:51,493 INFO [main] wt.pom.properties - wt.pom.batch.spec.delete.dispatchEvents= false
2017-02-09 07:51:51,493 INFO [main] wt.pom.properties - wt.pom.batch.retry.enable= true
2017-02-09 07:51:51,493 INFO [main] wt.pom.properties - wt.pom.batch.closePreparedStatement.threshold=-1
2017-02-09 07:51:51,493 INFO [main] wt.pom.properties - wt.pom.batch.insert.chunkSize= 100000
2017-02-09 07:51:51,493 INFO [main] wt.pom.properties - wt.pom.batch.update.chunkSize= 100000
2017-02-09 07:51:51,493 INFO [main] wt.pom.properties - wt.pom.combineOrSubSelectExpressions= true
2017-02-09 07:51:51,493 INFO [main] wt.pom.properties - wt.pom.emptyTableQueryClassChunkSize = 400
2017-02-09 07:51:51,493 INFO [main] wt.pom.properties - wt.pom.emptyTableQuery.excludedSourceClassNames = wt.fv.master.MasteredOnReplicaItem,wt.fv.FvItem,wt.fv.FvMountValidatorLock
2017-02-09 07:51:51,493 INFO [main] wt.pom.properties - wt.pom.maxQueryRetryCount= 5
2017-02-09 07:51:51,493 INFO [main] wt.pom.properties - wt.pom.pdsDecoderBypassUserLoader = true
2017-02-09 07:51:51,493 INFO [main] wt.pom.properties - wt.pom.oracle.blobExplictOpen.enable= false
2017-02-09 07:51:51,493 INFO [main] wt.pom.properties - wt.pom.oracle.blobInlineWriteThreshold= -1
2017-02-09 07:51:51,493 INFO [main] wt.pom.properties - wt.pom.oracle.disableAlwaysSemiJoin= true
2017-02-09 07:51:51,493 INFO [main] wt.pom.properties - wt.pom.oracle.jdbcConnectionMemoryLimit= 48
2017-02-09 07:51:51,493 INFO [main] wt.pom.properties - wt.pom.oracle.jdbcConnectionUseService= true
2017-02-09 07:51:51,493 INFO [main] wt.pom.properties - wt.pom.oracle.nlssort.truncateLength= 600
2017-02-09 07:51:51,493 INFO [main] wt.pom.properties - wt.pom.resultSetThreadPool.size = 7
2017-02-09 07:51:51,493 INFO [main] wt.pom.properties - wt.pom.resultSetThreadPool.queueSize = -1
2017-02-09 07:51:51,493 INFO [main] wt.pom.properties - wt.pom.resultSetThreadPool.implicitEnabled=false
2017-02-09 07:51:51,493 INFO [main] wt.pom.properties - wt.pom.externalTableValidSchemaNames = null
2017-02-09 07:51:51,493 INFO [main] wt.pom.properties - wt.pom.pdsHandleByteAsShort = false
2017-02-09 07:51:51,493 INFO [main] wt.pom.properties - wt.pom.pdsTruncateDate = true
2017-02-09 07:51:51,493 INFO [main] wt.pom.properties - wt.pom.useExplicitTimezoneForJDBC = false
2017-02-09 07:51:51,493 INFO [main] wt.pom.properties - Windchill DataStore: Oracle
2017-02-09 07:51:51,493 INFO [main] wt.pom.properties - Windchill DataStore is not cluster
2017-02-09 07:51:51,493 INFO [main] wt.pom.properties - JDBC Driver Version: major=12 minor=1
2017-02-09 07:51:51,728 INFO [main] wt.method.server.startup - MethodServer created - port 5003: MethodServerImpl[UnicastServerRef2 [liveRef: [endpoint:[172.31.26.169:5003,wt.boot.WTRMIMasterSocketFactory@1e240](local),objID:[-6bc69733:15a21a4703d:-7ffc, 4689392886346469270]]]]
2017-02-09 07:51:51,743 INFO [main] wt.util.WTPropertiesWatcher - wt.properties being watched at: D:\ptc\Windchill_11.0\Windchill\codebase\wt.properties
2017-02-09 07:51:52,071 INFO [main] wt.method.server.startup - Starting services - class = wt.services.StandardServicesHandler
2017-02-09 07:51:53,306 INFO [main] wt.system.err - javax.naming.AuthenticationException: [LDAP: error code 49 - Invalid Credentials]
2017-02-09 07:51:53,306 INFO [main] wt.system.err - at com.sun.jndi.ldap.LdapCtx.mapErrorCode(LdapCtx.java:3135)
2017-02-09 07:51:53,306 INFO [main] wt.system.err - at com.sun.jndi.ldap.LdapCtx.processReturnCode(LdapCtx.java:3081)
2017-02-09 07:51:53,306 INFO [main] wt.system.err - at com.sun.jndi.ldap.LdapCtx.processReturnCode(LdapCtx.java:2883)
2017-02-09 07:51:53,306 INFO [main] wt.system.err - at com.sun.jndi.ldap.LdapCtx.connect(LdapCtx.java:2797)
2017-02-09 07:51:53,306 INFO [main] wt.system.err - at com.sun.jndi.ldap.LdapCtx.<init>(LdapCtx.java:319)
2017-02-09 07:51:53,306 INFO [main] wt.system.err - at com.sun.jndi.ldap.LdapCtxFactory.getUsingURL(LdapCtxFactory.java:192)
2017-02-09 07:51:53,321 INFO [main] wt.system.err - at com.sun.jndi.ldap.LdapCtxFactory.getUsingURLs(LdapCtxFactory.java:210)
2017-02-09 07:51:53,321 INFO [main] wt.system.err - at com.sun.jndi.ldap.LdapCtxFactory.getLdapCtxInstance(LdapCtxFactory.java:153)
2017-02-09 07:51:53,321 INFO [main] wt.system.err - at com.sun.jndi.ldap.LdapCtxFactory.getInitialContext(LdapCtxFactory.java:83)
2017-02-09 07:51:53,321 INFO [main] wt.system.err - at javax.naming.spi.NamingManager.getInitialContext(NamingManager.java:684)
2017-02-09 07:51:53,321 INFO [main] wt.system.err - at javax.naming.InitialContext.getDefaultInitCtx(InitialContext.java:313)
2017-02-09 07:51:53,321 INFO [main] wt.system.err - at javax.naming.InitialContext.init(InitialContext.java:244)
2017-02-09 07:51:53,321 INFO [main] wt.system.err - at javax.naming.ldap.InitialLdapContext.<init>(InitialLdapContext.java:154)
2017-02-09 07:51:53,321 INFO [main] wt.system.err - at com.infoengine.jndi.DirContextWrapper.<init>(DirContextWrapper.java:89)
2017-02-09 07:51:53,321 INFO [main] wt.system.err - at com.infoengine.jndi.JNDIAdapterImpl.getDirContext(JNDIAdapterImpl.java:299)
2017-02-09 07:51:53,321 INFO [main] wt.system.err - at com.infoengine.jndi.JNDIAdapterImpl.processRequest(JNDIAdapterImpl.java:209)
2017-02-09 07:51:53,321 INFO [main] wt.system.err - at com.infoengine.au.DirectoryService.queryObjects(DirectoryService.java:153)
2017-02-09 07:51:53,321 INFO [main] wt.system.err - at com.infoengine.au.DirectoryInputStream.setUrl(DirectoryInputStream.java:92)
2017-02-09 07:51:53,321 INFO [main] wt.system.err - at com.infoengine.au.DirectoryInputStream.<init>(DirectoryInputStream.java:72)
2017-02-09 07:51:53,321 INFO [main] wt.system.err - at com.infoengine.au.DirectoryPropertyInputStream.setUrl(DirectoryPropertyInputStream.java:102)
2017-02-09 07:51:53,321 INFO [main] wt.system.err - at com.infoengine.au.DirectoryPropertyInputStream.<init>(DirectoryPropertyInputStream.java:72)
2017-02-09 07:51:53,321 INFO [main] wt.system.err - at com.infoengine.au.IEProperties.resetProperties(IEProperties.java:1162)
2017-02-09 07:51:53,321 INFO [main] wt.system.err - at com.infoengine.au.IEProperties.resetProperties(IEProperties.java:1153)
2017-02-09 07:51:53,321 INFO [main] wt.system.err - at com.infoengine.au.IEProperties.resetProperties(IEProperties.java:1099)
2017-02-09 07:51:53,321 INFO [main] wt.system.err - at com.infoengine.au.IEProperties.resetProperties(IEProperties.java:1077)
2017-02-09 07:51:53,321 INFO [main] wt.system.err - at com.infoengine.au.NamingService.setProperties(NamingService.java:1160)
2017-02-09 07:51:53,321 INFO [main] wt.system.err - at com.infoengine.au.NamingService.newInstance(NamingService.java:265)
2017-02-09 07:51:53,321 INFO [main] wt.system.err - at com.infoengine.au.NamingService.newInstance(NamingService.java:197)
2017-02-09 07:51:53,321 INFO [main] wt.system.err - at wt.federation.StandardFederationService.initInfoEngineProperties(StandardFederationService.java:2267)
2017-02-09 07:51:53,321 INFO [main] wt.system.err - at wt.org.StandardOrganizationServicesManager.<clinit>(StandardOrganizationServicesManager.java:444)
2017-02-09 07:51:53,321 INFO [main] wt.system.err - at java.lang.Class.forName0(Native Method)
2017-02-09 07:51:53,321 INFO [main] wt.system.err - at java.lang.Class.forName(Class.java:264)
2017-02-09 07:51:53,321 INFO [main] wt.system.err - at wt.services.ManagerImplementation.create(ManagerImplementation.java:235)
2017-02-09 07:51:53,321 INFO [main] wt.system.err - at wt.services.StandardManagerFactory.createImplementations(StandardManagerFactory.java:135)
2017-02-09 07:51:53,321 INFO [main] wt.system.err - at wt.services.StandardManagerFactory.<init>(StandardManagerFactory.java:117)
2017-02-09 07:51:53,321 INFO [main] wt.system.err - at wt.services.StandardManagerFactory$Singleton.<clinit>(StandardManagerFactory.java:73)
2017-02-09 07:51:53,321 INFO [main] wt.system.err - at wt.services.StandardManagerFactory.getInstance(StandardManagerFactory.java:102)
2017-02-09 07:51:53,321 INFO [main] wt.system.err - at wt.services.StandardManagerService.createFactory(StandardManagerService.java:373)
2017-02-09 07:51:53,321 INFO [main] wt.system.err - at wt.services.StandardManagerService.initialize(StandardManagerService.java:363)
2017-02-09 07:51:53,321 INFO [main] wt.system.err - at wt.services.StandardManagerService.newStandardManagerService(StandardManagerService.java:99)
2017-02-09 07:51:53,321 INFO [main] wt.system.err - at wt.services.StandardServicesHandler.getFactory(StandardServicesHandler.java:51)
2017-02-09 07:51:53,321 INFO [main] wt.system.err - at wt.services.StandardServicesHandler.start(StandardServicesHandler.java:42)
2017-02-09 07:51:53,321 INFO [main] wt.system.err - at wt.method.MethodServerMain.run(MethodServerMain.java:602)
2017-02-09 07:51:53,321 INFO [main] wt.system.err - at wt.method.MethodServerMain.main(MethodServerMain.java:372)
2017-02-09 07:51:53,368 INFO [main] wt.system.err - java.io.IOException: com.infoengine.exception.adapter.IEAdapterException; nested exception is:
2017-02-09 07:51:53,368 INFO [main] wt.system.err - javax.naming.AuthenticationException: [LDAP: error code 49 - Invalid Credentials]
2017-02-09 07:51:53,368 INFO [main] wt.system.err - at com.infoengine.au.IEProperties.resetProperties(IEProperties.java:1217)
2017-02-09 07:51:53,368 INFO [main] wt.system.err - at com.infoengine.au.IEProperties.resetProperties(IEProperties.java:1153)
2017-02-09 07:51:53,368 INFO [main] wt.system.err - at com.infoengine.au.IEProperties.resetProperties(IEProperties.java:1099)
2017-02-09 07:51:53,368 INFO [main] wt.system.err - at com.infoengine.au.IEProperties.resetProperties(IEProperties.java:1077)
2017-02-09 07:51:53,368 INFO [main] wt.system.err - at com.infoengine.au.NamingService.setProperties(NamingService.java:1160)
2017-02-09 07:51:53,368 INFO [main] wt.system.err - at com.infoengine.au.NamingService.newInstance(NamingService.java:265)
2017-02-09 07:51:53,368 INFO [main] wt.system.err - at com.infoengine.au.NamingService.newInstance(NamingService.java:197)
2017-02-09 07:51:53,368 INFO [main] wt.system.err - at wt.federation.StandardFederationService.initInfoEngineProperties(StandardFederationService.java:2267)
2017-02-09 07:51:53,368 INFO [main] wt.system.err - at wt.org.StandardOrganizationServicesManager.<clinit>(StandardOrganizationServicesManager.java:444)
2017-02-09 07:51:53,368 INFO [main] wt.system.err - at java.lang.Class.forName0(Native Method)
2017-02-09 07:51:53,368 INFO [main] wt.system.err - at java.lang.Class.forName(Class.java:264)
2017-02-09 07:51:53,368 INFO [main] wt.system.err - at wt.services.ManagerImplementation.create(ManagerImplementation.java:235)
2017-02-09 07:51:53,368 INFO [main] wt.system.err - at wt.services.StandardManagerFactory.createImplementations(StandardManagerFactory.java:135)
2017-02-09 07:51:53,368 INFO [main] wt.system.err - at wt.services.StandardManagerFactory.<init>(StandardManagerFactory.java:117)
2017-02-09 07:51:53,368 INFO [main] wt.system.err - at wt.services.StandardManagerFactory$Singleton.<clinit>(StandardManagerFactory.java:73)
2017-02-09 07:51:53,368 INFO [main] wt.system.err - at wt.services.StandardManagerFactory.getInstance(StandardManagerFactory.java:102)
2017-02-09 07:51:53,368 INFO [main] wt.system.err - at wt.services.StandardManagerService.createFactory(StandardManagerService.java:373)
2017-02-09 07:51:53,368 INFO [main] wt.system.err - at wt.services.StandardManagerService.initialize(StandardManagerService.java:363)
2017-02-09 07:51:53,368 INFO [main] wt.system.err - at wt.services.StandardManagerService.newStandardManagerService(StandardManagerService.java:99)
2017-02-09 07:51:53,368 INFO [main] wt.system.err - at wt.services.StandardServicesHandler.getFactory(StandardServicesHandler.java:51)
2017-02-09 07:51:53,368 INFO [main] wt.system.err - at wt.services.StandardServicesHandler.start(StandardServicesHandler.java:42)
2017-02-09 07:51:53,368 INFO [main] wt.system.err - at wt.method.MethodServerMain.run(MethodServerMain.java:602)
2017-02-09 07:51:53,368 INFO [main] wt.system.err - at wt.method.MethodServerMain.main(MethodServerMain.java:372)
2017-02-09 07:51:53,368 ERROR [main] wt.org.StandardOrganizationServicesManager -
java.io.IOException: com.infoengine.exception.adapter.IEAdapterException; nested exception is:
javax.naming.AuthenticationException: [LDAP: error code 49 - Invalid Credentials]
at com.infoengine.au.IEProperties.resetProperties(IEProperties.java:1217)
at com.infoengine.au.IEProperties.resetProperties(IEProperties.java:1153)
at com.infoengine.au.IEProperties.resetProperties(IEProperties.java:1099)
at com.infoengine.au.IEProperties.resetProperties(IEProperties.java:1077)
at com.infoengine.au.NamingService.setProperties(NamingService.java:1160)
at com.infoengine.au.NamingService.newInstance(NamingService.java:265)
at com.infoengine.au.NamingService.newInstance(NamingService.java:197)
at wt.federation.StandardFederationService.initInfoEngineProperties(StandardFederationService.java:2267)
at wt.org.StandardOrganizationServicesManager.<clinit>(StandardOrganizationServicesManager.java:444)
at java.lang.Class.forName0(Native Method)
at java.lang.Class.forName(Class.java:264)
at wt.services.ManagerImplementation.create(ManagerImplementation.java:235)
at wt.services.StandardManagerFactory.createImplementations(StandardManagerFactory.java:135)
at wt.services.StandardManagerFactory.<init>(StandardManagerFactory.java:117)
at wt.services.StandardManagerFactory$Singleton.<clinit>(StandardManagerFactory.java:73)
at wt.services.StandardManagerFactory.getInstance(StandardManagerFactory.java:102)
at wt.services.StandardManagerService.createFactory(StandardManagerService.java:373)
at wt.services.StandardManagerService.initialize(StandardManagerService.java:363)
at wt.services.StandardManagerService.newStandardManagerService(StandardManagerService.java:99)
at wt.services.StandardServicesHandler.getFactory(StandardServicesHandler.java:51)
at wt.services.StandardServicesHandler.start(StandardServicesHandler.java:42)
at wt.method.MethodServerMain.run(MethodServerMain.java:602)
at wt.method.MethodServerMain.main(MethodServerMain.java:372)
2017-02-09 07:51:53,368 ERROR [main] wt.method.server.startup.services - Failed to create: wt.services.service.90=wt.org.OrganizationServicesManager/wt.org.StandardOrganizationServicesManager
java.lang.ExceptionInInitializerError
at wt.org.StandardOrganizationServicesManager.<clinit>(StandardOrganizationServicesManager.java:482)
at java.lang.Class.forName0(Native Method)
at java.lang.Class.forName(Class.java:264)
at wt.services.ManagerImplementation.create(ManagerImplementation.java:235)
at wt.services.StandardManagerFactory.createImplementations(StandardManagerFactory.java:135)
at wt.services.StandardManagerFactory.<init>(StandardManagerFactory.java:117)
at wt.services.StandardManagerFactory$Singleton.<clinit>(StandardManagerFactory.java:73)
at wt.services.StandardManagerFactory.getInstance(StandardManagerFactory.java:102)
at wt.services.StandardManagerService.createFactory(StandardManagerService.java:373)
at wt.services.StandardManagerService.initialize(StandardManagerService.java:363)
at wt.services.StandardManagerService.newStandardManagerService(StandardManagerService.java:99)
at wt.services.StandardServicesHandler.getFactory(StandardServicesHandler.java:51)
at wt.services.StandardServicesHandler.start(StandardServicesHandler.java:42)
at wt.method.MethodServerMain.run(MethodServerMain.java:602)
at wt.method.MethodServerMain.main(MethodServerMain.java:372)
Caused by: java.io.IOException: com.infoengine.exception.adapter.IEAdapterException; nested exception is:
javax.naming.AuthenticationException: [LDAP: error code 49 - Invalid Credentials]
at com.infoengine.au.IEProperties.resetProperties(IEProperties.java:1217)
at com.infoengine.au.IEProperties.resetProperties(IEProperties.java:1153)
at com.infoengine.au.IEProperties.resetProperties(IEProperties.java:1099)
at com.infoengine.au.IEProperties.resetProperties(IEProperties.java:1077)
at com.infoengine.au.NamingService.setProperties(NamingService.java:1160)
at com.infoengine.au.NamingService.newInstance(NamingService.java:265)
at com.infoengine.au.NamingService.newInstance(NamingService.java:197)
at wt.federation.StandardFederationService.initInfoEngineProperties(StandardFederationService.java:2267)
at wt.org.StandardOrganizationServicesManager.<clinit>(StandardOrganizationServicesManager.java:444)
... 14 more
2017-02-09 07:51:53,384 FATAL [main] wt.method.server - MethodServerMain abort
java.io.IOException: com.infoengine.exception.adapter.IEAdapterException; nested exception is:
javax.naming.AuthenticationException: [LDAP: error code 49 - Invalid Credentials]
at com.infoengine.au.IEProperties.resetProperties(IEProperties.java:1217)
at com.infoengine.au.IEProperties.resetProperties(IEProperties.java:1153)
at com.infoengine.au.IEProperties.resetProperties(IEProperties.java:1099)
at com.infoengine.au.IEProperties.resetProperties(IEProperties.java:1077)
at com.infoengine.au.NamingService.setProperties(NamingService.java:1160)
at com.infoengine.au.NamingService.newInstance(NamingService.java:265)
at com.infoengine.au.NamingService.newInstance(NamingService.java:197)
at wt.federation.StandardFederationService.initInfoEngineProperties(StandardFederationService.java:2267)
at wt.org.StandardOrganizationServicesManager.<clinit>(StandardOrganizationServicesManager.java:444)
at java.lang.Class.forName0(Native Method)
at java.lang.Class.forName(Class.java:264)
at wt.services.ManagerImplementation.create(ManagerImplementation.java:235)
at wt.services.StandardManagerFactory.createImplementations(StandardManagerFactory.java:135)
at wt.services.StandardManagerFactory.<init>(StandardManagerFactory.java:117)
at wt.services.StandardManagerFactory$Singleton.<clinit>(StandardManagerFactory.java:73)
at wt.services.StandardManagerFactory.getInstance(StandardManagerFactory.java:102)
at wt.services.StandardManagerService.createFactory(StandardManagerService.java:373)
at wt.services.StandardManagerService.initialize(StandardManagerService.java:363)
at wt.services.StandardManagerService.newStandardManagerService(StandardManagerService.java:99)
at wt.services.StandardServicesHandler.getFactory(StandardServicesHandler.java:51)
at wt.services.StandardServicesHandler.start(StandardServicesHandler.java:42)
at wt.method.MethodServerMain.run(MethodServerMain.java:602)
at wt.method.MethodServerMain.main(MethodServerMain.java:372)
2017-02-09 07:51:53,399 FATAL [main] wt.method.server.shutdown - Stopping services...
2017-02-09 07:51:53,399 INFO [main] wt.system.out - WARNING: The ManagerService is not initialized! This can be caused by:
2017-02-09 07:51:53,399 INFO [main] wt.system.out - 1) Attempting to invoke a server only method from a remote client
2017-02-09 07:51:53,399 INFO [main] wt.system.out - 2) Attempting to invoke a method on a service from the constructor or static initializer of another service
2017-02-09 07:51:53,399 FATAL [main] wt.method.server.shutdown - MethodServer stopped
2017-02-09 07:51:53,603 INFO [wt.log4j.jmx.AsyncJDBCAppender.worker] wt.pom.properties - Connection: datastore=Oracle(Oracle Database 11g Enterprise Edition Release 11.2.0.1.0 - 64bit Production) jdbcVersion=4.1 driver=Oracle JDBC driver(12.1.0.1.0) driverVersion=12.1
I tried restarting Windchill DS, Apache, and the Server Manager.
Can someone please help me?
Did you make rehost?
Do you have the windchill server with an active directory adapter?
I didn't rehost but I think something happened with the same effect. How can I connect (or make sure that it already is) my Windchill Server to an active directory adapter?
Thank you so much..
Ammar
I enable more logs and got this:
2017-02-09 10:05:51,138 WARN [main] com.ptc.windchill.keystore.KeyStoreProxy - Creating new keystore
2017-02-09 10:05:51,138 DEBUG [main] com.ptc.windchill.keystore.KeyStoreProxy - Getting a key that does not exist: (encrypted.ie.ldap.managerPw)
2017-02-09 10:05:51,294 INFO [main] wt.system.err - javax.naming.AuthenticationException: [LDAP: error code 49 - Invalid Credentials]
Do you know how Windchill fetches the encryption?
Hi Ammar,
Looks like Windchill is unable to fetch the passwords for Database, LDAP etc. from Keystore files. Did you correct the dbpassword yesterday? Update the Ldap password from site.xconf using xconfmanager and see if you get any other password issue. If so, then you have to recreate the keystore.
Refer the below article to recreate it.
https://support.ptc.com/appserver/cs/view/solution.jsp?n=CS110492
Thanks,
Bhagirath
Thanks a lot Bhagirath! I recreated the keystore and got past the error LDAP: error code 49, but I encountered LDAP: error code 53
javax.naming.OperationNotSupportedException: [LDAP: error code 53 - Rejecting the requested operation because the connection has not been authenticated];
I can connect to Windchill DS but something is wrong when Windchill tries to connect to the LDAP upon launch. Any clue?
Thanks again!
Ammar
May be you need to change password for mapcredentials.admin.adapters
Title | How to change the password of the property mapcredentials.admin.adapters in Windchill PDMLink |
---|---|
Description |
|
Applies To |
|
Cause | |
Resolution |
|
Thank you Sergey, it seems like the definition of my password encryption got erased, not sure why.
I now get error javax.naming.OperationNotSupportedException: [LDAP: error code 53 - Rejecting the requested operation because the connection has not been authenticated];
Did you ever see this?
The error message "LDAP: error code 53 - Rejecting the requested operation because the connection has not been authenticated" is display in the logs in Windchill PDMLink
https://support.ptc.com/appserver/cs/view/solution.jsp?n=CS77583
I appreciate all the responses.
For those with a similar error in the future: I had to roll-back my machine to my latest working state. No solution here fixed my problem..
Good luck,
Ammar
in addition with jndi you must respect this exact process :
your original map credential file is located at windchill\codebase\WEB-INF\mapCredentials.txt and looks like this if using an enterprise ldap :
mapcredentials.admin.adapters=net.<yourdomain>.Ldap^cn\=<DsAccount>r^encrypted.net.<yourdomain>.Ldap.cn\=<DsAccount>r;net.<yourdomain>.<yourserver>.ldap-pending^cn\=<DsAccount>^encrypted.net.<yourdomain>.<yourserver>.ldap-pending.cn\=<DsAccount>;net.<yourdomain>.EnterpriseLdap^<youraccount>^encrypted.net.<yourdomain>.EnterpriseLdap.<youraccount>
mapcredentials.nonprivileged.adapters=
The new map credential will erase the old one, using the shell, ldap info per ldap info, ie : ldap, pending then after ldap and ending with enterprise ldap.
caution : input the "-" with your keyboard rather than copy paste in the shell. the "<>" must be replaced with "your data".
open a windchill shell and type :
xconfmanager -t codebase/WEB/mapCredentials.txt -s "mapcredentials.admin.adapters=net.<yourdomain>.EnterpriseLdap^CN=<youraccount>,OU=<depending on your enterprise ldap orgs>,OU=< same specific> -,DC=<yourdomaindc>,DC=net^<yourpassword>"
hit enter, the shell will display :
Default product root=[...]Windchill\bin\.. java -jar "[...]Windchill\bin\..\codebase\WEB-INF\lib\install.jar" -r "[...]Windchill\bin\.." -t codebase/WEB/mapCredentials.txt -s "mapcredentials.admin.adapters=net.yourdomain.EnterpriseLdap^CN=<youraccount>,OU=<depending on your enterprise ldap orgs>,OU=< same specific> -,DC=<yourdomain dc>,DC=net^<yourpassword>"
then type
xconfmanager -t codebase/WEB-INF/mapCredentials.txt --add "mapcredentials.admin.adapters=net.<yourdomain>.Ldap^cn=<DsAccount>^<DsPassword>"
hit enter, the shell will display :
Default product root=[...]Windchill\bin\.. java -jar "[...]Windchill\bin\..\codebase\WEB-INF\lib\install.jar" -r "[...]Windchill\bin\.." -t codebase/WEB-INF/mapCredentials.txt --add "mapcredentials.admin.adapters=net.yourdomain.Ldap^cn=<DsAccount>^<DsPassword>"
then type
xconfmanager -t codebase/WEB-INF/mapCredentials.txt --add "mapcredentials.admin.adapters=net.<yourdomain>.<yourserver>.ldap-pending^cn=<DsAccount>^<DsPassword>"
hit enter, the shell will display :
Default product root=[...]Windchill\bin\.. java -jar "[...]Windchill\bin\..\codebase\WEB-INF\lib\install.jar" -r "[...]Windchill\bin\.." -t codebase/WEB-INF/mapCredentials.txt --add "mapcredentials.admin.adapters=net.<yourdomain>.<yourserver>.ldap-pending^cn=<DsAccount>^<DsPassword>"
then type
xconfmanager -p
then restart apache an windchill.