Skip to content

Instantly share code, notes, and snippets.

@Stromweld

Stromweld/automation.log

Created January 19, 2018 21:37
Show Gist options
  • Save Stromweld/d59742714eda7e732378e262217dd412 to your computer and use it in GitHub Desktop.
Save Stromweld/d59742714eda7e732378e262217dd412 to your computer and use it in GitHub Desktop.
Download ZIP
vm_reconfigure_request error checking quota's
Raw
automation.log
[----] I, [2018-01-19T14:17:33.934248 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) MiqAeEvent.build_evm_event >> event=<"request_starting"> inputs=<{"EventStream::event_stream"=>2795799, :event_stream_id=>2795799}>
[----] I, [2018-01-19T14:17:33.942817 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) User [test.test] with current group ID [32] name [APP_ManageIQ-EcommSoftware-VMAdmin]
[----] I, [2018-01-19T14:17:33.955458 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) Instantiating [/System/Process/Event?EventStream%3A%3Aevent_stream=2795799&MiqRequest%3A%3Amiq_request=349&MiqServer%3A%3Amiq_server=1&User%3A%3Auser=25&VmReconfigureRequest%3A%3Avm_reconfigure_request=349&event_stream_id=2795799&event_type=request_starting&object_name=Event&vmdb_object_type=vm_reconfigure_request]
[----] I, [2018-01-19T14:17:34.036101 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) Updated namespace [/System/Process/Event?EventStream%3A%3Aevent_stream=2795799&MiqRequest%3A%3Amiq_request=349&MiqServer%3A%3Amiq_server=1&User%3A%3Auser=25&VmReconfigureRequest%3A%3Avm_reconfigure_request=349&event_stream_id=2795799&event_type=request_starting&object_name=Event&vmdb_object_type=vm_reconfigure_request ManageIQ/System]
[----] I, [2018-01-19T14:17:34.277649 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) Following Relationship [miqaedb:/System/Event/RequestEvent/Request/request_starting#create]
[----] I, [2018-01-19T14:17:34.315499 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) Updated namespace [miqaedb:/System/Event/RequestEvent/Request/request_starting#create ManageIQ/System/Event/RequestEvent]
[----] I, [2018-01-19T14:17:34.342856 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) Following Relationship [miqaedb:/System/Policy/request_starting#create]
[----] I, [2018-01-19T14:17:34.359410 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) Updated namespace [miqaedb:/System/Policy/request_starting#create ManageIQ/System]
[----] I, [2018-01-19T14:17:34.387843 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) Updated namespace [System/Policy/get_request_type ManageIQ/System]
[----] I, [2018-01-19T14:17:34.398540 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) Invoking [inline] method [/ManageIQ/System/Policy/get_request_type] with inputs [{}]
[----] I, [2018-01-19T14:17:34.403270 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) <AEMethod [/ManageIQ/System/Policy/get_request_type]> Starting
[----] I, [2018-01-19T14:17:35.000257 #128421:bf5e78] INFO -- : Q-task_id([vm_reconfigure_request_349]) <AEMethod get_request_type> Request Type:<VmReconfigureRequest>
[----] I, [2018-01-19T14:17:35.019656 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) <AEMethod [/ManageIQ/System/Policy/get_request_type]> Ending
[----] I, [2018-01-19T14:17:35.019789 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) Method exited with rc=MIQ_OK
[----] I, [2018-01-19T14:17:35.020774 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) Following Relationship [miqaedb:/System/Process/parse_provider_category#create]
[----] I, [2018-01-19T14:17:35.045780 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) Updated namespace [miqaedb:/System/Process/parse_provider_category#create ManageIQ/System]
[----] I, [2018-01-19T14:17:35.079803 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) Updated namespace [System/Process/parse_provider_category ManageIQ/System]
[----] I, [2018-01-19T14:17:35.087204 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) Invoking [builtin] method [/ManageIQ/System/Process/parse_provider_category] with inputs [{}]
[----] I, [2018-01-19T14:17:35.088336 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) Setting provider_category to:
[----] I, [2018-01-19T14:17:35.089228 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) Followed Relationship [miqaedb:/System/Process/parse_provider_category#create]
[----] I, [2018-01-19T14:17:35.089513 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) Following Relationship [miqaedb:/System/Policy/VmReconfigureRequest_starting#create]
[----] I, [2018-01-19T14:17:35.107235 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) Updated namespace [miqaedb:/System/Policy/VmReconfigureRequest_starting#create ManageIQ/System]
[----] I, [2018-01-19T14:17:35.115902 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) Following Relationship [miqaedb:/System/CommonMethods/QuotaStatemachine/quota#create]
[----] I, [2018-01-19T14:17:35.143769 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) Updated namespace [miqaedb:/System/CommonMethods/QuotaStatemachine/quota#create ManageIQ/System/CommonMethods]
[----] I, [2018-01-19T14:17:35.171588 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) Processing State=[quota_source]
[----] I, [2018-01-19T14:17:35.171808 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) Following Relationship [miqaedb:/System/CommonMethods/QuotaMethods/quota_source#create]
[----] I, [2018-01-19T14:17:35.188447 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) Updated namespace [miqaedb:/System/CommonMethods/QuotaMethods/quota_source#create ManageIQ/System/CommonMethods]
[----] I, [2018-01-19T14:17:35.208380 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) Updated namespace [System/CommonMethods/QuotaMethods/quota_source ManageIQ/System/CommonMethods]
[----] I, [2018-01-19T14:17:35.216122 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) Invoking [inline] method [/ManageIQ/System/CommonMethods/QuotaMethods/quota_source] with inputs [{}]
[----] I, [2018-01-19T14:17:35.216929 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) <AEMethod [/ManageIQ/System/CommonMethods/QuotaMethods/quota_source]> Starting
[----] I, [2018-01-19T14:17:35.743534 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) <AEMethod [/ManageIQ/System/CommonMethods/QuotaMethods/quota_source]> Ending
[----] I, [2018-01-19T14:17:35.743705 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) Method exited with rc=MIQ_OK
[----] I, [2018-01-19T14:17:35.744148 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) Followed Relationship [miqaedb:/System/CommonMethods/QuotaMethods/quota_source#create]
[----] I, [2018-01-19T14:17:35.744288 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) Processed State=[quota_source] with Result=[ok]
[----] I, [2018-01-19T14:17:35.744374 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) Processed State =[quota_source]
[----] I, [2018-01-19T14:17:35.744691 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) Next State=[limits]
[----] I, [2018-01-19T14:17:35.744954 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) Processing State=[limits]
[----] I, [2018-01-19T14:17:35.745127 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) Following Relationship [miqaedb:/System/CommonMethods/QuotaMethods/limits#create]
[----] I, [2018-01-19T14:17:35.764169 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) Updated namespace [miqaedb:/System/CommonMethods/QuotaMethods/limits#create ManageIQ/System/CommonMethods]
[----] I, [2018-01-19T14:17:35.786513 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) Updated namespace [System/CommonMethods/QuotaMethods/limits ManageIQ/System/CommonMethods]
[----] I, [2018-01-19T14:17:35.793855 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) Invoking [inline] method [/ManageIQ/System/CommonMethods/QuotaMethods/limits] with inputs [{}]
[----] I, [2018-01-19T14:17:35.794554 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) <AEMethod [/ManageIQ/System/CommonMethods/QuotaMethods/limits]> Starting
[----] I, [2018-01-19T14:17:36.336273 #128421:bf5db0] INFO -- : Q-task_id([vm_reconfigure_request_349]) <AEMethod limits> Getting Tenant Quota Values for: {:memory=>274877906944}
[----] I, [2018-01-19T14:17:36.352947 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) <AEMethod [/ManageIQ/System/CommonMethods/QuotaMethods/limits]> Ending
[----] I, [2018-01-19T14:17:36.353065 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) Method exited with rc=MIQ_OK
[----] I, [2018-01-19T14:17:36.353428 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) Followed Relationship [miqaedb:/System/CommonMethods/QuotaMethods/limits#create]
[----] I, [2018-01-19T14:17:36.353513 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) Processed State=[limits] with Result=[ok]
[----] I, [2018-01-19T14:17:36.353609 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) Processed State =[limits]
[----] I, [2018-01-19T14:17:36.353841 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) Next State=[used]
[----] I, [2018-01-19T14:17:36.354215 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) Processing State=[used]
[----] I, [2018-01-19T14:17:36.354405 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) Following Relationship [miqaedb:/System/CommonMethods/QuotaMethods/used#create]
[----] I, [2018-01-19T14:17:36.370178 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) Updated namespace [miqaedb:/System/CommonMethods/QuotaMethods/used#create ManageIQ/System/CommonMethods]
[----] I, [2018-01-19T14:17:36.393119 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) Updated namespace [System/CommonMethods/QuotaMethods/used ManageIQ/System/CommonMethods]
[----] I, [2018-01-19T14:17:36.401673 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) Invoking [inline] method [/ManageIQ/System/CommonMethods/QuotaMethods/used] with inputs [{}]
[----] I, [2018-01-19T14:17:36.402512 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) <AEMethod [/ManageIQ/System/CommonMethods/QuotaMethods/used]> Starting
[----] I, [2018-01-19T14:17:37.344174 #128421:4f214a4] INFO -- : Q-task_id([vm_reconfigure_request_349]) <AEMethod used> Quota Used: {:cpu=>91, :memory=>137438953472, :vms=>28, :storage=>5626407157760, :provisioned_storage=>5763846111232}
[----] E, [2018-01-19T14:17:37.348186 #128421:65ccbcc] ERROR -- : Q-task_id([vm_reconfigure_request_349]) <AEMethod used> The following error occurred during method evaluation:
[----] E, [2018-01-19T14:17:37.348775 #128421:65ccbcc] ERROR -- : Q-task_id([vm_reconfigure_request_349]) <AEMethod used> NoMethodError: undefined method `check_quota' for #<MiqAeMethodService::MiqAeServiceVmReconfigureRequest:0x00000014ad6470>
[----] E, [2018-01-19T14:17:37.349515 #128421:65ccbcc] ERROR -- : Q-task_id([vm_reconfigure_request_349]) <AEMethod used> (druby://127.0.0.1:34899) /var/www/miq/vmdb/lib/miq_automation_engine/engine/miq_ae_method_service/miq_ae_service_model_base.rb:186:in `method_missing'
[----] E, [2018-01-19T14:17:37.352012 #128421:65ccbcc] ERROR -- : Q-task_id([vm_reconfigure_request_349]) Method STDERR: (druby://127.0.0.1:34899) /var/www/miq/vmdb/lib/miq_automation_engine/engine/miq_ae_method_service/miq_ae_service_model_base.rb:186:in `method_missing': undefined method `check_quota' for #<MiqAeMethodService::MiqAeServiceVmReconfigureRequest:0x00000014ad6470> (NoMethodError)
[----] E, [2018-01-19T14:17:37.352381 #128421:65ccbcc] ERROR -- : Q-task_id([vm_reconfigure_request_349]) Method STDERR: from (druby://127.0.0.1:34899) /opt/rubies/ruby-2.3.1/lib/ruby/2.3.0/drb/drb.rb:1624:in `perform_without_block'
[----] E, [2018-01-19T14:17:37.352783 #128421:65ccbcc] ERROR -- : Q-task_id([vm_reconfigure_request_349]) Method STDERR: from (druby://127.0.0.1:34899) /opt/rubies/ruby-2.3.1/lib/ruby/2.3.0/drb/drb.rb:1584:in `perform'
[----] E, [2018-01-19T14:17:37.353150 #128421:65ccbcc] ERROR -- : Q-task_id([vm_reconfigure_request_349]) Method STDERR: from (druby://127.0.0.1:34899) /opt/rubies/ruby-2.3.1/lib/ruby/2.3.0/drb/drb.rb:1657:in `block (2 levels) in main_loop'
[----] E, [2018-01-19T14:17:37.353543 #128421:65ccbcc] ERROR -- : Q-task_id([vm_reconfigure_request_349]) Method STDERR: from (druby://127.0.0.1:34899) /opt/rubies/ruby-2.3.1/lib/ruby/2.3.0/drb/drb.rb:1653:in `loop'
[----] E, [2018-01-19T14:17:37.354145 #128421:65ccbcc] ERROR -- : Q-task_id([vm_reconfigure_request_349]) Method STDERR: from (druby://127.0.0.1:34899) /opt/rubies/ruby-2.3.1/lib/ruby/2.3.0/drb/drb.rb:1653:in `block in main_loop'
[----] E, [2018-01-19T14:17:37.354738 #128421:65ccbcc] ERROR -- : Q-task_id([vm_reconfigure_request_349]) Method STDERR: from /ManageIQ/System/CommonMethods/QuotaMethods/used:54:in `active_provision_counts'
[----] E, [2018-01-19T14:17:37.355294 #128421:65ccbcc] ERROR -- : Q-task_id([vm_reconfigure_request_349]) Method STDERR: from /ManageIQ/System/CommonMethods/QuotaMethods/used:26:in `used'
[----] E, [2018-01-19T14:17:37.355920 #128421:65ccbcc] ERROR -- : Q-task_id([vm_reconfigure_request_349]) Method STDERR: from /ManageIQ/System/CommonMethods/QuotaMethods/used:17:in `main'
[----] E, [2018-01-19T14:17:37.356496 #128421:65ccbcc] ERROR -- : Q-task_id([vm_reconfigure_request_349]) Method STDERR: from /ManageIQ/System/CommonMethods/QuotaMethods/used:74:in `<main>'
[----] I, [2018-01-19T14:17:37.369644 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) <AEMethod [/ManageIQ/System/CommonMethods/QuotaMethods/used]> Ending
[----] E, [2018-01-19T14:17:37.370021 #128421:893140] ERROR -- : Q-task_id([vm_reconfigure_request_349]) Aborting instantiation (unknown method return code) because [Method exited with rc=Unknown RC: [1]]
[----] E, [2018-01-19T14:17:37.370327 #128421:893140] ERROR -- : Q-task_id([vm_reconfigure_request_349]) State=<used> running raised exception: <Method exited with rc=Unknown RC: [1]>
[----] W, [2018-01-19T14:17:37.370424 #128421:893140] WARN -- : Q-task_id([vm_reconfigure_request_349]) Error in State=[used]
[----] I, [2018-01-19T14:17:37.370727 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) Followed Relationship [miqaedb:/System/CommonMethods/QuotaStatemachine/quota#create]
[----] I, [2018-01-19T14:17:37.371174 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) Followed Relationship [miqaedb:/System/Policy/VmReconfigureRequest_starting#create]
[----] I, [2018-01-19T14:17:37.371423 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) Followed Relationship [miqaedb:/System/Policy/request_starting#create]
[----] I, [2018-01-19T14:17:37.371740 #128421:893140] INFO -- : Q-task_id([vm_reconfigure_request_349]) Followed Relationship [miqaedb:/System/Event/RequestEvent/Request/request_starting#create]
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment