Uploaded image for project: 'Network Controller'
  1. Network Controller
  2. SDNC-712

SERVICE_MODEL not found stops service creation

XMLWordPrintable

      With a  service instanciation from VID via SO the call to SDNC fails with the error in so-error.log.

      The service has been correctly distributed and is in the SERVICE_MODEL table

      mysql> select * from SERVICE_MODEL where service_uuid = "40c453c8-f322-4b48-b0a1-ce2e174be15e";
      -------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------+

      service_uuid model_yaml invariant_uuid version name description type category ecomp_naming service_instance_name_prefix filename naming_policy

      -------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------+

      40c453c8-f322-4b48-b0a1-ce2e174be15e null ae40a6a6-2c88-42ce-928e-efdd1c8633cf NULL ComplexService aaaa Service Network Service Y Complexservice service-Complexservice-csar.csar NULL

      -------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------+
      1 row in set (0.00 sec)

       

      The SDNC log is below

      It looks like the plugin org.onap.ccsdk.sli.adaptors.resource.sql.SqlResource isn't loaded.

      ...

      019-03-27 16:30:14,981 | INFO | qtp463173336-120 | GenericResourceApiProvider | 225 - org.onap.sdnc.northbound.generic-resource-api-provider - 1.5.0 | Adding INPUT data for service-topology-operation [f57c6df0-dbb8-4bfa-8408-46bc82141161] input: ServiceTopologyOperationInput{getRequestInformation=RequestInformation{getRequestAction=CreateServiceInstance, getRequestId=5246791b-70ff-4b69-80a2-3878758dfd4d, getSource=MSO, augmentations={}}, getSdncRequestHeader=SdncRequestHeader{getSvcAction=Assign, getSvcRequestId=5246791b-70ff-4b69-80a2-3878758dfd4d, augmentations={}}, getServiceInformation=ServiceInformation{getGlobalCustomerId=ADemoCustomerInCiti, getOnapModelInformation=OnapModelInformation{getModelInvariantUuid=ae40a6a6-2c88-42ce-928e-efdd1c8633cf, getModelName=ComplexService, getModelUuid=40c453c8-f322-4b48-b0a1-ce2e174be15e, getModelVersion=1.0, augmentations={}}, getServiceId=f57c6df0-dbb8-4bfa-8408-46bc82141161, getServiceInstanceId=f57c6df0-dbb8-4bfa-8408-46bc82141161, getSubscriptionServiceType=vCPE, augmentations={}}, getServiceRequestInput=ServiceRequestInput{getServiceInstanceName=aaaa, augmentations={}}, augmentations={}}
      2019-03-27 16:30:14,990 | INFO | qtp463173336-120 | GenericResourceApiProvider | 225 - org.onap.sdnc.northbound.generic-resource-api-provider - 1.5.0 | Adding OPERATIONAL data for service-topology-operation [f57c6df0-dbb8-4bfa-8408-46bc82141161] operational-data: ServiceData{augmentation=[]}
      2019-03-27 16:30:14,997 | INFO | qtp463173336-120 | SvcLogicServiceImpl | 209 - org.onap.ccsdk.sli.core.sli-provider - 0.4.1 | Fetching service logic from data store
      2019-03-27 16:30:15,006 | INFO | qtp463173336-120 | SvcLogicServiceImplBase | 418 - wrap_file__opt_opendaylight_system_org_onap_ccsdk_sli_core_sli-provider-base_0.4.1_sli-provider-base-0.4.1.jar - 0.0.0 | About to execute graph SvcLogicGraph [module=GENERIC-RESOURCE-API, rpc=service-topology-operation, mode=sync, version=1.5.0, md5sum=72e3ec170c42e74acfdfea3e3e3576c9]
      2019-03-27 16:30:15,007 | INFO | qtp463173336-120 | SvcLogicServiceImplBase | 418 - wrap_file__opt_opendaylight_system_org_onap_ccsdk_sli_core_sli-provider-base_0.4.1_sli-provider-base-0.4.1.jar - 0.0.0 | About to execute node # 1 (block)
      2019-03-27 16:30:15,008 | INFO | qtp463173336-120 | SvcLogicServiceImplBase | 418 - wrap_file__opt_opendaylight_system_org_onap_ccsdk_sli_core_sli-provider-base_0.4.1_sli-provider-base-0.4.1.jar - 0.0.0 | About to execute node # 2 (call)
      2019-03-27 16:30:15,012 | INFO | qtp463173336-120 | SvcLogicServiceImplBase | 418 - wrap_file__opt_opendaylight_system_org_onap_ccsdk_sli_core_sli-provider-base_0.4.1_sli-provider-base-0.4.1.jar - 0.0.0 | About to execute graph SvcLogicGraph [module=GENERIC-RESOURCE-API, rpc=validate-service-input, mode=sync, version=1.5.0, md5sum=5aca5019c04643e51ab308b2d25af816]
      2019-03-27 16:30:15,014 | INFO | qtp463173336-120 | SvcLogicServiceImplBase | 418 - wrap_file__opt_opendaylight_system_org_onap_ccsdk_sli_core_sli-provider-base_0.4.1_sli-provider-base-0.4.1.jar - 0.0.0 | About to execute node # 1 (block)
      2019-03-27 16:30:15,015 | INFO | qtp463173336-120 | SvcLogicServiceImplBase | 418 - wrap_file__opt_opendaylight_system_org_onap_ccsdk_sli_core_sli-provider-base_0.4.1_sli-provider-base-0.4.1.jar - 0.0.0 | About to execute node # 2 (switch)
      2019-03-27 16:30:15,016 | INFO | qtp463173336-120 | SvcLogicExprListener | 208 - org.onap.ccsdk.sli.core.sli-common - 0.4.1 | Outcome (assign) not found, keys are { ("")}
      2019-03-27 16:30:15,017 | INFO | qtp463173336-120 | SvcLogicServiceImplBase | 418 - wrap_file__opt_opendaylight_system_org_onap_ccsdk_sli_core_sli-provider-base_0.4.1_sli-provider-base-0.4.1.jar - 0.0.0 | About to execute node # 4 (switch)
      2019-03-27 16:30:15,017 | INFO | qtp463173336-120 | SvcLogicExprListener | 208 - org.onap.ccsdk.sli.core.sli-common - 0.4.1 | Outcome (5246791b-70ff-4b69-80a2-3878758dfd4d) not found, keys are { ("")}
      2019-03-27 16:30:15,018 | INFO | qtp463173336-120 | SvcLogicServiceImplBase | 418 - wrap_file__opt_opendaylight_system_org_onap_ccsdk_sli_core_sli-provider-base_0.4.1_sli-provider-base-0.4.1.jar - 0.0.0 | About to execute node # 6 (switch)
      2019-03-27 16:30:15,018 | INFO | qtp463173336-120 | SvcLogicExprListener | 208 - org.onap.ccsdk.sli.core.sli-common - 0.4.1 | Outcome (CreateServiceInstance) not found, keys are { ("")}
      2019-03-27 16:30:15,019 | INFO | qtp463173336-120 | SvcLogicServiceImplBase | 418 - wrap_file__opt_opendaylight_system_org_onap_ccsdk_sli_core_sli-provider-base_0.4.1_sli-provider-base-0.4.1.jar - 0.0.0 | About to execute node # 8 (switch)
      2019-03-27 16:30:15,020 | INFO | qtp463173336-120 | SvcLogicServiceImplBase | 418 - wrap_file__opt_opendaylight_system_org_onap_ccsdk_sli_core_sli-provider-base_0.4.1_sli-provider-base-0.4.1.jar - 0.0.0 | About to execute node # 9 (block)
      2019-03-27 16:30:15,020 | INFO | qtp463173336-120 | SvcLogicServiceImplBase | 418 - wrap_file__opt_opendaylight_system_org_onap_ccsdk_sli_core_sli-provider-base_0.4.1_sli-provider-base-0.4.1.jar - 0.0.0 | About to execute node # 10 (switch)
      2019-03-27 16:30:15,021 | INFO | qtp463173336-120 | SvcLogicExprListener | 208 - org.onap.ccsdk.sli.core.sli-common - 0.4.1 | Outcome (vCPE) not found, keys are { ("")}
      2019-03-27 16:30:15,022 | INFO | qtp463173336-120 | SvcLogicServiceImplBase | 418 - wrap_file__opt_opendaylight_system_org_onap_ccsdk_sli_core_sli-provider-base_0.4.1_sli-provider-base-0.4.1.jar - 0.0.0 | About to execute node # 12 (switch)
      2019-03-27 16:30:15,022 | INFO | qtp463173336-120 | SvcLogicExprListener | 208 - org.onap.ccsdk.sli.core.sli-common - 0.4.1 | Outcome (ADemoCustomerInCiti) not found, keys are { ("")}
      2019-03-27 16:30:15,023 | INFO | qtp463173336-120 | SvcLogicServiceImplBase | 418 - wrap_file__opt_opendaylight_system_org_onap_ccsdk_sli_core_sli-provider-base_0.4.1_sli-provider-base-0.4.1.jar - 0.0.0 | About to execute node # 14 (switch)
      2019-03-27 16:30:15,024 | INFO | qtp463173336-120 | SvcLogicExprListener | 208 - org.onap.ccsdk.sli.core.sli-common - 0.4.1 | Outcome (ae40a6a6-2c88-42ce-928e-efdd1c8633cf) not found, keys are { ("")}
      2019-03-27 16:30:15,024 | INFO | qtp463173336-120 | SvcLogicServiceImplBase | 418 - wrap_file__opt_opendaylight_system_org_onap_ccsdk_sli_core_sli-provider-base_0.4.1_sli-provider-base-0.4.1.jar - 0.0.0 | About to execute node # 16 (switch)
      2019-03-27 16:30:15,025 | INFO | qtp463173336-120 | SvcLogicExprListener | 208 - org.onap.ccsdk.sli.core.sli-common - 0.4.1 | Outcome (40c453c8-f322-4b48-b0a1-ce2e174be15e) not found, keys are { ("")}
      2019-03-27 16:30:15,025 | INFO | qtp463173336-120 | SvcLogicServiceImplBase | 418 - wrap_file__opt_opendaylight_system_org_onap_ccsdk_sli_core_sli-provider-base_0.4.1_sli-provider-base-0.4.1.jar - 0.0.0 | About to execute node # 18 (switch)
      2019-03-27 16:30:15,026 | INFO | qtp463173336-120 | SvcLogicExprListener | 208 - org.onap.ccsdk.sli.core.sli-common - 0.4.1 | Outcome (ComplexService) not found, keys are { ("")}
      2019-03-27 16:30:15,027 | INFO | qtp463173336-120 | SvcLogicServiceImplBase | 418 - wrap_file__opt_opendaylight_system_org_onap_ccsdk_sli_core_sli-provider-base_0.4.1_sli-provider-base-0.4.1.jar - 0.0.0 | About to execute node # 3 (set)
      2019-03-27 16:30:15,032 | INFO | qtp463173336-120 | SvcLogicServiceImplBase | 418 - wrap_file__opt_opendaylight_system_org_onap_ccsdk_sli_core_sli-provider-base_0.4.1_sli-provider-base-0.4.1.jar - 0.0.0 | About to execute node # 4 (switch)
      2019-03-27 16:30:15,033 | INFO | qtp463173336-120 | SvcLogicServiceImplBase | 418 - wrap_file__opt_opendaylight_system_org_onap_ccsdk_sli_core_sli-provider-base_0.4.1_sli-provider-base-0.4.1.jar - 0.0.0 | About to execute node # 5 (call)
      2019-03-27 16:30:15,039 | INFO | qtp463173336-120 | SvcLogicServiceImplBase | 418 - wrap_file__opt_opendaylight_system_org_onap_ccsdk_sli_core_sli-provider-base_0.4.1_sli-provider-base-0.4.1.jar - 0.0.0 | About to execute graph SvcLogicGraph [module=GENERIC-RESOURCE-API, rpc=service-topology-operation-assign, mode=sync, version=1.5.0, md5sum=7a2966e1e8863e74a468c4df1e4f239d]
      2019-03-27 16:30:15,040 | INFO | qtp463173336-120 | SvcLogicServiceImplBase | 418 - wrap_file__opt_opendaylight_system_org_onap_ccsdk_sli_core_sli-provider-base_0.4.1_sli-provider-base-0.4.1.jar - 0.0.0 | About to execute node # 1 (block)
      2019-03-27 16:30:15,040 | INFO | qtp463173336-120 | SvcLogicServiceImplBase | 418 - wrap_file__opt_opendaylight_system_org_onap_ccsdk_sli_core_sli-provider-base_0.4.1_sli-provider-base-0.4.1.jar - 0.0.0 | About to execute node # 2 (switch)
      2019-03-27 16:30:15,041 | INFO | qtp463173336-120 | SvcLogicServiceImplBase | 418 - wrap_file__opt_opendaylight_system_org_onap_ccsdk_sli_core_sli-provider-base_0.4.1_sli-provider-base-0.4.1.jar - 0.0.0 | About to execute node # 3 (block)
      2019-03-27 16:30:15,041 | INFO | qtp463173336-120 | SvcLogicServiceImplBase | 418 - wrap_file__opt_opendaylight_system_org_onap_ccsdk_sli_core_sli-provider-base_0.4.1_sli-provider-base-0.4.1.jar - 0.0.0 | About to execute node # 5 (get-resource)
      2019-03-27 16:30:15,042 | WARN | qtp463173336-120 | SvcLogicClassResolver | 209 - org.onap.ccsdk.sli.core.sli-provider - 0.4.1 | Could not find service reference object for class org.onap.ccsdk.sli.adaptors.resource.sql.SqlResource
      2019-03-27 16:30:15,043 | WARN | qtp463173336-120 | GetResourceNodeExecutor | 418 - wrap_file__opt_opendaylight_system_org_onap_ccsdk_sli_core_sli-provider-base_0.4.1_sli-provider-base-0.4.1.jar - 0.0.0 | Could not find SvcLogicResource object for plugin org.onap.ccsdk.sli.adaptors.resource.sql.SqlResource
      2019-03-27 16:30:15,046 | INFO | qtp463173336-120 | SvcLogicServiceImplBase | 418 - wrap_file__opt_opendaylight_system_org_onap_ccsdk_sli_core_sli-provider-base_0.4.1_sli-provider-base-0.4.1.jar - 0.0.0 | About to execute node # 6 (return)
      2019-03-27 16:30:15,047 | INFO | qtp463173336-120 | BlockNodeExecutor | 418 - wrap_file__opt_opendaylight_system_org_onap_ccsdk_sli_core_sli-provider-base_0.4.1_sli-provider-base-0.4.1.jar - 0.0.0 | Block - stopped executing nodes due to failure status
      2019-03-27 16:30:15,047 | INFO | qtp463173336-120 | BlockNodeExecutor | 418 - wrap_file__opt_opendaylight_system_org_onap_ccsdk_sli_core_sli-provider-base_0.4.1_sli-provider-base-0.4.1.jar - 0.0.0 | Block - stopped executing nodes due to failure status
      2019-03-27 16:30:15,061 | ERROR | qtp463173336-120 | GenericResourceApiProvider | 225 - org.onap.sdnc.northbound.generic-resource-api-provider - 1.5.0 | Returned FAILED for service-topology-operation [f57c6df0-dbb8-4bfa-8408-46bc82141161] ServiceTopologyOperationOutput{_ackFinalIndicator=Y, _responseCode=500, _responseMessage=Error reading SERVICE_MODEL table, _svcRequestId=5246791b-70ff-4b69-80a2-3878758dfd4d, augmentation=[]}
      2019-03-27 16:30:16,550 | INFO | qtp463173336-117 | GenericResourceApiProvider | 225 - org.onap.sdnc.northbound.generic-resource-api-provider - 1.5.0 | service-topology-operation called.
      2019-03-27 16:30:16,553 | INFO | qtp463173336-117 | GenericResourceApiProvider | 225 - org.onap.sdnc.northbound.generic-resource-api-provider - 1.5.0 | No service-data found in MD-SAL (CONFIGURATION) for [f57c6df0-dbb8-4bfa-8408-46bc82141161]
      2019-03-27 16:30:16,555 | INFO | qtp463173336-117 | GenericResourceApiProvider | 225 - org.onap.sdnc.northbound.generic-resource-api-provider - 1.5.0 | No data found in MD-SAL (OPERATIONAL) for [f57c6df0-dbb8-4bfa-8408-46bc82141161]

      ...

       

       

            afenner afenner
            afenner afenner
            Votes:
            0 Vote for this issue
            Watchers:
            4 Start watching this issue

              Created:
              Updated:
              Resolved: