grouper-users - [grouper-users] Re: Grouper Demo installer issues

Subject: Grouper Users - Open Discussion List

List archive

[grouper-users] Re: Grouper Demo installer issues

From: Roger Dills <>
To: "Hyzer, Chris" <>, "" <>
Subject: [grouper-users] Re: Grouper Demo installer issues
Date: Wed, 21 Mar 2018 21:26:48 +0000
Accept-language: en-US
Authentication-results: spf=none (sender IP is ) ;
Spamdiagnosticmetadata: NSPM
Spamdiagnosticoutput: 1:99

Hello,

To remove any confusion I've attached a complete "new" grouper 2.3 install dialogue using all the defaults. You can follow everything it does until it errors out on the WS component.

Ideally, there isn't much room to veer off the documented path.

Thank you,

Roger Dills
Senior Systems Administrator
Digital Infrastructure
The College of Wooster

From: Hyzer, Chris <>
Sent: Wednesday, March 21, 2018 2:37:20 PM
To: Roger Dills;
Subject: RE: Grouper Demo installer issues

It cant stop tomcat since it might not have been running, you can check processes to make sure its not running, then try continue as “true”

From: Roger Dills [mailto:]
Sent: Wednesday, March 21, 2018 12:19 PM
To: Hyzer, Chris <>;
Subject: RE: Grouper Demo installer issues

Hello Chris,

I’ve gone through the installer and it always seems to bomb out once it gets to the WS install.

The database and Tomcat will be up before it starts and then once it starts the install either or both go offline.

This is another attempt where I verified the database was up before the install, the installer verified and indicated tomcat was up, but only to see tomcat crash during the install.

Output from the attempt

******************

################ Checking patch grouper_v2_3_0_ui_patch_42

Patch doesnt exist yet (not an error): https://software.internet2.edu/grouper/release/2.3.0/patches/grouper_v2_3_0_ui_patch_42.tar.gz

Enter the GrouperSystem password:

The GrouperSystem password cannot be blank!

Enter the GrouperSystem password:

The GrouperSystem password cannot be blank!

Enter the GrouperSystem password:

The GrouperSystem password cannot be blank!

Enter the GrouperSystem password:

The GrouperSystem password cannot be blank!

Enter the GrouperSystem password: 1234356789

Do you want to set the GrouperSystem password in c:\grouper\apache-tomcat-8.5.12\conf\tomcat-users.xml? [t]:

Editing file: c:\grouper\apache-tomcat-8.5.12\conf\tomcat-users.xml

- adding Tomcat user GrouperSystem line: '<user username="GrouperSystem" password="123456789" roles="grouper_user"/>'

- adding Tomcat role grouper_user line: '<role rolename="grouper_user"/>'

Tomcat is supposed to be listening on port: 8080, port not listening, assuming tomcat is not running...

Should we stop tomcat anyway? (t|f)? [f]

##################################

Tomcat start with command (note you need CATALINA_HOME and JAVA_HOME set):

c:\grouper\apache-tomcat-8.5.12\bin\startup.bat

End tomcat start (note: logs are in c:\grouper\apache-tomcat-8.5.12\logs)

##################################

Should we check ports to see if tomcat was able to start (t|f)? [t]:

Waiting for tomcat to start...

Tomcat listening on port: 8080

##################################

Go here for the Grouper UI (change hostname if on different host): http://localhost:8080/grouper/

##################################

Do you want to install web services (t|f)? [t]:

wsFile path is c:\grouper\tarballs\grouper.ws-2.3.0.tar.gz

File exists: c:\grouper\tarballs\grouper.ws-2.3.0.tar.gz, should we use the local file (t|f)? [t]:

Unzipped file exists: c:\grouper\tarballs\grouper.ws-2.3.0.tar, use unzipped file (t|f)? [t]:

Unzipped Ws file is c:\grouper\tarballs\grouper.ws-2.3.0.tar

Untarred dir exists: c:\grouper\grouper.ws-2.3.0, use untarred dir (t|f)? [t]:

Editing c:\grouper\grouper.ws-2.3.0\grouper-ws\build.properties:

- property grouper.dir already was set to: c:/grouper/grouper.apiBinary-2.3.0, not changing file

The Grouper WS has been built in the past, do you want it rebuilt? (t|f) [t]:

##################################

Tomcat stop with command (note you need CATALINA_HOME and JAVA_HOME set):

c:\grouper\apache-tomcat-8.5.12\bin\shutdown.bat

Mar 21, 2018 12:02:43 PM edu.internet2.middleware.grouperInstaller.util.GrouperInstallerUtils execCommandHelper

SEVERE: Process exit status=1: out: , err: Mar 21, 2018 12:02:43 PM org.apache.catalina.startup.Catalina stopServer

SEVERE: Could not contact localhost:8005. Tomcat may not be running.

Mar 21, 2018 12:02:43 PM org.apache.catalina.startup.Catalina stopServer

SEVERE: Catalina.stop:

java.net.ConnectException: Connection refused: connect

at java.net.DualStackPlainSocketImpl.connect0(Native Method)

at java.net.DualStackPlainSocketImpl.socketConnect(DualStackPlainSocketImpl.java:79)

at java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:350)

at java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:206)

at java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:188)

at java.net.PlainSocketImpl.connect(PlainSocketImpl.java:172)

at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:392)

at java.net.Socket.connect(Socket.java:589)

at java.net.Socket.connect(Socket.java:538)

at java.net.Socket.<init>(Socket.java:434)

at java.net.Socket.<init>(Socket.java:211)

at org.apache.catalina.startup.Catalina.stopServer(Catalina.java:476)

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

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

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

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

at org.apache.catalina.startup.Bootstrap.stopServer(Bootstrap.java:408)

at org.apache.catalina.startup.Bootstrap.main(Bootstrap.java:497)

Java HotSpot(TM) 64-Bit Server VM warning: ignoring option MaxPermSize=150m; support was removed in 8.0

, on command: C:\Program Files\Java\jdk1.8.0_162\bin\java -XX:MaxPermSize=150m -Xmx640m -Dcatalina.home=c:\grouper\apache-tomcat-8.5.12 -cp c:\grouper\apache-tomcat-8.5.12\bin\bootstrap.jar;c:\grouper\apache-tomcat-8.5.12\bin\tomcat-juli.jar org.apache.catalina.startup.Bootstrap stop , workingDir: c:\grouper\apache-tomcat-8.5.12\bin

java.lang.RuntimeException: Process exit status=1: out: , err: Mar 21, 2018 12:02:43 PM org.apache.catalina.startup.Catalina stopServer

SEVERE: Could not contact localhost:8005. Tomcat may not be running.

Mar 21, 2018 12:02:43 PM org.apache.catalina.startup.Catalina stopServer

SEVERE: Catalina.stop:

java.net.ConnectException: Connection refused: connect

at java.net.DualStackPlainSocketImpl.connect0(Native Method)

at java.net.DualStackPlainSocketImpl.socketConnect(DualStackPlainSocketImpl.java:79)

at java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:350)

at java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:206)

at java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:188)

at java.net.PlainSocketImpl.connect(PlainSocketImpl.java:172)

at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:392)

at java.net.Socket.connect(Socket.java:589)

at java.net.Socket.connect(Socket.java:538)

at java.net.Socket.<init>(Socket.java:434)

at java.net.Socket.<init>(Socket.java:211)

at org.apache.catalina.startup.Catalina.stopServer(Catalina.java:476)

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

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

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

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

at org.apache.catalina.startup.Bootstrap.stopServer(Bootstrap.java:408)

at org.apache.catalina.startup.Bootstrap.main(Bootstrap.java:497)

Java HotSpot(TM) 64-Bit Server VM warning: ignoring option MaxPermSize=150m; support was removed in 8.0

java.lang.RuntimeException: caller stack

at edu.internet2.middleware.grouperInstaller.util.GrouperInstallerUtils.threadRunWithStatusDots(GrouperInstallerUtils.java:8345)

at edu.internet2.middleware.grouperInstaller.util.GrouperInstallerUtils.execCommand(GrouperInstallerUtils.java:10078)

at edu.internet2.middleware.grouperInstaller.util.GrouperInstallerUtils.execCommand(GrouperInstallerUtils.java:10041)

at edu.internet2.middleware.grouperInstaller.util.GrouperInstallerUtils.execCommand(GrouperInstallerUtils.java:10017)

at edu.internet2.middleware.grouperInstaller.GrouperInstaller.tomcatBounce(GrouperInstaller.java:1175)

at edu.internet2.middleware.grouperInstaller.GrouperInstaller.buildWs(GrouperInstaller.java:11344)

at edu.internet2.middleware.grouperInstaller.GrouperInstaller.mainInstallLogic(GrouperInstaller.java:8714)

at edu.internet2.middleware.grouperInstaller.GrouperInstaller.access$500(GrouperInstaller.java:83)

at edu.internet2.middleware.grouperInstaller.GrouperInstaller$GrouperInstallerMainFunction$2.logic(GrouperInstaller.java:1487)

at edu.internet2.middleware.grouperInstaller.GrouperInstaller.mainLogic(GrouperInstaller.java:1710)

at edu.internet2.middleware.grouperInstaller.GrouperInstaller.main(GrouperInstaller.java:550)

at edu.internet2.middleware.grouperInstaller.util.GrouperInstallerUtils.execCommandHelper(GrouperInstallerUtils.java:10175)

at edu.internet2.middleware.grouperInstaller.util.GrouperInstallerUtils.access$100(GrouperInstallerUtils.java:128)

at edu.internet2.middleware.grouperInstaller.util.GrouperInstallerUtils$2.run(GrouperInstallerUtils.java:10073)

at edu.internet2.middleware.grouperInstaller.util.GrouperInstallerUtils$1.run(GrouperInstallerUtils.java:8291)

at java.lang.Thread.run(Thread.java:748)

Do you want to continue (t|f)? [f]

**********************************

Maybe the script isn’t waiting long enough for Tomcat to “really” start?

From: Hyzer, Chris []
Sent: Wednesday, March 21, 2018 11:49 AM
To: Roger Dills;
Subject: Re: Grouper Demo installer issues

Do you have the database running before the WS starts? As you install it shows all the related commands, or the installer has commands to start/stop DB etc... ok?

From: <> on behalf of Roger Dills <>
Sent: Tuesday, March 20, 2018 5:07:56 PM
To:
Subject: [grouper-users] Grouper Demo installer issues

Hello,

I’m trying to get a demo install to complete without errors on Grouper V2.3.0.

The install works happily until I get to the web services client. It consistently bombs on its install.

The database contains only what the installer created. Running on Windows Server 2016 with Java JDK 1.8.

The error message

****************************************************

Should we check ports to see if tomcat was able to start (t|f)? [t]:

Waiting for tomcat to start...

Tomcat listening on port: 8080

This is the Grouper WS URL (change hostname if on different host): http://localhost:8080/grouper-ws/

Do you want to install the web services client (t|f)? [t]:

Downloading from URL: https://software.internet2.edu/grouper/release/2.3.0/grouper.clientBinary-2.3.0.tar.gz to file: c:\grouper\tarballs\grouper.clientBinary-2.3.0.tar.gz

Unzipping: c:\grouper\tarballs\grouper.clientBinary-2.3.0.tar.gz

Expanding: c:\grouper\tarballs\grouper.clientBinary-2.3.0.tar to c:\grouper\grouper.clientBinary-2.3.0

Editing c:\grouper\grouper.clientBinary-2.3.0\grouper.client.properties:

- set property: grouperClient.webService.url from: to: http://localhost:8080/grouper-ws/servicesRest

- set property: grouperClient.webService.login from: to: GrouperSystem

- set property: grouperClient.webService.password from: to: 123456789

##################################

Adding user GrouperSystem to grouper-ws users group with command:

cmd /c c:\grouper\grouper.apiBinary-2.3.0\bin\gsh.bat c:\grouper\grouper.apiBinary-2.3.0\gshAddGrouperSystemWsGroup.gsh

............

stderr: Couldnt startup grouper: Problems with db: DB: user: sa, url: jdbc:hsqldb:hsql://localhost:9001/grouper, driver: org.hsqldb.jdbcDriver

java.lang.RuntimeException: Problems with db: DB: user: sa, url: jdbc:hsqldb:hsql://localhost:9001/grouper, driver: org.hsqldb.jdbcDriver

at edu.internet2.middleware.grouper.app.loader.db.GrouperLoaderDb.connection(GrouperLoaderDb.java:254)

at edu.internet2.middleware.grouper.ddl.GrouperDdlUtils.bootstrapHelper(GrouperDdlUtils.java:436)

at edu.internet2.middleware.grouper.ddl.GrouperDdlUtils.bootstrap(GrouperDdlUtils.java:340)

at edu.internet2.middleware.grouper.misc.GrouperStartup.startup(GrouperStartup.java:303)

