before and after retrieve Logic Hook debugging

Hello all,
We have alot of custom modules in our Suite CRM version - 7.4.3. Our system is very slow specifically when we are using custom modules. I enabled debug logs and found there are multiple before_retrieve and after_retrieve logic hooks running , that show errors in case of empty fields. Most of these hooks have 12 runs . One hook running 12 times each. I need to know if there is a way to disable the logic hooks for activity modules like Meetings-Users, Contacts->Calls etc. I don’t see these logic hooks in logic_hook.php in custom->module folder.

I am also attaching my logs .
Please guide me how can i debug if logic hook is the issue for slow performance. My query retrieval timings are also fine so i dont think that DB indexing will solve the issue.
Please note we will upgrade to 7.10.14 in 2 weeks but we believe something is wrong with the logic hook.

Below a snapshot to my logs:

 
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Hook called: Cproj_order_management01::before_retrieve
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Retrieve Cproj_order_management01 : SELECT cproj_order_management01.*,cproj_order_management01_cstm.* FROM cproj_order_management01  LEFT JOIN cproj_order_management01_cstm ON cproj_order_management01.id = cproj_order_management01_cstm.id_c  WHERE cproj_order_management01.id = '8fcd21bd-d60a-8f11-268a-5c8fa80d92c5' AND cproj_order_management01.deleted=0
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Limit Query:SELECT cproj_order_management01.*,cproj_order_management01_cstm.* FROM cproj_order_management01  LEFT JOIN cproj_order_management01_cstm ON cproj_order_management01.id = cproj_order_management01_cstm.id_c  WHERE cproj_order_management01.id = '8fcd21bd-d60a-8f11-268a-5c8fa80d92c5' AND cproj_order_management01.deleted=0 Start: 0 count: 1
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT cproj_order_management01.*,cproj_order_management01_cstm.* FROM cproj_order_management01  LEFT JOIN cproj_order_management01_cstm ON cproj_order_management01.id = cproj_order_management01_cstm.id_c  WHERE cproj_order_management01.id = '8fcd21bd-d60a-8f11-268a-5c8fa80d92c5' AND cproj_order_management01.deleted=0 LIMIT 0,1
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00068211555480957
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean[Cproj_order_management01].load_relationships, Loading relationship (assigned_user_id).
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean.load_relationships, Error Loading relationship (assigned_user_id)
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean[Cproj_order_management01].load_relationships, Loading relationship (assigned_user_id).
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean.load_relationships, Error Loading relationship (assigned_user_id)
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Hook called: Contacts::before_retrieve
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Retrieve Contact : SELECT contacts.*,contacts_cstm.* FROM contacts  LEFT JOIN contacts_cstm ON contacts.id = contacts_cstm.id_c  WHERE contacts.id = '7ee8e3eb-dd65-6a6a-12c4-5ca75ce89506' AND contacts.deleted=0
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Limit Query:SELECT contacts.*,contacts_cstm.* FROM contacts  LEFT JOIN contacts_cstm ON contacts.id = contacts_cstm.id_c  WHERE contacts.id = '7ee8e3eb-dd65-6a6a-12c4-5ca75ce89506' AND contacts.deleted=0 Start: 0 count: 1
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT contacts.*,contacts_cstm.* FROM contacts  LEFT JOIN contacts_cstm ON contacts.id = contacts_cstm.id_c  WHERE contacts.id = '7ee8e3eb-dd65-6a6a-12c4-5ca75ce89506' AND contacts.deleted=0 LIMIT 0,1
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00074601173400879
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT acc.id, acc.name, con_reports_to.first_name, con_reports_to.last_name
		from contacts
		left join accounts_contacts a_c on a_c.contact_id = '7ee8e3eb-dd65-6a6a-12c4-5ca75ce89506' and a_c.deleted=0
		left join accounts acc on a_c.account_id = acc.id and acc.deleted=0
		left join contacts con_reports_to on con_reports_to.id = contacts.reports_to_id
		where contacts.id = '7ee8e3eb-dd65-6a6a-12c4-5ca75ce89506' ORDER BY a_c.date_modified DESC
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.0009150505065918
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean[Contact].load_relationships, Loading relationship (user_sync).
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT user_id id FROM contacts_users  WHERE contacts_users.contact_id = '7ee8e3eb-dd65-6a6a-12c4-5ca75ce89506' AND contacts_users.deleted=0
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00045180320739746
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT ea.email_address, ea.email_address_caps, ea.invalid_email, ea.opt_out, ea.date_created, ea.date_modified,
                ear.id, ear.email_address_id, ear.bean_id, ear.bean_module, ear.primary_address, ear.reply_to_address, ear.deleted
                FROM email_addresses ea LEFT JOIN email_addr_bean_rel ear ON ea.id = ear.email_address_id
                WHERE ear.bean_module = 'Contacts'
                AND ear.bean_id = '7ee8e3eb-dd65-6a6a-12c4-5ca75ce89506'
                AND ear.deleted = 0
                ORDER BY ear.reply_to_address, ear.primary_address DESC
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00072002410888672
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Hook called: Contacts::after_retrieve
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT id ,LTRIM(RTRIM(CONCAT(IFNULL(contacts.first_name,''),' ',IFNULL(contacts.last_name,'')))) as om_admin_dept_reference_c , contacts.assigned_user_id owner FROM contacts WHERE deleted=0 AND id='7ee8e3eb-dd65-6a6a-12c4-5ca75ce89506'
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00053286552429199
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Hook called: Contacts::before_retrieve
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Retrieve Contact : SELECT contacts.*,contacts_cstm.* FROM contacts  LEFT JOIN contacts_cstm ON contacts.id = contacts_cstm.id_c  WHERE contacts.id = '8f7a0d60-d91d-e819-6eb3-5541e2bf0268' AND contacts.deleted=0
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Limit Query:SELECT contacts.*,contacts_cstm.* FROM contacts  LEFT JOIN contacts_cstm ON contacts.id = contacts_cstm.id_c  WHERE contacts.id = '8f7a0d60-d91d-e819-6eb3-5541e2bf0268' AND contacts.deleted=0 Start: 0 count: 1
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT contacts.*,contacts_cstm.* FROM contacts  LEFT JOIN contacts_cstm ON contacts.id = contacts_cstm.id_c  WHERE contacts.id = '8f7a0d60-d91d-e819-6eb3-5541e2bf0268' AND contacts.deleted=0 LIMIT 0,1
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00058078765869141
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT acc.id, acc.name, con_reports_to.first_name, con_reports_to.last_name
		from contacts
		left join accounts_contacts a_c on a_c.contact_id = '8f7a0d60-d91d-e819-6eb3-5541e2bf0268' and a_c.deleted=0
		left join accounts acc on a_c.account_id = acc.id and acc.deleted=0
		left join contacts con_reports_to on con_reports_to.id = contacts.reports_to_id
		where contacts.id = '8f7a0d60-d91d-e819-6eb3-5541e2bf0268' ORDER BY a_c.date_modified DESC
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00088095664978027
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean[Contact].load_relationships, Loading relationship (user_sync).
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT user_id id FROM contacts_users  WHERE contacts_users.contact_id = '8f7a0d60-d91d-e819-6eb3-5541e2bf0268' AND contacts_users.deleted=0
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00047206878662109
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT ea.email_address, ea.email_address_caps, ea.invalid_email, ea.opt_out, ea.date_created, ea.date_modified,
                ear.id, ear.email_address_id, ear.bean_id, ear.bean_module, ear.primary_address, ear.reply_to_address, ear.deleted
                FROM email_addresses ea LEFT JOIN email_addr_bean_rel ear ON ea.id = ear.email_address_id
                WHERE ear.bean_module = 'Contacts'
                AND ear.bean_id = '8f7a0d60-d91d-e819-6eb3-5541e2bf0268'
                AND ear.deleted = 0
                ORDER BY ear.reply_to_address, ear.primary_address DESC
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00074291229248047
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Hook called: Contacts::after_retrieve
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT id ,LTRIM(RTRIM(CONCAT(IFNULL(contacts.first_name,''),' ',IFNULL(contacts.last_name,'')))) as om_client_reference , contacts.assigned_user_id owner FROM contacts WHERE deleted=0 AND id='8f7a0d60-d91d-e819-6eb3-5541e2bf0268'
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00055503845214844
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Hook called: Accounts::before_retrieve
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Retrieve Account : SELECT accounts.*,accounts_cstm.* FROM accounts  LEFT JOIN accounts_cstm ON accounts.id = accounts_cstm.id_c  WHERE accounts.id = 'b66e7834-80ed-6ef7-f1b6-5bf299262a26' AND accounts.deleted=0
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Limit Query:SELECT accounts.*,accounts_cstm.* FROM accounts  LEFT JOIN accounts_cstm ON accounts.id = accounts_cstm.id_c  WHERE accounts.id = 'b66e7834-80ed-6ef7-f1b6-5bf299262a26' AND accounts.deleted=0 Start: 0 count: 1
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT accounts.*,accounts_cstm.* FROM accounts  LEFT JOIN accounts_cstm ON accounts.id = accounts_cstm.id_c  WHERE accounts.id = 'b66e7834-80ed-6ef7-f1b6-5bf299262a26' AND accounts.deleted=0 LIMIT 0,1
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00069379806518555
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT a1.name from accounts a1, accounts a2 where a1.id = a2.parent_id and a2.id = 'b66e7834-80ed-6ef7-f1b6-5bf299262a26' and a1.deleted=0
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.0005190372467041
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT ea.email_address, ea.email_address_caps, ea.invalid_email, ea.opt_out, ea.date_created, ea.date_modified,
                ear.id, ear.email_address_id, ear.bean_id, ear.bean_module, ear.primary_address, ear.reply_to_address, ear.deleted
                FROM email_addresses ea LEFT JOIN email_addr_bean_rel ear ON ea.id = ear.email_address_id
                WHERE ear.bean_module = 'Accounts'
                AND ear.bean_id = 'b66e7834-80ed-6ef7-f1b6-5bf299262a26'
                AND ear.deleted = 0
                ORDER BY ear.reply_to_address, ear.primary_address DESC
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00073409080505371
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Hook called: Accounts::after_retrieve
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT id ,accounts.name as om_fiscal_account_c , accounts.assigned_user_id owner FROM accounts WHERE deleted=0 AND id='b66e7834-80ed-6ef7-f1b6-5bf299262a26'
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00044608116149902
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Hook called: Accounts::before_retrieve
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Retrieve Account : SELECT accounts.*,accounts_cstm.* FROM accounts  LEFT JOIN accounts_cstm ON accounts.id = accounts_cstm.id_c  WHERE accounts.id = 'baf9cf1d-407c-0db9-dbfd-5be014cea5a1' AND accounts.deleted=0
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Limit Query:SELECT accounts.*,accounts_cstm.* FROM accounts  LEFT JOIN accounts_cstm ON accounts.id = accounts_cstm.id_c  WHERE accounts.id = 'baf9cf1d-407c-0db9-dbfd-5be014cea5a1' AND accounts.deleted=0 Start: 0 count: 1
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT accounts.*,accounts_cstm.* FROM accounts  LEFT JOIN accounts_cstm ON accounts.id = accounts_cstm.id_c  WHERE accounts.id = 'baf9cf1d-407c-0db9-dbfd-5be014cea5a1' AND accounts.deleted=0 LIMIT 0,1
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00068283081054688
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT a1.name from accounts a1, accounts a2 where a1.id = a2.parent_id and a2.id = 'baf9cf1d-407c-0db9-dbfd-5be014cea5a1' and a1.deleted=0
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00046300888061523
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT ea.email_address, ea.email_address_caps, ea.invalid_email, ea.opt_out, ea.date_created, ea.date_modified,
                ear.id, ear.email_address_id, ear.bean_id, ear.bean_module, ear.primary_address, ear.reply_to_address, ear.deleted
                FROM email_addresses ea LEFT JOIN email_addr_bean_rel ear ON ea.id = ear.email_address_id
                WHERE ear.bean_module = 'Accounts'
                AND ear.bean_id = 'baf9cf1d-407c-0db9-dbfd-5be014cea5a1'
                AND ear.deleted = 0
                ORDER BY ear.reply_to_address, ear.primary_address DESC
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00056815147399902
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Hook called: Accounts::after_retrieve
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT id ,accounts.name as om_operation_account , accounts.assigned_user_id owner FROM accounts WHERE deleted=0 AND id='baf9cf1d-407c-0db9-dbfd-5be014cea5a1'
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00038409233093262
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Hook called: Contacts::before_retrieve
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Retrieve Contact : SELECT contacts.*,contacts_cstm.* FROM contacts  LEFT JOIN contacts_cstm ON contacts.id = contacts_cstm.id_c  WHERE contacts.id = '56839100-c153-120a-3c67-5c8fb4063ee6' AND contacts.deleted=0
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Limit Query:SELECT contacts.*,contacts_cstm.* FROM contacts  LEFT JOIN contacts_cstm ON contacts.id = contacts_cstm.id_c  WHERE contacts.id = '56839100-c153-120a-3c67-5c8fb4063ee6' AND contacts.deleted=0 Start: 0 count: 1
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT contacts.*,contacts_cstm.* FROM contacts  LEFT JOIN contacts_cstm ON contacts.id = contacts_cstm.id_c  WHERE contacts.id = '56839100-c153-120a-3c67-5c8fb4063ee6' AND contacts.deleted=0 LIMIT 0,1
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.0005500316619873
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT acc.id, acc.name, con_reports_to.first_name, con_reports_to.last_name
		from contacts
		left join accounts_contacts a_c on a_c.contact_id = '56839100-c153-120a-3c67-5c8fb4063ee6' and a_c.deleted=0
		left join accounts acc on a_c.account_id = acc.id and acc.deleted=0
		left join contacts con_reports_to on con_reports_to.id = contacts.reports_to_id
		where contacts.id = '56839100-c153-120a-3c67-5c8fb4063ee6' ORDER BY a_c.date_modified DESC
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00085020065307617
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean[Contact].load_relationships, Loading relationship (user_sync).
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT user_id id FROM contacts_users  WHERE contacts_users.contact_id = '56839100-c153-120a-3c67-5c8fb4063ee6' AND contacts_users.deleted=0
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00045204162597656
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT ea.email_address, ea.email_address_caps, ea.invalid_email, ea.opt_out, ea.date_created, ea.date_modified,
                ear.id, ear.email_address_id, ear.bean_id, ear.bean_module, ear.primary_address, ear.reply_to_address, ear.deleted
                FROM email_addresses ea LEFT JOIN email_addr_bean_rel ear ON ea.id = ear.email_address_id
                WHERE ear.bean_module = 'Contacts'
                AND ear.bean_id = '56839100-c153-120a-3c67-5c8fb4063ee6'
                AND ear.deleted = 0
                ORDER BY ear.reply_to_address, ear.primary_address DESC
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00071096420288086
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Hook called: Contacts::after_retrieve
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT id ,LTRIM(RTRIM(CONCAT(IFNULL(contacts.first_name,''),' ',IFNULL(contacts.last_name,'')))) as om_invoicing_reference_c , contacts.assigned_user_id owner FROM contacts WHERE deleted=0 AND id='56839100-c153-120a-3c67-5c8fb4063ee6'
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.0004279613494873
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Hook called: Contacts::before_retrieve
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Retrieve Contact : SELECT contacts.*,contacts_cstm.* FROM contacts  LEFT JOIN contacts_cstm ON contacts.id = contacts_cstm.id_c  WHERE contacts.id = '13d90047-7b47-2e90-a2bd-5be01533e064' AND contacts.deleted=0
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Limit Query:SELECT contacts.*,contacts_cstm.* FROM contacts  LEFT JOIN contacts_cstm ON contacts.id = contacts_cstm.id_c  WHERE contacts.id = '13d90047-7b47-2e90-a2bd-5be01533e064' AND contacts.deleted=0 Start: 0 count: 1
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT contacts.*,contacts_cstm.* FROM contacts  LEFT JOIN contacts_cstm ON contacts.id = contacts_cstm.id_c  WHERE contacts.id = '13d90047-7b47-2e90-a2bd-5be01533e064' AND contacts.deleted=0 LIMIT 0,1
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.0005800724029541
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT acc.id, acc.name, con_reports_to.first_name, con_reports_to.last_name
		from contacts
		left join accounts_contacts a_c on a_c.contact_id = '13d90047-7b47-2e90-a2bd-5be01533e064' and a_c.deleted=0
		left join accounts acc on a_c.account_id = acc.id and acc.deleted=0
		left join contacts con_reports_to on con_reports_to.id = contacts.reports_to_id
		where contacts.id = '13d90047-7b47-2e90-a2bd-5be01533e064' ORDER BY a_c.date_modified DESC
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00079107284545898
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean[Contact].load_relationships, Loading relationship (user_sync).
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT user_id id FROM contacts_users  WHERE contacts_users.contact_id = '13d90047-7b47-2e90-a2bd-5be01533e064' AND contacts_users.deleted=0
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00040698051452637
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT ea.email_address, ea.email_address_caps, ea.invalid_email, ea.opt_out, ea.date_created, ea.date_modified,
                ear.id, ear.email_address_id, ear.bean_id, ear.bean_module, ear.primary_address, ear.reply_to_address, ear.deleted
                FROM email_addresses ea LEFT JOIN email_addr_bean_rel ear ON ea.id = ear.email_address_id
                WHERE ear.bean_module = 'Contacts'
                AND ear.bean_id = '13d90047-7b47-2e90-a2bd-5be01533e064'
                AND ear.deleted = 0
                ORDER BY ear.reply_to_address, ear.primary_address DESC
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00074601173400879
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Hook called: Contacts::after_retrieve
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT id ,LTRIM(RTRIM(CONCAT(IFNULL(contacts.first_name,''),' ',IFNULL(contacts.last_name,'')))) as payments_responsible_c , contacts.assigned_user_id owner FROM contacts WHERE deleted=0 AND id='13d90047-7b47-2e90-a2bd-5be01533e064'
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00045108795166016
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Hook called: Users::before_retrieve
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Retrieve User : SELECT users.*,users_cstm.* FROM users  LEFT JOIN users_cstm ON users.id = users_cstm.id_c  WHERE users.id = '10d2ef47-001e-1ac5-292c-4e85d572201f' AND users.deleted=0
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Limit Query:SELECT users.*,users_cstm.* FROM users  LEFT JOIN users_cstm ON users.id = users_cstm.id_c  WHERE users.id = '10d2ef47-001e-1ac5-292c-4e85d572201f' AND users.deleted=0 Start: 0 count: 1
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT users.*,users_cstm.* FROM users  LEFT JOIN users_cstm ON users.id = users_cstm.id_c  WHERE users.id = '10d2ef47-001e-1ac5-292c-4e85d572201f' AND users.deleted=0 LIMIT 0,1
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00055098533630371
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT u1.first_name, u1.last_name from users  u1, users  u2 where u1.id = u2.reports_to_id AND u2.id = '10d2ef47-001e-1ac5-292c-4e85d572201f' and u1.deleted=0
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00039386749267578
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT ea.email_address, ea.email_address_caps, ea.invalid_email, ea.opt_out, ea.date_created, ea.date_modified,
                ear.id, ear.email_address_id, ear.bean_id, ear.bean_module, ear.primary_address, ear.reply_to_address, ear.deleted
                FROM email_addresses ea LEFT JOIN email_addr_bean_rel ear ON ea.id = ear.email_address_id
                WHERE ear.bean_module = 'Users'
                AND ear.bean_id = '10d2ef47-001e-1ac5-292c-4e85d572201f'
                AND ear.deleted = 0
                ORDER BY ear.reply_to_address, ear.primary_address DESC
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.0006260871887207
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Hook called: Users::after_retrieve
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT id ,LTRIM(RTRIM(CONCAT(IFNULL(users.first_name,''),' ',IFNULL(users.last_name,'')))) as supervisor_c , users.created_by owner FROM users WHERE deleted=0 AND id='10d2ef47-001e-1ac5-292c-4e85d572201f'
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00040411949157715
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean[Cproj_order_management01].load_relationships, Loading relationship (b13_banca_cproj_order_management01b13_banca_ida).
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT b13_banca_cproj_order_management01b13_banca_ida id FROM b13_banca_cproj_order_management01_c  WHERE b13_banca_cproj_order_management01_c.b13_banca_cproj_order_management01cproj_order_management01_idb = '8fcd21bd-d60a-8f11-268a-5c8fa80d92c5' AND b13_banca_cproj_order_management01_c.deleted=0
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00041389465332031
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Hook called: Contacts::before_retrieve
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Retrieve Contact : SELECT contacts.*,contacts_cstm.* FROM contacts  LEFT JOIN contacts_cstm ON contacts.id = contacts_cstm.id_c  WHERE contacts.id = 'b3b25ccc-f569-e9b1-e96f-5bf29a057c31' AND contacts.deleted=0
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Limit Query:SELECT contacts.*,contacts_cstm.* FROM contacts  LEFT JOIN contacts_cstm ON contacts.id = contacts_cstm.id_c  WHERE contacts.id = 'b3b25ccc-f569-e9b1-e96f-5bf29a057c31' AND contacts.deleted=0 Start: 0 count: 1
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT contacts.*,contacts_cstm.* FROM contacts  LEFT JOIN contacts_cstm ON contacts.id = contacts_cstm.id_c  WHERE contacts.id = 'b3b25ccc-f569-e9b1-e96f-5bf29a057c31' AND contacts.deleted=0 LIMIT 0,1
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00054812431335449
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT acc.id, acc.name, con_reports_to.first_name, con_reports_to.last_name
		from contacts
		left join accounts_contacts a_c on a_c.contact_id = 'b3b25ccc-f569-e9b1-e96f-5bf29a057c31' and a_c.deleted=0
		left join accounts acc on a_c.account_id = acc.id and acc.deleted=0
		left join contacts con_reports_to on con_reports_to.id = contacts.reports_to_id
		where contacts.id = 'b3b25ccc-f569-e9b1-e96f-5bf29a057c31' ORDER BY a_c.date_modified DESC
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00081396102905273
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean[Contact].load_relationships, Loading relationship (user_sync).
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT user_id id FROM contacts_users  WHERE contacts_users.contact_id = 'b3b25ccc-f569-e9b1-e96f-5bf29a057c31' AND contacts_users.deleted=0
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00044488906860352
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT ea.email_address, ea.email_address_caps, ea.invalid_email, ea.opt_out, ea.date_created, ea.date_modified,
                ear.id, ear.email_address_id, ear.bean_id, ear.bean_module, ear.primary_address, ear.reply_to_address, ear.deleted
                FROM email_addresses ea LEFT JOIN email_addr_bean_rel ear ON ea.id = ear.email_address_id
                WHERE ear.bean_module = 'Contacts'
                AND ear.bean_id = 'b3b25ccc-f569-e9b1-e96f-5bf29a057c31'
                AND ear.deleted = 0
                ORDER BY ear.reply_to_address, ear.primary_address DESC
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00064706802368164
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Hook called: Contacts::after_retrieve
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT id ,LTRIM(RTRIM(CONCAT(IFNULL(contacts.first_name,''),' ',IFNULL(contacts.last_name,'')))) as purchasing_responsible_c , contacts.assigned_user_id owner FROM contacts WHERE deleted=0 AND id='b3b25ccc-f569-e9b1-e96f-5bf29a057c31'
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00041794776916504
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Hook called: Users::before_retrieve
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Retrieve User : SELECT users.*,users_cstm.* FROM users  LEFT JOIN users_cstm ON users.id = users_cstm.id_c  WHERE users.id = 'a1f7eeb5-5b92-caf6-8e42-56499f2c0d7b' AND users.deleted=0
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Limit Query:SELECT users.*,users_cstm.* FROM users  LEFT JOIN users_cstm ON users.id = users_cstm.id_c  WHERE users.id = 'a1f7eeb5-5b92-caf6-8e42-56499f2c0d7b' AND users.deleted=0 Start: 0 count: 1
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT users.*,users_cstm.* FROM users  LEFT JOIN users_cstm ON users.id = users_cstm.id_c  WHERE users.id = 'a1f7eeb5-5b92-caf6-8e42-56499f2c0d7b' AND users.deleted=0 LIMIT 0,1
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00051689147949219
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT u1.first_name, u1.last_name from users  u1, users  u2 where u1.id = u2.reports_to_id AND u2.id = 'a1f7eeb5-5b92-caf6-8e42-56499f2c0d7b' and u1.deleted=0
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00038290023803711
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT ea.email_address, ea.email_address_caps, ea.invalid_email, ea.opt_out, ea.date_created, ea.date_modified,
                ear.id, ear.email_address_id, ear.bean_id, ear.bean_module, ear.primary_address, ear.reply_to_address, ear.deleted
                FROM email_addresses ea LEFT JOIN email_addr_bean_rel ear ON ea.id = ear.email_address_id
                WHERE ear.bean_module = 'Users'
                AND ear.bean_id = 'a1f7eeb5-5b92-caf6-8e42-56499f2c0d7b'
                AND ear.deleted = 0
                ORDER BY ear.reply_to_address, ear.primary_address DESC
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00064682960510254
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Hook called: Users::after_retrieve
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT id ,LTRIM(RTRIM(CONCAT(IFNULL(users.first_name,''),' ',IFNULL(users.last_name,'')))) as sales_owner_c , users.created_by owner FROM users WHERE deleted=0 AND id='a1f7eeb5-5b92-caf6-8e42-56499f2c0d7b'
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00039482116699219
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Hook called: bap1_Business_Category::before_retrieve
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Retrieve bap1_Business_Category : SELECT bap1_business_category.* FROM bap1_business_category  WHERE bap1_business_category.id = 'a093b59b-280c-b315-5cb9-587de0fe7743' AND bap1_business_category.deleted=0
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Limit Query:SELECT bap1_business_category.* FROM bap1_business_category  WHERE bap1_business_category.id = 'a093b59b-280c-b315-5cb9-587de0fe7743' AND bap1_business_category.deleted=0 Start: 0 count: 1
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT bap1_business_category.* FROM bap1_business_category  WHERE bap1_business_category.id = 'a093b59b-280c-b315-5cb9-587de0fe7743' AND bap1_business_category.deleted=0 LIMIT 0,1
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00039815902709961
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Hook called: bap1_Business_Category::after_retrieve
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT id ,bap1_business_category.name as business_category_c , bap1_business_category.assigned_user_id owner FROM bap1_business_category WHERE deleted=0 AND id='a093b59b-280c-b315-5cb9-587de0fe7743'
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.0003669261932373
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Hook called: Users::before_retrieve
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Retrieve User : SELECT users.*,users_cstm.* FROM users  LEFT JOIN users_cstm ON users.id = users_cstm.id_c  WHERE users.id = '33b90dd4-6451-effa-3efa-521e1ea48aa2' AND users.deleted=0
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Limit Query:SELECT users.*,users_cstm.* FROM users  LEFT JOIN users_cstm ON users.id = users_cstm.id_c  WHERE users.id = '33b90dd4-6451-effa-3efa-521e1ea48aa2' AND users.deleted=0 Start: 0 count: 1
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT users.*,users_cstm.* FROM users  LEFT JOIN users_cstm ON users.id = users_cstm.id_c  WHERE users.id = '33b90dd4-6451-effa-3efa-521e1ea48aa2' AND users.deleted=0 LIMIT 0,1
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00050497055053711
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT u1.first_name, u1.last_name from users  u1, users  u2 where u1.id = u2.reports_to_id AND u2.id = '33b90dd4-6451-effa-3efa-521e1ea48aa2' and u1.deleted=0
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00042510032653809
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT ea.email_address, ea.email_address_caps, ea.invalid_email, ea.opt_out, ea.date_created, ea.date_modified,
                ear.id, ear.email_address_id, ear.bean_id, ear.bean_module, ear.primary_address, ear.reply_to_address, ear.deleted
                FROM email_addresses ea LEFT JOIN email_addr_bean_rel ear ON ea.id = ear.email_address_id
                WHERE ear.bean_module = 'Users'
                AND ear.bean_id = '33b90dd4-6451-effa-3efa-521e1ea48aa2'
                AND ear.deleted = 0
                ORDER BY ear.reply_to_address, ear.primary_address DESC
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00072383880615234
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Hook called: Users::after_retrieve
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT id ,LTRIM(RTRIM(CONCAT(IFNULL(users.first_name,''),' ',IFNULL(users.last_name,'')))) as project_manager_c , users.created_by owner FROM users WHERE deleted=0 AND id='33b90dd4-6451-effa-3efa-521e1ea48aa2'
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00041699409484863
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean[Cproj_order_management01].load_relationships, Loading relationship (user_id3_c).
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean.load_relationships, Error Loading relationship (user_id3_c)
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Hook called: PQE_Projects::before_retrieve
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Retrieve PQE_Projects : SELECT pqe_projects.* FROM pqe_projects  WHERE pqe_projects.id = '2ef405ff-d76f-f976-7fbc-5c8fa8c029a0' AND pqe_projects.deleted=0
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Limit Query:SELECT pqe_projects.* FROM pqe_projects  WHERE pqe_projects.id = '2ef405ff-d76f-f976-7fbc-5c8fa8c029a0' AND pqe_projects.deleted=0 Start: 0 count: 1
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT pqe_projects.* FROM pqe_projects  WHERE pqe_projects.id = '2ef405ff-d76f-f976-7fbc-5c8fa8c029a0' AND pqe_projects.deleted=0 LIMIT 0,1
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00042390823364258
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Hook called: PQE_Projects::after_retrieve
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT id ,pqe_projects.name as project_c , pqe_projects.assigned_user_id owner FROM pqe_projects WHERE deleted=0 AND id='2ef405ff-d76f-f976-7fbc-5c8fa8c029a0'
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00034594535827637
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Hook called: Users::before_retrieve
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Retrieve User : SELECT users.*,users_cstm.* FROM users  LEFT JOIN users_cstm ON users.id = users_cstm.id_c  WHERE users.id = '7ccafff3-5a1c-4a4c-85c2-df6a823a17bf' AND users.deleted=0
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Limit Query:SELECT users.*,users_cstm.* FROM users  LEFT JOIN users_cstm ON users.id = users_cstm.id_c  WHERE users.id = '7ccafff3-5a1c-4a4c-85c2-df6a823a17bf' AND users.deleted=0 Start: 0 count: 1
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT users.*,users_cstm.* FROM users  LEFT JOIN users_cstm ON users.id = users_cstm.id_c  WHERE users.id = '7ccafff3-5a1c-4a4c-85c2-df6a823a17bf' AND users.deleted=0 LIMIT 0,1
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00049710273742676

Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT u1.first_name, u1.last_name from users  u1, users  u2 where u1.id = u2.reports_to_id AND u2.id = '7ccafff3-5a1c-4a4c-85c2-df6a823a17bf' and u1.deleted=0
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00044608116149902
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT ea.email_address, ea.email_address_caps, ea.invalid_email, ea.opt_out, ea.date_created, ea.date_modified,
                ear.id, ear.email_address_id, ear.bean_id, ear.bean_module, ear.primary_address, ear.reply_to_address, ear.deleted
                FROM email_addresses ea LEFT JOIN email_addr_bean_rel ear ON ea.id = ear.email_address_id
                WHERE ear.bean_module = 'Users'
                AND ear.bean_id = '7ccafff3-5a1c-4a4c-85c2-df6a823a17bf'
                AND ear.deleted = 0
                ORDER BY ear.reply_to_address, ear.primary_address DESC
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00068497657775879
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Hook called: Users::after_retrieve
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT id ,LTRIM(RTRIM(CONCAT(IFNULL(users.first_name,''),' ',IFNULL(users.last_name,'')))) as accountant_c , users.created_by owner FROM users WHERE deleted=0 AND id='7ccafff3-5a1c-4a4c-85c2-df6a823a17bf'
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00046920776367188
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean[Cproj_order_management01].load_relationships, Loading relationship (b2_company_cproj_order_management01b2_company_ida).

Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT b2_company_cproj_order_management01b2_company_ida id FROM b2_company_cproj_order_management01_c  WHERE b2_company_cproj_order_management01_c.b2_company_cproj_order_management01cproj_order_management01_idb = '8fcd21bd-d60a-8f11-268a-5c8fa80d92c5' AND b2_company_cproj_order_management01_c.deleted=0
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.0005190372467041
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Hook called: b2_Company::before_retrieve
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Including module specific hook file for custom/modules/b2_Company
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Retrieve b2_Company : SELECT b2_company.*,b2_company_cstm.* FROM b2_company  LEFT JOIN b2_company_cstm ON b2_company.id = b2_company_cstm.id_c  WHERE b2_company.id = 'b6c9ace4-bfc1-472e-348d-54c27565adad' AND b2_company.deleted=0
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Limit Query:SELECT b2_company.*,b2_company_cstm.* FROM b2_company  LEFT JOIN b2_company_cstm ON b2_company.id = b2_company_cstm.id_c  WHERE b2_company.id = 'b6c9ace4-bfc1-472e-348d-54c27565adad' AND b2_company.deleted=0 Start: 0 count: 1
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT b2_company.*,b2_company_cstm.* FROM b2_company  LEFT JOIN b2_company_cstm ON b2_company.id = b2_company_cstm.id_c  WHERE b2_company.id = 'b6c9ace4-bfc1-472e-348d-54c27565adad' AND b2_company.deleted=0 LIMIT 0,1
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00070595741271973
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Hook called: b2_Company::after_retrieve
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT id ,b2_company.name as b2_company_cproj_order_management01_name , b2_company.assigned_user_id owner FROM b2_company WHERE deleted=0 AND id='b6c9ace4-bfc1-472e-348d-54c27565adad'
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00048589706420898
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Hook called: Users::before_retrieve
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Retrieve User : SELECT users.*,users_cstm.* FROM users  LEFT JOIN users_cstm ON users.id = users_cstm.id_c  WHERE users.id = '10d2ef47-001e-1ac5-292c-4e85d572201f' AND users.deleted=0
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Limit Query:SELECT users.*,users_cstm.* FROM users  LEFT JOIN users_cstm ON users.id = users_cstm.id_c  WHERE users.id = '10d2ef47-001e-1ac5-292c-4e85d572201f' AND users.deleted=0 Start: 0 count: 1
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT users.*,users_cstm.* FROM users  LEFT JOIN users_cstm ON users.id = users_cstm.id_c  WHERE users.id = '10d2ef47-001e-1ac5-292c-4e85d572201f' AND users.deleted=0 LIMIT 0,1

Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00091218948364258

Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT u1.first_name, u1.last_name from users  u1, users  u2 where u1.id = u2.reports_to_id AND u2.id = '10d2ef47-001e-1ac5-292c-4e85d572201f' and u1.deleted=0
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00047111511230469
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT ea.email_address, ea.email_address_caps, ea.invalid_email, ea.opt_out, ea.date_created, ea.date_modified,
                ear.id, ear.email_address_id, ear.bean_id, ear.bean_module, ear.primary_address, ear.reply_to_address, ear.deleted
                FROM email_addresses ea LEFT JOIN email_addr_bean_rel ear ON ea.id = ear.email_address_id
                WHERE ear.bean_module = 'Users'
                AND ear.bean_id = '10d2ef47-001e-1ac5-292c-4e85d572201f'
                AND ear.deleted = 0
                ORDER BY ear.reply_to_address, ear.primary_address DESC
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00080704689025879
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Hook called: Users::after_retrieve
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT id ,LTRIM(RTRIM(CONCAT(IFNULL(users.first_name,''),' ',IFNULL(users.last_name,'')))) as controller_c , users.created_by owner FROM users WHERE deleted=0 AND id='10d2ef47-001e-1ac5-292c-4e85d572201f'
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00052499771118164
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Hook called: Cproj_order_management01::after_retrieve
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT id ,cproj_order_management01.name as work_order , cproj_order_management01.assigned_user_id owner FROM cproj_order_management01 WHERE deleted=0 AND id='8fcd21bd-d60a-8f11-268a-5c8fa80d92c5'
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00043988227844238
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Hook called: Users::before_retrieve
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Retrieve User : SELECT users.*,users_cstm.* FROM users  LEFT JOIN users_cstm ON users.id = users_cstm.id_c  WHERE users.id = '10d2ef47-001e-1ac5-292c-4e85d572201f' AND users.deleted=0
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Limit Query:SELECT users.*,users_cstm.* FROM users  LEFT JOIN users_cstm ON users.id = users_cstm.id_c  WHERE users.id = '10d2ef47-001e-1ac5-292c-4e85d572201f' AND users.deleted=0 Start: 0 count: 1
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT users.*,users_cstm.* FROM users  LEFT JOIN users_cstm ON users.id = users_cstm.id_c  WHERE users.id = '10d2ef47-001e-1ac5-292c-4e85d572201f' AND users.deleted=0 LIMIT 0,1
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00061488151550293
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT u1.first_name, u1.last_name from users  u1, users  u2 where u1.id = u2.reports_to_id AND u2.id = '10d2ef47-001e-1ac5-292c-4e85d572201f' and u1.deleted=0
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00046801567077637
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean[User].load_relationships, Loading relationship (reports_to_link).
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT ea.email_address, ea.email_address_caps, ea.invalid_email, ea.opt_out, ea.date_created, ea.date_modified,
                ear.id, ear.email_address_id, ear.bean_id, ear.bean_module, ear.primary_address, ear.reply_to_address, ear.deleted
                FROM email_addresses ea LEFT JOIN email_addr_bean_rel ear ON ea.id = ear.email_address_id
                WHERE ear.bean_module = 'Users'
                AND ear.bean_id = '10d2ef47-001e-1ac5-292c-4e85d572201f'
                AND ear.deleted = 0
                ORDER BY ear.reply_to_address, ear.primary_address DESC

Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00095081329345703
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Hook called: Users::after_retrieve
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT id ,LTRIM(RTRIM(CONCAT(IFNULL(users.first_name,''),' ',IFNULL(users.last_name,'')))) as supervisor , users.created_by owner FROM users WHERE deleted=0 AND id='10d2ef47-001e-1ac5-292c-4e85d572201f'
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00057101249694824

Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Hook called: Users::before_retrieve
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Retrieve User : SELECT users.*,users_cstm.* FROM users  LEFT JOIN users_cstm ON users.id = users_cstm.id_c  WHERE users.id = 'a1f7eeb5-5b92-caf6-8e42-56499f2c0d7b' AND users.deleted=0
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Limit Query:SELECT users.*,users_cstm.* FROM users  LEFT JOIN users_cstm ON users.id = users_cstm.id_c  WHERE users.id = 'a1f7eeb5-5b92-caf6-8e42-56499f2c0d7b' AND users.deleted=0 Start: 0 count: 1
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT users.*,users_cstm.* FROM users  LEFT JOIN users_cstm ON users.id = users_cstm.id_c  WHERE users.id = 'a1f7eeb5-5b92-caf6-8e42-56499f2c0d7b' AND users.deleted=0 LIMIT 0,1
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.0006871223449707
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT u1.first_name, u1.last_name from users  u1, users  u2 where u1.id = u2.reports_to_id AND u2.id = 'a1f7eeb5-5b92-caf6-8e42-56499f2c0d7b' and u1.deleted=0
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00048518180847168
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean[User].load_relationships, Loading relationship (reports_to_link).
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT ea.email_address, ea.email_address_caps, ea.invalid_email, ea.opt_out, ea.date_created, ea.date_modified,
                ear.id, ear.email_address_id, ear.bean_id, ear.bean_module, ear.primary_address, ear.reply_to_address, ear.deleted
                FROM email_addresses ea LEFT JOIN email_addr_bean_rel ear ON ea.id = ear.email_address_id
                WHERE ear.bean_module = 'Users'
                AND ear.bean_id = 'a1f7eeb5-5b92-caf6-8e42-56499f2c0d7b'
                AND ear.deleted = 0
                ORDER BY ear.reply_to_address, ear.primary_address DESC
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00078988075256348
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Hook called: Users::after_retrieve
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT id ,LTRIM(RTRIM(CONCAT(IFNULL(users.first_name,''),' ',IFNULL(users.last_name,'')))) as sales_owner , users.created_by owner FROM users WHERE deleted=0 AND id='a1f7eeb5-5b92-caf6-8e42-56499f2c0d7b'
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00050997734069824
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean[PQE_Projects].load_relationships, Loading relationship (calc_contact_id).
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean.load_relationships, Error Loading relationship (calc_contact_id)
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Hook called: PQE_Projects::after_retrieve
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Hook called: Opportunities::before_retrieve
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Including module specific hook file for custom/modules/Opportunities
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Retrieve Opportunity : SELECT opportunities.*,opportunities_cstm.* FROM opportunities  LEFT JOIN opportunities_cstm ON opportunities.id = opportunities_cstm.id_c  WHERE opportunities.id = 'ac171a1e-c6f2-1d4d-03df-5c87b7837bd3' AND opportunities.deleted=0
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Limit Query:SELECT opportunities.*,opportunities_cstm.* FROM opportunities  LEFT JOIN opportunities_cstm ON opportunities.id = opportunities_cstm.id_c  WHERE opportunities.id = 'ac171a1e-c6f2-1d4d-03df-5c87b7837bd3' AND opportunities.deleted=0 Start: 0 count: 1
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT opportunities.*,opportunities_cstm.* FROM opportunities  LEFT JOIN opportunities_cstm ON opportunities.id = opportunities_cstm.id_c  WHERE opportunities.id = 'ac171a1e-c6f2-1d4d-03df-5c87b7837bd3' AND opportunities.deleted=0 LIMIT 0,1
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00097179412841797
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT acc.id, acc.name, acc.assigned_user_id FROM accounts acc, accounts_opportunities a_o WHERE acc.id=a_o.account_id AND a_o.opportunity_id='ac171a1e-c6f2-1d4d-03df-5c87b7837bd3' AND a_o.deleted=0 AND acc.deleted=0
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.000762939453125
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean[Opportunity].load_relationships, Loading relationship (campaign_opportunities).
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean[Opportunity].load_relationships, Loading relationship (user_id_c).
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean.load_relationships, Error Loading relationship (user_id_c)
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean[Opportunity].load_relationships, Loading relationship (account_id1_c).
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean.load_relationships, Error Loading relationship (account_id1_c)
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Hook called: Contacts::before_retrieve
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Retrieve Contact : SELECT contacts.*,contacts_cstm.* FROM contacts  LEFT JOIN contacts_cstm ON contacts.id = contacts_cstm.id_c  WHERE contacts.id = 'b870e6ee-ff1b-b42f-6117-57021d816de1' AND contacts.deleted=0
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Limit Query:SELECT contacts.*,contacts_cstm.* FROM contacts  LEFT JOIN contacts_cstm ON contacts.id = contacts_cstm.id_c  WHERE contacts.id = 'b870e6ee-ff1b-b42f-6117-57021d816de1' AND contacts.deleted=0 Start: 0 count: 1
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT contacts.*,contacts_cstm.* FROM contacts  LEFT JOIN contacts_cstm ON contacts.id = contacts_cstm.id_c  WHERE contacts.id = 'b870e6ee-ff1b-b42f-6117-57021d816de1' AND contacts.deleted=0 LIMIT 0,1

Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00065493583679199
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT acc.id, acc.name, con_reports_to.first_name, con_reports_to.last_name
		from contacts
		left join accounts_contacts a_c on a_c.contact_id = 'b870e6ee-ff1b-b42f-6117-57021d816de1' and a_c.deleted=0
		left join accounts acc on a_c.account_id = acc.id and acc.deleted=0
		left join contacts con_reports_to on con_reports_to.id = contacts.reports_to_id
		where contacts.id = 'b870e6ee-ff1b-b42f-6117-57021d816de1' ORDER BY a_c.date_modified DESC
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.0010969638824463
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean[Contact].load_relationships, Loading relationship (user_sync).
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT user_id id FROM contacts_users  WHERE contacts_users.contact_id = 'b870e6ee-ff1b-b42f-6117-57021d816de1' AND contacts_users.deleted=0
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00047397613525391
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean[Contact].load_relationships, Loading relationship (reports_to_link).
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean[Contact].load_relationships, Loading relationship (campaign_contacts).
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT ea.email_address, ea.email_address_caps, ea.invalid_email, ea.opt_out, ea.date_created, ea.date_modified,
                ear.id, ear.email_address_id, ear.bean_id, ear.bean_module, ear.primary_address, ear.reply_to_address, ear.deleted
                FROM email_addresses ea LEFT JOIN email_addr_bean_rel ear ON ea.id = ear.email_address_id
                WHERE ear.bean_module = 'Contacts'
                AND ear.bean_id = 'b870e6ee-ff1b-b42f-6117-57021d816de1'
                AND ear.deleted = 0
                ORDER BY ear.reply_to_address, ear.primary_address DESC
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00069594383239746
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Hook called: Contacts::after_retrieve
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT id ,LTRIM(RTRIM(CONCAT(IFNULL(contacts.first_name,''),' ',IFNULL(contacts.last_name,'')))) as client_reference_c , contacts.assigned_user_id owner FROM contacts WHERE deleted=0 AND id='b870e6ee-ff1b-b42f-6117-57021d816de1'

Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00049400329589844
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean[Opportunity].load_relationships, Loading relationship (contact_id1_c).
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean.load_relationships, Error Loading relationship (contact_id1_c)
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean[Opportunity].load_relationships, Loading relationship (user_id1_c).
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean.load_relationships, Error Loading relationship (user_id1_c)
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean[Opportunity].load_relationships, Loading relationship (account_id_c).
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean.load_relationships, Error Loading relationship (account_id_c)
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean[Opportunity].load_relationships, Loading relationship (user_id2_c).
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean.load_relationships, Error Loading relationship (user_id2_c)
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean[Opportunity].load_relationships, Loading relationship (user_id3_c).
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean.load_relationships, Error Loading relationship (user_id3_c)
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean[Opportunity].load_relationships, Loading relationship (b2_company_opportunitiesb2_company_ida).
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT b2_company_opportunitiesb2_company_ida id FROM b2_company_opportunities_c  WHERE b2_company_opportunities_c.b2_company_opportunitiesopportunities_idb = 'ac171a1e-c6f2-1d4d-03df-5c87b7837bd3' AND b2_company_opportunities_c.deleted=0
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00048494338989258
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Hook called: b2_Company::before_retrieve
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Retrieve b2_Company : SELECT b2_company.*,b2_company_cstm.* FROM b2_company  LEFT JOIN b2_company_cstm ON b2_company.id = b2_company_cstm.id_c  WHERE b2_company.id = 'b6c9ace4-bfc1-472e-348d-54c27565adad' AND b2_company.deleted=0
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Limit Query:SELECT b2_company.*,b2_company_cstm.* FROM b2_company  LEFT JOIN b2_company_cstm ON b2_company.id = b2_company_cstm.id_c  WHERE b2_company.id = 'b6c9ace4-bfc1-472e-348d-54c27565adad' AND b2_company.deleted=0 Start: 0 count: 1
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT b2_company.*,b2_company_cstm.* FROM b2_company  LEFT JOIN b2_company_cstm ON b2_company.id = b2_company_cstm.id_c  WHERE b2_company.id = 'b6c9ace4-bfc1-472e-348d-54c27565adad' AND b2_company.deleted=0 LIMIT 0,1
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00068402290344238
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean[b2_Company].load_relationships, Loading relationship (assigned_user_id).
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean.load_relationships, Error Loading relationship (assigned_user_id)
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean[b2_Company].load_relationships, Loading relationship (assigned_user_id).
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean.load_relationships, Error Loading relationship (assigned_user_id)
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Hook called: b2_Company::after_retrieve
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT id ,b2_company.name as b2_company_opportunities_name , b2_company.assigned_user_id owner FROM b2_company WHERE deleted=0 AND id='b6c9ace4-bfc1-472e-348d-54c27565adad'
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00044393539428711
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean[Opportunity].load_relationships, Loading relationship (contact_id2_c).
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean.load_relationships, Error Loading relationship (contact_id2_c)
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Hook called: Opportunities::after_retrieve
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Hook called: PQE_Projects::before_retrieve
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Retrieve PQE_Projects : SELECT pqe_projects.* FROM pqe_projects  WHERE pqe_projects.id = '4407d1c1-b239-c826-a915-5a6edd2e0a9b' AND pqe_projects.deleted=0
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Limit Query:SELECT pqe_projects.* FROM pqe_projects  WHERE pqe_projects.id = '4407d1c1-b239-c826-a915-5a6edd2e0a9b' AND pqe_projects.deleted=0 Start: 0 count: 1
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT pqe_projects.* FROM pqe_projects  WHERE pqe_projects.id = '4407d1c1-b239-c826-a915-5a6edd2e0a9b' AND pqe_projects.deleted=0 LIMIT 0,1
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00049018859863281
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean[PQE_Projects].load_relationships, Loading relationship (assigned_user_id).
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean.load_relationships, Error Loading relationship (assigned_user_id)
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean[PQE_Projects].load_relationships, Loading relationship (assigned_user_id).
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean.load_relationships, Error Loading relationship (assigned_user_id)
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean[PQE_Projects].load_relationships, Loading relationship (user_id_c).
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean.load_relationships, Error Loading relationship (user_id_c)
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Hook called: Accounts::before_retrieve
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Retrieve Account : SELECT accounts.*,accounts_cstm.* FROM accounts  LEFT JOIN accounts_cstm ON accounts.id = accounts_cstm.id_c  WHERE accounts.id = '4f3e978c-03fc-11e7-9c88-005056a615fd' AND accounts.deleted=0
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Limit Query:SELECT accounts.*,accounts_cstm.* FROM accounts  LEFT JOIN accounts_cstm ON accounts.id = accounts_cstm.id_c  WHERE accounts.id = '4f3e978c-03fc-11e7-9c88-005056a615fd' AND accounts.deleted=0 Start: 0 count: 1
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT accounts.*,accounts_cstm.* FROM accounts  LEFT JOIN accounts_cstm ON accounts.id = accounts_cstm.id_c  WHERE accounts.id = '4f3e978c-03fc-11e7-9c88-005056a615fd' AND accounts.deleted=0 LIMIT 0,1
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00075912475585938
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT a1.name from accounts a1, accounts a2 where a1.id = a2.parent_id and a2.id = '4f3e978c-03fc-11e7-9c88-005056a615fd' and a1.deleted=0
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00058889389038086
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean[Account].load_relationships, Loading relationship (campaign_accounts).
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean[Account].load_relationships, Loading relationship (b2_company_accountsb2_company_ida).
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT b2_company_accountsb2_company_ida id FROM b2_company_accounts_c  WHERE b2_company_accounts_c.b2_company_accountsaccounts_idb = '4f3e978c-03fc-11e7-9c88-005056a615fd' AND b2_company_accounts_c.deleted=0
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00052595138549805
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean[Account].load_relationships, Loading relationship (contact_id1_c).
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean.load_relationships, Error Loading relationship (contact_id1_c)
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean[Account].load_relationships, Loading relationship (user_id2_c).
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean.load_relationships, Error Loading relationship (user_id2_c)
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean[Account].load_relationships, Loading relationship (contact_id2_c).
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean.load_relationships, Error Loading relationship (contact_id2_c)
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Hook called: Users::before_retrieve
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Retrieve User : SELECT users.*,users_cstm.* FROM users  LEFT JOIN users_cstm ON users.id = users_cstm.id_c  WHERE users.id = '2fb55996-a7ab-6c4d-597a-4e44ff37c42d' AND users.deleted=0
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Limit Query:SELECT users.*,users_cstm.* FROM users  LEFT JOIN users_cstm ON users.id = users_cstm.id_c  WHERE users.id = '2fb55996-a7ab-6c4d-597a-4e44ff37c42d' AND users.deleted=0 Start: 0 count: 1
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT users.*,users_cstm.* FROM users  LEFT JOIN users_cstm ON users.id = users_cstm.id_c  WHERE users.id = '2fb55996-a7ab-6c4d-597a-4e44ff37c42d' AND users.deleted=0 LIMIT 0,1
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00059199333190918
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT u1.first_name, u1.last_name from users  u1, users  u2 where u1.id = u2.reports_to_id AND u2.id = '2fb55996-a7ab-6c4d-597a-4e44ff37c42d' and u1.deleted=0
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00044512748718262
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT ea.email_address, ea.email_address_caps, ea.invalid_email, ea.opt_out, ea.date_created, ea.date_modified,
                ear.id, ear.email_address_id, ear.bean_id, ear.bean_module, ear.primary_address, ear.reply_to_address, ear.deleted
                FROM email_addresses ea LEFT JOIN email_addr_bean_rel ear ON ea.id = ear.email_address_id
                WHERE ear.bean_module = 'Users'
                AND ear.bean_id = '2fb55996-a7ab-6c4d-597a-4e44ff37c42d'
                AND ear.deleted = 0
                ORDER BY ear.reply_to_address, ear.primary_address DESC
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.0008080005645752
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Hook called: Users::after_retrieve
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT id ,LTRIM(RTRIM(CONCAT(IFNULL(users.first_name,''),' ',IFNULL(users.last_name,'')))) as sales_manager_c , users.created_by owner FROM users WHERE deleted=0 AND id='2fb55996-a7ab-6c4d-597a-4e44ff37c42d'
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00043201446533203
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean[Account].load_relationships, Loading relationship (b13_banca_accountsb13_banca_ida).
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT b13_banca_accountsb13_banca_ida id FROM b13_banca_accounts_c  WHERE b13_banca_accounts_c.b13_banca_accountsaccounts_idb = '4f3e978c-03fc-11e7-9c88-005056a615fd' AND b13_banca_accounts_c.deleted=0
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.0004119873046875
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean[Account].load_relationships, Loading relationship (account_id_c).
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean.load_relationships, Error Loading relationship (account_id_c)
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean[Account].load_relationships, Loading relationship (user_id_c).
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean.load_relationships, Error Loading relationship (user_id_c)
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean[Account].load_relationships, Loading relationship (account_id1_c).
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean.load_relationships, Error Loading relationship (account_id1_c)
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean[Account].load_relationships, Loading relationship (contact_id_c).
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean.load_relationships, Error Loading relationship (contact_id_c)
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT ea.email_address, ea.email_address_caps, ea.invalid_email, ea.opt_out, ea.date_created, ea.date_modified,
                ear.id, ear.email_address_id, ear.bean_id, ear.bean_module, ear.primary_address, ear.reply_to_address, ear.deleted
                FROM email_addresses ea LEFT JOIN email_addr_bean_rel ear ON ea.id = ear.email_address_id
                WHERE ear.bean_module = 'Accounts'
                AND ear.bean_id = '4f3e978c-03fc-11e7-9c88-005056a615fd'
                AND ear.deleted = 0
                ORDER BY ear.reply_to_address, ear.primary_address DESC
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00059890747070312
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Hook called: Accounts::after_retrieve
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT id ,accounts.name as operation_account , accounts.assigned_user_id owner FROM accounts WHERE deleted=0 AND id='4f3e978c-03fc-11e7-9c88-005056a615fd'
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00041508674621582
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Hook called: Users::before_retrieve
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Retrieve User : SELECT users.*,users_cstm.* FROM users  LEFT JOIN users_cstm ON users.id = users_cstm.id_c  WHERE users.id = 'e94d4a17-e8fd-1c61-dccc-521e1eeffe67' AND users.deleted=0
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Limit Query:SELECT users.*,users_cstm.* FROM users  LEFT JOIN users_cstm ON users.id = users_cstm.id_c  WHERE users.id = 'e94d4a17-e8fd-1c61-dccc-521e1eeffe67' AND users.deleted=0 Start: 0 count: 1
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT users.*,users_cstm.* FROM users  LEFT JOIN users_cstm ON users.id = users_cstm.id_c  WHERE users.id = 'e94d4a17-e8fd-1c61-dccc-521e1eeffe67' AND users.deleted=0 LIMIT 0,1
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00055098533630371
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT u1.first_name, u1.last_name from users  u1, users  u2 where u1.id = u2.reports_to_id AND u2.id = 'e94d4a17-e8fd-1c61-dccc-521e1eeffe67' and u1.deleted=0
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00039386749267578
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] SugarBean[User].load_relationships, Loading relationship (reports_to_link).
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT ea.email_address, ea.email_address_caps, ea.invalid_email, ea.opt_out, ea.date_created, ea.date_modified,
                ear.id, ear.email_address_id, ear.bean_id, ear.bean_module, ear.primary_address, ear.reply_to_address, ear.deleted
                FROM email_addresses ea LEFT JOIN email_addr_bean_rel ear ON ea.id = ear.email_address_id
                WHERE ear.bean_module = 'Users'
                AND ear.bean_id = 'e94d4a17-e8fd-1c61-dccc-521e1eeffe67'
                AND ear.deleted = 0
                ORDER BY ear.reply_to_address, ear.primary_address DESC
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00066709518432617
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Hook called: Users::after_retrieve
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query:SELECT id ,LTRIM(RTRIM(CONCAT(IFNULL(users.first_name,''),' ',IFNULL(users.last_name,'')))) as project_manager , users.created_by owner FROM users WHERE deleted=0 AND id='e94d4a17-e8fd-1c61-dccc-521e1eeffe67'
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][INFO] Query Execution Time:0.00042295455932617
Thu Jul  4 18:05:13 2019 [27773][6ddcc604-1ace-c8ad-faee-4e57b9e62dbb][DEBUG] Hook called: Cproj_order_management01::before_retrieve

Those hooks messages are a bit misleading. They get printed when hooks are just being considered (“can I find a hook for this module?”), but not actually executed.

If you want, make a backup of the file

include/utils/LogicHook.php

and then replace this function (around line 196 in my version of SuiteCRM) with my debugging version:


    public function call_custom_logic($module_dir, $event, $arguments = null)
      {
        $random = rand(1, 1000);
        // declare the hook array variable, it will be defined in the included file.
        $hook_array = null;
        if (isset($GLOBALS['log'])) {
            $GLOBALS['log']->debug("($random) Hooks check for: $module_dir::$event");
        }
        if (!empty($module_dir)) {
            // This will load an array of the hooks to process
            $hooks = $this->getHooks($module_dir);
            if (!empty($hooks)) {
                $GLOBALS['log']->debug("Hook called: $module_dir::$event, hooks not empty");
                $this->process_hooks($hooks, $event, $arguments);
            }
        }
        $hooks = $this->getHooks('');
        if (!empty($hooks)) {
            $GLOBALS['log']->debug("Hook called: $module_dir::$event, hooks not empty 2");
            $this->process_hooks($hooks, $event, $arguments);
        }
        if (isset($GLOBALS['log'])) {
            $GLOBALS['log']->debug("($random) Hooks checked for: $module_dir::$event");
        }
    }

Now you should get a better output where you can see when each hook execution starts and ends.

Meanwhile, please run the first query in this post:

https://pgorod.github.io/Database-tables-size/

… and post the results here. I’d like to check if you have overgrown tables that are causing delays.