=== 2014-04-29 21:31:04,320 [c-19] INFO RequestContext - URL: '/AdminOnline/version/9.0/isomorphic/IDACall', User-Agent: 'Mozilla/5.0 (Windows NT 6.3; WOW64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/34.0.1847.131 Safari/537.36': Safari with Accept-Encoding header CLASS: za.co.adminonline.servlet.SecurityCheck INFO: loggedInInd: null CLASS: za.co.adminonline.servlet.SecurityCheck INFO: getPathInfo: null CLASS: za.co.adminonline.servlet.SecurityCheck INFO: getRequestURI: /AdminOnline/version/9.0/isomorphic/IDACall CLASS: za.co.adminonline.servlet.SecurityCheck INFO: getServletPath: /version/9.0/isomorphic/IDACall CLASS: za.co.adminonline.servlet.SecurityCheck INFO: getContextPath: /AdminOnline CLASS: za.co.adminonline.servlet.SecurityCheck INFO: referer: http://adminonline.biz/AdminOnline/register.jsp === 2014-04-29 21:31:04,320 [c-19] DEBUG IDACall - Header Name:Value pair: host:adminonline.biz === 2014-04-29 21:31:04,320 [c-19] DEBUG IDACall - Header Name:Value pair: connection:keep-alive === 2014-04-29 21:31:04,320 [c-19] DEBUG IDACall - Header Name:Value pair: content-length:5956 === 2014-04-29 21:31:04,320 [c-19] DEBUG IDACall - Header Name:Value pair: origin:http://adminonline.biz === 2014-04-29 21:31:04,320 [c-19] DEBUG IDACall - Header Name:Value pair: user-agent:Mozilla/5.0 (Windows NT 6.3; WOW64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/34.0.1847.131 Safari/537.36 === 2014-04-29 21:31:04,320 [c-19] DEBUG IDACall - Header Name:Value pair: content-type:application/x-www-form-urlencoded; charset=UTF-8 === 2014-04-29 21:31:04,320 [c-19] DEBUG IDACall - Header Name:Value pair: accept:*/* === 2014-04-29 21:31:04,320 [c-19] DEBUG IDACall - Header Name:Value pair: referer:http://adminonline.biz/AdminOnline/register.jsp === 2014-04-29 21:31:04,320 [c-19] DEBUG IDACall - Header Name:Value pair: accept-encoding:gzip,deflate,sdch === 2014-04-29 21:31:04,320 [c-19] DEBUG IDACall - Header Name:Value pair: accept-language:en-US,en;q=0.8,af;q=0.6 === 2014-04-29 21:31:04,320 [c-19] DEBUG IDACall - Header Name:Value pair: cookie:JSESSIONID=148F6A0F3C7EEEC2829566F53C67206D; svarIntCompanyId=3; svarStrCompanyDescr=SuperSwim; isc_cState=ready === 2014-04-29 21:31:04,320 [c-19] DEBUG IDACall - session exists: 148F6A0F3C7EEEC2829566F53C67206D === 2014-04-29 21:31:04,320 [c-19] DEBUG IDACall - remote user: null === 2014-04-29 21:31:06,317 [c-19] DEBUG XML - Parsed XML from (in memory stream): 2ms === 2014-04-29 21:31:06,322 [c-19] DEBUG RPCManager - Processing 5 requests. === 2014-04-29 21:31:06,322 [c-19] DEBUG RPCManager - Request #1 (DSRequest) payload: { values:{ company_id:"3", status_cd:"Active", start_d:new Date(1396303200000), surname:"aaaaa", comment:"bbbbb" }, operationConfig:{ dataSource:"company_account", operationType:"add" }, componentId:"dfRegisterUserAccountDetail", appID:"builtinApplication", operation:"company_account_add", oldValues:{ }, criteria:{ } } === 2014-04-29 21:31:06,322 [c-19] DEBUG RPCManager - Request #2 (DSRequest) payload: { values:{ company_id:"3", status_cd:"Active", role_responsible:1, role_attendee:0, role_communicator:0, role_web_user:0, name:"bbbbbb", surname:"aaaaa", email:"henkiemaritz@iits.co.za", cell_number:"4444444444" }, operationConfig:{ dataSource:"register_account_person", operationType:"add" }, componentId:"dfRegisterUserTabTab0", appID:"builtinApplication", operation:"register_account_person_add", oldValues:{ }, criteria:{ } } === 2014-04-29 21:31:06,323 [c-19] DEBUG RPCManager - Request #3 (DSRequest) payload: { values:{ company_id:"3", status_cd:"Active", role_responsible:0, role_attendee:0, role_communicator:1, role_web_user:1, name:"cccccc", surname:"aaaaa", password:"aaaaaa", password2:"aaaaaa", email:"nerina@iits.co.za", cell_number:"6666666666" }, operationConfig:{ dataSource:"register_account_person", operationType:"add" }, componentId:"dfRegisterUserTabTab1", appID:"builtinApplication", operation:"register_account_person_add", oldValues:{ }, criteria:{ } } === 2014-04-29 21:31:06,323 [c-19] DEBUG RPCManager - Request #4 (DSRequest) payload: { values:{ company_id:"3", status_cd:"Active", role_responsible:0, role_attendee:1, role_communicator:0, role_web_user:0, name:"ddddd", surname:"aaaaa", birth_d:new Date(1397599200000), gender_cd:"Male", id_number:"4444444444444", medical_issues:"sdfgsdfg", school_name:"Centurion Christian School", school_grade:"5", activities:"Group Lessons" }, operationConfig:{ dataSource:"register_account_person", operationType:"add" }, componentId:"dfRegisterUserTabTab2", appID:"builtinApplication", operation:"register_account_person_add", oldValues:{ }, criteria:{ } } === 2014-04-29 21:31:06,323 [c-19] DEBUG RPCManager - Request #5 (DSRequest) payload: { values:{ company_id:"3", status_cd:"Active", role_responsible:0, role_attendee:1, role_communicator:0, role_web_user:0, name:"eeeee", surname:"aaaaa", birth_d:new Date(1398204000000), gender_cd:"Male", id_number:"5555555555555", medical_issues:"55sfgsdfgsdg", school_name:"Hennopspark Primary", school_grade:"7", activities:"Individual Lessons" }, operationConfig:{ dataSource:"register_account_person", operationType:"add" }, componentId:"dfRegisterUserTabTab3", appID:"builtinApplication", operation:"register_account_person_add", oldValues:{ }, criteria:{ } } === 2014-04-29 21:31:06,323 [c-19] INFO IDACall - Performing 5 operation(s) === 2014-04-29 21:31:06,323 [c-19] DEBUG DeclarativeSecurity - Processing security checks for DataSource null, field null === 2014-04-29 21:31:06,323 [c-19] DEBUG DeclarativeSecurity - DataSource company_account is not in the pre-checked list, processing... === 2014-04-29 21:31:06,324 [c-19] DEBUG DeclarativeSecurity - Processing security checks for DataSource null, field null === 2014-04-29 21:31:06,324 [c-19] DEBUG DeclarativeSecurity - DataSource company_account is not in the pre-checked list, processing... === 2014-04-29 21:31:06,324 [c-19] DEBUG AppBase - [builtinApplication.company_account_add] No userTypes defined, allowing anyone access to all operations for this application === 2014-04-29 21:31:06,324 [c-19] DEBUG AppBase - [builtinApplication.company_account_add] No public zero-argument method named '_company_account_add' found, performing generic datasource operation === 2014-04-29 21:31:06,324 [c-19] INFO SQLDataSource - [builtinApplication.company_account_add] Performing add operation with criteria: {company_id:"3",status_cd:"Active",start_d:new Date(1396303200000),surname:"aaaaa",comment:"bbbbb"} values: {company_id:3,status_cd:"Active",start_d:new Date(1396303200000),surname:"aaaaa",comment:"bbbbb",payment_terms_cd:"Monthly"} === 2014-04-29 21:31:06,325 [c-19] DEBUG SQLValuesClause - [builtinApplication.company_account_add] Sequences: {company_account_number=__default} === 2014-04-29 21:31:06,325 [c-19] DEBUG PoolableSQLConnectionFactory - [builtinApplication.company_account_add] Executing pingTest 'select 1 from dual' on connection 1892008743 === 2014-04-29 21:31:06,326 [c-19] DEBUG SQLConnectionManager - [builtinApplication.company_account_add] Borrowed connection '1892008743' === 2014-04-29 21:31:06,326 [c-19] DEBUG SQLTransaction - [builtinApplication.company_account_add] Started new Mysql transaction "1892008743" === 2014-04-29 21:31:06,326 [c-19] DEBUG SQLDriver - [builtinApplication.company_account_add] About to execute SQL update in 'Mysql' using connection'1892008743' === 2014-04-29 21:31:06,326 [c-19] INFO SQLDriver - [builtinApplication.company_account_add] Executing SQL update on 'Mysql': INSERT INTO company_account (comment, company_id, payment_terms_cd, start_d, status_cd, surname) VALUES ('bbbbb', 3, 'Monthly', '2014-04-01', 'Active', 'aaaaa') === 2014-04-29 21:31:06,328 [c-19] DEBUG SQLDataSource - [builtinApplication.company_account_add] add operation affected 1 rows === 2014-04-29 21:31:06,328 [c-19] DEBUG MysqlDriver - [builtinApplication.company_account_add] fetchLastRow data - primaryKeysPresent: {}sequencesNotPresent: [company_account_number] === 2014-04-29 21:31:06,328 [c-19] DEBUG SQLDriver - [builtinApplication.company_account_add] About to execute SQL query in 'Mysql' using connection '1892008743' === 2014-04-29 21:31:06,328 [c-19] INFO SQLDriver - [builtinApplication.company_account_add] Executing SQL query on 'Mysql': SELECT LAST_INSERT_ID() === 2014-04-29 21:31:06,329 [c-19] INFO SQLDataSource - [builtinApplication.company_account_add] primaryKeys: {company_account_number=14947} === 2014-04-29 21:31:06,329 [c-19] DEBUG DeclarativeSecurity - [builtinApplication.company_account_add] Processing security checks for DataSource null, field null === 2014-04-29 21:31:06,329 [c-19] DEBUG DeclarativeSecurity - [builtinApplication.company_account_add] DataSource company_account is not in the pre-checked list, processing... === 2014-04-29 21:31:06,330 [c-19] DEBUG DeclarativeSecurity - [builtinApplication.company_account_add] Processing security checks for DataSource null, field null === 2014-04-29 21:31:06,330 [c-19] DEBUG DeclarativeSecurity - [builtinApplication.company_account_add] DataSource company_account is not in the pre-checked list, processing... === 2014-04-29 21:31:06,330 [c-19] DEBUG AppBase - [builtinApplication.company_account_add, builtinApplication.null] No userTypes defined, allowing anyone access to all operations for this application === 2014-04-29 21:31:06,330 [c-19] DEBUG AppBase - [builtinApplication.company_account_add, builtinApplication.null] No public zero-argument method named '_null' found, performing generic datasource operation === 2014-04-29 21:31:06,330 [c-19] INFO SQLDataSource - [builtinApplication.company_account_add, builtinApplication.null] Performing fetch operation with criteria: {company_account_number:14947} values: {company_account_number:14947} === 2014-04-29 21:31:06,330 [c-19] INFO SQLDataSource - [builtinApplication.company_account_add, builtinApplication.null] derived query: SELECT $defaultSelectClause FROM $defaultTableClause WHERE $defaultWhereClause === 2014-04-29 21:31:06,330 [c-19] INFO SQLDataSource - [builtinApplication.company_account_add, builtinApplication.null] 126: Executing SQL query on 'Mysql': SELECT company_account.comment, company_account.company_account_number, company_account.company_id, company_account.discount_perc, company_account.doctor_contact_number, company_account.doctor_name, company_account.medical_aid_name, company_account.medical_aid_number, company_account.medical_aid_plan, company_account.medical_aid_principle_name, company_account.misc1, company_account.payment_terms_cd, company_account.start_d, company_account.status_cd, company_account.surname FROM company_account WHERE (company_account.company_account_number=14947) === 2014-04-29 21:31:06,331 [c-19] DEBUG SQLDriver - [builtinApplication.company_account_add, builtinApplication.null] About to execute SQL query in 'Mysql' using connection '1892008743' === 2014-04-29 21:31:06,331 [c-19] INFO SQLDriver - [builtinApplication.company_account_add, builtinApplication.null] Executing SQL query on 'Mysql': SELECT company_account.comment, company_account.company_account_number, company_account.company_id, company_account.discount_perc, company_account.doctor_contact_number, company_account.doctor_name, company_account.medical_aid_name, company_account.medical_aid_number, company_account.medical_aid_plan, company_account.medical_aid_principle_name, company_account.misc1, company_account.payment_terms_cd, company_account.start_d, company_account.status_cd, company_account.surname FROM company_account WHERE (company_account.company_account_number=14947) === 2014-04-29 21:31:06,332 [c-19] INFO DSResponse - [builtinApplication.company_account_add, builtinApplication.null] DSResponse: List with 1 items === 2014-04-29 21:31:06,332 [c-19] INFO DSResponse - [builtinApplication.company_account_add] DSResponse: List with 1 items === 2014-04-29 21:31:06,332 [c-19] DEBUG DeclarativeSecurity - Processing security checks for DataSource null, field null === 2014-04-29 21:31:06,332 [c-19] DEBUG DeclarativeSecurity - DataSource register_account_person is not in the pre-checked list, processing... === 2014-04-29 21:31:06,338 [c-19] DEBUG DeclarativeSecurity - Processing security checks for DataSource null, field null === 2014-04-29 21:31:06,338 [c-19] DEBUG AppBase - [builtinApplication.null] No userTypes defined, allowing anyone access to all operations for this application === 2014-04-29 21:31:06,338 [c-19] DEBUG AppBase - [builtinApplication.null] No public zero-argument method named '_null' found, performing generic datasource operation === 2014-04-29 21:31:06,338 [c-19] INFO SQLDataSource - [builtinApplication.null] Performing fetch operation with criteria: {company_id:3,email:"henkiemaritz@iits.co.za"} values: {company_id:3,email:"henkiemaritz@iits.co.za"} === 2014-04-29 21:31:06,338 [c-19] INFO SQLDataSource - [builtinApplication.null] derived query: SELECT $defaultSelectClause FROM $defaultTableClause WHERE $defaultWhereClause === 2014-04-29 21:31:06,339 [c-19] INFO SQLDataSource - [builtinApplication.null] 505: Executing SQL query on 'Mysql': SELECT company_person.birth_d, company_person.cell_number, company_person.comment, company_person.company_id, company_person.company_person_id, company_person.contact_number_h, company_person.contact_number_w, company_person.email, company_person.gender_cd, company_person.id_number, company_person.name, company_person.password, company_person.postal_addr_city, company_person.postal_addr_code, company_person.postal_addr_line1, company_person.postal_addr_line2, company_person.postal_addr_suburb, company_person.street_addr_city, company_person.street_addr_code, company_person.street_addr_line1, company_person.street_addr_line2, company_person.street_addr_suburb, company_person.surname, company_person.title_cd FROM company_person WHERE (company_person.company_id=3 AND company_person.email='henkiemaritz@iits.co.za') === 2014-04-29 21:31:06,339 [c-19] DEBUG PoolableSQLConnectionFactory - [builtinApplication.null] Executing pingTest 'select 1 from dual' on connection 1892008743 === 2014-04-29 21:31:06,339 [c-19] DEBUG SQLConnectionManager - [builtinApplication.null] Borrowed connection '1892008743' === 2014-04-29 21:31:06,339 [c-19] DEBUG SQLDriver - [builtinApplication.null] About to execute SQL query in 'Mysql' using connection '1892008743' === 2014-04-29 21:31:06,339 [c-19] INFO SQLDriver - [builtinApplication.null] Executing SQL query on 'Mysql': SELECT company_person.birth_d, company_person.cell_number, company_person.comment, company_person.company_id, company_person.company_person_id, company_person.contact_number_h, company_person.contact_number_w, company_person.email, company_person.gender_cd, company_person.id_number, company_person.name, company_person.password, company_person.postal_addr_city, company_person.postal_addr_code, company_person.postal_addr_line1, company_person.postal_addr_line2, company_person.postal_addr_suburb, company_person.street_addr_city, company_person.street_addr_code, company_person.street_addr_line1, company_person.street_addr_line2, company_person.street_addr_suburb, company_person.surname, company_person.title_cd FROM company_person WHERE (company_person.company_id=3 AND company_person.email='henkiemaritz@iits.co.za') === 2014-04-29 21:31:06,340 [c-19] INFO DSResponse - [builtinApplication.null] DSResponse: List with 1 items === 2014-04-29 21:31:06,341 [c-19] DEBUG SQLDriver - Freeing SQLDriver dbConnection 1892008743 === 2014-04-29 21:31:06,419 [c-19] DEBUG SQLConnectionManager - About to close PoolableConnection with hashcode "1892008743" === 2014-04-29 21:31:06,420 [c-19] DEBUG PoolableSQLConnectionFactory - Executing pingTest 'select 1 from dual' on connection 1892008743 === 2014-04-29 21:31:06,420 [c-19] DEBUG DataSourceDMI - Invocation threw exception java.lang.Exception: email There is already a person using the following email address: henkiemaritz@iits.co.za Either use another email or contact support@iits.co.za if it is your email address. at za.co.adminonline.br.DataValidationServices.isEmailCompanyDuplicate(DataValidationServices.java:26) at za.co.adminonline.br.CompanyPerson.addPerson(CompanyPerson.java:30) at za.co.adminonline.br.CompanyAccount.userRegisterSubmitNewMember(CompanyAccount.java:85) at za.co.adminonline.br.CompanyAccount.userRegisterSubmit(CompanyAccount.java:40) at za.co.adminonline.dmi.RegisterCompanyDMI.add(RegisterCompanyDMI.java:18) === 2014-04-29 21:31:06,422 [c-19] DEBUG DeclarativeSecurity - Processing security checks for DataSource null, field null === 2014-04-29 21:31:06,422 [c-19] DEBUG DeclarativeSecurity - DataSource register_account_person is not in the pre-checked list, processing... === 2014-04-29 21:31:06,428 [c-19] DEBUG DeclarativeSecurity - Processing security checks for DataSource null, field null === 2014-04-29 21:31:06,428 [c-19] DEBUG AppBase - [builtinApplication.null] No userTypes defined, allowing anyone access to all operations for this application === 2014-04-29 21:31:06,428 [c-19] DEBUG AppBase - [builtinApplication.null] No public zero-argument method named '_null' found, performing generic datasource operation === 2014-04-29 21:31:06,428 [c-19] INFO SQLDataSource - [builtinApplication.null] Performing fetch operation with criteria: {company_id:3,email:"nerina@iits.co.za"} values: {company_id:3,email:"nerina@iits.co.za"} === 2014-04-29 21:31:06,428 [c-19] INFO SQLDataSource - [builtinApplication.null] derived query: SELECT $defaultSelectClause FROM $defaultTableClause WHERE $defaultWhereClause === 2014-04-29 21:31:06,429 [c-19] INFO SQLDataSource - [builtinApplication.null] 505: Executing SQL query on 'Mysql': SELECT company_person.birth_d, company_person.cell_number, company_person.comment, company_person.company_id, company_person.company_person_id, company_person.contact_number_h, company_person.contact_number_w, company_person.email, company_person.gender_cd, company_person.id_number, company_person.name, company_person.password, company_person.postal_addr_city, company_person.postal_addr_code, company_person.postal_addr_line1, company_person.postal_addr_line2, company_person.postal_addr_suburb, company_person.street_addr_city, company_person.street_addr_code, company_person.street_addr_line1, company_person.street_addr_line2, company_person.street_addr_suburb, company_person.surname, company_person.title_cd FROM company_person WHERE (company_person.company_id=3 AND company_person.email='nerina@iits.co.za') === 2014-04-29 21:31:06,429 [c-19] DEBUG PoolableSQLConnectionFactory - [builtinApplication.null] Executing pingTest 'select 1 from dual' on connection 1892008743 === 2014-04-29 21:31:06,429 [c-19] DEBUG SQLConnectionManager - [builtinApplication.null] Borrowed connection '1892008743' === 2014-04-29 21:31:06,429 [c-19] DEBUG SQLDriver - [builtinApplication.null] About to execute SQL query in 'Mysql' using connection '1892008743' === 2014-04-29 21:31:06,429 [c-19] INFO SQLDriver - [builtinApplication.null] Executing SQL query on 'Mysql': SELECT company_person.birth_d, company_person.cell_number, company_person.comment, company_person.company_id, company_person.company_person_id, company_person.contact_number_h, company_person.contact_number_w, company_person.email, company_person.gender_cd, company_person.id_number, company_person.name, company_person.password, company_person.postal_addr_city, company_person.postal_addr_code, company_person.postal_addr_line1, company_person.postal_addr_line2, company_person.postal_addr_suburb, company_person.street_addr_city, company_person.street_addr_code, company_person.street_addr_line1, company_person.street_addr_line2, company_person.street_addr_suburb, company_person.surname, company_person.title_cd FROM company_person WHERE (company_person.company_id=3 AND company_person.email='nerina@iits.co.za') === 2014-04-29 21:31:06,430 [c-19] INFO DSResponse - [builtinApplication.null] DSResponse: List with 1 items === 2014-04-29 21:31:06,430 [c-19] DEBUG SQLDriver - Freeing SQLDriver dbConnection 1892008743 === 2014-04-29 21:31:06,430 [c-19] DEBUG SQLConnectionManager - About to close PoolableConnection with hashcode "1892008743" === 2014-04-29 21:31:06,430 [c-19] DEBUG PoolableSQLConnectionFactory - Executing pingTest 'select 1 from dual' on connection 1892008743 === 2014-04-29 21:31:06,430 [c-19] DEBUG DataSourceDMI - Invocation threw exception java.lang.Exception: email There is already a person using the following email address: nerina@iits.co.za Either use another email or contact support@iits.co.za if it is your email address. at za.co.adminonline.br.DataValidationServices.isEmailCompanyDuplicate(DataValidationServices.java:26) at za.co.adminonline.br.CompanyPerson.addPerson(CompanyPerson.java:30) at za.co.adminonline.br.CompanyAccount.userRegisterSubmitNewMember(CompanyAccount.java:85) at za.co.adminonline.br.CompanyAccount.userRegisterSubmit(CompanyAccount.java:40) at za.co.adminonline.dmi.RegisterCompanyDMI.add(RegisterCompanyDMI.java:18)