Hello Team, When i'm trying to restart my VNF through APPC LCM Restart API, i get successful response from APPC but the VNF is not restarted successfully at openstack. The log at APPC says there is an error at DG ? Any input? Below are the request response and error logs:
*Request:* POST http://xx.xx.xx.xx:30230/restconf/operations/appc-provider-lcm:restart { "input": { "common-header": { "timestamp": "2018-12-14T02:10:04.244Z", "api-ver": "2.00", "originator-id": "664be3d2-6c12-4f4b-a3e7-c349acced2001", "request-id": "268a5e6d-3e8e-496c-b282-3c0a33be3c28", "sub-request-id": "1", "flags": { "force" : "TRUE", "ttl" : 60000 } }, "action": "Restart", "action-identifiers": { "vnf-id": "b0ced82c-b549-4404-970c-ea39437d993b" } } } *Response:* 200 OK { "output": { "status": { "code": 100, "message": "ACCEPTED - request accepted" }, "common-header": { "api-ver": "2.00", "flags": { "force": "TRUE", "ttl": 60000 }, "sub-request-id": "1", "originator-id": "664be3d2-6c12-4f4b-a3e7-c349acced2001", "timestamp": "2018-12-14T02:10:04.244Z", "request-id": "268a5e6d-3e8e-496c-b282-3c0a33be3c28" } } } ERRRO LOG at APPC karaf.log 2018-12-14 10:34:58,350 | INFO | ]-nio2-thread-14 | ServerSession | 51 - org.apache.sshd.core - 0.14.0 - - | Server session created from /127.0.0.1:56104 2018-12-14 10:34:58,533 | INFO | ]-nio2-thread-13 | LogAuditLoginModule | 38 - org.apache.karaf.jaas.modules - 4.0.10 - - | Authentication attempt - karaf 2018-12-14 10:34:58,533 | INFO | ]-nio2-thread-13 | LogAuditLoginModule | 38 - org.apache.karaf.jaas.modules - 4.0.10 - - | Authentication failed - karaf 2018-12-14 10:34:58,545 | INFO | f]-nio2-thread-1 | LogAuditLoginModule | 38 - org.apache.karaf.jaas.modules - 4.0.10 - - | Authentication attempt - karaf 2018-12-14 10:34:58,545 | INFO | f]-nio2-thread-1 | LogAuditLoginModule | 38 - org.apache.karaf.jaas.modules - 4.0.10 - - | Authentication succeeded - karaf 2018-12-14 10:34:58,545 | INFO | f]-nio2-thread-1 | ServerUserAuthService | 51 - org.apache.sshd.core - 0.14.0 - - | Session karaf@/ 127.0.0.1:56104 authenticated 2018-12-14 10:34:58,581 | INFO | f]-nio2-thread-5 | ChannelSession | 51 - org.apache.sshd.core - 0.14.0 - - | Executing command: system:start-level 2018-12-14 10:34:58,876 | INFO | 8894141-12614609 | RequestValidatorImpl | 413 - appc-common - 1.3.0 - - | AAIService from bundlecontext 2018-12-14 10:34:58,883 | INFO | 8894141-12614609 | AAIService | 348 - org.onap.ccsdk.sli.adaptors.aai-service-provider - 0.2.3 - - | AAI Deprecation - the format of request key is no longer supported. Please rewrite this key : vnf-id = 'b0ced82c-b549-4404-970c-ea39437d993b' 2018-12-14 10:34:58,883 | INFO | 8894141-12614609 | AAIService | 348 - org.onap.ccsdk.sli.adaptors.aai-service-provider - 0.2.3 - - | Input - vnf-id : b0ced82c-b549-4404-970c-ea39437d993b 2018-12-14 10:34:58,883 | INFO | 8894141-12614609 | AAIService | 348 - org.onap.ccsdk.sli.adaptors.aai-service-provider - 0.2.3 - - | A&AI transaction : 2018-12-14 10:34:58,883 | INFO | 8894141-12614609 | AAIService | 348 - org.onap.ccsdk.sli.adaptors.aai-service-provider - 0.2.3 - - | Request Time : 2018-12-14T10:34:58.883Z, Method : GET 2018-12-14 10:34:58,883 | INFO | 8894141-12614609 | AAIService | 348 - org.onap.ccsdk.sli.adaptors.aai-service-provider - 0.2.3 - - | Request URL : https://aai.onap:8443/aai/v13/network/generic-vnfs/generic-vnf/b0ced82c-b549-4404-970c-ea39437d993b 2018-12-14 10:34:58,883 | INFO | 8894141-12614609 | AAIService | 348 - org.onap.ccsdk.sli.adaptors.aai-service-provider - 0.2.3 - - | Missing requestID. Assigned def33f65-f1e4-4731-a59b-c208fe202f65 2018-12-14 10:34:58,942 | INFO | 8894141-12614609 | metric | 339 - org.onap.ccsdk.sli.core.sli-common - 0.2.3 - - | 2018-12-14 10:34:58,944 | INFO | 8894141-12614609 | AAIService | 348 - org.onap.ccsdk.sli.adaptors.aai-service-provider - 0.2.3 - - | Response code : 200, OK 2018-12-14 10:34:58,948 | INFO | 8894141-12614609 | AAIService | 348 - org.onap.ccsdk.sli.adaptors.aai-service-provider - 0.2.3 - - | Response data : {"vnf-id":"b0ced82c-b549-4404-970c-ea39437d993b","vnf-name":"vlb002","vnf-type":"vlb_02/vlb_02 0","service-id":"0e5ae4d0-1b6a-4691-bb2e-85159f2eab12","prov-status":"PREPROV","orchestration-status":"Created","in-maint":false,"is-closed-loop-disabled":false,"resource-version":"1544686507931","model-invariant-id":"6d82a5b8-172e-4bfd-aaa6-ae9cb91e3637","model-version-id":"f798d762-7b44-4d8e-898e-a1480defb42e","model-customization-id":"b640bddb-a246-4cfe-addd-b1c0c4e32e72","nf-type":"","nf-function":"","nf-role":"","nf-naming-code":"","relationship-list":{"relationship":[{"related-to":"service-instance","relationship-label":"org.onap.relationships.inventory.ComposedOf","related-link":"/aai/v13/business/customers/customer/Demonstration/service-subscriptions/service-subscription/vLB/service-instances/service-instance/a45bb699-4f45-4299-aa3f-cd65eb08dc7b","relationship-data":[{"relationship-key":"customer.global-customer-id","relationship-value":"Demonstration"},{"relationship-key":"service-subscription.service-type","relationship-value":"vLB"},{"relationship-key":"service-instance.service-instance-id","relationship-value":"a45bb699-4f45-4299-aa3f-cd65eb08dc7b"}],"related-to-property":[{"property-key":"service-instance.service-instance-name","property-value":"vlb02"}]},{"related-to":"platform","relationship-label":"org.onap.relationships.inventory.Uses","related-link":"/aai/v13/business/platforms/platform/Platform-Demonstration","relationship-data":[{"relationship-key":"platform.platform-name","relationship-value":"Platform-Demonstration"}]},{"related-to":"line-of-business","relationship-label":"org.onap.relationships.inventory.Uses","related-link":"/aai/v13/business/lines-of-business/line-of-business/LOB-Demonstration","relationship-data":[{"relationship-key":"line-of-business.line-of-business-name","relationship-value":"LOB-Demonstration"}]}]},"vf-modules":{"vf-module":[{"vf-module-id":"8ac77016-c9dd-4385-84dc-f5423860277d","vf-module-name":"vLB_Test","heat-stack-id":"vLB_Test/fc830b8f-9a91-418a-9fb3-576b8c3fca9a","orchestration-status":"active","is-base-vf-module":true,"resource-version":"1544691551639","model-invariant-id":"80755505-a4ed-46dd-9b58-d1bb45e9bbd0","model-version-id":"dff1abe0-48b3-4414-9d88-0ef433c80036","model-customization-id":"9d760e31-9df5-4567-98a3-ad803ed5334e","module-index":0}]}} 2018-12-14 10:34:58,999 | INFO | 8894141-12614609 | metrics | 413 - appc-common - 1.3.0 - - | APPC0128I Operation "null" for VNF type "null" from Source "null" with RequestID "def33f65-f1e4-4731-a59b-c208fe202f65" on "A&AI" with action "query" ended in 115 ms with result "COMPLETE" 2018-12-14 10:34:58,999 | INFO | 8894141-12614609 | RequestValidatorImpl | 413 - appc-common - 1.3.0 - - | AAIResponse: SUCCESS 2018-12-14 10:34:59,026 | INFO | 8894141-12614609 | CommandTask | 421 - appc-command-executor-core - 1.3.0 - - | AAIService from bundlecontext 2018-12-14 10:34:59,027 | INFO | ppc-dispatcher-7 | SvcLogicServiceImpl | 340 - org.onap.ccsdk.sli.core.sli-provider - 0.2.3 - - | Fetching service logic from data store 2018-12-14 10:34:59,029 | INFO | ppc-dispatcher-7 | SvcLogicServiceImpl | 340 - org.onap.ccsdk.sli.core.sli-provider - 0.2.3 - SvcLogicGraph [module=APPC, rpc=Generic_Restart, mode=sync, version=3.0.0, md5sum=9223fbd1e1a9645d78ba151289ae7c6e] - | About to execute graph SvcLogicGraph [module=APPC, rpc=Generic_Restart, mode=sync, version=3.0.0, md5sum=9223fbd1e1a9645d78ba151289ae7c6e] 2018-12-14 10:34:59,029 | INFO | ppc-dispatcher-7 | SvcLogicServiceImpl | 340 - org.onap.ccsdk.sli.core.sli-provider - 0.2.3 - SvcLogicGraph [module=APPC, rpc=Generic_Restart, mode=sync, version=3.0.0, md5sum=9223fbd1e1a9645d78ba151289ae7c6e] - 1 (execute) | About to execute node # 1 (execute) 2018-12-14 10:34:59,029 | WARN | ppc-dispatcher-7 | JsonDgUtilImpl | 413 - appc-common - 1.3.0 - SvcLogicGraph [module=APPC, rpc=Generic_Restart, mode=sync, version=3.0.0, md5sum=9223fbd1e1a9645d78ba151289ae7c6e] - 1 (execute) | input payload param value is empty ("") or null 2018-12-14 10:34:59,029 | INFO | ppc-dispatcher-7 | SvcLogicServiceImpl | 340 - org.onap.ccsdk.sli.core.sli-provider - 0.2.3 - SvcLogicGraph [module=APPC, rpc=Generic_Restart, mode=sync, version=3.0.0, md5sum=9223fbd1e1a9645d78ba151289ae7c6e] - 8 (switch) | About to execute node # 8 (switch) 2018-12-14 10:34:59,029 | INFO | ppc-dispatcher-7 | SvcLogicExprListener | 339 - org.onap.ccsdk.sli.core.sli-common - 0.2.3 - SvcLogicGraph [module=APPC, rpc=Generic_Restart, mode=sync, version=3.0.0, md5sum=9223fbd1e1a9645d78ba151289ae7c6e] - 8 (switch) | Outcome ($input.action-identifiers.vnf-id) not found, keys are { ("") (Other)} 2018-12-14 10:34:59,029 | INFO | ppc-dispatcher-7 | SvcLogicServiceImpl | 340 - org.onap.ccsdk.sli.core.sli-provider - 0.2.3 - SvcLogicGraph [module=APPC, rpc=Generic_Restart, mode=sync, version=3.0.0, md5sum=9223fbd1e1a9645d78ba151289ae7c6e] - 10 (block) | About to execute node # 10 (block) 2018-12-14 10:34:59,030 | INFO | 8894141-12614609 | audit | 413 - appc-common - 1.3.0 - - | APPC0090A Operation "Restart" for VNF type "b0ced82c-b549-4404-970c-ea39437d993b" from Source "664be3d2-6c12-4f4b-a3e7-c349acced2001" with RequestID "268a5e6d-3e8e-496c-b282-3c0a33be3c28" was started at "2018-12-14T10:34:58Z" and ended at "2018-12-14T10:34:59Z" with status code "100" 2018-12-14 10:34:59,030 | INFO | 8894141-12614609 | metrics | 413 - appc-common - 1.3.0 - - | APPC0128I Operation "Restart" for VNF type "b0ced82c-b549-4404-970c-ea39437d993b" from Source "664be3d2-6c12-4f4b-a3e7-c349acced2001" with RequestID "268a5e6d-3e8e-496c-b282-3c0a33be3c28" on "APPC" with action "Restart" ended in 199 ms with result "COMPLETE" 2018-12-14 10:34:59,030 | INFO | 8894141-12614609 | AppcProviderLcm | 413 - appc-common - 1.3.0 - - | Execute of 'ActionIdentifiers{getVnfId=b0ced82c-b549-4404-970c-ea39437d993b, augmentations={}}' finished with status 100. Reason: ACCEPTED - request accepted 2018-12-14 10:34:59,031 | INFO | ppc-dispatcher-7 | AAIService | 348 - org.onap.ccsdk.sli.adaptors.aai-service-provider - 0.2.3 - SvcLogicGraph [module=APPC, rpc=Generic_Restart, mode=sync, version=3.0.0, md5sum=9223fbd1e1a9645d78ba151289ae7c6e] - 10 (block) | Input - named-query-uuid : 037eb932-edac-48f5-9782-c19c0aa5a031 2018-12-14 10:34:59,031 | INFO | ppc-dispatcher-7 | AAIService | 348 - org.onap.ccsdk.sli.adaptors.aai-service-provider - 0.2.3 - SvcLogicGraph [module=APPC, rpc=Generic_Restart, mode=sync, version=3.0.0, md5sum=9223fbd1e1a9645d78ba151289ae7c6e] - 10 (block) | Input - prefix : namedQueryData 2018-12-14 10:34:59,032 | INFO | ppc-dispatcher-7 | AAIService | 348 - org.onap.ccsdk.sli.adaptors.aai-service-provider - 0.2.3 - SvcLogicGraph [module=APPC, rpc=Generic_Restart, mode=sync, version=3.0.0, md5sum=9223fbd1e1a9645d78ba151289ae7c6e] - 10 (block) | A&AI transaction : 2018-12-14 10:34:59,032 | INFO | ppc-dispatcher-7 | AAIService | 348 - org.onap.ccsdk.sli.adaptors.aai-service-provider - 0.2.3 - SvcLogicGraph [module=APPC, rpc=Generic_Restart, mode=sync, version=3.0.0, md5sum=9223fbd1e1a9645d78ba151289ae7c6e] - 10 (block) | Request Time : 2018-12-14T10:34:59.031Z, Method : POST 2018-12-14 10:34:59,032 | INFO | ppc-dispatcher-7 | AAIService | 348 - org.onap.ccsdk.sli.adaptors.aai-service-provider - 0.2.3 - SvcLogicGraph [module=APPC, rpc=Generic_Restart, mode=sync, version=3.0.0, md5sum=9223fbd1e1a9645d78ba151289ae7c6e] - 10 (block) | Request URL : https://aai.onap:8443/aai/search/named-query 2018-12-14 10:34:59,034 | INFO | ppc-dispatcher-7 | AAIService | 348 - org.onap.ccsdk.sli.adaptors.aai-service-provider - 0.2.3 - SvcLogicGraph [module=APPC, rpc=Generic_Restart, mode=sync, version=3.0.0, md5sum=9223fbd1e1a9645d78ba151289ae7c6e] - 10 (block) | Input - data : {"query-parameters":{"named-query":{"named-query-uuid":"037eb932-edac-48f5-9782-c19c0aa5a031"}},"instance-filters":{"instance-filter":[{"generic-vnf":{"vnf-id":"b0ced82c-b549-4404-970c-ea39437d993b"}}]}} 2018-12-14 10:34:59,226 | INFO | ppc-dispatcher-7 | metric | 339 - org.onap.ccsdk.sli.core.sli-common - 0.2.3 - SvcLogicGraph [module=APPC, rpc=Generic_Restart, mode=sync, version=3.0.0, md5sum=9223fbd1e1a9645d78ba151289ae7c6e] - 10 (block) | {"query-parameters":{"named-query":{"named-query-uuid":"037eb932-edac-48f5-9782-c19c0aa5a031"}},"instance-filters":{"instance-filter":[{"generic-vnf":{"vnf-id":"b0ced82c-b549-4404-970c-ea39437d993b"}}]}} 2018-12-14 10:34:59,228 | INFO | ppc-dispatcher-7 | AAIService | 348 - org.onap.ccsdk.sli.adaptors.aai-service-provider - 0.2.3 - SvcLogicGraph [module=APPC, rpc=Generic_Restart, mode=sync, version=3.0.0, md5sum=9223fbd1e1a9645d78ba151289ae7c6e] - 10 (block) | Response code : 200, OK 2018-12-14 10:34:59,228 | INFO | ppc-dispatcher-7 | AAIService | 348 - org.onap.ccsdk.sli.adaptors.aai-service-provider - 0.2.3 - SvcLogicGraph [module=APPC, rpc=Generic_Restart, mode=sync, version=3.0.0, md5sum=9223fbd1e1a9645d78ba151289ae7c6e] - 10 (block) | Response data : {"inventory-response-item":[{"model-name":"vlb_02","generic-vnf":{"vnf-id":"b0ced82c-b549-4404-970c-ea39437d993b","vnf-name":"vlb002","vnf-type":"vlb_02/vlb_02 0","service-id":"0e5ae4d0-1b6a-4691-bb2e-85159f2eab12","prov-status":"PREPROV","orchestration-status":"Created","in-maint":false,"is-closed-loop-disabled":false,"resource-version":"1544686507931","model-invariant-id":"6d82a5b8-172e-4bfd-aaa6-ae9cb91e3637","model-version-id":"f798d762-7b44-4d8e-898e-a1480defb42e","model-customization-id":"b640bddb-a246-4cfe-addd-b1c0c4e32e72","nf-type":"","nf-function":"","nf-role":"","nf-naming-code":""},"extra-properties":{}}]} 2018-12-14 10:34:59,253 | INFO | ppc-dispatcher-7 | SvcLogicExprListener | 339 - org.onap.ccsdk.sli.core.sli-common - 0.2.3 - SvcLogicGraph [module=APPC, rpc=Generic_Restart, mode=sync, version=3.0.0, md5sum=9223fbd1e1a9645d78ba151289ae7c6e] - 10 (block) | Outcome (success) not found, keys are { (failure)} 2018-12-14 10:34:59,253 | INFO | ppc-dispatcher-7 | SvcLogicExprListener | 339 - org.onap.ccsdk.sli.core.sli-common - 0.2.3 - SvcLogicGraph [module=APPC, rpc=Generic_Restart, mode=sync, version=3.0.0, md5sum=9223fbd1e1a9645d78ba151289ae7c6e] - 10 (block) | Outcome (Other) not found, keys are { (failure)} 2018-12-14 10:34:59,253 | INFO | ppc-dispatcher-7 | SvcLogicExprListener | 339 - org.onap.ccsdk.sli.core.sli-common - 0.2.3 - SvcLogicGraph [module=APPC, rpc=Generic_Restart, mode=sync, version=3.0.0, md5sum=9223fbd1e1a9645d78ba151289ae7c6e] - 10 (block) | Outcome (b0ced82c-b549-4404-970c-ea39437d993b) not found, keys are { ("")} 2018-12-14 10:34:59,253 | ERROR | ppc-dispatcher-7 | WorkFlowManagerImpl | 413 - appc-common - 1.3.0 - SvcLogicGraph [module=APPC, rpc=Generic_Restart, mode=sync, version=3.0.0, md5sum=9223fbd1e1a9645d78ba151289ae7c6e] - 10 (block) | Error in DG org.onap.ccsdk.sli.core.sli.SvcLogicException: Invalid index values [0,] at org.onap.ccsdk.sli.core.sli.provider.ForNodeExecutor.execute(ForNodeExecutor.java:68) at org.onap.ccsdk.sli.core.sli.provider.SvcLogicServiceImpl.executeNode(SvcLogicServiceImpl.java:181) at org.onap.ccsdk.sli.core.sli.provider.BlockNodeExecutor.execute(BlockNodeExecutor.java:62) at org.onap.ccsdk.sli.core.sli.provider.SvcLogicServiceImpl.executeNode(SvcLogicServiceImpl.java:181) at org.onap.ccsdk.sli.core.sli.provider.BlockNodeExecutor.execute(BlockNodeExecutor.java:62) at org.onap.ccsdk.sli.core.sli.provider.SvcLogicServiceImpl.executeNode(SvcLogicServiceImpl.java:181) at org.onap.ccsdk.sli.core.sli.provider.SvcLogicServiceImpl.execute(SvcLogicServiceImpl.java:158) at org.onap.ccsdk.sli.core.sli.provider.SvcLogicServiceImpl.execute(SvcLogicServiceImpl.java:238) at org.onap.ccsdk.sli.core.sli.provider.SvcLogicServiceImpl.execute(SvcLogicServiceImpl.java:216) at Proxy6ad30656_b7dc_4fda_821b_79fcf1b9f3ea.execute(Unknown Source) at Proxyd2bcbfd5_429a_45d3_82e7_706069b232bc.execute(Unknown Source) at org.onap.appc.workflow.impl.WorkFlowManagerImpl.SVCLogicServiceExecute(WorkFlowManagerImpl.java:253)[427:appc-workflow-management-core:1.3.0] at org.onap.appc.workflow.impl.WorkFlowManagerImpl.executeWorkflow(WorkFlowManagerImpl.java:156)[427:appc-workflow-management-core:1.3.0] at Proxye0f56a4a_780f_422c_a970_14594cb9e6b7.executeWorkflow(Unknown Source) at Proxy9242ccbb_5919_4c75_8811_d9485b845e33.executeWorkflow(Unknown Source) at org.onap.appc.executor.impl.CommandTask.run(CommandTask.java:117) at org.onap.appc.executionqueue.impl.QueueManager.lambda$enqueueTask$0(QueueManager.java:105) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)[:1.8.0_171] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)[:1.8.0_171] at java.lang.Thread.run(Thread.java:748)[:1.8.0_171] 2018-12-14 10:34:59,380 | INFO | ppc-dispatcher-7 | audit | 413 - appc-common - 1.3.0 - SvcLogicGraph [module=APPC, rpc=Generic_Restart, mode=sync, version=3.0.0, md5sum=9223fbd1e1a9645d78ba151289ae7c6e] - 10 (block) | APPC0090A Operation "Restart" for VNF type "b0ced82c-b549-4404-970c-ea39437d993b" from Source "664be3d2-6c12-4f4b-a3e7-c349acced2001" with RequestID "268a5e6d-3e8e-496c-b282-3c0a33be3c28" was started at "2018-12-14T10:34:58Z" and ended at "2018-12-14T10:34:59Z" with status code "200" -- *Regards,* Prakas P, Network and Technology IT, VDSI - Olympia – Chennai *VoIP: *72184* | Direct: *+91 44 4394 2184 *Mailto * *|* [email protected] <[email protected]> *We Are VERIZON <http://www.verizon.com/>* *INTEGRITY . RESPECT . PERFORMANCE EXCELLENCE . ACCOUNTABILITY <http://www.verizon.com/>* -=-=-=-=-=-=-=-=-=-=-=- Links: You receive all messages sent to this group. View/Reply Online (#14519): https://lists.onap.org/g/onap-discuss/message/14519 Mute This Topic: https://lists.onap.org/mt/28752573/21656 Group Owner: [email protected] Unsubscribe: https://lists.onap.org/g/onap-discuss/unsub [[email protected]] -=-=-=-=-=-=-=-=-=-=-=-
