Hey Pete, I do have to set the assertion to skip for the objectwalker to run. Not sure about the error and relationship comment…
Automate log:
[----] I, [2018-01-25T05:10:03.000287 #31259:2b0945d7f130] INFO – : MiqAeEvent.build_evm_event >> event=<“request_created”> inputs=<{“EventStream::event_stream”=>7653, :event_stream_id=>7653}>
[----] I, [2018-01-25T05:10:07.853937 #31277:2b0945d7f130] INFO – : Instantiating [/System/Process/Event?EventStream%3A%3Aevent_stream=7653&MiqRequest%3A%3Amiq_request=125&MiqServer%3A%3Amiq_server=1&ServiceTemplateProvisionRequest%3A%3Aservice_template_provision_request=125&User%3A%3Auser=1&event_stream_id=7653&event_type=request_created&object_name=Event&vmdb_object_type=service_template_provision_request]
[----] I, [2018-01-25T05:10:07.876180 #31277:2b0945d7f130] INFO – : Updated namespace [/System/Process/Event?EventStream%3A%3Aevent_stream=7653&MiqRequest%3A%3Amiq_request=125&MiqServer%3A%3Amiq_server=1&ServiceTemplateProvisionRequest%3A%3Aservice_template_provision_request=125&User%3A%3Auser=1&event_stream_id=7653&event_type=request_created&object_name=Event&vmdb_object_type=service_template_provision_request ManageIQ/System]
[----] I, [2018-01-25T05:10:08.010791 #31277:2b0945d7f130] INFO – : Following Relationship [miqaedb:/System/Event/RequestEvent/Request/request_created#create]
[----] I, [2018-01-25T05:10:08.026315 #31277:2b0945d7f130] INFO – : Updated namespace [miqaedb:/System/Event/RequestEvent/Request/request_created#create ManageIQ/System/Event/RequestEvent]
[----] I, [2018-01-25T05:10:08.049095 #31277:2b0945d7f130] INFO – : Following Relationship [miqaedb:/System/Policy/request_created#create]
[----] I, [2018-01-25T05:10:08.055443 #31277:2b0945d7f130] INFO – : Updated namespace [miqaedb:/System/Policy/request_created#create ManageIQ/System]
[----] I, [2018-01-25T05:10:08.074412 #31277:2b0945d7f130] INFO – : Updated namespace [System/Policy/get_request_type ManageIQ/System]
[----] I, [2018-01-25T05:10:08.079810 #31277:2b0945d7f130] INFO – : Invoking [inline] method [/ManageIQ/System/Policy/get_request_type] with inputs [{}]
[----] I, [2018-01-25T05:10:08.089915 #31277:2b0945d7f130] INFO – : <AEMethod [/ManageIQ/System/Policy/get_request_type]> Starting
[----] I, [2018-01-25T05:10:09.818014 #31277:2b0945d70630] INFO – : Request Type:
[----] I, [2018-01-25T05:10:09.845704 #31277:2b0945d7f130] INFO – : <AEMethod [/ManageIQ/System/Policy/get_request_type]> Ending
[----] I, [2018-01-25T05:10:09.845794 #31277:2b0945d7f130] INFO – : Method exited with rc=MIQ_OK
[----] I, [2018-01-25T05:10:09.846875 #31277:2b0945d7f130] INFO – : Following Relationship [miqaedb:/System/Process/parse_provider_category#create]
[----] I, [2018-01-25T05:10:09.883975 #31277:2b0945d7f130] INFO – : Updated namespace [miqaedb:/System/Process/parse_provider_category#create ManageIQ/System]
[----] I, [2018-01-25T05:10:09.896357 #31277:2b0945d7f130] INFO – : Updated namespace [System/Process/parse_provider_category ManageIQ/System]
[----] I, [2018-01-25T05:10:09.902200 #31277:2b0945d7f130] INFO – : Invoking [builtin] method [/ManageIQ/System/Process/parse_provider_category] with inputs [{}]
[----] I, [2018-01-25T05:10:09.956608 #31277:2b0945d7f130] INFO – : Setting provider_category to:
[----] I, [2018-01-25T05:10:09.957720 #31277:2b0945d7f130] INFO – : Followed Relationship [miqaedb:/System/Process/parse_provider_category#create]
[----] I, [2018-01-25T05:10:09.958062 #31277:2b0945d7f130] INFO – : Following Relationship [miqaedb:/System/Policy/ServiceTemplateProvisionRequest_created#create]
[----] I, [2018-01-25T05:10:09.962418 #31277:2b0945d7f130] INFO – : Updated namespace [miqaedb:/System/Policy/ServiceTemplateProvisionRequest_created#create ManageIQ/System]
[----] I, [2018-01-25T05:10:09.970307 #31277:2b0945d7f130] INFO – : Evaluating substituted assertion [true]
[----] I, [2018-01-25T05:10:09.973301 #31277:2b0945d7f130] INFO – : Following Relationship [miqaedb:/service/Provisioning/Profile/EvmGroup-super_administrator#get_auto_approval_state_machine]
[----] I, [2018-01-25T05:10:10.067730 #31277:2b0945d7f130] INFO – : Updated namespace [miqaedb:/service/Provisioning/Profile/EvmGroup-super_administrator#get_auto_approval_state_machine ManageIQ/service/Provisioning]
[----] I, [2018-01-25T05:10:10.123149 #31277:2b0945d7f130] INFO – : Instance [/ManageIQ/service/Provisioning/Profile/EvmGroup-super_administrator] not found in MiqAeDatastore - trying [.missing]
[----] I, [2018-01-25T05:10:10.136363 #31277:2b0945d7f130] INFO – : Followed Relationship [miqaedb:/service/Provisioning/Profile/EvmGroup-super_administrator#get_auto_approval_state_machine]
[----] I, [2018-01-25T05:10:10.137664 #31277:2b0945d7f130] INFO – : Following Relationship [miqaedb:/service/Provisioning/StateMachines/ServiceProvisionRequestApproval/Default#create]
[----] I, [2018-01-25T05:10:10.327075 #31277:2b0945d7f130] INFO – : Updated namespace [miqaedb:/service/Provisioning/StateMachines/ServiceProvisionRequestApproval/Default#create CPA/service/Provisioning/StateMachines]
EVM log:
[----] I, [2018-01-25T05:10:08.079714 #31277:2b0945d7f130] INFO – : Invoking [inline] method [/ManageIQ/System/Policy/get_request_type] with inputs [{}]
[----] I, [2018-01-25T05:10:08.089801 #31277:2b0945d7f130] INFO – : <AEMethod [/ManageIQ/System/Policy/get_request_type]> Starting
[----] I, [2018-01-25T05:10:09.817826 #31277:2b0945d70630] INFO – : Request Type:
[----] I, [2018-01-25T05:10:09.845614 #31277:2b0945d7f130] INFO – : <AEMethod [/ManageIQ/System/Policy/get_request_type]> Ending
[----] I, [2018-01-25T05:10:09.845764 #31277:2b0945d7f130] INFO – : Method exited with rc=MIQ_OK
[----] I, [2018-01-25T05:10:09.846795 #31277:2b0945d7f130] INFO – : Following Relationship [miqaedb:/System/Process/parse_provider_category#create]
[----] I, [2018-01-25T05:10:09.883812 #31277:2b0945d7f130] INFO – : Updated namespace [miqaedb:/System/Process/parse_provider_category#create ManageIQ/System]
[----] I, [2018-01-25T05:10:09.896270 #31277:2b0945d7f130] INFO – : Updated namespace [System/Process/parse_provider_category ManageIQ/System]
[----] I, [2018-01-25T05:10:09.902110 #31277:2b0945d7f130] INFO – : Invoking [builtin] method [/ManageIQ/System/Process/parse_provider_category] with inputs [{}]
[----] I, [2018-01-25T05:10:09.956516 #31277:2b0945d7f130] INFO – : Setting provider_category to:
[----] I, [2018-01-25T05:10:09.957658 #31277:2b0945d7f130] INFO – : Followed Relationship [miqaedb:/System/Process/parse_provider_category#create]
[----] I, [2018-01-25T05:10:09.957984 #31277:2b0945d7f130] INFO – : Following Relationship [miqaedb:/System/Policy/ServiceTemplateProvisionRequest_created#create]
[----] I, [2018-01-25T05:10:09.962302 #31277:2b0945d7f130] INFO – : Updated namespace [miqaedb:/System/Policy/ServiceTemplateProvisionRequest_created#create ManageIQ/System]
[----] I, [2018-01-25T05:10:09.970221 #31277:2b0945d7f130] INFO – : Evaluating substituted assertion [true]
[----] I, [2018-01-25T05:10:09.973215 #31277:2b0945d7f130] INFO – : Following Relationship [miqaedb:/service/Provisioning/Profile/EvmGroup-super_administrator#get_auto_approval_state_machine]
[----] I, [2018-01-25T05:10:10.067614 #31277:2b0945d7f130] INFO – : Updated namespace [miqaedb:/service/Provisioning/Profile/EvmGroup-super_administrator#get_auto_approval_state_machine ManageIQ/service/Provisioning]
[----] I, [2018-01-25T05:10:10.123037 #31277:2b0945d7f130] INFO – : Instance [/ManageIQ/service/Provisioning/Profile/EvmGroup-super_administrator] not found in MiqAeDatastore - trying [.missing]
[----] I, [2018-01-25T05:10:10.136266 #31277:2b0945d7f130] INFO – : Followed Relationship [miqaedb:/service/Provisioning/Profile/EvmGroup-super_administrator#get_auto_approval_state_machine]
[----] I, [2018-01-25T05:10:10.137583 #31277:2b0945d7f130] INFO – : Following Relationship [miqaedb:/service/Provisioning/StateMachines/ServiceProvisionRequestApproval/Default#create]
[----] I, [2018-01-25T05:10:10.326979 #31277:2b0945d7f130] INFO – : Updated namespace [miqaedb:/service/Provisioning/StateMachines/ServiceProvisionRequestApproval/Default#create CPA/service/Provisioning/StateMachines]
[----] E, [2018-01-25T05:10:10.451999 #31277:2b0945d7f130] ERROR – : MIQ(MiqAeEngine.deliver) Error delivering {:event_type=>“request_created”, “EventStream::event_stream”=>7653, :event_stream_id=>7653, “ServiceTemplateProvisionRequest::service_templ
ate_provision_request”=>125, “User::user”=>1} for object [ServiceTemplateProvisionRequest.125] with state to Automate: bad URI(is not URI?): /#miq_request.options[:dialog][‘dialog_zone’]
[----] I, [2018-01-25T05:10:10.452630 #31277:2b0945d7f130] INFO – : MIQ(MiqQueue#delivered) Message id: [232538], State: [ok], Delivered in [2.67747021] seconds