Upgrade Wizard - after clicking next on system check, getting white screen
Currently on 7.10.11, trying to upgrade to 7.11.x
Have had this issue for months. Been troubleshooting.
Have tried updating permissions, deleting the cache files, renaming the upgrade folder… all to no avail.
I’ll post my upgrade wizard file and a portion of the end of the error log. Any suggestions would be greatly appreciated.
UPGRADE WIZARD
assigned_user_name , jt2.created_by assigned_user_name_owner , ‘Users’ assigned_user_name_mod FROM alerts LEFT JOIN users jt0 ON alerts.modified_user_id=jt0.id AND jt0.deleted=0
AND jt0.deleted=0 LEFT JOIN users jt1 ON alerts.created_by=jt1.id AND jt1.deleted=0
AND jt1.deleted=0 LEFT JOIN users jt2 ON alerts.assigned_user_id=jt2.id AND jt2.deleted=0
AND jt2.deleted=0 where (alerts.assigned_user_id = ‘ecba9706-6831-685a-e538-5be6d7924a5a’ AND is_read != ‘1’) AND alerts.deleted=0
Wed Feb 12 23:20:23 2020 [26960][ecba9706-6831-685a-e538-5be6d7924a5a][INFO] Query: SELECT alerts.* , jt0.user_name modified_by_name , jt0.created_by modified_by_name_owner , ‘Users’ modified_by_name_mod , jt1.user_name created_by_name , jt1.created_by created_by_name_owner , ‘Users’ created_by_name_mod , jt2.user_name assigned_user_name , jt2.created_by assigned_user_name_owner , ‘Users’ assigned_user_name_mod FROM alerts LEFT JOIN users jt0 ON alerts.modified_user_id=jt0.id AND jt0.deleted=0
AND jt0.deleted=0 LEFT JOIN users jt1 ON alerts.created_by=jt1.id AND jt1.deleted=0
AND jt1.deleted=0 LEFT JOIN users jt2 ON alerts.assigned_user_id=jt2.id AND jt2.deleted=0
AND jt2.deleted=0 where (alerts.assigned_user_id = ‘ecba9706-6831-685a-e538-5be6d7924a5a’ AND is_read != ‘1’) AND alerts.deleted=0
Wed Feb 12 23:20:23 2020 [26960][ecba9706-6831-685a-e538-5be6d7924a5a][INFO] Query Execution Time:7.6055526733398E-5
Wed Feb 12 23:20:23 2020 [26960][ecba9706-6831-685a-e538-5be6d7924a5a][DEBUG] process_full_list_query: result is mysqli_result Object
(
[current_field] => 0
[field_count] => 23
[lengths] =>
[num_rows] => 0
[type] => 0
)
Wed Feb 12 23:20:23 2020 [26960][ecba9706-6831-685a-e538-5be6d7924a5a][DEBUG] Hook called: ::server_round_trip
Wed Feb 12 23:20:23 2020 [26960][ecba9706-6831-685a-e538-5be6d7924a5a][DEBUG] Calling MySQLi::disconnect()
Wed Feb 12 23:20:24 2020 [26960][-none-][DEBUG] current_language is: en_us
Wed Feb 12 23:20:24 2020 [26960][-none-][DEBUG] Found cache backend SugarCacheWincache
Wed Feb 12 23:20:24 2020 [26960][-none-][DEBUG] Found cache backend SugarCacheRedis
Wed Feb 12 23:20:24 2020 [26960][-none-][DEBUG] Found cache backend SugarCacheAPC
Wed Feb 12 23:20:24 2020 [26960][-none-][DEBUG] Found cache backend SugarCacheMemory
Wed Feb 12 23:20:24 2020 [26960][-none-][DEBUG] Using cache backend SugarCacheMemory, since 999 is less than 1000
Wed Feb 12 23:20:24 2020 [26960][-none-][DEBUG] Found cache backend SugarCacheFile
Wed Feb 12 23:20:24 2020 [26960][-none-][DEBUG] Found cache backend SugarCachesMash
Wed Feb 12 23:20:24 2020 [26960][-none-][DEBUG] Found cache backend SugarCacheZend
Wed Feb 12 23:20:24 2020 [26960][-none-][DEBUG] Found cache backend SugarCacheMemcached
Wed Feb 12 23:20:24 2020 [26960][-none-][DEBUG] Found cache backend SugarCacheMemcache
Wed Feb 12 23:20:24 2020 [26960][-none-][INFO] Found language file: en_us.lang.php
Wed Feb 12 23:20:24 2020 [26960][-none-][INFO] Found extended language file: en_us.lang.ext.php
Wed Feb 12 23:20:24 2020 [26960][-none-][INFO] Found custom language file: en_us.lang.php
Wed Feb 12 23:20:24 2020 [26960][-none-][INFO] Query:SELECT id, name, symbol, conversion_rate FROM currencies WHERE status = ‘Active’ and deleted = 0
Wed Feb 12 23:20:24 2020 [26960][-none-][INFO] Query Execution Time:9.2029571533203E-5
Wed Feb 12 23:20:24 2020 [26960][-none-][DEBUG] rebuilding cache for Users
Wed Feb 12 23:20:24 2020 [26960][-none-][INFO] Query:SELECT * FROM fields_meta_data WHERE custom_module=‘Users’ AND deleted = 0
Wed Feb 12 23:20:24 2020 [26960][-none-][INFO] Query Execution Time:0.0001220703125
Wed Feb 12 23:20:24 2020 [26960][-none-][DEBUG] rebuilding cache for Employees
Wed Feb 12 23:20:24 2020 [26960][-none-][INFO] Query:SELECT * FROM fields_meta_data WHERE custom_module=‘Employees’ AND deleted = 0
Wed Feb 12 23:20:24 2020 [26960][-none-][INFO] Query Execution Time:0.00019001960754395
Wed Feb 12 23:20:24 2020 [26960][-none-][DEBUG] rebuilding cache for EmailAddresses
Wed Feb 12 23:20:24 2020 [26960][-none-][INFO] Query:SELECT * FROM fields_meta_data WHERE custom_module=‘EmailAddresses’ AND deleted = 0
Wed Feb 12 23:20:24 2020 [26960][-none-][INFO] Query Execution Time:0.00020098686218262
Wed Feb 12 23:20:24 2020 [26960][-none-][DEBUG] rebuilding cache for UserPreferences
Wed Feb 12 23:20:24 2020 [26960][-none-][INFO] Query:SELECT * FROM fields_meta_data WHERE custom_module=‘UserPreferences’ AND deleted = 0
Wed Feb 12 23:20:24 2020 [26960][-none-][INFO] Query Execution Time:0.00014996528625488
Wed Feb 12 23:20:24 2020 [26960][-none-][DEBUG] rebuilding cache for Administration
Wed Feb 12 23:20:24 2020 [26960][-none-][INFO] Query:SELECT * FROM fields_meta_data WHERE custom_module=‘Administration’ AND deleted = 0
Wed Feb 12 23:20:24 2020 [26960][-none-][INFO] Query Execution Time:0.00012803077697754
Wed Feb 12 23:20:24 2020 [26960][-none-][INFO] Query:SELECT category, name, value FROM config
Wed Feb 12 23:20:24 2020 [26960][-none-][INFO] Query Execution Time:8.9168548583984E-5
Wed Feb 12 23:20:24 2020 [26960][-none-][INFO] Query:SELECT id FROM outbound_email WHERE type = ‘system’
Wed Feb 12 23:20:24 2020 [26960][-none-][INFO] Query Execution Time:0.00012397766113281
Wed Feb 12 23:20:24 2020 [26960][-none-][INFO] Query:SELECT * FROM outbound_email WHERE id = ‘87b4d0bd-e14a-adbd-3016-5bd1683c3c10’
Wed Feb 12 23:20:24 2020 [26960][-none-][INFO] Query Execution Time:7.0095062255859E-5
Wed Feb 12 23:20:24 2020 [26960][-none-][DEBUG] Hook called: ::after_entry_point
Wed Feb 12 23:20:24 2020 [26960][-none-][DEBUG] Including module specific hook file for custom/modules
Wed Feb 12 23:20:24 2020 [26960][-none-][DEBUG] Including Ext hook file for custom/application
Wed Feb 12 23:20:24 2020 [26960][-none-][DEBUG] Hook called: ::after_session_start
Wed Feb 12 23:20:24 2020 [26960][-none-][DEBUG] Unable to find SugarController:: get
Wed Feb 12 23:20:24 2020 [26960][-none-][DEBUG] We have an authenticated user id: ecba9706-6831-685a-e538-5be6d7924a5a
Wed Feb 12 23:20:24 2020 [26960][-none-][DEBUG] Hook called: Users::before_retrieve
Wed Feb 12 23:20:24 2020 [26960][-none-][DEBUG] Including module specific hook file for custom/modules/Users
Wed Feb 12 23:20:24 2020 [26960][-none-][DEBUG] Retrieve User : SELECT users.* FROM users WHERE users.id = ‘ecba9706-6831-685a-e538-5be6d7924a5a’ AND users.deleted=0
Wed Feb 12 23:20:24 2020 [26960][-none-][DEBUG] Limit Query:SELECT users.* FROM users WHERE users.id = ‘ecba9706-6831-685a-e538-5be6d7924a5a’ AND users.deleted=0 Start: 0 count: 1
Wed Feb 12 23:20:24 2020 [26960][-none-][INFO] Query:SELECT users.* FROM users WHERE users.id = ‘ecba9706-6831-685a-e538-5be6d7924a5a’ AND users.deleted=0 LIMIT 0,1
Wed Feb 12 23:20:24 2020 [26960][-none-][INFO] Query Execution Time:0.00014901161193848
Wed Feb 12 23:20:24 2020 [26960][ecba9706-6831-685a-e538-5be6d7924a5a][DEBUG] get_user_array query: SELECT id, first_name, last_name, user_name FROM users WHERE 1=1 ORDER BY first_name, last_name ASC
Wed Feb 12 23:20:24 2020 [26960][ecba9706-6831-685a-e538-5be6d7924a5a][INFO] Query:SELECT id, first_name, last_name, user_name FROM users WHERE 1=1 ORDER BY first_name, last_name ASC
Wed Feb 12 23:20:24 2020 [26960][ecba9706-6831-685a-e538-5be6d7924a5a][INFO] Query Execution Time:6.103515625E-5
Wed Feb 12 23:20:24 2020 [26960][ecba9706-6831-685a-e538-5be6d7924a5a][INFO] Query:SELECT u1.first_name, u1.last_name from users u1, users u2 where u1.id = u2.reports_to_id AND u2.id = ‘ecba9706-6831-685a-e538-5be6d7924a5a’ and u1.deleted=0
Wed Feb 12 23:20:24 2020 [26960][ecba9706-6831-685a-e538-5be6d7924a5a][INFO] Query Execution Time:6.1988830566406E-5
Wed Feb 12 23:20:24 2020 [26960][ecba9706-6831-685a-e538-5be6d7924a5a][DEBUG] SugarBean[User].load_relationships, Loading relationship (reports_to_link).
Wed Feb 12 23:20:24 2020 [26960][ecba9706-6831-685a-e538-5be6d7924a5a][INFO] Query:SELECT
ea.email_address,
ea.email_address_caps,
ea.invalid_email,
ea.opt_out,
ea.confirm_opt_in,
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 = ‘ecba9706-6831-685a-e538-5be6d7924a5a’
AND ear.deleted = 0
ORDER BY ear.reply_to_address, ear.primary_address DESC
Wed Feb 12 23:20:24 2020 [26960][ecba9706-6831-685a-e538-5be6d7924a5a][INFO] Query Execution Time:0.00014209747314453
Wed Feb 12 23:20:24 2020 [26960][ecba9706-6831-685a-e538-5be6d7924a5a][DEBUG] Hook called: Users::after_retrieve
Wed Feb 12 23:20:24 2020 [26960][ecba9706-6831-685a-e538-5be6d7924a5a][DEBUG] FACTOR AUTH: -------------------------------------------------------------
Wed Feb 12 23:20:24 2020 [26960][ecba9706-6831-685a-e538-5be6d7924a5a][DEBUG] FACTOR AUTH: --------------------- CHECK FACTOR AUtH ---------------------
Wed Feb 12 23:20:24 2020 [26960][ecba9706-6831-685a-e538-5be6d7924a5a][DEBUG] FACTOR AUTH: -------------------------------------------------------------
Wed Feb 12 23:20:24 2020 [26960][ecba9706-6831-685a-e538-5be6d7924a5a][DEBUG] FACTOR AUTH: User needs factor auth, request is not Logout
Wed Feb 12 23:20:24 2020 [26960][ecba9706-6831-685a-e538-5be6d7924a5a][DEBUG] FACTOR AUTH: User does`nt need factor auth
Wed Feb 12 23:20:24 2020 [26960][ecba9706-6831-685a-e538-5be6d7924a5a][DEBUG] Current user is: npwomack
Wed Feb 12 23:20:24 2020 [26960][ecba9706-6831-685a-e538-5be6d7924a5a][DEBUG] Current user is: npwomack
Wed Feb 12 23:20:24 2020 [26960][ecba9706-6831-685a-e538-5be6d7924a5a][DEBUG] setting cookie ck_login_id_20 to ecba9706-6831-685a-e538-5be6d7924a5a
Wed Feb 12 23:20:24 2020 [26960][ecba9706-6831-685a-e538-5be6d7924a5a][DEBUG] setting cookie ck_login_language_20 to en_us
Wed Feb 12 23:20:24 2020 [26960][ecba9706-6831-685a-e538-5be6d7924a5a][DEBUG] current_language is: en_us
Wed Feb 12 23:20:24 2020 [26960][ecba9706-6831-685a-e538-5be6d7924a5a][INFO] Found language file: en_us.lang.php
Wed Feb 12 23:20:24 2020 [26960][ecba9706-6831-685a-e538-5be6d7924a5a][INFO] Found extended language file: en_us.lang.ext.php
Wed Feb 12 23:20:24 2020 [26960][ecba9706-6831-685a-e538-5be6d7924a5a][INFO] Found custom language file: en_us.lang.php
Wed Feb 12 23:20:24 2020 [26960][ecba9706-6831-685a-e538-5be6d7924a5a][DEBUG] rebuilding cache for Alerts
Wed Feb 12 23:20:24 2020 [26960][ecba9706-6831-685a-e538-5be6d7924a5a][INFO] Query:SELECT * FROM fields_meta_data WHERE custom_module=‘Alerts’ AND deleted = 0
Wed Feb 12 23:20:24 2020 [26960][ecba9706-6831-685a-e538-5be6d7924a5a][INFO] Query Execution Time:0.00012898445129395
Wed Feb 12 23:20:24 2020 [26960][ecba9706-6831-685a-e538-5be6d7924a5a][DEBUG] Performing action: action_get MODULE: Alerts
Wed Feb 12 23:20:24 2020 [26960][ecba9706-6831-685a-e538-5be6d7924a5a][DEBUG] get_full_list: order_by = ‘alerts.date_entered’ and where = ‘alerts.assigned_user_id = ‘ecba9706-6831-685a-e538-5be6d7924a5a’ AND is_read != ‘1’’
Wed Feb 12 23:20:24 2020 [26960][ecba9706-6831-685a-e538-5be6d7924a5a][DEBUG] SugarBean[Alert].load_relationships, Loading relationship (modified_user_link).
Wed Feb 12 23:20:24 2020 [26960][ecba9706-6831-685a-e538-5be6d7924a5a][DEBUG] SugarBean[Alert].load_relationships, Loading relationship (created_by_link).
Wed Feb 12 23:20:24 2020 [26960][ecba9706-6831-685a-e538-5be6d7924a5a][DEBUG] SugarBean[Alert].load_relationships, Loading relationship (assigned_user_link).
Wed Feb 12 23:20:24 2020 [26960][ecba9706-6831-685a-e538-5be6d7924a5a][DEBUG] process_order_by: (alerts.date_entered) does not have a vardef entry.
Wed Feb 12 23:20:24 2020 [26960][ecba9706-6831-685a-e538-5be6d7924a5a][DEBUG] process_full_list_query: query is SELECT alerts.* , jt0.user_name modified_by_name , jt0.created_by modified_by_name_owner , ‘Users’ modified_by_name_mod , jt1.user_name created_by_name , jt1.created_by created_by_name_owner , ‘Users’ created_by_name_mod , jt2.user_name assigned_user_name , jt2.created_by assigned_user_name_owner , ‘Users’ assigned_user_name_mod FROM alerts LEFT JOIN users jt0 ON alerts.modified_user_id=jt0.id AND jt0.deleted=0
AND jt0.deleted=0 LEFT JOIN users jt1 ON alerts.created_by=jt1.id AND jt1.deleted=0
AND jt1.deleted=0 LEFT JOIN users jt2 ON alerts.assigned_user_id=jt2.id AND jt2.deleted=0
AND jt2.deleted=0 where (alerts.assigned_user_id = ‘ecba9706-6831-685a-e538-5be6d7924a5a’ AND is_read != ‘1’) AND alerts.deleted=0
Wed Feb 12 23:20:24 2020 [26960][ecba9706-6831-685a-e538-5be6d7924a5a][INFO] Query: SELECT alerts.* , jt0.user_name modified_by_name , jt0.created_by modified_by_name_owner , ‘Users’ modified_by_name_mod , jt1.user_name created_by_name , jt1.created_by created_by_name_owner , ‘Users’ created_by_name_mod , jt2.user_name assigned_user_name , jt2.created_by assigned_user_name_owner , ‘Users’ assigned_user_name_mod FROM alerts LEFT JOIN users jt0 ON alerts.modified_user_id=jt0.id AND jt0.deleted=0
AND jt0.deleted=0 LEFT JOIN users jt1 ON alerts.created_by=jt1.id AND jt1.deleted=0
AND jt1.deleted=0 LEFT JOIN users jt2 ON alerts.assigned_user_id=jt2.id AND jt2.deleted=0
AND jt2.deleted=0 where (alerts.assigned_user_id = ‘ecba9706-6831-685a-e538-5be6d7924a5a’ AND is_read != ‘1’) AND alerts.deleted=0
Wed Feb 12 23:20:24 2020 [26960][ecba9706-6831-685a-e538-5be6d7924a5a][INFO] Query Execution Time:0.00015592575073242
Wed Feb 12 23:20:24 2020 [26960][ecba9706-6831-685a-e538-5be6d7924a5a][DEBUG] process_full_list_query: result is mysqli_result Object
(
[current_field] => 0
[field_count] => 23
[lengths] =>
[num_rows] => 0
[type] => 0
)
Wed Feb 12 23:20:24 2020 [26960][ecba9706-6831-685a-e538-5be6d7924a5a][DEBUG] Hook called: ::server_round_trip
Wed Feb 12 23:20:24 2020 [26960][ecba9706-6831-685a-e538-5be6d7924a5a][DEBUG] Calling MySQLi::disconnect()
Wed Feb 12 23:20:37 2020 [27021][-none-][DEBUG] current_language is: en_us
Wed Feb 12 23:20:37 2020 [27021][-none-][DEBUG] Found cache backend SugarCacheWincache
Wed Feb 12 23:20:37 2020 [27021][-none-][DEBUG] Found cache backend SugarCacheRedis
Wed Feb 12 23:20:37 2020 [27021][-none-][DEBUG] Found cache backend SugarCacheAPC
Wed Feb 12 23:20:37 2020 [27021][-none-][DEBUG] Found cache backend SugarCacheMemory
Wed Feb 12 23:20:37 2020 [27021][-none-][DEBUG] Using cache backend SugarCacheMemory, since 999 is less than 1000
Wed Feb 12 23:20:37 2020 [27021][-none-][DEBUG] Found cache backend SugarCacheFile
Wed Feb 12 23:20:37 2020 [27021][-none-][DEBUG] Found cache backend SugarCachesMash
Wed Feb 12 23:20:37 2020 [27021][-none-][DEBUG] Found cache backend SugarCacheZend
Wed Feb 12 23:20:37 2020 [27021][-none-][DEBUG] Found cache backend SugarCacheMemcached
Wed Feb 12 23:20:37 2020 [27021][-none-][DEBUG] Found cache backend SugarCacheMemcache
Wed Feb 12 23:20:37 2020 [27021][-none-][INFO] Found language file: en_us.lang.php
Wed Feb 12 23:20:37 2020 [27021][-none-][INFO] Found extended language file: en_us.lang.ext.php
Wed Feb 12 23:20:37 2020 [27021][-none-][INFO] Found custom language file: en_us.lang.php
Wed Feb 12 23:20:37 2020 [27021][-none-][INFO] Query:SELECT id, name, symbol, conversion_rate FROM currencies WHERE status = ‘Active’ and deleted = 0
Wed Feb 12 23:20:37 2020 [27021][-none-][INFO] Query Execution Time:7.2002410888672E-5
Wed Feb 12 23:20:37 2020 [27021][-none-][DEBUG] rebuilding cache for Users
Wed Feb 12 23:20:37 2020 [27021][-none-][INFO] Query:SELECT * FROM fields_meta_data WHERE custom_module=‘Users’ AND deleted = 0
Wed Feb 12 23:20:37 2020 [27021][-none-][INFO] Query Execution Time:0.0001070499420166
Wed Feb 12 23:20:37 2020 [27021][-none-][DEBUG] rebuilding cache for Employees
Wed Feb 12 23:20:37 2020 [27021][-none-][INFO] Query:SELECT * FROM fields_meta_data WHERE custom_module=‘Employees’ AND deleted = 0
Wed Feb 12 23:20:37 2020 [27021][-none-][INFO] Query Execution Time:0.00013184547424316
Wed Feb 12 23:20:37 2020 [27021][-none-][DEBUG] rebuilding cache for EmailAddresses
Wed Feb 12 23:20:37 2020 [27021][-none-][INFO] Query:SELECT * FROM fields_meta_data WHERE custom_module=‘EmailAddresses’ AND deleted = 0
Wed Feb 12 23:20:37 2020 [27021][-none-][INFO] Query Execution Time:0.00012707710266113
Wed Feb 12 23:20:37 2020 [27021][-none-][DEBUG] rebuilding cache for UserPreferences
Wed Feb 12 23:20:37 2020 [27021][-none-][INFO] Query:SELECT * FROM fields_meta_data WHERE custom_module=‘UserPreferences’ AND deleted = 0
Wed Feb 12 23:20:37 2020 [27021][-none-][INFO] Query Execution Time:0.00014305114746094
Wed Feb 12 23:20:37 2020 [27021][-none-][DEBUG] rebuilding cache for Administration
Wed Feb 12 23:20:37 2020 [27021][-none-][INFO] Query:SELECT * FROM fields_meta_data WHERE custom_module=‘Administration’ AND deleted = 0
Wed Feb 12 23:20:37 2020 [27021][-none-][INFO] Query Execution Time:0.0001070499420166
Wed Feb 12 23:20:37 2020 [27021][-none-][INFO] Query:SELECT category, name, value FROM config
Wed Feb 12 23:20:37 2020 [27021][-none-][INFO] Query Execution Time:9.8943710327148E-5
Wed Feb 12 23:20:37 2020 [27021][-none-][INFO] Query:SELECT id FROM outbound_email WHERE type = ‘system’
Wed Feb 12 23:20:37 2020 [27021][-none-][INFO] Query Execution Time:5.6028366088867E-5
Wed Feb 12 23:20:37 2020 [27021][-none-][INFO] Query:SELECT * FROM outbound_email WHERE id = ‘87b4d0bd-e14a-adbd-3016-5bd1683c3c10’
Wed Feb 12 23:20:37 2020 [27021][-none-][INFO] Query Execution Time:8.7976455688477E-5
Wed Feb 12 23:20:37 2020 [27021][-none-][DEBUG] Hook called: ::after_entry_point
Wed Feb 12 23:20:37 2020 [27021][-none-][DEBUG] Including module specific hook file for custom/modules
Wed Feb 12 23:20:37 2020 [27021][-none-][DEBUG] Including Ext hook file for custom/application
Wed Feb 12 23:20:37 2020 [27021][-none-][DEBUG] Hook called: ::after_session_start
Wed Feb 12 23:20:37 2020 [27021][-none-][DEBUG] Unable to find SugarController:: get
Wed Feb 12 23:20:37 2020 [27021][-none-][DEBUG] We have an authenticated user id: ecba9706-6831-685a-e538-5be6d7924a5a
Wed Feb 12 23:20:37 2020 [27021][-none-][DEBUG] Hook called: Users::before_retrieve
Wed Feb 12 23:20:37 2020 [27021][-none-][DEBUG] Including module specific hook file for custom/modules/Users
Wed Feb 12 23:20:37 2020 [27021][-none-][DEBUG] Retrieve User : SELECT users.* FROM users WHERE users.id = ‘ecba9706-6831-685a-e538-5be6d7924a5a’ AND users.deleted=0
Wed Feb 12 23:20:37 2020 [27021][-none-][DEBUG] Limit Query:SELECT users.* FROM users WHERE users.id = ‘ecba9706-6831-685a-e538-5be6d7924a5a’ AND users.deleted=0 Start: 0 count: 1
Wed Feb 12 23:20:37 2020 [27021][-none-][INFO] Query:SELECT users.* FROM users WHERE users.id = ‘ecba9706-6831-685a-e538-5be6d7924a5a’ AND users.deleted=0 LIMIT 0,1
Wed Feb 12 23:20:37 2020 [27021][-none-][INFO] Query Execution Time:0.00010204315185547
Wed Feb 12 23:20:37 2020 [27021][ecba9706-6831-685a-e538-5be6d7924a5a][DEBUG] get_user_array query: SELECT id, first_name, last_name, user_name FROM users WHERE 1=1 ORDER BY first_name, last_name ASC
Wed Feb 12 23:20:37 2020 [27021][ecba9706-6831-685a-e538-5be6d7924a5a][INFO] Query:SELECT id, first_name, last_name, user_name FROM users WHERE 1=1 ORDER BY first_name, last_name ASC
Wed Feb 12 23:20:37 2020 [27021][ecba9706-6831-685a-e538-5be6d7924a5a][INFO] Query Execution Time:7.4863433837891E-5
Wed Feb 12 23:20:37 2020 [27021][ecba9706-6831-685a-e538-5be6d7924a5a][INFO] Query:SELECT u1.first_name, u1.last_name from users u1, users u2 where u1.id = u2.reports_to_id AND u2.id = ‘ecba9706-6831-685a-e538-5be6d7924a5a’ and u1.deleted=0
Wed Feb 12 23:20:37 2020 [27021][ecba9706-6831-685a-e538-5be6d7924a5a][INFO] Query Execution Time:5.1975250244141E-5
Wed Feb 12 23:20:37 2020 [27021][ecba9706-6831-685a-e538-5be6d7924a5a][DEBUG] SugarBean[User].load_relationships, Loading relationship (reports_to_link).
Wed Feb 12 23:20:37 2020 [27021][ecba9706-6831-685a-e538-5be6d7924a5a][INFO] Query:SELECT
ea.email_address,
ea.email_address_caps,
ea.invalid_email,
ea.opt_out,
ea.confirm_opt_in,
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 = ‘ecba9706-6831-685a-e538-5be6d7924a5a’
AND ear.deleted = 0
ORDER BY ear.reply_to_address, ear.primary_address DESC
Wed Feb 12 23:20:37 2020 [27021][ecba9706-6831-685a-e538-5be6d7924a5a][INFO] Query Execution Time:0.00011110305786133
Wed Feb 12 23:20:37 2020 [27021][ecba9706-6831-685a-e538-5be6d7924a5a][DEBUG] Hook called: Users::after_retrieve
Wed Feb 12 23:20:37 2020 [27021][ecba9706-6831-685a-e538-5be6d7924a5a][DEBUG] FACTOR AUTH: -------------------------------------------------------------
Wed Feb 12 23:20:37 2020 [27021][ecba9706-6831-685a-e538-5be6d7924a5a][DEBUG] FACTOR AUTH: --------------------- CHECK FACTOR AUtH ---------------------
Wed Feb 12 23:20:37 2020 [27021][ecba9706-6831-685a-e538-5be6d7924a5a][DEBUG] FACTOR AUTH: -------------------------------------------------------------
Wed Feb 12 23:20:37 2020 [27021][ecba9706-6831-685a-e538-5be6d7924a5a][DEBUG] FACTOR AUTH: User needs factor auth, request is not Logout
Wed Feb 12 23:20:37 2020 [27021][ecba9706-6831-685a-e538-5be6d7924a5a][DEBUG] FACTOR AUTH: User does`nt need factor auth
Wed Feb 12 23:20:37 2020 [27021][ecba9706-6831-685a-e538-5be6d7924a5a][DEBUG] Current user is: npwomack
Wed Feb 12 23:20:37 2020 [27021][ecba9706-6831-685a-e538-5be6d7924a5a][DEBUG] Current user is: npwomack
Wed Feb 12 23:20:37 2020 [27021][ecba9706-6831-685a-e538-5be6d7924a5a][DEBUG] setting cookie ck_login_id_20 to ecba9706-6831-685a-e538-5be6d7924a5a
Wed Feb 12 23:20:37 2020 [27021][ecba9706-6831-685a-e538-5be6d7924a5a][DEBUG] setting cookie ck_login_language_20 to en_us
Wed Feb 12 23:20:37 2020 [27021][ecba9706-6831-685a-e538-5be6d7924a5a][DEBUG] current_language is: en_us
Wed Feb 12 23:20:37 2020 [27021][ecba9706-6831-685a-e538-5be6d7924a5a][INFO] Found language file: en_us.lang.php
Wed Feb 12 23:20:37 2020 [27021][ecba9706-6831-685a-e538-5be6d7924a5a][INFO] Found extended language file: en_us.lang.ext.php
Wed Feb 12 23:20:37 2020 [27021][ecba9706-6831-685a-e538-5be6d7924a5a][INFO] Found custom language file: en_us.lang.php
Wed Feb 12 23:20:37 2020 [27021][ecba9706-6831-685a-e538-5be6d7924a5a][DEBUG] rebuilding cache for Alerts
Wed Feb 12 23:20:37 2020 [27021][ecba9706-6831-685a-e538-5be6d7924a5a][INFO] Query:SELECT * FROM fields_meta_data WHERE custom_module=‘Alerts’ AND deleted = 0
Wed Feb 12 23:20:37 2020 [27021][ecba9706-6831-685a-e538-5be6d7924a5a][INFO] Query Execution Time:9.0122222900391E-5
Wed Feb 12 23:20:37 2020 [27021][ecba9706-6831-685a-e538-5be6d7924a5a][DEBUG] Performing action: action_get MODULE: Alerts
Wed Feb 12 23:20:37 2020 [27021][ecba9706-6831-685a-e538-5be6d7924a5a][DEBUG] get_full_list: order_by = ‘alerts.date_entered’ and where = ‘alerts.assigned_user_id = ‘ecba9706-6831-685a-e538-5be6d7924a5a’ AND is_read != ‘1’’
Wed Feb 12 23:20:37 2020 [27021][ecba9706-6831-685a-e538-5be6d7924a5a][DEBUG] SugarBean[Alert].load_relationships, Loading relationship (modified_user_link).
Wed Feb 12 23:20:37 2020 [27021][ecba9706-6831-685a-e538-5be6d7924a5a][DEBUG] SugarBean[Alert].load_relationships, Loading relationship (created_by_link).
Wed Feb 12 23:20:37 2020 [27021][ecba9706-6831-685a-e538-5be6d7924a5a][DEBUG] SugarBean[Alert].load_relationships, Loading relationship (assigned_user_link).
Wed Feb 12 23:20:37 2020 [27021][ecba9706-6831-685a-e538-5be6d7924a5a][DEBUG] process_order_by: (alerts.date_entered) does not have a vardef entry.
Wed Feb 12 23:20:37 2020 [27021][ecba9706-6831-685a-e538-5be6d7924a5a][DEBUG] process_full_list_query: query is SELECT alerts.* , jt0.user_name modified_by_name , jt0.created_by modified_by_name_owner , ‘Users’ modified_by_name_mod , jt1.user_name created_by_name , jt1.created_by created_by_name_owner , ‘Users’ created_by_name_mod , jt2.user_name assigned_user_name , jt2.created_by assigned_user_name_owner , ‘Users’ assigned_user_name_mod FROM alerts LEFT JOIN users jt0 ON alerts.modified_user_id=jt0.id AND jt0.deleted=0
AND jt0.deleted=0 LEFT JOIN users jt1 ON alerts.created_by=jt1.id AND jt1.deleted=0
AND jt1.deleted=0 LEFT JOIN users jt2 ON alerts.assigned_user_id=jt2.id AND jt2.deleted=0
AND jt2.deleted=0 where (alerts.assigned_user_id = ‘ecba9706-6831-685a-e538-5be6d7924a5a’ AND is_read != ‘1’) AND alerts.deleted=0
Wed Feb 12 23:20:37 2020 [27021][ecba9706-6831-685a-e538-5be6d7924a5a][INFO] Query: SELECT alerts.* , jt0.user_name modified_by_name , jt0.created_by modified_by_name_owner , ‘Users’ modified_by_name_mod , jt1.user_name created_by_name , jt1.created_by created_by_name_owner , ‘Users’ created_by_name_mod , jt2.user_name assigned_user_name , jt2.created_by assigned_user_name_owner , ‘Users’ assigned_user_name_mod FROM alerts LEFT JOIN users jt0 ON alerts.modified_user_id=jt0.id AND jt0.deleted=0
AND jt0.deleted=0 LEFT JOIN users jt1 ON alerts.created_by=jt1.id AND jt1.deleted=0
AND jt1.deleted=0 LEFT JOIN users jt2 ON alerts.assigned_user_id=jt2.id AND jt2.deleted=0
AND jt2.deleted=0 where (alerts.assigned_user_id = ‘ecba9706-6831-685a-e538-5be6d7924a5a’ AND is_read != ‘1’) AND alerts.deleted=0
Wed Feb 12 23:20:37 2020 [27021][ecba9706-6831-685a-e538-5be6d7924a5a][INFO] Query Execution Time:8.5830688476562E-5
Wed Feb 12 23:20:37 2020 [27021][ecba9706-6831-685a-e538-5be6d7924a5a][DEBUG] process_full_list_query: result is mysqli_result Object
(
[current_field] => 0
[field_count] => 23
[lengths] =>
[num_rows] => 0
[type] => 0
)
Wed Feb 12 23:20:37 2020 [27021][ecba9706-6831-685a-e538-5be6d7924a5a][DEBUG] Hook called: ::server_round_trip
Wed Feb 12 23:20:37 2020 [27021][ecba9706-6831-685a-e538-5be6d7924a5a][DEBUG] Calling MySQLi::disconnect()
