Unable to run server.product

662 views

Skip to first unread message

Derek Lew

unread,

Oct 18, 2013, 8:51:42 PM10/18/13

to idem...@googlegroups.com

when I ran install.app, I am getting:

Oct 19, 2013 8:47:56 AM org.compiere.util.Language getLanguage

INFO: Adding Language=en, Country=SG, Locale=en_SG

*** 2013-10-19 08:47:56.887 idempiere Log (CLogConsole) ***

08:47:56.946 ConfigurationData.load: C:\idempiere\idempiereEnv.properties [1]

08:48:00.126 Config.test: OK: JavaHome=C:\Program Files\Java\jdk1.7.0_25 [28]

08:48:00.127 Config.test: OK: Version=1.7.0_25 [28]

08:48:00.127 ConfigurationData.testAdempiere: OK: AdempiereHome = C:\idempiere [28]

08:48:00.129 KeyStoreMgt.<init>: C:\idempiere\keystore\myKeystore [28]

08:48:00.132 ConfigurationData.testAdempiere: OK: KeyStore = C:\idempiere\keystore\myKeystore [28]

08:48:00.132 Config.test: OK: AppsServer = Keredwell/192.168.2.2 [28]

testPort[http,Keredwell, 8080, /]

testServerPort: 8080

08:48:01.143 Config.test: OK: Web Port = 8080 [28]

testPort[https,Keredwell, 8443, /]

testServerPort: 8443

08:48:02.292 Config.test: OK: SSL Port = 8443 [28]

08:48:02.293 ConfigPostgreSQL.test: OK: Database Server = localhost/127.0.0.1 [28]

testPort[127.0.0.1, 5432]

08:48:02.294 ConfigPostgreSQL.test: OK: Database Port = 5432 [28]

08:48:02.344 ConfigPostgreSQL.test: OK: System Connection = jdbc:postgresql://localhost:5432/template1 [28]

08:48:02.363 ConfigPostgreSQL.test: OK: Database User = adempiere [28]

08:48:02.367-----------> ConfigurationData.testMail: Not valid: - Illegal address [28]

08:48:04.660 Config.test: OK: JavaHome=C:\Program Files\Java\jdk1.7.0_25 [31]

08:48:04.660 Config.test: OK: Version=1.7.0_25 [31]

08:48:04.661 ConfigurationData.testAdempiere: OK: AdempiereHome = C:\idempiere [31]

08:48:04.661 KeyStoreMgt.<init>: C:\idempiere\keystore\myKeystore [31]

08:48:04.662 ConfigurationData.testAdempiere: OK: KeyStore = C:\idempiere\keystore\myKeystore [31]

08:48:04.663 Config.test: OK: AppsServer = Keredwell/192.168.2.2 [31]

testPort[http,Keredwell, 8080, /]

testServerPort: 8080

08:48:05.666 Config.test: OK: Web Port = 8080 [31]

testPort[https,Keredwell, 8443, /]

testServerPort: 8443

08:48:06.669 Config.test: OK: SSL Port = 8443 [31]

08:48:06.669 ConfigPostgreSQL.test: OK: Database Server = localhost/127.0.0.1 [31]

testPort[127.0.0.1, 5432]

08:48:06.670 ConfigPostgreSQL.test: OK: Database Port = 5432 [31]

08:48:06.693 ConfigPostgreSQL.test: OK: System Connection = jdbc:postgresql://localhost:5432/template1 [31]

08:48:06.713 ConfigPostgreSQL.test: OK: Database User = adempiere [31]

08:48:06.714-----------> ConfigurationData.testMail: Not valid: - Illegal address [31]

08:48:06.717 Ini.loadProperties: C:\idempiere\idempiere.properties #28 [25]

08:48:06.717 ConfigurationData.save: C:\idempiere\idempiereEnv.properties [25]

file=C:\idempiere/org.adempiere.install/build.xml exists=true

Buildfile: C:\idempiere/org.adempiere.install/build.xml

parsing buildfile C:\idempiere\org.adempiere.install\build.xml with URI = file:/C:/idempiere/org.adempiere.install/build.xml

Project base dir set to: C:\idempiere\org.adempiere.install

[antlib:org.apache.tools.ant] Could not load definitions from resource org/apache/tools/ant/antlib.xml. It could not be found.

[property] Loading Environment env.

Build sequence for target(s) `setup' is [setupTomcat, setup]

Complete build sequence is [setupTomcat, setup, ]

setupTomcat:

[echo] Setup Tomcat ===================

[echo] IDEMPIERE_HOME = C:\iDempiere

[available] Found: C:\idempiere\idempiereEnv.properties

[property] Loading C:\idempiere\idempiereEnv.properties

Override ignored for property "JAVA_HOME"

Override ignored for property "IDEMPIERE_HOME"

[filter] Reading filters from C:\idempiere\idempiereEnv.properties

Reading filters from C:\idempiere\idempiereEnv.properties

[copy] Copying 1 file to C:\idempiere\org.adempiere.tomcat.config\META-INF\tomcat

[copy] Copying C:\idempiere\org.adempiere.tomcat.config\META-INF\tomcat\serverTemplate.xml to C:\idempiere\org.adempiere.tomcat.config\META-INF\tomcat\server.xml

Replacing: @ADEMPIERE_WEB_PORT@ -> 8080

Replacing: @ADEMPIERE_SSL_PORT@ -> 8443

Replacing: @ADEMPIERE_KEYSTORE@ -> C:\idempiere\keystore\myKeystore

Replacing: @ADEMPIERE_KEYSTOREPASS@ -> myPassword

Replacing: @ADEMPIERE_SSL_PORT@ -> 8443

setup:

BUILD SUCCESSFUL

Total time: 0 seconds

*** 2013-10-19 08:48:07.548 idempiere Log (CLogConsole) ***

But when I ran server.product, I am getting:

osgi> Oct 19, 2013 8:49:12 AM org.compiere.util.Language getLanguage

INFO: Adding Language=en, Country=SG, Locale=en_SG

SLF4J: Class path contains multiple SLF4J bindings.

SLF4J: Found binding in [bundleresource://28.fwk201785674:1/org/slf4j/impl/StaticLoggerBinder.class]

SLF4J: Found binding in [bundleresource://28.fwk201785674:2/org/slf4j/impl/StaticLoggerBinder.class]

SLF4J: See http://www.slf4j.org/codes.html#multiple_bindings for an explanation.

Oct 19, 2013 8:49:12 AM org.slf4j.impl.JCLLoggerAdapter info

INFO: Configuring Tomcat from fragment entry 'bundleentry://55.fwk201785674/META-INF/tomcat/server.xml'

Oct 19, 2013 8:49:12 AM org.apache.catalina.startup.SetAllPropertiesRule begin

WARNING: [SetAllPropertiesRule]{Server/Service/Connector} Setting property 'maxSpareThreads' to '75' did not find a matching property.

Oct 19, 2013 8:49:12 AM org.apache.catalina.startup.SetAllPropertiesRule begin

WARNING: [SetAllPropertiesRule]{Server/Service/Connector} Setting property 'maxSpareThreads' to '75' did not find a matching property.

Oct 19, 2013 8:49:12 AM org.apache.tomcat.util.digester.SetPropertiesRule begin

WARNING: [SetPropertiesRule]{Server/Service/Engine/Host} Setting property 'xmlValidation' to 'false' did not find a matching property.

Oct 19, 2013 8:49:12 AM org.apache.tomcat.util.digester.SetPropertiesRule begin

WARNING: [SetPropertiesRule]{Server/Service/Engine/Host} Setting property 'xmlNamespaceAware' to 'false' did not find a matching property.

Oct 19, 2013 8:49:13 AM org.apache.coyote.AbstractProtocol init

INFO: Initializing ProtocolHandler ["http-bio-8080"]

Oct 19, 2013 8:49:13 AM org.apache.coyote.AbstractProtocol init

INFO: Initializing ProtocolHandler ["http-bio-8443"]

Oct 19, 2013 8:49:13 AM org.apache.coyote.AbstractProtocol init

INFO: Initializing ProtocolHandler ["ajp-bio-8009"]

Oct 19, 2013 8:49:13 AM org.apache.catalina.core.StandardService startInternal

INFO: Starting service Catalina

Oct 19, 2013 8:49:13 AM org.apache.catalina.core.StandardEngine startInternal

INFO: Starting Servlet Engine: Apache Tomcat/7.0.21

Oct 19, 2013 8:49:13 AM org.apache.coyote.AbstractProtocol start

INFO: Starting ProtocolHandler ["http-bio-8080"]

Oct 19, 2013 8:49:13 AM org.apache.coyote.AbstractProtocol start

INFO: Starting ProtocolHandler ["http-bio-8443"]

Oct 19, 2013 8:49:13 AM org.apache.coyote.AbstractProtocol start

INFO: Starting ProtocolHandler ["ajp-bio-8009"]

Oct 19, 2013 8:49:13 AM org.apache.catalina.realm.JAASRealm setContainer

INFO: Set JAAS app name Catalina

Oct 19, 2013 8:49:13 AM org.compiere.web.AdempiereMonitorFilter init

INFO:

08:49:13.996 Ini.loadProperties: C:\idempiere\idempiere.properties #28 [32]

[INFO] MLog clients using com.mchange.v2.log.FallbackMLog logging.

[INFO] Initializing c3p0-0.9.2 [built 09-February-2013 02:13:17 +0000; debug? true; trace: 10]

[INFO] Initializing c3p0 pool... com.mchange.v2.c3p0.ComboPooledDataSource [ acquireIncrement -> 3, acquireRetryAttempts -> 2, acquireRetryDelay -> 1000, autoCommitOnClose -> false, automaticTestTable -> null, breakAfterAcquireFailure -> false, checkoutTimeout -> 0, connectionCustomizerClassName -> null, connectionTesterClassName -> com.mchange.v2.c3p0.impl.DefaultConnectionTester, dataSourceName -> iDempiereDS, debugUnreturnedConnectionStackTraces -> false, description -> null, driverClass -> org.postgresql.Driver, factoryClassLocation -> null, forceIgnoreUnresolvedTransactions -> false, identityToken -> 1hge1aa8x1l7jry7hwtic6|2f5e1167, idleConnectionTestPeriod -> 1200, initialPoolSize -> 10, jdbcUrl -> jdbc:postgresql://localhost:5432/idempiere?encoding=UNICODE, maxAdministrativeTaskTime -> 0, maxConnectionAge -> 0, maxIdleTime -> 1200, maxIdleTimeExcessConnections -> 1200, maxPoolSize -> 90, maxStatements -> 0, maxStatementsPerConnection -> 30, minPoolSize -> 5, numHelperThreads -> 3, preferredTestQuery -> SELECT Version FROM AD_System, properties -> {user=******, password=******}, propertyCycle -> 0, statementCacheNumDeferredCloseThreads -> 0, testConnectionOnCheckin -> false, testConnectionOnCheckout -> false, unreturnedConnectionTimeout -> 0, userOverrides -> {}, usesTraditionalReflectiveProxies -> false ]

08:49:14.293===========> MTable.get: SELECT * FROM AD_Table WHERE UPPER(TableName)=? [32]

org.postgresql.util.PSQLException: ERROR: relation "ad_table" does not exist

Position: 15; State=42P01; ErrorCode=0

at org.postgresql.core.v3.QueryExecutorImpl.receiveErrorResponse(QueryExecutorImpl.java:2157)

at org.postgresql.core.v3.QueryExecutorImpl.processResults(QueryExecutorImpl.java:1886)

at org.postgresql.core.v3.QueryExecutorImpl.execute(QueryExecutorImpl.java:255)

at org.postgresql.jdbc2.AbstractJdbc2Statement.execute(AbstractJdbc2Statement.java:559)

at org.postgresql.jdbc2.AbstractJdbc2Statement.executeWithFlags(AbstractJdbc2Statement.java:417)

at org.postgresql.jdbc2.AbstractJdbc2Statement.executeQuery(AbstractJdbc2Statement.java:302)

at com.mchange.v2.c3p0.impl.NewProxyPreparedStatement.executeQuery(NewProxyPreparedStatement.java:116)

at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)

at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)

at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)

at java.lang.reflect.Method.invoke(Method.java:606)

at org.compiere.db.StatementProxy.invoke(StatementProxy.java:126)

at com.sun.proxy.$Proxy0.executeQuery(Unknown Source)

at org.compiere.model.MTable.get(MTable.java:112)

at org.compiere.model.Query.<init>(Query.java:120)

at org.compiere.model.MSystem.get(MSystem.java:70)

at org.compiere.Adempiere.startupEnvironment(Adempiere.java:589)

at org.compiere.Adempiere.startup(Adempiere.java:551)

at org.compiere.util.WebEnv.initWeb(WebEnv.java:170)

at org.compiere.util.WebEnv.initWeb(WebEnv.java:129)

at org.compiere.web.AdempiereMonitor.init(AdempiereMonitor.java:1047)

[INFO] Multiply prepared statement! SELECT * FROM AD_Table WHERE UPPER(TableName)=?

[WARNING] [c3p0] A PooledConnection that has already signalled a Connection error is still in use!

[WARNING] [c3p0] Another error has occurred [ org.postgresql.util.PSQLException: ERROR: relation "ad_table" does not exist

Position: 15 ] which will not be reported to listeners!org.postgresql.util.PSQLException: ERROR: relation "ad_table" does not exist

Position: 15