Error Message When trying to log into the IM7.1

[18 Jul 2006 17:13:10,484] INFO xmppd [org.netbeans.lib.collab.util.Worker 2] [Identity] Failed to create SSO token for jsoapAny Help AppreciatedCarinus
[173 byte] By [ccarelse1] at [2007-11-26 8:50:44]
# 1

Creating of SSO token may fail for many reasons.

For startup try the following:

* Check whether you have assigned IM & Presence to the domain/org & to users.

* IM was configured to use AM Policy & SSO?

If the above options doesn't work then please provide more details like:

* IM version?

* Am version etc & some more debug logs.

Amit_Bakhru at 2007-7-6 22:41:58 > top of Java-index,E-Mail, Calendar, & Collaboration,Sun Java System Instant Messaging...
# 2

I have the IM 7.1 from the 2005q4 suite of jes with the patches installed.

I have turned on the debug to the fatal level in the iim.conf but just get the same error message all the time. I have checked and the users and they all have the presence services and the im service in their profiles what other logs can I check to see what is happening.

Carinus

ccarelse1 at 2007-7-6 22:41:58 > top of Java-index,E-Mail, Calendar, & Collaboration,Sun Java System Instant Messaging...
# 3
Set iim.log.iim_server.severity=DEBUG in iim.conf file (if not using log4j.conf file) or log4j.logger.xmppd=DEBUG (if your using log4j.conf) & then send me the complete xmppd.log on my mail-id: Amit.Bakhru@Gmail.COM
Amit_Bakhru at 2007-7-6 22:41:58 > top of Java-index,E-Mail, Calendar, & Collaboration,Sun Java System Instant Messaging...
# 4

I have posted it to your gmail account but I posting here as well just in case I got a crash on my mail client when I sent it. I got a error message for the log4j when I made the change in the conf file.

log4j:WARN No appenders could be found for logger (nbcollab.nio).

log4j:WARN Please initialize the log4j system properly.

xmppd.log

[19 Jul 2006 10:52:17,285] INFO xmppd [main] Starting XMPP Server: Version 7.1

[19 Jul 2006 10:52:20,964] INFO xmppd [main] RealmClassName com.iplanet.im.server.IdentityRealm

[19 Jul 2006 10:52:20,964] DEBUG xmppd [main] Creating realm for first time com.iplanet.im.server.IdentityRealm

[19 Jul 2006 10:52:24,293] DEBUG xmppd [main] [LDAPPool] binding as cn=dsameuser,ou=DSAME Users,o=msp

[19 Jul 2006 10:52:24,294] DEBUG xmppd [main] [LDAPPool] creating a new context

[19 Jul 2006 10:52:28,944] DEBUG xmppd [main] [FileGroupChatStorage] root dir = /var/opt/sun/im/default/db/pubsub

[19 Jul 2006 10:52:28,944] DEBUG xmppd [main] [FileGroupChatStorage] loaded /var/opt/sun/im/default/db/pubsub

[19 Jul 2006 10:52:37,322] DEBUG xmppd [main] [Identity] open called, getting user attributes names.

[19 Jul 2006 10:52:37,466] DEBUG xmppd [main] [Identity] sunIM user service attributes: [sunIMUserProperties, sunIMUserRoster, sunIMUserConferenceRoster, sunIMUserNewsRoster, sunIMUserPrivateSettings]

[19 Jul 2006 10:52:37,467] DEBUG xmppd [main] [Identity] sunIM dynamic service attributes: [sunIMProperties, sunIMPrivateSettings, sunIMNewsRoster, sunIMRoster, sunIMConferenceRoster]

[19 Jul 2006 10:52:37,467] DEBUG xmppd [main] [Identity] sunIM policy attributes: [sunIMAllowPollingAccess, sunIMAllowContactListManage, sunIMAllowAlertsAccess, sunIMAllowPollingSend, sunIMAllowChatInvite, sunIMAllowFileTransfer, sunIMAllowChat, sunIMAllowForumManage, sunIMAllowNewsManage, sunIMAllowNewsAccess, sunIMAllowForumAccess, sunIMAllowForumModerate, sunIMAllowUserSettings, sunIMAllowAlertsSend]

