Tue May 19 22:29:09.196 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081223: ArAuthFrameworkImpl::doPreAuth::1:10081223:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:29:09.196 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081223: Arcot Native Server: recvd AA_BIN_MSG_VER_CHG Tue May 19 22:29:09.196 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081223: Cert Subject String....:[CN=00919545;O=MLS; UserID=00919545; CardName=ARCARD] Tue May 19 22:29:09.196 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081223: Cert issuer............:[CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US] Tue May 19 22:29:09.196 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081223: Cert serial String.....:[ef17] Tue May 19 22:29:09.196 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081223: ArcotId Certificate received with signature have ArcotExtension. Cert issuer=CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US, serial=ef17 and subject=CN=00919545;O=MLS Tue May 19 22:29:09.196 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081223: ArcotID Auth SUCCESS (serial Number [ef17]) Tue May 19 22:29:09.196 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081223: Session tracker Id associated with verify signed challenge[1:10081219] Tue May 19 22:29:09.196 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081223: ArAuthFrameworkImpl::doAuth::1:10081219:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:29:09.196 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081223: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:29:09.196 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081223: Handle_NSPAdvice::NSP Action :[NSP_RESET] Tue May 19 22:29:09.196 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081223: NSP Update Query is based on Serial Number Tue May 19 22:29:09.212 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081223: ArAuthFrameworkImpl::doPostAuth::1:10081219:: Authentication mechanism returned [0] for AuthIdentity [00919545] Tue May 19 22:29:09.227 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 10081223: Prepared to Send OK Tue May 19 22:29:09.227 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 61: 10081223: Packet being sent Tue May 19 22:29:09.227 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Packet Sent (MsgType:109, Size: 256 Bytes). Tue May 19 22:29:09.274 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Packet Received (MsgType:110, Size: 100 Bytes). Tue May 19 22:29:09.274 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:29:09.274 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 0: 10081224: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:29:09.274 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081224: Using session identifier [1:10081224] Tue May 19 22:29:09.274 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081224: ArAuthFrameworkImpl::doPreAuth::1:10081224:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:29:09.274 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081224: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:29:09.274 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081224: Session tracker Id associated with generate challenge[1:10081224] Tue May 19 22:29:09.274 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081224: ArAuthFrameworkImpl::doAuth::1:10081224:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:29:09.274 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081224: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:29:09.274 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081224: ArAuthFrameworkImpl::doPostAuth::1:10081224:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:29:09.290 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 10081224: Sending Continue with challenge Tue May 19 22:29:09.290 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 61: 10081224: Packet being sent Tue May 19 22:29:09.290 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Packet Sent (MsgType:110, Size: 176 Bytes). Tue May 19 22:29:10.899 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Packet Received (MsgType:110, Size: 154 Bytes). Tue May 19 22:29:10.899 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:29:10.899 2009 Morocco Standard Time INFO: pid 2172 tid 688: 0: 10081225: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:29:10.899 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081225: Using session identifier [1:10081225] Tue May 19 22:29:10.899 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081225: ArAuthFrameworkImpl::doPreAuth::1:10081225:: Authentication mechanism returned [0] for AuthIdentity [01118438;ARCARD] Tue May 19 22:29:10.899 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081225: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:29:10.915 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081225: ArAuthFrameworkImpl::doAuth::1:10081225:: Authentication mechanism returned [1] for AuthIdentity [01118438;ARCARD] Tue May 19 22:29:10.915 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081225: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:29:10.915 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081225: ArAuthFrameworkImpl::doPostAuth::1:10081225:: Authentication mechanism returned [1] for AuthIdentity [01118438] Tue May 19 22:29:10.915 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 10081225: Sending Continue with challenge Tue May 19 22:29:10.915 2009 Morocco Standard Time INFO: pid 2172 tid 688: 61: 10081225: Packet being sent Tue May 19 22:29:10.915 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Packet Sent (MsgType:110, Size: 1564 Bytes). Tue May 19 22:29:10.931 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Packet Received (MsgType:109, Size: 1430 Bytes). Tue May 19 22:29:10.931 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:29:10.931 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 0: 10081226: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:29:10.931 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081226: Using session identifier [1:10081226] Tue May 19 22:29:10.931 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081226: ArAuthFrameworkImpl::doPreAuth::1:10081226:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:29:10.931 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081226: Arcot Native Server: recvd AA_BIN_MSG_VER_CHG Tue May 19 22:29:10.931 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081226: Cert Subject String....:[CN=01118438;O=MLS; UserID=01118438; CardName=ARCARD] Tue May 19 22:29:10.931 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081226: Cert issuer............:[CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US] Tue May 19 22:29:10.931 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081226: Cert serial String.....:[0103f6] Tue May 19 22:29:10.931 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081226: ArcotId Certificate received with signature have ArcotExtension. Cert issuer=CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US, serial=0103f6 and subject=CN=01118438;O=MLS Tue May 19 22:29:10.931 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081226: ArcotID Credential Not found. Serial number[103f6].Considering the cert is reissued. Tue May 19 22:29:10.931 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081226: Auth failed due to Account Verification(serial Number [103f6]) Tue May 19 22:29:10.931 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081226: Session tracker Id associated with verify signed challenge[1:10081224] Tue May 19 22:29:10.931 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081226: ArAuthFrameworkImpl::doAuth::1:10081224:: Authentication mechanism returned [10] for AuthIdentity [] Tue May 19 22:29:10.931 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081226: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:29:10.931 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081226: ArAuthFrameworkImpl::doPostAuth::1:10081224:: Authentication mechanism returned [10] for AuthIdentity [] Tue May 19 22:29:10.946 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 61: 10081226: Packet being sent Tue May 19 22:29:10.946 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Packet Sent (MsgType:109, Size: 148 Bytes). Tue May 19 22:29:11.227 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Packet Received (MsgType:110, Size: 100 Bytes). Tue May 19 22:29:11.227 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:29:11.227 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 0: 10081227: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:29:11.227 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081227: Using session identifier [1:10081227] Tue May 19 22:29:11.227 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081227: ArAuthFrameworkImpl::doPreAuth::1:10081227:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:29:11.227 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081227: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:29:11.227 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081227: Session tracker Id associated with generate challenge[1:10081227] Tue May 19 22:29:11.227 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081227: ArAuthFrameworkImpl::doAuth::1:10081227:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:29:11.227 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081227: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:29:11.227 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081227: ArAuthFrameworkImpl::doPostAuth::1:10081227:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:29:11.227 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 10081227: Sending Continue with challenge Tue May 19 22:29:11.227 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 61: 10081227: Packet being sent Tue May 19 22:29:11.227 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Packet Sent (MsgType:110, Size: 176 Bytes). Tue May 19 22:29:11.337 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Packet Received (MsgType:110, Size: 154 Bytes). Tue May 19 22:29:11.337 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:29:11.337 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 0: 10081228: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:29:11.337 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081228: Using session identifier [1:10081228] Tue May 19 22:29:11.337 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081228: ArAuthFrameworkImpl::doPreAuth::1:10081228:: Authentication mechanism returned [0] for AuthIdentity [01018603;ARCARD] Tue May 19 22:29:11.337 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081228: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:29:11.337 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081228: ArAuthFrameworkImpl::doAuth::1:10081228:: Authentication mechanism returned [1] for AuthIdentity [01018603;ARCARD] Tue May 19 22:29:11.337 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081228: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:29:11.337 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081228: ArAuthFrameworkImpl::doPostAuth::1:10081228:: Authentication mechanism returned [1] for AuthIdentity [01018603] Tue May 19 22:29:11.352 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 10081228: Sending Continue with challenge Tue May 19 22:29:11.352 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 61: 10081228: Packet being sent Tue May 19 22:29:11.352 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Packet Sent (MsgType:110, Size: 1564 Bytes). Tue May 19 22:29:12.634 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Packet Received (MsgType: 0, Size: 106 Bytes). Tue May 19 22:29:12.634 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:29:12.634 2009 Morocco Standard Time INFO: pid 2172 tid 688: 0: 10081229: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:29:12.634 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 10081229: Entering [MechQnA::handleAuthRequest] Tue May 19 22:29:12.634 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 10081229: Exiting [MechQnA::handleAuthRequest] Tue May 19 22:29:12.634 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081229: Using session identifier [1:10081229] Tue May 19 22:29:12.634 2009 Morocco Standard Time INFO: pid 2172 tid 688: 160: 10081229: Entering QnAModule::openSession Tue May 19 22:29:12.634 2009 Morocco Standard Time INFO: pid 2172 tid 688: 160: 10081229: Exiting QnAModule::openSession Tue May 19 22:29:12.634 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081229: ArAuthFrameworkImpl::doPreAuth::1:10081229:: Authentication mechanism returned [0] for AuthIdentity [01018603] Tue May 19 22:29:12.634 2009 Morocco Standard Time INFO: pid 2172 tid 688: 160: 10081229: Entering QnAModule::authenticate Tue May 19 22:29:12.634 2009 Morocco Standard Time INFO: pid 2172 tid 688: 160: 10081229: QnA Session Id :[1:10081229] Tue May 19 22:29:12.634 2009 Morocco Standard Time INFO: pid 2172 tid 688: 160: 10081229: QNA Step - ASK AUTH QUESTIONS Tue May 19 22:29:12.634 2009 Morocco Standard Time INFO: pid 2172 tid 688: 160: 10081229: User DB Query Details: Tue May 19 22:29:12.634 2009 Morocco Standard Time INFO: pid 2172 tid 688: 160: 10081229: userName :[01018603] Tue May 19 22:29:12.634 2009 Morocco Standard Time INFO: pid 2172 tid 688: 160: 10081229: Group ID :1020 Tue May 19 22:29:12.634 2009 Morocco Standard Time INFO: pid 2172 tid 688: 160: 10081229: User ID :-1 Tue May 19 22:29:12.634 2009 Morocco Standard Time INFO: pid 2172 tid 688: 160: 10081229: Number of rows fetched from DB : 1 Tue May 19 22:29:12.634 2009 Morocco Standard Time INFO: pid 2172 tid 688: 160: 10081229: Entering QnAUserData::dump Tue May 19 22:29:12.634 2009 Morocco Standard Time INFO: pid 2172 tid 688: 160: 10081229: Exiting QnAUserData::dump Tue May 19 22:29:12.634 2009 Morocco Standard Time INFO: pid 2172 tid 688: 160: 10081229: Set of questions(bitmap) selected : 3 Tue May 19 22:29:12.634 2009 Morocco Standard Time INFO: pid 2172 tid 688: 160: 10081229: Session tracker Id associated with QnA challenge(auth round questions) : [1:10081229] Tue May 19 22:29:12.634 2009 Morocco Standard Time INFO: pid 2172 tid 688: 160: 10081229: Exiting QnAModule::authenticate Tue May 19 22:29:12.634 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081229: ArAuthFrameworkImpl::doAuth::1:10081229:: Authentication mechanism returned [1] for AuthIdentity [01018603] Tue May 19 22:29:12.634 2009 Morocco Standard Time INFO: pid 2172 tid 688: 160: 10081229: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [2] Tue May 19 22:29:12.634 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081229: ArAuthFrameworkImpl::doPostAuth::1:10081229:: Authentication mechanism returned [1] for AuthIdentity [01018603] Tue May 19 22:29:12.634 2009 Morocco Standard Time INFO: pid 2172 tid 688: 160: 10081229: Entering QnAModule::closeSession Tue May 19 22:29:12.634 2009 Morocco Standard Time INFO: pid 2172 tid 688: 160: 10081229: Exiting QnAModule::closeSession Tue May 19 22:29:12.649 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 10081229: Entering [MechQnA::handleAuthResMoreSteps] Tue May 19 22:29:12.649 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 10081229: Exiting [MechQnA::handleAuthResMoreSteps] Tue May 19 22:29:12.649 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 10081229: Sending Continue with challenge Tue May 19 22:29:12.649 2009 Morocco Standard Time INFO: pid 2172 tid 688: 61: 10081229: Packet being sent Tue May 19 22:29:12.649 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Packet Sent (MsgType: 0, Size: 368 Bytes). Tue May 19 22:29:14.493 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Packet Received (MsgType: 0, Size: 106 Bytes). Tue May 19 22:29:14.493 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:29:14.493 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 0: 10081230: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:29:14.493 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 10081230: Entering [MechQnA::handleAuthRequest] Tue May 19 22:29:14.493 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 10081230: Exiting [MechQnA::handleAuthRequest] Tue May 19 22:29:14.493 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081230: Using session identifier [1:10081230] Tue May 19 22:29:14.493 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 160: 10081230: Entering QnAModule::openSession Tue May 19 22:29:14.493 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 160: 10081230: Exiting QnAModule::openSession Tue May 19 22:29:14.493 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081230: ArAuthFrameworkImpl::doPreAuth::1:10081230:: Authentication mechanism returned [0] for AuthIdentity [01018603] Tue May 19 22:29:14.493 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 160: 10081230: Entering QnAModule::authenticate Tue May 19 22:29:14.493 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 160: 10081230: QnA Session Id :[1:10081230] Tue May 19 22:29:14.493 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 160: 10081230: QNA Step - ASK AUTH QUESTIONS Tue May 19 22:29:14.493 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 160: 10081230: User DB Query Details: Tue May 19 22:29:14.493 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 160: 10081230: userName :[01018603] Tue May 19 22:29:14.493 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 160: 10081230: Group ID :1020 Tue May 19 22:29:14.493 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 160: 10081230: User ID :-1 Tue May 19 22:29:14.493 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 160: 10081230: Number of rows fetched from DB : 1 Tue May 19 22:29:14.493 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 160: 10081230: Entering QnAUserData::dump Tue May 19 22:29:14.493 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 160: 10081230: Exiting QnAUserData::dump Tue May 19 22:29:14.493 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 160: 10081230: Set of questions(bitmap) selected : 3 Tue May 19 22:29:14.509 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 160: 10081230: Session tracker Id associated with QnA challenge(auth round questions) : [1:10081230] Tue May 19 22:29:14.509 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 160: 10081230: Exiting QnAModule::authenticate Tue May 19 22:29:14.509 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081230: ArAuthFrameworkImpl::doAuth::1:10081230:: Authentication mechanism returned [1] for AuthIdentity [01018603] Tue May 19 22:29:14.509 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 160: 10081230: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [2] Tue May 19 22:29:14.509 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081230: ArAuthFrameworkImpl::doPostAuth::1:10081230:: Authentication mechanism returned [1] for AuthIdentity [01018603] Tue May 19 22:29:14.509 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 160: 10081230: Entering QnAModule::closeSession Tue May 19 22:29:14.509 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 160: 10081230: Exiting QnAModule::closeSession Tue May 19 22:29:14.509 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 10081230: Entering [MechQnA::handleAuthResMoreSteps] Tue May 19 22:29:14.509 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 10081230: Exiting [MechQnA::handleAuthResMoreSteps] Tue May 19 22:29:14.509 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 10081230: Sending Continue with challenge Tue May 19 22:29:14.509 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 61: 10081230: Packet being sent Tue May 19 22:29:14.509 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Packet Sent (MsgType: 0, Size: 368 Bytes). Tue May 19 22:29:15.056 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Packet Received (MsgType:110, Size: 100 Bytes). Tue May 19 22:29:15.056 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:29:15.056 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 0: 10081231: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:29:15.056 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081231: Using session identifier [1:10081231] Tue May 19 22:29:15.056 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081231: ArAuthFrameworkImpl::doPreAuth::1:10081231:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:29:15.056 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081231: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:29:15.056 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081231: Session tracker Id associated with generate challenge[1:10081231] Tue May 19 22:29:15.056 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081231: ArAuthFrameworkImpl::doAuth::1:10081231:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:29:15.056 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081231: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:29:15.056 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081231: ArAuthFrameworkImpl::doPostAuth::1:10081231:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:29:15.071 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 10081231: Sending Continue with challenge Tue May 19 22:29:15.071 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 61: 10081231: Packet being sent Tue May 19 22:29:15.071 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Packet Sent (MsgType:110, Size: 176 Bytes). Tue May 19 22:29:15.571 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Packet Received (MsgType:110, Size: 154 Bytes). Tue May 19 22:29:15.571 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:29:15.571 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 0: 10081232: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:29:15.571 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081232: Using session identifier [1:10081232] Tue May 19 22:29:15.571 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081232: ArAuthFrameworkImpl::doPreAuth::1:10081232:: Authentication mechanism returned [0] for AuthIdentity [01374062;ARCARD] Tue May 19 22:29:15.571 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081232: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:29:15.571 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081232: ArAuthFrameworkImpl::doAuth::1:10081232:: Authentication mechanism returned [1] for AuthIdentity [01374062;ARCARD] Tue May 19 22:29:15.571 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081232: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:29:15.571 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081232: ArAuthFrameworkImpl::doPostAuth::1:10081232:: Authentication mechanism returned [1] for AuthIdentity [01374062] Tue May 19 22:29:15.587 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 10081232: Sending Continue with challenge Tue May 19 22:29:15.587 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 61: 10081232: Packet being sent Tue May 19 22:29:15.587 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Packet Sent (MsgType:110, Size: 1564 Bytes). Tue May 19 22:29:15.587 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Packet Received (MsgType:109, Size: 1430 Bytes). Tue May 19 22:29:15.587 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:29:15.587 2009 Morocco Standard Time INFO: pid 2172 tid 688: 0: 10081233: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:29:15.587 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081233: Using session identifier [1:10081233] Tue May 19 22:29:15.587 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081233: ArAuthFrameworkImpl::doPreAuth::1:10081233:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:29:15.587 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081233: Arcot Native Server: recvd AA_BIN_MSG_VER_CHG Tue May 19 22:29:15.587 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081233: Cert Subject String....:[CN=01374062;O=MLS; UserID=01374062; CardName=ARCARD] Tue May 19 22:29:15.587 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081233: Cert issuer............:[CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US] Tue May 19 22:29:15.587 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081233: Cert serial String.....:[98d0] Tue May 19 22:29:15.587 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081233: ArcotId Certificate received with signature have ArcotExtension. Cert issuer=CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US, serial=98d0 and subject=CN=01374062;O=MLS Tue May 19 22:29:15.587 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081233: ArcotID Auth SUCCESS (serial Number [98d0]) Tue May 19 22:29:15.587 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081233: Session tracker Id associated with verify signed challenge[1:10081231] Tue May 19 22:29:15.587 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081233: ArAuthFrameworkImpl::doAuth::1:10081231:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:29:15.587 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081233: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:29:15.587 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081233: Handle_NSPAdvice::NSP Action :[NSP_RESET] Tue May 19 22:29:15.602 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081233: NSP Update Query is based on Serial Number Tue May 19 22:29:15.602 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081233: ArAuthFrameworkImpl::doPostAuth::1:10081231:: Authentication mechanism returned [0] for AuthIdentity [01374062] Tue May 19 22:29:15.618 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 10081233: Prepared to Send OK Tue May 19 22:29:15.618 2009 Morocco Standard Time INFO: pid 2172 tid 688: 61: 10081233: Packet being sent Tue May 19 22:29:15.618 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Packet Sent (MsgType:109, Size: 256 Bytes). Tue May 19 22:29:20.524 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Packet Received (MsgType:110, Size: 100 Bytes). Tue May 19 22:29:20.524 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:29:20.524 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 0: 10081234: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:29:20.524 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081234: Using session identifier [1:10081234] Tue May 19 22:29:20.524 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081234: ArAuthFrameworkImpl::doPreAuth::1:10081234:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:29:20.524 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081234: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:29:20.524 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081234: Session tracker Id associated with generate challenge[1:10081234] Tue May 19 22:29:20.524 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081234: ArAuthFrameworkImpl::doAuth::1:10081234:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:29:20.524 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081234: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:29:20.524 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081234: ArAuthFrameworkImpl::doPostAuth::1:10081234:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:29:20.524 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 10081234: Sending Continue with challenge Tue May 19 22:29:20.524 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 61: 10081234: Packet being sent Tue May 19 22:29:20.524 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Packet Sent (MsgType:110, Size: 176 Bytes). Tue May 19 22:29:22.602 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Packet Received (MsgType:110, Size: 154 Bytes). Tue May 19 22:29:22.602 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:29:22.602 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 0: 10081235: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:29:22.602 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081235: Using session identifier [1:10081235] Tue May 19 22:29:22.602 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081235: ArAuthFrameworkImpl::doPreAuth::1:10081235:: Authentication mechanism returned [0] for AuthIdentity [01483481;ARCARD] Tue May 19 22:29:22.602 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081235: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:29:22.602 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081235: ArAuthFrameworkImpl::doAuth::1:10081235:: Authentication mechanism returned [1] for AuthIdentity [01483481;ARCARD] Tue May 19 22:29:22.602 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081235: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:29:22.602 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081235: ArAuthFrameworkImpl::doPostAuth::1:10081235:: Authentication mechanism returned [1] for AuthIdentity [01483481] Tue May 19 22:29:22.618 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 10081235: Sending Continue with challenge Tue May 19 22:29:22.618 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 61: 10081235: Packet being sent Tue May 19 22:29:22.618 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Packet Sent (MsgType:110, Size: 1564 Bytes). Tue May 19 22:29:22.618 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Packet Received (MsgType:109, Size: 1430 Bytes). Tue May 19 22:29:22.618 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:29:22.618 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 0: 10081236: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:29:22.618 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081236: Using session identifier [1:10081236] Tue May 19 22:29:22.618 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081236: ArAuthFrameworkImpl::doPreAuth::1:10081236:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:29:22.618 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081236: Arcot Native Server: recvd AA_BIN_MSG_VER_CHG Tue May 19 22:29:22.618 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081236: Cert Subject String....:[CN=01483481;O=MLS; UserID=01483481; CardName=ARCARD] Tue May 19 22:29:22.618 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081236: Cert issuer............:[CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US] Tue May 19 22:29:22.618 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081236: Cert serial String.....:[ffc2] Tue May 19 22:29:22.618 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081236: ArcotId Certificate received with signature have ArcotExtension. Cert issuer=CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US, serial=ffc2 and subject=CN=01483481;O=MLS Tue May 19 22:29:22.634 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081236: ArcotID Auth SUCCESS (serial Number [ffc2]) Tue May 19 22:29:22.634 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081236: Session tracker Id associated with verify signed challenge[1:10081234] Tue May 19 22:29:22.634 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081236: ArAuthFrameworkImpl::doAuth::1:10081234:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:29:22.634 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081236: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:29:22.634 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081236: Handle_NSPAdvice::NSP Action :[NSP_RESET] Tue May 19 22:29:22.634 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081236: NSP Update Query is based on Serial Number Tue May 19 22:29:22.649 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081236: ArAuthFrameworkImpl::doPostAuth::1:10081234:: Authentication mechanism returned [0] for AuthIdentity [01483481] Tue May 19 22:29:22.665 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 10081236: Prepared to Send OK Tue May 19 22:29:22.665 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 61: 10081236: Packet being sent Tue May 19 22:29:22.665 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Packet Sent (MsgType:109, Size: 256 Bytes). Tue May 19 22:29:30.493 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Packet Received (MsgType:110, Size: 100 Bytes). Tue May 19 22:29:30.493 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:29:30.493 2009 Morocco Standard Time INFO: pid 2172 tid 688: 0: 10081237: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:29:30.493 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081237: Using session identifier [1:10081237] Tue May 19 22:29:30.493 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081237: ArAuthFrameworkImpl::doPreAuth::1:10081237:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:29:30.493 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081237: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:29:30.493 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081237: Session tracker Id associated with generate challenge[1:10081237] Tue May 19 22:29:30.493 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081237: ArAuthFrameworkImpl::doAuth::1:10081237:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:29:30.493 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081237: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:29:30.493 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081237: ArAuthFrameworkImpl::doPostAuth::1:10081237:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:29:30.509 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 10081237: Sending Continue with challenge Tue May 19 22:29:30.509 2009 Morocco Standard Time INFO: pid 2172 tid 688: 61: 10081237: Packet being sent Tue May 19 22:29:30.509 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Packet Sent (MsgType:110, Size: 176 Bytes). Tue May 19 22:29:31.399 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Packet Received (MsgType:110, Size: 154 Bytes). Tue May 19 22:29:31.399 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:29:31.399 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 0: 10081238: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:29:31.399 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081238: Using session identifier [1:10081238] Tue May 19 22:29:31.399 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081238: ArAuthFrameworkImpl::doPreAuth::1:10081238:: Authentication mechanism returned [0] for AuthIdentity [01035994;ARCARD] Tue May 19 22:29:31.399 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081238: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:29:31.399 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081238: ArAuthFrameworkImpl::doAuth::1:10081238:: Authentication mechanism returned [1] for AuthIdentity [01035994;ARCARD] Tue May 19 22:29:31.399 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081238: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:29:31.399 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081238: ArAuthFrameworkImpl::doPostAuth::1:10081238:: Authentication mechanism returned [1] for AuthIdentity [01035994] Tue May 19 22:29:31.415 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 10081238: Sending Continue with challenge Tue May 19 22:29:31.415 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 61: 10081238: Packet being sent Tue May 19 22:29:31.415 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Packet Sent (MsgType:110, Size: 1564 Bytes). Tue May 19 22:29:31.415 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Packet Received (MsgType:109, Size: 1430 Bytes). Tue May 19 22:29:31.415 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:29:31.415 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 0: 10081239: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:29:31.415 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081239: Using session identifier [1:10081239] Tue May 19 22:29:31.415 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081239: ArAuthFrameworkImpl::doPreAuth::1:10081239:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:29:31.415 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081239: Arcot Native Server: recvd AA_BIN_MSG_VER_CHG Tue May 19 22:29:31.415 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081239: Cert Subject String....:[CN=01035994;O=MLS; UserID=01035994; CardName=ARCARD] Tue May 19 22:29:31.415 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081239: Cert issuer............:[CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US] Tue May 19 22:29:31.415 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081239: Cert serial String.....:[0104d7] Tue May 19 22:29:31.415 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081239: ArcotId Certificate received with signature have ArcotExtension. Cert issuer=CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US, serial=0104d7 and subject=CN=01035994;O=MLS Tue May 19 22:29:31.415 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081239: ArcotID Auth SUCCESS (serial Number [104d7]) Tue May 19 22:29:31.415 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081239: Session tracker Id associated with verify signed challenge[1:10081237] Tue May 19 22:29:31.415 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081239: ArAuthFrameworkImpl::doAuth::1:10081237:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:29:31.415 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081239: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:29:31.415 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081239: Handle_NSPAdvice::NSP Action :[NSP_RESET] Tue May 19 22:29:31.415 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081239: NSP Update Query is based on Serial Number Tue May 19 22:29:31.431 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081239: ArAuthFrameworkImpl::doPostAuth::1:10081237:: Authentication mechanism returned [0] for AuthIdentity [01035994] Tue May 19 22:29:31.446 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 10081239: Prepared to Send OK Tue May 19 22:29:31.446 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 61: 10081239: Packet being sent Tue May 19 22:29:31.446 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Packet Sent (MsgType:109, Size: 256 Bytes). Tue May 19 22:29:31.524 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Packet Received (MsgType:110, Size: 100 Bytes). Tue May 19 22:29:31.524 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:29:31.524 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 0: 10081240: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:29:31.524 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081240: Using session identifier [1:10081240] Tue May 19 22:29:31.524 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081240: ArAuthFrameworkImpl::doPreAuth::1:10081240:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:29:31.524 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081240: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:29:31.524 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081240: Session tracker Id associated with generate challenge[1:10081240] Tue May 19 22:29:31.524 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081240: ArAuthFrameworkImpl::doAuth::1:10081240:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:29:31.524 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081240: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:29:31.524 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081240: ArAuthFrameworkImpl::doPostAuth::1:10081240:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:29:31.524 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 10081240: Sending Continue with challenge Tue May 19 22:29:31.524 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 61: 10081240: Packet being sent Tue May 19 22:29:31.524 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Packet Sent (MsgType:110, Size: 176 Bytes). Tue May 19 22:29:32.368 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Packet Received (MsgType:110, Size: 154 Bytes). Tue May 19 22:29:32.368 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:29:32.368 2009 Morocco Standard Time INFO: pid 2172 tid 688: 0: 10081241: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:29:32.368 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081241: Using session identifier [1:10081241] Tue May 19 22:29:32.368 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081241: ArAuthFrameworkImpl::doPreAuth::1:10081241:: Authentication mechanism returned [0] for AuthIdentity [35000467;ARCARD] Tue May 19 22:29:32.368 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081241: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:29:32.368 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081241: ArAuthFrameworkImpl::doAuth::1:10081241:: Authentication mechanism returned [1] for AuthIdentity [35000467;ARCARD] Tue May 19 22:29:32.368 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081241: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:29:32.368 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081241: ArAuthFrameworkImpl::doPostAuth::1:10081241:: Authentication mechanism returned [1] for AuthIdentity [35000467] Tue May 19 22:29:32.384 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 10081241: Sending Continue with challenge Tue May 19 22:29:32.384 2009 Morocco Standard Time INFO: pid 2172 tid 688: 61: 10081241: Packet being sent Tue May 19 22:29:32.384 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Packet Sent (MsgType:110, Size: 1564 Bytes). Tue May 19 22:29:32.384 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Packet Received (MsgType:109, Size: 1430 Bytes). Tue May 19 22:29:32.384 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:29:32.384 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 0: 10081242: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:29:32.384 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081242: Using session identifier [1:10081242] Tue May 19 22:29:32.384 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081242: ArAuthFrameworkImpl::doPreAuth::1:10081242:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:29:32.384 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081242: Arcot Native Server: recvd AA_BIN_MSG_VER_CHG Tue May 19 22:29:32.384 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081242: Cert Subject String....:[CN=35000467;O=MLS; UserID=35000467; CardName=ARCARD] Tue May 19 22:29:32.384 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081242: Cert issuer............:[CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US] Tue May 19 22:29:32.384 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081242: Cert serial String.....:[010f1d] Tue May 19 22:29:32.384 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081242: ArcotId Certificate received with signature have ArcotExtension. Cert issuer=CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US, serial=010f1d and subject=CN=35000467;O=MLS Tue May 19 22:29:32.399 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081242: ArcotID Auth SUCCESS (serial Number [10f1d]) Tue May 19 22:29:32.399 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081242: Session tracker Id associated with verify signed challenge[1:10081240] Tue May 19 22:29:32.399 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081242: ArAuthFrameworkImpl::doAuth::1:10081240:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:29:32.399 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081242: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:29:32.399 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081242: Handle_NSPAdvice::NSP Action :[NSP_RESET] Tue May 19 22:29:32.399 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081242: NSP Update Query is based on Serial Number Tue May 19 22:29:32.415 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081242: ArAuthFrameworkImpl::doPostAuth::1:10081240:: Authentication mechanism returned [0] for AuthIdentity [35000467] Tue May 19 22:29:32.415 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 10081242: Prepared to Send OK Tue May 19 22:29:32.415 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 61: 10081242: Packet being sent Tue May 19 22:29:32.415 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Packet Sent (MsgType:109, Size: 256 Bytes). Tue May 19 22:29:32.446 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Packet Received (MsgType:110, Size: 100 Bytes). Tue May 19 22:29:32.446 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:29:32.446 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 0: 10081243: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:29:32.446 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081243: Using session identifier [1:10081243] Tue May 19 22:29:32.446 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081243: ArAuthFrameworkImpl::doPreAuth::1:10081243:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:29:32.446 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081243: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:29:32.446 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081243: Session tracker Id associated with generate challenge[1:10081243] Tue May 19 22:29:32.446 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081243: ArAuthFrameworkImpl::doAuth::1:10081243:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:29:32.446 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081243: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:29:32.446 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081243: ArAuthFrameworkImpl::doPostAuth::1:10081243:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:29:32.462 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 10081243: Sending Continue with challenge Tue May 19 22:29:32.462 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 61: 10081243: Packet being sent Tue May 19 22:29:32.462 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Packet Sent (MsgType:110, Size: 176 Bytes). Tue May 19 22:29:33.431 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Packet Received (MsgType:110, Size: 154 Bytes). Tue May 19 22:29:33.431 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:29:33.431 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 0: 10081244: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:29:33.431 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081244: Using session identifier [1:10081244] Tue May 19 22:29:33.431 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081244: ArAuthFrameworkImpl::doPreAuth::1:10081244:: Authentication mechanism returned [0] for AuthIdentity [01777074;ARCARD] Tue May 19 22:29:33.431 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081244: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:29:33.446 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081244: ArAuthFrameworkImpl::doAuth::1:10081244:: Authentication mechanism returned [1] for AuthIdentity [01777074;ARCARD] Tue May 19 22:29:33.446 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081244: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:29:33.446 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081244: ArAuthFrameworkImpl::doPostAuth::1:10081244:: Authentication mechanism returned [1] for AuthIdentity [01777074] Tue May 19 22:29:33.462 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 10081244: Sending Continue with challenge Tue May 19 22:29:33.462 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 61: 10081244: Packet being sent Tue May 19 22:29:33.462 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Packet Sent (MsgType:110, Size: 1564 Bytes). Tue May 19 22:29:33.462 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Packet Received (MsgType:109, Size: 1430 Bytes). Tue May 19 22:29:33.462 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:29:33.462 2009 Morocco Standard Time INFO: pid 2172 tid 688: 0: 10081245: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:29:33.462 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081245: Using session identifier [1:10081245] Tue May 19 22:29:33.462 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081245: ArAuthFrameworkImpl::doPreAuth::1:10081245:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:29:33.462 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081245: Arcot Native Server: recvd AA_BIN_MSG_VER_CHG Tue May 19 22:29:33.462 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081245: Cert Subject String....:[CN=01777074;O=MLS; UserID=01777074; CardName=ARCARD] Tue May 19 22:29:33.462 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081245: Cert issuer............:[CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US] Tue May 19 22:29:33.462 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081245: Cert serial String.....:[010908] Tue May 19 22:29:33.462 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081245: ArcotId Certificate received with signature have ArcotExtension. Cert issuer=CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US, serial=010908 and subject=CN=01777074;O=MLS Tue May 19 22:29:33.462 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081245: ArcotID Auth SUCCESS (serial Number [10908]) Tue May 19 22:29:33.462 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081245: Session tracker Id associated with verify signed challenge[1:10081243] Tue May 19 22:29:33.462 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081245: ArAuthFrameworkImpl::doAuth::1:10081243:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:29:33.462 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081245: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:29:33.462 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081245: Handle_NSPAdvice::NSP Action :[NSP_RESET] Tue May 19 22:29:33.462 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081245: NSP Update Query is based on Serial Number Tue May 19 22:29:33.477 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081245: ArAuthFrameworkImpl::doPostAuth::1:10081243:: Authentication mechanism returned [0] for AuthIdentity [01777074] Tue May 19 22:29:33.493 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 10081245: Prepared to Send OK Tue May 19 22:29:33.493 2009 Morocco Standard Time INFO: pid 2172 tid 688: 61: 10081245: Packet being sent Tue May 19 22:29:33.493 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Packet Sent (MsgType:109, Size: 256 Bytes). Tue May 19 22:29:33.868 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Packet Received (MsgType:110, Size: 100 Bytes). Tue May 19 22:29:33.868 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:29:33.868 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 0: 10081246: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:29:33.868 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081246: Using session identifier [1:10081246] Tue May 19 22:29:33.868 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081246: ArAuthFrameworkImpl::doPreAuth::1:10081246:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:29:33.868 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081246: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:29:33.868 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081246: Session tracker Id associated with generate challenge[1:10081246] Tue May 19 22:29:33.868 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081246: ArAuthFrameworkImpl::doAuth::1:10081246:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:29:33.868 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081246: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:29:33.868 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081246: ArAuthFrameworkImpl::doPostAuth::1:10081246:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:29:33.884 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 10081246: Sending Continue with challenge Tue May 19 22:29:33.884 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 61: 10081246: Packet being sent Tue May 19 22:29:33.884 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Packet Sent (MsgType:110, Size: 176 Bytes). Tue May 19 22:29:34.743 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Packet Received (MsgType:110, Size: 100 Bytes). Tue May 19 22:29:34.743 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:29:34.743 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 0: 10081247: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:29:34.743 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081247: Using session identifier [1:10081247] Tue May 19 22:29:34.743 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081247: ArAuthFrameworkImpl::doPreAuth::1:10081247:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:29:34.743 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081247: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:29:34.743 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081247: Session tracker Id associated with generate challenge[1:10081247] Tue May 19 22:29:34.743 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081247: ArAuthFrameworkImpl::doAuth::1:10081247:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:29:34.743 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081247: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:29:34.743 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081247: ArAuthFrameworkImpl::doPostAuth::1:10081247:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:29:34.759 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Packet Received (MsgType:110, Size: 154 Bytes). Tue May 19 22:29:34.759 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:29:34.759 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 0: 10081248: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:29:34.759 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081248: Using session identifier [1:10081248] Tue May 19 22:29:34.759 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081248: ArAuthFrameworkImpl::doPreAuth::1:10081248:: Authentication mechanism returned [0] for AuthIdentity [01011089;ARCARD] Tue May 19 22:29:34.759 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081248: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:29:34.759 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081248: ArAuthFrameworkImpl::doAuth::1:10081248:: Authentication mechanism returned [1] for AuthIdentity [01011089;ARCARD] Tue May 19 22:29:34.759 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081248: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:29:34.759 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081248: ArAuthFrameworkImpl::doPostAuth::1:10081248:: Authentication mechanism returned [1] for AuthIdentity [01011089] Tue May 19 22:29:34.774 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 10081247: Sending Continue with challenge Tue May 19 22:29:34.774 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 61: 10081247: Packet being sent Tue May 19 22:29:34.774 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Packet Sent (MsgType:110, Size: 176 Bytes). Tue May 19 22:29:34.774 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 10081248: Sending Continue with challenge Tue May 19 22:29:34.774 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 61: 10081248: Packet being sent Tue May 19 22:29:34.774 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Packet Sent (MsgType:110, Size: 1564 Bytes). Tue May 19 22:29:34.790 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Packet Received (MsgType:109, Size: 1430 Bytes). Tue May 19 22:29:34.790 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:29:34.790 2009 Morocco Standard Time INFO: pid 2172 tid 688: 0: 10081249: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:29:34.790 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081249: Using session identifier [1:10081249] Tue May 19 22:29:34.790 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081249: ArAuthFrameworkImpl::doPreAuth::1:10081249:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:29:34.790 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081249: Arcot Native Server: recvd AA_BIN_MSG_VER_CHG Tue May 19 22:29:34.790 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081249: Cert Subject String....:[CN=01011089;O=MLS; UserID=01011089; CardName=ARCARD] Tue May 19 22:29:34.790 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081249: Cert issuer............:[CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US] Tue May 19 22:29:34.790 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081249: Cert serial String.....:[e40a] Tue May 19 22:29:34.790 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081249: ArcotId Certificate received with signature have ArcotExtension. Cert issuer=CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US, serial=e40a and subject=CN=01011089;O=MLS Tue May 19 22:29:34.790 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081249: ArcotID Auth SUCCESS (serial Number [e40a]) Tue May 19 22:29:34.790 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081249: Session tracker Id associated with verify signed challenge[1:10081246] Tue May 19 22:29:34.790 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081249: ArAuthFrameworkImpl::doAuth::1:10081246:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:29:34.790 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081249: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:29:34.790 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081249: Handle_NSPAdvice::NSP Action :[NSP_RESET] Tue May 19 22:29:34.790 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081249: NSP Update Query is based on Serial Number Tue May 19 22:29:34.806 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081249: ArAuthFrameworkImpl::doPostAuth::1:10081246:: Authentication mechanism returned [0] for AuthIdentity [01011089] Tue May 19 22:29:34.821 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 10081249: Prepared to Send OK Tue May 19 22:29:34.821 2009 Morocco Standard Time INFO: pid 2172 tid 688: 61: 10081249: Packet being sent Tue May 19 22:29:34.821 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Packet Sent (MsgType:109, Size: 256 Bytes). Tue May 19 22:29:35.290 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Packet Received (MsgType:110, Size: 154 Bytes). Tue May 19 22:29:35.290 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:29:35.290 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 0: 10081250: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:29:35.290 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081250: Using session identifier [1:10081250] Tue May 19 22:29:35.290 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081250: ArAuthFrameworkImpl::doPreAuth::1:10081250:: Authentication mechanism returned [0] for AuthIdentity [50007446;ARCARD] Tue May 19 22:29:35.290 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081250: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:29:35.290 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081250: ArAuthFrameworkImpl::doAuth::1:10081250:: Authentication mechanism returned [1] for AuthIdentity [50007446;ARCARD] Tue May 19 22:29:35.290 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081250: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:29:35.290 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081250: ArAuthFrameworkImpl::doPostAuth::1:10081250:: Authentication mechanism returned [1] for AuthIdentity [50007446] Tue May 19 22:29:35.306 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 10081250: Sending Continue with challenge Tue May 19 22:29:35.306 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 61: 10081250: Packet being sent Tue May 19 22:29:35.306 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Packet Sent (MsgType:110, Size: 1564 Bytes). Tue May 19 22:29:35.306 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Packet Received (MsgType:109, Size: 1430 Bytes). Tue May 19 22:29:35.306 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:29:35.306 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 0: 10081251: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:29:35.306 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081251: Using session identifier [1:10081251] Tue May 19 22:29:35.306 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081251: ArAuthFrameworkImpl::doPreAuth::1:10081251:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:29:35.306 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081251: Arcot Native Server: recvd AA_BIN_MSG_VER_CHG Tue May 19 22:29:35.306 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081251: Cert Subject String....:[CN=50007446;O=MLS; UserID=50007446; CardName=ARCARD] Tue May 19 22:29:35.306 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081251: Cert issuer............:[CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US] Tue May 19 22:29:35.306 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081251: Cert serial String.....:[be8d] Tue May 19 22:29:35.306 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081251: ArcotId Certificate received with signature have ArcotExtension. Cert issuer=CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US, serial=be8d and subject=CN=50007446;O=MLS Tue May 19 22:29:35.321 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081251: ArcotID Auth SUCCESS (serial Number [be8d]) Tue May 19 22:29:35.321 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081251: Session tracker Id associated with verify signed challenge[1:10081247] Tue May 19 22:29:35.321 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081251: ArAuthFrameworkImpl::doAuth::1:10081247:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:29:35.321 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081251: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:29:35.321 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081251: Handle_NSPAdvice::NSP Action :[NSP_RESET] Tue May 19 22:29:35.321 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081251: NSP Update Query is based on Serial Number Tue May 19 22:29:35.321 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081251: ArAuthFrameworkImpl::doPostAuth::1:10081247:: Authentication mechanism returned [0] for AuthIdentity [50007446] Tue May 19 22:29:35.337 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 10081251: Prepared to Send OK Tue May 19 22:29:35.337 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 61: 10081251: Packet being sent Tue May 19 22:29:35.337 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Packet Sent (MsgType:109, Size: 256 Bytes). Tue May 19 22:29:47.102 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Packet Received (MsgType:110, Size: 100 Bytes). Tue May 19 22:29:47.102 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:29:47.102 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 0: 10081252: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:29:47.102 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081252: Using session identifier [1:10081252] Tue May 19 22:29:47.102 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081252: ArAuthFrameworkImpl::doPreAuth::1:10081252:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:29:47.102 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081252: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:29:47.102 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081252: Session tracker Id associated with generate challenge[1:10081252] Tue May 19 22:29:47.102 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081252: ArAuthFrameworkImpl::doAuth::1:10081252:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:29:47.102 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081252: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:29:47.102 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081252: ArAuthFrameworkImpl::doPostAuth::1:10081252:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:29:47.118 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 10081252: Sending Continue with challenge Tue May 19 22:29:47.118 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 61: 10081252: Packet being sent Tue May 19 22:29:47.118 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Packet Sent (MsgType:110, Size: 176 Bytes). Tue May 19 22:29:48.868 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Packet Received (MsgType:110, Size: 154 Bytes). Tue May 19 22:29:48.868 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:29:48.868 2009 Morocco Standard Time INFO: pid 2172 tid 688: 0: 10081253: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:29:48.868 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081253: Using session identifier [1:10081253] Tue May 19 22:29:48.868 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081253: ArAuthFrameworkImpl::doPreAuth::1:10081253:: Authentication mechanism returned [0] for AuthIdentity [01214225;ARCARD] Tue May 19 22:29:48.868 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081253: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:29:48.884 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081253: ArAuthFrameworkImpl::doAuth::1:10081253:: Authentication mechanism returned [1] for AuthIdentity [01214225;ARCARD] Tue May 19 22:29:48.884 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081253: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:29:48.884 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081253: ArAuthFrameworkImpl::doPostAuth::1:10081253:: Authentication mechanism returned [1] for AuthIdentity [01214225] Tue May 19 22:29:48.884 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 10081253: Sending Continue with challenge Tue May 19 22:29:48.884 2009 Morocco Standard Time INFO: pid 2172 tid 688: 61: 10081253: Packet being sent Tue May 19 22:29:48.884 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Packet Sent (MsgType:110, Size: 1564 Bytes). Tue May 19 22:29:48.993 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Packet Received (MsgType: 0, Size: 106 Bytes). Tue May 19 22:29:48.993 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:29:48.993 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 0: 10081254: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:29:48.993 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 10081254: Entering [MechQnA::handleAuthRequest] Tue May 19 22:29:48.993 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 10081254: Exiting [MechQnA::handleAuthRequest] Tue May 19 22:29:48.993 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081254: Using session identifier [1:10081254] Tue May 19 22:29:48.993 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 160: 10081254: Entering QnAModule::openSession Tue May 19 22:29:48.993 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 160: 10081254: Exiting QnAModule::openSession Tue May 19 22:29:48.993 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081254: ArAuthFrameworkImpl::doPreAuth::1:10081254:: Authentication mechanism returned [0] for AuthIdentity [01214225] Tue May 19 22:29:48.993 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 160: 10081254: Entering QnAModule::authenticate Tue May 19 22:29:48.993 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 160: 10081254: QnA Session Id :[1:10081254] Tue May 19 22:29:48.993 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 160: 10081254: QNA Step - ASK AUTH QUESTIONS Tue May 19 22:29:48.993 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 160: 10081254: User DB Query Details: Tue May 19 22:29:48.993 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 160: 10081254: userName :[01214225] Tue May 19 22:29:48.993 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 160: 10081254: Group ID :1020 Tue May 19 22:29:48.993 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 160: 10081254: User ID :-1 Tue May 19 22:29:49.009 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 160: 10081254: Number of rows fetched from DB : 1 Tue May 19 22:29:49.009 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 160: 10081254: Entering QnAUserData::dump Tue May 19 22:29:49.009 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 160: 10081254: Exiting QnAUserData::dump Tue May 19 22:29:49.009 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 160: 10081254: Set of questions(bitmap) selected : 10 Tue May 19 22:29:49.009 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 160: 10081254: Session tracker Id associated with QnA challenge(auth round questions) : [1:10081254] Tue May 19 22:29:49.009 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 160: 10081254: Exiting QnAModule::authenticate Tue May 19 22:29:49.009 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081254: ArAuthFrameworkImpl::doAuth::1:10081254:: Authentication mechanism returned [1] for AuthIdentity [01214225] Tue May 19 22:29:49.009 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 160: 10081254: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [2] Tue May 19 22:29:49.009 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081254: ArAuthFrameworkImpl::doPostAuth::1:10081254:: Authentication mechanism returned [1] for AuthIdentity [01214225] Tue May 19 22:29:49.009 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 160: 10081254: Entering QnAModule::closeSession Tue May 19 22:29:49.009 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 160: 10081254: Exiting QnAModule::closeSession Tue May 19 22:29:49.024 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 10081254: Entering [MechQnA::handleAuthResMoreSteps] Tue May 19 22:29:49.024 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 10081254: Exiting [MechQnA::handleAuthResMoreSteps] Tue May 19 22:29:49.024 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 10081254: Sending Continue with challenge Tue May 19 22:29:49.024 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 61: 10081254: Packet being sent Tue May 19 22:29:49.024 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Packet Sent (MsgType: 0, Size: 340 Bytes). Tue May 19 22:29:49.196 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Packet Received (MsgType: 0, Size: 106 Bytes). Tue May 19 22:29:49.196 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:29:49.196 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 0: 10081255: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:29:49.196 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 10081255: Entering [MechQnA::handleAuthRequest] Tue May 19 22:29:49.196 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 10081255: Exiting [MechQnA::handleAuthRequest] Tue May 19 22:29:49.196 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081255: Using session identifier [1:10081255] Tue May 19 22:29:49.196 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081255: Entering QnAModule::openSession Tue May 19 22:29:49.196 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081255: Exiting QnAModule::openSession Tue May 19 22:29:49.196 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081255: ArAuthFrameworkImpl::doPreAuth::1:10081255:: Authentication mechanism returned [0] for AuthIdentity [01214225] Tue May 19 22:29:49.196 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081255: Entering QnAModule::authenticate Tue May 19 22:29:49.196 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081255: QnA Session Id :[1:10081255] Tue May 19 22:29:49.196 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081255: QNA Step - ASK AUTH QUESTIONS Tue May 19 22:29:49.196 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081255: User DB Query Details: Tue May 19 22:29:49.196 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081255: userName :[01214225] Tue May 19 22:29:49.196 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081255: Group ID :1020 Tue May 19 22:29:49.196 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081255: User ID :-1 Tue May 19 22:29:49.212 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081255: Number of rows fetched from DB : 1 Tue May 19 22:29:49.212 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081255: Entering QnAUserData::dump Tue May 19 22:29:49.212 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081255: Exiting QnAUserData::dump Tue May 19 22:29:49.212 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081255: Set of questions(bitmap) selected : 12 Tue May 19 22:29:49.212 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081255: Session tracker Id associated with QnA challenge(auth round questions) : [1:10081255] Tue May 19 22:29:49.212 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081255: Exiting QnAModule::authenticate Tue May 19 22:29:49.212 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081255: ArAuthFrameworkImpl::doAuth::1:10081255:: Authentication mechanism returned [1] for AuthIdentity [01214225] Tue May 19 22:29:49.212 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081255: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [2] Tue May 19 22:29:49.212 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081255: ArAuthFrameworkImpl::doPostAuth::1:10081255:: Authentication mechanism returned [1] for AuthIdentity [01214225] Tue May 19 22:29:49.212 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081255: Entering QnAModule::closeSession Tue May 19 22:29:49.212 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081255: Exiting QnAModule::closeSession Tue May 19 22:29:49.227 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 10081255: Entering [MechQnA::handleAuthResMoreSteps] Tue May 19 22:29:49.227 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 10081255: Exiting [MechQnA::handleAuthResMoreSteps] Tue May 19 22:29:49.227 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 10081255: Sending Continue with challenge Tue May 19 22:29:49.227 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 61: 10081255: Packet being sent Tue May 19 22:29:49.227 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Packet Sent (MsgType: 0, Size: 348 Bytes). Tue May 19 22:29:49.306 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Packet Received (MsgType:110, Size: 100 Bytes). Tue May 19 22:29:49.306 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:29:49.306 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 0: 10081256: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:29:49.306 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081256: Using session identifier [1:10081256] Tue May 19 22:29:49.306 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081256: ArAuthFrameworkImpl::doPreAuth::1:10081256:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:29:49.306 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081256: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:29:49.306 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081256: Session tracker Id associated with generate challenge[1:10081256] Tue May 19 22:29:49.306 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081256: ArAuthFrameworkImpl::doAuth::1:10081256:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:29:49.306 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081256: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:29:49.306 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081256: ArAuthFrameworkImpl::doPostAuth::1:10081256:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:29:49.321 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 10081256: Sending Continue with challenge Tue May 19 22:29:49.321 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 61: 10081256: Packet being sent Tue May 19 22:29:49.321 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Packet Sent (MsgType:110, Size: 176 Bytes). Tue May 19 22:29:50.384 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Packet Received (MsgType:110, Size: 154 Bytes). Tue May 19 22:29:50.384 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:29:50.384 2009 Morocco Standard Time INFO: pid 2172 tid 688: 0: 10081257: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:29:50.384 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081257: Using session identifier [1:10081257] Tue May 19 22:29:50.384 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081257: ArAuthFrameworkImpl::doPreAuth::1:10081257:: Authentication mechanism returned [0] for AuthIdentity [01720624;ARCARD] Tue May 19 22:29:50.384 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081257: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:29:50.384 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081257: ArAuthFrameworkImpl::doAuth::1:10081257:: Authentication mechanism returned [1] for AuthIdentity [01720624;ARCARD] Tue May 19 22:29:50.384 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081257: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:29:50.384 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081257: ArAuthFrameworkImpl::doPostAuth::1:10081257:: Authentication mechanism returned [1] for AuthIdentity [01720624] Tue May 19 22:29:50.399 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 10081257: Sending Continue with challenge Tue May 19 22:29:50.399 2009 Morocco Standard Time INFO: pid 2172 tid 688: 61: 10081257: Packet being sent Tue May 19 22:29:50.399 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Packet Sent (MsgType:110, Size: 1564 Bytes). Tue May 19 22:29:50.399 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Packet Received (MsgType:109, Size: 1430 Bytes). Tue May 19 22:29:50.399 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:29:50.399 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 0: 10081258: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:29:50.399 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081258: Using session identifier [1:10081258] Tue May 19 22:29:50.399 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081258: ArAuthFrameworkImpl::doPreAuth::1:10081258:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:29:50.399 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081258: Arcot Native Server: recvd AA_BIN_MSG_VER_CHG Tue May 19 22:29:50.399 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081258: Cert Subject String....:[CN=01720624;O=MLS; UserID=01720624; CardName=ARCARD] Tue May 19 22:29:50.399 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081258: Cert issuer............:[CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US] Tue May 19 22:29:50.399 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081258: Cert serial String.....:[a96f] Tue May 19 22:29:50.399 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081258: ArcotId Certificate received with signature have ArcotExtension. Cert issuer=CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US, serial=a96f and subject=CN=01720624;O=MLS Tue May 19 22:29:50.415 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081258: ArcotID Auth SUCCESS (serial Number [a96f]) Tue May 19 22:29:50.415 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081258: Session tracker Id associated with verify signed challenge[1:10081256] Tue May 19 22:29:50.415 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081258: ArAuthFrameworkImpl::doAuth::1:10081256:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:29:50.415 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081258: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:29:50.415 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081258: Handle_NSPAdvice::NSP Action :[NSP_RESET] Tue May 19 22:29:50.415 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081258: NSP Update Query is based on Serial Number Tue May 19 22:29:50.415 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081258: ArAuthFrameworkImpl::doPostAuth::1:10081256:: Authentication mechanism returned [0] for AuthIdentity [01720624] Tue May 19 22:29:50.431 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 10081258: Prepared to Send OK Tue May 19 22:29:50.431 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 61: 10081258: Packet being sent Tue May 19 22:29:50.431 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Packet Sent (MsgType:109, Size: 256 Bytes). Tue May 19 22:29:52.806 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Packet Received (MsgType:110, Size: 100 Bytes). Tue May 19 22:29:52.806 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:29:52.806 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 0: 10081259: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:29:52.806 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081259: Using session identifier [1:10081259] Tue May 19 22:29:52.806 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081259: ArAuthFrameworkImpl::doPreAuth::1:10081259:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:29:52.806 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081259: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:29:52.806 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081259: Session tracker Id associated with generate challenge[1:10081259] Tue May 19 22:29:52.806 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081259: ArAuthFrameworkImpl::doAuth::1:10081259:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:29:52.806 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081259: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:29:52.806 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081259: ArAuthFrameworkImpl::doPostAuth::1:10081259:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:29:52.821 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 10081259: Sending Continue with challenge Tue May 19 22:29:52.821 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 61: 10081259: Packet being sent Tue May 19 22:29:52.821 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Packet Sent (MsgType:110, Size: 176 Bytes). Tue May 19 22:29:53.509 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Packet Received (MsgType:110, Size: 154 Bytes). Tue May 19 22:29:53.509 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:29:53.509 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 0: 10081260: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:29:53.509 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081260: Using session identifier [1:10081260] Tue May 19 22:29:53.509 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081260: ArAuthFrameworkImpl::doPreAuth::1:10081260:: Authentication mechanism returned [0] for AuthIdentity [01118110;ARCARD] Tue May 19 22:29:53.509 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081260: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:29:53.509 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081260: ArAuthFrameworkImpl::doAuth::1:10081260:: Authentication mechanism returned [1] for AuthIdentity [01118110;ARCARD] Tue May 19 22:29:53.509 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081260: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:29:53.509 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081260: ArAuthFrameworkImpl::doPostAuth::1:10081260:: Authentication mechanism returned [1] for AuthIdentity [01118110] Tue May 19 22:29:53.524 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 10081260: Sending Continue with challenge Tue May 19 22:29:53.524 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 61: 10081260: Packet being sent Tue May 19 22:29:53.524 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Packet Sent (MsgType:110, Size: 1564 Bytes). Tue May 19 22:29:53.524 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Packet Received (MsgType:109, Size: 1430 Bytes). Tue May 19 22:29:53.524 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:29:53.524 2009 Morocco Standard Time INFO: pid 2172 tid 688: 0: 10081261: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:29:53.524 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081261: Using session identifier [1:10081261] Tue May 19 22:29:53.524 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081261: ArAuthFrameworkImpl::doPreAuth::1:10081261:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:29:53.524 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081261: Arcot Native Server: recvd AA_BIN_MSG_VER_CHG Tue May 19 22:29:53.524 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081261: Cert Subject String....:[CN=01118110;O=MLS; UserID=01118110; CardName=ARCARD] Tue May 19 22:29:53.524 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081261: Cert issuer............:[CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US] Tue May 19 22:29:53.524 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081261: Cert serial String.....:[a39c] Tue May 19 22:29:53.524 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081261: ArcotId Certificate received with signature have ArcotExtension. Cert issuer=CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US, serial=a39c and subject=CN=01118110;O=MLS Tue May 19 22:29:53.524 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081261: ArcotID Auth SUCCESS (serial Number [a39c]) Tue May 19 22:29:53.524 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081261: Session tracker Id associated with verify signed challenge[1:10081259] Tue May 19 22:29:53.524 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081261: ArAuthFrameworkImpl::doAuth::1:10081259:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:29:53.524 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081261: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:29:53.524 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081261: Handle_NSPAdvice::NSP Action :[NSP_RESET] Tue May 19 22:29:53.524 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081261: NSP Update Query is based on Serial Number Tue May 19 22:29:53.540 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081261: ArAuthFrameworkImpl::doPostAuth::1:10081259:: Authentication mechanism returned [0] for AuthIdentity [01118110] Tue May 19 22:29:53.556 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 10081261: Prepared to Send OK Tue May 19 22:29:53.556 2009 Morocco Standard Time INFO: pid 2172 tid 688: 61: 10081261: Packet being sent Tue May 19 22:29:53.556 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Packet Sent (MsgType:109, Size: 256 Bytes). Tue May 19 22:29:55.056 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Packet Received (MsgType:110, Size: 100 Bytes). Tue May 19 22:29:55.056 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:29:55.056 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 0: 10081262: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:29:55.056 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081262: Using session identifier [1:10081262] Tue May 19 22:29:55.056 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081262: ArAuthFrameworkImpl::doPreAuth::1:10081262:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:29:55.056 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081262: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:29:55.056 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081262: Session tracker Id associated with generate challenge[1:10081262] Tue May 19 22:29:55.056 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081262: ArAuthFrameworkImpl::doAuth::1:10081262:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:29:55.056 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081262: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:29:55.056 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081262: ArAuthFrameworkImpl::doPostAuth::1:10081262:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:29:55.071 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 10081262: Sending Continue with challenge Tue May 19 22:29:55.071 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 61: 10081262: Packet being sent Tue May 19 22:29:55.071 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Packet Sent (MsgType:110, Size: 176 Bytes). Tue May 19 22:29:55.743 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Packet Received (MsgType:110, Size: 154 Bytes). Tue May 19 22:29:55.743 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:29:55.743 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 0: 10081263: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:29:55.743 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081263: Using session identifier [1:10081263] Tue May 19 22:29:55.743 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081263: ArAuthFrameworkImpl::doPreAuth::1:10081263:: Authentication mechanism returned [0] for AuthIdentity [01789302;ARCARD] Tue May 19 22:29:55.743 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081263: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:29:55.743 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081263: ArAuthFrameworkImpl::doAuth::1:10081263:: Authentication mechanism returned [1] for AuthIdentity [01789302;ARCARD] Tue May 19 22:29:55.743 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081263: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:29:55.743 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081263: ArAuthFrameworkImpl::doPostAuth::1:10081263:: Authentication mechanism returned [1] for AuthIdentity [01789302] Tue May 19 22:29:55.759 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 10081263: Sending Continue with challenge Tue May 19 22:29:55.759 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 61: 10081263: Packet being sent Tue May 19 22:29:55.759 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Packet Sent (MsgType:110, Size: 1564 Bytes). Tue May 19 22:29:55.759 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Packet Received (MsgType:109, Size: 1430 Bytes). Tue May 19 22:29:55.759 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:29:55.759 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 0: 10081264: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:29:55.759 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081264: Using session identifier [1:10081264] Tue May 19 22:29:55.759 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081264: ArAuthFrameworkImpl::doPreAuth::1:10081264:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:29:55.759 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081264: Arcot Native Server: recvd AA_BIN_MSG_VER_CHG Tue May 19 22:29:55.759 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081264: Cert Subject String....:[CN=01789302;O=MLS; UserID=01789302; CardName=ARCARD] Tue May 19 22:29:55.759 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081264: Cert issuer............:[CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US] Tue May 19 22:29:55.759 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081264: Cert serial String.....:[b9ab] Tue May 19 22:29:55.759 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081264: ArcotId Certificate received with signature have ArcotExtension. Cert issuer=CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US, serial=b9ab and subject=CN=01789302;O=MLS Tue May 19 22:29:55.759 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081264: Auth fail due to signature verification.Serial Number [b9ab] Tue May 19 22:29:55.759 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081264: Session tracker Id associated with verify signed challenge[1:10081262] Tue May 19 22:29:55.759 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081264: ArAuthFrameworkImpl::doAuth::1:10081262:: Authentication mechanism returned [3] for AuthIdentity [] Tue May 19 22:29:55.759 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081264: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:29:55.759 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081264: Handle_NSPAdvice::NSP Action :[NSP_INC] Tue May 19 22:29:55.759 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081264: Using Oracle Query Tue May 19 22:29:55.759 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081264: NSP Update Query is based on Serial Number Tue May 19 22:29:55.774 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081264: ArAuthFrameworkImpl::doPostAuth::1:10081262:: Authentication mechanism returned [3] for AuthIdentity [01789302] Tue May 19 22:29:55.790 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 10081264: Sending Invalid credential Tue May 19 22:29:55.790 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 61: 10081264: Packet being sent Tue May 19 22:29:55.790 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Packet Sent (MsgType:109, Size: 182 Bytes). Tue May 19 22:29:57.712 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Packet Received (MsgType:110, Size: 100 Bytes). Tue May 19 22:29:57.712 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:29:57.712 2009 Morocco Standard Time INFO: pid 2172 tid 688: 0: 10081265: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:29:57.712 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081265: Using session identifier [1:10081265] Tue May 19 22:29:57.712 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081265: ArAuthFrameworkImpl::doPreAuth::1:10081265:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:29:57.712 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081265: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:29:57.712 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081265: Session tracker Id associated with generate challenge[1:10081265] Tue May 19 22:29:57.712 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081265: ArAuthFrameworkImpl::doAuth::1:10081265:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:29:57.712 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081265: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:29:57.712 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081265: ArAuthFrameworkImpl::doPostAuth::1:10081265:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:29:57.727 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 10081265: Sending Continue with challenge Tue May 19 22:29:57.727 2009 Morocco Standard Time INFO: pid 2172 tid 688: 61: 10081265: Packet being sent Tue May 19 22:29:57.727 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Packet Sent (MsgType:110, Size: 176 Bytes). Tue May 19 22:29:58.931 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Packet Received (MsgType:110, Size: 154 Bytes). Tue May 19 22:29:58.931 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:29:58.931 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 0: 10081266: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:29:58.931 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081266: Using session identifier [1:10081266] Tue May 19 22:29:58.931 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081266: ArAuthFrameworkImpl::doPreAuth::1:10081266:: Authentication mechanism returned [0] for AuthIdentity [01118438;ARCARD] Tue May 19 22:29:58.931 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081266: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:29:58.931 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081266: ArAuthFrameworkImpl::doAuth::1:10081266:: Authentication mechanism returned [1] for AuthIdentity [01118438;ARCARD] Tue May 19 22:29:58.931 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081266: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:29:58.931 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081266: ArAuthFrameworkImpl::doPostAuth::1:10081266:: Authentication mechanism returned [1] for AuthIdentity [01118438] Tue May 19 22:29:58.946 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 10081266: Sending Continue with challenge Tue May 19 22:29:58.946 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 61: 10081266: Packet being sent Tue May 19 22:29:58.946 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Packet Sent (MsgType:110, Size: 1564 Bytes). Tue May 19 22:29:58.946 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Packet Received (MsgType:109, Size: 1430 Bytes). Tue May 19 22:29:58.946 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:29:58.946 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 0: 10081267: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:29:58.946 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081267: Using session identifier [1:10081267] Tue May 19 22:29:58.946 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081267: ArAuthFrameworkImpl::doPreAuth::1:10081267:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:29:58.946 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081267: Arcot Native Server: recvd AA_BIN_MSG_VER_CHG Tue May 19 22:29:58.946 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081267: Cert Subject String....:[CN=01118438;O=MLS; UserID=01118438; CardName=ARCARD] Tue May 19 22:29:58.946 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081267: Cert issuer............:[CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US] Tue May 19 22:29:58.946 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081267: Cert serial String.....:[0103f6] Tue May 19 22:29:58.946 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081267: ArcotId Certificate received with signature have ArcotExtension. Cert issuer=CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US, serial=0103f6 and subject=CN=01118438;O=MLS Tue May 19 22:29:58.946 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081267: ArcotID Credential Not found. Serial number[103f6].Considering the cert is reissued. Tue May 19 22:29:58.946 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081267: Auth failed due to Account Verification(serial Number [103f6]) Tue May 19 22:29:58.946 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081267: Session tracker Id associated with verify signed challenge[1:10081265] Tue May 19 22:29:58.946 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081267: ArAuthFrameworkImpl::doAuth::1:10081265:: Authentication mechanism returned [10] for AuthIdentity [] Tue May 19 22:29:58.946 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081267: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:29:58.946 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081267: ArAuthFrameworkImpl::doPostAuth::1:10081265:: Authentication mechanism returned [10] for AuthIdentity [] Tue May 19 22:29:58.962 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 61: 10081267: Packet being sent Tue May 19 22:29:58.962 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Packet Sent (MsgType:109, Size: 148 Bytes). Tue May 19 22:30:01.274 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Packet Received (MsgType:110, Size: 100 Bytes). Tue May 19 22:30:01.274 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:01.274 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 0: 10081268: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:01.274 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081268: Using session identifier [1:10081268] Tue May 19 22:30:01.274 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081268: ArAuthFrameworkImpl::doPreAuth::1:10081268:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:30:01.274 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081268: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:30:01.274 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081268: Session tracker Id associated with generate challenge[1:10081268] Tue May 19 22:30:01.274 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081268: ArAuthFrameworkImpl::doAuth::1:10081268:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:30:01.274 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081268: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:30:01.274 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081268: ArAuthFrameworkImpl::doPostAuth::1:10081268:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:30:01.290 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 10081268: Sending Continue with challenge Tue May 19 22:30:01.290 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 61: 10081268: Packet being sent Tue May 19 22:30:01.290 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Packet Sent (MsgType:110, Size: 176 Bytes). Tue May 19 22:30:02.306 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Packet Received (MsgType:110, Size: 154 Bytes). Tue May 19 22:30:02.306 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:02.306 2009 Morocco Standard Time INFO: pid 2172 tid 688: 0: 10081269: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:02.306 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081269: Using session identifier [1:10081269] Tue May 19 22:30:02.306 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081269: ArAuthFrameworkImpl::doPreAuth::1:10081269:: Authentication mechanism returned [0] for AuthIdentity [00859961;ARCARD] Tue May 19 22:30:02.306 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081269: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:30:02.306 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081269: ArAuthFrameworkImpl::doAuth::1:10081269:: Authentication mechanism returned [1] for AuthIdentity [00859961;ARCARD] Tue May 19 22:30:02.306 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081269: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:30:02.306 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081269: ArAuthFrameworkImpl::doPostAuth::1:10081269:: Authentication mechanism returned [1] for AuthIdentity [00859961] Tue May 19 22:30:02.321 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 10081269: Sending Continue with challenge Tue May 19 22:30:02.321 2009 Morocco Standard Time INFO: pid 2172 tid 688: 61: 10081269: Packet being sent Tue May 19 22:30:02.321 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Packet Sent (MsgType:110, Size: 1564 Bytes). Tue May 19 22:30:02.321 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Packet Received (MsgType:109, Size: 1430 Bytes). Tue May 19 22:30:02.321 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:02.321 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 0: 10081270: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:02.321 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081270: Using session identifier [1:10081270] Tue May 19 22:30:02.321 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081270: ArAuthFrameworkImpl::doPreAuth::1:10081270:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:30:02.321 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081270: Arcot Native Server: recvd AA_BIN_MSG_VER_CHG Tue May 19 22:30:02.321 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081270: Cert Subject String....:[CN=00859961;O=MLS; UserID=00859961; CardName=ARCARD] Tue May 19 22:30:02.321 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081270: Cert issuer............:[CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US] Tue May 19 22:30:02.321 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081270: Cert serial String.....:[011443] Tue May 19 22:30:02.321 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081270: ArcotId Certificate received with signature have ArcotExtension. Cert issuer=CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US, serial=011443 and subject=CN=00859961;O=MLS Tue May 19 22:30:02.337 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081270: Auth fail due to signature verification.Serial Number [11443] Tue May 19 22:30:02.337 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081270: Session tracker Id associated with verify signed challenge[1:10081268] Tue May 19 22:30:02.337 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081270: ArAuthFrameworkImpl::doAuth::1:10081268:: Authentication mechanism returned [3] for AuthIdentity [] Tue May 19 22:30:02.337 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081270: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:30:02.337 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081270: Handle_NSPAdvice::NSP Action :[NSP_INC] Tue May 19 22:30:02.337 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081270: Using Oracle Query Tue May 19 22:30:02.337 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081270: NSP Update Query is based on Serial Number Tue May 19 22:30:02.337 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Packet Received (MsgType:110, Size: 100 Bytes). Tue May 19 22:30:02.337 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:02.337 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 0: 10081271: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:02.337 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081271: Using session identifier [1:10081271] Tue May 19 22:30:02.337 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081271: ArAuthFrameworkImpl::doPreAuth::1:10081271:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:30:02.337 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081271: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:30:02.337 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081271: Session tracker Id associated with generate challenge[1:10081271] Tue May 19 22:30:02.337 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081271: ArAuthFrameworkImpl::doAuth::1:10081271:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:30:02.337 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081271: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:30:02.337 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081271: ArAuthFrameworkImpl::doPostAuth::1:10081271:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:30:02.337 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081270: ArAuthFrameworkImpl::doPostAuth::1:10081268:: Authentication mechanism returned [3] for AuthIdentity [00859961] Tue May 19 22:30:02.352 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 10081271: Sending Continue with challenge Tue May 19 22:30:02.352 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 61: 10081271: Packet being sent Tue May 19 22:30:02.352 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Packet Sent (MsgType:110, Size: 176 Bytes). Tue May 19 22:30:02.352 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 10081270: Sending Invalid credential Tue May 19 22:30:02.352 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 61: 10081270: Packet being sent Tue May 19 22:30:02.352 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Packet Sent (MsgType:109, Size: 182 Bytes). Tue May 19 22:30:03.071 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Packet Received (MsgType:110, Size: 154 Bytes). Tue May 19 22:30:03.071 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:03.071 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 0: 10081272: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:03.071 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081272: Using session identifier [1:10081272] Tue May 19 22:30:03.071 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081272: ArAuthFrameworkImpl::doPreAuth::1:10081272:: Authentication mechanism returned [0] for AuthIdentity [01789302;ARCARD] Tue May 19 22:30:03.071 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081272: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:30:03.071 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081272: ArAuthFrameworkImpl::doAuth::1:10081272:: Authentication mechanism returned [1] for AuthIdentity [01789302;ARCARD] Tue May 19 22:30:03.071 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081272: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:30:03.071 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081272: ArAuthFrameworkImpl::doPostAuth::1:10081272:: Authentication mechanism returned [1] for AuthIdentity [01789302] Tue May 19 22:30:03.087 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 10081272: Sending Continue with challenge Tue May 19 22:30:03.087 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 61: 10081272: Packet being sent Tue May 19 22:30:03.087 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Packet Sent (MsgType:110, Size: 1564 Bytes). Tue May 19 22:30:03.087 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Packet Received (MsgType:109, Size: 1430 Bytes). Tue May 19 22:30:03.087 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:03.087 2009 Morocco Standard Time INFO: pid 2172 tid 688: 0: 10081273: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:03.087 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081273: Using session identifier [1:10081273] Tue May 19 22:30:03.087 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081273: ArAuthFrameworkImpl::doPreAuth::1:10081273:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:30:03.087 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081273: Arcot Native Server: recvd AA_BIN_MSG_VER_CHG Tue May 19 22:30:03.087 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081273: Cert Subject String....:[CN=01789302;O=MLS; UserID=01789302; CardName=ARCARD] Tue May 19 22:30:03.087 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081273: Cert issuer............:[CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US] Tue May 19 22:30:03.087 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081273: Cert serial String.....:[b9ab] Tue May 19 22:30:03.087 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081273: ArcotId Certificate received with signature have ArcotExtension. Cert issuer=CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US, serial=b9ab and subject=CN=01789302;O=MLS Tue May 19 22:30:03.087 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081273: Auth fail due to signature verification.Serial Number [b9ab] Tue May 19 22:30:03.087 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081273: Session tracker Id associated with verify signed challenge[1:10081271] Tue May 19 22:30:03.087 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081273: ArAuthFrameworkImpl::doAuth::1:10081271:: Authentication mechanism returned [3] for AuthIdentity [] Tue May 19 22:30:03.087 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081273: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:30:03.087 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081273: Handle_NSPAdvice::NSP Action :[NSP_INC] Tue May 19 22:30:03.087 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081273: Using Oracle Query Tue May 19 22:30:03.102 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081273: NSP Update Query is based on Serial Number Tue May 19 22:30:03.102 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081273: ArAuthFrameworkImpl::doPostAuth::1:10081271:: Authentication mechanism returned [3] for AuthIdentity [01789302] Tue May 19 22:30:03.118 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 10081273: Sending Invalid credential Tue May 19 22:30:03.118 2009 Morocco Standard Time INFO: pid 2172 tid 688: 61: 10081273: Packet being sent Tue May 19 22:30:03.118 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Packet Sent (MsgType:109, Size: 182 Bytes). Tue May 19 22:30:03.931 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Packet Received (MsgType:110, Size: 100 Bytes). Tue May 19 22:30:03.931 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:03.931 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 0: 10081274: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:03.931 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081274: Using session identifier [1:10081274] Tue May 19 22:30:03.931 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081274: ArAuthFrameworkImpl::doPreAuth::1:10081274:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:30:03.931 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081274: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:30:03.931 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081274: Session tracker Id associated with generate challenge[1:10081274] Tue May 19 22:30:03.931 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081274: ArAuthFrameworkImpl::doAuth::1:10081274:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:30:03.931 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081274: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:30:03.931 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081274: ArAuthFrameworkImpl::doPostAuth::1:10081274:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:30:03.946 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 10081274: Sending Continue with challenge Tue May 19 22:30:03.946 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 61: 10081274: Packet being sent Tue May 19 22:30:03.946 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Packet Sent (MsgType:110, Size: 176 Bytes). Tue May 19 22:30:04.712 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Packet Received (MsgType:110, Size: 154 Bytes). Tue May 19 22:30:04.712 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:04.712 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 0: 10081275: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:04.712 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081275: Using session identifier [1:10081275] Tue May 19 22:30:04.712 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081275: ArAuthFrameworkImpl::doPreAuth::1:10081275:: Authentication mechanism returned [0] for AuthIdentity [00888531;ARCARD] Tue May 19 22:30:04.712 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081275: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:30:04.712 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081275: ArAuthFrameworkImpl::doAuth::1:10081275:: Authentication mechanism returned [1] for AuthIdentity [00888531;ARCARD] Tue May 19 22:30:04.712 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081275: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:30:04.712 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081275: ArAuthFrameworkImpl::doPostAuth::1:10081275:: Authentication mechanism returned [1] for AuthIdentity [00888531] Tue May 19 22:30:04.727 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 10081275: Sending Continue with challenge Tue May 19 22:30:04.727 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 61: 10081275: Packet being sent Tue May 19 22:30:04.727 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Packet Sent (MsgType:110, Size: 1564 Bytes). Tue May 19 22:30:04.727 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Packet Received (MsgType:109, Size: 1430 Bytes). Tue May 19 22:30:04.727 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:04.727 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 0: 10081276: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:04.727 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081276: Using session identifier [1:10081276] Tue May 19 22:30:04.727 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081276: ArAuthFrameworkImpl::doPreAuth::1:10081276:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:30:04.727 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081276: Arcot Native Server: recvd AA_BIN_MSG_VER_CHG Tue May 19 22:30:04.727 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081276: Cert Subject String....:[CN=00888531;O=MLS; UserID=00888531; CardName=ARCARD] Tue May 19 22:30:04.727 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081276: Cert issuer............:[CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US] Tue May 19 22:30:04.727 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081276: Cert serial String.....:[c214] Tue May 19 22:30:04.727 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081276: ArcotId Certificate received with signature have ArcotExtension. Cert issuer=CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US, serial=c214 and subject=CN=00888531;O=MLS Tue May 19 22:30:04.727 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081276: ArcotID Auth SUCCESS (serial Number [c214]) Tue May 19 22:30:04.727 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081276: Session tracker Id associated with verify signed challenge[1:10081274] Tue May 19 22:30:04.727 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081276: ArAuthFrameworkImpl::doAuth::1:10081274:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:30:04.727 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081276: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:30:04.727 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081276: Handle_NSPAdvice::NSP Action :[NSP_RESET] Tue May 19 22:30:04.743 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081276: NSP Update Query is based on Serial Number Tue May 19 22:30:04.743 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081276: ArAuthFrameworkImpl::doPostAuth::1:10081274:: Authentication mechanism returned [0] for AuthIdentity [00888531] Tue May 19 22:30:04.759 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 10081276: Prepared to Send OK Tue May 19 22:30:04.759 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 61: 10081276: Packet being sent Tue May 19 22:30:04.759 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Packet Sent (MsgType:109, Size: 256 Bytes). Tue May 19 22:30:06.384 2009 Morocco Standard Time INFO: pid 2172 tid 2768: 2: 0: A request came for SERVER_CB_ACCEPT from ip:172.16.1.10, transport:Socket Tue May 19 22:30:06.384 2009 Morocco Standard Time INFO: pid 2172 tid 3576: 60: 0: ==> Handling a request Tue May 19 22:30:06.384 2009 Morocco Standard Time INFO: pid 2172 tid 3576: 2: 0: A request came for SERVER_CB_CLOSE from ip:172.16.1.10, transport:Socket Tue May 19 22:30:06.665 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Packet Received (MsgType:110, Size: 100 Bytes). Tue May 19 22:30:06.665 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:06.665 2009 Morocco Standard Time INFO: pid 2172 tid 688: 0: 10081277: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:06.665 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081277: Using session identifier [1:10081277] Tue May 19 22:30:06.665 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081277: ArAuthFrameworkImpl::doPreAuth::1:10081277:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:30:06.665 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081277: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:30:06.665 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081277: Session tracker Id associated with generate challenge[1:10081277] Tue May 19 22:30:06.665 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081277: ArAuthFrameworkImpl::doAuth::1:10081277:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:30:06.665 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081277: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:30:06.665 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081277: ArAuthFrameworkImpl::doPostAuth::1:10081277:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:30:06.681 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 10081277: Sending Continue with challenge Tue May 19 22:30:06.681 2009 Morocco Standard Time INFO: pid 2172 tid 688: 61: 10081277: Packet being sent Tue May 19 22:30:06.681 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Packet Sent (MsgType:110, Size: 176 Bytes). Tue May 19 22:30:07.415 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Packet Received (MsgType:110, Size: 100 Bytes). Tue May 19 22:30:07.415 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:07.415 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 0: 10081278: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:07.415 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081278: Using session identifier [1:10081278] Tue May 19 22:30:07.415 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081278: ArAuthFrameworkImpl::doPreAuth::1:10081278:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:30:07.415 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081278: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:30:07.415 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081278: Session tracker Id associated with generate challenge[1:10081278] Tue May 19 22:30:07.415 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081278: ArAuthFrameworkImpl::doAuth::1:10081278:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:30:07.415 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081278: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:30:07.415 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081278: ArAuthFrameworkImpl::doPostAuth::1:10081278:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:30:07.431 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 10081278: Sending Continue with challenge Tue May 19 22:30:07.431 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 61: 10081278: Packet being sent Tue May 19 22:30:07.431 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Packet Sent (MsgType:110, Size: 176 Bytes). Tue May 19 22:30:07.446 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Packet Received (MsgType:110, Size: 154 Bytes). Tue May 19 22:30:07.446 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:07.446 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 0: 10081279: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:07.446 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081279: Using session identifier [1:10081279] Tue May 19 22:30:07.446 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081279: ArAuthFrameworkImpl::doPreAuth::1:10081279:: Authentication mechanism returned [0] for AuthIdentity [35000376;ARCARD] Tue May 19 22:30:07.446 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081279: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:30:07.446 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081279: ArAuthFrameworkImpl::doAuth::1:10081279:: Authentication mechanism returned [1] for AuthIdentity [35000376;ARCARD] Tue May 19 22:30:07.446 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081279: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:30:07.446 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081279: ArAuthFrameworkImpl::doPostAuth::1:10081279:: Authentication mechanism returned [1] for AuthIdentity [35000376] Tue May 19 22:30:07.462 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 10081279: Sending Continue with challenge Tue May 19 22:30:07.462 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 61: 10081279: Packet being sent Tue May 19 22:30:07.462 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Packet Sent (MsgType:110, Size: 1564 Bytes). Tue May 19 22:30:07.462 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Packet Received (MsgType:109, Size: 1430 Bytes). Tue May 19 22:30:07.462 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:07.462 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 0: 10081280: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:07.462 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081280: Using session identifier [1:10081280] Tue May 19 22:30:07.462 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081280: ArAuthFrameworkImpl::doPreAuth::1:10081280:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:30:07.462 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081280: Arcot Native Server: recvd AA_BIN_MSG_VER_CHG Tue May 19 22:30:07.462 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081280: Cert Subject String....:[CN=35000376;O=MLS; UserID=35000376; CardName=ARCARD] Tue May 19 22:30:07.462 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081280: Cert issuer............:[CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US] Tue May 19 22:30:07.462 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081280: Cert serial String.....:[b455] Tue May 19 22:30:07.462 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081280: ArcotId Certificate received with signature have ArcotExtension. Cert issuer=CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US, serial=b455 and subject=CN=35000376;O=MLS Tue May 19 22:30:07.477 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081280: ArcotID Auth SUCCESS (serial Number [b455]) Tue May 19 22:30:07.477 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081280: Session tracker Id associated with verify signed challenge[1:10081277] Tue May 19 22:30:07.477 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081280: ArAuthFrameworkImpl::doAuth::1:10081277:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:30:07.477 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081280: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:30:07.477 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081280: Handle_NSPAdvice::NSP Action :[NSP_RESET] Tue May 19 22:30:07.477 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081280: NSP Update Query is based on Serial Number Tue May 19 22:30:07.477 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081280: ArAuthFrameworkImpl::doPostAuth::1:10081277:: Authentication mechanism returned [0] for AuthIdentity [35000376] Tue May 19 22:30:07.493 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 10081280: Prepared to Send OK Tue May 19 22:30:07.493 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 61: 10081280: Packet being sent Tue May 19 22:30:07.493 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Packet Sent (MsgType:109, Size: 256 Bytes). Tue May 19 22:30:08.118 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Packet Received (MsgType:110, Size: 100 Bytes). Tue May 19 22:30:08.118 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:08.118 2009 Morocco Standard Time INFO: pid 2172 tid 688: 0: 10081281: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:08.118 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081281: Using session identifier [1:10081281] Tue May 19 22:30:08.118 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081281: ArAuthFrameworkImpl::doPreAuth::1:10081281:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:30:08.118 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081281: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:30:08.118 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081281: Session tracker Id associated with generate challenge[1:10081281] Tue May 19 22:30:08.118 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081281: ArAuthFrameworkImpl::doAuth::1:10081281:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:30:08.118 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081281: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:30:08.118 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081281: ArAuthFrameworkImpl::doPostAuth::1:10081281:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:30:08.134 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 10081281: Sending Continue with challenge Tue May 19 22:30:08.134 2009 Morocco Standard Time INFO: pid 2172 tid 688: 61: 10081281: Packet being sent Tue May 19 22:30:08.134 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Packet Sent (MsgType:110, Size: 176 Bytes). Tue May 19 22:30:08.446 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Packet Received (MsgType:110, Size: 154 Bytes). Tue May 19 22:30:08.446 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:08.446 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 0: 10081282: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:08.446 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081282: Using session identifier [1:10081282] Tue May 19 22:30:08.446 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081282: ArAuthFrameworkImpl::doPreAuth::1:10081282:: Authentication mechanism returned [0] for AuthIdentity [01309325;ARCARD] Tue May 19 22:30:08.446 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081282: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:30:08.446 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081282: ArAuthFrameworkImpl::doAuth::1:10081282:: Authentication mechanism returned [1] for AuthIdentity [01309325;ARCARD] Tue May 19 22:30:08.446 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081282: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:30:08.446 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081282: ArAuthFrameworkImpl::doPostAuth::1:10081282:: Authentication mechanism returned [1] for AuthIdentity [01309325] Tue May 19 22:30:08.462 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 10081282: Sending Continue with challenge Tue May 19 22:30:08.462 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 61: 10081282: Packet being sent Tue May 19 22:30:08.462 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Packet Sent (MsgType:110, Size: 1564 Bytes). Tue May 19 22:30:08.462 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Packet Received (MsgType:109, Size: 1430 Bytes). Tue May 19 22:30:08.462 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:08.462 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 0: 10081283: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:08.462 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081283: Using session identifier [1:10081283] Tue May 19 22:30:08.462 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081283: ArAuthFrameworkImpl::doPreAuth::1:10081283:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:30:08.462 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081283: Arcot Native Server: recvd AA_BIN_MSG_VER_CHG Tue May 19 22:30:08.462 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081283: Cert Subject String....:[CN=01309325;O=MLS; UserID=01309325; CardName=ARCARD] Tue May 19 22:30:08.462 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081283: Cert issuer............:[CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US] Tue May 19 22:30:08.462 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081283: Cert serial String.....:[85b2] Tue May 19 22:30:08.462 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081283: ArcotId Certificate received with signature have ArcotExtension. Cert issuer=CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US, serial=85b2 and subject=CN=01309325;O=MLS Tue May 19 22:30:08.462 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081283: ArcotID Auth SUCCESS (serial Number [85b2]) Tue May 19 22:30:08.462 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081283: Session tracker Id associated with verify signed challenge[1:10081278] Tue May 19 22:30:08.462 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081283: ArAuthFrameworkImpl::doAuth::1:10081278:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:30:08.462 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081283: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:30:08.462 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081283: Handle_NSPAdvice::NSP Action :[NSP_RESET] Tue May 19 22:30:08.462 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081283: NSP Update Query is based on Serial Number Tue May 19 22:30:08.477 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081283: ArAuthFrameworkImpl::doPostAuth::1:10081278:: Authentication mechanism returned [0] for AuthIdentity [01309325] Tue May 19 22:30:08.493 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 10081283: Prepared to Send OK Tue May 19 22:30:08.493 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 61: 10081283: Packet being sent Tue May 19 22:30:08.493 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Packet Sent (MsgType:109, Size: 256 Bytes). Tue May 19 22:30:08.868 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Packet Received (MsgType:110, Size: 154 Bytes). Tue May 19 22:30:08.868 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:08.868 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 0: 10081284: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:08.868 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081284: Using session identifier [1:10081284] Tue May 19 22:30:08.868 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081284: ArAuthFrameworkImpl::doPreAuth::1:10081284:: Authentication mechanism returned [0] for AuthIdentity [01789302;ARCARD] Tue May 19 22:30:08.868 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081284: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:30:08.868 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081284: ArAuthFrameworkImpl::doAuth::1:10081284:: Authentication mechanism returned [1] for AuthIdentity [01789302;ARCARD] Tue May 19 22:30:08.868 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081284: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:30:08.868 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081284: ArAuthFrameworkImpl::doPostAuth::1:10081284:: Authentication mechanism returned [1] for AuthIdentity [01789302] Tue May 19 22:30:08.884 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 10081284: Sending Continue with challenge Tue May 19 22:30:08.884 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 61: 10081284: Packet being sent Tue May 19 22:30:08.884 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Packet Sent (MsgType:110, Size: 1564 Bytes). Tue May 19 22:30:08.884 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Packet Received (MsgType:109, Size: 1430 Bytes). Tue May 19 22:30:08.884 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:08.884 2009 Morocco Standard Time INFO: pid 2172 tid 688: 0: 10081285: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:08.884 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081285: Using session identifier [1:10081285] Tue May 19 22:30:08.884 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081285: ArAuthFrameworkImpl::doPreAuth::1:10081285:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:30:08.884 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081285: Arcot Native Server: recvd AA_BIN_MSG_VER_CHG Tue May 19 22:30:08.884 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081285: Cert Subject String....:[CN=01789302;O=MLS; UserID=01789302; CardName=ARCARD] Tue May 19 22:30:08.884 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081285: Cert issuer............:[CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US] Tue May 19 22:30:08.884 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081285: Cert serial String.....:[b9ab] Tue May 19 22:30:08.884 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081285: ArcotId Certificate received with signature have ArcotExtension. Cert issuer=CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US, serial=b9ab and subject=CN=01789302;O=MLS Tue May 19 22:30:08.899 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081285: Auth fail due to signature verification.Serial Number [b9ab] Tue May 19 22:30:08.899 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081285: Session tracker Id associated with verify signed challenge[1:10081281] Tue May 19 22:30:08.899 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081285: ArAuthFrameworkImpl::doAuth::1:10081281:: Authentication mechanism returned [3] for AuthIdentity [] Tue May 19 22:30:08.899 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081285: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:30:08.899 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081285: Handle_NSPAdvice::NSP Action :[NSP_INC] Tue May 19 22:30:08.899 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081285: Using Oracle Query Tue May 19 22:30:08.899 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081285: NSP Update Query is based on Serial Number Tue May 19 22:30:08.899 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081285: ArAuthFrameworkImpl::doPostAuth::1:10081281:: Authentication mechanism returned [3] for AuthIdentity [01789302] Tue May 19 22:30:08.915 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 10081285: Sending Invalid credential Tue May 19 22:30:08.915 2009 Morocco Standard Time INFO: pid 2172 tid 688: 61: 10081285: Packet being sent Tue May 19 22:30:08.915 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Packet Sent (MsgType:109, Size: 182 Bytes). Tue May 19 22:30:12.759 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Packet Received (MsgType:110, Size: 100 Bytes). Tue May 19 22:30:12.759 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:12.759 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 0: 10081286: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:12.759 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081286: Using session identifier [1:10081286] Tue May 19 22:30:12.759 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081286: ArAuthFrameworkImpl::doPreAuth::1:10081286:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:30:12.759 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081286: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:30:12.759 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081286: Session tracker Id associated with generate challenge[1:10081286] Tue May 19 22:30:12.759 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081286: ArAuthFrameworkImpl::doAuth::1:10081286:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:30:12.759 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081286: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:30:12.759 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081286: ArAuthFrameworkImpl::doPostAuth::1:10081286:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:30:12.774 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 10081286: Sending Continue with challenge Tue May 19 22:30:12.774 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 61: 10081286: Packet being sent Tue May 19 22:30:12.774 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Packet Sent (MsgType:110, Size: 176 Bytes). Tue May 19 22:30:14.009 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Packet Received (MsgType:110, Size: 154 Bytes). Tue May 19 22:30:14.009 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:14.009 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 0: 10081287: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:14.009 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081287: Using session identifier [1:10081287] Tue May 19 22:30:14.009 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081287: ArAuthFrameworkImpl::doPreAuth::1:10081287:: Authentication mechanism returned [0] for AuthIdentity [00988681;ARCARD] Tue May 19 22:30:14.009 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081287: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:30:14.024 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081287: ArAuthFrameworkImpl::doAuth::1:10081287:: Authentication mechanism returned [1] for AuthIdentity [00988681;ARCARD] Tue May 19 22:30:14.024 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081287: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:30:14.024 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081287: ArAuthFrameworkImpl::doPostAuth::1:10081287:: Authentication mechanism returned [1] for AuthIdentity [00988681] Tue May 19 22:30:14.024 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 10081287: Sending Continue with challenge Tue May 19 22:30:14.024 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 61: 10081287: Packet being sent Tue May 19 22:30:14.024 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Packet Sent (MsgType:110, Size: 1564 Bytes). Tue May 19 22:30:14.040 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Packet Received (MsgType:109, Size: 1430 Bytes). Tue May 19 22:30:14.040 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:14.040 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 0: 10081288: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:14.040 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081288: Using session identifier [1:10081288] Tue May 19 22:30:14.040 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081288: ArAuthFrameworkImpl::doPreAuth::1:10081288:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:30:14.040 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081288: Arcot Native Server: recvd AA_BIN_MSG_VER_CHG Tue May 19 22:30:14.040 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081288: Cert Subject String....:[CN=00988681;O=MLS; UserID=00988681; CardName=ARCARD] Tue May 19 22:30:14.040 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081288: Cert issuer............:[CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US] Tue May 19 22:30:14.040 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081288: Cert serial String.....:[010515] Tue May 19 22:30:14.040 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081288: ArcotId Certificate received with signature have ArcotExtension. Cert issuer=CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US, serial=010515 and subject=CN=00988681;O=MLS Tue May 19 22:30:14.040 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081288: ArcotID Auth SUCCESS (serial Number [10515]) Tue May 19 22:30:14.040 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081288: Session tracker Id associated with verify signed challenge[1:10081286] Tue May 19 22:30:14.040 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081288: ArAuthFrameworkImpl::doAuth::1:10081286:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:30:14.040 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081288: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:30:14.040 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081288: Handle_NSPAdvice::NSP Action :[NSP_RESET] Tue May 19 22:30:14.040 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081288: NSP Update Query is based on Serial Number Tue May 19 22:30:14.056 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081288: ArAuthFrameworkImpl::doPostAuth::1:10081286:: Authentication mechanism returned [0] for AuthIdentity [00988681] Tue May 19 22:30:14.087 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 10081288: Prepared to Send OK Tue May 19 22:30:14.087 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 61: 10081288: Packet being sent Tue May 19 22:30:14.087 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Packet Sent (MsgType:109, Size: 256 Bytes). Tue May 19 22:30:14.681 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Packet Received (MsgType:110, Size: 100 Bytes). Tue May 19 22:30:14.681 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:14.681 2009 Morocco Standard Time INFO: pid 2172 tid 688: 0: 10081289: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:14.681 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081289: Using session identifier [1:10081289] Tue May 19 22:30:14.681 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081289: ArAuthFrameworkImpl::doPreAuth::1:10081289:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:30:14.681 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081289: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:30:14.681 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081289: Session tracker Id associated with generate challenge[1:10081289] Tue May 19 22:30:14.681 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081289: ArAuthFrameworkImpl::doAuth::1:10081289:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:30:14.681 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081289: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:30:14.681 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081289: ArAuthFrameworkImpl::doPostAuth::1:10081289:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:30:14.696 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 10081289: Sending Continue with challenge Tue May 19 22:30:14.696 2009 Morocco Standard Time INFO: pid 2172 tid 688: 61: 10081289: Packet being sent Tue May 19 22:30:14.696 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Packet Sent (MsgType:110, Size: 176 Bytes). Tue May 19 22:30:15.165 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Packet Received (MsgType:110, Size: 154 Bytes). Tue May 19 22:30:15.165 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:15.165 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 0: 10081290: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:15.165 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081290: Using session identifier [1:10081290] Tue May 19 22:30:15.165 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081290: ArAuthFrameworkImpl::doPreAuth::1:10081290:: Authentication mechanism returned [0] for AuthIdentity [00326705;ARCARD] Tue May 19 22:30:15.165 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081290: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:30:15.165 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081290: ArAuthFrameworkImpl::doAuth::1:10081290:: Authentication mechanism returned [1] for AuthIdentity [00326705;ARCARD] Tue May 19 22:30:15.165 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081290: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:30:15.165 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081290: ArAuthFrameworkImpl::doPostAuth::1:10081290:: Authentication mechanism returned [1] for AuthIdentity [00326705] Tue May 19 22:30:15.181 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 10081290: Sending Continue with challenge Tue May 19 22:30:15.181 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 61: 10081290: Packet being sent Tue May 19 22:30:15.181 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Packet Sent (MsgType:110, Size: 1564 Bytes). Tue May 19 22:30:15.181 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Packet Received (MsgType:109, Size: 1430 Bytes). Tue May 19 22:30:15.181 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:15.181 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 0: 10081291: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:15.181 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081291: Using session identifier [1:10081291] Tue May 19 22:30:15.181 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081291: ArAuthFrameworkImpl::doPreAuth::1:10081291:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:30:15.181 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081291: Arcot Native Server: recvd AA_BIN_MSG_VER_CHG Tue May 19 22:30:15.181 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081291: Cert Subject String....:[CN=00326705;O=MLS; UserID=00326705; CardName=ARCARD] Tue May 19 22:30:15.181 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081291: Cert issuer............:[CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US] Tue May 19 22:30:15.181 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081291: Cert serial String.....:[0104d8] Tue May 19 22:30:15.181 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081291: ArcotId Certificate received with signature have ArcotExtension. Cert issuer=CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US, serial=0104d8 and subject=CN=00326705;O=MLS Tue May 19 22:30:15.196 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081291: ArcotID Auth SUCCESS (serial Number [104d8]) Tue May 19 22:30:15.196 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081291: Session tracker Id associated with verify signed challenge[1:10081289] Tue May 19 22:30:15.196 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081291: ArAuthFrameworkImpl::doAuth::1:10081289:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:30:15.196 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081291: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:30:15.196 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081291: Handle_NSPAdvice::NSP Action :[NSP_RESET] Tue May 19 22:30:15.196 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081291: NSP Update Query is based on Serial Number Tue May 19 22:30:15.196 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081291: ArAuthFrameworkImpl::doPostAuth::1:10081289:: Authentication mechanism returned [0] for AuthIdentity [00326705] Tue May 19 22:30:15.212 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 10081291: Prepared to Send OK Tue May 19 22:30:15.212 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 61: 10081291: Packet being sent Tue May 19 22:30:15.212 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Packet Sent (MsgType:109, Size: 256 Bytes). Tue May 19 22:30:16.727 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Packet Received (MsgType:110, Size: 100 Bytes). Tue May 19 22:30:16.727 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:16.727 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 0: 10081292: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:16.727 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081292: Using session identifier [1:10081292] Tue May 19 22:30:16.727 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081292: ArAuthFrameworkImpl::doPreAuth::1:10081292:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:30:16.727 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081292: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:30:16.727 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081292: Session tracker Id associated with generate challenge[1:10081292] Tue May 19 22:30:16.727 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081292: ArAuthFrameworkImpl::doAuth::1:10081292:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:30:16.727 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081292: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:30:16.727 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081292: ArAuthFrameworkImpl::doPostAuth::1:10081292:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:30:16.743 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 10081292: Sending Continue with challenge Tue May 19 22:30:16.743 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 61: 10081292: Packet being sent Tue May 19 22:30:16.743 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Packet Sent (MsgType:110, Size: 176 Bytes). Tue May 19 22:30:17.290 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Packet Received (MsgType:110, Size: 154 Bytes). Tue May 19 22:30:17.290 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:17.290 2009 Morocco Standard Time INFO: pid 2172 tid 688: 0: 10081293: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:17.290 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081293: Using session identifier [1:10081293] Tue May 19 22:30:17.290 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081293: ArAuthFrameworkImpl::doPreAuth::1:10081293:: Authentication mechanism returned [0] for AuthIdentity [01217582;ARCARD] Tue May 19 22:30:17.290 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081293: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:30:17.306 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081293: ArAuthFrameworkImpl::doAuth::1:10081293:: Authentication mechanism returned [1] for AuthIdentity [01217582;ARCARD] Tue May 19 22:30:17.306 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081293: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:30:17.306 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081293: ArAuthFrameworkImpl::doPostAuth::1:10081293:: Authentication mechanism returned [1] for AuthIdentity [01217582] Tue May 19 22:30:17.321 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 10081293: Sending Continue with challenge Tue May 19 22:30:17.321 2009 Morocco Standard Time INFO: pid 2172 tid 688: 61: 10081293: Packet being sent Tue May 19 22:30:17.321 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Packet Sent (MsgType:110, Size: 1564 Bytes). Tue May 19 22:30:17.321 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Packet Received (MsgType:109, Size: 1430 Bytes). Tue May 19 22:30:17.321 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:17.321 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 0: 10081294: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:17.321 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081294: Using session identifier [1:10081294] Tue May 19 22:30:17.321 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081294: ArAuthFrameworkImpl::doPreAuth::1:10081294:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:30:17.321 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081294: Arcot Native Server: recvd AA_BIN_MSG_VER_CHG Tue May 19 22:30:17.321 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081294: Cert Subject String....:[CN=01217582;O=MLS; UserID=01217582; CardName=ARCARD] Tue May 19 22:30:17.321 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081294: Cert issuer............:[CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US] Tue May 19 22:30:17.321 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081294: Cert serial String.....:[9bd4] Tue May 19 22:30:17.321 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081294: ArcotId Certificate received with signature have ArcotExtension. Cert issuer=CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US, serial=9bd4 and subject=CN=01217582;O=MLS Tue May 19 22:30:17.321 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081294: ArcotID Auth SUCCESS (serial Number [9bd4]) Tue May 19 22:30:17.321 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081294: Session tracker Id associated with verify signed challenge[1:10081292] Tue May 19 22:30:17.321 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081294: ArAuthFrameworkImpl::doAuth::1:10081292:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:30:17.321 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081294: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:30:17.321 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081294: Handle_NSPAdvice::NSP Action :[NSP_RESET] Tue May 19 22:30:17.321 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081294: NSP Update Query is based on Serial Number Tue May 19 22:30:17.337 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081294: ArAuthFrameworkImpl::doPostAuth::1:10081292:: Authentication mechanism returned [0] for AuthIdentity [01217582] Tue May 19 22:30:17.352 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 10081294: Prepared to Send OK Tue May 19 22:30:17.352 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 61: 10081294: Packet being sent Tue May 19 22:30:17.352 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Packet Sent (MsgType:109, Size: 256 Bytes). Tue May 19 22:30:24.509 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Packet Received (MsgType:110, Size: 100 Bytes). Tue May 19 22:30:24.509 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:24.509 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 0: 10081295: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:24.509 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081295: Using session identifier [1:10081295] Tue May 19 22:30:24.509 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081295: ArAuthFrameworkImpl::doPreAuth::1:10081295:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:30:24.524 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081295: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:30:24.524 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081295: Session tracker Id associated with generate challenge[1:10081295] Tue May 19 22:30:24.524 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081295: ArAuthFrameworkImpl::doAuth::1:10081295:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:30:24.524 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081295: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:30:24.524 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081295: ArAuthFrameworkImpl::doPostAuth::1:10081295:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:30:24.524 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 10081295: Sending Continue with challenge Tue May 19 22:30:24.524 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 61: 10081295: Packet being sent Tue May 19 22:30:24.524 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Packet Sent (MsgType:110, Size: 176 Bytes). Tue May 19 22:30:25.071 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Packet Received (MsgType:110, Size: 154 Bytes). Tue May 19 22:30:25.071 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:25.071 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 0: 10081296: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:25.071 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081296: Using session identifier [1:10081296] Tue May 19 22:30:25.071 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081296: ArAuthFrameworkImpl::doPreAuth::1:10081296:: Authentication mechanism returned [0] for AuthIdentity [01491703;ARCARD] Tue May 19 22:30:25.071 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081296: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:30:25.087 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081296: ArAuthFrameworkImpl::doAuth::1:10081296:: Authentication mechanism returned [1] for AuthIdentity [01491703;ARCARD] Tue May 19 22:30:25.087 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081296: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:30:25.087 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081296: ArAuthFrameworkImpl::doPostAuth::1:10081296:: Authentication mechanism returned [1] for AuthIdentity [01491703] Tue May 19 22:30:25.102 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 10081296: Sending Continue with challenge Tue May 19 22:30:25.102 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 61: 10081296: Packet being sent Tue May 19 22:30:25.102 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Packet Sent (MsgType:110, Size: 1564 Bytes). Tue May 19 22:30:25.102 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Packet Received (MsgType:109, Size: 1430 Bytes). Tue May 19 22:30:25.102 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:25.102 2009 Morocco Standard Time INFO: pid 2172 tid 688: 0: 10081297: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:25.102 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081297: Using session identifier [1:10081297] Tue May 19 22:30:25.102 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081297: ArAuthFrameworkImpl::doPreAuth::1:10081297:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:30:25.102 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081297: Arcot Native Server: recvd AA_BIN_MSG_VER_CHG Tue May 19 22:30:25.102 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081297: Cert Subject String....:[CN=01491703;O=MLS; UserID=01491703; CardName=ARCARD] Tue May 19 22:30:25.102 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081297: Cert issuer............:[CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US] Tue May 19 22:30:25.102 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081297: Cert serial String.....:[8b4f] Tue May 19 22:30:25.102 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081297: ArcotId Certificate received with signature have ArcotExtension. Cert issuer=CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US, serial=8b4f and subject=CN=01491703;O=MLS Tue May 19 22:30:25.102 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081297: ArcotID Auth SUCCESS (serial Number [8b4f]) Tue May 19 22:30:25.102 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081297: Session tracker Id associated with verify signed challenge[1:10081295] Tue May 19 22:30:25.102 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081297: ArAuthFrameworkImpl::doAuth::1:10081295:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:30:25.102 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081297: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:30:25.102 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081297: Handle_NSPAdvice::NSP Action :[NSP_RESET] Tue May 19 22:30:25.102 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081297: NSP Update Query is based on Serial Number Tue May 19 22:30:25.118 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081297: ArAuthFrameworkImpl::doPostAuth::1:10081295:: Authentication mechanism returned [0] for AuthIdentity [01491703] Tue May 19 22:30:25.134 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 10081297: Prepared to Send OK Tue May 19 22:30:25.134 2009 Morocco Standard Time INFO: pid 2172 tid 688: 61: 10081297: Packet being sent Tue May 19 22:30:25.134 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Packet Sent (MsgType:109, Size: 256 Bytes). Tue May 19 22:30:27.524 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Packet Received (MsgType: 0, Size: 106 Bytes). Tue May 19 22:30:27.524 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:27.524 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 0: 10081298: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:27.524 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 10081298: Entering [MechQnA::handleAuthRequest] Tue May 19 22:30:27.524 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 10081298: Exiting [MechQnA::handleAuthRequest] Tue May 19 22:30:27.524 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081298: Using session identifier [1:10081298] Tue May 19 22:30:27.524 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081298: Entering QnAModule::openSession Tue May 19 22:30:27.524 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081298: Exiting QnAModule::openSession Tue May 19 22:30:27.524 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081298: ArAuthFrameworkImpl::doPreAuth::1:10081298:: Authentication mechanism returned [0] for AuthIdentity [01789302] Tue May 19 22:30:27.524 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081298: Entering QnAModule::authenticate Tue May 19 22:30:27.524 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081298: QnA Session Id :[1:10081298] Tue May 19 22:30:27.524 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081298: QNA Step - ASK AUTH QUESTIONS Tue May 19 22:30:27.524 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081298: User DB Query Details: Tue May 19 22:30:27.524 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081298: userName :[01789302] Tue May 19 22:30:27.524 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081298: Group ID :1020 Tue May 19 22:30:27.524 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081298: User ID :-1 Tue May 19 22:30:27.540 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081298: Number of rows fetched from DB : 1 Tue May 19 22:30:27.540 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081298: Entering QnAUserData::dump Tue May 19 22:30:27.540 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081298: Exiting QnAUserData::dump Tue May 19 22:30:27.540 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081298: Set of questions(bitmap) selected : 9 Tue May 19 22:30:27.540 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081298: Session tracker Id associated with QnA challenge(auth round questions) : [1:10081298] Tue May 19 22:30:27.540 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081298: Exiting QnAModule::authenticate Tue May 19 22:30:27.540 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081298: ArAuthFrameworkImpl::doAuth::1:10081298:: Authentication mechanism returned [1] for AuthIdentity [01789302] Tue May 19 22:30:27.540 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081298: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [2] Tue May 19 22:30:27.540 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081298: ArAuthFrameworkImpl::doPostAuth::1:10081298:: Authentication mechanism returned [1] for AuthIdentity [01789302] Tue May 19 22:30:27.540 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081298: Entering QnAModule::closeSession Tue May 19 22:30:27.540 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081298: Exiting QnAModule::closeSession Tue May 19 22:30:27.540 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 10081298: Entering [MechQnA::handleAuthResMoreSteps] Tue May 19 22:30:27.540 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 10081298: Exiting [MechQnA::handleAuthResMoreSteps] Tue May 19 22:30:27.540 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 10081298: Sending Continue with challenge Tue May 19 22:30:27.556 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 61: 10081298: Packet being sent Tue May 19 22:30:27.556 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Packet Sent (MsgType: 0, Size: 360 Bytes). Tue May 19 22:30:36.774 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Packet Received (MsgType:110, Size: 100 Bytes). Tue May 19 22:30:36.774 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:36.774 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 0: 10081299: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:36.774 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081299: Using session identifier [1:10081299] Tue May 19 22:30:36.774 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081299: ArAuthFrameworkImpl::doPreAuth::1:10081299:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:30:36.774 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081299: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:30:36.774 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081299: Session tracker Id associated with generate challenge[1:10081299] Tue May 19 22:30:36.774 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081299: ArAuthFrameworkImpl::doAuth::1:10081299:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:30:36.774 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081299: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:30:36.774 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081299: ArAuthFrameworkImpl::doPostAuth::1:10081299:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:30:36.790 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 10081299: Sending Continue with challenge Tue May 19 22:30:36.790 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 61: 10081299: Packet being sent Tue May 19 22:30:36.790 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Packet Sent (MsgType:110, Size: 176 Bytes). Tue May 19 22:30:37.962 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Packet Received (MsgType:110, Size: 154 Bytes). Tue May 19 22:30:37.962 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:37.962 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 0: 10081300: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:37.962 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081300: Using session identifier [1:10081300] Tue May 19 22:30:37.962 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081300: ArAuthFrameworkImpl::doPreAuth::1:10081300:: Authentication mechanism returned [0] for AuthIdentity [01377974;ARCARD] Tue May 19 22:30:37.962 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081300: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:30:37.962 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081300: ArAuthFrameworkImpl::doAuth::1:10081300:: Authentication mechanism returned [1] for AuthIdentity [01377974;ARCARD] Tue May 19 22:30:37.962 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081300: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:30:37.962 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081300: ArAuthFrameworkImpl::doPostAuth::1:10081300:: Authentication mechanism returned [1] for AuthIdentity [01377974] Tue May 19 22:30:37.977 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 10081300: Sending Continue with challenge Tue May 19 22:30:37.977 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 61: 10081300: Packet being sent Tue May 19 22:30:37.977 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Packet Sent (MsgType:110, Size: 1564 Bytes). Tue May 19 22:30:37.993 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Packet Received (MsgType:109, Size: 1430 Bytes). Tue May 19 22:30:37.993 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:37.993 2009 Morocco Standard Time INFO: pid 2172 tid 688: 0: 10081301: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:37.993 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081301: Using session identifier [1:10081301] Tue May 19 22:30:37.993 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081301: ArAuthFrameworkImpl::doPreAuth::1:10081301:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:30:37.993 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081301: Arcot Native Server: recvd AA_BIN_MSG_VER_CHG Tue May 19 22:30:37.993 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081301: Cert Subject String....:[CN=01377974;O=MLS; UserID=01377974; CardName=ARCARD] Tue May 19 22:30:37.993 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081301: Cert issuer............:[CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US] Tue May 19 22:30:37.993 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081301: Cert serial String.....:[ba37] Tue May 19 22:30:37.993 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081301: ArcotId Certificate received with signature have ArcotExtension. Cert issuer=CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US, serial=ba37 and subject=CN=01377974;O=MLS Tue May 19 22:30:37.993 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081301: ArcotID Auth SUCCESS (serial Number [ba37]) Tue May 19 22:30:37.993 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081301: Session tracker Id associated with verify signed challenge[1:10081299] Tue May 19 22:30:37.993 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081301: ArAuthFrameworkImpl::doAuth::1:10081299:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:30:37.993 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081301: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:30:37.993 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081301: Handle_NSPAdvice::NSP Action :[NSP_RESET] Tue May 19 22:30:37.993 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081301: NSP Update Query is based on Serial Number Tue May 19 22:30:38.009 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081301: ArAuthFrameworkImpl::doPostAuth::1:10081299:: Authentication mechanism returned [0] for AuthIdentity [01377974] Tue May 19 22:30:38.024 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 10081301: Prepared to Send OK Tue May 19 22:30:38.024 2009 Morocco Standard Time INFO: pid 2172 tid 688: 61: 10081301: Packet being sent Tue May 19 22:30:38.024 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Packet Sent (MsgType:109, Size: 256 Bytes). Tue May 19 22:30:42.196 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Packet Received (MsgType: 0, Size: 264 Bytes). Tue May 19 22:30:42.196 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:42.196 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 0: 10081302: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:42.196 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 10081302: Entering [MechQnA::handleAuthRequest] Tue May 19 22:30:42.196 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 10081302: Exiting [MechQnA::handleAuthRequest] Tue May 19 22:30:42.196 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081302: Using session identifier [1:10081302] Tue May 19 22:30:42.196 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081302: Entering QnAModule::openSession Tue May 19 22:30:42.196 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081302: Exiting QnAModule::openSession Tue May 19 22:30:42.196 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081302: ArAuthFrameworkImpl::doPreAuth::1:10081302:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:30:42.196 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081302: Entering QnAModule::authenticate Tue May 19 22:30:42.196 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081302: QnA Session Id :[1:10081302] Tue May 19 22:30:42.196 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081302: QNA Step - AUTH IN PROGRESS Tue May 19 22:30:42.196 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081302: Session tracker Id associated with QnA challenge(auth round questions) : [1:10081298] Tue May 19 22:30:42.196 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081302: User DB Query Details: Tue May 19 22:30:42.196 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081302: userName :[] Tue May 19 22:30:42.196 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081302: Group ID :1020 Tue May 19 22:30:42.196 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081302: User ID :11605 Tue May 19 22:30:42.212 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081302: Number of rows fetched from DB : 1 Tue May 19 22:30:42.212 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081302: QNA Auth - Success and Complete, Returning SUCCESS Tue May 19 22:30:42.212 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081302: Exiting QnAModule::authenticate Tue May 19 22:30:42.212 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081302: ArAuthFrameworkImpl::doAuth::1:10081298:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:30:42.212 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081302: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [2] Tue May 19 22:30:42.212 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081302: Handle_NSPAdvice::NSP Action :[NSP_RESET] Tue May 19 22:30:42.212 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081302: NSP Update Query is based on UserID/GroupID Tue May 19 22:30:42.212 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081302: ArAuthFrameworkImpl::doPostAuth::1:10081298:: Authentication mechanism returned [0] for AuthIdentity [01789302] Tue May 19 22:30:42.227 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081302: Entering QnAModule::closeSession Tue May 19 22:30:42.227 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081302: Exiting QnAModule::closeSession Tue May 19 22:30:42.227 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 10081302: Prepared to Send OK Tue May 19 22:30:42.227 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 61: 10081302: Packet being sent Tue May 19 22:30:42.227 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Packet Sent (MsgType: 0, Size: 244 Bytes). Tue May 19 22:30:42.384 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Packet Received (MsgType:110, Size: 100 Bytes). Tue May 19 22:30:42.384 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:42.384 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 0: 10081303: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:42.384 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081303: Using session identifier [1:10081303] Tue May 19 22:30:42.384 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081303: ArAuthFrameworkImpl::doPreAuth::1:10081303:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:30:42.384 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081303: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:30:42.384 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081303: Session tracker Id associated with generate challenge[1:10081303] Tue May 19 22:30:42.384 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081303: ArAuthFrameworkImpl::doAuth::1:10081303:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:30:42.384 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081303: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:30:42.384 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081303: ArAuthFrameworkImpl::doPostAuth::1:10081303:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:30:42.399 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 10081303: Sending Continue with challenge Tue May 19 22:30:42.399 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 61: 10081303: Packet being sent Tue May 19 22:30:42.399 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Packet Sent (MsgType:110, Size: 176 Bytes). Tue May 19 22:30:43.102 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Packet Received (MsgType:110, Size: 154 Bytes). Tue May 19 22:30:43.102 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:43.102 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 0: 10081304: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:43.102 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081304: Using session identifier [1:10081304] Tue May 19 22:30:43.102 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081304: ArAuthFrameworkImpl::doPreAuth::1:10081304:: Authentication mechanism returned [0] for AuthIdentity [01790860;ARCARD] Tue May 19 22:30:43.102 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081304: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:30:43.102 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081304: ArAuthFrameworkImpl::doAuth::1:10081304:: Authentication mechanism returned [1] for AuthIdentity [01790860;ARCARD] Tue May 19 22:30:43.102 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081304: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:30:43.102 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081304: ArAuthFrameworkImpl::doPostAuth::1:10081304:: Authentication mechanism returned [1] for AuthIdentity [01790860] Tue May 19 22:30:43.118 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 10081304: Sending Continue with challenge Tue May 19 22:30:43.118 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 61: 10081304: Packet being sent Tue May 19 22:30:43.118 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Packet Sent (MsgType:110, Size: 1564 Bytes). Tue May 19 22:30:43.134 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Packet Received (MsgType:109, Size: 1430 Bytes). Tue May 19 22:30:43.134 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:43.134 2009 Morocco Standard Time INFO: pid 2172 tid 688: 0: 10081305: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:43.134 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081305: Using session identifier [1:10081305] Tue May 19 22:30:43.134 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081305: ArAuthFrameworkImpl::doPreAuth::1:10081305:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:30:43.134 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081305: Arcot Native Server: recvd AA_BIN_MSG_VER_CHG Tue May 19 22:30:43.134 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081305: Cert Subject String....:[CN=01790860;O=MLS; UserID=01790860; CardName=ARCARD] Tue May 19 22:30:43.134 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081305: Cert issuer............:[CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US] Tue May 19 22:30:43.134 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081305: Cert serial String.....:[010fc8] Tue May 19 22:30:43.134 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081305: ArcotId Certificate received with signature have ArcotExtension. Cert issuer=CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US, serial=010fc8 and subject=CN=01790860;O=MLS Tue May 19 22:30:43.134 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081305: ArcotID Auth SUCCESS (serial Number [10fc8]) Tue May 19 22:30:43.134 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081305: Session tracker Id associated with verify signed challenge[1:10081303] Tue May 19 22:30:43.134 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081305: ArAuthFrameworkImpl::doAuth::1:10081303:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:30:43.134 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081305: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:30:43.134 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081305: Handle_NSPAdvice::NSP Action :[NSP_RESET] Tue May 19 22:30:43.134 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081305: NSP Update Query is based on Serial Number Tue May 19 22:30:43.149 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081305: ArAuthFrameworkImpl::doPostAuth::1:10081303:: Authentication mechanism returned [0] for AuthIdentity [01790860] Tue May 19 22:30:43.165 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 10081305: Prepared to Send OK Tue May 19 22:30:43.165 2009 Morocco Standard Time INFO: pid 2172 tid 688: 61: 10081305: Packet being sent Tue May 19 22:30:43.165 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Packet Sent (MsgType:109, Size: 256 Bytes). Tue May 19 22:30:48.743 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Packet Received (MsgType:110, Size: 100 Bytes). Tue May 19 22:30:48.743 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:48.743 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 0: 10081306: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:48.743 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081306: Using session identifier [1:10081306] Tue May 19 22:30:48.743 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081306: ArAuthFrameworkImpl::doPreAuth::1:10081306:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:30:48.743 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081306: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:30:48.743 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081306: Session tracker Id associated with generate challenge[1:10081306] Tue May 19 22:30:48.743 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081306: ArAuthFrameworkImpl::doAuth::1:10081306:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:30:48.743 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081306: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:30:48.743 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081306: ArAuthFrameworkImpl::doPostAuth::1:10081306:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:30:48.759 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 10081306: Sending Continue with challenge Tue May 19 22:30:48.759 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 61: 10081306: Packet being sent Tue May 19 22:30:48.759 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Packet Sent (MsgType:110, Size: 176 Bytes). Tue May 19 22:30:49.993 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Packet Received (MsgType:110, Size: 154 Bytes). Tue May 19 22:30:50.009 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:50.009 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 0: 10081307: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:50.009 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081307: Using session identifier [1:10081307] Tue May 19 22:30:50.009 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081307: ArAuthFrameworkImpl::doPreAuth::1:10081307:: Authentication mechanism returned [0] for AuthIdentity [50028491;ARCARD] Tue May 19 22:30:50.009 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081307: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:30:50.009 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081307: ArAuthFrameworkImpl::doAuth::1:10081307:: Authentication mechanism returned [1] for AuthIdentity [50028491;ARCARD] Tue May 19 22:30:50.009 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081307: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:30:50.009 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081307: ArAuthFrameworkImpl::doPostAuth::1:10081307:: Authentication mechanism returned [1] for AuthIdentity [50028491] Tue May 19 22:30:50.024 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 10081307: Sending Continue with challenge Tue May 19 22:30:50.024 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 61: 10081307: Packet being sent Tue May 19 22:30:50.024 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Packet Sent (MsgType:110, Size: 1564 Bytes). Tue May 19 22:30:50.024 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Packet Received (MsgType:109, Size: 1430 Bytes). Tue May 19 22:30:50.024 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:50.024 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 0: 10081308: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:50.024 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081308: Using session identifier [1:10081308] Tue May 19 22:30:50.024 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081308: ArAuthFrameworkImpl::doPreAuth::1:10081308:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:30:50.024 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081308: Arcot Native Server: recvd AA_BIN_MSG_VER_CHG Tue May 19 22:30:50.024 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081308: Cert Subject String....:[CN=50028491;O=MLS; UserID=50028491; CardName=ARCARD] Tue May 19 22:30:50.024 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081308: Cert issuer............:[CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US] Tue May 19 22:30:50.024 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081308: Cert serial String.....:[c53c] Tue May 19 22:30:50.024 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081308: ArcotId Certificate received with signature have ArcotExtension. Cert issuer=CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US, serial=c53c and subject=CN=50028491;O=MLS Tue May 19 22:30:50.024 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081308: ArcotID Auth SUCCESS (serial Number [c53c]) Tue May 19 22:30:50.024 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081308: Session tracker Id associated with verify signed challenge[1:10081306] Tue May 19 22:30:50.024 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081308: ArAuthFrameworkImpl::doAuth::1:10081306:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:30:50.024 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081308: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:30:50.024 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081308: Handle_NSPAdvice::NSP Action :[NSP_RESET] Tue May 19 22:30:50.024 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081308: NSP Update Query is based on Serial Number Tue May 19 22:30:50.040 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081308: ArAuthFrameworkImpl::doPostAuth::1:10081306:: Authentication mechanism returned [0] for AuthIdentity [50028491] Tue May 19 22:30:50.056 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 10081308: Prepared to Send OK Tue May 19 22:30:50.056 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 61: 10081308: Packet being sent Tue May 19 22:30:50.056 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Packet Sent (MsgType:109, Size: 256 Bytes). Tue May 19 22:30:53.009 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Packet Received (MsgType:110, Size: 100 Bytes). Tue May 19 22:30:53.009 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:53.009 2009 Morocco Standard Time INFO: pid 2172 tid 688: 0: 10081309: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:53.009 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081309: Using session identifier [1:10081309] Tue May 19 22:30:53.009 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081309: ArAuthFrameworkImpl::doPreAuth::1:10081309:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:30:53.009 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081309: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:30:53.009 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081309: Session tracker Id associated with generate challenge[1:10081309] Tue May 19 22:30:53.009 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081309: ArAuthFrameworkImpl::doAuth::1:10081309:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:30:53.009 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081309: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:30:53.009 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081309: ArAuthFrameworkImpl::doPostAuth::1:10081309:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:30:53.024 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 10081309: Sending Continue with challenge Tue May 19 22:30:53.024 2009 Morocco Standard Time INFO: pid 2172 tid 688: 61: 10081309: Packet being sent Tue May 19 22:30:53.024 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Packet Sent (MsgType:110, Size: 176 Bytes). Tue May 19 22:30:53.946 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Packet Received (MsgType:110, Size: 154 Bytes). Tue May 19 22:30:53.946 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:53.946 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 0: 10081310: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:53.946 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081310: Using session identifier [1:10081310] Tue May 19 22:30:53.946 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081310: ArAuthFrameworkImpl::doPreAuth::1:10081310:: Authentication mechanism returned [0] for AuthIdentity [00809082;ARCARD] Tue May 19 22:30:53.946 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081310: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:30:53.946 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081310: ArAuthFrameworkImpl::doAuth::1:10081310:: Authentication mechanism returned [1] for AuthIdentity [00809082;ARCARD] Tue May 19 22:30:53.946 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081310: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:30:53.946 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081310: ArAuthFrameworkImpl::doPostAuth::1:10081310:: Authentication mechanism returned [1] for AuthIdentity [00809082] Tue May 19 22:30:53.962 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 10081310: Sending Continue with challenge Tue May 19 22:30:53.962 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 61: 10081310: Packet being sent Tue May 19 22:30:53.962 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Packet Sent (MsgType:110, Size: 1564 Bytes). Tue May 19 22:30:53.962 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Packet Received (MsgType:109, Size: 1430 Bytes). Tue May 19 22:30:53.962 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:53.962 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 0: 10081311: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:53.962 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081311: Using session identifier [1:10081311] Tue May 19 22:30:53.962 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081311: ArAuthFrameworkImpl::doPreAuth::1:10081311:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:30:53.962 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081311: Arcot Native Server: recvd AA_BIN_MSG_VER_CHG Tue May 19 22:30:53.962 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081311: Cert Subject String....:[CN=00809082;O=MLS; UserID=00809082; CardName=ARCARD] Tue May 19 22:30:53.962 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081311: Cert issuer............:[CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US] Tue May 19 22:30:53.962 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081311: Cert serial String.....:[ce8d] Tue May 19 22:30:53.962 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081311: ArcotId Certificate received with signature have ArcotExtension. Cert issuer=CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US, serial=ce8d and subject=CN=00809082;O=MLS Tue May 19 22:30:53.962 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081311: ArcotID Auth SUCCESS (serial Number [ce8d]) Tue May 19 22:30:53.962 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081311: Session tracker Id associated with verify signed challenge[1:10081309] Tue May 19 22:30:53.962 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081311: ArAuthFrameworkImpl::doAuth::1:10081309:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:30:53.962 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081311: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:30:53.962 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081311: Handle_NSPAdvice::NSP Action :[NSP_RESET] Tue May 19 22:30:53.962 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081311: NSP Update Query is based on Serial Number Tue May 19 22:30:53.977 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081311: ArAuthFrameworkImpl::doPostAuth::1:10081309:: Authentication mechanism returned [0] for AuthIdentity [00809082] Tue May 19 22:30:53.993 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 10081311: Prepared to Send OK Tue May 19 22:30:53.993 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 61: 10081311: Packet being sent Tue May 19 22:30:53.993 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Packet Sent (MsgType:109, Size: 256 Bytes). Tue May 19 22:30:55.509 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Packet Received (MsgType:110, Size: 100 Bytes). Tue May 19 22:30:55.509 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:55.509 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 0: 10081312: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:55.509 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081312: Using session identifier [1:10081312] Tue May 19 22:30:55.509 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081312: ArAuthFrameworkImpl::doPreAuth::1:10081312:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:30:55.509 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081312: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:30:55.509 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081312: Session tracker Id associated with generate challenge[1:10081312] Tue May 19 22:30:55.509 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081312: ArAuthFrameworkImpl::doAuth::1:10081312:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:30:55.509 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081312: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:30:55.509 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081312: ArAuthFrameworkImpl::doPostAuth::1:10081312:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:30:55.524 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 10081312: Sending Continue with challenge Tue May 19 22:30:55.524 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 61: 10081312: Packet being sent Tue May 19 22:30:55.524 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Packet Sent (MsgType:110, Size: 176 Bytes). Tue May 19 22:30:55.884 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Packet Received (MsgType: 0, Size: 269 Bytes). Tue May 19 22:30:55.884 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:55.884 2009 Morocco Standard Time INFO: pid 2172 tid 688: 0: 10081313: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:55.884 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 10081313: Entering [MechQnA::handleAuthRequest] Tue May 19 22:30:55.884 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 10081313: Exiting [MechQnA::handleAuthRequest] Tue May 19 22:30:55.884 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081313: Using session identifier [1:10081313] Tue May 19 22:30:55.884 2009 Morocco Standard Time INFO: pid 2172 tid 688: 160: 10081313: Entering QnAModule::openSession Tue May 19 22:30:55.884 2009 Morocco Standard Time INFO: pid 2172 tid 688: 160: 10081313: Exiting QnAModule::openSession Tue May 19 22:30:55.884 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081313: ArAuthFrameworkImpl::doPreAuth::1:10081313:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:30:55.884 2009 Morocco Standard Time INFO: pid 2172 tid 688: 160: 10081313: Entering QnAModule::authenticate Tue May 19 22:30:55.884 2009 Morocco Standard Time INFO: pid 2172 tid 688: 160: 10081313: QnA Session Id :[1:10081313] Tue May 19 22:30:55.884 2009 Morocco Standard Time INFO: pid 2172 tid 688: 160: 10081313: QNA Step - AUTH IN PROGRESS Tue May 19 22:30:55.884 2009 Morocco Standard Time INFO: pid 2172 tid 688: 160: 10081313: Session tracker Id associated with QnA challenge(auth round questions) : [1:10081230] Tue May 19 22:30:55.884 2009 Morocco Standard Time INFO: pid 2172 tid 688: 160: 10081313: User DB Query Details: Tue May 19 22:30:55.884 2009 Morocco Standard Time INFO: pid 2172 tid 688: 160: 10081313: userName :[] Tue May 19 22:30:55.884 2009 Morocco Standard Time INFO: pid 2172 tid 688: 160: 10081313: Group ID :1020 Tue May 19 22:30:55.884 2009 Morocco Standard Time INFO: pid 2172 tid 688: 160: 10081313: User ID :6917 Tue May 19 22:30:55.899 2009 Morocco Standard Time INFO: pid 2172 tid 688: 160: 10081313: Number of rows fetched from DB : 1 Tue May 19 22:30:55.899 2009 Morocco Standard Time INFO: pid 2172 tid 688: 160: 10081313: Err[115261735], Message: Native Verification: ANSWER(s) MISMATCH! (correct/total : 1/2)! Tue May 19 22:30:55.899 2009 Morocco Standard Time INFO: pid 2172 tid 688: 160: 10081313: Err[115261735], Message: QNA Auth Failed(Invalid Credentials), Repeating the challenge and Returning FAILED Tue May 19 22:30:55.899 2009 Morocco Standard Time INFO: pid 2172 tid 688: 160: 10081313: Exiting QnAModule::authenticate Tue May 19 22:30:55.899 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081313: ArAuthFrameworkImpl::doAuth::1:10081230:: Authentication mechanism returned [3] for AuthIdentity [] Tue May 19 22:30:55.899 2009 Morocco Standard Time INFO: pid 2172 tid 688: 160: 10081313: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [2] Tue May 19 22:30:55.899 2009 Morocco Standard Time INFO: pid 2172 tid 688: 160: 10081313: Handle_NSPAdvice::NSP Action :[NSP_INC] Tue May 19 22:30:55.899 2009 Morocco Standard Time INFO: pid 2172 tid 688: 160: 10081313: Using Oracle Query Tue May 19 22:30:55.899 2009 Morocco Standard Time INFO: pid 2172 tid 688: 160: 10081313: NSP Update Query is based on UserID/GroupID Tue May 19 22:30:55.915 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081313: ArAuthFrameworkImpl::doPostAuth::1:10081230:: Authentication mechanism returned [3] for AuthIdentity [01018603] Tue May 19 22:30:55.915 2009 Morocco Standard Time INFO: pid 2172 tid 688: 160: 10081313: Entering QnAModule::closeSession Tue May 19 22:30:55.915 2009 Morocco Standard Time INFO: pid 2172 tid 688: 160: 10081313: Exiting QnAModule::closeSession Tue May 19 22:30:55.931 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 10081313: Sending Invalid credential Tue May 19 22:30:55.931 2009 Morocco Standard Time INFO: pid 2172 tid 688: 61: 10081313: Packet being sent Tue May 19 22:30:55.931 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Packet Sent (MsgType: 0, Size: 182 Bytes). Tue May 19 22:30:56.227 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Packet Received (MsgType: 0, Size: 106 Bytes). Tue May 19 22:30:56.227 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:56.227 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 0: 10081314: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:56.227 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 10081314: Entering [MechQnA::handleAuthRequest] Tue May 19 22:30:56.227 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 10081314: Exiting [MechQnA::handleAuthRequest] Tue May 19 22:30:56.227 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081314: Using session identifier [1:10081314] Tue May 19 22:30:56.227 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081314: Entering QnAModule::openSession Tue May 19 22:30:56.227 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081314: Exiting QnAModule::openSession Tue May 19 22:30:56.227 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081314: ArAuthFrameworkImpl::doPreAuth::1:10081314:: Authentication mechanism returned [0] for AuthIdentity [01018603] Tue May 19 22:30:56.227 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081314: Entering QnAModule::authenticate Tue May 19 22:30:56.227 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081314: QnA Session Id :[1:10081314] Tue May 19 22:30:56.227 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081314: QNA Step - ASK AUTH QUESTIONS Tue May 19 22:30:56.227 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081314: User DB Query Details: Tue May 19 22:30:56.227 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081314: userName :[01018603] Tue May 19 22:30:56.227 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081314: Group ID :1020 Tue May 19 22:30:56.227 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081314: User ID :-1 Tue May 19 22:30:56.227 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081314: Number of rows fetched from DB : 1 Tue May 19 22:30:56.227 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081314: Entering QnAUserData::dump Tue May 19 22:30:56.227 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081314: Exiting QnAUserData::dump Tue May 19 22:30:56.227 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081314: Set of questions(bitmap) selected : 3 Tue May 19 22:30:56.227 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081314: Session tracker Id associated with QnA challenge(auth round questions) : [1:10081314] Tue May 19 22:30:56.227 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081314: Exiting QnAModule::authenticate Tue May 19 22:30:56.227 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081314: ArAuthFrameworkImpl::doAuth::1:10081314:: Authentication mechanism returned [1] for AuthIdentity [01018603] Tue May 19 22:30:56.227 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081314: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [2] Tue May 19 22:30:56.227 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081314: ArAuthFrameworkImpl::doPostAuth::1:10081314:: Authentication mechanism returned [1] for AuthIdentity [01018603] Tue May 19 22:30:56.227 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081314: Entering QnAModule::closeSession Tue May 19 22:30:56.227 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 160: 10081314: Exiting QnAModule::closeSession Tue May 19 22:30:56.243 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 10081314: Entering [MechQnA::handleAuthResMoreSteps] Tue May 19 22:30:56.243 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 10081314: Exiting [MechQnA::handleAuthResMoreSteps] Tue May 19 22:30:56.243 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 10081314: Sending Continue with challenge Tue May 19 22:30:56.243 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 61: 10081314: Packet being sent Tue May 19 22:30:56.243 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Packet Sent (MsgType: 0, Size: 368 Bytes). Tue May 19 22:30:56.556 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Packet Received (MsgType:110, Size: 154 Bytes). Tue May 19 22:30:56.556 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:56.556 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 0: 10081315: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:56.556 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081315: Using session identifier [1:10081315] Tue May 19 22:30:56.556 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081315: ArAuthFrameworkImpl::doPreAuth::1:10081315:: Authentication mechanism returned [0] for AuthIdentity [00826007;ARCARD] Tue May 19 22:30:56.556 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081315: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:30:56.556 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081315: ArAuthFrameworkImpl::doAuth::1:10081315:: Authentication mechanism returned [1] for AuthIdentity [00826007;ARCARD] Tue May 19 22:30:56.556 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081315: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:30:56.556 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081315: ArAuthFrameworkImpl::doPostAuth::1:10081315:: Authentication mechanism returned [1] for AuthIdentity [00826007] Tue May 19 22:30:56.587 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 10081315: Sending Continue with challenge Tue May 19 22:30:56.587 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 61: 10081315: Packet being sent Tue May 19 22:30:56.587 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Packet Sent (MsgType:110, Size: 1564 Bytes). Tue May 19 22:30:56.587 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Packet Received (MsgType:109, Size: 1430 Bytes). Tue May 19 22:30:56.587 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:56.587 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 0: 10081316: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:56.587 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081316: Using session identifier [1:10081316] Tue May 19 22:30:56.587 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081316: ArAuthFrameworkImpl::doPreAuth::1:10081316:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:30:56.587 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081316: Arcot Native Server: recvd AA_BIN_MSG_VER_CHG Tue May 19 22:30:56.587 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081316: Cert Subject String....:[CN=00826007;O=MLS; UserID=00826007; CardName=ARCARD] Tue May 19 22:30:56.587 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081316: Cert issuer............:[CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US] Tue May 19 22:30:56.587 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081316: Cert serial String.....:[f741] Tue May 19 22:30:56.587 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081316: ArcotId Certificate received with signature have ArcotExtension. Cert issuer=CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US, serial=f741 and subject=CN=00826007;O=MLS Tue May 19 22:30:56.587 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081316: ArcotID Auth SUCCESS (serial Number [f741]) Tue May 19 22:30:56.587 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081316: Session tracker Id associated with verify signed challenge[1:10081312] Tue May 19 22:30:56.587 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081316: ArAuthFrameworkImpl::doAuth::1:10081312:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:30:56.587 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081316: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:30:56.587 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081316: Handle_NSPAdvice::NSP Action :[NSP_RESET] Tue May 19 22:30:56.587 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081316: NSP Update Query is based on Serial Number Tue May 19 22:30:56.602 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081316: ArAuthFrameworkImpl::doPostAuth::1:10081312:: Authentication mechanism returned [0] for AuthIdentity [00826007] Tue May 19 22:30:56.618 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 10081316: Prepared to Send OK Tue May 19 22:30:56.618 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 61: 10081316: Packet being sent Tue May 19 22:30:56.618 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Packet Sent (MsgType:109, Size: 256 Bytes). Tue May 19 22:30:57.665 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Packet Received (MsgType:110, Size: 100 Bytes). Tue May 19 22:30:57.665 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:57.665 2009 Morocco Standard Time INFO: pid 2172 tid 688: 0: 10081317: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:57.665 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081317: Using session identifier [1:10081317] Tue May 19 22:30:57.665 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081317: ArAuthFrameworkImpl::doPreAuth::1:10081317:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:30:57.665 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081317: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:30:57.665 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081317: Session tracker Id associated with generate challenge[1:10081317] Tue May 19 22:30:57.665 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081317: ArAuthFrameworkImpl::doAuth::1:10081317:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:30:57.665 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081317: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:30:57.665 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081317: ArAuthFrameworkImpl::doPostAuth::1:10081317:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:30:57.681 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 10081317: Sending Continue with challenge Tue May 19 22:30:57.681 2009 Morocco Standard Time INFO: pid 2172 tid 688: 61: 10081317: Packet being sent Tue May 19 22:30:57.681 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Packet Sent (MsgType:110, Size: 176 Bytes). Tue May 19 22:30:58.384 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Packet Received (MsgType:110, Size: 100 Bytes). Tue May 19 22:30:58.384 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:58.384 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 0: 10081318: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:58.384 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081318: Using session identifier [1:10081318] Tue May 19 22:30:58.384 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081318: ArAuthFrameworkImpl::doPreAuth::1:10081318:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:30:58.384 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081318: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:30:58.384 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081318: Session tracker Id associated with generate challenge[1:10081318] Tue May 19 22:30:58.384 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081318: ArAuthFrameworkImpl::doAuth::1:10081318:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:30:58.384 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081318: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:30:58.384 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081318: ArAuthFrameworkImpl::doPostAuth::1:10081318:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:30:58.399 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 10081318: Sending Continue with challenge Tue May 19 22:30:58.399 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 61: 10081318: Packet being sent Tue May 19 22:30:58.399 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Packet Sent (MsgType:110, Size: 176 Bytes). Tue May 19 22:30:58.415 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Packet Received (MsgType:110, Size: 154 Bytes). Tue May 19 22:30:58.415 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:58.415 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 0: 10081319: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:58.415 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081319: Using session identifier [1:10081319] Tue May 19 22:30:58.415 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081319: ArAuthFrameworkImpl::doPreAuth::1:10081319:: Authentication mechanism returned [0] for AuthIdentity [00605724;ARCARD] Tue May 19 22:30:58.415 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081319: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:30:58.431 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081319: ArAuthFrameworkImpl::doAuth::1:10081319:: Authentication mechanism returned [1] for AuthIdentity [00605724;ARCARD] Tue May 19 22:30:58.431 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 170: 10081319: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:30:58.431 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 17: 10081319: ArAuthFrameworkImpl::doPostAuth::1:10081319:: Authentication mechanism returned [1] for AuthIdentity [00605724] Tue May 19 22:30:58.431 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 10081319: Sending Continue with challenge Tue May 19 22:30:58.431 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 61: 10081319: Packet being sent Tue May 19 22:30:58.431 2009 Morocco Standard Time INFO: pid 2172 tid 3124: 60: 0: Packet Sent (MsgType:110, Size: 1564 Bytes). Tue May 19 22:30:58.446 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Packet Received (MsgType:109, Size: 1430 Bytes). Tue May 19 22:30:58.446 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:58.446 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 0: 10081320: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:58.446 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081320: Using session identifier [1:10081320] Tue May 19 22:30:58.446 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081320: ArAuthFrameworkImpl::doPreAuth::1:10081320:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:30:58.446 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081320: Arcot Native Server: recvd AA_BIN_MSG_VER_CHG Tue May 19 22:30:58.446 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081320: Cert Subject String....:[CN=00605724;O=MLS; UserID=00605724; CardName=ARCARD] Tue May 19 22:30:58.446 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081320: Cert issuer............:[CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US] Tue May 19 22:30:58.446 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081320: Cert serial String.....:[ee1e] Tue May 19 22:30:58.446 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081320: ArcotId Certificate received with signature have ArcotExtension. Cert issuer=CN=aok.arcot.com;OU=ArcotSecureServices;O=Arcot Systems Inc.;L=Sunnyvale;ST=California;C=US, serial=ee1e and subject=CN=00605724;O=MLS Tue May 19 22:30:58.446 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081320: ArcotID Auth SUCCESS (serial Number [ee1e]) Tue May 19 22:30:58.446 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081320: Session tracker Id associated with verify signed challenge[1:10081317] Tue May 19 22:30:58.446 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081320: ArAuthFrameworkImpl::doAuth::1:10081317:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:30:58.446 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081320: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:30:58.446 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081320: Handle_NSPAdvice::NSP Action :[NSP_RESET] Tue May 19 22:30:58.446 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 170: 10081320: NSP Update Query is based on Serial Number Tue May 19 22:30:58.462 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 17: 10081320: ArAuthFrameworkImpl::doPostAuth::1:10081317:: Authentication mechanism returned [0] for AuthIdentity [00605724] Tue May 19 22:30:58.477 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 10081320: Prepared to Send OK Tue May 19 22:30:58.477 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 61: 10081320: Packet being sent Tue May 19 22:30:58.477 2009 Morocco Standard Time INFO: pid 2172 tid 3412: 60: 0: Packet Sent (MsgType:109, Size: 256 Bytes). Tue May 19 22:30:58.806 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Packet Received (MsgType:110, Size: 100 Bytes). Tue May 19 22:30:58.806 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:58.806 2009 Morocco Standard Time INFO: pid 2172 tid 688: 0: 10081321: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:58.806 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081321: Using session identifier [1:10081321] Tue May 19 22:30:58.806 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081321: ArAuthFrameworkImpl::doPreAuth::1:10081321:: Authentication mechanism returned [0] for AuthIdentity [] Tue May 19 22:30:58.806 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081321: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:30:58.806 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081321: Session tracker Id associated with generate challenge[1:10081321] Tue May 19 22:30:58.806 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081321: ArAuthFrameworkImpl::doAuth::1:10081321:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:30:58.806 2009 Morocco Standard Time INFO: pid 2172 tid 688: 170: 10081321: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:30:58.806 2009 Morocco Standard Time INFO: pid 2172 tid 688: 17: 10081321: ArAuthFrameworkImpl::doPostAuth::1:10081321:: Authentication mechanism returned [1] for AuthIdentity [] Tue May 19 22:30:58.821 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 10081321: Sending Continue with challenge Tue May 19 22:30:58.821 2009 Morocco Standard Time INFO: pid 2172 tid 688: 61: 10081321: Packet being sent Tue May 19 22:30:58.821 2009 Morocco Standard Time INFO: pid 2172 tid 688: 60: 0: Packet Sent (MsgType:110, Size: 176 Bytes). Tue May 19 22:30:59.071 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Packet Received (MsgType:110, Size: 154 Bytes). Tue May 19 22:30:59.071 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 60: 0: Locale Name[en], Locale ID[1] Tue May 19 22:30:59.071 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 0: 10081322: Message: ArAuthBinaryAuthRequestMgr::setSecurityInfo: security_info_offset [0] is invalid. Assuming security info not available. Tue May 19 22:30:59.071 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081322: Using session identifier [1:10081322] Tue May 19 22:30:59.071 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081322: ArAuthFrameworkImpl::doPreAuth::1:10081322:: Authentication mechanism returned [0] for AuthIdentity [01739549;ARCARD] Tue May 19 22:30:59.071 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081322: Arcot Native Server: recvd AA_BIN_MSG_GET_WLT Tue May 19 22:30:59.071 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081322: ArAuthFrameworkImpl::doAuth::1:10081322:: Authentication mechanism returned [1] for AuthIdentity [01739549;ARCARD] Tue May 19 22:30:59.071 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 170: 10081322: Handle_NSPAdvice:: Handling NSPAdvice for mechanism [4] Tue May 19 22:30:59.071 2009 Morocco Standard Time INFO: pid 2172 tid 3352: 17: 10081322: ArAuthFrameworkImpl::doPostAuth::1:10081322:: Authentication mechanism returned [1] for AuthIdentity [01739549] Tue May 19 22:30:59.087 2009 Morocco Standard Time INFO: