2015-02-13 14:18:05,660 DEBUG [Thread-54] changenotify.ChangeNotificationQueue - Waiting for 60 seconds or until interrupted
2015-02-13 14:19:05,661 DEBUG [Thread-54] changenotify.ChangeNotificationQueue - Woke up after 60 seconds or notified to wake up.
2015-02-13 14:19:05,662 DEBUG [Thread-54] changenotify.ChangeNotificationQueue - Waiting for 60 seconds or until interrupted
2015-02-13 14:20:05,662 DEBUG [Thread-54] changenotify.ChangeNotificationQueue - Woke up after 60 seconds or notified to wake up.
2015-02-13 14:20:05,662 DEBUG [Thread-54] changenotify.ChangeNotificationQueue - Waiting for 60 seconds or until interrupted
2015-02-13 14:21:05,663 DEBUG [Thread-54] changenotify.ChangeNotificationQueue - Woke up after 60 seconds or notified to wake up.
2015-02-13 14:21:05,663 DEBUG [Thread-54] changenotify.ChangeNotificationQueue - Waiting for 60 seconds or until interrupted
2015-02-13 14:22:05,663 DEBUG [Thread-54] changenotify.ChangeNotificationQueue - Woke up after 60 seconds or notified to wake up.
2015-02-13 14:22:05,664 DEBUG [Thread-54] changenotify.ChangeNotificationQueue - Waiting for 60 seconds or until interrupted
2015-02-13 14:23:05,664 DEBUG [Thread-54] changenotify.ChangeNotificationQueue - Woke up after 60 seconds or notified to wake up.
2015-02-13 14:23:05,664 DEBUG [Thread-54] changenotify.ChangeNotificationQueue - Waiting for 60 seconds or until interrupted
2015-02-13 14:24:05,665 DEBUG [Thread-54] changenotify.ChangeNotificationQueue - Woke up after 60 seconds or notified to wake up.
2015-02-13 14:24:05,665 DEBUG [Thread-54] changenotify.ChangeNotificationQueue - Waiting for 60 seconds or until interrupted
2015-02-13 14:25:05,665 DEBUG [Thread-54] changenotify.ChangeNotificationQueue - Woke up after 60 seconds or notified to wake up.
2015-02-13 14:25:05,666 DEBUG [Thread-54] changenotify.ChangeNotificationQueue - Waiting for 60 seconds or until interrupted
2015-02-13 14:26:05,666 DEBUG [Thread-54] changenotify.ChangeNotificationQueue - Woke up after 60 seconds or notified to wake up.
2015-02-13 14:26:05,666 DEBUG [Thread-54] changenotify.ChangeNotificationQueue - Waiting for 60 seconds or until interrupted
2015-02-13 14:27:05,667 DEBUG [Thread-54] changenotify.ChangeNotificationQueue - Woke up after 60 seconds or notified to wake up.
2015-02-13 14:27:05,667 DEBUG [Thread-54] changenotify.ChangeNotificationQueue - Waiting for 60 seconds or until interrupted
2015-02-13 14:27:43,650 INFO [http-bio-443-exec-19] soap.SoapServlet - SOAP request URI: /EPASSoap/service/v80
2015-02-13 14:27:43,650 DEBUG [http-bio-443-exec-19] soap.SoapServlet - Service version requested: v80
2015-02-13 14:27:43,651 DEBUG [http-bio-443-exec-19] soap.SoapServlet - Incoming Request
kim617408...
2015-02-13 14:27:43,654 DEBUG [http-bio-443-exec-19] ext.SoapRequestParserExt - Parsing SOAP request securely with a SecurityManager set
2015-02-13 14:27:43,655 INFO [http-bio-443-exec-19] soap.SoapServlet - SOAP request for: login, version: v80
2015-02-13 14:27:43,655 DEBUG [http-bio-443-exec-19] storage.SessionInfo - New SessionInfo createdSessionInfo [userPkid=null, sessionId=null, clientVersion=10.5.2.45439]
2015-02-13 14:27:43,655 INFO [http-bio-443-exec-19] handlers.LoginHandler - process:Created session info for userid:kim617408| cType:CUPC| client-version: 10.5.2.45439 |force:true | auth-type:USERNAME_PASSWORD
2015-02-13 14:27:43,656 DEBUG [http-bio-443-exec-19] handlers.LoginHandlerAbstract - prelogin:localHostName=ISCUPS01| hostAddr:192.168.200.3 | hostFQDNISCUPS01.insunginfo.co.kr
2015-02-13 14:27:43,656 INFO [http-bio-443-exec-19] handlers.LoginHandlerAbstract - prelogin:queryString=EXECUTE PROCEDURE ucSOAPPreLogin('kim617408','ISCUPS01','192.168.200.3','ISCUPS01.insunginfo.co.kr');
2015-02-13 14:27:43,656 DEBUG [http-bio-443-exec-19] imdb.ImdbGeneralAccessorUtil - getValidAppusersResultset -- query: SELECT * FROM validappusers WHERE userid='kim617408';
2015-02-13 14:27:43,673 DEBUG [http-bio-443-exec-19] handlers.LoginHandlerAbstract - process:Session is created for an end user client-type
2015-02-13 14:27:43,673 INFO [http-bio-443-exec-19] handlers.LoginHandlerAbstract - process:Client requires version check, minVersion is :7.1.0.0
2015-02-13 14:27:43,673 DEBUG [http-bio-443-exec-19] handlers.LoginHandlerAbstract - process:Client has valid version, proceeding to Login.
2015-02-13 14:27:43,674 INFO [http-bio-443-exec-19] handlers.LoginHandlerAbstract - process:PRELOGIN reasoncode=SUCCESS
2015-02-13 14:27:43,674 DEBUG [http-bio-443-exec-19] handlers.LoginHandlerNonSSO - getNextAction: Next action:LOGIN
2015-02-13 14:27:43,674 DEBUG [http-bio-443-exec-19] handlers.LoginHandlerAbstract - doLogin:kim617408:true:cupc
2015-02-13 14:27:43,674 DEBUG [http-bio-443-exec-19] handlers.LoginHandlerNonSSO - Authenticate using IMS
2015-02-13 14:27:43,674 DEBUG [http-bio-443-exec-19] handlers.LoginHandlerNonSSO - doLogin:Added credentials
2015-02-13 14:27:43,674 DEBUG [http-bio-443-exec-19] handlers.LoginHandlerNonSSO - doLogin:Create IMS instance=com.cisco.security.ims.impl.IMSImpl@226330
2015-02-13 14:27:43,686 DEBUG [http-bio-443-exec-19] handlers.LoginHandlerNonSSO - doLogin:Created Authentication instance=com.cisco.security.ims.authentication.AuthenticationImpl@eb790a
2015-02-13 14:27:43,755 INFO [http-bio-443-exec-19] handlers.LoginHandlerNonSSO - doLogin:IMS login result is success for kim617408| IMS result code:0
2015-02-13 14:27:43,755 DEBUG [http-bio-443-exec-19] imdb.ImdbLoginAccessorUtil - Attempt ucSoapLogin for user=kim617408
2015-02-13 14:27:43,756 DEBUG [http-bio-443-exec-19] imdb.ImdbGeneralAccessorUtil - getValidEndusersResultset -- query: SELECT * FROM validendusers WHERE userid='kim617408';
2015-02-13 14:27:43,757 DEBUG [http-bio-443-exec-19] imdb.ImdbGeneralAccessorUtil - getValidEndusersResultset -- User found in validenduser table= true
2015-02-13 14:27:43,757 DEBUG [http-bio-443-exec-19] imdb.ImdbLoginAccessorUtil - valUser:ENDUSER FOUND in imdb
2015-02-13 14:27:43,757 DEBUG [http-bio-443-exec-19] imdb.ImdbLoginAccessorUtil - User is an End user, type=cupc
2015-02-13 14:27:43,757 DEBUG [http-bio-443-exec-19] imdb.ImdbLoginAccessorUtil - Check Sessions for pkid=228e64f0-7794-dff2-1634-db3959510b65
2015-02-13 14:27:43,757 DEBUG [http-bio-443-exec-19] imdb.ImdbGeneralAccessorUtil - getClientsessionResultSet -- Query=SELECT * FROM clientsessions WHERE fkIdsUser='228e64f0-7794-dff2-1634-db3959510b65' AND clienttype=1;
2015-02-13 14:27:43,758 DEBUG [http-bio-443-exec-19] imdb.ImdbLoginAccessorUtil - ucSoapAppLogin:qry:Existing session found:68d76356-51a2-7e01-d453-2eeb8e1d58b8
2015-02-13 14:27:43,759 DEBUG [http-bio-443-exec-19] imdb.ImdbLoginAccessorUtil - ucSoapLogin:updSession=UPDATE clientsessions SET sessionid ='17e7f2d9-db88-ec4e-4205-097a077b9b69', clientversion='10.5.2.45439' WHERE sessionid='68d76356-51a2-7e01-d453-2eeb8e1d58b8';
2015-02-13 14:27:43,770 DEBUG [http-bio-443-exec-19] imdb.ImdbLoginAccessorUtil - updSession session succeeded for userid:kim617408
2015-02-13 14:27:43,770 DEBUG [http-bio-443-exec-19] imdb.ImdbLoginAccessorUtil - ucSoapLogin:delAppSess=DELETE FROM clientsessions WHERE parentsession='68d76356-51a2-7e01-d453-2eeb8e1d58b8';
2015-02-13 14:27:43,771 DEBUG [http-bio-443-exec-19] imdb.ImdbGeneralAccessorUtil - exeuteDelete --Delete failed or no data found to delete: DELETE FROM clientsessions WHERE parentsession='68d76356-51a2-7e01-d453-2eeb8e1d58b8';
2015-02-13 14:27:43,771 DEBUG [http-bio-443-exec-19] imdb.ImdbLoginAccessorUtil - No Parent Sessions removed for pkid:228e64f0-7794-dff2-1634-db3959510b65
2015-02-13 14:27:43,772 INFO [http-bio-443-exec-19] handlers.LoginHandlerAbstract - SOAP Login was successful
2015-02-13 14:27:43,772 INFO [http-bio-443-exec-19] handlers.LoginHandlerAbstract - doLogin:IMDB check completed & session created for user:kim617408. SessionKey is: 17e7f2d9-db88-ec4e-4205-097a077b9b69
2015-02-13 14:27:43,839 INFO [http-bio-443-exec-14] soap.SoapServlet - SOAP request URI: /EPASSoap/service/v80
2015-02-13 14:27:43,839 DEBUG [http-bio-443-exec-14] soap.SoapServlet - Service version requested: v80
2015-02-13 14:27:43,840 DEBUG [http-bio-443-exec-14] soap.SoapServlet - Incoming Request
17e7f2d9-db88-ec4e-4205-097a077b9b69
2015-02-13 14:27:43,842 DEBUG [http-bio-443-exec-14] ext.SoapRequestParserExt - Parsing SOAP request securely with a SecurityManager set
2015-02-13 14:27:43,844 INFO [http-bio-443-exec-14] soap.SoapServlet - SOAP request for: get-all-config, version: v80
2015-02-13 14:27:43,844 DEBUG [http-bio-443-exec-14] imdb.ImdbGeneralAccessorUtil - getClientsessionResultSet -- Query=SELECT * FROM clientsessions WHERE sessionid='17e7f2d9-db88-ec4e-4205-097a077b9b69';
2015-02-13 14:27:43,845 DEBUG [http-bio-443-exec-14] handlers.GetAllConfigHandler - - writeResponseForUser
2015-02-13 14:27:43,845 DEBUG [http-bio-443-exec-14] handlers.GetAllConfigHandler - Get-All-Config Handler
2015-02-13 14:27:43,846 DEBUG [http-bio-443-exec-14] handlers.GetAllConfigHandler - Processing node:system-config
2015-02-13 14:27:43,846 DEBUG [http-bio-443-exec-14] handlers.GetSystemConfigHandler - : writeResponseForUser
2015-02-13 14:27:43,846 DEBUG [http-bio-443-exec-14] handlers.GetSystemConfigHandler - :writeResponseForUser -- Writing response for version:v80
2015-02-13 14:27:43,879 DEBUG [http-bio-443-exec-14] handlers.GetSystemConfigHandler - : ProcessServiceXML-- attrName:UCServiceProfileDetailXML.Mailstore.xml: attrVAlue:INBOXDeleted Items60true
2015-02-13 14:27:43,886 DEBUG [http-bio-443-exec-14] handlers.GetSystemConfigHandler - ResultMap:{pollinginterval=60, inbox=INBOX, trashfolder=Deleted Items, isdualfolder=true}
2015-02-13 14:27:43,886 DEBUG [http-bio-443-exec-14] handlers.GetSystemConfigHandler - : fillNonExistingKeys -- Checking if ResultMap has non existing keys, if not filling them.
2015-02-13 14:27:43,895 DEBUG [http-bio-443-exec-14] handlers.GetSystemConfigHandler - : ProcessServiceXML-- attrName:UCServiceProfileDetailXML.Directory.xml: attrVAlue:truetruetrue5
2015-02-13 14:27:43,898 DEBUG [http-bio-443-exec-14] handlers.GetSystemConfigHandler - ResultMap:{searchcontext3=null, useuds=true, searchcontext2=null, useusercredential=true, searchcontext1=null, basefilter=null, dn=null, configurationname=null, password=null, searchtimeout=5, recursivesearch1=true, predictivesearchfilter=null}
2015-02-13 14:27:43,898 DEBUG [http-bio-443-exec-14] handlers.GetSystemConfigHandler - : fillNonExistingKeys -- Checking if ResultMap has non existing keys, if not filling them.
2015-02-13 14:27:43,898 DEBUG [http-bio-443-exec-14] handlers.GetSystemConfigHandler - : fillNonExistingKeys -- filling key: recursivesearch3 to buffer
2015-02-13 14:27:43,898 DEBUG [http-bio-443-exec-14] handlers.GetSystemConfigHandler - : fillNonExistingKeys -- filling key: recursivesearch2 to buffer
2015-02-13 14:27:43,900 DEBUG [http-bio-443-exec-14] handlers.GetSystemConfigHandler - : writeResponseForUser_legacy: MeetingPlace: attrName:'MeetingPlace.Primary.ServerType',old attrValue:'null': newAttrvalue:'null'
2015-02-13 14:27:43,903 DEBUG [http-bio-443-exec-14] handlers.GetSystemConfigHandler - : writeResponseForUser_legacy: MeetingPlace: attrName:'MeetingPlace.Backup1.ServerType',old attrValue:'null': newAttrvalue:'null'
2015-02-13 14:27:43,904 DEBUG [http-bio-443-exec-14] handlers.GetSystemConfigHandler - : writeResponseForUser_legacy: MeetingPlace: attrName:'MeetingPlace.Backup2.ServerType',old attrValue:'null': newAttrvalue:'null'
2015-02-13 14:27:43,905 DEBUG [http-bio-443-exec-14] handlers.GetSystemConfigHandler - : writeResponseForUser_legacy: MeetingPlace: attrName:'MeetingPlace.CertLevel',old attrValue:'CERT_VERIFICATION_LEVEL_ANY_CERT': newAttrvalue:'ANY_CERT'
2015-02-13 14:27:43,922 DEBUG [http-bio-443-exec-14] handlers.GetSystemConfigHandler - : ProcessServiceXML-- attrName:UCServiceProfileDetailXML.Credential.xml: attrVAlue:12
2015-02-13 14:27:43,926 DEBUG [http-bio-443-exec-14] handlers.GetSystemConfigHandler - ResultMap:{webconfservicecredentialssource=2, voicemailservicecredentialssource=1}
2015-02-13 14:27:43,927 DEBUG [http-bio-443-exec-14] handlers.GetSystemConfigHandler - : fillNonExistingKeys -- Checking if ResultMap has non existing keys, if not filling them.
2015-02-13 14:27:43,927 DEBUG [http-bio-443-exec-14] handlers.GetSystemConfigHandler - updateVoicemailOrWebConfRresultMap: key=[webconfservicecredentialssource], origValue=[2] updatedvalue=[CUP]
2015-02-13 14:27:43,927 DEBUG [http-bio-443-exec-14] handlers.GetSystemConfigHandler - updateVoicemailOrWebConfRresultMap: key=[voicemailservicecredentialssource], origValue=[1] updatedvalue=[NOT_SET]
2015-02-13 14:27:43,940 DEBUG [http-bio-443-exec-14] handlers.GetAllConfigHandler - Processing node:user-config
2015-02-13 14:27:43,940 DEBUG [http-bio-443-exec-14] handlers.GetUserConfigHandler - - writeResponseForUser
2015-02-13 14:27:43,940 INFO [http-bio-443-exec-14] handlers.GetUserConfigHandler - get-user-config Query:EXECUTE PROCEDURE ucSOAPGetUserConfig('228e64f0-7794-dff2-1634-db3959510b65', 8);
2015-02-13 14:27:43,945 DEBUG [http-bio-443-exec-14] handlers.GetAllConfigHandler - Processing node:contact-info
2015-02-13 14:27:43,945 DEBUG [http-bio-443-exec-14] handlers.GetContactInfoHandler - - writeResponseForUser
2015-02-13 14:27:43,945 INFO [http-bio-443-exec-14] handlers.GetContactInfoHandler - About to execute query [EXECUTE PROCEDURE getAllContactInfo('228e64f0-7794-dff2-1634-db3959510b65');]
2015-02-13 14:27:44,028 INFO [http-bio-443-exec-12] soap.SoapServlet - SOAP request URI: /EPASSoap/service/v105
2015-02-13 14:27:44,029 DEBUG [http-bio-443-exec-12] soap.SoapServlet - Service version requested: v105
2015-02-13 14:27:44,029 DEBUG [http-bio-443-exec-12] soap.SoapServlet - Incoming Request
17e7f2d9-db88-ec4e-4205-097a077b9b69
2015-02-13 14:27:44,032 DEBUG [http-bio-443-exec-12] ext.SoapRequestParserExt - Parsing SOAP request securely with a SecurityManager set
2015-02-13 14:27:44,033 INFO [http-bio-443-exec-12] soap.SoapServlet - SOAP request for: get-im-domains, version: v105
2015-02-13 14:27:44,034 DEBUG [http-bio-443-exec-12] imdb.ImdbGeneralAccessorUtil - getClientsessionResultSet -- Query=SELECT * FROM clientsessions WHERE sessionid='17e7f2d9-db88-ec4e-4205-097a077b9b69';
2015-02-13 14:27:44,035 DEBUG [http-bio-443-exec-12] handlers.GetIMDomainsHandler - - writeResponseForUser
2015-02-13 14:27:44,108 INFO [http-bio-443-exec-11] soap.SoapServlet - SOAP request URI: /EPASSoap/service/v100
2015-02-13 14:27:44,108 DEBUG [http-bio-443-exec-11] soap.SoapServlet - Service version requested: v100
2015-02-13 14:27:44,147 DEBUG [http-bio-443-exec-11] soap.SoapServlet - Incoming Request
17e7f2d9-db88-ec4e-4205-097a077b9b69
2015-02-13 14:27:44,150 DEBUG [http-bio-443-exec-11] ext.SoapRequestParserExt - Parsing SOAP request securely with a SecurityManager set
2015-02-13 14:27:44,152 INFO [http-bio-443-exec-11] soap.SoapServlet - SOAP request for: get-user-config, version: v100
2015-02-13 14:27:44,152 DEBUG [http-bio-443-exec-11] imdb.ImdbGeneralAccessorUtil - getClientsessionResultSet -- Query=SELECT * FROM clientsessions WHERE sessionid='17e7f2d9-db88-ec4e-4205-097a077b9b69';
2015-02-13 14:27:44,155 DEBUG [http-bio-443-exec-11] handlers.GetUserConfigHandler - - writeResponseForUser
2015-02-13 14:27:44,155 INFO [http-bio-443-exec-11] handlers.GetUserConfigHandler - get-user-config Query:EXECUTE PROCEDURE ucSOAPGetUserConfig('228e64f0-7794-dff2-1634-db3959510b65', 10);
2015-02-13 14:27:44,227 INFO [http-bio-443-exec-16] soap.SoapServlet - SOAP request URI: /EPASSoap/service/v80
2015-02-13 14:27:44,227 DEBUG [http-bio-443-exec-16] soap.SoapServlet - Service version requested: v80
2015-02-13 14:27:44,266 DEBUG [http-bio-443-exec-16] soap.SoapServlet - Incoming Request
17e7f2d9-db88-ec4e-4205-097a077b9b69
2015-02-13 14:27:44,270 DEBUG [http-bio-443-exec-16] ext.SoapRequestParserExt - Parsing SOAP request securely with a SecurityManager set
2015-02-13 14:27:44,272 INFO [http-bio-443-exec-16] soap.SoapServlet - SOAP request for: get-onetime-password, version: v80
2015-02-13 14:27:44,272 DEBUG [http-bio-443-exec-16] imdb.ImdbGeneralAccessorUtil - getClientsessionResultSet -- Query=SELECT * FROM clientsessions WHERE sessionid='17e7f2d9-db88-ec4e-4205-097a077b9b69';
2015-02-13 14:27:44,274 DEBUG [http-bio-443-exec-16] imdb.ImdbGeneralAccessorUtil - getClientsessionResultSet -- Query=SELECT * FROM clientsessions WHERE sessionid='17e7f2d9-db88-ec4e-4205-097a077b9b69';
2015-02-13 14:27:44,275 DEBUG [http-bio-443-exec-16] imdb.ImdbGeneralAccessorUtil - getValidEndusersResultset -- query: SELECT * FROM validendusers WHERE fkEndUser='228e64f0-7794-dff2-1634-db3959510b65';
2015-02-13 14:27:44,276 DEBUG [http-bio-443-exec-16] imdb.ImdbGeneralAccessorUtil - getValidEndusersResultset -- User found in validenduser table= true
2015-02-13 14:27:44,276 DEBUG [http-bio-443-exec-16] imdb.ImdbGeneralAccessorUtil - getUserIdBySessionId -- userid: kim617408
2015-02-13 14:27:44,276 DEBUG [http-bio-443-exec-16] imdb.ImdbGeneralAccessorUtil - getOneTimePassword --User userid=kim617408
2015-02-13 14:27:44,276 DEBUG [http-bio-443-exec-16] imdb.ImdbGeneralAccessorUtil - getOnetimepasswordResultSet -- qry=SELECT * FROM onetimepassword WHERE userid='kim617408';
2015-02-13 14:27:44,277 DEBUG [http-bio-443-exec-16] imdb.ImdbGeneralAccessorUtil - getOnetimepasswordResultSet -- User data either not found or exceeded maxcount in onetimepassword
2015-02-13 14:27:44,277 DEBUG [http-bio-443-exec-16] imdb.ImdbGeneralAccessorUtil - getOneTimePassword -- insert: INSERT INTO oneTimePassword (userid,password,tmstamp) VALUES ('kim617408','2518757','1423805264277');
2015-02-13 14:27:44,278 DEBUG [http-bio-443-exec-16] imdb.ImdbGeneralAccessorUtil - getOneTimePassword -- For sesssionID=17e7f2d9-db88-ec4e-4205-097a077b9b69 and userid=kim617408, password and time stamp inserted.
2015-02-13 14:27:44,278 INFO [http-bio-443-exec-16] handlers.GetOneTimePasswordHandler - GetOneTimePasswordHandler: successful
2015-02-13 14:27:44,278 INFO [http-bio-443-exec-16] handlers.GetOneTimePasswordHandler - GetOneTimePasswordHandler: Returning response for get-onetime-password
2015-02-13 14:27:45,676 INFO [http-bio-443-exec-25] soap.SoapServlet - SOAP request URI: /EPASSoap/service/v80
2015-02-13 14:27:45,677 DEBUG [http-bio-443-exec-25] soap.SoapServlet - Service version requested: v80
2015-02-13 14:27:45,677 DEBUG [http-bio-443-exec-25] soap.SoapServlet - Incoming Request
17e7f2d9-db88-ec4e-4205-097a077b9b69
2015-02-13 14:27:45,679 DEBUG [http-bio-443-exec-25] ext.SoapRequestParserExt - Parsing SOAP request securely with a SecurityManager set
2015-02-13 14:27:45,680 INFO [http-bio-443-exec-25] soap.SoapServlet - SOAP request for: get-all-config, version: v80
2015-02-13 14:27:45,680 DEBUG [http-bio-443-exec-25] imdb.ImdbGeneralAccessorUtil - getClientsessionResultSet -- Query=SELECT * FROM clientsessions WHERE sessionid='17e7f2d9-db88-ec4e-4205-097a077b9b69';
2015-02-13 14:27:45,681 DEBUG [http-bio-443-exec-25] handlers.GetAllConfigHandler - - writeResponseForUser
2015-02-13 14:27:45,682 DEBUG [http-bio-443-exec-25] handlers.GetAllConfigHandler - Get-All-Config Handler
2015-02-13 14:27:45,682 DEBUG [http-bio-443-exec-25] handlers.GetAllConfigHandler - Processing node:system-config
2015-02-13 14:27:45,682 DEBUG [http-bio-443-exec-25] handlers.GetSystemConfigHandler - : writeResponseForUser
2015-02-13 14:27:45,682 DEBUG [http-bio-443-exec-25] handlers.GetSystemConfigHandler - :writeResponseForUser -- Writing response for version:v80
2015-02-13 14:27:45,693 DEBUG [http-bio-443-exec-25] handlers.GetSystemConfigHandler - : ProcessServiceXML-- attrName:UCServiceProfileDetailXML.Mailstore.xml: attrVAlue:INBOXDeleted Items60true
2015-02-13 14:27:45,697 DEBUG [http-bio-443-exec-25] handlers.GetSystemConfigHandler - ResultMap:{pollinginterval=60, inbox=INBOX, trashfolder=Deleted Items, isdualfolder=true}
2015-02-13 14:27:45,697 DEBUG [http-bio-443-exec-25] handlers.GetSystemConfigHandler - : fillNonExistingKeys -- Checking if ResultMap has non existing keys, if not filling them.
2015-02-13 14:27:45,702 DEBUG [http-bio-443-exec-25] handlers.GetSystemConfigHandler - : ProcessServiceXML-- attrName:UCServiceProfileDetailXML.Directory.xml: attrVAlue:truetruetrue5
2015-02-13 14:27:45,705 DEBUG [http-bio-443-exec-25] handlers.GetSystemConfigHandler - ResultMap:{searchcontext3=null, useuds=true, searchcontext2=null, useusercredential=true, searchcontext1=null, basefilter=null, dn=null, configurationname=null, password=null, searchtimeout=5, recursivesearch1=true, predictivesearchfilter=null}
2015-02-13 14:27:45,705 DEBUG [http-bio-443-exec-25] handlers.GetSystemConfigHandler - : fillNonExistingKeys -- Checking if ResultMap has non existing keys, if not filling them.
2015-02-13 14:27:45,706 DEBUG [http-bio-443-exec-25] handlers.GetSystemConfigHandler - : fillNonExistingKeys -- filling key: recursivesearch3 to buffer
2015-02-13 14:27:45,706 DEBUG [http-bio-443-exec-25] handlers.GetSystemConfigHandler - : fillNonExistingKeys -- filling key: recursivesearch2 to buffer
2015-02-13 14:27:45,707 DEBUG [http-bio-443-exec-25] handlers.GetSystemConfigHandler - : writeResponseForUser_legacy: MeetingPlace: attrName:'MeetingPlace.Primary.ServerType',old attrValue:'null': newAttrvalue:'null'
2015-02-13 14:27:45,708 DEBUG [http-bio-443-exec-25] handlers.GetSystemConfigHandler - : writeResponseForUser_legacy: MeetingPlace: attrName:'MeetingPlace.Backup1.ServerType',old attrValue:'null': newAttrvalue:'null'
2015-02-13 14:27:45,708 DEBUG [http-bio-443-exec-25] handlers.GetSystemConfigHandler - : writeResponseForUser_legacy: MeetingPlace: attrName:'MeetingPlace.Backup2.ServerType',old attrValue:'null': newAttrvalue:'null'
2015-02-13 14:27:45,709 DEBUG [http-bio-443-exec-25] handlers.GetSystemConfigHandler - : writeResponseForUser_legacy: MeetingPlace: attrName:'MeetingPlace.CertLevel',old attrValue:'CERT_VERIFICATION_LEVEL_ANY_CERT': newAttrvalue:'ANY_CERT'
2015-02-13 14:27:45,717 DEBUG [http-bio-443-exec-25] handlers.GetSystemConfigHandler - : ProcessServiceXML-- attrName:UCServiceProfileDetailXML.Credential.xml: attrVAlue:12
2015-02-13 14:27:45,721 DEBUG [http-bio-443-exec-25] handlers.GetSystemConfigHandler - ResultMap:{webconfservicecredentialssource=2, voicemailservicecredentialssource=1}
2015-02-13 14:27:45,721 DEBUG [http-bio-443-exec-25] handlers.GetSystemConfigHandler - : fillNonExistingKeys -- Checking if ResultMap has non existing keys, if not filling them.
2015-02-13 14:27:45,721 DEBUG [http-bio-443-exec-25] handlers.GetSystemConfigHandler - updateVoicemailOrWebConfRresultMap: key=[webconfservicecredentialssource], origValue=[2] updatedvalue=[CUP]
2015-02-13 14:27:45,721 DEBUG [http-bio-443-exec-25] handlers.GetSystemConfigHandler - updateVoicemailOrWebConfRresultMap: key=[voicemailservicecredentialssource], origValue=[1] updatedvalue=[NOT_SET]
2015-02-13 14:27:45,732 DEBUG [http-bio-443-exec-25] handlers.GetAllConfigHandler - Processing node:user-config
2015-02-13 14:27:45,732 DEBUG [http-bio-443-exec-25] handlers.GetUserConfigHandler - - writeResponseForUser
2015-02-13 14:27:45,732 INFO [http-bio-443-exec-25] handlers.GetUserConfigHandler - get-user-config Query:EXECUTE PROCEDURE ucSOAPGetUserConfig('228e64f0-7794-dff2-1634-db3959510b65', 8);
2015-02-13 14:27:45,735 DEBUG [http-bio-443-exec-25] handlers.GetAllConfigHandler - Processing node:contact-info
2015-02-13 14:27:45,735 DEBUG [http-bio-443-exec-25] handlers.GetContactInfoHandler - - writeResponseForUser
2015-02-13 14:27:45,735 INFO [http-bio-443-exec-25] handlers.GetContactInfoHandler - About to execute query [EXECUTE PROCEDURE getAllContactInfo('228e64f0-7794-dff2-1634-db3959510b65');]
2015-02-13 14:27:45,819 INFO [http-bio-443-exec-15] soap.SoapServlet - SOAP request URI: /EPASSoap/service/v105
2015-02-13 14:27:45,819 DEBUG [http-bio-443-exec-15] soap.SoapServlet - Service version requested: v105
2015-02-13 14:27:45,820 DEBUG [http-bio-443-exec-15] soap.SoapServlet - Incoming Request
17e7f2d9-db88-ec4e-4205-097a077b9b69
2015-02-13 14:27:45,823 DEBUG [http-bio-443-exec-15] ext.SoapRequestParserExt - Parsing SOAP request securely with a SecurityManager set
2015-02-13 14:27:45,824 INFO [http-bio-443-exec-15] soap.SoapServlet - SOAP request for: get-im-domains, version: v105
2015-02-13 14:27:45,825 DEBUG [http-bio-443-exec-15] imdb.ImdbGeneralAccessorUtil - getClientsessionResultSet -- Query=SELECT * FROM clientsessions WHERE sessionid='17e7f2d9-db88-ec4e-4205-097a077b9b69';
2015-02-13 14:27:45,826 DEBUG [http-bio-443-exec-15] handlers.GetIMDomainsHandler - - writeResponseForUser
2015-02-13 14:27:45,898 INFO [http-bio-443-exec-4] soap.SoapServlet - SOAP request URI: /EPASSoap/service/v100
2015-02-13 14:27:45,899 DEBUG [http-bio-443-exec-4] soap.SoapServlet - Service version requested: v100
2015-02-13 14:27:45,938 DEBUG [http-bio-443-exec-4] soap.SoapServlet - Incoming Request
17e7f2d9-db88-ec4e-4205-097a077b9b69
2015-02-13 14:27:45,942 DEBUG [http-bio-443-exec-4] ext.SoapRequestParserExt - Parsing SOAP request securely with a SecurityManager set
2015-02-13 14:27:45,943 INFO [http-bio-443-exec-4] soap.SoapServlet - SOAP request for: get-user-config, version: v100
2015-02-13 14:27:45,944 DEBUG [http-bio-443-exec-4] imdb.ImdbGeneralAccessorUtil - getClientsessionResultSet -- Query=SELECT * FROM clientsessions WHERE sessionid='17e7f2d9-db88-ec4e-4205-097a077b9b69';
2015-02-13 14:27:45,945 DEBUG [http-bio-443-exec-4] handlers.GetUserConfigHandler - - writeResponseForUser
2015-02-13 14:27:45,945 INFO [http-bio-443-exec-4] handlers.GetUserConfigHandler - get-user-config Query:EXECUTE PROCEDURE ucSOAPGetUserConfig('228e64f0-7794-dff2-1634-db3959510b65', 10);
2015-02-13 14:27:46,029 INFO [http-bio-443-exec-13] soap.SoapServlet - SOAP request URI: /EPASSoap/service/v80
2015-02-13 14:27:46,030 DEBUG [http-bio-443-exec-13] soap.SoapServlet - Service version requested: v80
2015-02-13 14:27:46,068 DEBUG [http-bio-443-exec-13] soap.SoapServlet - Incoming Request
17e7f2d9-db88-ec4e-4205-097a077b9b69
2015-02-13 14:27:46,071 DEBUG [http-bio-443-exec-13] ext.SoapRequestParserExt - Parsing SOAP request securely with a SecurityManager set
2015-02-13 14:27:46,073 INFO [http-bio-443-exec-13] soap.SoapServlet - SOAP request for: get-onetime-password, version: v80
2015-02-13 14:27:46,073 DEBUG [http-bio-443-exec-13] imdb.ImdbGeneralAccessorUtil - getClientsessionResultSet -- Query=SELECT * FROM clientsessions WHERE sessionid='17e7f2d9-db88-ec4e-4205-097a077b9b69';
2015-02-13 14:27:46,075 DEBUG [http-bio-443-exec-13] imdb.ImdbGeneralAccessorUtil - getClientsessionResultSet -- Query=SELECT * FROM clientsessions WHERE sessionid='17e7f2d9-db88-ec4e-4205-097a077b9b69';
2015-02-13 14:27:46,076 DEBUG [http-bio-443-exec-13] imdb.ImdbGeneralAccessorUtil - getValidEndusersResultset -- query: SELECT * FROM validendusers WHERE fkEndUser='228e64f0-7794-dff2-1634-db3959510b65';
2015-02-13 14:27:46,077 DEBUG [http-bio-443-exec-13] imdb.ImdbGeneralAccessorUtil - getValidEndusersResultset -- User found in validenduser table= true
2015-02-13 14:27:46,077 DEBUG [http-bio-443-exec-13] imdb.ImdbGeneralAccessorUtil - getUserIdBySessionId -- userid: kim617408
2015-02-13 14:27:46,077 DEBUG [http-bio-443-exec-13] imdb.ImdbGeneralAccessorUtil - getOneTimePassword --User userid=kim617408
2015-02-13 14:27:46,077 DEBUG [http-bio-443-exec-13] imdb.ImdbGeneralAccessorUtil - getOnetimepasswordResultSet -- qry=SELECT * FROM onetimepassword WHERE userid='kim617408';
2015-02-13 14:27:46,078 DEBUG [http-bio-443-exec-13] imdb.ImdbGeneralAccessorUtil - getOnetimepasswordResultSet -- User data either not found or exceeded maxcount in onetimepassword
2015-02-13 14:27:46,078 DEBUG [http-bio-443-exec-13] imdb.ImdbGeneralAccessorUtil - getOneTimePassword -- insert: INSERT INTO oneTimePassword (userid,password,tmstamp) VALUES ('kim617408','5848638','1423805266078');
2015-02-13 14:27:46,079 DEBUG [http-bio-443-exec-13] imdb.ImdbGeneralAccessorUtil - getOneTimePassword -- For sesssionID=17e7f2d9-db88-ec4e-4205-097a077b9b69 and userid=kim617408, password and time stamp inserted.
2015-02-13 14:27:46,079 INFO [http-bio-443-exec-13] handlers.GetOneTimePasswordHandler - GetOneTimePasswordHandler: successful
2015-02-13 14:27:46,079 INFO [http-bio-443-exec-13] handlers.GetOneTimePasswordHandler - GetOneTimePasswordHandler: Returning response for get-onetime-password
2015-02-13 14:28:05,667 DEBUG [Thread-54] changenotify.ChangeNotificationQueue - Woke up after 60 seconds or notified to wake up.
2015-02-13 14:28:05,668 DEBUG [Thread-54] changenotify.ChangeNotificationQueue - Waiting for 60 seconds or until interrupted
2015-02-13 14:29:05,668 DEBUG [Thread-54] changenotify.ChangeNotificationQueue - Woke up after 60 seconds or notified to wake up.
2015-02-13 14:29:05,668 DEBUG [Thread-54] changenotify.ChangeNotificationQueue - Waiting for 60 seconds or until interrupted
2015-02-13 14:30:05,669 DEBUG [Thread-54] changenotify.ChangeNotificationQueue - Woke up after 60 seconds or notified to wake up.
2015-02-13 14:30:05,669 DEBUG [Thread-54] changenotify.ChangeNotificationQueue - Waiting for 60 seconds or until interrupted
2015-02-13 14:31:05,669 DEBUG [Thread-54] changenotify.ChangeNotificationQueue - Woke up after 60 seconds or notified to wake up.
2015-02-13 14:31:05,670 DEBUG [Thread-54] changenotify.ChangeNotificationQueue - Waiting for 60 seconds or until interrupted
2015-02-13 14:32:05,670 DEBUG [Thread-54] changenotify.ChangeNotificationQueue - Woke up after 60 seconds or notified to wake up.
2015-02-13 14:32:05,671 DEBUG [Thread-54] changenotify.ChangeNotificationQueue - Waiting for 60 seconds or until interrupted
2015-02-13 14:33:05,671 DEBUG [Thread-54] changenotify.ChangeNotificationQueue - Woke up after 60 seconds or notified to wake up.
2015-02-13 14:33:05,671 DEBUG [Thread-54] changenotify.ChangeNotificationQueue - Waiting for 60 seconds or until interrupted
2015-02-13 14:34:05,672 DEBUG [Thread-54] changenotify.ChangeNotificationQueue - Woke up after 60 seconds or notified to wake up.
2015-02-13 14:34:05,672 DEBUG [Thread-54] changenotify.ChangeNotificationQueue - Waiting for 60 seconds or until interrupted
2015-02-13 14:35:05,672 DEBUG [Thread-54] changenotify.ChangeNotificationQueue - Woke up after 60 seconds or notified to wake up.
2015-02-13 14:35:05,672 DEBUG [Thread-54] changenotify.ChangeNotificationQueue - Waiting for 60 seconds or until interrupted
2015-02-13 14:36:05,673 DEBUG [Thread-54] changenotify.ChangeNotificationQueue - Woke up after 60 seconds or notified to wake up.
2015-02-13 14:36:05,673 DEBUG [Thread-54] changenotify.ChangeNotificationQueue - Waiting for 60 seconds or until interrupted
2015-02-13 14:37:05,673 DEBUG [Thread-54] changenotify.ChangeNotificationQueue - Woke up after 60 seconds or notified to wake up.
2015-02-13 14:37:05,674 DEBUG [Thread-54] changenotify.ChangeNotificationQueue - Waiting for 60 seconds or until interrupted
2015-02-13 14:37:36,495 INFO [http-bio-443-exec-20] soap.SoapServlet - SOAP request URI: /EPASSoap/service/v80
2015-02-13 14:37:36,496 DEBUG [http-bio-443-exec-20] soap.SoapServlet - Service version requested: v80
2015-02-13 14:37:36,497 DEBUG [http-bio-443-exec-20] soap.SoapServlet - Incoming Request
kim617408...
2015-02-13 14:37:36,504 DEBUG [http-bio-443-exec-20] ext.SoapRequestParserExt - Parsing SOAP request securely with a SecurityManager set
2015-02-13 14:37:36,507 INFO [http-bio-443-exec-20] soap.SoapServlet - SOAP request for: login, version: v80
2015-02-13 14:37:36,507 DEBUG [http-bio-443-exec-20] storage.SessionInfo - New SessionInfo createdSessionInfo [userPkid=null, sessionId=null, clientVersion=10.6.0.52330]
2015-02-13 14:37:36,508 INFO [http-bio-443-exec-20] handlers.LoginHandler - process:Created session info for userid:kim617408| cType:CUPC| client-version: 10.6.0.52330 |force:true | auth-type:USERNAME_PASSWORD
2015-02-13 14:37:36,511 DEBUG [http-bio-443-exec-20] handlers.LoginHandlerAbstract - prelogin:localHostName=ISCUPS01| hostAddr:192.168.200.3 | hostFQDNISCUPS01.insunginfo.co.kr
2015-02-13 14:37:36,513 INFO [http-bio-443-exec-20] handlers.LoginHandlerAbstract - prelogin:queryString=EXECUTE PROCEDURE ucSOAPPreLogin('kim617408','ISCUPS01','192.168.200.3','ISCUPS01.insunginfo.co.kr');
2015-02-13 14:37:36,513 DEBUG [http-bio-443-exec-20] imdb.ImdbGeneralAccessorUtil - getValidAppusersResultset -- query: SELECT * FROM validappusers WHERE userid='kim617408';
2015-02-13 14:37:36,535 DEBUG [http-bio-443-exec-20] handlers.LoginHandlerAbstract - process:Session is created for an end user client-type
2015-02-13 14:37:36,535 INFO [http-bio-443-exec-20] handlers.LoginHandlerAbstract - process:Client requires version check, minVersion is :7.1.0.0
2015-02-13 14:37:36,536 DEBUG [http-bio-443-exec-20] handlers.LoginHandlerAbstract - process:Client has valid version, proceeding to Login.
2015-02-13 14:37:36,536 INFO [http-bio-443-exec-20] handlers.LoginHandlerAbstract - process:PRELOGIN reasoncode=SUCCESS
2015-02-13 14:37:36,536 DEBUG [http-bio-443-exec-20] handlers.LoginHandlerNonSSO - getNextAction: Next action:LOGIN
2015-02-13 14:37:36,536 DEBUG [http-bio-443-exec-20] handlers.LoginHandlerAbstract - doLogin:kim617408:true:cupc
2015-02-13 14:37:36,536 DEBUG [http-bio-443-exec-20] handlers.LoginHandlerNonSSO - Authenticate using IMS
2015-02-13 14:37:36,536 DEBUG [http-bio-443-exec-20] handlers.LoginHandlerNonSSO - doLogin:Added credentials
2015-02-13 14:37:36,536 DEBUG [http-bio-443-exec-20] handlers.LoginHandlerNonSSO - doLogin:Create IMS instance=com.cisco.security.ims.impl.IMSImpl@226330
2015-02-13 14:37:36,540 DEBUG [http-bio-443-exec-20] handlers.LoginHandlerNonSSO - doLogin:Created Authentication instance=com.cisco.security.ims.authentication.AuthenticationImpl@5bf848
2015-02-13 14:37:36,625 INFO [http-bio-443-exec-20] handlers.LoginHandlerNonSSO - doLogin:IMS login result is success for kim617408| IMS result code:0
2015-02-13 14:37:36,625 DEBUG [http-bio-443-exec-20] imdb.ImdbLoginAccessorUtil - Attempt ucSoapLogin for user=kim617408
2015-02-13 14:37:36,625 DEBUG [http-bio-443-exec-20] imdb.ImdbGeneralAccessorUtil - getValidEndusersResultset -- query: SELECT * FROM validendusers WHERE userid='kim617408';
2015-02-13 14:37:36,626 DEBUG [http-bio-443-exec-20] imdb.ImdbGeneralAccessorUtil - getValidEndusersResultset -- User found in validenduser table= true
2015-02-13 14:37:36,627 DEBUG [http-bio-443-exec-20] imdb.ImdbLoginAccessorUtil - valUser:ENDUSER FOUND in imdb
2015-02-13 14:37:36,627 DEBUG [http-bio-443-exec-20] imdb.ImdbLoginAccessorUtil - User is an End user, type=cupc
2015-02-13 14:37:36,627 DEBUG [http-bio-443-exec-20] imdb.ImdbLoginAccessorUtil - Check Sessions for pkid=228e64f0-7794-dff2-1634-db3959510b65
2015-02-13 14:37:36,627 DEBUG [http-bio-443-exec-20] imdb.ImdbGeneralAccessorUtil - getClientsessionResultSet -- Query=SELECT * FROM clientsessions WHERE fkIdsUser='228e64f0-7794-dff2-1634-db3959510b65' AND clienttype=1;
2015-02-13 14:37:36,628 DEBUG [http-bio-443-exec-20] imdb.ImdbLoginAccessorUtil - ucSoapAppLogin:qry:Existing session found:17e7f2d9-db88-ec4e-4205-097a077b9b69
2015-02-13 14:37:36,628 DEBUG [http-bio-443-exec-20] imdb.ImdbLoginAccessorUtil - ucSoapLogin:updSession=UPDATE clientsessions SET sessionid ='d0a5c593-cea9-22f1-af84-f7ac57528b7f', clientversion='10.6.0.52330' WHERE sessionid='17e7f2d9-db88-ec4e-4205-097a077b9b69';
2015-02-13 14:37:36,629 DEBUG [http-bio-443-exec-20] imdb.ImdbLoginAccessorUtil - updSession session succeeded for userid:kim617408
2015-02-13 14:37:36,629 DEBUG [http-bio-443-exec-20] imdb.ImdbLoginAccessorUtil - ucSoapLogin:delAppSess=DELETE FROM clientsessions WHERE parentsession='17e7f2d9-db88-ec4e-4205-097a077b9b69';
2015-02-13 14:37:36,630 DEBUG [http-bio-443-exec-20] imdb.ImdbGeneralAccessorUtil - exeuteDelete --Delete failed or no data found to delete: DELETE FROM clientsessions WHERE parentsession='17e7f2d9-db88-ec4e-4205-097a077b9b69';
2015-02-13 14:37:36,630 DEBUG [http-bio-443-exec-20] imdb.ImdbLoginAccessorUtil - No Parent Sessions removed for pkid:228e64f0-7794-dff2-1634-db3959510b65
2015-02-13 14:37:36,630 INFO [http-bio-443-exec-20] handlers.LoginHandlerAbstract - SOAP Login was successful
2015-02-13 14:37:36,631 INFO [http-bio-443-exec-20] handlers.LoginHandlerAbstract - doLogin:IMDB check completed & session created for user:kim617408. SessionKey is: d0a5c593-cea9-22f1-af84-f7ac57528b7f
2015-02-13 14:37:36,821 INFO [http-bio-443-exec-14] soap.SoapServlet - SOAP request URI: /EPASSoap/service/v105
2015-02-13 14:37:36,822 DEBUG [http-bio-443-exec-14] soap.SoapServlet - Service version requested: v105
2015-02-13 14:37:36,822 DEBUG [http-bio-443-exec-14] soap.SoapServlet - Incoming Request
d0a5c593-cea9-22f1-af84-f7ac57528b7f
2015-02-13 14:37:36,824 DEBUG [http-bio-443-exec-14] ext.SoapRequestParserExt - Parsing SOAP request securely with a SecurityManager set
2015-02-13 14:37:36,826 INFO [http-bio-443-exec-14] soap.SoapServlet - SOAP request for: get-all-config, version: v105
2015-02-13 14:37:36,827 DEBUG [http-bio-443-exec-14] imdb.ImdbGeneralAccessorUtil - getClientsessionResultSet -- Query=SELECT * FROM clientsessions WHERE sessionid='d0a5c593-cea9-22f1-af84-f7ac57528b7f';
2015-02-13 14:37:36,828 DEBUG [http-bio-443-exec-14] handlers.GetAllConfigHandler - - writeResponseForUser
2015-02-13 14:37:36,828 DEBUG [http-bio-443-exec-14] handlers.GetAllConfigHandler - Get-All-Config Handler
2015-02-13 14:37:36,829 DEBUG [http-bio-443-exec-14] handlers.GetAllConfigHandler - Processing node:system-config
2015-02-13 14:37:36,829 DEBUG [http-bio-443-exec-14] handlers.GetSystemConfigHandler - : writeResponseForUser
2015-02-13 14:37:36,830 DEBUG [http-bio-443-exec-14] handlers.GetSystemConfigHandler - :writeResponseForUser -- Writing response for version:v105
2015-02-13 14:37:36,859 DEBUG [http-bio-443-exec-14] handlers.GetAllConfigHandler - Processing node:user-config
2015-02-13 14:37:36,860 DEBUG [http-bio-443-exec-14] handlers.GetUserConfigHandler - - writeResponseForUser
2015-02-13 14:37:36,860 INFO [http-bio-443-exec-14] handlers.GetUserConfigHandler - get-user-config Query:EXECUTE PROCEDURE ucSOAPGetUserConfig('228e64f0-7794-dff2-1634-db3959510b65', 10.5);
2015-02-13 14:37:36,867 DEBUG [http-bio-443-exec-14] handlers.GetAllConfigHandler - Processing node:contact-info
2015-02-13 14:37:36,867 DEBUG [http-bio-443-exec-14] handlers.GetContactInfoHandler - - writeResponseForUser
2015-02-13 14:37:36,867 INFO [http-bio-443-exec-14] handlers.GetContactInfoHandler - About to execute query [EXECUTE PROCEDURE getAllContactInfo('228e64f0-7794-dff2-1634-db3959510b65');]
2015-02-13 14:37:36,870 DEBUG [http-bio-443-exec-14] handlers.GetAllConfigHandler - Processing node:im-domains
2015-02-13 14:37:36,871 DEBUG [http-bio-443-exec-14] handlers.GetIMDomainsHandler - - writeResponseForUser
2015-02-13 14:37:37,012 INFO [http-bio-443-exec-23] soap.SoapServlet - SOAP request URI: /EPASSoap/service/v80
2015-02-13 14:37:37,012 DEBUG [http-bio-443-exec-23] soap.SoapServlet - Service version requested: v80
2015-02-13 14:37:37,012 DEBUG [http-bio-443-exec-23] soap.SoapServlet - Incoming Request
d0a5c593-cea9-22f1-af84-f7ac57528b7f
2015-02-13 14:37:37,014 DEBUG [http-bio-443-exec-23] ext.SoapRequestParserExt - Parsing SOAP request securely with a SecurityManager set
2015-02-13 14:37:37,015 INFO [http-bio-443-exec-23] soap.SoapServlet - SOAP request for: get-system-config, version: v80
2015-02-13 14:37:37,015 DEBUG [http-bio-443-exec-23] imdb.ImdbGeneralAccessorUtil - getClientsessionResultSet -- Query=SELECT * FROM clientsessions WHERE sessionid='d0a5c593-cea9-22f1-af84-f7ac57528b7f';
2015-02-13 14:37:37,016 DEBUG [http-bio-443-exec-23] handlers.GetSystemConfigHandler - : writeResponseForUser
2015-02-13 14:37:37,016 DEBUG [http-bio-443-exec-23] handlers.GetSystemConfigHandler - :writeResponseForUser -- Writing response for version:v80
2015-02-13 14:37:37,031 DEBUG [http-bio-443-exec-23] handlers.GetSystemConfigHandler - : ProcessServiceXML-- attrName:UCServiceProfileDetailXML.Mailstore.xml: attrVAlue:INBOXDeleted Items60true
2015-02-13 14:37:37,036 DEBUG [http-bio-443-exec-23] handlers.GetSystemConfigHandler - ResultMap:{pollinginterval=60, inbox=INBOX, trashfolder=Deleted Items, isdualfolder=true}
2015-02-13 14:37:37,036 DEBUG [http-bio-443-exec-23] handlers.GetSystemConfigHandler - : fillNonExistingKeys -- Checking if ResultMap has non existing keys, if not filling them.
2015-02-13 14:37:37,045 DEBUG [http-bio-443-exec-23] handlers.GetSystemConfigHandler - : ProcessServiceXML-- attrName:UCServiceProfileDetailXML.Directory.xml: attrVAlue:truetruetrue5
2015-02-13 14:37:37,048 DEBUG [http-bio-443-exec-23] handlers.GetSystemConfigHandler - ResultMap:{searchcontext3=null, useuds=true, searchcontext2=null, useusercredential=true, searchcontext1=null, basefilter=null, dn=null, configurationname=null, password=null, searchtimeout=5, recursivesearch1=true, predictivesearchfilter=null}
2015-02-13 14:37:37,048 DEBUG [http-bio-443-exec-23] handlers.GetSystemConfigHandler - : fillNonExistingKeys -- Checking if ResultMap has non existing keys, if not filling them.
2015-02-13 14:37:37,048 DEBUG [http-bio-443-exec-23] handlers.GetSystemConfigHandler - : fillNonExistingKeys -- filling key: recursivesearch3 to buffer
2015-02-13 14:37:37,049 DEBUG [http-bio-443-exec-23] handlers.GetSystemConfigHandler - : fillNonExistingKeys -- filling key: recursivesearch2 to buffer
2015-02-13 14:37:37,051 DEBUG [http-bio-443-exec-23] handlers.GetSystemConfigHandler - : writeResponseForUser_legacy: MeetingPlace: attrName:'MeetingPlace.Primary.ServerType',old attrValue:'null': newAttrvalue:'null'
2015-02-13 14:37:37,052 DEBUG [http-bio-443-exec-23] handlers.GetSystemConfigHandler - : writeResponseForUser_legacy: MeetingPlace: attrName:'MeetingPlace.Backup1.ServerType',old attrValue:'null': newAttrvalue:'null'
2015-02-13 14:37:37,053 DEBUG [http-bio-443-exec-23] handlers.GetSystemConfigHandler - : writeResponseForUser_legacy: MeetingPlace: attrName:'MeetingPlace.Backup2.ServerType',old attrValue:'null': newAttrvalue:'null'
2015-02-13 14:37:37,054 DEBUG [http-bio-443-exec-23] handlers.GetSystemConfigHandler - : writeResponseForUser_legacy: MeetingPlace: attrName:'MeetingPlace.CertLevel',old attrValue:'CERT_VERIFICATION_LEVEL_ANY_CERT': newAttrvalue:'ANY_CERT'
2015-02-13 14:37:37,068 DEBUG [http-bio-443-exec-23] handlers.GetSystemConfigHandler - : ProcessServiceXML-- attrName:UCServiceProfileDetailXML.Credential.xml: attrVAlue:12
2015-02-13 14:37:37,071 DEBUG [http-bio-443-exec-23] handlers.GetSystemConfigHandler - ResultMap:{webconfservicecredentialssource=2, voicemailservicecredentialssource=1}
2015-02-13 14:37:37,071 DEBUG [http-bio-443-exec-23] handlers.GetSystemConfigHandler - : fillNonExistingKeys -- Checking if ResultMap has non existing keys, if not filling them.
2015-02-13 14:37:37,071 DEBUG [http-bio-443-exec-23] handlers.GetSystemConfigHandler - updateVoicemailOrWebConfRresultMap: key=[webconfservicecredentialssource], origValue=[2] updatedvalue=[CUP]
2015-02-13 14:37:37,071 DEBUG [http-bio-443-exec-23] handlers.GetSystemConfigHandler - updateVoicemailOrWebConfRresultMap: key=[voicemailservicecredentialssource], origValue=[1] updatedvalue=[NOT_SET]
2015-02-13 14:37:37,170 INFO [http-bio-443-exec-4] soap.SoapServlet - SOAP request URI: /EPASSoap/service/v105
2015-02-13 14:37:37,171 DEBUG [http-bio-443-exec-4] soap.SoapServlet - Service version requested: v105
2015-02-13 14:37:37,171 DEBUG [http-bio-443-exec-4] soap.SoapServlet - Incoming Request
d0a5c593-cea9-22f1-af84-f7ac57528b7f
2015-02-13 14:37:37,174 DEBUG [http-bio-443-exec-4] ext.SoapRequestParserExt - Parsing SOAP request securely with a SecurityManager set
2015-02-13 14:37:37,176 INFO [http-bio-443-exec-4] soap.SoapServlet - SOAP request for: get-onetime-password, version: v105
2015-02-13 14:37:37,176 DEBUG [http-bio-443-exec-4] imdb.ImdbGeneralAccessorUtil - getClientsessionResultSet -- Query=SELECT * FROM clientsessions WHERE sessionid='d0a5c593-cea9-22f1-af84-f7ac57528b7f';
2015-02-13 14:37:37,178 DEBUG [http-bio-443-exec-4] imdb.ImdbGeneralAccessorUtil - getClientsessionResultSet -- Query=SELECT * FROM clientsessions WHERE sessionid='d0a5c593-cea9-22f1-af84-f7ac57528b7f';
2015-02-13 14:37:37,181 DEBUG [http-bio-443-exec-4] imdb.ImdbGeneralAccessorUtil - getValidEndusersResultset -- query: SELECT * FROM validendusers WHERE fkEndUser='228e64f0-7794-dff2-1634-db3959510b65';
2015-02-13 14:37:37,183 DEBUG [http-bio-443-exec-4] imdb.ImdbGeneralAccessorUtil - getValidEndusersResultset -- User found in validenduser table= true
2015-02-13 14:37:37,183 DEBUG [http-bio-443-exec-4] imdb.ImdbGeneralAccessorUtil - getUserIdBySessionId -- userid: kim617408
2015-02-13 14:37:37,184 DEBUG [http-bio-443-exec-4] imdb.ImdbGeneralAccessorUtil - getOneTimePassword --User userid=kim617408
2015-02-13 14:37:37,184 DEBUG [http-bio-443-exec-4] imdb.ImdbGeneralAccessorUtil - getOnetimepasswordResultSet -- qry=SELECT * FROM onetimepassword WHERE userid='kim617408';
2015-02-13 14:37:37,185 DEBUG [http-bio-443-exec-4] imdb.ImdbGeneralAccessorUtil - getOnetimepasswordResultSet -- User data either not found or exceeded maxcount in onetimepassword
2015-02-13 14:37:37,186 DEBUG [http-bio-443-exec-4] imdb.ImdbGeneralAccessorUtil - getOneTimePassword -- insert: INSERT INTO oneTimePassword (userid,password,tmstamp) VALUES ('kim617408','13481572','1423805857185');
2015-02-13 14:37:37,187 DEBUG [http-bio-443-exec-4] imdb.ImdbGeneralAccessorUtil - getOneTimePassword -- For sesssionID=d0a5c593-cea9-22f1-af84-f7ac57528b7f and userid=kim617408, password and time stamp inserted.
2015-02-13 14:37:37,187 INFO [http-bio-443-exec-4] handlers.GetOneTimePasswordHandler - GetOneTimePasswordHandler: successful
2015-02-13 14:37:37,187 INFO [http-bio-443-exec-4] handlers.GetOneTimePasswordHandler - GetOneTimePasswordHandler: Returning response for get-onetime-password
2015-02-13 14:37:40,165 INFO [http-bio-443-exec-15] soap.SoapServlet - SOAP request URI: /EPASSoap/service/v80
2015-02-13 14:37:40,166 DEBUG [http-bio-443-exec-15] soap.SoapServlet - Service version requested: v80
2015-02-13 14:37:40,166 DEBUG [http-bio-443-exec-15] soap.SoapServlet - Incoming Request
kim617408...
2015-02-13 14:37:40,168 DEBUG [http-bio-443-exec-15] ext.SoapRequestParserExt - Parsing SOAP request securely with a SecurityManager set
2015-02-13 14:37:40,169 INFO [http-bio-443-exec-15] soap.SoapServlet - SOAP request for: login, version: v80
2015-02-13 14:37:40,169 DEBUG [http-bio-443-exec-15] storage.SessionInfo - New SessionInfo createdSessionInfo [userPkid=null, sessionId=null, clientVersion=10.6.0.52330]
2015-02-13 14:37:40,169 INFO [http-bio-443-exec-15] handlers.LoginHandler - process:Created session info for userid:kim617408| cType:CUPC| client-version: 10.6.0.52330 |force:true | auth-type:USERNAME_PASSWORD
2015-02-13 14:37:40,169 DEBUG [http-bio-443-exec-15] handlers.LoginHandlerAbstract - prelogin:localHostName=ISCUPS01| hostAddr:192.168.200.3 | hostFQDNISCUPS01.insunginfo.co.kr
2015-02-13 14:37:40,169 INFO [http-bio-443-exec-15] handlers.LoginHandlerAbstract - prelogin:queryString=EXECUTE PROCEDURE ucSOAPPreLogin('kim617408','ISCUPS01','192.168.200.3','ISCUPS01.insunginfo.co.kr');
2015-02-13 14:37:40,170 DEBUG [http-bio-443-exec-15] imdb.ImdbGeneralAccessorUtil - getValidAppusersResultset -- query: SELECT * FROM validappusers WHERE userid='kim617408';
2015-02-13 14:37:40,173 DEBUG [http-bio-443-exec-15] handlers.LoginHandlerAbstract - process:Session is created for an end user client-type
2015-02-13 14:37:40,173 INFO [http-bio-443-exec-15] handlers.LoginHandlerAbstract - process:Client requires version check, minVersion is :7.1.0.0
2015-02-13 14:37:40,174 DEBUG [http-bio-443-exec-15] handlers.LoginHandlerAbstract - process:Client has valid version, proceeding to Login.
2015-02-13 14:37:40,174 INFO [http-bio-443-exec-15] handlers.LoginHandlerAbstract - process:PRELOGIN reasoncode=SUCCESS
2015-02-13 14:37:40,174 DEBUG [http-bio-443-exec-15] handlers.LoginHandlerNonSSO - getNextAction: Next action:LOGIN
2015-02-13 14:37:40,174 DEBUG [http-bio-443-exec-15] handlers.LoginHandlerAbstract - doLogin:kim617408:true:cupc
2015-02-13 14:37:40,174 DEBUG [http-bio-443-exec-15] handlers.LoginHandlerNonSSO - Authenticate using IMS
2015-02-13 14:37:40,174 DEBUG [http-bio-443-exec-15] handlers.LoginHandlerNonSSO - doLogin:Added credentials
2015-02-13 14:37:40,175 DEBUG [http-bio-443-exec-15] handlers.LoginHandlerNonSSO - doLogin:Create IMS instance=com.cisco.security.ims.impl.IMSImpl@226330
2015-02-13 14:37:40,175 DEBUG [http-bio-443-exec-15] handlers.LoginHandlerNonSSO - doLogin:Created Authentication instance=com.cisco.security.ims.authentication.AuthenticationImpl@1b3e6c3
2015-02-13 14:37:40,228 INFO [http-bio-443-exec-15] handlers.LoginHandlerNonSSO - doLogin:IMS login result is success for kim617408| IMS result code:0
2015-02-13 14:37:40,228 DEBUG [http-bio-443-exec-15] imdb.ImdbLoginAccessorUtil - Attempt ucSoapLogin for user=kim617408
2015-02-13 14:37:40,228 DEBUG [http-bio-443-exec-15] imdb.ImdbGeneralAccessorUtil - getValidEndusersResultset -- query: SELECT * FROM validendusers WHERE userid='kim617408';
2015-02-13 14:37:40,229 DEBUG [http-bio-443-exec-15] imdb.ImdbGeneralAccessorUtil - getValidEndusersResultset -- User found in validenduser table= true
2015-02-13 14:37:40,229 DEBUG [http-bio-443-exec-15] imdb.ImdbLoginAccessorUtil - valUser:ENDUSER FOUND in imdb
2015-02-13 14:37:40,229 DEBUG [http-bio-443-exec-15] imdb.ImdbLoginAccessorUtil - User is an End user, type=cupc
2015-02-13 14:37:40,229 DEBUG [http-bio-443-exec-15] imdb.ImdbLoginAccessorUtil - Check Sessions for pkid=228e64f0-7794-dff2-1634-db3959510b65
2015-02-13 14:37:40,229 DEBUG [http-bio-443-exec-15] imdb.ImdbGeneralAccessorUtil - getClientsessionResultSet -- Query=SELECT * FROM clientsessions WHERE fkIdsUser='228e64f0-7794-dff2-1634-db3959510b65' AND clienttype=1;
2015-02-13 14:37:40,230 DEBUG [http-bio-443-exec-15] imdb.ImdbLoginAccessorUtil - ucSoapAppLogin:qry:Existing session found:d0a5c593-cea9-22f1-af84-f7ac57528b7f
2015-02-13 14:37:40,231 DEBUG [http-bio-443-exec-15] imdb.ImdbLoginAccessorUtil - ucSoapLogin:updSession=UPDATE clientsessions SET sessionid ='8385cf1b-316e-8dfa-7398-fc45bc71ad13', clientversion='10.6.0.52330' WHERE sessionid='d0a5c593-cea9-22f1-af84-f7ac57528b7f';
2015-02-13 14:37:40,231 DEBUG [http-bio-443-exec-15] imdb.ImdbLoginAccessorUtil - updSession session succeeded for userid:kim617408
2015-02-13 14:37:40,232 DEBUG [http-bio-443-exec-15] imdb.ImdbLoginAccessorUtil - ucSoapLogin:delAppSess=DELETE FROM clientsessions WHERE parentsession='d0a5c593-cea9-22f1-af84-f7ac57528b7f';
2015-02-13 14:37:40,232 DEBUG [http-bio-443-exec-15] imdb.ImdbGeneralAccessorUtil - exeuteDelete --Delete failed or no data found to delete: DELETE FROM clientsessions WHERE parentsession='d0a5c593-cea9-22f1-af84-f7ac57528b7f';
2015-02-13 14:37:40,232 DEBUG [http-bio-443-exec-15] imdb.ImdbLoginAccessorUtil - No Parent Sessions removed for pkid:228e64f0-7794-dff2-1634-db3959510b65
2015-02-13 14:37:40,233 INFO [http-bio-443-exec-15] handlers.LoginHandlerAbstract - SOAP Login was successful
2015-02-13 14:37:40,233 INFO [http-bio-443-exec-15] handlers.LoginHandlerAbstract - doLogin:IMDB check completed & session created for user:kim617408. SessionKey is: 8385cf1b-316e-8dfa-7398-fc45bc71ad13
2015-02-13 14:37:40,341 INFO [http-bio-443-exec-25] soap.SoapServlet - SOAP request URI: /EPASSoap/service/v105
2015-02-13 14:37:40,341 DEBUG [http-bio-443-exec-25] soap.SoapServlet - Service version requested: v105
2015-02-13 14:37:40,342 DEBUG [http-bio-443-exec-25] soap.SoapServlet - Incoming Request
8385cf1b-316e-8dfa-7398-fc45bc71ad13
2015-02-13 14:37:40,343 DEBUG [http-bio-443-exec-25] ext.SoapRequestParserExt - Parsing SOAP request securely with a SecurityManager set
2015-02-13 14:37:40,344 INFO [http-bio-443-exec-25] soap.SoapServlet - SOAP request for: get-all-config, version: v105
2015-02-13 14:37:40,344 DEBUG [http-bio-443-exec-25] imdb.ImdbGeneralAccessorUtil - getClientsessionResultSet -- Query=SELECT * FROM clientsessions WHERE sessionid='8385cf1b-316e-8dfa-7398-fc45bc71ad13';
2015-02-13 14:37:40,345 DEBUG [http-bio-443-exec-25] handlers.GetAllConfigHandler - - writeResponseForUser
2015-02-13 14:37:40,345 DEBUG [http-bio-443-exec-25] handlers.GetAllConfigHandler - Get-All-Config Handler
2015-02-13 14:37:40,345 DEBUG [http-bio-443-exec-25] handlers.GetAllConfigHandler - Processing node:system-config
2015-02-13 14:37:40,346 DEBUG [http-bio-443-exec-25] handlers.GetSystemConfigHandler - : writeResponseForUser
2015-02-13 14:37:40,346 DEBUG [http-bio-443-exec-25] handlers.GetSystemConfigHandler - :writeResponseForUser -- Writing response for version:v105
2015-02-13 14:37:40,364 DEBUG [http-bio-443-exec-25] handlers.GetAllConfigHandler - Processing node:user-config
2015-02-13 14:37:40,364 DEBUG [http-bio-443-exec-25] handlers.GetUserConfigHandler - - writeResponseForUser
2015-02-13 14:37:40,365 INFO [http-bio-443-exec-25] handlers.GetUserConfigHandler - get-user-config Query:EXECUTE PROCEDURE ucSOAPGetUserConfig('228e64f0-7794-dff2-1634-db3959510b65', 10.5);
2015-02-13 14:37:40,367 DEBUG [http-bio-443-exec-25] handlers.GetAllConfigHandler - Processing node:contact-info
2015-02-13 14:37:40,368 DEBUG [http-bio-443-exec-25] handlers.GetContactInfoHandler - - writeResponseForUser
2015-02-13 14:37:40,368 INFO [http-bio-443-exec-25] handlers.GetContactInfoHandler - About to execute query [EXECUTE PROCEDURE getAllContactInfo('228e64f0-7794-dff2-1634-db3959510b65');]
2015-02-13 14:37:40,370 DEBUG [http-bio-443-exec-25] handlers.GetAllConfigHandler - Processing node:im-domains
2015-02-13 14:37:40,370 DEBUG [http-bio-443-exec-25] handlers.GetIMDomainsHandler - - writeResponseForUser
2015-02-13 14:37:40,441 INFO [http-bio-443-exec-17] soap.SoapServlet - SOAP request URI: /EPASSoap/service/v80
2015-02-13 14:37:40,442 DEBUG [http-bio-443-exec-17] soap.SoapServlet - Service version requested: v80
2015-02-13 14:37:40,481 DEBUG [http-bio-443-exec-17] soap.SoapServlet - Incoming Request
8385cf1b-316e-8dfa-7398-fc45bc71ad13
2015-02-13 14:37:40,484 DEBUG [http-bio-443-exec-17] ext.SoapRequestParserExt - Parsing SOAP request securely with a SecurityManager set
2015-02-13 14:37:40,486 INFO [http-bio-443-exec-17] soap.SoapServlet - SOAP request for: get-system-config, version: v80
2015-02-13 14:37:40,486 DEBUG [http-bio-443-exec-17] imdb.ImdbGeneralAccessorUtil - getClientsessionResultSet -- Query=SELECT * FROM clientsessions WHERE sessionid='8385cf1b-316e-8dfa-7398-fc45bc71ad13';
2015-02-13 14:37:40,488 DEBUG [http-bio-443-exec-17] handlers.GetSystemConfigHandler - : writeResponseForUser
2015-02-13 14:37:40,488 DEBUG [http-bio-443-exec-17] handlers.GetSystemConfigHandler - :writeResponseForUser -- Writing response for version:v80
2015-02-13 14:37:40,498 DEBUG [http-bio-443-exec-17] handlers.GetSystemConfigHandler - : ProcessServiceXML-- attrName:UCServiceProfileDetailXML.Mailstore.xml: attrVAlue:INBOXDeleted Items60true
2015-02-13 14:37:40,502 DEBUG [http-bio-443-exec-17] handlers.GetSystemConfigHandler - ResultMap:{pollinginterval=60, inbox=INBOX, trashfolder=Deleted Items, isdualfolder=true}
2015-02-13 14:37:40,502 DEBUG [http-bio-443-exec-17] handlers.GetSystemConfigHandler - : fillNonExistingKeys -- Checking if ResultMap has non existing keys, if not filling them.
2015-02-13 14:37:40,507 DEBUG [http-bio-443-exec-17] handlers.GetSystemConfigHandler - : ProcessServiceXML-- attrName:UCServiceProfileDetailXML.Directory.xml: attrVAlue:truetruetrue5
2015-02-13 14:37:40,510 DEBUG [http-bio-443-exec-17] handlers.GetSystemConfigHandler - ResultMap:{searchcontext3=null, useuds=true, searchcontext2=null, useusercredential=true, searchcontext1=null, basefilter=null, dn=null, configurationname=null, password=null, searchtimeout=5, recursivesearch1=true, predictivesearchfilter=null}
2015-02-13 14:37:40,510 DEBUG [http-bio-443-exec-17] handlers.GetSystemConfigHandler - : fillNonExistingKeys -- Checking if ResultMap has non existing keys, if not filling them.
2015-02-13 14:37:40,510 DEBUG [http-bio-443-exec-17] handlers.GetSystemConfigHandler - : fillNonExistingKeys -- filling key: recursivesearch3 to buffer
2015-02-13 14:37:40,510 DEBUG [http-bio-443-exec-17] handlers.GetSystemConfigHandler - : fillNonExistingKeys -- filling key: recursivesearch2 to buffer
2015-02-13 14:37:40,511 DEBUG [http-bio-443-exec-17] handlers.GetSystemConfigHandler - : writeResponseForUser_legacy: MeetingPlace: attrName:'MeetingPlace.Primary.ServerType',old attrValue:'null': newAttrvalue:'null'
2015-02-13 14:37:40,512 DEBUG [http-bio-443-exec-17] handlers.GetSystemConfigHandler - : writeResponseForUser_legacy: MeetingPlace: attrName:'MeetingPlace.Backup1.ServerType',old attrValue:'null': newAttrvalue:'null'
2015-02-13 14:37:40,513 DEBUG [http-bio-443-exec-17] handlers.GetSystemConfigHandler - : writeResponseForUser_legacy: MeetingPlace: attrName:'MeetingPlace.Backup2.ServerType',old attrValue:'null': newAttrvalue:'null'
2015-02-13 14:37:40,513 DEBUG [http-bio-443-exec-17] handlers.GetSystemConfigHandler - : writeResponseForUser_legacy: MeetingPlace: attrName:'MeetingPlace.CertLevel',old attrValue:'CERT_VERIFICATION_LEVEL_ANY_CERT': newAttrvalue:'ANY_CERT'
2015-02-13 14:37:40,522 DEBUG [http-bio-443-exec-17] handlers.GetSystemConfigHandler - : ProcessServiceXML-- attrName:UCServiceProfileDetailXML.Credential.xml: attrVAlue:12
2015-02-13 14:37:40,525 DEBUG [http-bio-443-exec-17] handlers.GetSystemConfigHandler - ResultMap:{webconfservicecredentialssource=2, voicemailservicecredentialssource=1}
2015-02-13 14:37:40,525 DEBUG [http-bio-443-exec-17] handlers.GetSystemConfigHandler - : fillNonExistingKeys -- Checking if ResultMap has non existing keys, if not filling them.
2015-02-13 14:37:40,526 DEBUG [http-bio-443-exec-17] handlers.GetSystemConfigHandler - updateVoicemailOrWebConfRresultMap: key=[webconfservicecredentialssource], origValue=[2] updatedvalue=[CUP]
2015-02-13 14:37:40,526 DEBUG [http-bio-443-exec-17] handlers.GetSystemConfigHandler - updateVoicemailOrWebConfRresultMap: key=[voicemailservicecredentialssource], origValue=[1] updatedvalue=[NOT_SET]
2015-02-13 14:37:40,651 INFO [http-bio-443-exec-11] soap.SoapServlet - SOAP request URI: /EPASSoap/service/v105
2015-02-13 14:37:40,652 DEBUG [http-bio-443-exec-11] soap.SoapServlet - Service version requested: v105
2015-02-13 14:37:40,652 DEBUG [http-bio-443-exec-11] soap.SoapServlet - Incoming Request
8385cf1b-316e-8dfa-7398-fc45bc71ad13
2015-02-13 14:37:40,655 DEBUG [http-bio-443-exec-11] ext.SoapRequestParserExt - Parsing SOAP request securely with a SecurityManager set
2015-02-13 14:37:40,656 INFO [http-bio-443-exec-11] soap.SoapServlet - SOAP request for: get-onetime-password, version: v105
2015-02-13 14:37:40,657 DEBUG [http-bio-443-exec-11] imdb.ImdbGeneralAccessorUtil - getClientsessionResultSet -- Query=SELECT * FROM clientsessions WHERE sessionid='8385cf1b-316e-8dfa-7398-fc45bc71ad13';
2015-02-13 14:37:40,658 DEBUG [http-bio-443-exec-11] imdb.ImdbGeneralAccessorUtil - getClientsessionResultSet -- Query=SELECT * FROM clientsessions WHERE sessionid='8385cf1b-316e-8dfa-7398-fc45bc71ad13';
2015-02-13 14:37:40,659 DEBUG [http-bio-443-exec-11] imdb.ImdbGeneralAccessorUtil - getValidEndusersResultset -- query: SELECT * FROM validendusers WHERE fkEndUser='228e64f0-7794-dff2-1634-db3959510b65';
2015-02-13 14:37:40,660 DEBUG [http-bio-443-exec-11] imdb.ImdbGeneralAccessorUtil - getValidEndusersResultset -- User found in validenduser table= true
2015-02-13 14:37:40,660 DEBUG [http-bio-443-exec-11] imdb.ImdbGeneralAccessorUtil - getUserIdBySessionId -- userid: kim617408
2015-02-13 14:37:40,660 DEBUG [http-bio-443-exec-11] imdb.ImdbGeneralAccessorUtil - getOneTimePassword --User userid=kim617408
2015-02-13 14:37:40,660 DEBUG [http-bio-443-exec-11] imdb.ImdbGeneralAccessorUtil - getOnetimepasswordResultSet -- qry=SELECT * FROM onetimepassword WHERE userid='kim617408';
2015-02-13 14:37:40,661 DEBUG [http-bio-443-exec-11] imdb.ImdbGeneralAccessorUtil - getOnetimepasswordResultSet -- User data either not found or exceeded maxcount in onetimepassword
2015-02-13 14:37:40,661 DEBUG [http-bio-443-exec-11] imdb.ImdbGeneralAccessorUtil - getOneTimePassword -- insert: INSERT INTO oneTimePassword (userid,password,tmstamp) VALUES ('kim617408','7181780','1423805860661');
2015-02-13 14:37:40,662 DEBUG [http-bio-443-exec-11] imdb.ImdbGeneralAccessorUtil - getOneTimePassword -- For sesssionID=8385cf1b-316e-8dfa-7398-fc45bc71ad13 and userid=kim617408, password and time stamp inserted.
2015-02-13 14:37:40,662 INFO [http-bio-443-exec-11] handlers.GetOneTimePasswordHandler - GetOneTimePasswordHandler: successful
2015-02-13 14:37:40,662 INFO [http-bio-443-exec-11] handlers.GetOneTimePasswordHandler - GetOneTimePasswordHandler: Returning response for get-onetime-password
2015-02-13 14:38:05,674 DEBUG [Thread-54] changenotify.ChangeNotificationQueue - Woke up after 60 seconds or notified to wake up.
2015-02-13 14:38:05,675 DEBUG [Thread-54] changenotify.ChangeNotificationQueue - Waiting for 60 seconds or until interrupted
2015-02-13 14:39:05,675 DEBUG [Thread-54] changenotify.ChangeNotificationQueue - Woke up after 60 seconds or notified to wake up.
2015-02-13 14:39:05,675 DEBUG [Thread-54] changenotify.ChangeNotificationQueue - Waiting for 60 seconds or until interrupted
2015-02-13 14:40:05,675 DEBUG [Thread-54] changenotify.ChangeNotificationQueue - Woke up after 60 seconds or notified to wake up.
2015-02-13 14:40:05,676 DEBUG [Thread-54] changenotify.ChangeNotificationQueue - Waiting for 60 seconds or until interrupted