users@glassfish.java.net

Glassfish Log filling up when Using OpenSSO within GlassFish

From: <glassfish_at_javadesktop.org>
Date: Wed, 26 Aug 2009 08:09:06 PDT

We have installed OpenSSO into GlassFish. We are using XACML to send policy requests to OpenSSO. Those requests are being processed by a custom request handler. When installing OpenSSO and sending in any request through the Policy engine, we OpenSSO starts continuously logging a set of errors. It starts filling up log files very quickly. It writes so many updates that glassfish is unable to process requests. We have tried changing settings in OpenSSO for logs (The error gives the impression that debug logs cannot be written) - But this does not solve the problem.

The following is the set of errors that are continuously repeated in rapid succession:

[#|2009-08-17T12:22:51.770-0600|WARNING|sun-appserver2.1|javax.enterprise.system.stream.err|_ThreadID=41;_ThreadName=amSessionPoller;_RequestID=118f4d48-5c56-43e7-ba07-06678503545f;|
Failed to create debug directory|#]
 
[#|2009-08-17T12:22:51.770-0600|INFO|sun-appserver2.1|javax.enterprise.system.stream.out|_ThreadID=41;_ThreadName=amSessionPoller;|amSession:08/17/2009 12:22:51:770 PM MDT: Thread[amSessionPoller,10,Grizzly]
DebugWriter is null.
|#]
 
[#|2009-08-17T12:22:51.770-0600|INFO|sun-appserver2.1|javax.enterprise.system.stream.out|_ThreadID=41;_ThreadName=amSessionPoller;|amSession:08/17/2009 12:22:51:770 PM MDT: Thread[amSessionPoller,10,Grizzly]
Session.isPollingEnabled is true
|#]
 
[#|2009-08-17T12:22:51.770-0600|WARNING|sun-appserver2.1|javax.enterprise.system.stream.err|_ThreadID=40;_ThreadName=SystemTimerPool;_RequestID=dd76b3e6-cf7b-4f45-8d68-ba1a327fcee4;|
Failed to create debug directory|#]
 
[#|2009-08-17T12:22:51.770-0600|INFO|sun-appserver2.1|javax.enterprise.system.stream.out|_ThreadID=40;_ThreadName=SystemTimerPool;|amSession:08/17/2009 12:22:51:770 PM MDT: Thread[SystemTimerPool,10,Grizzly]
DebugWriter is null.
|#]
 
[#|2009-08-17T12:22:51.770-0600|INFO|sun-appserver2.1|javax.enterprise.system.stream.out|_ThreadID=40;_ThreadName=SystemTimerPool;|amSession:08/17/2009 12:22:51:770 PM MDT: Thread[SystemTimerPool,10,Grizzly]
Session.isPollingEnabled is true
|#]
 
[#|2009-08-17T12:22:51.770-0600|WARNING|sun-appserver2.1|javax.enterprise.system.stream.err|_ThreadID=41;_ThreadName=amSessionPoller;_RequestID=118f4d48-5c56-43e7-ba07-06678503545f;|
Failed to create debug directory|#]
 
[#|2009-08-17T12:22:51.770-0600|INFO|sun-appserver2.1|javax.enterprise.system.stream.out|_ThreadID=41;_ThreadName=amSessionPoller;|amSession:08/17/2009 12:22:51:770 PM MDT: Thread[amSessionPoller,10,Grizzly]
DebugWriter is null.
|#]
 
[#|2009-08-17T12:22:51.770-0600|INFO|sun-appserver2.1|javax.enterprise.system.stream.out|_ThreadID=41;_ThreadName=amSessionPoller;|amSession:08/17/2009 12:22:51:770 PM MDT: Thread[amSessionPoller,10,Grizzly]
Session.getLBCookie()lbCookieName is:amlbcookie
|#]
 
[#|2009-08-17T12:22:51.770-0600|WARNING|sun-appserver2.1|javax.enterprise.system.stream.err|_ThreadID=41;_ThreadName=amSessionPoller;_RequestID=118f4d48-5c56-43e7-ba07-06678503545f;|
Failed to create debug directory|#]
 
[#|2009-08-17T12:22:51.770-0600|INFO|sun-appserver2.1|javax.enterprise.system.stream.out|_ThreadID=41;_ThreadName=amSessionPoller;|amNaming:08/17/2009 12:22:51:770 PM MDT: Thread[amSessionPoller,10,Grizzly]
DebugWriter is null.
|#]
 
[#|2009-08-17T12:22:51.770-0600|INFO|sun-appserver2.1|javax.enterprise.system.stream.out|_ThreadID=41;_ThreadName=amSessionPoller;|amNaming:08/17/2009 12:22:51:770 PM MDT: Thread[amSessionPoller,10,Grizzly]
WebtopNaming.getLBCookieValue(): server id is null, returning null
|#]
 
[#|2009-08-17T12:22:51.770-0600|WARNING|sun-appserver2.1|javax.enterprise.system.stream.err|_ThreadID=41;_ThreadName=amSessionPoller;_RequestID=118f4d48-5c56-43e7-ba07-06678503545f;|
Failed to create debug directory|#]
 
[#|2009-08-17T12:22:51.770-0600|INFO|sun-appserver2.1|javax.enterprise.system.stream.out|_ThreadID=41;_ThreadName=amSessionPoller;|PLLClient:08/17/2009 12:22:51:770 PM MDT: Thread[amSessionPoller,10,Grizzly]
DebugWriter is null.
|#]
 
[#|2009-08-17T12:22:51.770-0600|INFO|sun-appserver2.1|javax.enterprise.system.stream.out|_ThreadID=41;_ThreadName=amSessionPoller;|PLLClient:08/17/2009 12:22:51:770 PM MDT: Thread[amSessionPoller,10,Grizzly]
sending cookies: iPlanetDirectoryPro=AQIC5wM2LY4SfcxGtyAow5KcEPAyOktayT9rDtWWb1wGzVw=_at_AAJTSQA=#;amlbcookie=null
|#]
 
[#|2009-08-17T12:22:51.786-0600|WARNING|sun-appserver2.1|javax.enterprise.system.stream.err|_ThreadID=41;_ThreadName=amSessionPoller;_RequestID=118f4d48-5c56-43e7-ba07-06678503545f;|
Failed to create debug directory|#]
 
[#|2009-08-17T12:22:51.786-0600|INFO|sun-appserver2.1|javax.enterprise.system.stream.out|_ThreadID=41;_ThreadName=amSessionPoller;|amSession:08/17/2009 12:22:51:786 PM MDT: Thread[amSessionPoller,10,Grizzly]
DebugWriter is null.
|#]
 
[#|2009-08-17T12:22:51.786-0600|INFO|sun-appserver2.1|javax.enterprise.system.stream.out|_ThreadID=41;_ThreadName=amSessionPoller;|amSession:08/17/2009 12:22:51:786 PM MDT: Thread[amSessionPoller,10,Grizzly]
In parse session com.iplanet.dpro.session.share.SessionInfo_at_8b9227
|#]
 
[#|2009-08-17T12:22:51.786-0600|WARNING|sun-appserver2.1|javax.enterprise.system.stream.err|_ThreadID=41;_ThreadName=amSessionPoller;_RequestID=118f4d48-5c56-43e7-ba07-06678503545f;|
Failed to create debug directory|#]
 
[#|2009-08-17T12:22:51.786-0600|INFO|sun-appserver2.1|javax.enterprise.system.stream.out|_ThreadID=41;_ThreadName=amSessionPoller;|amSession:08/17/2009 12:22:51:786 PM MDT: Thread[amSessionPoller,10,Grizzly]
DebugWriter is null.
|#]
 
[#|2009-08-17T12:22:51.786-0600|INFO|sun-appserver2.1|javax.enterprise.system.stream.out|_ThreadID=41;_ThreadName=amSessionPoller;|amSession:08/17/2009 12:22:51:786 PM MDT: Thread[amSessionPoller,10,Grizzly]
Updating<Session sid="AQIC5wM2LY4SfcxGtyAow5KcEPAyOktayT9rDtWWb1wGzVw=_at_AAJTSQACMDE=#" stype="user" cid="amService-UrlAccessAgent" cdomain="dc=opensso,dc=java,dc=net" maxtime="153722867280912930" maxidle="153722867280912930" maxcaching="153722867280912930" timeidle="0" timeleft="153722867280912930" state="valid">
<Property name="CharSet" value="UTF-8"></Property>
<Property name="UserId" value="amService-UrlAccessAgent"></Property>
<Property name="successURL" value="/opensso/console"></Property>
<Property name="cookieSupport" value="true"></Property>
<Property name="AuthLevel" value="0"></Property>
<Property name="SessionHandle" value="shandle:AQIC5wM2LY4SfcyKjz9q/xO0sH2pgBcDUTSMjzaQw6NcngQ=_at_AAJTSQACMDE=#"></Property>
<Property name="UserToken" value="amService-UrlAccessAgent"></Property>
<Property name="IndexType" value="module_instance"></Property>
<Property name="Principals" value="cn=amService-UrlAccessAgent,ou=DSAME Users,dc=opensso,dc=java,dc=net"></Property>
<Property name="amlbcookie" value="01"></Property>
<Property name="sun.am.UniversalIdentifier" value="id=amservice-urlaccessagent,ou=user,dc=opensso,dc=java,dc=net"></Property>
<Property name="Organization" value="dc=opensso,dc=java,dc=net"></Property>
<Property name="Locale" value="en_US"></Property>
<Property name="HostName" value="127.0.0.1"></Property>
<Property name="AuthType" value="Application"></Property>
<Property name="Host" value="127.0.0.1"></Property>
<Property name="UserProfile" value="Required"></Property>
<Property name="clientType" value="genericHTML"></Property>
<Property name="AMCtxId" value="7c8ea0522144003d01"></Property>
<Property name="authInstant" value="2009-08-17T18:22:32Z"></Property>
<Property name="Principal" value="cn=amService-UrlAccessAgent,ou=DSAME Users,dc=opensso,dc=java,dc=net"></Property>
</Session>
|#]
[Message sent by forum member 'leswestberg' (les.westberg_at_agilex.com)]

http://forums.java.net/jive/thread.jspa?messageID=361998