Created
March 14, 2017 06:12
-
-
Save moolitayer/d6e87267a3378da460d13229a4e07f66 to your computer and use it in GitHub Desktop.
This file contains bidirectional Unicode text that may be interpreted or compiled differently than what appears below. To review, open the file in an editor that reveals hidden Unicode characters.
Learn more about bidirectional Unicode characters
[----] I, [2017-03-14T08:10:36.359525 #773:2115e84] INFO -- : Started GET "/api/alerts?expand=resources" for 127.0.0.1 at 2017-03-14 08:10:36 +0200 | |
[----] I, [2017-03-14T08:10:36.388548 #773:2115e84] INFO -- : Processing by Api::AlertsController#index as JSON | |
[----] I, [2017-03-14T08:10:36.388645 #773:2115e84] INFO -- : Parameters: {"expand"=>"resources"} | |
[----] D, [2017-03-14T08:10:36.390332 #773:2115e84] DEBUG -- : PostgreSQLAdapter#log_after_checkout, connection_pool: size: 8, connections: 3, in use: 3, waiting_in_queue: 0 | |
[----] D, [2017-03-14T08:10:36.391437 #773:2115e84] DEBUG -- : [1m[36mUser Load (0.7ms)[0m [1m[34mSELECT "users".* FROM "users" WHERE ("users"."id" BETWEEN $1 AND $2) AND "users"."userid" = $3 LIMIT $4[0m [["id", 1000000000000], ["id", 1999999999999], ["userid", "admin"], ["LIMIT", 1]] | |
[----] D, [2017-03-14T08:10:36.391800 #773:2115e84] DEBUG -- : User Inst Including Associations (0.1ms - 1rows) | |
[----] D, [2017-03-14T08:10:36.416046 #722:d27120] DEBUG -- : [1m[35m (0.2ms)[0m [1m[34mSELECT pg_backend_pid()[0m | |
[----] D, [2017-03-14T08:10:36.453767 #694:d27120] DEBUG -- : [1m[35m (0.2ms)[0m [1m[34mSELECT pg_backend_pid()[0m | |
[----] D, [2017-03-14T08:10:36.459624 #773:2115e84] DEBUG -- : [1m[35m (0.2ms)[0m [1m[35mBEGIN[0m | |
[----] D, [2017-03-14T08:10:36.461241 #773:2115e84] DEBUG -- : [1m[35mSQL (0.6ms)[0m [1m[32mINSERT INTO "audit_events" ("event", "status", "message", "severity", "userid", "source", "created_on") VALUES ($1, $2, $3, $4, $5, $6, $7) RETURNING "id"[0m [["event", "authenticate_database"], ["status", "success"], ["message", "User admin successfully validated by EVM"], ["severity", "info"], ["userid", "admin"], ["source", "Authenticator.authenticate"], ["created_on", 2017-03-14 06:10:36 UTC]] | |
[----] D, [2017-03-14T08:10:36.480425 #682:d27120] DEBUG -- : [1m[35m (0.4ms)[0m [1m[34mSELECT pg_backend_pid()[0m | |
[----] D, [2017-03-14T08:10:36.501316 #773:2115e84] DEBUG -- : [1m[35m (39.8ms)[0m [1m[35mCOMMIT[0m | |
[----] D, [2017-03-14T08:10:36.502627 #773:2115e84] DEBUG -- : [1m[36mUser Load (0.5ms)[0m [1m[34mSELECT "users".* FROM "users" WHERE ("users"."id" BETWEEN $1 AND $2) AND "users"."userid" = $3 LIMIT $4[0m [["id", 1000000000000], ["id", 1999999999999], ["userid", "admin"], ["LIMIT", 1]] | |
[----] D, [2017-03-14T08:10:36.502975 #773:2115e84] DEBUG -- : User Inst Including Associations (0.1ms - 1rows) | |
[----] D, [2017-03-14T08:10:36.503728 #773:2115e84] DEBUG -- : [1m[35m (0.2ms)[0m [1m[35mBEGIN[0m | |
[----] D, [2017-03-14T08:10:36.504991 #773:2115e84] DEBUG -- : [1m[35mSQL (0.4ms)[0m [1m[32mINSERT INTO "audit_events" ("event", "status", "message", "severity", "userid", "source", "created_on") VALUES ($1, $2, $3, $4, $5, $6, $7) RETURNING "id"[0m [["event", "authenticate_database"], ["status", "success"], ["message", "Authentication successful for user admin"], ["severity", "info"], ["userid", "admin"], ["source", "Authenticator.authenticate"], ["created_on", 2017-03-14 06:10:36 UTC]] | |
[----] D, [2017-03-14T08:10:36.509561 #773:2115e84] DEBUG -- : [1m[35m (4.3ms)[0m [1m[35mCOMMIT[0m | |
[----] D, [2017-03-14T08:10:36.510005 #773:2115e84] DEBUG -- : [1m[35m (0.2ms)[0m [1m[35mBEGIN[0m | |
[----] D, [2017-03-14T08:10:36.511668 #773:2115e84] DEBUG -- : [1m[35m (0.5ms)[0m [1m[34mSELECT COUNT(*) FROM "users" WHERE LOWER("users"."userid") = 'admin' AND ("users"."id" BETWEEN $1 AND $2) AND ("users"."id" != $3)[0m [["id", 1000000000000], ["id", 1999999999999], ["id", 1000000000001]] | |
[----] D, [2017-03-14T08:10:36.513078 #773:2115e84] DEBUG -- : [1m[36mMiqGroup Load (0.5ms)[0m [1m[34mSELECT "miq_groups".* FROM "miq_groups" WHERE "miq_groups"."id" = $1 LIMIT $2[0m [["id", 1000000000002], ["LIMIT", 1]] | |
[----] D, [2017-03-14T08:10:36.513414 #773:2115e84] DEBUG -- : MiqGroup Inst Including Associations (0.1ms - 1rows) | |
[----] D, [2017-03-14T08:10:36.515692 #773:2115e84] DEBUG -- : [1m[36mMiqGroup Exists (0.7ms)[0m [1m[34mSELECT 1 AS one FROM "miq_groups" INNER JOIN "miq_groups_users" ON "miq_groups"."id" = "miq_groups_users"."miq_group_id" WHERE "miq_groups_users"."user_id" = $1 AND "miq_groups"."id" = $2 LIMIT $3[0m [["user_id", 1000000000001], ["id", 1000000000002], ["LIMIT", 1]] | |
[----] D, [2017-03-14T08:10:36.517852 #773:2115e84] DEBUG -- : [1m[35mSQL (0.6ms)[0m [1m[33mUPDATE "users" SET "lastlogon" = $1, "updated_on" = $2 WHERE "users"."id" = $3[0m [["lastlogon", 2017-03-14 06:10:36 UTC], ["updated_on", 2017-03-14 06:10:36 UTC], ["id", 1000000000001]] | |
[----] D, [2017-03-14T08:10:36.519538 #704:d27120] DEBUG -- : [1m[35m (0.3ms)[0m [1m[34mSELECT pg_backend_pid()[0m | |
[----] D, [2017-03-14T08:10:36.526343 #773:2115e84] DEBUG -- : [1m[35m (8.0ms)[0m [1m[35mCOMMIT[0m | |
[----] D, [2017-03-14T08:10:36.527782 #773:2115e84] DEBUG -- : [1m[36mUser Load (0.6ms)[0m [1m[34mSELECT "users".* FROM "users" WHERE ("users"."id" BETWEEN $1 AND $2) AND "users"."userid" = $3 LIMIT $4[0m [["id", 1000000000000], ["id", 1999999999999], ["userid", "admin"], ["LIMIT", 1]] | |
[----] D, [2017-03-14T08:10:36.528140 #773:2115e84] DEBUG -- : User Inst Including Associations (0.1ms - 1rows) | |
[----] D, [2017-03-14T08:10:36.529365 #773:2115e84] DEBUG -- : [1m[36mMiqGroup Load (0.4ms)[0m [1m[34mSELECT "miq_groups".* FROM "miq_groups" WHERE "miq_groups"."id" = $1 LIMIT $2[0m [["id", 1000000000002], ["LIMIT", 1]] | |
[----] D, [2017-03-14T08:10:36.529641 #773:2115e84] DEBUG -- : MiqGroup Inst Including Associations (0.1ms - 1rows) | |
[----] D, [2017-03-14T08:10:36.530957 #773:2115e84] DEBUG -- : [1m[36mMiqUserRole Load (0.3ms)[0m [1m[34mSELECT "miq_user_roles".* FROM "miq_user_roles" INNER JOIN "entitlements" ON "miq_user_roles"."id" = "entitlements"."miq_user_role_id" WHERE "entitlements"."miq_group_id" = $1 LIMIT $2[0m [["miq_group_id", 1000000000002], ["LIMIT", 1]] | |
[----] D, [2017-03-14T08:10:36.531194 #773:2115e84] DEBUG -- : MiqUserRole Inst Including Associations (0.1ms - 1rows) | |
[----] D, [2017-03-14T08:10:36.532558 #773:2115e84] DEBUG -- : [1m[36mTenant Load (0.3ms)[0m [1m[34mSELECT "tenants".* FROM "tenants" WHERE "tenants"."id" = $1 LIMIT $2[0m [["id", 1000000000001], ["LIMIT", 1]] | |
[----] D, [2017-03-14T08:10:36.532863 #773:2115e84] DEBUG -- : Tenant Inst Including Associations (0.1ms - 1rows) | |
[----] D, [2017-03-14T08:10:36.533966 #773:2115e84] DEBUG -- : Unpermitted parameter: expand | |
[----] D, [2017-03-14T08:10:36.537046 #773:2115e84] DEBUG -- : [1m[36mMiqProductFeature Load (0.9ms)[0m [1m[34mSELECT "miq_product_features".* FROM "miq_product_features" INNER JOIN "miq_roles_features" ON "miq_product_features"."id" = "miq_roles_features"."miq_product_feature_id" WHERE "miq_roles_features"."miq_user_role_id" = $1[0m [["miq_user_role_id", 1000000000001]] | |
[----] D, [2017-03-14T08:10:36.537317 #773:2115e84] DEBUG -- : MiqProductFeature Inst Including Associations (0.1ms - 1rows) | |
[----] D, [2017-03-14T08:10:36.539363 #773:2115e84] DEBUG -- : [1m[36mEntitlement Load (0.3ms)[0m [1m[34mSELECT "entitlements".* FROM "entitlements" WHERE "entitlements"."miq_group_id" = $1 LIMIT $2[0m [["miq_group_id", 1000000000002], ["LIMIT", 1]] | |
[----] D, [2017-03-14T08:10:36.539566 #773:2115e84] DEBUG -- : Entitlement Inst Including Associations (0.1ms - 1rows) | |
[----] D, [2017-03-14T08:10:36.540770 #773:2115e84] DEBUG -- : [1m[35m (0.5ms)[0m [1m[34mSELECT COUNT(*) FROM "miq_alert_statuses"[0m | |
[----] D, [2017-03-14T08:10:36.541436 #773:2115e84] DEBUG -- : [1m[36mMiqAlertStatus Load (0.4ms)[0m [1m[34mSELECT "miq_alert_statuses".* FROM "miq_alert_statuses"[0m | |
[----] D, [2017-03-14T08:10:36.541693 #773:2115e84] DEBUG -- : MiqAlertStatus Inst Including Associations (0.1ms - 3rows) | |
[----] I, [2017-03-14T08:10:36.544567 #773:2115e84] INFO -- : Completed 200 OK in 156ms (Views: 0.1ms | ActiveRecord: 61.0ms) | |
[----] D, [2017-03-14T08:10:36.545192 #773:2115e84] DEBUG -- : PostgreSQLAdapter#log_after_checkin, connection_pool: size: 8, connections: 3, in use: 2, waiting_in_queue: 0 | |
[----] I, [2017-03-14T08:10:36.558868 #773:2108040] INFO -- : Started GET "/api/alerts?expand=resources,alert_actions" for 127.0.0.1 at 2017-03-14 08:10:36 +0200 | |
[----] I, [2017-03-14T08:10:36.589514 #773:2108040] INFO -- : Processing by Api::AlertsController#index as JSON | |
[----] I, [2017-03-14T08:10:36.589627 #773:2108040] INFO -- : Parameters: {"expand"=>"resources,alert_actions"} | |
[----] D, [2017-03-14T08:10:36.591156 #773:2108040] DEBUG -- : PostgreSQLAdapter#log_after_checkout, connection_pool: size: 8, connections: 3, in use: 3, waiting_in_queue: 0 | |
[----] D, [2017-03-14T08:10:36.592075 #773:2108040] DEBUG -- : [1m[36mUser Load (0.4ms)[0m [1m[34mSELECT "users".* FROM "users" WHERE ("users"."id" BETWEEN $1 AND $2) AND "users"."userid" = $3 LIMIT $4[0m [["id", 1000000000000], ["id", 1999999999999], ["userid", "admin"], ["LIMIT", 1]] | |
[----] D, [2017-03-14T08:10:36.592499 #773:2108040] DEBUG -- : User Inst Including Associations (0.1ms - 1rows) | |
[----] D, [2017-03-14T08:10:36.659199 #773:2108040] DEBUG -- : [1m[35m (0.3ms)[0m [1m[35mBEGIN[0m | |
[----] D, [2017-03-14T08:10:36.660778 #773:2108040] DEBUG -- : [1m[35mSQL (0.5ms)[0m [1m[32mINSERT INTO "audit_events" ("event", "status", "message", "severity", "userid", "source", "created_on") VALUES ($1, $2, $3, $4, $5, $6, $7) RETURNING "id"[0m [["event", "authenticate_database"], ["status", "success"], ["message", "User admin successfully validated by EVM"], ["severity", "info"], ["userid", "admin"], ["source", "Authenticator.authenticate"], ["created_on", 2017-03-14 06:10:36 UTC]] | |
[----] D, [2017-03-14T08:10:36.667963 #773:2108040] DEBUG -- : [1m[35m (7.0ms)[0m [1m[35mCOMMIT[0m | |
[----] D, [2017-03-14T08:10:36.669136 #773:2108040] DEBUG -- : [1m[36mUser Load (0.4ms)[0m [1m[34mSELECT "users".* FROM "users" WHERE ("users"."id" BETWEEN $1 AND $2) AND "users"."userid" = $3 LIMIT $4[0m [["id", 1000000000000], ["id", 1999999999999], ["userid", "admin"], ["LIMIT", 1]] | |
[----] D, [2017-03-14T08:10:36.669468 #773:2108040] DEBUG -- : User Inst Including Associations (0.1ms - 1rows) | |
[----] D, [2017-03-14T08:10:36.670143 #773:2108040] DEBUG -- : [1m[35m (0.2ms)[0m [1m[35mBEGIN[0m | |
[----] D, [2017-03-14T08:10:36.671298 #773:2108040] DEBUG -- : [1m[35mSQL (0.3ms)[0m [1m[32mINSERT INTO "audit_events" ("event", "status", "message", "severity", "userid", "source", "created_on") VALUES ($1, $2, $3, $4, $5, $6, $7) RETURNING "id"[0m [["event", "authenticate_database"], ["status", "success"], ["message", "Authentication successful for user admin"], ["severity", "info"], ["userid", "admin"], ["source", "Authenticator.authenticate"], ["created_on", 2017-03-14 06:10:36 UTC]] | |
[----] D, [2017-03-14T08:10:36.676240 #773:2108040] DEBUG -- : [1m[35m (4.8ms)[0m [1m[35mCOMMIT[0m | |
[----] D, [2017-03-14T08:10:36.676641 #773:2108040] DEBUG -- : [1m[35m (0.2ms)[0m [1m[35mBEGIN[0m | |
[----] D, [2017-03-14T08:10:36.678163 #773:2108040] DEBUG -- : [1m[35m (0.3ms)[0m [1m[34mSELECT COUNT(*) FROM "users" WHERE LOWER("users"."userid") = 'admin' AND ("users"."id" BETWEEN $1 AND $2) AND ("users"."id" != $3)[0m [["id", 1000000000000], ["id", 1999999999999], ["id", 1000000000001]] | |
[----] D, [2017-03-14T08:10:36.679318 #773:2108040] DEBUG -- : [1m[36mMiqGroup Load (0.3ms)[0m [1m[34mSELECT "miq_groups".* FROM "miq_groups" WHERE "miq_groups"."id" = $1 LIMIT $2[0m [["id", 1000000000002], ["LIMIT", 1]] | |
[----] D, [2017-03-14T08:10:36.679565 #773:2108040] DEBUG -- : MiqGroup Inst Including Associations (0.1ms - 1rows) | |
[----] D, [2017-03-14T08:10:36.681427 #773:2108040] DEBUG -- : [1m[36mMiqGroup Exists (0.3ms)[0m [1m[34mSELECT 1 AS one FROM "miq_groups" INNER JOIN "miq_groups_users" ON "miq_groups"."id" = "miq_groups_users"."miq_group_id" WHERE "miq_groups_users"."user_id" = $1 AND "miq_groups"."id" = $2 LIMIT $3[0m [["user_id", 1000000000001], ["id", 1000000000002], ["LIMIT", 1]] | |
[----] D, [2017-03-14T08:10:36.683209 #773:2108040] DEBUG -- : [1m[35mSQL (0.3ms)[0m [1m[33mUPDATE "users" SET "lastlogon" = $1, "updated_on" = $2 WHERE "users"."id" = $3[0m [["lastlogon", 2017-03-14 06:10:36 UTC], ["updated_on", 2017-03-14 06:10:36 UTC], ["id", 1000000000001]] | |
[----] D, [2017-03-14T08:10:36.692902 #773:2108040] DEBUG -- : [1m[35m (9.3ms)[0m [1m[35mCOMMIT[0m | |
[----] D, [2017-03-14T08:10:36.693868 #773:2108040] DEBUG -- : [1m[36mUser Load (0.3ms)[0m [1m[34mSELECT "users".* FROM "users" WHERE ("users"."id" BETWEEN $1 AND $2) AND "users"."userid" = $3 LIMIT $4[0m [["id", 1000000000000], ["id", 1999999999999], ["userid", "admin"], ["LIMIT", 1]] | |
[----] D, [2017-03-14T08:10:36.694207 #773:2108040] DEBUG -- : User Inst Including Associations (0.1ms - 1rows) | |
[----] D, [2017-03-14T08:10:36.695227 #773:2108040] DEBUG -- : [1m[36mMiqGroup Load (0.2ms)[0m [1m[34mSELECT "miq_groups".* FROM "miq_groups" WHERE "miq_groups"."id" = $1 LIMIT $2[0m [["id", 1000000000002], ["LIMIT", 1]] | |
[----] D, [2017-03-14T08:10:36.695441 #773:2108040] DEBUG -- : MiqGroup Inst Including Associations (0.1ms - 1rows) | |
[----] D, [2017-03-14T08:10:36.696520 #773:2108040] DEBUG -- : [1m[36mMiqUserRole Load (0.2ms)[0m [1m[34mSELECT "miq_user_roles".* FROM "miq_user_roles" INNER JOIN "entitlements" ON "miq_user_roles"."id" = "entitlements"."miq_user_role_id" WHERE "entitlements"."miq_group_id" = $1 LIMIT $2[0m [["miq_group_id", 1000000000002], ["LIMIT", 1]] | |
[----] D, [2017-03-14T08:10:36.696726 #773:2108040] DEBUG -- : MiqUserRole Inst Including Associations (0.1ms - 1rows) | |
[----] D, [2017-03-14T08:10:36.697894 #773:2108040] DEBUG -- : [1m[36mTenant Load (0.2ms)[0m [1m[34mSELECT "tenants".* FROM "tenants" WHERE "tenants"."id" = $1 LIMIT $2[0m [["id", 1000000000001], ["LIMIT", 1]] | |
[----] D, [2017-03-14T08:10:36.698211 #773:2108040] DEBUG -- : Tenant Inst Including Associations (0.1ms - 1rows) | |
[----] D, [2017-03-14T08:10:36.699193 #773:2108040] DEBUG -- : Unpermitted parameter: expand | |
[----] D, [2017-03-14T08:10:36.701582 #773:2108040] DEBUG -- : [1m[36mMiqProductFeature Load (0.4ms)[0m [1m[34mSELECT "miq_product_features".* FROM "miq_product_features" INNER JOIN "miq_roles_features" ON "miq_product_features"."id" = "miq_roles_features"."miq_product_feature_id" WHERE "miq_roles_features"."miq_user_role_id" = $1[0m [["miq_user_role_id", 1000000000001]] | |
[----] D, [2017-03-14T08:10:36.701826 #773:2108040] DEBUG -- : MiqProductFeature Inst Including Associations (0.1ms - 1rows) | |
[----] D, [2017-03-14T08:10:36.703551 #773:2108040] DEBUG -- : [1m[36mEntitlement Load (0.2ms)[0m [1m[34mSELECT "entitlements".* FROM "entitlements" WHERE "entitlements"."miq_group_id" = $1 LIMIT $2[0m [["miq_group_id", 1000000000002], ["LIMIT", 1]] | |
[----] D, [2017-03-14T08:10:36.703824 #773:2108040] DEBUG -- : Entitlement Inst Including Associations (0.1ms - 1rows) | |
[----] D, [2017-03-14T08:10:36.704849 #773:2108040] DEBUG -- : [1m[35m (0.3ms)[0m [1m[34mSELECT COUNT(*) FROM "miq_alert_statuses"[0m | |
[----] D, [2017-03-14T08:10:36.705291 #773:2108040] DEBUG -- : [1m[36mMiqAlertStatus Load (0.2ms)[0m [1m[34mSELECT "miq_alert_statuses".* FROM "miq_alert_statuses"[0m | |
[----] D, [2017-03-14T08:10:36.705581 #773:2108040] DEBUG -- : MiqAlertStatus Inst Including Associations (0.1ms - 3rows) | |
[----] D, [2017-03-14T08:10:36.707878 #773:2108040] DEBUG -- : [1m[36mMiqAlertStatusAction Load (0.3ms)[0m [1m[34mSELECT "miq_alert_status_actions".* FROM "miq_alert_status_actions" WHERE "miq_alert_status_actions"."miq_alert_status_id" = $1 ORDER BY created_at[0m [["miq_alert_status_id", 1000000000100]] | |
[----] D, [2017-03-14T08:10:36.708034 #773:2108040] DEBUG -- : MiqAlertStatusAction Inst Including Associations (0.0ms - 0rows) | |
[----] D, [2017-03-14T08:10:36.710182 #773:2108040] DEBUG -- : [1m[36mMiqAlertStatusAction Load (0.3ms)[0m [1m[34mSELECT "miq_alert_status_actions".* FROM "miq_alert_status_actions" WHERE "miq_alert_status_actions"."miq_alert_status_id" = $1 ORDER BY created_at[0m [["miq_alert_status_id", 1000000000102]] | |
[----] D, [2017-03-14T08:10:36.710454 #773:2108040] DEBUG -- : MiqAlertStatusAction Inst Including Associations (0.1ms - 1rows) | |
[----] D, [2017-03-14T08:10:36.713006 #773:2108040] DEBUG -- : [1m[36mMiqAlertStatusAction Load (0.3ms)[0m [1m[34mSELECT "miq_alert_status_actions".* FROM "miq_alert_status_actions" WHERE "miq_alert_status_actions"."miq_alert_status_id" = $1 ORDER BY created_at[0m [["miq_alert_status_id", 1000000000101]] | |
[----] D, [2017-03-14T08:10:36.713279 #773:2108040] DEBUG -- : MiqAlertStatusAction Inst Including Associations (0.1ms - 2rows) | |
[----] I, [2017-03-14T08:10:36.715418 #773:2108040] INFO -- : Completed 200 OK in 126ms (Views: 0.1ms | ActiveRecord: 27.5ms) | |
[----] D, [2017-03-14T08:10:36.716007 #773:2108040] DEBUG -- : PostgreSQLAdapter#log_after_checkin, connection_pool: size: 8, connections: 3, in use: 2, waiting_in_queue: 0 | |
[----] I, [2017-03-14T08:10:36.735782 #773:210af0c] INFO -- : Started GET "/api/alerts?attributes=resource&expand=resources" for 127.0.0.1 at 2017-03-14 08:10:36 +0200 | |
[----] I, [2017-03-14T08:10:36.762834 #773:210af0c] INFO -- : Processing by Api::AlertsController#index as JSON | |
[----] I, [2017-03-14T08:10:36.762924 #773:210af0c] INFO -- : Parameters: {"attributes"=>"resource", "expand"=>"resources"} | |
[----] D, [2017-03-14T08:10:36.764267 #773:210af0c] DEBUG -- : PostgreSQLAdapter#log_after_checkout, connection_pool: size: 8, connections: 3, in use: 3, waiting_in_queue: 0 | |
[----] D, [2017-03-14T08:10:36.765024 #773:210af0c] DEBUG -- : [1m[36mUser Load (0.4ms)[0m [1m[34mSELECT "users".* FROM "users" WHERE ("users"."id" BETWEEN $1 AND $2) AND "users"."userid" = $3 LIMIT $4[0m [["id", 1000000000000], ["id", 1999999999999], ["userid", "admin"], ["LIMIT", 1]] | |
[----] D, [2017-03-14T08:10:36.765349 #773:210af0c] DEBUG -- : User Inst Including Associations (0.1ms - 1rows) | |
[----] D, [2017-03-14T08:10:36.825002 #773:210af0c] DEBUG -- : [1m[35m (0.2ms)[0m [1m[35mBEGIN[0m | |
[----] D, [2017-03-14T08:10:36.826532 #773:210af0c] DEBUG -- : [1m[35mSQL (0.5ms)[0m [1m[32mINSERT INTO "audit_events" ("event", "status", "message", "severity", "userid", "source", "created_on") VALUES ($1, $2, $3, $4, $5, $6, $7) RETURNING "id"[0m [["event", "authenticate_database"], ["status", "success"], ["message", "User admin successfully validated by EVM"], ["severity", "info"], ["userid", "admin"], ["source", "Authenticator.authenticate"], ["created_on", 2017-03-14 06:10:36 UTC]] | |
[----] D, [2017-03-14T08:10:36.834770 #773:210af0c] DEBUG -- : [1m[35m (7.9ms)[0m [1m[35mCOMMIT[0m | |
[----] D, [2017-03-14T08:10:36.836261 #773:210af0c] DEBUG -- : [1m[36mUser Load (0.5ms)[0m [1m[34mSELECT "users".* FROM "users" WHERE ("users"."id" BETWEEN $1 AND $2) AND "users"."userid" = $3 LIMIT $4[0m [["id", 1000000000000], ["id", 1999999999999], ["userid", "admin"], ["LIMIT", 1]] | |
[----] D, [2017-03-14T08:10:36.836605 #773:210af0c] DEBUG -- : User Inst Including Associations (0.1ms - 1rows) | |
[----] D, [2017-03-14T08:10:36.837371 #773:210af0c] DEBUG -- : [1m[35m (0.2ms)[0m [1m[35mBEGIN[0m | |
[----] D, [2017-03-14T08:10:36.838554 #773:210af0c] DEBUG -- : [1m[35mSQL (0.4ms)[0m [1m[32mINSERT INTO "audit_events" ("event", "status", "message", "severity", "userid", "source", "created_on") VALUES ($1, $2, $3, $4, $5, $6, $7) RETURNING "id"[0m [["event", "authenticate_database"], ["status", "success"], ["message", "Authentication successful for user admin"], ["severity", "info"], ["userid", "admin"], ["source", "Authenticator.authenticate"], ["created_on", 2017-03-14 06:10:36 UTC]] | |
[----] D, [2017-03-14T08:10:36.842963 #773:210af0c] DEBUG -- : [1m[35m (4.2ms)[0m [1m[35mCOMMIT[0m | |
[----] D, [2017-03-14T08:10:36.843371 #773:210af0c] DEBUG -- : [1m[35m (0.1ms)[0m [1m[35mBEGIN[0m | |
[----] D, [2017-03-14T08:10:36.845134 #773:210af0c] DEBUG -- : [1m[35m (0.4ms)[0m [1m[34mSELECT COUNT(*) FROM "users" WHERE LOWER("users"."userid") = 'admin' AND ("users"."id" BETWEEN $1 AND $2) AND ("users"."id" != $3)[0m [["id", 1000000000000], ["id", 1999999999999], ["id", 1000000000001]] | |
[----] D, [2017-03-14T08:10:36.846401 #773:210af0c] DEBUG -- : [1m[36mMiqGroup Load (0.3ms)[0m [1m[34mSELECT "miq_groups".* FROM "miq_groups" WHERE "miq_groups"."id" = $1 LIMIT $2[0m [["id", 1000000000002], ["LIMIT", 1]] | |
[----] D, [2017-03-14T08:10:36.846719 #773:210af0c] DEBUG -- : MiqGroup Inst Including Associations (0.1ms - 1rows) | |
[----] D, [2017-03-14T08:10:36.848763 #773:210af0c] DEBUG -- : [1m[36mMiqGroup Exists (0.4ms)[0m [1m[34mSELECT 1 AS one FROM "miq_groups" INNER JOIN "miq_groups_users" ON "miq_groups"."id" = "miq_groups_users"."miq_group_id" WHERE "miq_groups_users"."user_id" = $1 AND "miq_groups"."id" = $2 LIMIT $3[0m [["user_id", 1000000000001], ["id", 1000000000002], ["LIMIT", 1]] | |
[----] D, [2017-03-14T08:10:36.850697 #773:210af0c] DEBUG -- : [1m[35mSQL (0.3ms)[0m [1m[33mUPDATE "users" SET "lastlogon" = $1, "updated_on" = $2 WHERE "users"."id" = $3[0m [["lastlogon", 2017-03-14 06:10:36 UTC], ["updated_on", 2017-03-14 06:10:36 UTC], ["id", 1000000000001]] | |
[----] D, [2017-03-14T08:10:36.859592 #773:210af0c] DEBUG -- : [1m[35m (8.4ms)[0m [1m[35mCOMMIT[0m | |
[----] D, [2017-03-14T08:10:36.860637 #773:210af0c] DEBUG -- : [1m[36mUser Load (0.4ms)[0m [1m[34mSELECT "users".* FROM "users" WHERE ("users"."id" BETWEEN $1 AND $2) AND "users"."userid" = $3 LIMIT $4[0m [["id", 1000000000000], ["id", 1999999999999], ["userid", "admin"], ["LIMIT", 1]] | |
[----] D, [2017-03-14T08:10:36.860971 #773:210af0c] DEBUG -- : User Inst Including Associations (0.1ms - 1rows) | |
[----] D, [2017-03-14T08:10:36.862027 #773:210af0c] DEBUG -- : [1m[36mMiqGroup Load (0.2ms)[0m [1m[34mSELECT "miq_groups".* FROM "miq_groups" WHERE "miq_groups"."id" = $1 LIMIT $2[0m [["id", 1000000000002], ["LIMIT", 1]] | |
[----] D, [2017-03-14T08:10:36.862296 #773:210af0c] DEBUG -- : MiqGroup Inst Including Associations (0.1ms - 1rows) | |
[----] D, [2017-03-14T08:10:36.863456 #773:210af0c] DEBUG -- : [1m[36mMiqUserRole Load (0.2ms)[0m [1m[34mSELECT "miq_user_roles".* FROM "miq_user_roles" INNER JOIN "entitlements" ON "miq_user_roles"."id" = "entitlements"."miq_user_role_id" WHERE "entitlements"."miq_group_id" = $1 LIMIT $2[0m [["miq_group_id", 1000000000002], ["LIMIT", 1]] | |
[----] D, [2017-03-14T08:10:36.863675 #773:210af0c] DEBUG -- : MiqUserRole Inst Including Associations (0.1ms - 1rows) | |
[----] D, [2017-03-14T08:10:36.864902 #773:210af0c] DEBUG -- : [1m[36mTenant Load (0.2ms)[0m [1m[34mSELECT "tenants".* FROM "tenants" WHERE "tenants"."id" = $1 LIMIT $2[0m [["id", 1000000000001], ["LIMIT", 1]] | |
[----] D, [2017-03-14T08:10:36.865251 #773:210af0c] DEBUG -- : Tenant Inst Including Associations (0.1ms - 1rows) | |
[----] D, [2017-03-14T08:10:36.866326 #773:210af0c] DEBUG -- : Unpermitted parameters: attributes, expand | |
[----] D, [2017-03-14T08:10:36.868974 #773:210af0c] DEBUG -- : [1m[36mMiqProductFeature Load (0.5ms)[0m [1m[34mSELECT "miq_product_features".* FROM "miq_product_features" INNER JOIN "miq_roles_features" ON "miq_product_features"."id" = "miq_roles_features"."miq_product_feature_id" WHERE "miq_roles_features"."miq_user_role_id" = $1[0m [["miq_user_role_id", 1000000000001]] | |
[----] D, [2017-03-14T08:10:36.869283 #773:210af0c] DEBUG -- : MiqProductFeature Inst Including Associations (0.1ms - 1rows) | |
[----] D, [2017-03-14T08:10:36.871161 #773:210af0c] DEBUG -- : [1m[36mEntitlement Load (0.2ms)[0m [1m[34mSELECT "entitlements".* FROM "entitlements" WHERE "entitlements"."miq_group_id" = $1 LIMIT $2[0m [["miq_group_id", 1000000000002], ["LIMIT", 1]] | |
[----] D, [2017-03-14T08:10:36.871384 #773:210af0c] DEBUG -- : Entitlement Inst Including Associations (0.1ms - 1rows) | |
[----] D, [2017-03-14T08:10:36.872375 #773:210af0c] DEBUG -- : [1m[35m (0.3ms)[0m [1m[34mSELECT COUNT(*) FROM "miq_alert_statuses"[0m | |
[----] D, [2017-03-14T08:10:36.872895 #773:210af0c] DEBUG -- : [1m[36mMiqAlertStatus Load (0.3ms)[0m [1m[34mSELECT "miq_alert_statuses".* FROM "miq_alert_statuses"[0m | |
[----] D, [2017-03-14T08:10:36.873184 #773:210af0c] DEBUG -- : MiqAlertStatus Inst Including Associations (0.1ms - 3rows) | |
[----] D, [2017-03-14T08:10:36.875184 #773:210af0c] DEBUG -- : [1m[36mContainerNode Load (0.3ms)[0m [1m[34mSELECT "container_nodes".* FROM "container_nodes" WHERE "container_nodes"."id" = $1 LIMIT $2[0m [["id", 1000000000001], ["LIMIT", 1]] | |
[----] D, [2017-03-14T08:10:36.875529 #773:210af0c] DEBUG -- : ContainerNode Inst Including Associations (0.1ms - 1rows) | |
[----] D, [2017-03-14T08:10:36.877645 #773:210af0c] DEBUG -- : [1m[36mCACHE (0.0ms)[0m [1m[34mSELECT "container_nodes".* FROM "container_nodes" WHERE "container_nodes"."id" = $1 LIMIT $2[0m [["id", 1000000000001], ["LIMIT", 1]] | |
[----] D, [2017-03-14T08:10:36.877799 #773:210af0c] DEBUG -- : ContainerNode Inst Including Associations (0.1ms - 1rows) | |
[----] D, [2017-03-14T08:10:36.879719 #773:210af0c] DEBUG -- : [1m[36mCACHE (0.0ms)[0m [1m[34mSELECT "container_nodes".* FROM "container_nodes" WHERE "container_nodes"."id" = $1 LIMIT $2[0m [["id", 1000000000001], ["LIMIT", 1]] | |
[----] D, [2017-03-14T08:10:36.879863 #773:210af0c] DEBUG -- : ContainerNode Inst Including Associations (0.1ms - 1rows) | |
[----] I, [2017-03-14T08:10:36.882050 #773:210af0c] INFO -- : Completed 200 OK in 119ms (Views: 0.1ms | ActiveRecord: 27.0ms) | |
[----] D, [2017-03-14T08:10:36.882651 #773:210af0c] DEBUG -- : PostgreSQLAdapter#log_after_checkin, connection_pool: size: 8, connections: 3, in use: 2, waiting_in_queue: 0 |
Sign up for free
to join this conversation on GitHub.
Already have an account?
Sign in to comment