at edu.internet2.middleware.grouper.app.gsh.GrouperShell.main(GrouperShell.java:156)

at edu.internet2.middleware.grouper.app.gsh.GrouperShellWrapper.main(GrouperShellWrapper.java:31)

Caused by: java.sql.SQLException: Connections could not be acquired from the underlying database!

at com.mchange.v2.sql.SqlUtils.toSQLException(SqlUtils.java:118)

at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool.checkoutPooledConnection(C3P0PooledConnectionPool.java:692)

at com.mchange.v2.c3p0.impl.AbstractPoolBackedDataSource.getConnection(AbstractPoolBackedDataSource.java:140)

at edu.internet2.middleware.grouper.app.loader.db.GrouperLoaderDb.connection(GrouperLoaderDb.java:251)

... 5 more

Caused by: com.mchange.v2.resourcepool.CannotAcquireResourceException: A ResourcePool could not acquire a resource from its primary factory or source.

at com.mchange.v2.resourcepool.BasicResourcePool.awaitAvailable(BasicResourcePool.java:1469)

at com.mchange.v2.resourcepool.BasicResourcePool.prelimCheckoutResource(BasicResourcePool.java:644)

at com.mchange.v2.resourcepool.BasicResourcePool.checkoutResource(BasicResourcePool.java:554)

at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool.checkoutAndMarkConnectionInUse(C3P0PooledConnectionPool.java:758)

at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool.checkoutPooledConnection(C3P0PooledConnectionPool.java:685)

... 7 more

Caused by: java.sql.SQLTransientConnectionException: java.net.ConnectException: Connection refused: connect

at org.hsqldb.jdbc.JDBCUtil.sqlException(Unknown Source)

at org.hsqldb.jdbc.JDBCConnection.<init>(Unknown Source)

at org.hsqldb.jdbc.JDBCDriver.getConnection(Unknown Source)

at org.hsqldb.jdbc.JDBCDriver.connect(Unknown Source)

at com.mchange.v2.c3p0.DriverManagerDataSource.getConnection(DriverManagerDataSource.java:175)

at com.mchange.v2.c3p0.WrapperConnectionPoolDataSource.getPooledConnection(WrapperConnectionPoolDataSource.java:220)

at com.mchange.v2.c3p0.WrapperConnectionPoolDataSource.getPooledConnection(WrapperConnectionPoolDataSource.java:206)

at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool$1PooledConnectionResourcePoolManager.acquireResource(C3P0PooledConnectionPool.java:203)

at com.mchange.v2.resourcepool.BasicResourcePool.doAcquire(BasicResourcePool.java:1138)

at com.mchange.v2.resourcepool.BasicResourcePool.doAcquireAndDecrementPendingAcquiresWithinLockOnSuccess(BasicResourcePool.java:1125)

at com.mchange.v2.resourcepool.BasicResourcePool.access$700(BasicResourcePool.java:44)

at com.mchange.v2.resourcepool.BasicResourcePool$ScatteredAcquireTask.run(BasicResourcePool.java:1870)

at com.mchange.v2.async.ThreadPoolAsynchronousRunner$PoolThread.run(ThreadPoolAsynchronousRunner.java:696)

Caused by: org.hsqldb.HsqlException: java.net.ConnectException: Connection refused: connect

at org.hsqldb.ClientConnection.openConnection(Unknown Source)

at org.hsqldb.ClientConnection.initConnection(Unknown Source)

at org.hsqldb.ClientConnection.<init>(Unknown Source)

... 12 more

Caused by: java.net.ConnectException: Connection refused: connect

at java.net.DualStackPlainSocketImpl.connect0(Native Method)

at java.net.DualStackPlainSocketImpl.socketConnect(DualStackPlainSocketImpl.java:79)

at java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:350)

at java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:206)

at java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:188)

at java.net.PlainSocketImpl.connect(PlainSocketImpl.java:172)

at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:392)

at java.net.Socket.connect(Socket.java:589)

at java.net.Socket.connect(Socket.java:538)

at java.net.Socket.<init>(Socket.java:434)

at java.net.Socket.<init>(Socket.java:211)

at org.hsqldb.server.HsqlSocketFactory.createSocket(Unknown Source)

... 15 more

Exception in thread "main" java.lang.RuntimeException: Problems with db: DB: user: sa, url: jdbc:hsqldb:hsql://localhost:9001/grouper, driver: org.hsqldb.jdbcDriver