=== 2016-08-11 11:51:13,583 [ec-5] INFO IDACall - Performing 1 operation(s) === 2016-08-11 11:51:13,583 [ec-5] DEBUG DeclarativeSecurity - Processing security checks for DataSource null, field null === 2016-08-11 11:51:13,587 [ec-5] DEBUG DeclarativeSecurity - DataSource company is not in the pre-checked list, processing... === 2016-08-11 11:51:13,594 [ec-5] DEBUG DeclarativeSecurity - Processing security checks for DataSource null, field null === 2016-08-11 11:51:13,595 [ec-5] DEBUG DeclarativeSecurity - DataSource company is not in the pre-checked list, processing... === 2016-08-11 11:51:13,596 [ec-5] DEBUG AppBase - [builtinApplication.company_update] No userTypes defined, allowing anyone access to all operations for this application === 2016-08-11 11:51:13,596 [ec-5] DEBUG AppBase - [builtinApplication.company_update] No public zero-argument method named '_company_update' found, performing generic datasource operation === 2016-08-11 11:51:13,599 [ec-5] INFO SQLDataSource - [builtinApplication.company_update] Performing update operation with criteria: {company_id:5} values: {company_id:5,postal_addr_code:"0000",street_addr_line2:"street_addr_line2",street_addr_line1:"street_addr_line1",advanced_billing:true,company_type:"coach",next_statement_run_dt:new Date(1458770400000),auto_statement_send:false,allow_multiple_service_selection:false,num_of_months_in_statement:6,no_payment_due:false,invoice_payment_instructions:"

Banking Details: Breakpoint Tennis Academy
FNB Cheque: 62420435754. Branch name: Eldoraigne. Branch code: 251145
EFT Reference MUST be the account number AND surname. For example: 10054 Maritz

",postal_addr_line2:"postal_addr_line2",street_addr_city:"street_addr_city",default_commission_cd:"No commission",status_cd:"Active",company_name:"Breakpoint Tennis Academy",postal_addr_line1:"postal_addr_line1",company_email_txt_invoice:"Account Number %s\n\nDear Mr/Mrs %s\n\nPlease find attached your latest statement that reflect the amount outstanding (or in credit) on your account.\nPlease note that payment is due on the 7th of each month.\n\nKind Regards\nTiaan",sms_budget_amount:200.0,registration_email_message:"Dear Mr/Mrs %s\n\nWelcome to %s.\n\nYou are now successfully registered on our AdminOnline system.\nYour new account number is: %s\n\nIMPORTANT: Please use this number in all your EFTs and correspondence.\n\nPlease note that our fees will be charged at month end.\nWe always charge for the coming month in advance.\nOn this date, you will receive a statement from us showing all account history and amount outstanding.\n\nWe will be loading registration fees and pro-rata fees if applicable before month end.\n\nYou can login to our AdminOnline system from this URL: http://breakpoint.adminonline.co.za\nUse this email address and the password supplied during registration to log in. If you don''t know your password, use the forget password button and form to retrieve it.\n\nFrom this login you will be able to:\n- View your latest statement\n- Send a message to us\n- Maintain your account\n\nCall us on 0825753165 or reply to this email should you have any questions or account queries.\n\nKind Regards\nTiaan",use_amazon_email:true,street_addr_code:"0000",member_reg_fee:125.0,company_short_name:"breakpoint",del_line_bank_days:5,registration_instruction:"Please state which weekdays and times will suit you best",next_billing_run_dt:new Date(1472076000000),bulk_sms_username:"integrityit",company_package_cd:"Professional",contact_number:"0126535187",member_transport_fee_std:0.0,iits_discount:20,postal_addr_suburb:"postal_addr_suburb",iits_sales_channel:"MSport",street_addr_suburb:"street_addr_suburb",bulk_sms_password:"Broombox#",email:"5@iits.co.za",due_date_dt:new Date(1470520800000),postal_addr_city:"postal_addr_city",per_account:false,registration_information:"\n

Here follows some important registration instructions

\n ",default_commission_perc:0.0,member_terms_and_conditions:"member_terms_and_conditions"} === 2016-08-11 11:51:13,624 [ec-5] DEBUG PoolableSQLConnectionFactory - [builtinApplication.company_update] Executing pingTest 'select 1 from dual' on connection 142454698 === 2016-08-11 11:51:13,625 [ec-5] DEBUG SQLConnectionManager - [builtinApplication.company_update] Borrowed connection '142454698' === 2016-08-11 11:51:13,626 [ec-5] DEBUG SQLTransaction - [builtinApplication.company_update] Started new Mysql transaction "142454698" === 2016-08-11 11:51:13,626 [ec-5] DEBUG SQLDriver - [builtinApplication.company_update] About to execute SQL update in 'Mysql' using connection'142454698' === 2016-08-11 11:51:13,627 [ec-5] INFO SQLDriver - [builtinApplication.company_update] Executing SQL update on 'Mysql': UPDATE company SET advanced_billing=1, allow_multiple_service_selection=0, auto_statement_send=0, bulk_sms_password='Broombox#', bulk_sms_username='integrityit', company_email_txt_invoice='Account Number %s Dear Mr/Mrs %s Please find attached your latest statement that reflect the amount outstanding (or in credit) on your account. Please note that payment is due on the 7th of each month. Kind Regards Tiaan', company_name='Breakpoint Tennis Academy', company_package_cd='Professional', company_short_name='breakpoint', company_type='coach', contact_number='0126535187', default_commission_cd='No commission', default_commission_perc=0.0, del_line_bank_days=5, due_date_dt='2016-08-07', email='5@iits.co.za', iits_discount=20, iits_sales_channel='MSport', invoice_payment_instructions='

Banking Details: Breakpoint Tennis Academy
FNB Cheque: 62420435754. Branch name: Eldoraigne. Branch code: 251145
EFT Reference MUST be the account number AND surname. For example: 10054 Maritz

', member_reg_fee=125.0, member_terms_and_conditions='member_terms_and_conditions', member_transport_fee_std=0.0, next_billing_run_dt='2016-08-25', next_statement_run_dt='2016-03-24', no_payment_due=0, num_of_months_in_statement=6, per_account=0, postal_addr_city='postal_addr_city', postal_addr_code='0000', postal_addr_line1='postal_addr_line1', postal_addr_line2='postal_addr_line2', postal_addr_suburb='postal_addr_suburb', registration_email_message='Dear Mr/Mrs %s Welcome to %s. You are now successfully registered on our AdminOnline system. Your new account number is: %s IMPORTANT: Please use this number in all your EFTs and correspondence. Please note that our fees will be charged at month end. We always charge for the coming month in advance. On this date, you will receive a statement from us showing all account history and amount outstanding. We will be loading registration fees and pro-rata fees if applicable before month end. You can login to our AdminOnline system from this URL: http://breakpoint.adminonline.co.za Use this email address and the password supplied during registration to log in. If you don''''t know your password, use the forget password button and form to retrieve it. From this login you will be able to: - View your latest statement - Send a message to us - Maintain your account Call us on 0825753165 or reply to this email should you have any questions or account queries. Kind Regards Tiaan', registration_information='

Here follows some important registration instructions

', registration_instruction='Please state which weekdays and times will suit you best', sms_budget_amount=200.0, status_cd='Active', street_addr_city='street_addr_city', street_addr_code='0000', street_addr_line1='street_addr_line1', street_addr_line2='street_addr_line2', street_addr_suburb='street_addr_suburb', use_amazon_email=1 WHERE (company.company_id=5) === 2016-08-11 11:51:13,737 [ec-5] DEBUG SQLDataSource - [builtinApplication.company_update] update operation affected 1 rows === 2016-08-11 11:51:13,739 [ec-5] INFO SQLDataSource - [builtinApplication.company_update] primaryKeys: {company_id=5} === 2016-08-11 11:51:13,740 [ec-5] DEBUG DeclarativeSecurity - [builtinApplication.company_update] Processing security checks for DataSource null, field null === 2016-08-11 11:51:13,740 [ec-5] DEBUG DeclarativeSecurity - [builtinApplication.company_update] DataSource company is not in the pre-checked list, processing... === 2016-08-11 11:51:13,741 [ec-5] DEBUG DeclarativeSecurity - [builtinApplication.company_update] Processing security checks for DataSource null, field null === 2016-08-11 11:51:13,742 [ec-5] DEBUG DeclarativeSecurity - [builtinApplication.company_update] DataSource company is not in the pre-checked list, processing... === 2016-08-11 11:51:13,742 [ec-5] DEBUG AppBase - [builtinApplication.company_update, builtinApplication.null] No userTypes defined, allowing anyone access to all operations for this application === 2016-08-11 11:51:13,742 [ec-5] DEBUG AppBase - [builtinApplication.company_update, builtinApplication.null] No public zero-argument method named '_null' found, performing generic datasource operation === 2016-08-11 11:51:13,743 [ec-5] INFO SQLDataSource - [builtinApplication.company_update, builtinApplication.null] Performing fetch operation with criteria: {company_id:5} values: {company_id:5} === 2016-08-11 11:51:13,744 [ec-5] INFO SQLDataSource - [builtinApplication.company_update, builtinApplication.null] derived query: SELECT $defaultSelectClause FROM $defaultTableClause WHERE $defaultWhereClause === 2016-08-11 11:51:13,745 [ec-5] INFO SQLDataSource - [builtinApplication.company_update, builtinApplication.null] 83: Executing SQL query on 'Mysql': SELECT company.company_id, company.company_name, company.status_cd, company.email, company.contact_number, company.fax_number, company.street_addr_line1, company.street_addr_line2, company.street_addr_suburb, company.street_addr_city, company.street_addr_code, company.postal_addr_line1, company.postal_addr_line2, company.postal_addr_suburb, company.postal_addr_city, company.company_type, company.postal_addr_code, company.member_reg_fee, company.member_transport_fee_std, company.member_terms_and_conditions, company.registration_email_message, company.registration_information, company.company_email_txt_invoice, company.default_commission_cd, company.default_commission_perc, company.next_billing_run_dt, company.due_date_dt, company.next_statement_run_dt, company.del_line_bank_days, company.num_of_months_in_statement, company.csv_last_imported_date, company.invoice_payment_instructions, company.sms_budget_amount, company.bulk_sms_username, company.bulk_sms_password, company.registration_instruction, company.iits_discount, company.iits_sales_channel, company.verification_hash, company.creation_dt, company.company_short_name, company.per_account, company.use_amazon_email, company.allow_multiple_service_selection, company.advanced_billing, company.auto_statement_send, company.no_payment_due, company.company_registration_number, company.company_vat_number, company.company_package_cd FROM company WHERE (company.company_id=5) === 2016-08-11 11:51:13,747 [ec-5] DEBUG SQLDriver - [builtinApplication.company_update, builtinApplication.null] About to execute SQL query in 'Mysql' using connection '142454698' === 2016-08-11 11:51:13,747 [ec-5] INFO SQLDriver - [builtinApplication.company_update, builtinApplication.null] Executing SQL query on 'Mysql': SELECT company.company_id, company.company_name, company.status_cd, company.email, company.contact_number, company.fax_number, company.street_addr_line1, company.street_addr_line2, company.street_addr_suburb, company.street_addr_city, company.street_addr_code, company.postal_addr_line1, company.postal_addr_line2, company.postal_addr_suburb, company.postal_addr_city, company.company_type, company.postal_addr_code, company.member_reg_fee, company.member_transport_fee_std, company.member_terms_and_conditions, company.registration_email_message, company.registration_information, company.company_email_txt_invoice, company.default_commission_cd, company.default_commission_perc, company.next_billing_run_dt, company.due_date_dt, company.next_statement_run_dt, company.del_line_bank_days, company.num_of_months_in_statement, company.csv_last_imported_date, company.invoice_payment_instructions, company.sms_budget_amount, company.bulk_sms_username, company.bulk_sms_password, company.registration_instruction, company.iits_discount, company.iits_sales_channel, company.verification_hash, company.creation_dt, company.company_short_name, company.per_account, company.use_amazon_email, company.allow_multiple_service_selection, company.advanced_billing, company.auto_statement_send, company.no_payment_due, company.company_registration_number, company.company_vat_number, company.company_package_cd FROM company WHERE (company.company_id=5) === 2016-08-11 11:51:13,753 [ec-5] INFO DSResponse - [builtinApplication.company_update, builtinApplication.null] DSResponse: List with 1 items === 2016-08-11 11:51:13,753 [ec-5] INFO DSResponse - [builtinApplication.company_update] DSResponse: List with 1 items === 2016-08-11 11:51:13,754 [ec-5] DEBUG RPCManager - Content type for RPC transaction: text/plain; charset=UTF-8 === 2016-08-11 11:51:13,754 [ec-5] DEBUG SQLTransaction - Committing Mysql transaction "142454698" === 2016-08-11 11:51:13,805 [ec-5] DEBUG RPCManager - DMI response, dropExtraFields: true === 2016-08-11 11:51:13,807 [ec-5] DEBUG SQLTransaction - getConnection() found transactional connection for Mysql with hashcode "142454698" === 2016-08-11 11:51:13,807 [ec-5] DEBUG SQLTransaction - Ending Mysql transaction "142454698" === 2016-08-11 11:51:13,807 [ec-5] DEBUG SQLConnectionManager - About to close with hashcode "142454698" === 2016-08-11 11:51:13,808 [ec-5] DEBUG PoolableSQLConnectionFactory - Executing pingTest 'select 1 from dual' on connection 142454698 === 2016-08-11 11:51:13,808 [ec-5] DEBUG PoolableDataSourceFactory - Cleared and passivated DataSource 83 of type 'company' === 2016-08-11 11:51:13,809 [ec-5] INFO Compression - /adminonline/version/10.0/isomorphic/IDACall: 4425 -> 1992 bytes === 2016-08-11 11:51:13,820 [ec-3] INFO RequestContext - URL: '/adminonline/version/10.0/isomorphic/IDACall', User-Agent: 'Mozilla/5.0 (Windows NT 10.0; WOW64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/52.0.2743.116 Safari/537.36': Safari with Accept-Encoding header === 2016-08-11 11:51:13,822 [ec-3] DEBUG IDACall - Header Name:Value pair: host:localhost:8080 === 2016-08-11 11:51:13,822 [ec-3] DEBUG IDACall - Header Name:Value pair: connection:keep-alive === 2016-08-11 11:51:13,823 [ec-1] INFO RequestContext - URL: '/adminonline/version/10.0/isomorphic/IDACall', User-Agent: 'Mozilla/5.0 (Windows NT 10.0; WOW64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/52.0.2743.116 Safari/537.36': Safari with Accept-Encoding header === 2016-08-11 11:51:13,823 [ec-3] DEBUG IDACall - Header Name:Value pair: content-length:1176 === 2016-08-11 11:51:13,824 [ec-3] DEBUG IDACall - Header Name:Value pair: origin:http://localhost:8080 === 2016-08-11 11:51:13,826 [ec-1] DEBUG IDACall - Header Name:Value pair: host:localhost:8080 === 2016-08-11 11:51:13,826 [ec-3] DEBUG IDACall - Header Name:Value pair: user-agent:Mozilla/5.0 (Windows NT 10.0; WOW64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/52.0.2743.116 Safari/537.36 === 2016-08-11 11:51:13,826 [ec-1] DEBUG IDACall - Header Name:Value pair: connection:keep-alive === 2016-08-11 11:51:13,831 [ec-3] DEBUG IDACall - Header Name:Value pair: content-type:application/x-www-form-urlencoded; charset=UTF-8 === 2016-08-11 11:51:13,831 [ec-1] DEBUG IDACall - Header Name:Value pair: content-length:1174 === 2016-08-11 11:51:13,831 [ec-3] DEBUG IDACall - Header Name:Value pair: accept:*/* === 2016-08-11 11:51:13,832 [ec-1] DEBUG IDACall - Header Name:Value pair: origin:http://localhost:8080 === 2016-08-11 11:51:13,835 [ec-3] DEBUG IDACall - Header Name:Value pair: referer:http://localhost:8080/adminonline/secure/index.jsp === 2016-08-11 11:51:13,835 [ec-1] DEBUG IDACall - Header Name:Value pair: user-agent:Mozilla/5.0 (Windows NT 10.0; WOW64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/52.0.2743.116 Safari/537.36 === 2016-08-11 11:51:13,839 [ec-3] DEBUG IDACall - Header Name:Value pair: accept-encoding:gzip, deflate === 2016-08-11 11:51:13,840 [ec-1] DEBUG IDACall - Header Name:Value pair: content-type:application/x-www-form-urlencoded; charset=UTF-8 === 2016-08-11 11:51:13,840 [ec-3] DEBUG IDACall - Header Name:Value pair: accept-language:en-US,en;q=0.8,af;q=0.6 === 2016-08-11 11:51:13,843 [ec-1] DEBUG IDACall - Header Name:Value pair: accept:*/* === 2016-08-11 11:51:13,844 [ec-3] DEBUG IDACall - Header Name:Value pair: cookie:JSESSIONID=CF1D1ACA547D6B4F1D3CD9F3B9992D38; svarIntCompanyId=5; svarStrCompanyDescr=Tiaan; isc_cState=ready; GLog=%7B%0D%20%20%20%20trackRPC%3Afalse%0D%7D === 2016-08-11 11:51:13,844 [ec-1] DEBUG IDACall - Header Name:Value pair: referer:http://localhost:8080/adminonline/secure/index.jsp === 2016-08-11 11:51:13,849 [ec-3] DEBUG IDACall - session exists: CF1D1ACA547D6B4F1D3CD9F3B9992D38 === 2016-08-11 11:51:13,849 [ec-3] DEBUG IDACall - remote user: null === 2016-08-11 11:51:13,849 [ec-1] DEBUG IDACall - Header Name:Value pair: accept-encoding:gzip, deflate === 2016-08-11 11:51:13,853 [ec-3] DEBUG XML - Parsed XML from (in memory stream): 2ms === 2016-08-11 11:51:13,853 [ec-1] DEBUG IDACall - Header Name:Value pair: accept-language:en-US,en;q=0.8,af;q=0.6 === 2016-08-11 11:51:13,854 [ec-3] DEBUG ISCKeyedObjectPool - Borrowing object for 'transaction' === 2016-08-11 11:51:13,854 [ec-1] DEBUG IDACall - Header Name:Value pair: cookie:JSESSIONID=CF1D1ACA547D6B4F1D3CD9F3B9992D38; svarIntCompanyId=5; svarStrCompanyDescr=Tiaan; isc_cState=ready; GLog=%7B%0D%20%20%20%20trackRPC%3Afalse%0D%7D === 2016-08-11 11:51:13,854 [ec-3] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'transaction' in the pooling flow === 2016-08-11 11:51:13,858 [ec-1] DEBUG IDACall - session exists: CF1D1ACA547D6B4F1D3CD9F3B9992D38 === 2016-08-11 11:51:13,858 [ec-1] DEBUG IDACall - remote user: null === 2016-08-11 11:51:13,858 [ec-3] DEBUG ISCKeyedObjectPool - Borrowing object for 'Object' === 2016-08-11 11:51:13,864 [ec-3] DEBUG PoolableDataSourceFactory - Created DataSource 646 of type 'Object' and assigned it to thread http-apr-8080-exec-3 === 2016-08-11 11:51:13,864 [ec-3] DEBUG PoolableDataSourceFactory - Created DataSource 646 of type 'Object' in the pooling flow === 2016-08-11 11:51:13,864 [ec-3] DEBUG PoolableDataSourceFactory - Activated DataSource 646 of type 'Object' === 2016-08-11 11:51:13,867 [ec-1] DEBUG XML - Parsed XML from (in memory stream): 2ms === 2016-08-11 11:51:13,868 [ec-1] DEBUG ISCKeyedObjectPool - Borrowing object for 'transaction' === 2016-08-11 11:51:13,869 [ec-1] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'transaction' in the pooling flow === 2016-08-11 11:51:13,869 [ec-1] DEBUG ISCKeyedObjectPool - Borrowing object for 'Object' === 2016-08-11 11:51:13,873 [ec-1] DEBUG PoolableDataSourceFactory - Created DataSource 647 of type 'Object' and assigned it to thread http-apr-8080-exec-1 === 2016-08-11 11:51:13,873 [ec-1] DEBUG PoolableDataSourceFactory - Created DataSource 647 of type 'Object' in the pooling flow === 2016-08-11 11:51:13,874 [ec-1] DEBUG PoolableDataSourceFactory - Activated DataSource 647 of type 'Object' === 2016-08-11 11:51:13,874 [ec-3] DEBUG ISCKeyedObjectPool - Borrowing object for 'List' === 2016-08-11 11:51:13,878 [ec-3] DEBUG PoolableDataSourceFactory - Created DataSource 648 of type 'List' and assigned it to thread http-apr-8080-exec-3 === 2016-08-11 11:51:13,878 [ec-3] DEBUG PoolableDataSourceFactory - Created DataSource 648 of type 'List' in the pooling flow === 2016-08-11 11:51:13,878 [ec-3] DEBUG PoolableDataSourceFactory - Activated DataSource 648 of type 'List' === 2016-08-11 11:51:13,879 [ec-1] DEBUG ISCKeyedObjectPool - Borrowing object for 'List' === 2016-08-11 11:51:13,884 [ec-1] DEBUG PoolableDataSourceFactory - Created DataSource 649 of type 'List' and assigned it to thread http-apr-8080-exec-1 === 2016-08-11 11:51:13,884 [ec-1] DEBUG PoolableDataSourceFactory - Created DataSource 649 of type 'List' in the pooling flow === 2016-08-11 11:51:13,884 [ec-1] DEBUG PoolableDataSourceFactory - Activated DataSource 649 of type 'List' === 2016-08-11 11:51:13,885 [ec-3] DEBUG ISCKeyedObjectPool - Borrowing object for 'elem' === 2016-08-11 11:51:13,888 [ec-3] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'elem' in the pooling flow === 2016-08-11 11:51:13,888 [ec-1] DEBUG ISCKeyedObjectPool - Borrowing object for 'elem' === 2016-08-11 11:51:13,888 [ec-1] DEBUG PoolableDataSourceFactory - Created DataSource null of type 'elem' in the pooling flow === 2016-08-11 11:51:13,889 [ec-3] DEBUG RPCManager - Processing 1 requests. === 2016-08-11 11:51:13,889 [ec-1] DEBUG RPCManager - Processing 1 requests. === 2016-08-11 11:51:13,892 [ec-3] DEBUG ISCKeyedObjectPool - Borrowing object for 'company_field_rules' === 2016-08-11 11:51:13,892 [ec-3] DEBUG PoolableDataSourceFactory - Activated DataSource 446 of type 'company_field_rules' === 2016-08-11 11:51:13,893 [ec-1] DEBUG ISCKeyedObjectPool - Borrowing object for 'company_config_var' === 2016-08-11 11:51:13,893 [ec-3] DEBUG RPCManager - Request #1 (DSRequest) payload: { criteria:{ _constructor:"AdvancedCriteria", fieldName:"company_id", operator:"equals", value:"5" }, operationConfig:{ dataSource:"company_field_rules", operationType:"fetch", textMatchStyle:"exact" }, appID:"builtinApplication", operation:"company_field_rules_fetch", oldValues:{ _constructor:"AdvancedCriteria", fieldName:"company_id", operator:"equals", value:"5" } } === 2016-08-11 11:51:13,898 [ec-1] DEBUG PoolableDataSourceFactory - Activated DataSource 450 of type 'company_config_var' === 2016-08-11 11:51:13,921 [ec-3] INFO IDACall - Performing 1 operation(s) === 2016-08-11 11:51:13,923 [ec-3] DEBUG DeclarativeSecurity - Processing security checks for DataSource null, field null === 2016-08-11 11:51:13,923 [ec-1] DEBUG RPCManager - Request #1 (DSRequest) payload: { criteria:{ _constructor:"AdvancedCriteria", fieldName:"company_id", operator:"equals", value:"5" }, operationConfig:{ dataSource:"company_config_var", operationType:"fetch", textMatchStyle:"exact" }, appID:"builtinApplication", operation:"company_config_var_fetch", oldValues:{ _constructor:"AdvancedCriteria", fieldName:"company_id", operator:"equals", value:"5" } } === 2016-08-11 11:51:13,925 [ec-3] DEBUG DeclarativeSecurity - DataSource company_field_rules is not in the pre-checked list, processing... === 2016-08-11 11:51:13,953 [ec-1] INFO IDACall - Performing 1 operation(s) === 2016-08-11 11:51:13,955 [ec-1] DEBUG DeclarativeSecurity - Processing security checks for DataSource null, field null === 2016-08-11 11:51:13,955 [ec-3] DEBUG DeclarativeSecurity - Processing security checks for DataSource null, field null === 2016-08-11 11:51:13,957 [ec-3] DEBUG DeclarativeSecurity - DataSource company_field_rules is not in the pre-checked list, processing... === 2016-08-11 11:51:13,957 [ec-1] DEBUG DeclarativeSecurity - DataSource company_config_var is not in the pre-checked list, processing... === 2016-08-11 11:51:13,957 [ec-3] DEBUG AppBase - [builtinApplication.company_field_rules_fetch] No userTypes defined, allowing anyone access to all operations for this application === 2016-08-11 11:51:13,957 [ec-1] DEBUG AppBase - [builtinApplication.company_config_var_fetch] No userTypes defined, allowing anyone access to all operations for this application === 2016-08-11 11:51:13,963 [ec-3] DEBUG AppBase - [builtinApplication.company_field_rules_fetch] No public zero-argument method named '_company_field_rules_fetch' found, performing generic datasource operation === 2016-08-11 11:51:13,963 [ec-1] DEBUG AppBase - [builtinApplication.company_config_var_fetch] No public zero-argument method named '_company_config_var_fetch' found, performing generic datasource operation === 2016-08-11 11:51:13,964 [ec-3] INFO SQLDataSource - [builtinApplication.company_field_rules_fetch] Performing fetch operation with criteria: {_constructor:"AdvancedCriteria",fieldName:"company_id",operator:"equals",value:"5"} values: {_constructor:"AdvancedCriteria",fieldName:"company_id",operator:"equals",value:"5"} === 2016-08-11 11:51:13,964 [ec-1] INFO SQLDataSource - [builtinApplication.company_config_var_fetch] Performing fetch operation with criteria: {_constructor:"AdvancedCriteria",fieldName:"company_id",operator:"equals",value:"5"} values: {_constructor:"AdvancedCriteria",fieldName:"company_id",operator:"equals",value:"5"} === 2016-08-11 11:51:13,967 [ec-3] INFO SQLDataSource - [builtinApplication.company_field_rules_fetch] derived query: SELECT $defaultSelectClause FROM $defaultTableClause WHERE $defaultWhereClause === 2016-08-11 11:51:13,967 [ec-1] INFO SQLDataSource - [builtinApplication.company_config_var_fetch] derived query: SELECT $defaultSelectClause FROM $defaultTableClause WHERE $defaultWhereClause === 2016-08-11 11:51:13,976 [ec-3] INFO SQLDataSource - [builtinApplication.company_field_rules_fetch] 446: Executing SQL query on 'Mysql': SELECT company_field_rules.company_id, company_field_rules.field_cd, company_field_rules.field_name, company_field_rules.misc_label, company_field_rules.field_state_cd FROM company_field_rules WHERE (company_field_rules.company_id = 5 AND company_field_rules.company_id IS NOT NULL) === 2016-08-11 11:51:13,976 [ec-1] INFO SQLDataSource - [builtinApplication.company_config_var_fetch] 450: Executing SQL query on 'Mysql': SELECT company_config_var.company_id, company_config_var.config_var_cd, company_config_var.config_value FROM company_config_var WHERE (company_config_var.company_id = 5 AND company_config_var.company_id IS NOT NULL) === 2016-08-11 11:51:13,977 [ec-3] DEBUG PoolableSQLConnectionFactory - [builtinApplication.company_field_rules_fetch] Executing pingTest 'select 1 from dual' on connection 142454698 === 2016-08-11 11:51:13,981 [ec-3] DEBUG SQLConnectionManager - [builtinApplication.company_field_rules_fetch] Borrowed connection '142454698' === 2016-08-11 11:51:13,981 [ec-1] DEBUG PoolableSQLConnectionFactory - [builtinApplication.company_config_var_fetch] Executing pingTest 'select 1 from dual' on connection 1466198345 === 2016-08-11 11:51:13,981 [ec-3] DEBUG SQLDriver - [builtinApplication.company_field_rules_fetch] About to execute SQL query in 'Mysql' using connection '142454698' === 2016-08-11 11:51:13,984 [ec-3] INFO SQLDriver - [builtinApplication.company_field_rules_fetch] Executing SQL query on 'Mysql': SELECT company_field_rules.company_id, company_field_rules.field_cd, company_field_rules.field_name, company_field_rules.misc_label, company_field_rules.field_state_cd FROM company_field_rules WHERE (company_field_rules.company_id = 5 AND company_field_rules.company_id IS NOT NULL) === 2016-08-11 11:51:13,985 [ec-1] DEBUG SQLConnectionManager - [builtinApplication.company_config_var_fetch] Borrowed connection '1466198345' === 2016-08-11 11:51:13,988 [ec-1] DEBUG SQLDriver - [builtinApplication.company_config_var_fetch] About to execute SQL query in 'Mysql' using connection '1466198345' === 2016-08-11 11:51:13,988 [ec-1] INFO SQLDriver - [builtinApplication.company_config_var_fetch] Executing SQL query on 'Mysql': SELECT company_config_var.company_id, company_config_var.config_var_cd, company_config_var.config_value FROM company_config_var WHERE (company_config_var.company_id = 5 AND company_config_var.company_id IS NOT NULL) === 2016-08-11 11:51:13,990 [ec-1] INFO DSResponse - [builtinApplication.company_config_var_fetch] DSResponse: List with 0 items === 2016-08-11 11:51:13,990 [ec-3] INFO DSResponse - [builtinApplication.company_field_rules_fetch] DSResponse: List with 47 items === 2016-08-11 11:51:13,995 [ec-1] DEBUG RPCManager - Content type for RPC transaction: text/plain; charset=UTF-8 === 2016-08-11 11:51:13,995 [ec-3] DEBUG RPCManager - Content type for RPC transaction: text/plain; charset=UTF-8 === 2016-08-11 11:51:13,995 [ec-1] DEBUG RPCManager - non-DMI response, dropExtraFields: false === 2016-08-11 11:51:13,996 [ec-3] DEBUG RPCManager - DMI response, dropExtraFields: true === 2016-08-11 11:51:14,000 [ec-1] DEBUG SQLDriver - Freeing SQLDriver dbConnection 1466198345 === 2016-08-11 11:51:14,001 [ec-1] DEBUG SQLConnectionManager - About to close with hashcode "1466198345" === 2016-08-11 11:51:14,001 [ec-1] DEBUG PoolableSQLConnectionFactory - Executing pingTest 'select 1 from dual' on connection 1466198345 === 2016-08-11 11:51:14,002 [ec-3] DEBUG SQLDriver - Freeing SQLDriver dbConnection 142454698 === 2016-08-11 11:51:14,008 [ec-3] DEBUG SQLConnectionManager - About to close with hashcode "142454698" === 2016-08-11 11:51:14,008 [ec-1] DEBUG PoolableDataSourceFactory - Cleared and passivated DataSource 450 of type 'company_config_var' === 2016-08-11 11:51:14,008 [ec-3] DEBUG PoolableSQLConnectionFactory - Executing pingTest 'select 1 from dual' on connection 142454698 === 2016-08-11 11:51:14,008 [ec-1] INFO Compression - /adminonline/version/10.0/isomorphic/IDACall: 188 -> 152 bytes === 2016-08-11 11:51:14,013 [ec-3] DEBUG PoolableDataSourceFactory - Cleared and passivated DataSource 446 of type 'company_field_rules' === 2016-08-11 11:51:14,014 [ec-3] INFO Compression - /adminonline/version/10.0/isomorphic/IDACall: 7674 -> 1008 bytes