development.log

2015-12-14 05:43:39 [I] Connecting to database specified by database.yml
2015-12-14 05:43:50 [D]   Setting::General Load (1.6ms)  SELECT "settings".* FROM "settings" WHERE "settings"."category" IN ('Setting::General') AND "settings"."name" = 'fix_db_cache' ORDER BY name LIMIT 1
2015-12-14 05:43:50 [D]   Setting Load (0.6ms)  SELECT "settings".* FROM "settings" ORDER BY name LIMIT 1
2015-12-14 05:43:50 [D]    (0.1ms)  BEGIN
2015-12-14 05:43:50 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'dynflow_allow_dangerous_actions' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.6ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'dynflow_allow_dangerous_actions' AND "settings"."id" != 2) LIMIT 1
2015-12-14 05:43:51 [D] removing dynflow_allow_dangerous_actions from cache
2015-12-14 05:43:51 [D]   Setting Load (0.4ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'dynflow_enable_console' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'dynflow_enable_console' AND "settings"."id" != 3) LIMIT 1
2015-12-14 05:43:51 [D] removing dynflow_enable_console from cache
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'dynflow_console_require_auth' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'dynflow_console_require_auth' AND "settings"."id" != 4) LIMIT 1
2015-12-14 05:43:51 [D] removing dynflow_console_require_auth from cache
2015-12-14 05:43:51 [D]    (0.2ms)  COMMIT
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]    (0.1ms)  BEGIN
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'satellite_default_provision' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.5ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'satellite_default_provision' AND "settings"."id" != 5) LIMIT 1
2015-12-14 05:43:51 [D] removing satellite_default_provision from cache
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'satellite_default_finish' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'satellite_default_finish' AND "settings"."id" != 6) LIMIT 1
2015-12-14 05:43:51 [D] removing satellite_default_finish from cache
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'satellite_default_user_data' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'satellite_default_user_data' AND "settings"."id" != 7) LIMIT 1
2015-12-14 05:43:51 [D] removing satellite_default_user_data from cache
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'satellite_default_PXELinux' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'satellite_default_PXELinux' AND "settings"."id" != 8) LIMIT 1
2015-12-14 05:43:51 [D] removing satellite_default_PXELinux from cache
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'satellite_default_iPXE' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'satellite_default_iPXE' AND "settings"."id" != 9) LIMIT 1
2015-12-14 05:43:51 [D] removing satellite_default_iPXE from cache
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'satellite_default_ptable' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'satellite_default_ptable' AND "settings"."id" != 10) LIMIT 1
2015-12-14 05:43:51 [D] removing satellite_default_ptable from cache
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'content_action_accept_timeout' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'content_action_accept_timeout' AND "settings"."id" != 11) LIMIT 1
2015-12-14 05:43:51 [D] removing content_action_accept_timeout from cache
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'content_action_finish_timeout' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'content_action_finish_timeout' AND "settings"."id" != 12) LIMIT 1
2015-12-14 05:43:51 [D] removing content_action_finish_timeout from cache
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'pulp_sync_node_action_accept_timeout' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'pulp_sync_node_action_accept_timeout' AND "settings"."id" != 13) LIMIT 1
2015-12-14 05:43:51 [D] removing pulp_sync_node_action_accept_timeout from cache
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'pulp_sync_node_action_finish_timeout' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'pulp_sync_node_action_finish_timeout' AND "settings"."id" != 14) LIMIT 1
2015-12-14 05:43:51 [D] removing pulp_sync_node_action_finish_timeout from cache
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'check_services_before_actions' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'check_services_before_actions' AND "settings"."id" != 15) LIMIT 1
2015-12-14 05:43:51 [D] removing check_services_before_actions from cache
2015-12-14 05:43:51 [D]    (0.1ms)  COMMIT
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]    (0.2ms)  BEGIN
2015-12-14 05:43:51 [D]   Setting Load (0.5ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'administrator' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'administrator' AND "settings"."id" != 16) LIMIT 1
2015-12-14 05:43:51 [D] removing administrator from cache
2015-12-14 05:43:51 [D]   Setting Load (0.4ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'foreman_url' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'foreman_url' AND "settings"."id" != 17) LIMIT 1
2015-12-14 05:43:51 [D] removing foreman_url from cache
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'email_reply_address' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'email_reply_address' AND "settings"."id" != 18) LIMIT 1
2015-12-14 05:43:51 [D] removing email_reply_address from cache
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'email_subject_prefix' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'email_subject_prefix' AND "settings"."id" != 19) LIMIT 1
2015-12-14 05:43:51 [D] removing email_subject_prefix from cache
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'send_welcome_email' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'send_welcome_email' AND "settings"."id" != 20) LIMIT 1
2015-12-14 05:43:51 [D] removing send_welcome_email from cache
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'entries_per_page' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'entries_per_page' AND "settings"."id" != 21) LIMIT 1
2015-12-14 05:43:51 [D] removing entries_per_page from cache
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'fix_db_cache' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'fix_db_cache' AND "settings"."id" != 1) LIMIT 1
2015-12-14 05:43:51 [D] removing fix_db_cache from cache
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'authorize_login_delegation' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'authorize_login_delegation' AND "settings"."id" != 22) LIMIT 1
2015-12-14 05:43:51 [D] removing authorize_login_delegation from cache
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'authorize_login_delegation_api' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'authorize_login_delegation_api' AND "settings"."id" != 23) LIMIT 1
2015-12-14 05:43:51 [D] removing authorize_login_delegation_api from cache
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'idle_timeout' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'idle_timeout' AND "settings"."id" != 24) LIMIT 1
2015-12-14 05:43:51 [D] removing idle_timeout from cache
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'max_trend' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'max_trend' AND "settings"."id" != 25) LIMIT 1
2015-12-14 05:43:51 [D] removing max_trend from cache
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'use_gravatar' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'use_gravatar' AND "settings"."id" != 26) LIMIT 1
2015-12-14 05:43:51 [D] removing use_gravatar from cache
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'db_pending_migration' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'db_pending_migration' AND "settings"."id" != 27) LIMIT 1
2015-12-14 05:43:51 [D] removing db_pending_migration from cache
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'db_pending_seed' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'db_pending_seed' AND "settings"."id" != 28) LIMIT 1
2015-12-14 05:43:51 [D] removing db_pending_seed from cache
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'proxy_request_timeout' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'proxy_request_timeout' AND "settings"."id" != 29) LIMIT 1
2015-12-14 05:43:51 [D] removing proxy_request_timeout from cache
2015-12-14 05:43:51 [D]    (0.1ms)  COMMIT
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]    (0.1ms)  BEGIN
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'oauth_active' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.4ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'oauth_active' AND "settings"."id" != 30) LIMIT 1
2015-12-14 05:43:51 [D] removing oauth_active from cache
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'oauth_consumer_key' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'oauth_consumer_key' AND "settings"."id" != 31) LIMIT 1
2015-12-14 05:43:51 [D] removing oauth_consumer_key from cache
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'oauth_consumer_secret' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'oauth_consumer_secret' AND "settings"."id" != 32) LIMIT 1
2015-12-14 05:43:51 [D] removing oauth_consumer_secret from cache
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'oauth_map_users' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'oauth_map_users' AND "settings"."id" != 33) LIMIT 1
2015-12-14 05:43:51 [D] removing oauth_map_users from cache
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'restrict_registered_puppetmasters' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'restrict_registered_puppetmasters' AND "settings"."id" != 34) LIMIT 1
2015-12-14 05:43:51 [D] removing restrict_registered_puppetmasters from cache
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'require_ssl_puppetmasters' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'require_ssl_puppetmasters' AND "settings"."id" != 35) LIMIT 1
2015-12-14 05:43:51 [D] removing require_ssl_puppetmasters from cache
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'trusted_puppetmaster_hosts' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'trusted_puppetmaster_hosts' AND "settings"."id" != 36) LIMIT 1
2015-12-14 05:43:51 [D] removing trusted_puppetmaster_hosts from cache
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'ssl_client_dn_env' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'ssl_client_dn_env' AND "settings"."id" != 37) LIMIT 1
2015-12-14 05:43:51 [D] removing ssl_client_dn_env from cache
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'ssl_client_verify_env' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'ssl_client_verify_env' AND "settings"."id" != 38) LIMIT 1
2015-12-14 05:43:51 [D] removing ssl_client_verify_env from cache
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'login_delegation_logout_url' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'login_delegation_logout_url' AND "settings"."id" != 39) LIMIT 1
2015-12-14 05:43:51 [D] removing login_delegation_logout_url from cache
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'authorize_login_delegation_auth_source_user_autocreate' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'authorize_login_delegation_auth_source_user_autocreate' AND "settings"."id" != 40) LIMIT 1
2015-12-14 05:43:51 [D] removing authorize_login_delegation_auth_source_user_autocreate from cache
2015-12-14 05:43:51 [D]    (0.4ms)  COMMIT
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]    (0.1ms)  BEGIN
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'root_pass' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'root_pass' AND "settings"."id" != 41) LIMIT 1
2015-12-14 05:43:51 [D] removing root_pass from cache
2015-12-14 05:43:51 [D]   Setting Load (0.4ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'unattended_url' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'unattended_url' AND "settings"."id" != 42) LIMIT 1
2015-12-14 05:43:51 [D] removing unattended_url from cache
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'safemode_render' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'safemode_render' AND "settings"."id" != 43) LIMIT 1
2015-12-14 05:43:51 [D] removing safemode_render from cache
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'ssl_certificate' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'ssl_certificate' AND "settings"."id" != 44) LIMIT 1
2015-12-14 05:43:51 [D] removing ssl_certificate from cache
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'ssl_ca_file' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'ssl_ca_file' AND "settings"."id" != 45) LIMIT 1
2015-12-14 05:43:51 [D] removing ssl_ca_file from cache
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'ssl_priv_key' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'ssl_priv_key' AND "settings"."id" != 46) LIMIT 1
2015-12-14 05:43:51 [D] removing ssl_priv_key from cache
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'manage_puppetca' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'manage_puppetca' AND "settings"."id" != 47) LIMIT 1
2015-12-14 05:43:51 [D] removing manage_puppetca from cache
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'ignore_puppet_facts_for_provisioning' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'ignore_puppet_facts_for_provisioning' AND "settings"."id" != 48) LIMIT 1
2015-12-14 05:43:51 [D] removing ignore_puppet_facts_for_provisioning from cache
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'query_local_nameservers' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'query_local_nameservers' AND "settings"."id" != 49) LIMIT 1
2015-12-14 05:43:51 [D] removing query_local_nameservers from cache
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'remote_addr' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'remote_addr' AND "settings"."id" != 50) LIMIT 1
2015-12-14 05:43:51 [D] removing remote_addr from cache
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'token_duration' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'token_duration' AND "settings"."id" != 51) LIMIT 1
2015-12-14 05:43:51 [D] removing token_duration from cache
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'libvirt_default_console_address' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'libvirt_default_console_address' AND "settings"."id" != 52) LIMIT 1
2015-12-14 05:43:51 [D] removing libvirt_default_console_address from cache
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'update_ip_from_built_request' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'update_ip_from_built_request' AND "settings"."id" != 53) LIMIT 1
2015-12-14 05:43:51 [D] removing update_ip_from_built_request from cache
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'use_shortname_for_vms' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'use_shortname_for_vms' AND "settings"."id" != 54) LIMIT 1
2015-12-14 05:43:51 [D] removing use_shortname_for_vms from cache
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'websockets_encrypt' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'websockets_encrypt' AND "settings"."id" != 55) LIMIT 1
2015-12-14 05:43:51 [D] removing websockets_encrypt from cache
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'websockets_ssl_key' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'websockets_ssl_key' AND "settings"."id" != 56) LIMIT 1
2015-12-14 05:43:51 [D] removing websockets_ssl_key from cache
2015-12-14 05:43:51 [D]    (0.6ms)  UPDATE "settings" SET "description" = 'Private key that Foreman will use to encrypt websockets', "updated_at" = '2015-12-14 10:43:51.847593' WHERE "settings"."category" IN ('Setting::Provisioning') AND "settings"."id" = 56
2015-12-14 05:43:51 [D]   Setting Load (0.4ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'websockets_ssl_cert' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'websockets_ssl_cert' AND "settings"."id" != 57) LIMIT 1
2015-12-14 05:43:51 [D] removing websockets_ssl_cert from cache
2015-12-14 05:43:51 [D]    (0.3ms)  UPDATE "settings" SET "description" = 'Certificate that Foreman will use to encrypt websockets', "updated_at" = '2015-12-14 10:43:51.861671' WHERE "settings"."category" IN ('Setting::Provisioning') AND "settings"."id" = 57
2015-12-14 05:43:51 [D]    (24.3ms)  COMMIT
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]    (0.1ms)  BEGIN
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'puppet_interval' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'puppet_interval' AND "settings"."id" != 58) LIMIT 1
2015-12-14 05:43:51 [D] removing puppet_interval from cache
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'default_puppet_environment' ORDER BY name LIMIT 1
2015-12-14 05:43:51 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'default_puppet_environment' AND "settings"."id" != 59) LIMIT 1
2015-12-14 05:43:51 [D] removing default_puppet_environment from cache
2015-12-14 05:43:51 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'modulepath' ORDER BY name LIMIT 1
2015-12-14 05:43:52 [D]   Setting Exists (0.5ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'modulepath' AND "settings"."id" != 60) LIMIT 1
2015-12-14 05:43:52 [D] removing modulepath from cache
2015-12-14 05:43:52 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'document_root' ORDER BY name LIMIT 1
2015-12-14 05:43:52 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'document_root' AND "settings"."id" != 61) LIMIT 1
2015-12-14 05:43:52 [D] removing document_root from cache
2015-12-14 05:43:52 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'puppetrun' ORDER BY name LIMIT 1
2015-12-14 05:43:52 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'puppetrun' AND "settings"."id" != 62) LIMIT 1
2015-12-14 05:43:52 [D] removing puppetrun from cache
2015-12-14 05:43:52 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'puppet_server' ORDER BY name LIMIT 1
2015-12-14 05:43:52 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'puppet_server' AND "settings"."id" != 63) LIMIT 1
2015-12-14 05:43:52 [D] removing puppet_server from cache
2015-12-14 05:43:52 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'Default_variables_Lookup_Path' ORDER BY name LIMIT 1
2015-12-14 05:43:52 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'Default_variables_Lookup_Path' AND "settings"."id" != 64) LIMIT 1
2015-12-14 05:43:52 [D] removing Default_variables_Lookup_Path from cache
2015-12-14 05:43:52 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'Enable_Smart_Variables_in_ENC' ORDER BY name LIMIT 1
2015-12-14 05:43:52 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'Enable_Smart_Variables_in_ENC' AND "settings"."id" != 65) LIMIT 1
2015-12-14 05:43:52 [D] removing Enable_Smart_Variables_in_ENC from cache
2015-12-14 05:43:52 [D]   Setting Load (0.4ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'Parametrized_Classes_in_ENC' ORDER BY name LIMIT 1
2015-12-14 05:43:52 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'Parametrized_Classes_in_ENC' AND "settings"."id" != 66) LIMIT 1
2015-12-14 05:43:52 [D] removing Parametrized_Classes_in_ENC from cache
2015-12-14 05:43:52 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'interpolate_erb_in_parameters' ORDER BY name LIMIT 1
2015-12-14 05:43:52 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'interpolate_erb_in_parameters' AND "settings"."id" != 67) LIMIT 1
2015-12-14 05:43:52 [D] removing interpolate_erb_in_parameters from cache
2015-12-14 05:43:52 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'enc_environment' ORDER BY name LIMIT 1
2015-12-14 05:43:52 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'enc_environment' AND "settings"."id" != 68) LIMIT 1
2015-12-14 05:43:52 [D] removing enc_environment from cache
2015-12-14 05:43:52 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'use_uuid_for_certificates' ORDER BY name LIMIT 1
2015-12-14 05:43:52 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'use_uuid_for_certificates' AND "settings"."id" != 69) LIMIT 1
2015-12-14 05:43:52 [D] removing use_uuid_for_certificates from cache
2015-12-14 05:43:52 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'update_environment_from_facts' ORDER BY name LIMIT 1
2015-12-14 05:43:52 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'update_environment_from_facts' AND "settings"."id" != 70) LIMIT 1
2015-12-14 05:43:52 [D] removing update_environment_from_facts from cache
2015-12-14 05:43:52 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'host_group_matchers_inheritance' ORDER BY name LIMIT 1
2015-12-14 05:43:52 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'host_group_matchers_inheritance' AND "settings"."id" != 71) LIMIT 1
2015-12-14 05:43:52 [D] removing host_group_matchers_inheritance from cache
2015-12-14 05:43:52 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'create_new_host_when_facts_are_uploaded' ORDER BY name LIMIT 1
2015-12-14 05:43:52 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'create_new_host_when_facts_are_uploaded' AND "settings"."id" != 72) LIMIT 1
2015-12-14 05:43:52 [D] removing create_new_host_when_facts_are_uploaded from cache
2015-12-14 05:43:52 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'create_new_host_when_report_is_uploaded' ORDER BY name LIMIT 1
2015-12-14 05:43:52 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'create_new_host_when_report_is_uploaded' AND "settings"."id" != 73) LIMIT 1
2015-12-14 05:43:52 [D] removing create_new_host_when_report_is_uploaded from cache
2015-12-14 05:43:52 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'legacy_puppet_hostname' ORDER BY name LIMIT 1
2015-12-14 05:43:52 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'legacy_puppet_hostname' AND "settings"."id" != 74) LIMIT 1
2015-12-14 05:43:52 [D] removing legacy_puppet_hostname from cache
2015-12-14 05:43:52 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'location_fact' ORDER BY name LIMIT 1
2015-12-14 05:43:52 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'location_fact' AND "settings"."id" != 75) LIMIT 1
2015-12-14 05:43:52 [D] removing location_fact from cache
2015-12-14 05:43:52 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'organization_fact' ORDER BY name LIMIT 1
2015-12-14 05:43:52 [D]   Setting Exists (0.4ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'organization_fact' AND "settings"."id" != 76) LIMIT 1
2015-12-14 05:43:52 [D] removing organization_fact from cache
2015-12-14 05:43:52 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'default_location' ORDER BY name LIMIT 1
2015-12-14 05:43:52 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'default_location' AND "settings"."id" != 77) LIMIT 1
2015-12-14 05:43:52 [D] removing default_location from cache
2015-12-14 05:43:52 [D]   Setting Load (0.3ms)  SELECT "settings".* FROM "settings" WHERE "settings"."name" = 'default_organization' ORDER BY name LIMIT 1
2015-12-14 05:43:52 [D]   Setting Exists (0.3ms)  SELECT 1 AS one FROM "settings" WHERE ("settings"."name" = 'default_organization' AND "settings"."id" != 78) LIMIT 1
2015-12-14 05:43:52 [D] removing default_organization from cache
2015-12-14 05:43:52 [D]    (0.1ms)  COMMIT
2015-12-14 05:43:52 [D]   SQL (0.9ms)  SELECT "users"."id" FROM "users" 
2015-12-14 05:43:58 [W] Creating scope :completer_scope. Overwriting existing method Location.completer_scope.
2015-12-14 05:43:58 [W] Creating scope :completer_scope. Overwriting existing method Organization.completer_scope.
2015-12-14 05:44:01 [D]   Feature Load (0.4ms)  SELECT "features".* FROM "features" 
2015-12-14 05:44:02 [D]    (0.5ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:02 [D]   Permission Load (0.8ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'view_foreman_tasks' AND "permissions"."resource_type" = 'ForemanTasks::Task' LIMIT 1
2015-12-14 05:44:02 [D]    (0.4ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:02 [D]   Permission Load (0.5ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'edit_foreman_tasks' AND "permissions"."resource_type" = 'ForemanTasks::Task' LIMIT 1
2015-12-14 05:44:02 [D]    (0.4ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:02 [D]    (0.2ms)  BEGIN
2015-12-14 05:44:02 [D]   Role Load (0.5ms)  SELECT "roles".* FROM "roles" WHERE "roles"."name" = 'Tasks Manager' LIMIT 1
2015-12-14 05:44:03 [D]    (1.3ms)  SELECT COUNT(*) FROM "permissions" INNER JOIN "filterings" ON "permissions"."id" = "filterings"."permission_id" INNER JOIN "filters" ON "filterings"."filter_id" = "filters"."id" WHERE "filters"."role_id" = 1
2015-12-14 05:44:03 [D]    (0.2ms)  COMMIT
2015-12-14 05:44:03 [D]    (0.3ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:03 [D]    (0.1ms)  BEGIN
2015-12-14 05:44:03 [D]   Role Load (0.3ms)  SELECT "roles".* FROM "roles" WHERE "roles"."name" = 'Tasks Reader' LIMIT 1
2015-12-14 05:44:03 [D]    (0.8ms)  SELECT COUNT(*) FROM "permissions" INNER JOIN "filterings" ON "permissions"."id" = "filterings"."permission_id" INNER JOIN "filters" ON "filterings"."filter_id" = "filters"."id" WHERE "filters"."role_id" = 2
2015-12-14 05:44:03 [D]    (0.1ms)  COMMIT
2015-12-14 05:44:03 [D]    (0.3ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:03 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'view_content_reports' AND "permissions"."resource_type" IS NULL LIMIT 1
2015-12-14 05:44:08 [D]    (0.5ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:08 [D]   Permission Load (0.9ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'view_containers' AND "permissions"."resource_type" = 'Container' LIMIT 1
2015-12-14 05:44:08 [D]    (0.4ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:08 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'commit_containers' AND "permissions"."resource_type" = 'Container' LIMIT 1
2015-12-14 05:44:08 [D]    (0.3ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:08 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'create_containers' AND "permissions"."resource_type" = 'Container' LIMIT 1
2015-12-14 05:44:08 [D]    (0.4ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:08 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'destroy_containers' AND "permissions"."resource_type" = 'Container' LIMIT 1
2015-12-14 05:44:08 [D]    (1.8ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:08 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'power_compute_resources_vms' AND "permissions"."resource_type" = 'ComputeResource' LIMIT 1
2015-12-14 05:44:08 [D]    (0.3ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:08 [D]   Permission Load (0.5ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'view_registries' AND "permissions"."resource_type" = 'DockerRegistry' LIMIT 1
2015-12-14 05:44:08 [D]    (0.3ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:08 [D]   Permission Load (0.5ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'create_registries' AND "permissions"."resource_type" = 'DockerRegistry' LIMIT 1
2015-12-14 05:44:08 [D]    (0.4ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:08 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'destroy_registries' AND "permissions"."resource_type" = 'DockerRegistry' LIMIT 1
2015-12-14 05:44:08 [D]    (0.4ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:08 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'search_repository_image_search' AND "permissions"."resource_type" = 'Docker/ImageSearch' LIMIT 1
2015-12-14 05:44:08 [D]    (0.4ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:08 [D]   Permission Load (0.5ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'view_activation_keys' AND "permissions"."resource_type" = 'Katello::ActivationKey' LIMIT 1
2015-12-14 05:44:08 [D]    (0.4ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:08 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'create_activation_keys' AND "permissions"."resource_type" = 'Katello::ActivationKey' LIMIT 1
2015-12-14 05:44:08 [D]    (0.4ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:08 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'edit_activation_keys' AND "permissions"."resource_type" = 'Katello::ActivationKey' LIMIT 1
2015-12-14 05:44:08 [D]    (0.3ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:08 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'destroy_activation_keys' AND "permissions"."resource_type" = 'Katello::ActivationKey' LIMIT 1
2015-12-14 05:44:08 [D]    (0.4ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:08 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'manage_capsule_content' AND "permissions"."resource_type" = 'SmartProxy' LIMIT 1
2015-12-14 05:44:08 [D]    (0.4ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:08 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'view_gpg_keys' AND "permissions"."resource_type" = 'Katello::GpgKey' LIMIT 1
2015-12-14 05:44:08 [D]    (0.3ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:08 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'create_gpg_keys' AND "permissions"."resource_type" = 'Katello::GpgKey' LIMIT 1
2015-12-14 05:44:08 [D]    (0.3ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:08 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'edit_gpg_keys' AND "permissions"."resource_type" = 'Katello::GpgKey' LIMIT 1
2015-12-14 05:44:08 [D]    (0.4ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:08 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'destroy_gpg_keys' AND "permissions"."resource_type" = 'Katello::GpgKey' LIMIT 1
2015-12-14 05:44:08 [D]    (0.4ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:08 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'view_lifecycle_environments' AND "permissions"."resource_type" = 'Katello::KTEnvironment' LIMIT 1
2015-12-14 05:44:08 [D]    (0.4ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:08 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'create_lifecycle_environments' AND "permissions"."resource_type" = 'Katello::KTEnvironment' LIMIT 1
2015-12-14 05:44:08 [D]    (0.3ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:09 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'edit_lifecycle_environments' AND "permissions"."resource_type" = 'Katello::KTEnvironment' LIMIT 1
2015-12-14 05:44:09 [D]    (0.4ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:09 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'destroy_lifecycle_environments' AND "permissions"."resource_type" = 'Katello::KTEnvironment' LIMIT 1
2015-12-14 05:44:09 [D]    (0.4ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:09 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'promote_or_remove_content_views_to_environments' AND "permissions"."resource_type" = 'Katello::KTEnvironment' LIMIT 1
2015-12-14 05:44:09 [D]    (0.4ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:09 [D]   Permission Load (0.5ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'my_organizations' AND "permissions"."resource_type" IS NULL LIMIT 1
2015-12-14 05:44:09 [D]    (0.3ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:09 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'view_content_hosts' AND "permissions"."resource_type" = 'Katello::System' LIMIT 1
2015-12-14 05:44:09 [D]    (0.4ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:09 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'create_content_hosts' AND "permissions"."resource_type" = 'Katello::System' LIMIT 1
2015-12-14 05:44:09 [D]    (0.4ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:09 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'edit_content_hosts' AND "permissions"."resource_type" = 'Katello::System' LIMIT 1
2015-12-14 05:44:09 [D]    (0.4ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:09 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'destroy_content_hosts' AND "permissions"."resource_type" = 'Katello::System' LIMIT 1
2015-12-14 05:44:09 [D]    (0.4ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:09 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'view_content_views' AND "permissions"."resource_type" = 'Katello::ContentView' LIMIT 1
2015-12-14 05:44:09 [D]    (0.3ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:09 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'create_content_views' AND "permissions"."resource_type" = 'Katello::ContentView' LIMIT 1
2015-12-14 05:44:09 [D]    (0.4ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:09 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'edit_content_views' AND "permissions"."resource_type" = 'Katello::ContentView' LIMIT 1
2015-12-14 05:44:09 [D]    (0.3ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:09 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'destroy_content_views' AND "permissions"."resource_type" = 'Katello::ContentView' LIMIT 1
2015-12-14 05:44:09 [D]    (0.4ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:09 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'publish_content_views' AND "permissions"."resource_type" = 'Katello::ContentView' LIMIT 1
2015-12-14 05:44:09 [D]    (0.3ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:09 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'promote_or_remove_content_views' AND "permissions"."resource_type" = 'Katello::ContentView' LIMIT 1
2015-12-14 05:44:09 [D]    (0.4ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:09 [D]   Permission Load (0.5ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'view_host_collections' AND "permissions"."resource_type" = 'Katello::HostCollection' LIMIT 1
2015-12-14 05:44:09 [D]    (0.3ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:09 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'create_host_collections' AND "permissions"."resource_type" = 'Katello::HostCollection' LIMIT 1
2015-12-14 05:44:09 [D]    (0.3ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:09 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'edit_host_collections' AND "permissions"."resource_type" = 'Katello::HostCollection' LIMIT 1
2015-12-14 05:44:09 [D]    (0.4ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:09 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'destroy_host_collections' AND "permissions"."resource_type" = 'Katello::HostCollection' LIMIT 1
2015-12-14 05:44:09 [D]    (0.4ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:09 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'view_products' AND "permissions"."resource_type" = 'Katello::Product' LIMIT 1
2015-12-14 05:44:09 [D]    (0.3ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:09 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'create_products' AND "permissions"."resource_type" = 'Katello::Product' LIMIT 1
2015-12-14 05:44:09 [D]    (0.3ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:09 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'edit_products' AND "permissions"."resource_type" = 'Katello::Product' LIMIT 1
2015-12-14 05:44:09 [D]    (0.4ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:09 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'destroy_products' AND "permissions"."resource_type" = 'Katello::Product' LIMIT 1
2015-12-14 05:44:09 [D]    (0.3ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:09 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'sync_products' AND "permissions"."resource_type" = 'Katello::Product' LIMIT 1
2015-12-14 05:44:09 [D]    (0.3ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:09 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'view_subscriptions' AND "permissions"."resource_type" = 'Organization' LIMIT 1
2015-12-14 05:44:09 [D]    (0.4ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:09 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'attach_subscriptions' AND "permissions"."resource_type" = 'Organization' LIMIT 1
2015-12-14 05:44:09 [D]    (0.4ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:09 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'unattach_subscriptions' AND "permissions"."resource_type" = 'Organization' LIMIT 1
2015-12-14 05:44:09 [D]    (0.3ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:09 [D]   Permission Load (0.5ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'import_manifest' AND "permissions"."resource_type" = 'Organization' LIMIT 1
2015-12-14 05:44:09 [D]    (0.3ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:09 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'delete_manifest' AND "permissions"."resource_type" = 'Organization' LIMIT 1
2015-12-14 05:44:09 [D]    (0.3ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:09 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'view_sync_plans' AND "permissions"."resource_type" = 'Katello::SyncPlan' LIMIT 1
2015-12-14 05:44:09 [D]    (0.3ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:09 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'create_sync_plans' AND "permissions"."resource_type" = 'Katello::SyncPlan' LIMIT 1
2015-12-14 05:44:09 [D]    (0.4ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:09 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'edit_sync_plans' AND "permissions"."resource_type" = 'Katello::SyncPlan' LIMIT 1
2015-12-14 05:44:09 [D]    (0.3ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:09 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'destroy_sync_plans' AND "permissions"."resource_type" = 'Katello::SyncPlan' LIMIT 1
2015-12-14 05:44:09 [W] fusor_server has added '["api/v21/foreman_tasks"]' to 'Katello.config.logging.ignored_paths': ["/notices/get_new", "/assets/", "/api/tasks/bulk_search", "api/v21/foreman_tasks"]
2015-12-14 05:44:09 [D]    (0.3ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:09 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'view_fusor_deployments' AND "permissions"."resource_type" = 'Fusor::Deployment' LIMIT 1
2015-12-14 05:44:09 [D]    (0.3ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:09 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'create_fusor_deployments' AND "permissions"."resource_type" = 'Fusor::Deployment' LIMIT 1
2015-12-14 05:44:09 [D]    (0.4ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:10 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'edit_fusor_deployments' AND "permissions"."resource_type" = 'Fusor::Deployment' LIMIT 1
2015-12-14 05:44:10 [D]    (0.3ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:10 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."name" = 'destroy_fusor_deployments' AND "permissions"."resource_type" = 'Fusor::Deployment' LIMIT 1
2015-12-14 05:44:15 [D]    (0.4ms)  SELECT "schema_migrations"."version" FROM "schema_migrations" 
2015-12-14 05:44:15 [D]   AuthSourceInternal Load (0.8ms)  SELECT "auth_sources".* FROM "auth_sources" WHERE "auth_sources"."type" IN ('AuthSourceInternal') AND "auth_sources"."type" = 'AuthSourceInternal' LIMIT 1
2015-12-14 05:44:15 [D]   AuthSourceHidden Load (0.6ms)  SELECT "auth_sources".* FROM "auth_sources" WHERE "auth_sources"."type" IN ('AuthSourceHidden') AND "auth_sources"."type" = 'AuthSourceHidden' LIMIT 1
2015-12-14 05:44:15 [D]   Permission Load (0.5ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Architecture' AND "permissions"."name" = 'view_architectures' LIMIT 1
2015-12-14 05:44:15 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Architecture' AND "permissions"."name" = 'create_architectures' LIMIT 1
2015-12-14 05:44:15 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Architecture' AND "permissions"."name" = 'edit_architectures' LIMIT 1
2015-12-14 05:44:15 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Architecture' AND "permissions"."name" = 'destroy_architectures' LIMIT 1
2015-12-14 05:44:15 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Audit' AND "permissions"."name" = 'view_audit_logs' LIMIT 1
2015-12-14 05:44:15 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'AuthSourceLdap' AND "permissions"."name" = 'view_authenticators' LIMIT 1
2015-12-14 05:44:15 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'AuthSourceLdap' AND "permissions"."name" = 'create_authenticators' LIMIT 1
2015-12-14 05:44:15 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'AuthSourceLdap' AND "permissions"."name" = 'edit_authenticators' LIMIT 1
2015-12-14 05:44:15 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'AuthSourceLdap' AND "permissions"."name" = 'destroy_authenticators' LIMIT 1
2015-12-14 05:44:15 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Bookmark' AND "permissions"."name" = 'view_bookmarks' LIMIT 1
2015-12-14 05:44:15 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Bookmark' AND "permissions"."name" = 'create_bookmarks' LIMIT 1
2015-12-14 05:44:15 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Bookmark' AND "permissions"."name" = 'edit_bookmarks' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Bookmark' AND "permissions"."name" = 'destroy_bookmarks' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'ComputeProfile' AND "permissions"."name" = 'view_compute_profiles' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'ComputeProfile' AND "permissions"."name" = 'create_compute_profiles' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'ComputeProfile' AND "permissions"."name" = 'edit_compute_profiles' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'ComputeProfile' AND "permissions"."name" = 'destroy_compute_profiles' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'ComputeResource' AND "permissions"."name" = 'view_compute_resources' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'ComputeResource' AND "permissions"."name" = 'create_compute_resources' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'ComputeResource' AND "permissions"."name" = 'edit_compute_resources' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'ComputeResource' AND "permissions"."name" = 'destroy_compute_resources' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'ComputeResource' AND "permissions"."name" = 'view_compute_resources_vms' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'ComputeResource' AND "permissions"."name" = 'create_compute_resources_vms' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'ComputeResource' AND "permissions"."name" = 'edit_compute_resources_vms' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'ComputeResource' AND "permissions"."name" = 'destroy_compute_resources_vms' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'ComputeResource' AND "permissions"."name" = 'power_compute_resources_vms' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'ComputeResource' AND "permissions"."name" = 'console_compute_resources_vms' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'ConfigTemplate' AND "permissions"."name" = 'view_templates' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'ConfigTemplate' AND "permissions"."name" = 'create_templates' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'ConfigTemplate' AND "permissions"."name" = 'edit_templates' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'ConfigTemplate' AND "permissions"."name" = 'destroy_templates' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'ConfigTemplate' AND "permissions"."name" = 'deploy_templates' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'ConfigTemplate' AND "permissions"."name" = 'lock_templates' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'ConfigGroup' AND "permissions"."name" = 'view_config_groups' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'ConfigGroup' AND "permissions"."name" = 'create_config_groups' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'ConfigGroup' AND "permissions"."name" = 'edit_config_groups' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'ConfigGroup' AND "permissions"."name" = 'destroy_config_groups' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" IS NULL AND "permissions"."name" = 'access_dashboard' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Domain' AND "permissions"."name" = 'view_domains' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Domain' AND "permissions"."name" = 'create_domains' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Domain' AND "permissions"."name" = 'edit_domains' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Domain' AND "permissions"."name" = 'destroy_domains' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Environment' AND "permissions"."name" = 'view_environments' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Environment' AND "permissions"."name" = 'create_environments' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Environment' AND "permissions"."name" = 'edit_environments' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Environment' AND "permissions"."name" = 'destroy_environments' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Environment' AND "permissions"."name" = 'import_environments' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'ExternalUsergroups' AND "permissions"."name" = 'view_external_usergroups' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'ExternalUsergroups' AND "permissions"."name" = 'create_external_usergroups' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'ExternalUsergroups' AND "permissions"."name" = 'edit_external_usergroups' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'ExternalUsergroups' AND "permissions"."name" = 'destroy_external_usergroups' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'LookupKey' AND "permissions"."name" = 'view_external_variables' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'LookupKey' AND "permissions"."name" = 'create_external_variables' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'LookupKey' AND "permissions"."name" = 'edit_external_variables' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'LookupKey' AND "permissions"."name" = 'destroy_external_variables' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'FactValue' AND "permissions"."name" = 'view_facts' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'FactValue' AND "permissions"."name" = 'upload_facts' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Filter' AND "permissions"."name" = 'view_filters' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Filter' AND "permissions"."name" = 'create_filters' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Filter' AND "permissions"."name" = 'edit_filters' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Filter' AND "permissions"."name" = 'destroy_filters' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'CommonParameter' AND "permissions"."name" = 'view_globals' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'CommonParameter' AND "permissions"."name" = 'create_globals' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'CommonParameter' AND "permissions"."name" = 'edit_globals' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'CommonParameter' AND "permissions"."name" = 'destroy_globals' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'HostClass' AND "permissions"."name" = 'edit_classes' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Parameter' AND "permissions"."name" = 'create_params' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Parameter' AND "permissions"."name" = 'edit_params' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Parameter' AND "permissions"."name" = 'destroy_params' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Hostgroup' AND "permissions"."name" = 'view_hostgroups' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Hostgroup' AND "permissions"."name" = 'create_hostgroups' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Hostgroup' AND "permissions"."name" = 'edit_hostgroups' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Hostgroup' AND "permissions"."name" = 'destroy_hostgroups' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Host' AND "permissions"."name" = 'view_hosts' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Host' AND "permissions"."name" = 'create_hosts' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Host' AND "permissions"."name" = 'edit_hosts' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Host' AND "permissions"."name" = 'destroy_hosts' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Host' AND "permissions"."name" = 'build_hosts' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Host' AND "permissions"."name" = 'power_hosts' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Host' AND "permissions"."name" = 'console_hosts' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Host' AND "permissions"."name" = 'ipmi_boot' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Host' AND "permissions"."name" = 'puppetrun_hosts' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Image' AND "permissions"."name" = 'view_images' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Image' AND "permissions"."name" = 'create_images' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Image' AND "permissions"."name" = 'edit_images' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Image' AND "permissions"."name" = 'destroy_images' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Location' AND "permissions"."name" = 'view_locations' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Location' AND "permissions"."name" = 'create_locations' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Location' AND "permissions"."name" = 'edit_locations' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Location' AND "permissions"."name" = 'destroy_locations' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Location' AND "permissions"."name" = 'assign_locations' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'MailNotification' AND "permissions"."name" = 'view_mail_notifications' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Medium' AND "permissions"."name" = 'view_media' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Medium' AND "permissions"."name" = 'create_media' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Medium' AND "permissions"."name" = 'edit_media' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Medium' AND "permissions"."name" = 'destroy_media' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Model' AND "permissions"."name" = 'view_models' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Model' AND "permissions"."name" = 'create_models' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Model' AND "permissions"."name" = 'edit_models' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Model' AND "permissions"."name" = 'destroy_models' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Operatingsystem' AND "permissions"."name" = 'view_operatingsystems' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Operatingsystem' AND "permissions"."name" = 'create_operatingsystems' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Operatingsystem' AND "permissions"."name" = 'edit_operatingsystems' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Operatingsystem' AND "permissions"."name" = 'destroy_operatingsystems' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Organization' AND "permissions"."name" = 'view_organizations' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Organization' AND "permissions"."name" = 'create_organizations' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Organization' AND "permissions"."name" = 'edit_organizations' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Organization' AND "permissions"."name" = 'destroy_organizations' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Organization' AND "permissions"."name" = 'assign_organizations' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Ptable' AND "permissions"."name" = 'view_ptables' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Ptable' AND "permissions"."name" = 'create_ptables' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Ptable' AND "permissions"."name" = 'edit_ptables' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Ptable' AND "permissions"."name" = 'destroy_ptables' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" IS NULL AND "permissions"."name" = 'view_plugins' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Puppetclass' AND "permissions"."name" = 'view_puppetclasses' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Puppetclass' AND "permissions"."name" = 'create_puppetclasses' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Puppetclass' AND "permissions"."name" = 'edit_puppetclasses' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Puppetclass' AND "permissions"."name" = 'destroy_puppetclasses' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Puppetclass' AND "permissions"."name" = 'import_puppetclasses' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Realm' AND "permissions"."name" = 'view_realms' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Realm' AND "permissions"."name" = 'create_realms' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Realm' AND "permissions"."name" = 'edit_realms' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Realm' AND "permissions"."name" = 'destroy_realms' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Report' AND "permissions"."name" = 'view_reports' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Report' AND "permissions"."name" = 'destroy_reports' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Report' AND "permissions"."name" = 'upload_reports' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Role' AND "permissions"."name" = 'view_roles' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Role' AND "permissions"."name" = 'create_roles' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Role' AND "permissions"."name" = 'edit_roles' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Role' AND "permissions"."name" = 'destroy_roles' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" IS NULL AND "permissions"."name" = 'access_settings' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'SmartProxy' AND "permissions"."name" = 'view_smart_proxies' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'SmartProxy' AND "permissions"."name" = 'create_smart_proxies' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'SmartProxy' AND "permissions"."name" = 'edit_smart_proxies' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'SmartProxy' AND "permissions"."name" = 'destroy_smart_proxies' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'SmartProxy' AND "permissions"."name" = 'view_smart_proxies_autosign' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'SmartProxy' AND "permissions"."name" = 'create_smart_proxies_autosign' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'SmartProxy' AND "permissions"."name" = 'destroy_smart_proxies_autosign' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'SmartProxy' AND "permissions"."name" = 'view_smart_proxies_puppetca' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'SmartProxy' AND "permissions"."name" = 'edit_smart_proxies_puppetca' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'SmartProxy' AND "permissions"."name" = 'destroy_smart_proxies_puppetca' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" IS NULL AND "permissions"."name" = 'view_statistics' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Subnet' AND "permissions"."name" = 'view_subnets' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Subnet' AND "permissions"."name" = 'create_subnets' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Subnet' AND "permissions"."name" = 'edit_subnets' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.4ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Subnet' AND "permissions"."name" = 'destroy_subnets' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Subnet' AND "permissions"."name" = 'import_subnets' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" IS NULL AND "permissions"."name" = 'view_tasks' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Trend' AND "permissions"."name" = 'view_trends' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Trend' AND "permissions"."name" = 'create_trends' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Trend' AND "permissions"."name" = 'edit_trends' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Trend' AND "permissions"."name" = 'destroy_trends' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Trend' AND "permissions"."name" = 'update_trends' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Usergroup' AND "permissions"."name" = 'view_usergroups' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Usergroup' AND "permissions"."name" = 'create_usergroups' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Usergroup' AND "permissions"."name" = 'edit_usergroups' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'Usergroup' AND "permissions"."name" = 'destroy_usergroups' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'User' AND "permissions"."name" = 'view_users' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'User' AND "permissions"."name" = 'create_users' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'User' AND "permissions"."name" = 'edit_users' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (0.3ms)  SELECT "permissions".* FROM "permissions" WHERE "permissions"."resource_type" = 'User' AND "permissions"."name" = 'destroy_users' LIMIT 1
2015-12-14 05:44:16 [D]   Permission Load (1.2ms)  SELECT "permissions".* FROM "permissions" 
2015-12-14 05:44:16 [D]   Role Load (0.4ms)  SELECT "roles".* FROM "roles" WHERE "roles"."name" = 'Manager' LIMIT 1
2015-12-14 05:44:16 [D]   Role Load (0.3ms)  SELECT "roles".* FROM "roles" WHERE "roles"."name" = 'Edit partition tables' LIMIT 1
2015-12-14 05:44:16 [D]   Role Load (0.3ms)  SELECT "roles".* FROM "roles" WHERE "roles"."name" = 'View hosts' LIMIT 1
2015-12-14 05:44:16 [D]   Role Load (0.3ms)  SELECT "roles".* FROM "roles" WHERE "roles"."name" = 'Edit hosts' LIMIT 1
2015-12-14 05:44:16 [D]   Role Load (0.3ms)  SELECT "roles".* FROM "roles" WHERE "roles"."name" = 'Viewer' LIMIT 1
2015-12-14 05:44:16 [D]   Role Load (0.3ms)  SELECT "roles".* FROM "roles" WHERE "roles"."name" = 'Site manager' LIMIT 1
2015-12-14 05:44:16 [D]   Role Load (0.3ms)  SELECT "roles".* FROM "roles" WHERE "roles"."name" = 'Default user' LIMIT 1
2015-12-14 05:44:16 [D]   Role Load (0.3ms)  SELECT "roles".* FROM "roles" WHERE "roles"."name" = 'Anonymous' LIMIT 1
2015-12-14 05:44:16 [D]   AuthSourceInternal Load (0.4ms)  SELECT "auth_sources".* FROM "auth_sources" WHERE "auth_sources"."type" IN ('AuthSourceInternal') AND "auth_sources"."type" = 'AuthSourceInternal' LIMIT 1
2015-12-14 05:44:16 [D]   AuthSourceHidden Load (0.3ms)  SELECT "auth_sources".* FROM "auth_sources" WHERE "auth_sources"."type" IN ('AuthSourceHidden') AND "auth_sources"."type" = 'AuthSourceHidden' LIMIT 1
2015-12-14 05:44:16 [D]   User Load (0.7ms)  SELECT "users".* FROM "users" WHERE "users"."lower_login" = 'foreman_admin' LIMIT 1
2015-12-14 05:44:16 [D] Setting current user thread-local variable to Anonymous Admin
2015-12-14 05:44:16 [D]    (0.2ms)  BEGIN
2015-12-14 05:44:16 [D]   User Exists (0.9ms)  SELECT 1 AS one FROM "users" WHERE LOWER("users"."login") = LOWER('foreman_admin') LIMIT 1
2015-12-14 05:44:16 [D]   Usergroup Load (0.6ms)  SELECT "usergroups".* FROM "usergroups" ORDER BY usergroups.name