Grouper Users - Open Discussion List

[Dominique Petitpierre <>]

Hello,

after installing Grouper 2.1.1 running "gsh.sh -test -all" produces
many errors and failures. To narrow the search range for clues I tried
to run just one set of tests like this:

# cleanup the DB:
$GROUPER_HOME/bin/gsh.sh -registry -droponly -runscript
# reinitialize the schema:
$GROUPER_HOME/bin/gsh.sh -registry -noprompt -runsqlfile
grouperDdl_20120808_15_51_05_967.sql > & gsh-runsqlfile.out
# run one class of tests:
( $GROUPER_HOME/bin/gsh.sh -test TestStem >
/var/tmp/gsh.sh_-test_TestStem.out ) > & /var/tmp/gsh.sh_-test_TestStem.err

This ends with one failure (the full stdout and stderr output are in
annexe):

testGetChildGroups2(edu.internet2.middleware.grouper.TestStem)junit.framework.AssertionFailedError:
Expecting groups of size: 6 but received size: 7...

There is no corresponding error in
$GROUPER_HOME/logs/grouper_error.log

Context:
Grouper 2.1.1 (unpacked from
http://www.internet2.edu/grouper/release/2.1.1/grouper.apiBinary-2.1.1.tar.gz)
Java 1.6.0_33
DB: Oracle 10g
OS: Oracle Solaris 11 11/11 X86
Specific config in grouper.hibernate.properties:
hibernate.connection.driver_class = oracle.jdbc.driver.OracleDriver
hibernate.dialect               =  org.hibernate.dialect.Oracle10gDialect
hibernate.connection.password         =
/usr/local/grouper/conf/pw1.encrypted.tx
hibernate.connection.username         = grouperuser
hibernate.connection.url = jdbc:oracle:thin:@dbhost.unige.ch:1521:dbinstance

- Where could the problem be? (
- What could I do next? (e.g. raise the log level somewhere)?

Thanks in advance for your help!

Dominique
--
Mr Dominique Petitpierre, user=Dominique.Petitpierre domain=unige.ch
IT Division, University of Geneva, Switzerland
Grouper warning: cannot find group from config: wheel group from 
grouper.properties key: groups.wheel.group: etc:sysadmingroup
Grouper note: auto-created wheel group from grouper.properties key: 
groups.wheel.group: etc:sysadmingroup
Grouper note: auto-created attributeDefName: 
etc:attribute:attrExternalSubjectInvite:externalSubjectInvite
Grouper note: auto-created attributeDefName: 
etc:attribute:attrExternalSubjectInvite:externalSubjectInviteExpireDate
Grouper note: auto-created attributeDefName: 
etc:attribute:attrExternalSubjectInvite:externalSubjectInviteDate
Grouper note: auto-created attributeDefName: 
etc:attribute:attrExternalSubjectInvite:externalSubjectEmailAddress
Grouper note: auto-created attributeDefName: 
etc:attribute:attrExternalSubjectInvite:externalSubjectInviteGroupUuids
Grouper note: auto-created attributeDefName: 
etc:attribute:attrExternalSubjectInvite:externalSubjectInviteMemberId
Grouper note: auto-created attributeDefName: 
etc:attribute:attrExternalSubjectInvite:externalSubjectInviteUuid
Grouper note: auto-created attributeDefName: 
etc:attribute:attrExternalSubjectInvite:externalSubjectInviteEmailWhenRegistered
Grouper note: auto-created attributeDefName: 
etc:attribute:attrExternalSubjectInvite:externalSubjectInviteEmail
Grouper note: auto-created attributeDefName: etc:attribute:rules:rule
Grouper note: auto-created attributeDefName: 
etc:attribute:rules:ruleActAsSubjectId
Grouper note: auto-created attributeDefName: 
etc:attribute:rules:ruleActAsSubjectIdentifier
Grouper note: auto-created attributeDefName: 
etc:attribute:rules:ruleActAsSubjectSourceId
Grouper note: auto-created attributeDefName: etc:attribute:rules:ruleCheckType
Grouper note: auto-created attributeDefName: 
etc:attribute:rules:ruleCheckOwnerId
Grouper note: auto-created attributeDefName: 
etc:attribute:rules:ruleCheckOwnerName
Grouper note: auto-created attributeDefName: 
etc:attribute:rules:ruleCheckStemScope
Grouper note: auto-created attributeDefName: etc:attribute:rules:ruleCheckArg0
Grouper note: auto-created attributeDefName: etc:attribute:rules:ruleCheckArg1
Grouper note: auto-created attributeDefName: etc:attribute:rules:ruleIfOwnerId
Grouper note: auto-created attributeDefName: 
etc:attribute:rules:ruleIfOwnerName
Grouper note: auto-created attributeDefName: 
etc:attribute:rules:ruleIfConditionEl
Grouper note: auto-created attributeDefName: 
etc:attribute:rules:ruleIfConditionEnum
Grouper note: auto-created attributeDefName: 
etc:attribute:rules:ruleIfConditionEnumArg0
Grouper note: auto-created attributeDefName: 
etc:attribute:rules:ruleIfConditionEnumArg1
Grouper note: auto-created attributeDefName: 
etc:attribute:rules:ruleIfStemScope
Grouper note: auto-created attributeDefName: etc:attribute:rules:ruleThenEl
Grouper note: auto-created attributeDefName: etc:attribute:rules:ruleThenEnum
Grouper note: auto-created attributeDefName: 
etc:attribute:rules:ruleThenEnumArg0
Grouper note: auto-created attributeDefName: 
etc:attribute:rules:ruleThenEnumArg1
Grouper note: auto-created attributeDefName: 
etc:attribute:rules:ruleThenEnumArg2
Grouper note: auto-created attributeDefName: etc:attribute:rules:ruleValid
Grouper note: auto-created attributeDefName: etc:attribute:rules:ruleRunDaemon
Grouper note: auto-created attributeDefName: 
etc:attribute:permissionLimits:limitExpression
Grouper note: auto-created attributeDefName: 
etc:attribute:permissionLimits:limitIpOnNetworks
Grouper note: auto-created attributeDefName: 
etc:attribute:permissionLimits:limitIpOnNetworkRealm
Grouper note: auto-created attributeDefName: 
etc:attribute:permissionLimits:limitLabelsContain
Grouper note: auto-created attributeDefName: 
etc:attribute:permissionLimits:limitAmountLessThan
Grouper note: auto-created attributeDefName: 
etc:attribute:permissionLimits:limitAmountLessThanOrEqual
Grouper note: auto-created attributeDefName: 
etc:attribute:permissionLimits:limitWeekday9to5
Grouper note: auto-created attributeDefName: 
etc:attribute:attrLoader:attributeLoader
Grouper note: auto-created attributeDefName: 
etc:attribute:attrLoader:attributeLoaderType
Grouper note: auto-created attributeDefName: 
etc:attribute:attrLoader:attributeLoaderDbName
Grouper note: auto-created attributeDefName: 
etc:attribute:attrLoader:attributeLoaderScheduleType
Grouper note: auto-created attributeDefName: 
etc:attribute:attrLoader:attributeLoaderQuartzCron
Grouper note: auto-created attributeDefName: 
etc:attribute:attrLoader:attributeLoaderIntervalSeconds
Grouper note: auto-created attributeDefName: 
etc:attribute:attrLoader:attributeLoaderPriority
Grouper note: auto-created attributeDefName: 
etc:attribute:attrLoader:attributeLoaderAttrsLike
Grouper note: auto-created attributeDefName: 
etc:attribute:attrLoader:attributeLoaderAttrQuery
Grouper note: auto-created attributeDefName: 
etc:attribute:attrLoader:attributeLoaderAttrSetQuery
Grouper note: auto-created attributeDefName: 
etc:attribute:attrLoader:attributeLoaderActionQuery
Grouper note: auto-created attributeDefName: 
etc:attribute:attrLoader:attributeLoaderActionSetQuery
Grouper note: auto-created attributeDefName: 
etc:attribute:loaderLdap:grouperLoaderLdap
Grouper note: auto-created attributeDefName: 
etc:attribute:loaderLdap:grouperLoaderLdapType
Grouper note: auto-created attributeDefName: 
etc:attribute:loaderLdap:grouperLoaderLdapServerId
Grouper note: auto-created attributeDefName: 
etc:attribute:loaderLdap:grouperLoaderLdapFilter
Grouper note: auto-created attributeDefName: 
etc:attribute:loaderLdap:grouperLoaderLdapQuartzCron
Grouper note: auto-created attributeDefName: 
etc:attribute:loaderLdap:grouperLoaderLdapSearchDn
Grouper note: auto-created attributeDefName: 
etc:attribute:loaderLdap:grouperLoaderLdapSubjectAttribute
Grouper note: auto-created attributeDefName: 
etc:attribute:loaderLdap:grouperLoaderLdapSourceId
Grouper note: auto-created attributeDefName: 
etc:attribute:loaderLdap:grouperLoaderLdapSubjectIdType
Grouper note: auto-created attributeDefName: 
etc:attribute:loaderLdap:grouperLoaderLdapAndGroups
Grouper note: auto-created attributeDefName: 
etc:attribute:loaderLdap:grouperLoaderLdapSearchScope
Grouper note: auto-created attributeDefName: 
etc:attribute:loaderLdap:grouperLoaderLdapPriority
Grouper note: auto-created attributeDefName: 
etc:attribute:loaderLdap:grouperLoaderLdapGroupsLike
Grouper note: auto-created attributeDefName: 
etc:attribute:loaderLdap:grouperLoaderLdapGroupAttribute
Grouper note: auto-created attributeDefName: 
etc:attribute:loaderLdap:grouperLoaderLdapExtraAttributes
Grouper note: auto-created attributeDefName: 
etc:attribute:loaderLdap:grouperLoaderLdapErrorUnresolvable
Grouper note: auto-created attributeDefName: 
etc:attribute:loaderLdap:grouperLoaderLdapGroupNameExpression
Grouper note: auto-created attributeDefName: 
etc:attribute:loaderLdap:grouperLoaderLdapGroupDisplayNameExpression
Grouper note: auto-created attributeDefName: 
etc:attribute:loaderLdap:grouperLoaderLdapGroupDescriptionExpression
Grouper note: auto-created attributeDefName: 
etc:attribute:loaderLdap:grouperLoaderLdapSubjectExpression
Grouper note: auto-created attributeDefName: 
etc:attribute:loaderLdap:grouperLoaderLdapGroupTypes
Grouper note: auto-created attributeDefName: 
etc:attribute:loaderLdap:grouperLoaderLdapReaders
Grouper note: auto-created attributeDefName: 
etc:attribute:loaderLdap:grouperLoaderLdapViewers
Grouper note: auto-created attributeDefName: 
etc:attribute:loaderLdap:grouperLoaderLdapAdmins
Grouper note: auto-created attributeDefName: 
etc:attribute:loaderLdap:grouperLoaderLdapUpdaters
Grouper note: auto-created attributeDefName: 
etc:attribute:loaderLdap:grouperLoaderLdapOptins
Grouper note: auto-created attributeDefName: 
etc:attribute:loaderLdap:grouperLoaderLdapOptouts
Grouper note: auto-created attributeDefName: 
etc:attribute:entities:entitySubjectIdentifier
Using GROUPER_HOME: /usr/local/grouper
Using GROUPER_CONF: /usr/local/grouper/conf
Using JAVA: /usr/jdk/jdk1.6.0_33/bin/java
using MEMORY: 64m-750m
Grouper starting up: version: 2.1.1, build date: 2012/07/02 13:18:13, env: 
test3
grouper.properties read from: 
/usr/local/grouper.apiBinary-2.1.1/conf/grouper.properties
Grouper current directory is: /usr/local/grouper.apiBinary-2.1.1/ddlScripts
log4j.properties read from:   
/usr/local/grouper.apiBinary-2.1.1/conf/log4j.properties
Grouper is logging to file:   /usr/local/grouper/logs/grouper_error.log, at 
min level WARN for package: edu.internet2.middleware.grouper, based on 
log4j.properties
grouper.hibernate.properties: 
/usr/local/grouper.apiBinary-2.1.1/conf/grouper.hibernate.properties
grouper.hibernate.properties: 
grouperuser@jdbc:oracle:thin:@dbhost.unige.ch:1521:dbinstance
sources.xml read from:        
/usr/local/grouper.apiBinary-2.1.1/conf/sources.xml
sources.xml groupersource id: g:gsa
sources.xml groupersource id: grouperEntities
sources.xml jdbc source id:   jdbc: GrouperJdbcConnectionProvider
..Would obliterate stem: test
Would obliterate stem: test:sub1
Would obliterate stem: test:sub1:sub12
Would be done deleting group: test:sub1:sub12:testGroup
Would be done deleting group: test:sub1:sub12:testGroup2
Would be done deleting group: test:sub1:sub12:testGroup3
Would be done deleting attributeDef: test:sub1:sub12:testAttributeDef
Would be done deleting attributeDef: test:sub1:sub12:testAttributeDef2
Would be done deleting attributeDef: test:sub1:sub12:testAttributeDef3
Would be done obliterating stem: test:sub1:sub12
Would be done deleting group: test:sub1:testGroup
Would be done deleting group: test:sub1:testGroup2
Would be done deleting group: test:sub1:testGroup3
Would be done deleting attributeDef: test:sub1:testAttributeDef
Would be done deleting attributeDef: test:sub1:testAttributeDef2
Would be done deleting attributeDef: test:sub1:testAttributeDef3
Would be done obliterating stem: test:sub1
Would obliterate stem: test:sub2
Would obliterate stem: test:sub2:sub22
Would be done deleting group: test:sub2:sub22:testGroup
Would be done deleting group: test:sub2:sub22:testGroup2
Would be done deleting group: test:sub2:sub22:testGroup3
Would be done deleting attributeDef: test:sub2:sub22:testAttributeDef
Would be done deleting attributeDef: test:sub2:sub22:testAttributeDef2
Would be done deleting attributeDef: test:sub2:sub22:testAttributeDef3
Would be done obliterating stem: test:sub2:sub22
Would be done deleting group: test:sub2:testGroup
Would be done deleting group: test:sub2:testGroup2
Would be done deleting group: test:sub2:testGroup3
Would be done deleting attributeDef: test:sub2:testAttributeDef
Would be done deleting attributeDef: test:sub2:testAttributeDef2
Would be done deleting attributeDef: test:sub2:testAttributeDef3
Would be done obliterating stem: test:sub2
Would be done deleting group: test:testGroup2
Would be done deleting group: test:testGroup
Would be done deleting group: test:testGroup3
Would be done deleting attributeDefName: test:testAttributeDefName3
Would be done deleting attributeDefName: test:testSub1AttributeDefName
Would be done deleting attributeDefName: test:testSub12AttributeDefName
Would be done deleting attributeDefName: test:testSub22AttributeDefName
Would be done deleting attributeDefName: test:testSub23AttributeDefName
Would be done deleting attributeDefName: test:testSub112AttributeDefName
Would be done deleting attributeDefName: test:testSub122AttributeDefName
Would be done deleting attributeDefName: test:testSub123AttributeDefName
Would be done deleting attributeDefName: test:testSub222AttributeDefName
Would be done deleting attributeDefName: test:testAttributeDefName
Would be done deleting attributeDefName: test:testAttributeDefName2
Would be done deleting attributeDefName: test:testSub13AttributeDefName
Would be done deleting attributeDefName: test:testSub2AttributeDefName
Would be done deleting attributeDefName: test:testSub2222AttributeDefName
Would be done deleting attributeDefName: test:testSub2223AttributeDefName
Would be done deleting attributeDef: test:testAttributeDef
Would be done deleting attributeDef: test:testAttributeDef2
Would be done deleting attributeDef: test:testAttributeDef3
Would be done obliterating stem: test
.............F..........................
..............2012-08-09 23:22:58.071
.
Time: 253.701
There was 1 failure:
1) 
testGetChildGroups2(edu.internet2.middleware.grouper.TestStem)junit.framework.AssertionFailedError:
 Expecting groups of size: 6 but received size: 7, expecting: LinkedHashSet 
size: 6: [0]: Group[name=test:entity,uuid=68d7e39931244996bca0b04658ae1aba]
[1]: Group[name=test:group,uuid=424ee2e6fa0742718d4c706bf44ffa0b]
[2]: Group[name=test:role,uuid=1a7a57a2ce..., but received: LinkedHashSet 
size: 7: [0]: 
Group[name=etc:sysadmingroup,uuid=bf84953745c84b6693b00a25fb2c9cec]
[1]: Group[name=test:entity,uuid=68d7e39931244996bca0b04658ae1aba]
[2]: Group[name=test:group,uuid=42...
        at 
edu.internet2.middleware.grouper.helper.GrouperTest.assertGroupSetsAndOrder(GrouperTest.java:661)
        at 
edu.internet2.middleware.grouper.TestStem.testGetChildGroups2(TestStem.java:609)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
        at edu.internet2.middleware.grouper.AllTests.main(AllTests.java:157)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
        at 
edu.internet2.middleware.grouper.app.gsh.GrouperShell.handleSpecialCase(GrouperShell.java:204)
        at 
edu.internet2.middleware.grouper.app.gsh.GrouperShell.main(GrouperShell.java:144)
        at 
edu.internet2.middleware.grouper.app.gsh.GrouperShellWrapper.main(GrouperShellWrapper.java:31)

FAILURES!!!
Tests run: 56,  Failures: 1,  Errors: 0