Debug output for display of alerts at 500

gistfile1.txt

[----] D, [2021-12-08T11:34:54.244292 #200559:2b2a7020595c] DEBUG -- :   MiqQueue Load (0.9ms)  SELECT "miq_queue".* FROM "miq_queue" WHERE (    state = 'ready'
    AND (zone IS NULL OR zone = 'default')
    AND (task_id IS NULL OR task_id NOT IN (
      SELECT DISTINCT task_id
      FROM miq_queue
      WHERE state = 'dequeue'
        AND (zone IS NULL OR zone = 'default')
        AND task_id IS NOT NULL
    ))
    AND (role IS NULL OR role IN ('ems_inventory'))
    AND (server_guid IS NULL OR server_guid = '61846270-c6fb-4373-a0ef-925e63093337')
    AND (deliver_on IS NULL OR deliver_on <= '2021-12-08 16:34:54.242796')
    AND (priority <= 200)
AND queue_name = 'ems_1000000000002') ORDER BY priority, id LIMIT $1  [["LIMIT", 10]]
[----] D, [2021-12-08T11:34:54.244584 #200559:2b2a7020595c] DEBUG -- :   MiqQueue Inst Including Associations (0.0ms - 0rows)
[----] I, [2021-12-08T11:34:56.033325 #200877:2b1d1da81e24]  INFO -- : Started POST "/miq_alert/report_data" for 100.66.3.5 at 2021-12-08 11:34:56 -0500
[----] I, [2021-12-08T11:34:56.036282 #200877:2b1d1da81e24]  INFO -- : Processing by MiqAlertController#report_data as */*
[----] I, [2021-12-08T11:34:56.036417 #200877:2b1d1da81e24]  INFO -- :   Parameters: {"model_name"=>"MiqAlert", "model"=>"MiqAlert", "page"=>1, "ppsetting"=>500, "is_ascending"=>true, "records[]"=>[], "records"=>[], "additional_options"=>{"named_scope"=>nil, "gtl_dbname"=>nil, "model"=>"MiqAlert", "match_via_descendants"=>nil, "parent_id"=>nil, "parent_class_name"=>nil, "filter"=>nil, "parent_method"=>nil, "association"=>nil, "view_suffix"=>nil, "row_button"=>nil, "menu_click"=>nil, "sb_controller"=>nil, "embedded"=>nil, "showlinks"=>nil, "policy_sim"=>nil, "in_a_form"=>nil, "lastaction"=>"show_list", "display"=>nil, "supported_features_filter"=>nil, "clickable"=>nil, "no_checkboxes"=>nil, "show_pagination"=>nil, "report_name"=>nil, "custom_action"=>nil}, "miq_alert"=>{}}
[----] D, [2021-12-08T11:34:56.038337 #200877:2b1d1da81e24] DEBUG -- : PostgreSQLAdapter#log_after_checkout, connection_pool: size: 8, connections: 3, in use: 2, waiting_in_queue: 0
[----] D, [2021-12-08T11:34:56.039118 #200877:2b1d1da81e24] DEBUG -- :   User Load (0.4ms)  SELECT "users".* FROM "users" WHERE "users"."id" BETWEEN $1 AND $2 AND "users"."userid" = $3 LIMIT $4  [["id", 1000000000000], ["id", 1999999999999], ["userid", "admin"], ["LIMIT", 1]]
[----] D, [2021-12-08T11:34:56.039393 #200877:2b1d1da81e24] DEBUG -- :   User Inst Including Associations (0.1ms - 1rows)
[----] D, [2021-12-08T11:34:56.040190 #200877:2b1d1da81e24] DEBUG -- :   MiqGroup Load (0.3ms)  SELECT "miq_groups".* FROM "miq_groups" WHERE "miq_groups"."id" = $1 LIMIT $2  [["id", 1000000000002], ["LIMIT", 1]]
[----] D, [2021-12-08T11:34:56.040398 #200877:2b1d1da81e24] DEBUG -- :   MiqGroup Inst Including Associations (0.1ms - 1rows)
[----] D, [2021-12-08T11:34:56.041074 #200877:2b1d1da81e24] DEBUG -- :   Tenant Load (0.3ms)  SELECT "tenants".* FROM "tenants" WHERE "tenants"."id" = $1 LIMIT $2  [["id", 1000000000001], ["LIMIT", 1]]
[----] D, [2021-12-08T11:34:56.040398 #200877:2b1d1da81e24] DEBUG -- :   MiqGroup Inst Including Associations (0.1ms - 1rows)
[----] D, [2021-12-08T11:34:56.041074 #200877:2b1d1da81e24] DEBUG -- :   Tenant Load (0.3ms)  SELECT "tenants".* FROM "tenants" WHERE "tenants"."id" = $1 LIMIT $2  [["id", 1000000000001], ["LIMIT", 1]]
[----] D, [2021-12-08T11:34:56.041305 #200877:2b1d1da81e24] DEBUG -- :   Tenant Inst Including Associations (0.1ms - 1rows)
[----] D, [2021-12-08T11:34:56.043058 #200877:2b1d1da81e24] DEBUG -- :   MiqUserRole Load (0.3ms)  SELECT "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  [["miq_group_id", 1000000000002], ["LIMIT", 1]]
[----] D, [2021-12-08T11:34:56.043251 #200877:2b1d1da81e24] DEBUG -- :   MiqUserRole Inst Including Associations (0.1ms - 1rows)
[----] D, [2021-12-08T11:34:56.044336 #200877:2b1d1da81e24] DEBUG -- :    (0.3ms)  SELECT "miq_product_features"."identifier" 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  [["miq_user_role_id", 1000000000001]]
[----] D, [2021-12-08T11:34:56.046027 #200877:2b1d1da81e24] DEBUG -- :   CACHE User Load (0.0ms)  SELECT "users".* FROM "users" WHERE "users"."id" BETWEEN $1 AND $2 AND "users"."userid" = $3 LIMIT $4  [["id", 1000000000000], ["id", 1999999999999], ["userid", "admin"], ["LIMIT", 1]]
[----] D, [2021-12-08T11:34:56.046196 #200877:2b1d1da81e24] DEBUG -- :   User Inst Including Associations (0.1ms - 1rows)
[----] D, [2021-12-08T11:34:56.046549 #200877:2b1d1da81e24] DEBUG -- :   CACHE MiqGroup Load (0.0ms)  SELECT "miq_groups".* FROM "miq_groups" WHERE "miq_groups"."id" = $1 LIMIT $2  [["id", 1000000000002], ["LIMIT", 1]]
[----] D, [2021-12-08T11:34:56.046702 #200877:2b1d1da81e24] DEBUG -- :   MiqGroup Inst Including Associations (0.1ms - 1rows)
[----] D, [2021-12-08T11:34:56.047304 #200877:2b1d1da81e24] DEBUG -- :   Entitlement Load (0.2ms)  SELECT "entitlements".* FROM "entitlements" WHERE "entitlements"."miq_group_id" = $1 LIMIT $2  [["miq_group_id", 1000000000002], ["LIMIT", 1]]
[----] D, [2021-12-08T11:34:56.047484 #200877:2b1d1da81e24] DEBUG -- :   Entitlement Inst Including Associations (0.1ms - 1rows)
[----] D, [2021-12-08T11:34:56.048713 #200877:2b1d1da81e24] DEBUG -- :    (0.4ms)  SELECT COUNT(*) FROM (SELECT DISTINCT "miq_alerts"."id" FROM "miq_alerts") subquery_for_count
[----] D, [2021-12-08T11:34:56.051304 #200877:2b1d1da81e24] DEBUG -- :   SQL (2.1ms)  SELECT "miq_alerts"."id" AS t0_r0, "miq_alerts"."guid" AS t0_r1, "miq_alerts"."description" AS t0_r2, "miq_alerts"."created_on" AS t0_r3, "miq_alerts"."updated_on" AS t0_r4, "miq_alerts"."options" AS t0_r5, "miq_alerts"."db" AS t0_r6, "miq_alerts"."miq_expression" AS t0_r7, "miq_alerts"."responds_to_events" AS t0_r8, "miq_alerts"."enabled" AS t0_r9, "miq_alerts"."read_only" AS t0_r10, "miq_alerts"."hash_expression" AS t0_r11, "miq_alerts"."severity" AS t0_r12 FROM "miq_alerts" ORDER BY LOWER("miq_alerts"."description") ASC LIMIT $1 OFFSET $2  [["LIMIT", 500], ["OFFSET", 0]]
[----] D, [2021-12-08T11:34:56.055946 #200877:2b1d1da81e24] DEBUG -- :   MiqAlert Inst Including Associations (4.0ms - 213rows)
[----] F, [2021-12-08T11:34:56.165388 #200877:2b1d1da81e24] FATAL -- : Error caught: [ArgumentError] undefined class/module VimString
/opt/IBM/infrastructure-management-gemset/gems/psych-3.3.1/lib/psych/class_loader.rb:56:in `path2class'
/opt/IBM/infrastructure-management-gemset/gems/psych-3.3.1/lib/psych/class_loader.rb:56:in `resolve'
/opt/IBM/infrastructure-management-gemset/gems/psych-3.3.1/lib/psych/class_loader.rb:48:in `find'
/opt/IBM/infrastructure-management-gemset/gems/psych-3.3.1/lib/psych/class_loader.rb:28:in `load'
/opt/IBM/infrastructure-management-gemset/gems/psych-3.3.1/lib/psych/visitors/to_ruby.rb:424:in `resolve_class'
/var/www/miq/vmdb/config/initializers/yaml_autoloader.rb:10:in `resolve_class'
/opt/IBM/infrastructure-management-gemset/gems/psych-3.3.1/lib/psych/visitors/to_ruby.rb:218:in `visit_Psych_Nodes_Mapping'
/opt/IBM/infrastructure-management-gemset/gems/psych-3.3.1/lib/psych/visitors/visitor.rb:30:in `visit'
/opt/IBM/infrastructure-management-gemset/gems/psych-3.3.1/lib/psych/visitors/visitor.rb:6:in `accept'
/opt/IBM/infrastructure-management-gemset/gems/psych-3.3.1/lib/psych/visitors/to_ruby.rb:35:in `accept'
/opt/IBM/infrastructure-management-gemset/gems/psych-3.3.1/lib/psych/visitors/to_ruby.rb:345:in `block in revive_hash'
/opt/IBM/infrastructure-management-gemset/gems/psych-3.3.1/lib/psych/visitors/to_ruby.rb:343:in `each'
/opt/IBM/infrastructure-management-gemset/gems/psych-3.3.1/lib/psych/visitors/to_ruby.rb:343:in `each_slice'
/opt/IBM/infrastructure-management-gemset/gems/psych-3.3.1/lib/psych/visitors/to_ruby.rb:343:in `revive_hash'
/opt/IBM/infrastructure-management-gemset/gems/psych-3.3.1/lib/psych/visitors/to_ruby.rb:167:in `visit_Psych_Nodes_Mapping'
/opt/IBM/infrastructure-management-gemset/gems/psych-3.3.1/lib/psych/visitors/visitor.rb:30:in `visit'
/opt/IBM/infrastructure-management-gemset/gems/psych-3.3.1/lib/psych/visitors/visitor.rb:6:in `accept'
/opt/IBM/infrastructure-management-gemset/gems/psych-3.3.1/lib/psych/visitors/to_ruby.rb:35:in `accept'
/opt/IBM/infrastructure-management-gemset/gems/psych-3.3.1/lib/psych/visitors/to_ruby.rb:345:in `block in revive_hash'
/opt/IBM/infrastructure-management-gemset/gems/psych-3.3.1/lib/psych/visitors/to_ruby.rb:343:in `each'
/opt/IBM/infrastructure-management-gemset/gems/psych-3.3.1/lib/psych/visitors/to_ruby.rb:343:in `each_slice'
/opt/IBM/infrastructure-management-gemset/gems/psych-3.3.1/lib/psych/visitors/to_ruby.rb:343:in `revive_hash'
/opt/IBM/infrastructure-management-gemset/gems/psych-3.3.1/lib/psych/visitors/to_ruby.rb:167:in `visit_Psych_Nodes_Mapping'
/opt/IBM/infrastructure-management-gemset/gems/psych-3.3.1/lib/psych/visitors/visitor.rb:30:in `visit'
/opt/IBM/infrastructure-management-gemset/gems/psych-3.3.1/lib/psych/visitors/visitor.rb:6:in `accept'
/opt/IBM/infrastructure-management-gemset/gems/psych-3.3.1/lib/psych/visitors/to_ruby.rb:35:in `accept'
/opt/IBM/infrastructure-management-gemset/gems/psych-3.3.1/lib/psych/visitors/to_ruby.rb:318:in `visit_Psych_Nodes_Document'
/opt/IBM/infrastructure-management-gemset/gems/psych-3.3.1/lib/psych/visitors/visitor.rb:30:in `visit'
/opt/IBM/infrastructure-management-gemset/gems/psych-3.3.1/lib/psych/visitors/visitor.rb:6:in `accept'
/opt/IBM/infrastructure-management-gemset/gems/psych-3.3.1/lib/psych/visitors/to_ruby.rb:35:in `accept'
/opt/IBM/infrastructure-management-gemset/gems/psych-3.3.1/lib/psych/nodes/node.rb:50:in `to_ruby'
/opt/IBM/infrastructure-management-gemset/gems/psych-3.3.1/lib/psych.rb:282:in `load'
/opt/IBM/infrastructure-management-gemset/gems/activerecord-6.0.3.6/lib/active_record/coders/yaml_column.rb:26:in `load'
/opt/IBM/infrastructure-management-gemset/gems/activerecord-6.0.3.6/lib/active_record/type/serialized.rb:22:in `deserialize'
/opt/IBM/infrastructure-management-gemset/gems/activemodel-6.0.3.6/lib/active_model/attribute.rb:164:in `type_cast'
/opt/IBM/infrastructure-management-gemset/gems/activemodel-6.0.3.6/lib/active_model/attribute.rb:42:in `value'
/opt/IBM/infrastructure-management-gemset/gems/activemodel-6.0.3.6/lib/active_model/attribute_set.rb:41:in `fetch_value'
/opt/IBM/infrastructure-management-gemset/gems/activerecord-6.0.3.6/lib/active_record/attribute_methods/read.rb:39:in `_read_attribute'
/opt/IBM/infrastructure-management-gemset/gems/activerecord-6.0.3.6/lib/active_record/attribute_methods/read.rb:17:in `hash_expression'
/var/www/miq/vmdb/app/models/miq_alert.rb:73:in `evaluation_description'
/var/www/miq/vmdb/app/models/miq_report/generator.rb:739:in `block in build_get_attributes_with_options'
/var/www/miq/vmdb/app/models/miq_report/generator.rb:735:in `each'
/var/www/miq/vmdb/app/models/miq_report/generator.rb:735:in `build_get_attributes_with_options'
/var/www/miq/vmdb/app/models/miq_report/generator.rb:723:in `build_reportable_data'
/var/www/miq/vmdb/app/models/miq_report/generator.rb:436:in `block in build_table'
/var/www/miq/vmdb/app/models/miq_report/generator.rb:435:in `collect'
/var/www/miq/vmdb/app/models/miq_report/generator.rb:435:in `build_table'
/var/www/miq/vmdb/app/models/miq_report/search.rb:127:in `paged_view_search'
/opt/IBM/infrastructure-management-gemset/bundler/gems/bluecf-ui-classic-affa6cb6766b/app/controllers/application_controller.rb:1257:in `get_view'
/opt/IBM/infrastructure-management-gemset/bundler/gems/bluecf-ui-classic-affa6cb6766b/app/controllers/application_controller.rb:363:in `report_data'
/opt/IBM/infrastructure-management-gemset/gems/actionpack-6.0.3.6/lib/action_controller/metal/basic_implicit_render.rb:6:in `send_action'
/opt/IBM/infrastructure-management-gemset/gems/actionpack-6.0.3.6/lib/abstract_controller/base.rb:195:in `process_action'
/opt/IBM/infrastructure-management-gemset/gems/actionpack-6.0.3.6/lib/action_controller/metal/rendering.rb:30:in `process_action'
/opt/IBM/infrastructure-management-gemset/gems/actionpack-6.0.3.6/lib/abstract_controller/callbacks.rb:42:in `block in process_action'
/opt/IBM/infrastructure-management-gemset/gems/activesupport-6.0.3.6/lib/active_support/callbacks.rb:135:in `run_callbacks'
/opt/IBM/infrastructure-management-gemset/gems/actionpack-6.0.3.6/lib/abstract_controller/callbacks.rb:41:in `process_action'
/opt/IBM/infrastructure-management-gemset/gems/actionpack-6.0.3.6/lib/action_controller/metal/rescue.rb:22:in `process_action'
/opt/IBM/infrastructure-management-gemset/gems/actionpack-6.0.3.6/lib/action_controller/metal/instrumentation.rb:33:in `block in process_action'
/opt/IBM/infrastructure-management-gemset/gems/activesupport-6.0.3.6/lib/active_support/notifications.rb:180:in `block in instrument'
/opt/IBM/infrastructure-management-gemset/gems/activesupport-6.0.3.6/lib/active_support/notifications/instrumenter.rb:24:in `instrument'
/opt/IBM/infrastructure-management-gemset/gems/activesupport-6.0.3.6/lib/active_support/notifications.rb:180:in `instrument'
/opt/IBM/infrastructure-management-gemset/gems/actionpack-6.0.3.6/lib/action_controller/metal/instrumentation.rb:32:in `process_action'
/opt/IBM/infrastructure-management-gemset/gems/actionpack-6.0.3.6/lib/action_controller/metal/params_wrapper.rb:245:in `process_action'
/opt/IBM/infrastructure-management-gemset/gems/activerecord-6.0.3.6/lib/active_record/railties/controller_runtime.rb:27:in `process_action'
/opt/IBM/infrastructure-management-gemset/gems/activesupport-6.0.3.6/lib/active_support/notifications.rb:180:in `block in instrument'
/opt/IBM/infrastructure-management-gemset/gems/activesupport-6.0.3.6/lib/active_support/notifications/instrumenter.rb:24:in `instrument'
/opt/IBM/infrastructure-management-gemset/gems/activesupport-6.0.3.6/lib/active_support/notifications.rb:180:in `instrument'
/opt/IBM/infrastructure-management-gemset/gems/actionpack-6.0.3.6/lib/action_controller/metal/instrumentation.rb:32:in `process_action'
/opt/IBM/infrastructure-management-gemset/gems/actionpack-6.0.3.6/lib/action_controller/metal/params_wrapper.rb:245:in `process_action'
/opt/IBM/infrastructure-management-gemset/gems/activerecord-6.0.3.6/lib/active_record/railties/controller_runtime.rb:27:in `process_action'
/opt/IBM/infrastructure-management-gemset/gems/actionpack-6.0.3.6/lib/abstract_controller/base.rb:136:in `process'
/opt/IBM/infrastructure-management-gemset/gems/actionview-6.0.3.6/lib/action_view/rendering.rb:39:in `process'
/opt/IBM/infrastructure-management-gemset/gems/actionpack-6.0.3.6/lib/action_controller/metal.rb:190:in `dispatch'
/opt/IBM/infrastructure-management-gemset/gems/actionpack-6.0.3.6/lib/action_controller/metal.rb:254:in `dispatch'
/opt/IBM/infrastructure-management-gemset/gems/actionpack-6.0.3.6/lib/action_dispatch/routing/route_set.rb:50:in `dispatch'
/opt/IBM/infrastructure-management-gemset/gems/actionpack-6.0.3.6/lib/action_dispatch/routing/route_set.rb:33:in `serve'
/opt/IBM/infrastructure-management-gemset/gems/actionpack-6.0.3.6/lib/action_dispatch/journey/router.rb:49:in `block in serve'
/opt/IBM/infrastructure-management-gemset/gems/actionpack-6.0.3.6/lib/action_dispatch/journey/router.rb:32:in `each'
/opt/IBM/infrastructure-management-gems...
[----] I, [2021-12-08T11:34:56.166512 #200877:2b1d1da81e24]  INFO -- : Completed 200 OK in 130ms (Views: 0.3ms | ActiveRecord: 4.3ms | Allocations: 65991)