[19 Jul 2006 10:52:37,681] DEBUG xmppd [main] [Identity] sunPresence user service attributes: [sunPresenceEntityAccessDenied, sunPresenceEntityDevices, sunPresenceEntityDefaultAccess, sunPresenceEntityAccessPermitted, sunPresenceUserPrivacy]

[19 Jul 2006 10:52:37,682] DEBUG xmppd [main] [Identity] sunPresence dynamic service attributes: [sunPresenceAccessDenied, sunPresenceDefaultAccess, sunPresenceDevices, sunPresenceAccessPermitted, sunPresencePrivacy]

[19 Jul 2006 10:52:37,682] DEBUG xmppd [main] [Identity] sunPresence policy attributes: [sunPresenceAllowPublish, sunPresenceAllowManage, sunPresenceAllowAccess]

[19 Jul 2006 10:52:37,691] DEBUG xmppd [main] [Identity] getServiceVersion Exception: Service does not exist : SunIMService

[19 Jul 2006 10:52:37,692] INFO xmppd [main] [Identity] no old sunIMService attributes: Service does not exist : SunIMService

[19 Jul 2006 10:52:41,961] DEBUG xmppd [main] [Identity] admin role DNs: [cn=IM Administrator,o=msp]

[19 Jul 2006 10:52:41,961] DEBUG xmppd [main] [Identity] admin role DN: cn=IM Administrator,o=msp

[19 Jul 2006 10:52:41,985] DEBUG xmppd [main] [Identity] admin user DNs: []

[19 Jul 2006 10:52:42,003] DEBUG xmppd [main] [Identity] topics role DN: cn=IM News Administrator,o=msp

[19 Jul 2006 10:52:42,042] DEBUG xmppd [main] [Identity] rooms role DN: cn=IM Conference Rooms Administrator,o=msp

[19 Jul 2006 10:52:42,060] DEBUG xmppd [main] [Identity] send alerts role DN: cn=IM Allow Send Alerts Role,o=msp

[19 Jul 2006 10:52:42,078] DEBUG xmppd [main] [Identity] watch role DN: cn=IM Allow Watch Changes Role,o=msp

[19 Jul 2006 10:52:42,097] DEBUG xmppd [main] [Identity] save user settings role DN: cn=IM Allow User Settings Role,o=msp

[19 Jul 2006 10:52:43,508] DEBUG xmppd [main] [Identity] _topicsDefault: deny

[19 Jul 2006 10:52:43,509] DEBUG xmppd [main] [Identity] _roomsDefault: deny

[19 Jul 2006 10:52:43,509] DEBUG xmppd [main] [Identity] _sendAlertsDefault: allow

[19 Jul 2006 10:52:43,509] DEBUG xmppd [main] [Identity] _saveUserSettingsDefault: allow

[19 Jul 2006 10:52:43,509] DEBUG xmppd [main] [Identity] _watchDefault: allow

[19 Jul 2006 10:52:43,509] INFO xmppd [main] Loaded realm: com.iplanet.im.server.IdentityRealm

[19 Jul 2006 10:52:43,619] INFO xmppd [main] Monitoring is disabled

[19 Jul 2006 10:52:43,625] INFO xmppd [main] XMPP Server, version 7.1 Starting

[19 Jul 2006 10:52:43,670] DEBUG xmppd [main] [Archive] not loaded yet

[19 Jul 2006 10:52:43,670] DEBUG xmppd [main] [Archive] initializing archive providers

[19 Jul 2006 10:52:43,710] INFO xmppd [main] [Archive] loaded archive provider: com.iplanet.im.server.EmailIMArchive

[19 Jul 2006 10:52:43,710] INFO xmppd [main] [Archive] autoarchive=false

[19 Jul 2006 10:52:43,710] DEBUG xmppd [main] [Archive] finished loading

[19 Jul 2006 10:52:43,745] DEBUG xmppd [Timer-1] [EmailIMArchive] submit called:

[19 Jul 2006 10:52:43,973] DEBUG xmppd [main] [Disco] new key: muc new size=1

[19 Jul 2006 10:52:43,974] DEBUG xmppd [main] [Disco] new key: pubsub new size=2

[19 Jul 2006 10:52:43,974] DEBUG xmppd [main] [Disco] new key: jud new size=3

[19 Jul 2006 10:52:43,978] DEBUG xmppd [main] ServerSocketChannel on: null Port: 5269

[19 Jul 2006 10:52:44,009] WARN xmppd [main] [S2SSession] server ID = null

[19 Jul 2006 10:52:44,012] DEBUG xmppd [main] [PeerServer] connecting to peers

[19 Jul 2006 10:52:44,014] INFO xmppd [main] [Multiplex] starting on 0.0.0.0:45222

[19 Jul 2006 10:52:44,015] INFO xmppd [main] Server start completed

[19 Jul 2006 10:52:44,015] INFO xmppd [Thread-14] [NioSelectAcceptor][0.0.0.0:5269] Acceptor starting

[19 Jul 2006 10:52:44,578] INFO xmppd [Thread-15] New Multiplexor Connection started from /127.0.0.1

[19 Jul 2006 10:52:44,585] INFO xmppd [Thread-15] New Multiplexor Connection started from /127.0.0.1

[19 Jul 2006 10:52:44,586] DEBUG xmppd [Thread-16] MultiplexManager#33185374 buffered bytes: 0

[19 Jul 2006 10:52:44,588] ERROR xmppd [Thread-16] MultiplexManager#33185374 read error java.io.IOException: Connection reset by peer

[19 Jul 2006 10:52:44,589] ERROR xmppd [Thread-16] MultiplexManager#33185374 error sending BYE

[19 Jul 2006 10:52:44,589] INFO xmppd [Thread-16] MultiplexManager#33185374 exiting

[19 Jul 2006 10:52:44,590] DEBUG xmppd [Thread-17] MultiplexManager#24211360 buffered bytes: 0

[19 Jul 2006 10:52:44,596] INFO xmppd [Thread-17] MultiplexManager#24211360 HELLO received version=4.1 maxchannels=1002

[19 Jul 2006 10:52:44,597] DEBUG xmppd [Thread-17] MultiplexManager#24211360 buffered bytes: 0

[19 Jul 2006 10:52:44,606] INFO xmppd [Thread-15] New Multiplexor Connection started from /127.0.0.1

[19 Jul 2006 10:52:44,606] DEBUG xmppd [Thread-18] MultiplexManager#31447311 buffered bytes: 0

[19 Jul 2006 10:52:44,607] INFO xmppd [Thread-18] MultiplexManager#31447311 HELLO received version=4.1 maxchannels=1002

[19 Jul 2006 10:52:44,607] DEBUG xmppd [Thread-18] MultiplexManager#31447311 buffered bytes: 0

[19 Jul 2006 10:53:17,416] DEBUG xmppd [Thread-18] MultiplexManager#31447311 OPEN Payload len=8

[19 Jul 2006 10:53:17,452] DEBUG xmppd [ThreadPoolManager:default] Starting activity check; inactivity timeout=900000 now=1153299197450

[19 Jul 2006 10:53:17,453] DEBUG xmppd [ThreadPoolManager:default] Completed activity check for 0 channels.

[19 Jul 2006 10:53:17,500] DEBUG xmppd [Thread-18] useTLS : false

[19 Jul 2006 10:53:17,500] DEBUG xmppd [Thread-18] useTLS1 : false

[19 Jul 2006 10:53:17,500] DEBUG xmppd [Thread-18] useSASL : true

[19 Jul 2006 10:53:17,513] DEBUG xmppd [Thread-18] FSN : <features xmlns='http://etherx.jabber.org/streams'><mechanisms xmlns='urn:ietf:params:xml:ns:xmpp-sasl'><mechanism>PLAIN</mechanis m></mechanisms><auth xmlns='http://jabber.org/features/iq-auth'/></features>

[19 Jul 2006 10:53:17,513] DEBUG xmppd [Thread-18] tlsFN : null

[19 Jul 2006 10:53:17,606] DEBUG xmppd [Thread-18] Session[null] outbound status changed from disconnected to connected

[19 Jul 2006 10:53:17,607] DEBUG xmppd [Thread-18] Session[null] inbound status changed from disconnected to connected

[19 Jul 2006 10:53:17,607] DEBUG xmppd [Thread-18] mxchnl[1] created, addr=/172.18.2.43

[19 Jul 2006 10:53:17,607] DEBUG xmppd [Thread-18] MultiplexManager#31447311 New channel 1 client address:/172.18.2.43

[19 Jul 2006 10:53:17,608] DEBUG xmppd [Thread-18] MultiplexManager#31447311 buffered bytes: 0

[19 Jul 2006 10:53:17,608] DEBUG xmppd [Thread-18] MultiplexManager#31447311 data received for channel 1 com.iplanet.im.server.MultiplexChannel@dc1f04

[19 Jul 2006 10:53:17,610] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 0] ClientSession started process()

[19 Jul 2006 10:53:17,611] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 0] Session[null] processing input

[19 Jul 2006 10:53:17,625] DEBUG xmppd [Thread-18] MultiplexManager#31447311 addRunnable: 1

[19 Jul 2006 10:53:17,625] DEBUG xmppd [Thread-18] MultiplexManager#31447311 buffered bytes: 0

[19 Jul 2006 10:53:17,728] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 0] Session[null] inbound status changed from connected to opened

[19 Jul 2006 10:53:17,728] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 0] [Session] expecting SASL support from client

[19 Jul 2006 10:53:17,728] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 0] [Session] opened.

[19 Jul 2006 10:53:17,730] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 0] [Session] Opening client session to proxy1.mrc.ac.za

[19 Jul 2006 10:53:17,732] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 0] [Session] opening outbound

[19 Jul 2006 10:53:17,737] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 0] Session[null] outbound status changed from connected to opened

[19 Jul 2006 10:53:17,737] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 0] [Session] opened outbound

[19 Jul 2006 10:53:17,744] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 0] [Session] opened.

[19 Jul 2006 10:53:17,744] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 0] Session[null] processing input

[19 Jul 2006 10:53:17,745] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 0] Session[null] processed input

[19 Jul 2006 10:53:17,745] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 1] ClientSession started process()

[19 Jul 2006 10:53:17,746] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 1] Session[null] processing input

[19 Jul 2006 10:53:17,746] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 1] Session[null] processed input

[19 Jul 2006 10:53:17,746] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 1] ClientSession finished process()

[19 Jul 2006 10:53:17,747] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 0] Session[null] processed input

[19 Jul 2006 10:53:17,747] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 0] ClientSession finished process()

[19 Jul 2006 10:53:18,074] DEBUG xmppd [Thread-18] MultiplexManager#31447311 data received for channel 1 com.iplanet.im.server.MultiplexChannel@dc1f04

[19 Jul 2006 10:53:18,074] DEBUG xmppd [Thread-18] MultiplexManager#31447311 addRunnable: 1

[19 Jul 2006 10:53:18,074] DEBUG xmppd [Thread-18] MultiplexManager#31447311 buffered bytes: 96

[19 Jul 2006 10:53:18,075] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 2] ClientSession started process()

[19 Jul 2006 10:53:18,075] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 2] Session[null] processing input

[19 Jul 2006 10:53:18,085] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 2] Session[null] processing request

[19 Jul 2006 10:53:18,085] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 2] [ClientPacketDispatcher] SASLPacket detected

[19 Jul 2006 10:53:18,085] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 2] [Sasl] new packet

[19 Jul 2006 10:53:18,086] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 2] [Sasl] IS SASLAuthPacket

[19 Jul 2006 10:53:18,086] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 2] [Sasl] mechanism PLAIN

[19 Jul 2006 10:53:18,091] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 2] [Sasl] saslProvider : com.iplanet.im.server.sasl.PlainSASLProvider@135da43

[19 Jul 2006 10:53:18,092] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 2] [Sasl] requestFailed : false

[19 Jul 2006 10:53:18,093] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 2] [Sasl] saslProvider.isRaw() : false

[19 Jul 2006 10:53:18,100] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 2] request status : {urn:ietf:params:xml:ns:xmpp-sasl}auth

[19 Jul 2006 10:53:18,100] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 2] [Sasl] PLAIN mechanism requested

[19 Jul 2006 10:53:18,101] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 2] [Identity] Authenticating user jisolder

[19 Jul 2006 10:53:18,101] INFO xmppd [org.netbeans.lib.collab.util.Worker 2] Authenticating using Identity Server SSO

[19 Jul 2006 10:53:18,111] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 2] Unable to create SSOToken - the specified token might be a password.

[19 Jul 2006 10:53:18,112] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 2] [Identity] domain = mrc.ac.za

[19 Jul 2006 10:53:18,283] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 2] [Identity] getSearchBase(mrc.ac.za)=o=mrc.ac.za,o=msp

[19 Jul 2006 10:53:18,290] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 2] [Identity] domain=mrc.ac.za OrgDN=o=mrc.ac.za,o=msp

[19 Jul 2006 10:53:18,640] INFO xmppd [org.netbeans.lib.collab.util.Worker 2] [Identity] Failed to create SSO token for jisolder

[19 Jul 2006 10:53:18,641] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 2] [Sasl] request status : 0

[19 Jul 2006 10:53:18,641] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 2] [Sasl] response status : 3

[19 Jul 2006 10:53:18,646] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 2] Session[class com.iplanet.im.server.ClientSession null] authFailed - null

[19 Jul 2006 10:53:18,646] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 2] Session[null] processed input

[19 Jul 2006 10:53:18,646] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 2] ClientSession finished process()

[19 Jul 2006 10:53:18,676] DEBUG xmppd [Thread-18] MultiplexManager#31447311 data received for channel 1 com.iplanet.im.server.MultiplexChannel@dc1f04

[19 Jul 2006 10:53:18,676] DEBUG xmppd [Thread-18] MultiplexManager#31447311 addRunnable: 1

[19 Jul 2006 10:53:18,676] DEBUG xmppd [Thread-18] MultiplexManager#31447311 buffered bytes: 16

[19 Jul 2006 10:53:18,677] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 3] ClientSession started process()

[19 Jul 2006 10:53:18,677] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 3] Session[null] processing input

[19 Jul 2006 10:53:18,677] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 3] Session[null] inbound status changed from opened to closed

[19 Jul 2006 10:53:18,678] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 3] Session[null] outbound status changed from opened to closed

[19 Jul 2006 10:53:18,678] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 3] mxchnl[1] closing

[19 Jul 2006 10:53:18,679] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 3] MultiplexManager#31447311 channel 1 terminated.

[19 Jul 2006 10:53:18,679] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 3] Session[null] outbound status changed from closed to disconnected

[19 Jul 2006 10:53:18,679] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 3] Session[null] inbound status changed from closed to disconnected

[19 Jul 2006 10:53:18,679] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 3] Session[null] inbound status reset from disconnected to disconnected

[19 Jul 2006 10:53:18,680] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 3] Session[null] processed input

[19 Jul 2006 10:53:18,680] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 3] ClientSession finished process()

[19 Jul 2006 10:53:44,595] DEBUG xmppd [Timer-0] MultiplexManager#11442116 Starting activity check at 1153299224595

[19 Jul 2006 10:53:44,596] DEBUG xmppd [Timer-0] MultiplexManager#11442116 Completed activity check

[19 Jul 2006 10:53:44,625] DEBUG xmppd [Timer-0] MultiplexManager#7202313 Starting activity check at 1153299224625

[19 Jul 2006 10:53:44,626] DEBUG xmppd [Timer-0] MultiplexManager#7202313 Completed activity check

[19 Jul 2006 10:54:17,425] DEBUG xmppd [ThreadPoolManager:default] Starting activity check; inactivity timeout=900000 now=1153299256925

[19 Jul 2006 10:54:17,426] DEBUG xmppd [ThreadPoolManager:default] Completed activity check for 0 channels.

[19 Jul 2006 10:54:30,110] DEBUG xmppd [Thread-18] MultiplexManager#31447311 OPEN Payload len=8

[19 Jul 2006 10:54:30,111] DEBUG xmppd [Thread-18] useTLS : false

[19 Jul 2006 10:54:30,111] DEBUG xmppd [Thread-18] useTLS1 : false

[19 Jul 2006 10:54:30,111] DEBUG xmppd [Thread-18] useSASL : true

[19 Jul 2006 10:54:30,112] DEBUG xmppd [Thread-18] FSN : <features xmlns='http://etherx.jabber.org/streams'><mechanisms xmlns='urn:ietf:params:xml:ns:xmpp-sasl'><mechanism>PLAIN</mechanis m></mechanisms><auth xmlns='http://jabber.org/features/iq-auth'/></features>

[19 Jul 2006 10:54:30,112] DEBUG xmppd [Thread-18] tlsFN : null

[19 Jul 2006 10:54:30,113] DEBUG xmppd [Thread-18] Session[null] outbound status changed from disconnected to connected

[19 Jul 2006 10:54:30,113] DEBUG xmppd [Thread-18] Session[null] inbound status changed from disconnected to connected

[19 Jul 2006 10:54:30,113] DEBUG xmppd [Thread-18] mxchnl[2] created, addr=/172.18.2.43

[19 Jul 2006 10:54:30,114] DEBUG xmppd [Thread-18] MultiplexManager#31447311 New channel 2 client address:/172.18.2.43

[19 Jul 2006 10:54:30,114] DEBUG xmppd [Thread-18] MultiplexManager#31447311 buffered bytes: 0

[19 Jul 2006 10:54:30,145] DEBUG xmppd [Thread-18] MultiplexManager#31447311 data received for channel 2 com.iplanet.im.server.MultiplexChannel@1195c2b

[19 Jul 2006 10:54:30,146] DEBUG xmppd [Thread-18] MultiplexManager#31447311 addRunnable: 1

[19 Jul 2006 10:54:30,146] DEBUG xmppd [Thread-18] MultiplexManager#31447311 buffered bytes: 121

[19 Jul 2006 10:54:30,146] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 1] ClientSession started process()

[19 Jul 2006 10:54:30,146] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 1] Session[null] processing input

[19 Jul 2006 10:54:30,147] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 1] Session[null] inbound status changed from connected to opened

[19 Jul 2006 10:54:30,147] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 1] [Session] expecting SASL support from client

[19 Jul 2006 10:54:30,148] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 1] [Session] opened.

[19 Jul 2006 10:54:30,149] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 1] [Session] Opening client session to proxy1.mrc.ac.za

[19 Jul 2006 10:54:30,149] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 1] [Session] opening outbound

[19 Jul 2006 10:54:30,150] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 1] Session[null] outbound status changed from connected to opened

[19 Jul 2006 10:54:30,150] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 1] [Session] opened outbound

[19 Jul 2006 10:54:30,151] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 1] [Session] opened.

[19 Jul 2006 10:54:30,152] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 1] Session[null] processing input

[19 Jul 2006 10:54:30,152] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 1] Session[null] processed input

[19 Jul 2006 10:54:30,152] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 1] Session[null] processed input

[19 Jul 2006 10:54:30,152] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 1] ClientSession finished process()

[19 Jul 2006 10:54:30,152] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 1] ClientSession started process()

[19 Jul 2006 10:54:30,152] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 1] Session[null] processing input

[19 Jul 2006 10:54:30,153] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 1] Session[null] processed input

[19 Jul 2006 10:54:30,153] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 1] ClientSession finished process()

[19 Jul 2006 10:54:30,163] DEBUG xmppd [Thread-18] MultiplexManager#31447311 data received for channel 2 com.iplanet.im.server.MultiplexChannel@1195c2b

[19 Jul 2006 10:54:30,164] DEBUG xmppd [Thread-18] MultiplexManager#31447311 addRunnable: 1

[19 Jul 2006 10:54:30,164] DEBUG xmppd [Thread-18] MultiplexManager#31447311 buffered bytes: 96

[19 Jul 2006 10:54:30,164] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 2] ClientSession started process()

[19 Jul 2006 10:54:30,164] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 2] Session[null] processing input

[19 Jul 2006 10:54:30,165] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 2] Session[null] processing request

[19 Jul 2006 10:54:30,166] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 2] [ClientPacketDispatcher] SASLPacket detected

[19 Jul 2006 10:54:30,166] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 2] [Sasl] new packet

[19 Jul 2006 10:54:30,166] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 2] [Sasl] IS SASLAuthPacket

[19 Jul 2006 10:54:30,166] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 2] [Sasl] mechanism PLAIN

[19 Jul 2006 10:54:30,166] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 2] [Sasl] saslProvider : com.iplanet.im.server.sasl.PlainSASLProvider@cd83d8

[19 Jul 2006 10:54:30,166] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 2] [Sasl] requestFailed : false

[19 Jul 2006 10:54:30,166] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 2] [Sasl] saslProvider.isRaw() : false

[19 Jul 2006 10:54:30,167] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 2] request status : {urn:ietf:params:xml:ns:xmpp-sasl}auth

[19 Jul 2006 10:54:30,167] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 2] [Sasl] PLAIN mechanism requested

[19 Jul 2006 10:54:30,167] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 2] [Identity] Authenticating user ccarelse

[19 Jul 2006 10:54:30,167] INFO xmppd [org.netbeans.lib.collab.util.Worker 2] Authenticating using Identity Server SSO

[19 Jul 2006 10:54:30,168] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 2] Unable to create SSOToken - the specified token might be a password.

[19 Jul 2006 10:54:30,169] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 2] [Identity] domain = mrc.ac.za

[19 Jul 2006 10:54:30,169] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 2] [Identity] getSearchBase(mrc.ac.za)=o=mrc.ac.za,o=msp

[19 Jul 2006 10:54:30,169] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 2] [Identity] domain=mrc.ac.za OrgDN=o=mrc.ac.za,o=msp

[19 Jul 2006 10:54:30,239] INFO xmppd [org.netbeans.lib.collab.util.Worker 2] [Identity] Failed to create SSO token for ccarelse

[19 Jul 2006 10:54:30,239] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 2] [Sasl] request status : 0

[19 Jul 2006 10:54:30,239] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 2] [Sasl] response status : 3

[19 Jul 2006 10:54:30,243] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 2] Session[class com.iplanet.im.server.ClientSession null] authFailed - null

[19 Jul 2006 10:54:30,243] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 2] Session[null] processed input

[19 Jul 2006 10:54:30,244] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 2] ClientSession finished process()

[19 Jul 2006 10:54:30,259] DEBUG xmppd [Thread-18] MultiplexManager#31447311 data received for channel 2 com.iplanet.im.server.MultiplexChannel@1195c2b

[19 Jul 2006 10:54:30,259] DEBUG xmppd [Thread-18] MultiplexManager#31447311 addRunnable: 1

[19 Jul 2006 10:54:30,259] DEBUG xmppd [Thread-18] MultiplexManager#31447311 buffered bytes: 16

[19 Jul 2006 10:54:30,259] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 3] ClientSession started process()

[19 Jul 2006 10:54:30,260] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 3] Session[null] processing input

[19 Jul 2006 10:54:30,260] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 3] Session[null] inbound status changed from opened to closed

[19 Jul 2006 10:54:30,260] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 3] Session[null] outbound status changed from opened to closed

[19 Jul 2006 10:54:30,261] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 3] mxchnl[2] closing

[19 Jul 2006 10:54:30,261] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 3] MultiplexManager#31447311 channel 2 terminated.

[19 Jul 2006 10:54:30,261] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 3] Session[null] outbound status changed from closed to disconnected

[19 Jul 2006 10:54:30,261] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 3] Session[null] inbound status changed from closed to disconnected

[19 Jul 2006 10:54:30,261] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 3] Session[null] inbound status reset from disconnected to disconnected

[19 Jul 2006 10:54:30,261] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 3] Session[null] processed input

[19 Jul 2006 10:54:30,262] DEBUG xmppd [org.netbeans.lib.collab.util.Worker 3] ClientSession finished process()

[19 Jul 2006 10:54:43,755] DEBUG xmppd [Timer-1] [EmailIMArchive] submit called:

[19 Jul 2006 10:54:44,605] DEBUG xmppd [Timer-0] MultiplexManager#11442116 Starting activity check at 1153299284605

[19 Jul 2006 10:54:44,606] DEBUG xmppd [Timer-0] MultiplexManager#11442116 Completed activity check

[19 Jul 2006 10:54:44,635] DEBUG xmppd [Timer-0] MultiplexManager#7202313 Starting activity check at 1153299284635

[19 Jul 2006 10:54:44,636] DEBUG xmppd [Timer-0] MultiplexManager#7202313 Completed activity check

[19 Jul 2006 10:55:17,435] DEBUG xmppd [ThreadPoolManager:default] Starting activity check; inactivity timeout=900000 now=1153299316515

[19 Jul 2006 10:55:17,436] DEBUG xmppd [ThreadPoolManager:default] Completed activity check for 0 channels.

dgargan at 2007-7-6 22:41:58 > top of Java-index,E-Mail, Calendar, & Collaboration,Sun Java System Instant Messaging...
# 5
Are you sure that you can login as this user with the same credentials directly to Access Manager (Identity server) ?It looks like the AM server rejects the credentials provided.Regards,Mridul
MridulM at 2007-7-6 22:41:58 > top of Java-index,E-Mail, Calendar, & Collaboration,Sun Java System Instant Messaging...