blob: 7cd96d8bffcef934b3c756093e11cc3a3be85daf [file] [log] [blame]
khenaidoob9203542018-09-17 22:56:37 -04001/*
2 * Copyright 2018-present Open Networking Foundation
3
4 * Licensed under the Apache License, Version 2.0 (the "License");
5 * you may not use this file except in compliance with the License.
6 * You may obtain a copy of the License at
7
8 * http://www.apache.org/licenses/LICENSE-2.0
9
10 * Unless required by applicable law or agreed to in writing, software
11 * distributed under the License is distributed on an "AS IS" BASIS,
12 * WITHOUT WARRANTIES OR CONDITIONS OF ANY KIND, either express or implied.
13 * See the License for the specific language governing permissions and
14 * limitations under the License.
15 */
npujar1d86a522019-11-14 17:11:16 +053016
Kent Hagerman2b216042020-04-03 18:28:56 -040017package device
khenaidoob9203542018-09-17 22:56:37 -040018
19import (
20 "context"
Matteo Scandolo360605d2019-11-05 18:29:17 -080021 "encoding/hex"
Kent Hagerman4f355f52020-03-30 16:01:33 -040022 "errors"
khenaidoo3ab34882019-05-02 21:33:30 -040023 "fmt"
Mahir Gunyelb0343bf2021-05-11 14:14:26 -070024 "reflect"
25 "sync"
26 "time"
27
Maninder0aabf0c2021-03-17 14:55:14 +053028 "github.com/cenkalti/backoff/v3"
Maninder9a1bc0d2020-10-26 11:34:02 +053029 "github.com/gogo/protobuf/proto"
30 "github.com/golang/protobuf/ptypes"
31 "github.com/golang/protobuf/ptypes/empty"
Maninder0aabf0c2021-03-17 14:55:14 +053032 "github.com/opencord/voltha-go/rw_core/config"
Maninder9a1bc0d2020-10-26 11:34:02 +053033 "google.golang.org/grpc/codes"
34 "google.golang.org/grpc/status"
Mahir Gunyeladdb66a2020-04-29 18:08:50 -070035
Himani Chawla2ba1c9c2020-10-07 13:19:03 +053036 "github.com/opencord/voltha-go/db/model"
Kent Hagerman2b216042020-04-03 18:28:56 -040037 "github.com/opencord/voltha-go/rw_core/core/adapter"
Mahir Gunyel03de0d32020-06-03 01:36:59 -070038 "github.com/opencord/voltha-go/rw_core/core/device/flow"
39 "github.com/opencord/voltha-go/rw_core/core/device/group"
Kent Hagerman2a07b862020-06-19 15:23:07 -040040 "github.com/opencord/voltha-go/rw_core/core/device/port"
Kent Hagerman2b216042020-04-03 18:28:56 -040041 "github.com/opencord/voltha-go/rw_core/core/device/remote"
Himani Chawla2ba1c9c2020-10-07 13:19:03 +053042 "github.com/opencord/voltha-go/rw_core/core/device/transientstate"
Scott Bakerb671a862019-10-24 10:53:40 -070043 coreutils "github.com/opencord/voltha-go/rw_core/utils"
yasin sapli5458a1c2021-06-14 22:24:38 +000044 "github.com/opencord/voltha-lib-go/v5/pkg/kafka"
45 "github.com/opencord/voltha-lib-go/v5/pkg/log"
Maninder9a1bc0d2020-10-26 11:34:02 +053046 "github.com/opencord/voltha-protos/v4/go/common"
Salman Siddiqui1cf95042020-11-19 00:42:56 +053047 "github.com/opencord/voltha-protos/v4/go/extension"
Maninderdfadc982020-10-28 14:04:33 +053048 ic "github.com/opencord/voltha-protos/v4/go/inter_container"
49 ofp "github.com/opencord/voltha-protos/v4/go/openflow_13"
50 "github.com/opencord/voltha-protos/v4/go/voltha"
khenaidoob9203542018-09-17 22:56:37 -040051)
52
Kent Hagerman2b216042020-04-03 18:28:56 -040053// Agent represents device agent attributes
54type Agent struct {
Maninder0aabf0c2021-03-17 14:55:14 +053055 deviceID string
56 parentID string
57 deviceType string
58 isRootDevice bool
59 adapterProxy *remote.AdapterProxy
60 adapterMgr *adapter.Manager
61 deviceMgr *Manager
62 dbProxy *model.Proxy
63 exitChannel chan int
64 device *voltha.Device
65 requestQueue *coreutils.RequestQueue
66 defaultTimeout time.Duration
67 startOnce sync.Once
68 stopOnce sync.Once
69 stopped bool
70 stopReconciling chan int
71 stopReconcilingMutex sync.RWMutex
72 config *config.RWCoreFlags
Mahir Gunyel03de0d32020-06-03 01:36:59 -070073
khenaidoo7585a962021-06-10 16:15:38 -040074 flowCache *flow.Cache
75 groupCache *group.Cache
Himani Chawla2ba1c9c2020-10-07 13:19:03 +053076 portLoader *port.Loader
77 transientStateLoader *transientstate.Loader
khenaidoob9203542018-09-17 22:56:37 -040078}
79
Kent Hagerman2b216042020-04-03 18:28:56 -040080//newAgent creates a new device agent. The device will be initialized when start() is called.
Kent Hagerman2a07b862020-06-19 15:23:07 -040081func newAgent(ap *remote.AdapterProxy, device *voltha.Device, deviceMgr *Manager, dbPath *model.Path, deviceProxy *model.Proxy, timeout time.Duration) *Agent {
82 deviceID := device.Id
83 if deviceID == "" {
84 deviceID = coreutils.CreateDeviceID()
Stephane Barbarie1ab43272018-12-08 21:42:13 -050085 }
Scott Baker80678602019-11-14 16:57:36 -080086
Kent Hagerman2a07b862020-06-19 15:23:07 -040087 return &Agent{
Himani Chawla2ba1c9c2020-10-07 13:19:03 +053088 deviceID: deviceID,
89 adapterProxy: ap,
90 isRootDevice: device.Root,
91 parentID: device.ParentId,
92 deviceType: device.Type,
93 deviceMgr: deviceMgr,
94 adapterMgr: deviceMgr.adapterMgr,
95 exitChannel: make(chan int, 1),
96 dbProxy: deviceProxy,
97 defaultTimeout: timeout,
98 device: proto.Clone(device).(*voltha.Device),
99 requestQueue: coreutils.NewRequestQueue(),
Maninder0aabf0c2021-03-17 14:55:14 +0530100 config: deviceMgr.config,
khenaidoo7585a962021-06-10 16:15:38 -0400101 flowCache: flow.NewCache(),
102 groupCache: group.NewCache(),
Himani Chawla2ba1c9c2020-10-07 13:19:03 +0530103 portLoader: port.NewLoader(dbPath.SubPath("ports").Proxy(deviceID)),
104 transientStateLoader: transientstate.NewLoader(dbPath.SubPath("core").Proxy("transientstate"), deviceID),
Kent Hagerman2a07b862020-06-19 15:23:07 -0400105 }
khenaidoob9203542018-09-17 22:56:37 -0400106}
107
khenaidoo442e7c72020-03-10 16:13:48 -0400108// start() saves the device to the data model and registers for callbacks on that device if deviceToCreate!=nil.
109// Otherwise, it will load the data from the dB and setup the necessary callbacks and proxies. Returns the device that
Scott Baker80678602019-11-14 16:57:36 -0800110// was started.
khenaidoo7585a962021-06-10 16:15:38 -0400111func (agent *Agent) start(ctx context.Context, deviceExist bool, deviceToCreate *voltha.Device) (*voltha.Device, error) {
khenaidoo442e7c72020-03-10 16:13:48 -0400112 needToStart := false
113 if agent.startOnce.Do(func() { needToStart = true }); !needToStart {
Kent Hagermancba2f302020-07-28 13:37:36 -0400114 return agent.getDeviceReadOnly(ctx)
khenaidoo442e7c72020-03-10 16:13:48 -0400115 }
116 var startSucceeded bool
117 defer func() {
118 if !startSucceeded {
119 if err := agent.stop(ctx); err != nil {
Rohan Agrawal31f21802020-06-12 05:38:46 +0000120 logger.Errorw(ctx, "failed-to-cleanup-after-unsuccessful-start", log.Fields{"device-id": agent.deviceID, "error": err})
khenaidoo442e7c72020-03-10 16:13:48 -0400121 }
122 }
123 }()
khenaidoo7585a962021-06-10 16:15:38 -0400124 if deviceExist {
125 device := deviceToCreate
126 if device == nil {
127 // Load from dB
128 device = &voltha.Device{}
129 have, err := agent.dbProxy.Get(ctx, agent.deviceID, device)
130 if err != nil {
131 return nil, err
132 } else if !have {
133 return nil, status.Errorf(codes.NotFound, "device-%s", agent.deviceID)
134 }
Thomas Lee Se5a44012019-11-07 20:32:24 +0530135 }
Kent Hagerman4f355f52020-03-30 16:01:33 -0400136 agent.deviceType = device.Adapter
137 agent.device = proto.Clone(device).(*voltha.Device)
khenaidoo7585a962021-06-10 16:15:38 -0400138 // load the ports from KV to cache
Kent Hagerman2a07b862020-06-19 15:23:07 -0400139 agent.portLoader.Load(ctx)
Himani Chawla2ba1c9c2020-10-07 13:19:03 +0530140 agent.transientStateLoader.Load(ctx)
Kent Hagerman4f355f52020-03-30 16:01:33 -0400141
Himani Chawlab4c25912020-11-12 17:16:38 +0530142 logger.Infow(ctx, "device-loaded-from-db", log.Fields{"device-id": agent.deviceID})
khenaidoo297cd252019-02-07 22:10:23 -0500143 } else {
Scott Baker80678602019-11-14 16:57:36 -0800144 // Create a new device
Maninder9a1bc0d2020-10-26 11:34:02 +0530145 var desc string
146 prevState := common.AdminState_UNKNOWN
147 currState := common.AdminState_UNKNOWN
148 operStatus := &common.OperationResp{Code: common.OperationResp_OPERATION_FAILURE}
149
150 defer agent.logDeviceUpdate(ctx, "createDevice", &prevState, &currState, operStatus, &desc)
151
Kent Hagermanf5a67352020-04-30 15:15:26 -0400152 // Assumption is that AdminState, FlowGroups, and Flows are uninitialized since this
153 // is a new device, so populate them here before passing the device to ldProxy.Set.
Kent Hagerman2b216042020-04-03 18:28:56 -0400154 // agent.deviceId will also have been set during newAgent().
khenaidoo7585a962021-06-10 16:15:38 -0400155 device := (proto.Clone(deviceToCreate)).(*voltha.Device)
npujar1d86a522019-11-14 17:11:16 +0530156 device.Id = agent.deviceID
Scott Baker80678602019-11-14 16:57:36 -0800157 device.AdminState = voltha.AdminState_PREPROVISIONED
Maninder9a1bc0d2020-10-26 11:34:02 +0530158 currState = device.AdminState
Scott Baker80678602019-11-14 16:57:36 -0800159 if !deviceToCreate.GetRoot() && deviceToCreate.ProxyAddress != nil {
160 // Set the default vlan ID to the one specified by the parent adapter. It can be
161 // overwritten by the child adapter during a device update request
162 device.Vlan = deviceToCreate.ProxyAddress.ChannelId
163 }
164
khenaidoo297cd252019-02-07 22:10:23 -0500165 // Add the initial device to the local model
Kent Hagermanf5a67352020-04-30 15:15:26 -0400166 if err := agent.dbProxy.Set(ctx, agent.deviceID, device); err != nil {
Maninder9a1bc0d2020-10-26 11:34:02 +0530167 desc = fmt.Sprintf("failed-adding-device-%s: %s", agent.deviceID, err.Error())
Kent Hagerman4f355f52020-03-30 16:01:33 -0400168 return nil, status.Errorf(codes.Aborted, "failed-adding-device-%s: %s", agent.deviceID, err)
khenaidoo297cd252019-02-07 22:10:23 -0500169 }
Mahir Gunyelb0343bf2021-05-11 14:14:26 -0700170 _ = agent.deviceMgr.Agent.SendDeviceStateChangeEvent(ctx, device.OperStatus, device.ConnectStatus, prevState, device, time.Now().Unix())
Maninder9a1bc0d2020-10-26 11:34:02 +0530171 operStatus.Code = common.OperationResp_OPERATION_SUCCESS
khenaidoo442e7c72020-03-10 16:13:48 -0400172 agent.device = device
khenaidoob9203542018-09-17 22:56:37 -0400173 }
khenaidoo442e7c72020-03-10 16:13:48 -0400174 startSucceeded = true
Rohan Agrawalcf12f202020-08-03 04:42:01 +0000175 log.EnrichSpan(ctx, log.Fields{"device-id": agent.deviceID})
Rohan Agrawal31f21802020-06-12 05:38:46 +0000176 logger.Debugw(ctx, "device-agent-started", log.Fields{"device-id": agent.deviceID})
khenaidoo442e7c72020-03-10 16:13:48 -0400177
Kent Hagermancba2f302020-07-28 13:37:36 -0400178 return agent.getDeviceReadOnly(ctx)
khenaidoob9203542018-09-17 22:56:37 -0400179}
180
khenaidoo4d4802d2018-10-04 21:59:49 -0400181// stop stops the device agent. Not much to do for now
Kent Hagerman2b216042020-04-03 18:28:56 -0400182func (agent *Agent) stop(ctx context.Context) error {
khenaidoo442e7c72020-03-10 16:13:48 -0400183 needToStop := false
184 if agent.stopOnce.Do(func() { needToStop = true }); !needToStop {
185 return nil
186 }
187 if err := agent.requestQueue.WaitForGreenLight(ctx); err != nil {
188 return err
189 }
190 defer agent.requestQueue.RequestComplete()
khenaidoo49085352020-01-13 19:15:43 -0500191
Himani Chawlab4c25912020-11-12 17:16:38 +0530192 logger.Infow(ctx, "stopping-device-agent", log.Fields{"device-id": agent.deviceID, "parent-id": agent.parentID})
Himani Chawla2ba1c9c2020-10-07 13:19:03 +0530193 // Remove the device transient loader
194 if err := agent.deleteTransientState(ctx); err != nil {
195 return err
196 }
khenaidoo0a822f92019-05-08 15:15:57 -0400197 // Remove the device from the KV store
Kent Hagermanf5a67352020-04-30 15:15:26 -0400198 if err := agent.dbProxy.Remove(ctx, agent.deviceID); err != nil {
khenaidoo442e7c72020-03-10 16:13:48 -0400199 return err
Thomas Lee Se5a44012019-11-07 20:32:24 +0530200 }
khenaidoo442e7c72020-03-10 16:13:48 -0400201
khenaidoo442e7c72020-03-10 16:13:48 -0400202 close(agent.exitChannel)
203
204 agent.stopped = true
205
Rohan Agrawal31f21802020-06-12 05:38:46 +0000206 logger.Infow(ctx, "device-agent-stopped", log.Fields{"device-id": agent.deviceID, "parent-id": agent.parentID})
khenaidoo442e7c72020-03-10 16:13:48 -0400207
208 return nil
khenaidoob9203542018-09-17 22:56:37 -0400209}
210
Scott Baker80678602019-11-14 16:57:36 -0800211// Load the most recent state from the KVStore for the device.
Kent Hagerman2b216042020-04-03 18:28:56 -0400212func (agent *Agent) reconcileWithKVStore(ctx context.Context) {
khenaidoo442e7c72020-03-10 16:13:48 -0400213 if err := agent.requestQueue.WaitForGreenLight(ctx); err != nil {
Rohan Agrawal31f21802020-06-12 05:38:46 +0000214 logger.Warnw(ctx, "request-aborted", log.Fields{"device-id": agent.deviceID, "error": err})
khenaidoo442e7c72020-03-10 16:13:48 -0400215 return
216 }
217 defer agent.requestQueue.RequestComplete()
Rohan Agrawal31f21802020-06-12 05:38:46 +0000218 logger.Debug(ctx, "reconciling-device-agent-devicetype")
Scott Baker80678602019-11-14 16:57:36 -0800219 // TODO: context timeout
Kent Hagerman4f355f52020-03-30 16:01:33 -0400220 device := &voltha.Device{}
Kent Hagermanf5a67352020-04-30 15:15:26 -0400221 if have, err := agent.dbProxy.Get(ctx, agent.deviceID, device); err != nil {
Rohan Agrawal31f21802020-06-12 05:38:46 +0000222 logger.Errorw(ctx, "kv-get-failed", log.Fields{"device-id": agent.deviceID, "error": err})
Thomas Lee Se5a44012019-11-07 20:32:24 +0530223 return
Kent Hagerman4f355f52020-03-30 16:01:33 -0400224 } else if !have {
225 return // not found in kv
Thomas Lee Se5a44012019-11-07 20:32:24 +0530226 }
Kent Hagerman4f355f52020-03-30 16:01:33 -0400227
228 agent.deviceType = device.Adapter
229 agent.device = device
Kent Hagerman2a07b862020-06-19 15:23:07 -0400230 agent.portLoader.Load(ctx)
Himani Chawla2ba1c9c2020-10-07 13:19:03 +0530231 agent.transientStateLoader.Load(ctx)
232
Rohan Agrawal31f21802020-06-12 05:38:46 +0000233 logger.Debugw(ctx, "reconciled-device-agent-devicetype", log.Fields{"device-id": agent.deviceID, "type": agent.deviceType})
Scott Baker80678602019-11-14 16:57:36 -0800234}
235
khenaidoo442e7c72020-03-10 16:13:48 -0400236// onSuccess is a common callback for scenarios where we receive a nil response following a request to an adapter
237// and the only action required is to publish a successful result on kafka
Rohan Agrawal31f21802020-06-12 05:38:46 +0000238func (agent *Agent) onSuccess(ctx context.Context, rpc string, response interface{}, reqArgs ...interface{}) {
Himani Chawla2ba1c9c2020-10-07 13:19:03 +0530239 logger.Debugw(ctx, "response-successful", log.Fields{"rpc": rpc, "device-id": agent.deviceID})
khenaidoo442e7c72020-03-10 16:13:48 -0400240 // TODO: Post success message onto kafka
241}
242
243// onFailure is a common callback for scenarios where we receive an error response following a request to an adapter
244// and the only action required is to publish the failed result on kafka
Rohan Agrawal31f21802020-06-12 05:38:46 +0000245func (agent *Agent) onFailure(ctx context.Context, rpc string, response interface{}, reqArgs ...interface{}) {
khenaidoo442e7c72020-03-10 16:13:48 -0400246 if res, ok := response.(error); ok {
Rohan Agrawal31f21802020-06-12 05:38:46 +0000247 logger.Errorw(ctx, "rpc-failed", log.Fields{"rpc": rpc, "device-id": agent.deviceID, "error": res, "args": reqArgs})
khenaidoo442e7c72020-03-10 16:13:48 -0400248 } else {
Rohan Agrawal31f21802020-06-12 05:38:46 +0000249 logger.Errorw(ctx, "rpc-failed-invalid-error", log.Fields{"rpc": rpc, "device-id": agent.deviceID, "args": reqArgs})
khenaidoo442e7c72020-03-10 16:13:48 -0400250 }
251 // TODO: Post failure message onto kafka
252}
253
Himani Chawlab4c25912020-11-12 17:16:38 +0530254func (agent *Agent) waitForAdapterForceDeleteResponse(ctx context.Context, cancel context.CancelFunc, rpc string, ch chan *kafka.RpcResponse,
khenaidoo442e7c72020-03-10 16:13:48 -0400255 onSuccess coreutils.ResponseCallback, onFailure coreutils.ResponseCallback, reqArgs ...interface{}) {
256 defer cancel()
257 select {
258 case rpcResponse, ok := <-ch:
259 if !ok {
Rohan Agrawal31f21802020-06-12 05:38:46 +0000260 onFailure(ctx, rpc, status.Errorf(codes.Aborted, "channel-closed"), reqArgs)
khenaidoo442e7c72020-03-10 16:13:48 -0400261 } else if rpcResponse.Err != nil {
Rohan Agrawal31f21802020-06-12 05:38:46 +0000262 onFailure(ctx, rpc, rpcResponse.Err, reqArgs)
khenaidoo442e7c72020-03-10 16:13:48 -0400263 } else {
Rohan Agrawal31f21802020-06-12 05:38:46 +0000264 onSuccess(ctx, rpc, rpcResponse.Reply, reqArgs)
khenaidoo442e7c72020-03-10 16:13:48 -0400265 }
266 case <-ctx.Done():
Rohan Agrawal31f21802020-06-12 05:38:46 +0000267 onFailure(ctx, rpc, ctx.Err(), reqArgs)
khenaidoo442e7c72020-03-10 16:13:48 -0400268 }
269}
270
Himani Chawla2ba1c9c2020-10-07 13:19:03 +0530271// onDeleteSuccess is a common callback for scenarios where we receive a nil response following a delete request
272// to an adapter.
273func (agent *Agent) onDeleteSuccess(ctx context.Context, rpc string, response interface{}, reqArgs ...interface{}) {
274 logger.Debugw(ctx, "response-successful", log.Fields{"rpc": rpc, "device-id": agent.deviceID})
275 if err := agent.requestQueue.WaitForGreenLight(ctx); err != nil {
276 logger.Errorw(ctx, "delete-device-failure", log.Fields{"device-id": agent.deviceID, "error": err, "args": reqArgs})
277 }
278 previousDeviceTransientState := agent.getTransientState()
279 newDevice := agent.cloneDeviceWithoutLock()
280 if err := agent.updateDeviceWithTransientStateAndReleaseLock(ctx, newDevice,
281 voltha.DeviceTransientState_DELETING_POST_ADAPTER_RESPONSE, previousDeviceTransientState); err != nil {
282 logger.Errorw(ctx, "delete-device-failure", log.Fields{"device-id": agent.deviceID, "error": err, "args": reqArgs})
283 }
284}
285
286// onDeleteFailure is a common callback for scenarios where we receive an error response following a delete request
287// to an adapter and the only action required is to return the error response.
288func (agent *Agent) onDeleteFailure(ctx context.Context, rpc string, response interface{}, reqArgs ...interface{}) {
289 if res, ok := response.(error); ok {
290 logger.Errorw(ctx, "rpc-failed", log.Fields{"rpc": rpc, "device-id": agent.deviceID, "error": res, "args": reqArgs})
291 } else {
292 logger.Errorw(ctx, "rpc-failed-invalid-error", log.Fields{"rpc": rpc, "device-id": agent.deviceID, "args": reqArgs})
293 }
294 //Only updating of transient state is required, no transition.
295 if err := agent.updateTransientState(ctx, voltha.DeviceTransientState_DELETE_FAILED); err != nil {
296 logger.Errorw(ctx, "failed-to-update-transient-state-as-delete-failed", log.Fields{"device-id": agent.deviceID})
297 }
298
299}
300
Himani Chawlab4c25912020-11-12 17:16:38 +0530301func (agent *Agent) waitForAdapterResponse(ctx context.Context, cancel context.CancelFunc, rpc string, ch chan *kafka.RpcResponse,
Himani Chawla2ba1c9c2020-10-07 13:19:03 +0530302 onSuccess coreutils.ResponseCallback, onFailure coreutils.ResponseCallback, reqArgs ...interface{}) {
303 defer cancel()
Himani Chawlab4c25912020-11-12 17:16:38 +0530304 var rpce *voltha.RPCEvent
305 defer func() {
306 if rpce != nil {
Himani Chawla606a4f02021-03-23 19:45:58 +0530307 agent.deviceMgr.SendRPCEvent(ctx, "RPC_ERROR_RAISE_EVENT", rpce,
308 voltha.EventCategory_COMMUNICATION, nil, time.Now().Unix())
Himani Chawlab4c25912020-11-12 17:16:38 +0530309 }
310 }()
Himani Chawla2ba1c9c2020-10-07 13:19:03 +0530311 select {
312 case rpcResponse, ok := <-ch:
313 if !ok {
Himani Chawlab4c25912020-11-12 17:16:38 +0530314 rpce = agent.deviceMgr.NewRPCEvent(ctx, agent.deviceID, "Response Channel Closed", nil)
Himani Chawla2ba1c9c2020-10-07 13:19:03 +0530315 onFailure(ctx, rpc, status.Errorf(codes.Aborted, "channel-closed"), reqArgs)
Himani Chawlab4c25912020-11-12 17:16:38 +0530316 //add failure
Himani Chawla2ba1c9c2020-10-07 13:19:03 +0530317 } else if rpcResponse.Err != nil {
Himani Chawlab4c25912020-11-12 17:16:38 +0530318 rpce = agent.deviceMgr.NewRPCEvent(ctx, agent.deviceID, rpcResponse.Err.Error(), nil)
Himani Chawla2ba1c9c2020-10-07 13:19:03 +0530319 onFailure(ctx, rpc, rpcResponse.Err, reqArgs)
Himani Chawlab4c25912020-11-12 17:16:38 +0530320 //add failure
Himani Chawla2ba1c9c2020-10-07 13:19:03 +0530321 } else {
322 onSuccess(ctx, rpc, rpcResponse.Reply, reqArgs)
323 }
324 case <-ctx.Done():
Himani Chawlab4c25912020-11-12 17:16:38 +0530325 rpce = agent.deviceMgr.NewRPCEvent(ctx, agent.deviceID, ctx.Err().Error(), nil)
Himani Chawla2ba1c9c2020-10-07 13:19:03 +0530326 onFailure(ctx, rpc, ctx.Err(), reqArgs)
327 }
328}
329
Maninder9a1bc0d2020-10-26 11:34:02 +0530330func (agent *Agent) waitForAdapterResponseAndLogDeviceUpdate(ctx context.Context, cancel context.CancelFunc, rpc string, ch chan *kafka.RpcResponse,
331 onSuccess coreutils.ResponseCallback, onFailure coreutils.ResponseCallback, prevState *common.AdminState_Types, reqArgs ...interface{}) {
332 defer cancel()
333 var desc string
334 operStatus := &common.OperationResp{Code: common.OperationResp_OPERATION_FAILURE}
khenaidoodd3324d2021-04-27 16:22:55 -0400335 defer func() {
336 currAdminState := prevState
337 if d, _ := agent.getDeviceReadOnly(ctx); d != nil {
338 currAdminState = &d.AdminState
339 }
340 agent.logDeviceUpdate(ctx, rpc, prevState, currAdminState, operStatus, &desc)
341 }()
Maninder9a1bc0d2020-10-26 11:34:02 +0530342 var rpce *voltha.RPCEvent
343 defer func() {
344 if rpce != nil {
Himani Chawla606a4f02021-03-23 19:45:58 +0530345 agent.deviceMgr.SendRPCEvent(ctx, "RPC_ERROR_RAISE_EVENT", rpce,
346 voltha.EventCategory_COMMUNICATION, nil, time.Now().Unix())
Maninder9a1bc0d2020-10-26 11:34:02 +0530347 }
348 }()
349
350 select {
351 case rpcResponse, ok := <-ch:
352 if !ok {
353 rpce = agent.deviceMgr.NewRPCEvent(ctx, agent.deviceID, "Response Channel Closed", nil)
354 onFailure(ctx, rpc, status.Errorf(codes.Aborted, "channel-closed"), reqArgs)
355 //add failure
356 } else if rpcResponse.Err != nil {
357 desc = rpcResponse.Err.Error()
358 rpce = agent.deviceMgr.NewRPCEvent(ctx, agent.deviceID, desc, nil)
359 onFailure(ctx, rpc, rpcResponse.Err, reqArgs)
360 //add failure
361 } else {
362 operStatus.Code = common.OperationResp_OPERATION_SUCCESS
363 onSuccess(ctx, rpc, rpcResponse.Reply, reqArgs)
364 }
365 case <-ctx.Done():
366 desc = ctx.Err().Error()
367 rpce = agent.deviceMgr.NewRPCEvent(ctx, agent.deviceID, desc, nil)
368 onFailure(ctx, rpc, ctx.Err(), reqArgs)
369 }
370}
371
Kent Hagermancba2f302020-07-28 13:37:36 -0400372// getDeviceReadOnly returns a device which MUST NOT be modified, but is safe to keep forever.
373func (agent *Agent) getDeviceReadOnly(ctx context.Context) (*voltha.Device, error) {
khenaidoo442e7c72020-03-10 16:13:48 -0400374 if err := agent.requestQueue.WaitForGreenLight(ctx); err != nil {
375 return nil, err
376 }
377 defer agent.requestQueue.RequestComplete()
Kent Hagermancba2f302020-07-28 13:37:36 -0400378 return agent.device, nil
khenaidoo92e62c52018-10-03 14:02:54 -0400379}
380
Kent Hagermancba2f302020-07-28 13:37:36 -0400381// getDeviceReadOnlyWithoutLock returns a device which MUST NOT be modified, but is safe to keep forever. This is very efficient.
Kent Hagermanf6db9f12020-07-22 17:16:19 -0400382// The device lock MUST be held by the caller.
Kent Hagermancba2f302020-07-28 13:37:36 -0400383func (agent *Agent) getDeviceReadOnlyWithoutLock() *voltha.Device {
khenaidoo0db4c812020-05-27 15:27:30 -0400384 return agent.device
khenaidoo92e62c52018-10-03 14:02:54 -0400385}
386
Kent Hagermanf6db9f12020-07-22 17:16:19 -0400387// cloneDeviceWithoutLock returns a copy of the device which is safe to modify.
388// The device lock MUST be held by the caller.
389func (agent *Agent) cloneDeviceWithoutLock() *voltha.Device {
390 return proto.Clone(agent.device).(*voltha.Device)
391}
392
khenaidoo3ab34882019-05-02 21:33:30 -0400393// enableDevice activates a preprovisioned or a disable device
Kent Hagerman2b216042020-04-03 18:28:56 -0400394func (agent *Agent) enableDevice(ctx context.Context) error {
Maninder9a1bc0d2020-10-26 11:34:02 +0530395 //To preserve and use oldDevice state as prev state in new device
Maninder9a1bc0d2020-10-26 11:34:02 +0530396 var desc string
397 operStatus := &common.OperationResp{Code: common.OperationResp_OPERATION_FAILURE}
398
399 defer agent.logDeviceUpdate(ctx, "enableDevice", nil, nil, operStatus, &desc)
400
khenaidoo442e7c72020-03-10 16:13:48 -0400401 if err := agent.requestQueue.WaitForGreenLight(ctx); err != nil {
402 return err
403 }
Himani Chawlab4c25912020-11-12 17:16:38 +0530404 logger.Debugw(ctx, "enable-device", log.Fields{"device-id": agent.deviceID})
khenaidoo21d51152019-02-01 13:48:37 -0500405
khenaidoodd3324d2021-04-27 16:22:55 -0400406 prevDeviceState := agent.device.AdminState
407
Kent Hagermancba2f302020-07-28 13:37:36 -0400408 oldDevice := agent.getDeviceReadOnlyWithoutLock()
Maninder9a1bc0d2020-10-26 11:34:02 +0530409
Kent Hagermanf6db9f12020-07-22 17:16:19 -0400410 if oldDevice.AdminState == voltha.AdminState_ENABLED {
411 logger.Warnw(ctx, "device-already-enabled", log.Fields{"device-id": agent.deviceID})
412 agent.requestQueue.RequestComplete()
Maninder9a1bc0d2020-10-26 11:34:02 +0530413 desc = fmt.Sprintf("cannot-enable-an-already-enabled-device: %s", oldDevice.Id)
414 return status.Error(codes.FailedPrecondition, desc)
Kent Hagermanf6db9f12020-07-22 17:16:19 -0400415 }
Maninder0aabf0c2021-03-17 14:55:14 +0530416 if !agent.proceedWithRequestNoLock() {
Kent Hagermanf6db9f12020-07-22 17:16:19 -0400417 agent.requestQueue.RequestComplete()
Maninder9a1bc0d2020-10-26 11:34:02 +0530418
Maninder581cf4b2021-06-16 22:42:07 +0530419 desc = fmt.Sprintf("deviceId:%s, Cannot complete operation as Device deletion/reconciling is in progress or reconcile failed.", agent.deviceID)
Maninder9a1bc0d2020-10-26 11:34:02 +0530420 return status.Error(codes.FailedPrecondition, desc)
Kent Hagermanf6db9f12020-07-22 17:16:19 -0400421 }
npujar1d86a522019-11-14 17:11:16 +0530422 // First figure out which adapter will handle this device type. We do it at this stage as allow devices to be
khenaidoo442e7c72020-03-10 16:13:48 -0400423 // pre-provisioned with the required adapter not registered. At this stage, since we need to communicate
npujar1d86a522019-11-14 17:11:16 +0530424 // with the adapter then we need to know the adapter that will handle this request
Kent Hagermanf6db9f12020-07-22 17:16:19 -0400425 adapterName, err := agent.adapterMgr.GetAdapterType(oldDevice.Type)
npujar1d86a522019-11-14 17:11:16 +0530426 if err != nil {
Kent Hagermanf6db9f12020-07-22 17:16:19 -0400427 agent.requestQueue.RequestComplete()
Maninder9a1bc0d2020-10-26 11:34:02 +0530428 desc = err.Error()
Matteo Scandolod525ae32020-04-02 17:27:29 -0700429 return err
npujar1d86a522019-11-14 17:11:16 +0530430 }
431
Kent Hagermanf6db9f12020-07-22 17:16:19 -0400432 newDevice := agent.cloneDeviceWithoutLock()
433 newDevice.Adapter = adapterName
npujar1d86a522019-11-14 17:11:16 +0530434
Kent Hagermanf6db9f12020-07-22 17:16:19 -0400435 // Update the Admin State and set the operational state to activating before sending the request to the Adapters
436 newDevice.AdminState = voltha.AdminState_ENABLED
437 newDevice.OperStatus = voltha.OperStatus_ACTIVATING
Maninder9a1bc0d2020-10-26 11:34:02 +0530438
Kent Hagermanf6db9f12020-07-22 17:16:19 -0400439 if err := agent.updateDeviceAndReleaseLock(ctx, newDevice); err != nil {
Maninder9a1bc0d2020-10-26 11:34:02 +0530440 desc = err.Error()
npujar1d86a522019-11-14 17:11:16 +0530441 return err
442 }
443
khenaidoo442e7c72020-03-10 16:13:48 -0400444 // Adopt the device if it was in pre-provision state. In all other cases, try to re-enable it.
khenaidoo442e7c72020-03-10 16:13:48 -0400445 var ch chan *kafka.RpcResponse
Rohan Agrawalcf12f202020-08-03 04:42:01 +0000446 subCtx, cancel := context.WithTimeout(log.WithSpanFromContext(context.Background(), ctx), agent.defaultTimeout)
Himani Chawlab4c25912020-11-12 17:16:38 +0530447 subCtx = coreutils.WithRPCMetadataFromContext(subCtx, ctx)
Maninder9a1bc0d2020-10-26 11:34:02 +0530448 subCtx = coreutils.WithFromTopicMetadataFromContext(subCtx, ctx)
Himani Chawlab4c25912020-11-12 17:16:38 +0530449
Kent Hagermanf6db9f12020-07-22 17:16:19 -0400450 if oldDevice.AdminState == voltha.AdminState_PREPROVISIONED {
451 ch, err = agent.adapterProxy.AdoptDevice(subCtx, newDevice)
khenaidoob9203542018-09-17 22:56:37 -0400452 } else {
Kent Hagermanf6db9f12020-07-22 17:16:19 -0400453 ch, err = agent.adapterProxy.ReEnableDevice(subCtx, newDevice)
khenaidoob9203542018-09-17 22:56:37 -0400454 }
khenaidoo442e7c72020-03-10 16:13:48 -0400455 if err != nil {
456 cancel()
Maninder9a1bc0d2020-10-26 11:34:02 +0530457 desc = err.Error()
khenaidoo442e7c72020-03-10 16:13:48 -0400458 return err
459 }
Maninder9a1bc0d2020-10-26 11:34:02 +0530460
461 operStatus.Code = common.OperationResp_OPERATION_IN_PROGRESS
462
khenaidoo442e7c72020-03-10 16:13:48 -0400463 // Wait for response
Maninder9a1bc0d2020-10-26 11:34:02 +0530464 go agent.waitForAdapterResponseAndLogDeviceUpdate(subCtx, cancel, "enableDevice", ch, agent.onSuccess, agent.onFailure, &prevDeviceState)
khenaidoob9203542018-09-17 22:56:37 -0400465 return nil
466}
467
Maninder9a1bc0d2020-10-26 11:34:02 +0530468func (agent *Agent) waitForAdapterFlowResponse(ctx context.Context, cancel context.CancelFunc, rpc string, ch chan *kafka.RpcResponse, response coreutils.Response) {
khenaidoo442e7c72020-03-10 16:13:48 -0400469 defer cancel()
Maninder9a1bc0d2020-10-26 11:34:02 +0530470 var desc string
471 operStatus := &common.OperationResp{Code: common.OperationResp_OPERATION_FAILURE}
472 defer agent.logDeviceUpdate(ctx, rpc, nil, nil, operStatus, &desc)
473
Himani Chawlab4c25912020-11-12 17:16:38 +0530474 var rpce *voltha.RPCEvent
475 defer func() {
476 if rpce != nil {
Himani Chawla606a4f02021-03-23 19:45:58 +0530477 agent.deviceMgr.SendRPCEvent(ctx, "RPC_ERROR_RAISE_EVENT", rpce,
478 voltha.EventCategory_COMMUNICATION, nil, time.Now().Unix())
Himani Chawlab4c25912020-11-12 17:16:38 +0530479 }
480 }()
khenaidoo442e7c72020-03-10 16:13:48 -0400481 select {
482 case rpcResponse, ok := <-ch:
483 if !ok {
Himani Chawlab4c25912020-11-12 17:16:38 +0530484 //add failure
Maninder9a1bc0d2020-10-26 11:34:02 +0530485 desc = "Response Channel Closed"
Himani Chawlab4c25912020-11-12 17:16:38 +0530486 rpce = agent.deviceMgr.NewRPCEvent(ctx, agent.deviceID, "Response Channel Closed", nil)
khenaidoo442e7c72020-03-10 16:13:48 -0400487 response.Error(status.Errorf(codes.Aborted, "channel-closed"))
488 } else if rpcResponse.Err != nil {
Himani Chawlab4c25912020-11-12 17:16:38 +0530489 //add failure
Maninder9a1bc0d2020-10-26 11:34:02 +0530490 desc = rpcResponse.Err.Error()
491 rpce = agent.deviceMgr.NewRPCEvent(ctx, agent.deviceID, desc, nil)
khenaidoo442e7c72020-03-10 16:13:48 -0400492 response.Error(rpcResponse.Err)
493 } else {
Maninder9a1bc0d2020-10-26 11:34:02 +0530494 operStatus.Code = common.OperationResp_OPERATION_SUCCESS
khenaidoo442e7c72020-03-10 16:13:48 -0400495 response.Done()
496 }
497 case <-ctx.Done():
Maninder9a1bc0d2020-10-26 11:34:02 +0530498 desc = ctx.Err().Error()
499 rpce = agent.deviceMgr.NewRPCEvent(ctx, agent.deviceID, desc, nil)
khenaidoo442e7c72020-03-10 16:13:48 -0400500 response.Error(ctx.Err())
khenaidoo2c6a0992019-04-29 13:46:56 -0400501 }
khenaidoo2c6a0992019-04-29 13:46:56 -0400502}
503
A R Karthick5c28f552019-12-11 22:47:44 -0800504//addFlowsAndGroups adds the "newFlows" and "newGroups" from the existing flows/groups and sends the update to the
505//adapters
Kent Hagerman2b216042020-04-03 18:28:56 -0400506func (agent *Agent) addFlowsAndGroups(ctx context.Context, newFlows []*ofp.OfpFlowStats, newGroups []*ofp.OfpGroupEntry, flowMetadata *voltha.FlowMetadata) error {
Mahir Gunyel03de0d32020-06-03 01:36:59 -0700507 var flwResponse, grpResponse coreutils.Response
508 var err error
509 //if new flow list is empty then the called function returns quickly
510 if flwResponse, err = agent.addFlowsToAdapter(ctx, newFlows, flowMetadata); err != nil {
A R Karthick5c28f552019-12-11 22:47:44 -0800511 return err
512 }
Mahir Gunyel03de0d32020-06-03 01:36:59 -0700513 //if new group list is empty then the called function returns quickly
514 if grpResponse, err = agent.addGroupsToAdapter(ctx, newGroups, flowMetadata); err != nil {
515 return err
516 }
517 if errs := coreutils.WaitForNilOrErrorResponses(agent.defaultTimeout, flwResponse, grpResponse); errs != nil {
Rohan Agrawal31f21802020-06-12 05:38:46 +0000518 logger.Warnw(ctx, "no-adapter-response", log.Fields{"device-id": agent.deviceID, "result": errs})
khenaidoo442e7c72020-03-10 16:13:48 -0400519 return status.Errorf(codes.Aborted, "flow-failure-device-%s", agent.deviceID)
khenaidoo0458db62019-06-20 08:50:36 -0400520 }
khenaidoo0458db62019-06-20 08:50:36 -0400521 return nil
522}
523
A R Karthick5c28f552019-12-11 22:47:44 -0800524//deleteFlowsAndGroups removes the "flowsToDel" and "groupsToDel" from the existing flows/groups and sends the update to the
525//adapters
Kent Hagerman2b216042020-04-03 18:28:56 -0400526func (agent *Agent) deleteFlowsAndGroups(ctx context.Context, flowsToDel []*ofp.OfpFlowStats, groupsToDel []*ofp.OfpGroupEntry, flowMetadata *voltha.FlowMetadata) error {
Mahir Gunyel03de0d32020-06-03 01:36:59 -0700527 var flwResponse, grpResponse coreutils.Response
528 var err error
529 if flwResponse, err = agent.deleteFlowsFromAdapter(ctx, flowsToDel, flowMetadata); err != nil {
A R Karthick5c28f552019-12-11 22:47:44 -0800530 return err
531 }
Mahir Gunyel03de0d32020-06-03 01:36:59 -0700532 if grpResponse, err = agent.deleteGroupsFromAdapter(ctx, groupsToDel, flowMetadata); err != nil {
533 return err
534 }
535
536 if res := coreutils.WaitForNilOrErrorResponses(agent.defaultTimeout, flwResponse, grpResponse); res != nil {
khenaidoo0458db62019-06-20 08:50:36 -0400537 return status.Errorf(codes.Aborted, "errors-%s", res)
538 }
539 return nil
khenaidoo0458db62019-06-20 08:50:36 -0400540}
541
A R Karthick5c28f552019-12-11 22:47:44 -0800542//updateFlowsAndGroups replaces the existing flows and groups with "updatedFlows" and "updatedGroups" respectively. It
543//also sends the updates to the adapters
Kent Hagerman2b216042020-04-03 18:28:56 -0400544func (agent *Agent) updateFlowsAndGroups(ctx context.Context, updatedFlows []*ofp.OfpFlowStats, updatedGroups []*ofp.OfpGroupEntry, flowMetadata *voltha.FlowMetadata) error {
Mahir Gunyel03de0d32020-06-03 01:36:59 -0700545 var flwResponse, grpResponse coreutils.Response
546 var err error
547 if flwResponse, err = agent.updateFlowsToAdapter(ctx, updatedFlows, flowMetadata); err != nil {
A R Karthick5c28f552019-12-11 22:47:44 -0800548 return err
549 }
Mahir Gunyel03de0d32020-06-03 01:36:59 -0700550 if grpResponse, err = agent.updateGroupsToAdapter(ctx, updatedGroups, flowMetadata); err != nil {
551 return err
552 }
553
554 if res := coreutils.WaitForNilOrErrorResponses(agent.defaultTimeout, flwResponse, grpResponse); res != nil {
khenaidoo0458db62019-06-20 08:50:36 -0400555 return status.Errorf(codes.Aborted, "errors-%s", res)
556 }
557 return nil
khenaidoo19d7b632018-10-30 10:49:50 -0400558}
559
khenaidoo4d4802d2018-10-04 21:59:49 -0400560//disableDevice disable a device
Kent Hagerman2b216042020-04-03 18:28:56 -0400561func (agent *Agent) disableDevice(ctx context.Context) error {
Maninder9a1bc0d2020-10-26 11:34:02 +0530562 var desc string
563 operStatus := &common.OperationResp{Code: common.OperationResp_OPERATION_FAILURE}
564
565 prevDeviceState := agent.device.AdminState
566
567 defer agent.logDeviceUpdate(ctx, "disableDevice", nil, nil, operStatus, &desc)
568
khenaidoo442e7c72020-03-10 16:13:48 -0400569 if err := agent.requestQueue.WaitForGreenLight(ctx); err != nil {
Maninder9a1bc0d2020-10-26 11:34:02 +0530570 desc = err.Error()
khenaidoo442e7c72020-03-10 16:13:48 -0400571 return err
572 }
Himani Chawlab4c25912020-11-12 17:16:38 +0530573 logger.Debugw(ctx, "disable-device", log.Fields{"device-id": agent.deviceID})
khenaidoo6e55d9e2019-12-12 18:26:26 -0500574
Kent Hagermanf6db9f12020-07-22 17:16:19 -0400575 cloned := agent.cloneDeviceWithoutLock()
khenaidoo6e55d9e2019-12-12 18:26:26 -0500576
577 if cloned.AdminState == voltha.AdminState_DISABLED {
Maninder9a1bc0d2020-10-26 11:34:02 +0530578 desc = "device-already-disabled"
divyadesaicb8b59d2020-08-18 09:55:47 +0000579 logger.Debugw(ctx, "device-already-disabled", log.Fields{"device-id": agent.deviceID})
Kent Hagermanf6db9f12020-07-22 17:16:19 -0400580 agent.requestQueue.RequestComplete()
npujar1d86a522019-11-14 17:11:16 +0530581 return nil
582 }
Himani Chawla2ba1c9c2020-10-07 13:19:03 +0530583 if cloned.AdminState == voltha.AdminState_PREPROVISIONED {
Kent Hagermanf6db9f12020-07-22 17:16:19 -0400584 agent.requestQueue.RequestComplete()
Maninder9a1bc0d2020-10-26 11:34:02 +0530585 desc = fmt.Sprintf("deviceId:%s, invalid-admin-state:%s", agent.deviceID, cloned.AdminState)
khenaidoo6e55d9e2019-12-12 18:26:26 -0500586 return status.Errorf(codes.FailedPrecondition, "deviceId:%s, invalid-admin-state:%s", agent.deviceID, cloned.AdminState)
npujar1d86a522019-11-14 17:11:16 +0530587 }
Maninder0aabf0c2021-03-17 14:55:14 +0530588
589 if !agent.proceedWithRequestNoLock() {
Himani Chawla2ba1c9c2020-10-07 13:19:03 +0530590 agent.requestQueue.RequestComplete()
Maninder581cf4b2021-06-16 22:42:07 +0530591 desc = fmt.Sprintf("deviceId:%s,Cannot complete operation as Device deletion/reconciling is in progress or reconcile failed.", agent.deviceID)
592 return status.Errorf(codes.FailedPrecondition, desc)
Himani Chawla2ba1c9c2020-10-07 13:19:03 +0530593 }
Maninder0aabf0c2021-03-17 14:55:14 +0530594
npujar1d86a522019-11-14 17:11:16 +0530595 // Update the Admin State and operational state before sending the request out
Kent Hagermanf6db9f12020-07-22 17:16:19 -0400596 cloned.AdminState = voltha.AdminState_DISABLED
597 cloned.OperStatus = voltha.OperStatus_UNKNOWN
Maninder9a1bc0d2020-10-26 11:34:02 +0530598
Kent Hagermanf6db9f12020-07-22 17:16:19 -0400599 if err := agent.updateDeviceAndReleaseLock(ctx, cloned); err != nil {
npujar1d86a522019-11-14 17:11:16 +0530600 return err
601 }
khenaidoo442e7c72020-03-10 16:13:48 -0400602
Rohan Agrawalcf12f202020-08-03 04:42:01 +0000603 subCtx, cancel := context.WithTimeout(log.WithSpanFromContext(context.Background(), ctx), agent.defaultTimeout)
Himani Chawlab4c25912020-11-12 17:16:38 +0530604 subCtx = coreutils.WithRPCMetadataFromContext(subCtx, ctx)
605
Kent Hagermanf6db9f12020-07-22 17:16:19 -0400606 ch, err := agent.adapterProxy.DisableDevice(subCtx, cloned)
khenaidoo442e7c72020-03-10 16:13:48 -0400607 if err != nil {
608 cancel()
Maninder9a1bc0d2020-10-26 11:34:02 +0530609 desc = err.Error()
npujar1d86a522019-11-14 17:11:16 +0530610 return err
khenaidoo0a822f92019-05-08 15:15:57 -0400611 }
Maninder9a1bc0d2020-10-26 11:34:02 +0530612 operStatus.Code = common.OperationResp_OPERATION_IN_PROGRESS
613
614 // Wait for response
615 go agent.waitForAdapterResponseAndLogDeviceUpdate(subCtx, cancel, "disableDevice", ch, agent.onSuccess, agent.onFailure, &prevDeviceState)
khenaidoo0a822f92019-05-08 15:15:57 -0400616
khenaidoo92e62c52018-10-03 14:02:54 -0400617 return nil
618}
619
Kent Hagerman2b216042020-04-03 18:28:56 -0400620func (agent *Agent) rebootDevice(ctx context.Context) error {
Maninder9a1bc0d2020-10-26 11:34:02 +0530621 var desc string
622 operStatus := &common.OperationResp{Code: common.OperationResp_OPERATION_FAILURE}
623
624 prevDeviceState := agent.device.AdminState
625
626 defer agent.logDeviceUpdate(ctx, "rebootDevice", nil, nil, operStatus, &desc)
627
khenaidoo442e7c72020-03-10 16:13:48 -0400628 if err := agent.requestQueue.WaitForGreenLight(ctx); err != nil {
Maninder9a1bc0d2020-10-26 11:34:02 +0530629 desc = err.Error()
npujar1d86a522019-11-14 17:11:16 +0530630 return err
khenaidoo4d4802d2018-10-04 21:59:49 -0400631 }
khenaidoo442e7c72020-03-10 16:13:48 -0400632 defer agent.requestQueue.RequestComplete()
Himani Chawlab4c25912020-11-12 17:16:38 +0530633 logger.Debugw(ctx, "reboot-device", log.Fields{"device-id": agent.deviceID})
khenaidoo442e7c72020-03-10 16:13:48 -0400634
Kent Hagermancba2f302020-07-28 13:37:36 -0400635 device := agent.getDeviceReadOnlyWithoutLock()
Maninder0aabf0c2021-03-17 14:55:14 +0530636 if !agent.proceedWithRequestNoLock() {
Maninder581cf4b2021-06-16 22:42:07 +0530637 desc = fmt.Sprintf("deviceId:%s, Cannot complete operation as Device deletion/reconciling is in progress or reconcile failed.", agent.deviceID)
638 return status.Errorf(codes.FailedPrecondition, desc)
Himani Chawla2ba1c9c2020-10-07 13:19:03 +0530639 }
Rohan Agrawalcf12f202020-08-03 04:42:01 +0000640 subCtx, cancel := context.WithTimeout(log.WithSpanFromContext(context.Background(), ctx), agent.defaultTimeout)
Himani Chawlab4c25912020-11-12 17:16:38 +0530641 subCtx = coreutils.WithRPCMetadataFromContext(subCtx, ctx)
642
Kent Hagerman2b216042020-04-03 18:28:56 -0400643 ch, err := agent.adapterProxy.RebootDevice(subCtx, device)
khenaidoo442e7c72020-03-10 16:13:48 -0400644 if err != nil {
645 cancel()
Maninder9a1bc0d2020-10-26 11:34:02 +0530646 desc = err.Error()
khenaidoo442e7c72020-03-10 16:13:48 -0400647 return err
648 }
Maninder9a1bc0d2020-10-26 11:34:02 +0530649 operStatus.Code = common.OperationResp_OPERATION_IN_PROGRESS
650
651 // Wait for response
652 go agent.waitForAdapterResponseAndLogDeviceUpdate(subCtx, cancel, "rebootDevice", ch, agent.onSuccess, agent.onFailure, &prevDeviceState)
khenaidoo4d4802d2018-10-04 21:59:49 -0400653 return nil
654}
655
Himani Chawla2ba1c9c2020-10-07 13:19:03 +0530656func (agent *Agent) deleteDeviceForce(ctx context.Context) error {
Himani Chawlab4c25912020-11-12 17:16:38 +0530657 logger.Debugw(ctx, "delete-device-force", log.Fields{"device-id": agent.deviceID})
Maninder9a1bc0d2020-10-26 11:34:02 +0530658
659 var desc string
660 operStatus := &common.OperationResp{Code: common.OperationResp_OPERATION_FAILURE}
661
Himani Chawla2ba1c9c2020-10-07 13:19:03 +0530662 if err := agent.requestQueue.WaitForGreenLight(ctx); err != nil {
Maninder9a1bc0d2020-10-26 11:34:02 +0530663 desc = err.Error()
664 agent.logDeviceUpdate(ctx, "deleteDeviceForce", nil, nil, operStatus, &desc)
Himani Chawla2ba1c9c2020-10-07 13:19:03 +0530665 return err
666 }
667 // Get the device Transient state, return err if it is DELETING
668 previousDeviceTransientState := agent.getTransientState()
669
670 if agent.isStateDeleting(previousDeviceTransientState) {
671 agent.requestQueue.RequestComplete()
Maninder9a1bc0d2020-10-26 11:34:02 +0530672 desc = fmt.Sprintf("deviceId:%s, Device Deletion is in progress",
Himani Chawla2ba1c9c2020-10-07 13:19:03 +0530673 agent.deviceID)
Maninder9a1bc0d2020-10-26 11:34:02 +0530674 agent.logDeviceUpdate(ctx, "deleteDeviceForce", nil, nil, operStatus, &desc)
675 return status.Error(codes.FailedPrecondition, desc)
Himani Chawla2ba1c9c2020-10-07 13:19:03 +0530676 }
Maninder0aabf0c2021-03-17 14:55:14 +0530677
678 //Send stop Reconcile if in progress
679 agent.stopReconcile()
680
Himani Chawla2ba1c9c2020-10-07 13:19:03 +0530681 device := agent.cloneDeviceWithoutLock()
Himani Chawlab4c25912020-11-12 17:16:38 +0530682 if err := agent.updateDeviceWithTransientStateAndReleaseLock(ctx, device,
683 voltha.DeviceTransientState_FORCE_DELETING, previousDeviceTransientState); err != nil {
Himani Chawla2ba1c9c2020-10-07 13:19:03 +0530684 return err
685 }
686 previousAdminState := device.AdminState
687 if previousAdminState != ic.AdminState_PREPROVISIONED {
688 subCtx, cancel := context.WithTimeout(log.WithSpanFromContext(context.Background(), ctx), agent.defaultTimeout)
Himani Chawlab4c25912020-11-12 17:16:38 +0530689 subCtx = coreutils.WithRPCMetadataFromContext(subCtx, ctx)
690
Himani Chawla2ba1c9c2020-10-07 13:19:03 +0530691 ch, err := agent.adapterProxy.DeleteDevice(subCtx, device)
692 if err != nil {
693 cancel()
Maninder9a1bc0d2020-10-26 11:34:02 +0530694 desc = err.Error()
695 agent.logDeviceUpdate(ctx, "deleteDeviceForce", nil, nil, operStatus, &desc)
Himani Chawla2ba1c9c2020-10-07 13:19:03 +0530696 return err
697 }
Maninder9a1bc0d2020-10-26 11:34:02 +0530698 // As force delete will not be dependent over the response of adapter, marking this operation as success
699 operStatus.Code = common.OperationResp_OPERATION_SUCCESS
700 agent.logDeviceUpdate(ctx, "deleteDeviceForce", nil, nil, operStatus, &desc)
Himani Chawla2ba1c9c2020-10-07 13:19:03 +0530701 // Since it is a case of force delete, nothing needs to be done on adapter responses.
Himani Chawlab4c25912020-11-12 17:16:38 +0530702 go agent.waitForAdapterForceDeleteResponse(subCtx, cancel, "deleteDeviceForce", ch, agent.onSuccess,
Himani Chawla2ba1c9c2020-10-07 13:19:03 +0530703 agent.onFailure)
704 }
705 return nil
706}
707
Kent Hagerman2b216042020-04-03 18:28:56 -0400708func (agent *Agent) deleteDevice(ctx context.Context) error {
Himani Chawlab4c25912020-11-12 17:16:38 +0530709 logger.Debugw(ctx, "delete-device", log.Fields{"device-id": agent.deviceID})
Maninder9a1bc0d2020-10-26 11:34:02 +0530710
711 var desc string
712 operStatus := &common.OperationResp{Code: common.OperationResp_OPERATION_FAILURE}
713 prevState := agent.device.AdminState
714
715 defer agent.logDeviceUpdate(ctx, "deleteDevice", nil, nil, operStatus, &desc)
716
khenaidoo442e7c72020-03-10 16:13:48 -0400717 if err := agent.requestQueue.WaitForGreenLight(ctx); err != nil {
Maninder9a1bc0d2020-10-26 11:34:02 +0530718 desc = err.Error()
khenaidoo442e7c72020-03-10 16:13:48 -0400719 return err
720 }
Maninder0aabf0c2021-03-17 14:55:14 +0530721
Maninder581cf4b2021-06-16 22:42:07 +0530722 if agent.isInReconcileState() {
Maninder0aabf0c2021-03-17 14:55:14 +0530723 agent.requestQueue.RequestComplete()
Maninder581cf4b2021-06-16 22:42:07 +0530724 desc = fmt.Sprintf("deviceId:%s, Cannot complete operation as Reconciling is in progress or failed", agent.deviceID)
Maninder0aabf0c2021-03-17 14:55:14 +0530725 return status.Error(codes.FailedPrecondition, desc)
726 }
727
Himani Chawla2ba1c9c2020-10-07 13:19:03 +0530728 // Get the device Transient state, return err if it is DELETING
729 previousDeviceTransientState := agent.getTransientState()
khenaidoo6e55d9e2019-12-12 18:26:26 -0500730
Himani Chawla2ba1c9c2020-10-07 13:19:03 +0530731 if agent.isStateDeleting(previousDeviceTransientState) {
732 agent.requestQueue.RequestComplete()
Maninder9a1bc0d2020-10-26 11:34:02 +0530733 desc = fmt.Sprintf("deviceId:%s, Device Deletion is in progress", agent.deviceID)
734 return status.Error(codes.FailedPrecondition, desc)
Himani Chawla2ba1c9c2020-10-07 13:19:03 +0530735 }
736 device := agent.cloneDeviceWithoutLock()
737 previousAdminState := device.AdminState
738 // Change the device transient state to DELETING_FROM_ADAPTER state till the device is removed from adapters.
739 currentDeviceTransientState := voltha.DeviceTransientState_DELETING_FROM_ADAPTER
khenaidoo442e7c72020-03-10 16:13:48 -0400740
Himani Chawla2ba1c9c2020-10-07 13:19:03 +0530741 if previousAdminState == ic.AdminState_PREPROVISIONED {
742 // Change the state to DELETING POST ADAPTER RESPONSE directly as adapters have no info of the device.
743 currentDeviceTransientState = voltha.DeviceTransientState_DELETING_POST_ADAPTER_RESPONSE
744 }
Himani Chawlab4c25912020-11-12 17:16:38 +0530745 if err := agent.updateDeviceWithTransientStateAndReleaseLock(ctx, device,
746 currentDeviceTransientState, previousDeviceTransientState); err != nil {
Maninder9a1bc0d2020-10-26 11:34:02 +0530747 desc = err.Error()
npujar1d86a522019-11-14 17:11:16 +0530748 return err
749 }
khenaidoo442e7c72020-03-10 16:13:48 -0400750 // If the device was in pre-prov state (only parent device are in that state) then do not send the request to the
751 // adapter
Himani Chawla2ba1c9c2020-10-07 13:19:03 +0530752 if previousAdminState != ic.AdminState_PREPROVISIONED {
Rohan Agrawalcf12f202020-08-03 04:42:01 +0000753 subCtx, cancel := context.WithTimeout(log.WithSpanFromContext(context.Background(), ctx), agent.defaultTimeout)
Himani Chawlab4c25912020-11-12 17:16:38 +0530754 subCtx = coreutils.WithRPCMetadataFromContext(subCtx, ctx)
755
Himani Chawla2ba1c9c2020-10-07 13:19:03 +0530756 ch, err := agent.adapterProxy.DeleteDevice(subCtx, device)
khenaidoo442e7c72020-03-10 16:13:48 -0400757 if err != nil {
758 cancel()
Himani Chawla2ba1c9c2020-10-07 13:19:03 +0530759 //updating of transient state is required in error
760 if err := agent.updateTransientState(ctx, voltha.DeviceTransientState_DELETE_FAILED); err != nil {
761 logger.Errorw(ctx, "failed-to-update-transient-state-as-delete-failed", log.Fields{"device-id": agent.deviceID})
762 }
Maninder9a1bc0d2020-10-26 11:34:02 +0530763 desc = err.Error()
khenaidoo442e7c72020-03-10 16:13:48 -0400764 return err
765 }
Maninder9a1bc0d2020-10-26 11:34:02 +0530766
767 operStatus.Code = common.OperationResp_OPERATION_IN_PROGRESS
768 go agent.waitForAdapterResponseAndLogDeviceUpdate(subCtx, cancel, "deleteDevice", ch, agent.onDeleteSuccess,
769 agent.onDeleteFailure, &prevState)
khenaidoo442e7c72020-03-10 16:13:48 -0400770 }
khenaidoo4d4802d2018-10-04 21:59:49 -0400771 return nil
772}
773
Kent Hagerman2b216042020-04-03 18:28:56 -0400774func (agent *Agent) setParentID(ctx context.Context, device *voltha.Device, parentID string) error {
khenaidoo442e7c72020-03-10 16:13:48 -0400775 if err := agent.requestQueue.WaitForGreenLight(ctx); err != nil {
776 return err
777 }
Himani Chawlab4c25912020-11-12 17:16:38 +0530778 logger.Debugw(ctx, "set-parent-id", log.Fields{"device-id": device.Id, "parent-id": parentID})
khenaidoo6e55d9e2019-12-12 18:26:26 -0500779
Kent Hagermanf6db9f12020-07-22 17:16:19 -0400780 cloned := agent.cloneDeviceWithoutLock()
npujar1d86a522019-11-14 17:11:16 +0530781 cloned.ParentId = parentID
Kent Hagermanf6db9f12020-07-22 17:16:19 -0400782 return agent.updateDeviceAndReleaseLock(ctx, cloned)
khenaidooad06fd72019-10-28 12:26:05 -0400783}
784
khenaidoo442e7c72020-03-10 16:13:48 -0400785// getSwitchCapability retrieves the switch capability of a parent device
Kent Hagerman2b216042020-04-03 18:28:56 -0400786func (agent *Agent) getSwitchCapability(ctx context.Context) (*ic.SwitchCapability, error) {
Himani Chawlab4c25912020-11-12 17:16:38 +0530787 logger.Debugw(ctx, "get-switch-capability", log.Fields{"device-id": agent.deviceID})
khenaidoo442e7c72020-03-10 16:13:48 -0400788
Kent Hagermancba2f302020-07-28 13:37:36 -0400789 device, err := agent.getDeviceReadOnly(ctx)
khenaidoo442e7c72020-03-10 16:13:48 -0400790 if err != nil {
khenaidoob9203542018-09-17 22:56:37 -0400791 return nil, err
khenaidoob9203542018-09-17 22:56:37 -0400792 }
Kent Hagermancba2f302020-07-28 13:37:36 -0400793 ch, err := agent.adapterProxy.GetOfpDeviceInfo(ctx, device)
khenaidoo442e7c72020-03-10 16:13:48 -0400794 if err != nil {
795 return nil, err
796 }
797
798 // Wait for adapter response
799 rpcResponse, ok := <-ch
800 if !ok {
801 return nil, status.Errorf(codes.Aborted, "channel-closed")
802 }
803 if rpcResponse.Err != nil {
804 return nil, rpcResponse.Err
805 }
806 // Successful response
807 switchCap := &ic.SwitchCapability{}
808 if err := ptypes.UnmarshalAny(rpcResponse.Reply, switchCap); err != nil {
npujar1d86a522019-11-14 17:11:16 +0530809 return nil, err
810 }
811 return switchCap, nil
khenaidoob9203542018-09-17 22:56:37 -0400812}
813
Rohan Agrawal31f21802020-06-12 05:38:46 +0000814func (agent *Agent) onPacketFailure(ctx context.Context, rpc string, response interface{}, args ...interface{}) {
khenaidoo442e7c72020-03-10 16:13:48 -0400815 // packet data is encoded in the args param as the first parameter
816 var packet []byte
817 if len(args) >= 1 {
818 if pkt, ok := args[0].([]byte); ok {
819 packet = pkt
820 }
821 }
822 var errResp error
823 if err, ok := response.(error); ok {
824 errResp = err
825 }
Rohan Agrawal31f21802020-06-12 05:38:46 +0000826 logger.Warnw(ctx, "packet-out-error", log.Fields{
khenaidoo442e7c72020-03-10 16:13:48 -0400827 "device-id": agent.deviceID,
828 "error": errResp,
829 "packet": hex.EncodeToString(packet),
830 })
831}
832
Kent Hagerman2b216042020-04-03 18:28:56 -0400833func (agent *Agent) packetOut(ctx context.Context, outPort uint32, packet *ofp.OfpPacketOut) error {
Scott Baker80678602019-11-14 16:57:36 -0800834 // If deviceType=="" then we must have taken ownership of this device.
835 // Fixes VOL-2226 where a core would take ownership and have stale data
836 if agent.deviceType == "" {
npujar467fe752020-01-16 20:17:45 +0530837 agent.reconcileWithKVStore(ctx)
Scott Baker80678602019-11-14 16:57:36 -0800838 }
khenaidoofdbad6e2018-11-06 22:26:38 -0500839 // Send packet to adapter
Rohan Agrawalcf12f202020-08-03 04:42:01 +0000840 subCtx, cancel := context.WithTimeout(log.WithSpanFromContext(context.Background(), ctx), agent.defaultTimeout)
Himani Chawlab4c25912020-11-12 17:16:38 +0530841 subCtx = coreutils.WithRPCMetadataFromContext(subCtx, ctx)
842
Kent Hagerman2b216042020-04-03 18:28:56 -0400843 ch, err := agent.adapterProxy.PacketOut(subCtx, agent.deviceType, agent.deviceID, outPort, packet)
khenaidoo442e7c72020-03-10 16:13:48 -0400844 if err != nil {
845 cancel()
846 return nil
khenaidoofdbad6e2018-11-06 22:26:38 -0500847 }
khenaidoo442e7c72020-03-10 16:13:48 -0400848 go agent.waitForAdapterResponse(subCtx, cancel, "packetOut", ch, agent.onSuccess, agent.onPacketFailure, packet.Data)
khenaidoofdbad6e2018-11-06 22:26:38 -0500849 return nil
850}
851
Kent Hagermanf6db9f12020-07-22 17:16:19 -0400852func (agent *Agent) updateDeviceUsingAdapterData(ctx context.Context, device *voltha.Device) error {
853 if err := agent.requestQueue.WaitForGreenLight(ctx); err != nil {
854 return err
855 }
Himani Chawlab4c25912020-11-12 17:16:38 +0530856 logger.Debugw(ctx, "update-device-using-adapter-data", log.Fields{"device-id": device.Id})
Kent Hagermanf6db9f12020-07-22 17:16:19 -0400857
858 cloned := agent.cloneDeviceWithoutLock()
Mahir Gunyel8e2707d2019-07-25 00:36:21 -0700859 cloned.Root = device.Root
860 cloned.Vendor = device.Vendor
861 cloned.Model = device.Model
862 cloned.SerialNumber = device.SerialNumber
863 cloned.MacAddress = device.MacAddress
864 cloned.Vlan = device.Vlan
865 cloned.Reason = device.Reason
Andrea Campanella025667e2021-01-14 11:50:07 +0100866 cloned.ImageDownloads = device.ImageDownloads
Kent Hagermanf6db9f12020-07-22 17:16:19 -0400867 return agent.updateDeviceAndReleaseLock(ctx, cloned)
khenaidoo43c82122018-11-22 18:38:28 -0500868}
869
Kent Hagerman2b216042020-04-03 18:28:56 -0400870func (agent *Agent) updateDeviceStatus(ctx context.Context, operStatus voltha.OperStatus_Types, connStatus voltha.ConnectStatus_Types) error {
khenaidoo442e7c72020-03-10 16:13:48 -0400871 if err := agent.requestQueue.WaitForGreenLight(ctx); err != nil {
872 return err
873 }
khenaidoo6e55d9e2019-12-12 18:26:26 -0500874
Kent Hagermanf6db9f12020-07-22 17:16:19 -0400875 cloned := agent.cloneDeviceWithoutLock()
npujar1d86a522019-11-14 17:11:16 +0530876 // Ensure the enums passed in are valid - they will be invalid if they are not set when this function is invoked
Kent Hagermanf6db9f12020-07-22 17:16:19 -0400877 if s, ok := voltha.ConnectStatus_Types_name[int32(connStatus)]; ok {
Himani Chawlab4c25912020-11-12 17:16:38 +0530878 logger.Debugw(ctx, "update-device-status-conn", log.Fields{"ok": ok, "val": s})
Kent Hagermanf6db9f12020-07-22 17:16:19 -0400879 cloned.ConnectStatus = connStatus
npujar1d86a522019-11-14 17:11:16 +0530880 }
Kent Hagermanf6db9f12020-07-22 17:16:19 -0400881 if s, ok := voltha.OperStatus_Types_name[int32(operStatus)]; ok {
Himani Chawlab4c25912020-11-12 17:16:38 +0530882 logger.Debugw(ctx, "update-device-status-conn", log.Fields{"ok": ok, "val": s})
Kent Hagermanf6db9f12020-07-22 17:16:19 -0400883 cloned.OperStatus = operStatus
npujar1d86a522019-11-14 17:11:16 +0530884 }
Himani Chawlab4c25912020-11-12 17:16:38 +0530885 logger.Debugw(ctx, "update-device-status", log.Fields{"device-id": cloned.Id, "oper-status": cloned.OperStatus, "connect-status": cloned.ConnectStatus})
npujar1d86a522019-11-14 17:11:16 +0530886 // Store the device
Kent Hagermanf6db9f12020-07-22 17:16:19 -0400887 return agent.updateDeviceAndReleaseLock(ctx, cloned)
khenaidoo92e62c52018-10-03 14:02:54 -0400888}
889
khenaidoob9203542018-09-17 22:56:37 -0400890// TODO: A generic device update by attribute
Kent Hagerman2b216042020-04-03 18:28:56 -0400891func (agent *Agent) updateDeviceAttribute(ctx context.Context, name string, value interface{}) {
khenaidoob9203542018-09-17 22:56:37 -0400892 if value == nil {
893 return
894 }
khenaidoo6e55d9e2019-12-12 18:26:26 -0500895
Kent Hagermanf6db9f12020-07-22 17:16:19 -0400896 if err := agent.requestQueue.WaitForGreenLight(ctx); err != nil {
897 logger.Warnw(ctx, "request-aborted", log.Fields{"device-id": agent.deviceID, "name": name, "error": err})
898 return
899 }
900
901 cloned := agent.cloneDeviceWithoutLock()
khenaidoob9203542018-09-17 22:56:37 -0400902 updated := false
khenaidoo6e55d9e2019-12-12 18:26:26 -0500903 s := reflect.ValueOf(cloned).Elem()
khenaidoob9203542018-09-17 22:56:37 -0400904 if s.Kind() == reflect.Struct {
905 // exported field
906 f := s.FieldByName(name)
907 if f.IsValid() && f.CanSet() {
908 switch f.Kind() {
909 case reflect.String:
910 f.SetString(value.(string))
911 updated = true
912 case reflect.Uint32:
913 f.SetUint(uint64(value.(uint32)))
914 updated = true
915 case reflect.Bool:
916 f.SetBool(value.(bool))
917 updated = true
918 }
919 }
920 }
divyadesaicb8b59d2020-08-18 09:55:47 +0000921 logger.Debugw(ctx, "update-field-status", log.Fields{"device-id": cloned.Id, "name": name, "updated": updated})
khenaidoob9203542018-09-17 22:56:37 -0400922 // Save the data
khenaidoo6e55d9e2019-12-12 18:26:26 -0500923
Kent Hagermanf6db9f12020-07-22 17:16:19 -0400924 if err := agent.updateDeviceAndReleaseLock(ctx, cloned); err != nil {
Rohan Agrawal31f21802020-06-12 05:38:46 +0000925 logger.Warnw(ctx, "attribute-update-failed", log.Fields{"attribute": name, "value": value})
khenaidoob9203542018-09-17 22:56:37 -0400926 }
khenaidoob9203542018-09-17 22:56:37 -0400927}
serkant.uluderya334479d2019-04-10 08:26:15 -0700928
Kent Hagerman45a13e42020-04-13 12:23:50 -0400929func (agent *Agent) simulateAlarm(ctx context.Context, simulateReq *voltha.SimulateAlarmRequest) error {
khenaidoo442e7c72020-03-10 16:13:48 -0400930 if err := agent.requestQueue.WaitForGreenLight(ctx); err != nil {
931 return err
932 }
933 defer agent.requestQueue.RequestComplete()
Himani Chawlab4c25912020-11-12 17:16:38 +0530934 logger.Debugw(ctx, "simulate-alarm", log.Fields{"device-id": agent.deviceID})
khenaidoo6e55d9e2019-12-12 18:26:26 -0500935
Kent Hagermancba2f302020-07-28 13:37:36 -0400936 device := agent.getDeviceReadOnlyWithoutLock()
khenaidoo6e55d9e2019-12-12 18:26:26 -0500937
Rohan Agrawalcf12f202020-08-03 04:42:01 +0000938 subCtx, cancel := context.WithTimeout(log.WithSpanFromContext(context.Background(), ctx), agent.defaultTimeout)
Himani Chawlab4c25912020-11-12 17:16:38 +0530939 subCtx = coreutils.WithRPCMetadataFromContext(subCtx, ctx)
940
Kent Hagermanf6db9f12020-07-22 17:16:19 -0400941 ch, err := agent.adapterProxy.SimulateAlarm(subCtx, device, simulateReq)
khenaidoo442e7c72020-03-10 16:13:48 -0400942 if err != nil {
943 cancel()
npujar1d86a522019-11-14 17:11:16 +0530944 return err
serkant.uluderya334479d2019-04-10 08:26:15 -0700945 }
khenaidoo442e7c72020-03-10 16:13:48 -0400946 go agent.waitForAdapterResponse(subCtx, cancel, "simulateAlarm", ch, agent.onSuccess, agent.onFailure)
serkant.uluderya334479d2019-04-10 08:26:15 -0700947 return nil
948}
Mahir Gunyelb5851672019-07-24 10:46:26 +0300949
Kent Hagermanf6db9f12020-07-22 17:16:19 -0400950// This function updates the device in the DB, releases the device lock, and runs any state transitions.
951// The calling function MUST hold the device lock. The caller MUST NOT modify the device after this is called.
952func (agent *Agent) updateDeviceAndReleaseLock(ctx context.Context, device *voltha.Device) error {
953 // fail early if this agent is no longer valid
Kent Hagerman4f355f52020-03-30 16:01:33 -0400954 if agent.stopped {
Kent Hagermanf6db9f12020-07-22 17:16:19 -0400955 agent.requestQueue.RequestComplete()
Himani Chawla2ba1c9c2020-10-07 13:19:03 +0530956 return errors.New("device-agent-stopped")
Thomas Lee Se5a44012019-11-07 20:32:24 +0530957 }
Kent Hagerman4f355f52020-03-30 16:01:33 -0400958
Kent Hagermanf6db9f12020-07-22 17:16:19 -0400959 // update in db
Kent Hagermanf5a67352020-04-30 15:15:26 -0400960 if err := agent.dbProxy.Set(ctx, agent.deviceID, device); err != nil {
Kent Hagermanf6db9f12020-07-22 17:16:19 -0400961 agent.requestQueue.RequestComplete()
Kent Hagerman4f355f52020-03-30 16:01:33 -0400962 return status.Errorf(codes.Internal, "failed-update-device:%s: %s", agent.deviceID, err)
Mahir Gunyelb5851672019-07-24 10:46:26 +0300963 }
divyadesaicb8b59d2020-08-18 09:55:47 +0000964 logger.Debugw(ctx, "updated-device-in-store", log.Fields{"device-id: ": agent.deviceID})
Mahir Gunyelb5851672019-07-24 10:46:26 +0300965
Kent Hagerman6031aad2020-07-29 16:36:33 -0400966 prevDevice := agent.device
Kent Hagermanf6db9f12020-07-22 17:16:19 -0400967 // update the device
khenaidoo0db4c812020-05-27 15:27:30 -0400968 agent.device = device
Mahir Gunyelb0343bf2021-05-11 14:14:26 -0700969 //If any of the states has chenged, send the change event.
970 if prevDevice.OperStatus != device.OperStatus || prevDevice.ConnectStatus != device.ConnectStatus || prevDevice.AdminState != device.AdminState {
971 _ = agent.deviceMgr.Agent.SendDeviceStateChangeEvent(ctx, prevDevice.OperStatus, prevDevice.ConnectStatus, prevDevice.AdminState, device, time.Now().Unix())
972 }
Maninder0aabf0c2021-03-17 14:55:14 +0530973 deviceTransientState := agent.getTransientState()
974
Kent Hagermanf6db9f12020-07-22 17:16:19 -0400975 // release lock before processing transition
976 agent.requestQueue.RequestComplete()
Himani Chawlab4c25912020-11-12 17:16:38 +0530977 subCtx := coreutils.WithSpanAndRPCMetadataFromContext(ctx)
Kent Hagermanf6db9f12020-07-22 17:16:19 -0400978
Himani Chawlab4c25912020-11-12 17:16:38 +0530979 if err := agent.deviceMgr.stateTransitions.ProcessTransition(subCtx,
Maninder0aabf0c2021-03-17 14:55:14 +0530980 device, prevDevice, deviceTransientState, deviceTransientState); err != nil {
Himani Chawlab4c25912020-11-12 17:16:38 +0530981 logger.Errorw(ctx, "failed-process-transition", log.Fields{"device-id": device.Id, "previous-admin-state": prevDevice.AdminState, "current-admin-state": device.AdminState})
982 // Sending RPC EVENT here
983 rpce := agent.deviceMgr.NewRPCEvent(ctx, agent.deviceID, err.Error(), nil)
Himani Chawla606a4f02021-03-23 19:45:58 +0530984 agent.deviceMgr.SendRPCEvent(ctx, "RPC_ERROR_RAISE_EVENT", rpce, voltha.EventCategory_COMMUNICATION,
985 nil, time.Now().Unix())
Himani Chawlab4c25912020-11-12 17:16:38 +0530986
Kent Hagermanf6db9f12020-07-22 17:16:19 -0400987 }
Mahir Gunyelb5851672019-07-24 10:46:26 +0300988 return nil
989}
Mahir Gunyelfdee9212019-10-16 16:52:21 -0700990
Himani Chawla2ba1c9c2020-10-07 13:19:03 +0530991// This function updates the device transient in the DB through loader, releases the device lock, and runs any state transitions.
992// The calling function MUST hold the device lock. The caller MUST NOT modify the device after this is called.
993func (agent *Agent) updateDeviceWithTransientStateAndReleaseLock(ctx context.Context, device *voltha.Device,
994 transientState, prevTransientState voltha.DeviceTransientState_Types) error {
995 // fail early if this agent is no longer valid
996 if agent.stopped {
997 agent.requestQueue.RequestComplete()
998 return errors.New("device-agent-stopped")
999 }
1000 //update device TransientState
1001 if err := agent.updateTransientState(ctx, transientState); err != nil {
1002 agent.requestQueue.RequestComplete()
1003 return err
1004 }
1005 // update in db
1006 if err := agent.dbProxy.Set(ctx, agent.deviceID, device); err != nil {
1007 //Reverting TransientState update
1008 err := agent.updateTransientState(ctx, prevTransientState)
1009 logger.Errorw(ctx, "failed-to-revert-transient-state-update-on-error", log.Fields{"device-id": device.Id,
Himani Chawlab4c25912020-11-12 17:16:38 +05301010 "previous-transient-state": prevTransientState, "current-transient-state": transientState})
Himani Chawla2ba1c9c2020-10-07 13:19:03 +05301011 agent.requestQueue.RequestComplete()
1012 return status.Errorf(codes.Internal, "failed-update-device:%s: %s", agent.deviceID, err)
1013 }
1014
1015 logger.Debugw(ctx, "updated-device-in-store", log.Fields{"device-id: ": agent.deviceID})
1016
1017 prevDevice := agent.device
1018 // update the device
1019 agent.device = device
Mahir Gunyelb0343bf2021-05-11 14:14:26 -07001020 //If any of the states has chenged, send the change event.
1021 if prevDevice.OperStatus != device.OperStatus || prevDevice.ConnectStatus != device.ConnectStatus || prevDevice.AdminState != device.AdminState {
1022 _ = agent.deviceMgr.Agent.SendDeviceStateChangeEvent(ctx, prevDevice.OperStatus, prevDevice.ConnectStatus, prevDevice.AdminState, device, time.Now().Unix())
1023 }
Himani Chawla2ba1c9c2020-10-07 13:19:03 +05301024
1025 // release lock before processing transition
1026 agent.requestQueue.RequestComplete()
Himani Chawlab4c25912020-11-12 17:16:38 +05301027 subCtx := coreutils.WithSpanAndRPCMetadataFromContext(ctx)
1028 if err := agent.deviceMgr.stateTransitions.ProcessTransition(subCtx,
Himani Chawla2ba1c9c2020-10-07 13:19:03 +05301029 device, prevDevice, transientState, prevTransientState); err != nil {
Himani Chawlab4c25912020-11-12 17:16:38 +05301030 logger.Errorw(ctx, "failed-process-transition", log.Fields{"device-id": device.Id, "previous-admin-state": prevDevice.AdminState, "current-admin-state": device.AdminState})
1031 // Sending RPC EVENT here
1032 rpce := agent.deviceMgr.NewRPCEvent(ctx, agent.deviceID, err.Error(), nil)
Himani Chawla606a4f02021-03-23 19:45:58 +05301033 agent.deviceMgr.SendRPCEvent(ctx, "RPC_ERROR_RAISE_EVENT", rpce, voltha.EventCategory_COMMUNICATION,
1034 nil, time.Now().Unix())
Himani Chawla2ba1c9c2020-10-07 13:19:03 +05301035 }
1036 return nil
1037}
Kent Hagerman2b216042020-04-03 18:28:56 -04001038func (agent *Agent) updateDeviceReason(ctx context.Context, reason string) error {
khenaidoo442e7c72020-03-10 16:13:48 -04001039 if err := agent.requestQueue.WaitForGreenLight(ctx); err != nil {
1040 return err
1041 }
Maninder9a1bc0d2020-10-26 11:34:02 +05301042
Himani Chawlab4c25912020-11-12 17:16:38 +05301043 logger.Debugw(ctx, "update-device-reason", log.Fields{"device-id": agent.deviceID, "reason": reason})
khenaidoo6e55d9e2019-12-12 18:26:26 -05001044
Maninder9a1bc0d2020-10-26 11:34:02 +05301045 var desc string
1046 operStatus := &common.OperationResp{Code: common.OperationResp_OPERATION_FAILURE}
1047
1048 defer agent.logDeviceUpdate(ctx, "updateDeviceReason", nil, nil, operStatus, &desc)
1049
Kent Hagermanf6db9f12020-07-22 17:16:19 -04001050 cloned := agent.cloneDeviceWithoutLock()
npujar1d86a522019-11-14 17:11:16 +05301051 cloned.Reason = reason
Maninder9a1bc0d2020-10-26 11:34:02 +05301052 retErr := agent.updateDeviceAndReleaseLock(ctx, cloned)
1053 if retErr != nil {
1054 desc = retErr.Error()
1055 } else {
1056 operStatus.Code = common.OperationResp_OPERATION_SUCCESS
1057 desc = reason
1058 }
1059 return retErr
Mahir Gunyelfdee9212019-10-16 16:52:21 -07001060}
kesavandbc2d1622020-01-21 00:42:01 -05001061
Kent Hagerman2b216042020-04-03 18:28:56 -04001062func (agent *Agent) ChildDeviceLost(ctx context.Context, device *voltha.Device) error {
Himani Chawlab4c25912020-11-12 17:16:38 +05301063 logger.Debugw(ctx, "child-device-lost", log.Fields{"child-device-id": device.Id, "parent-device-id": agent.deviceID})
Chaitrashree G S543df3e2020-02-24 22:36:54 -05001064
Kent Hagerman2a07b862020-06-19 15:23:07 -04001065 // Remove the associated peer ports on the parent device
1066 for portID := range agent.portLoader.ListIDs() {
1067 if portHandle, have := agent.portLoader.Lock(portID); have {
1068 oldPort := portHandle.GetReadOnly()
1069 updatedPeers := make([]*voltha.Port_PeerPort, 0)
1070 for _, peerPort := range oldPort.Peers {
1071 if peerPort.DeviceId != device.Id {
1072 updatedPeers = append(updatedPeers, peerPort)
1073 }
khenaidoo442e7c72020-03-10 16:13:48 -04001074 }
Kent Hagerman2a07b862020-06-19 15:23:07 -04001075 newPort := *oldPort
1076 newPort.Peers = updatedPeers
1077 if err := portHandle.Update(ctx, &newPort); err != nil {
1078 portHandle.Unlock()
1079 return nil
1080 }
1081 portHandle.Unlock()
khenaidoo442e7c72020-03-10 16:13:48 -04001082 }
Chaitrashree G S543df3e2020-02-24 22:36:54 -05001083 }
1084
khenaidoo442e7c72020-03-10 16:13:48 -04001085 //send request to adapter
Rohan Agrawalcf12f202020-08-03 04:42:01 +00001086 subCtx, cancel := context.WithTimeout(log.WithSpanFromContext(context.Background(), ctx), agent.defaultTimeout)
Himani Chawlab4c25912020-11-12 17:16:38 +05301087 subCtx = coreutils.WithRPCMetadataFromContext(subCtx, ctx)
1088
Girish Gowdra6f9b10e2021-03-11 14:36:39 -08001089 ch, err := agent.adapterProxy.ChildDeviceLost(ctx, agent.deviceType, device)
khenaidoo442e7c72020-03-10 16:13:48 -04001090 if err != nil {
1091 cancel()
1092 return err
Chaitrashree G S543df3e2020-02-24 22:36:54 -05001093 }
khenaidoo442e7c72020-03-10 16:13:48 -04001094 go agent.waitForAdapterResponse(subCtx, cancel, "childDeviceLost", ch, agent.onSuccess, agent.onFailure)
Chaitrashree G S543df3e2020-02-24 22:36:54 -05001095 return nil
Chaitrashree G S543df3e2020-02-24 22:36:54 -05001096}
onkarkundargi87285252020-01-27 11:34:52 +05301097
Kent Hagerman2b216042020-04-03 18:28:56 -04001098func (agent *Agent) startOmciTest(ctx context.Context, omcitestrequest *voltha.OmciTestRequest) (*voltha.TestResponse, error) {
onkarkundargi87285252020-01-27 11:34:52 +05301099 if err := agent.requestQueue.WaitForGreenLight(ctx); err != nil {
1100 return nil, err
1101 }
1102
Kent Hagermanf6db9f12020-07-22 17:16:19 -04001103 cloned := agent.cloneDeviceWithoutLock()
Matteo Scandolod525ae32020-04-02 17:27:29 -07001104
Kent Hagermanf6db9f12020-07-22 17:16:19 -04001105 if cloned.Adapter == "" {
1106 adapterName, err := agent.adapterMgr.GetAdapterType(cloned.Type)
Matteo Scandolod525ae32020-04-02 17:27:29 -07001107 if err != nil {
1108 agent.requestQueue.RequestComplete()
1109 return nil, err
1110 }
Kent Hagermanf6db9f12020-07-22 17:16:19 -04001111 cloned.Adapter = adapterName
onkarkundargi87285252020-01-27 11:34:52 +05301112 }
1113
1114 // Send request to the adapter
Kent Hagermanf6db9f12020-07-22 17:16:19 -04001115 ch, err := agent.adapterProxy.StartOmciTest(ctx, cloned, omcitestrequest)
onkarkundargi87285252020-01-27 11:34:52 +05301116 agent.requestQueue.RequestComplete()
1117 if err != nil {
1118 return nil, err
1119 }
1120
1121 // Wait for the adapter response
1122 rpcResponse, ok := <-ch
1123 if !ok {
1124 return nil, status.Errorf(codes.Aborted, "channel-closed-device-id-%s", agent.deviceID)
1125 }
1126 if rpcResponse.Err != nil {
1127 return nil, rpcResponse.Err
1128 }
1129
1130 // Unmarshal and return the response
1131 testResp := &voltha.TestResponse{}
1132 if err := ptypes.UnmarshalAny(rpcResponse.Reply, testResp); err != nil {
1133 return nil, status.Errorf(codes.InvalidArgument, "%s", err.Error())
1134 }
Himani Chawlab4c25912020-11-12 17:16:38 +05301135 logger.Debugw(ctx, "omci_test_request-success-device-agent", log.Fields{"test-resp": testResp})
onkarkundargi87285252020-01-27 11:34:52 +05301136 return testResp, nil
1137}
Dinesh Belwalkarc1129f12020-02-27 10:41:33 -08001138
1139func (agent *Agent) getExtValue(ctx context.Context, pdevice *voltha.Device, cdevice *voltha.Device, valueparam *voltha.ValueSpecifier) (*voltha.ReturnValues, error) {
Himani Chawlab4c25912020-11-12 17:16:38 +05301140 logger.Debugw(ctx, "get-ext-value", log.Fields{"device-id": agent.deviceID, "onu-id": valueparam.Id, "value-type": valueparam.Value})
Dinesh Belwalkarc1129f12020-02-27 10:41:33 -08001141 if err := agent.requestQueue.WaitForGreenLight(ctx); err != nil {
1142 return nil, err
1143 }
1144
1145 //send request to adapter
1146 ch, err := agent.adapterProxy.GetExtValue(ctx, pdevice, cdevice, valueparam.Id, valueparam.Value)
1147 agent.requestQueue.RequestComplete()
1148 if err != nil {
1149 return nil, err
1150 }
1151
1152 // Wait for the adapter response
1153 rpcResponse, ok := <-ch
1154 if !ok {
1155 return nil, status.Errorf(codes.Aborted, "channel-closed-device-id-%s", agent.deviceID)
1156 }
1157 if rpcResponse.Err != nil {
1158 return nil, rpcResponse.Err
1159 }
1160
1161 // Unmarshal and return the response
1162 Resp := &voltha.ReturnValues{}
1163 if err := ptypes.UnmarshalAny(rpcResponse.Reply, Resp); err != nil {
1164 return nil, status.Errorf(codes.InvalidArgument, "%s", err.Error())
1165 }
Himani Chawlab4c25912020-11-12 17:16:38 +05301166 logger.Debugw(ctx, "get-ext-value-success-device-agent", log.Fields{"Resp": Resp})
Dinesh Belwalkarc1129f12020-02-27 10:41:33 -08001167 return Resp, nil
1168}
dpaul62686312020-06-23 14:17:36 +05301169
1170func (agent *Agent) setExtValue(ctx context.Context, device *voltha.Device, value *voltha.ValueSet) (*empty.Empty, error) {
Himani Chawlab4c25912020-11-12 17:16:38 +05301171 logger.Debugw(ctx, "set-ext-value", log.Fields{"device-id": value.Id})
dpaul62686312020-06-23 14:17:36 +05301172 if err := agent.requestQueue.WaitForGreenLight(ctx); err != nil {
1173 return nil, err
1174 }
1175
1176 //send request to adapter
1177 ch, err := agent.adapterProxy.SetExtValue(ctx, device, value)
1178 agent.requestQueue.RequestComplete()
1179 if err != nil {
1180 return nil, err
1181 }
1182
1183 // Wait for the adapter response
1184 rpcResponse, ok := <-ch
1185 if !ok {
1186 return nil, status.Errorf(codes.Aborted, "channel-closed-device-id-%s", agent.deviceID)
1187 }
1188 if rpcResponse.Err != nil {
1189 return nil, rpcResponse.Err
1190 }
1191
1192 // Unmarshal and return the response
Himani Chawlab4c25912020-11-12 17:16:38 +05301193 logger.Debug(ctx, "set-ext-value-success-device-agent")
dpaul62686312020-06-23 14:17:36 +05301194 return &empty.Empty{}, nil
1195}
Salman Siddiqui1cf95042020-11-19 00:42:56 +05301196
1197func (agent *Agent) getSingleValue(ctx context.Context, request *extension.SingleGetValueRequest) (*extension.SingleGetValueResponse, error) {
Himani Chawlab4c25912020-11-12 17:16:38 +05301198 logger.Debugw(ctx, "get-single-value", log.Fields{"device-id": request.TargetId})
Salman Siddiqui1cf95042020-11-19 00:42:56 +05301199
1200 if err := agent.requestQueue.WaitForGreenLight(ctx); err != nil {
1201 return nil, err
1202 }
1203
1204 cloned := agent.cloneDeviceWithoutLock()
1205
1206 //send request to adapter
1207 ch, err := agent.adapterProxy.GetSingleValue(ctx, cloned.Adapter, request)
1208 agent.requestQueue.RequestComplete()
1209 if err != nil {
1210 return nil, err
1211 }
1212
1213 // Wait for the adapter response
1214 rpcResponse, ok := <-ch
1215 if !ok {
1216 return nil, status.Errorf(codes.Aborted, "channel-closed-device-id-%s", agent.deviceID)
1217 }
1218
1219 if rpcResponse.Err != nil {
1220 return nil, rpcResponse.Err
1221 }
1222
1223 resp := &extension.SingleGetValueResponse{}
1224 if err := ptypes.UnmarshalAny(rpcResponse.Reply, resp); err != nil {
1225 return nil, status.Errorf(codes.InvalidArgument, "%s", err.Error())
1226 }
1227
1228 return resp, nil
1229}
1230
1231func (agent *Agent) setSingleValue(ctx context.Context, request *extension.SingleSetValueRequest) (*extension.SingleSetValueResponse, error) {
Himani Chawlab4c25912020-11-12 17:16:38 +05301232 logger.Debugw(ctx, "set-single-value", log.Fields{"device-id": request.TargetId})
Salman Siddiqui1cf95042020-11-19 00:42:56 +05301233
1234 if err := agent.requestQueue.WaitForGreenLight(ctx); err != nil {
1235 return nil, err
1236 }
1237
1238 cloned := agent.cloneDeviceWithoutLock()
1239
1240 //send request to adapter
1241 ch, err := agent.adapterProxy.SetSingleValue(ctx, cloned.Adapter, request)
1242 agent.requestQueue.RequestComplete()
1243 if err != nil {
1244 return nil, err
1245 }
1246
1247 // Wait for the adapter response
1248 rpcResponse, ok := <-ch
1249 if !ok {
1250 return nil, status.Errorf(codes.Aborted, "channel-closed-cloned-id-%s", agent.deviceID)
1251 }
1252
1253 if rpcResponse.Err != nil {
1254 return nil, rpcResponse.Err
1255 }
1256
1257 resp := &extension.SingleSetValueResponse{}
1258 if err := ptypes.UnmarshalAny(rpcResponse.Reply, resp); err != nil {
1259 return nil, status.Errorf(codes.InvalidArgument, "%s", err.Error())
1260 }
1261
1262 return resp, nil
1263}
Maninder0aabf0c2021-03-17 14:55:14 +05301264
1265// The device lock MUST be held by the caller.
1266func (agent *Agent) proceedWithRequestNoLock() bool {
Maninder581cf4b2021-06-16 22:42:07 +05301267 return !agent.isDeletionInProgress() && !agent.isInReconcileState()
Maninder0aabf0c2021-03-17 14:55:14 +05301268}
1269
1270func (agent *Agent) stopReconcile() {
1271 agent.stopReconcilingMutex.Lock()
1272 if agent.stopReconciling != nil {
1273 agent.stopReconciling <- 0
1274 }
1275 agent.stopReconcilingMutex.Unlock()
1276}
1277
1278func (agent *Agent) ReconcileDevice(ctx context.Context, device *voltha.Device) {
1279 var desc string
1280 operStatus := &common.OperationResp{Code: common.OperationResp_OPERATION_FAILURE}
1281
1282 if err := agent.requestQueue.WaitForGreenLight(ctx); err != nil {
1283 desc = err.Error()
1284 agent.logDeviceUpdate(ctx, "Reconciling", nil, nil, operStatus, &desc)
1285 return
1286 }
1287
1288 if !agent.proceedWithRequestNoLock() {
1289 agent.requestQueue.RequestComplete()
Maninder581cf4b2021-06-16 22:42:07 +05301290 desc = fmt.Sprintf("Cannot complete operation as Device deletion/reconciling is in progress or reconcile failed for device : %s", device.Id)
Maninder0aabf0c2021-03-17 14:55:14 +05301291 logger.Errorf(ctx, desc)
1292 agent.logDeviceUpdate(ctx, "Reconciling", nil, nil, operStatus, &desc)
1293 return
1294 }
1295
1296 //set transient state to RECONCILE IN PROGRESS
1297 err := agent.updateTransientState(ctx, voltha.DeviceTransientState_RECONCILE_IN_PROGRESS)
1298 if err != nil {
1299 agent.requestQueue.RequestComplete()
1300 desc = fmt.Sprintf("Not able to set device transient state to Reconcile in progress."+
1301 "Err: %s", err.Error())
1302 logger.Errorf(ctx, desc)
1303 agent.logDeviceUpdate(ctx, "Reconciling", nil, nil, operStatus, &desc)
1304 return
1305 }
1306
1307 logger.Debugw(ctx, "retrying-reconciling", log.Fields{"deviceID": device.Id})
1308 reconcilingBackoff := backoff.NewExponentialBackOff()
1309 reconcilingBackoff.InitialInterval = agent.config.BackoffRetryInitialInterval
1310 reconcilingBackoff.MaxElapsedTime = agent.config.BackoffRetryMaxElapsedTime
1311 reconcilingBackoff.MaxInterval = agent.config.BackoffRetryMaxInterval
1312
1313 //making here to keep lifecycle of this channel within the scope of retryReconcile
1314 agent.stopReconcilingMutex.Lock()
1315 agent.stopReconciling = make(chan int)
1316 agent.stopReconcilingMutex.Unlock()
1317
1318Loop:
1319 for {
1320 // Use an exponential back off to prevent getting into a tight loop
1321 duration := reconcilingBackoff.NextBackOff()
1322 //This case should never occur in default case as max elapsed time for backoff is 0(by default) , so it will never return stop
1323 if duration == backoff.Stop {
1324 // If we reach a maximum then warn and reset the backoff
1325 // timer and keep attempting.
1326 logger.Warnw(ctx, "maximum-reconciling-backoff-reached--resetting-backoff-timer",
1327 log.Fields{"max-reconciling-backoff": reconcilingBackoff.MaxElapsedTime,
1328 "device-id": device.Id})
1329 reconcilingBackoff.Reset()
1330 duration = reconcilingBackoff.NextBackOff()
1331 }
1332
1333 backoffTimer := time.NewTimer(duration)
1334
1335 // Send a reconcile request to the adapter.
1336 ch, err := agent.adapterProxy.ReconcileDevice(ctx, agent.device)
1337 //release lock before moving further
1338 agent.requestQueue.RequestComplete()
1339 if err != nil {
1340 desc := fmt.Sprintf("Failed reconciling from adapter side. Err: %s", err.Error())
1341 agent.logDeviceUpdate(ctx, "Reconciling", nil, nil, operStatus, &desc)
1342 <-backoffTimer.C
1343 // backoffTimer expired continue
1344 // Take lock back before retrying
1345 if err := agent.requestQueue.WaitForGreenLight(ctx); err != nil {
1346 desc = err.Error()
1347 agent.logDeviceUpdate(ctx, "Reconciling", nil, nil, operStatus, &desc)
1348 return
1349 }
1350 continue
1351 }
1352
1353 // if return err retry if not then break loop and quit retrying reconcile
1354 if err = agent.waitForReconcileResponse(backoffTimer, ch); err != nil {
1355 desc = err.Error()
1356 logger.Errorf(ctx, desc)
1357 agent.logDeviceUpdate(ctx, "Reconciling", nil, nil, operStatus, &desc)
1358 } else {
1359 operStatus = &common.OperationResp{Code: common.OperationResp_OPERATION_IN_PROGRESS}
1360 agent.logDeviceUpdate(ctx, "Reconciling", nil, nil, operStatus, &desc)
1361 break Loop
1362 }
1363
1364 // Take lock back before retrying
1365 if err := agent.requestQueue.WaitForGreenLight(ctx); err != nil {
1366 desc = err.Error()
1367 agent.logDeviceUpdate(ctx, "Reconciling", nil, nil, operStatus, &desc)
1368 return
1369 }
1370 }
1371}
1372
1373func (agent *Agent) waitForReconcileResponse(backoffTimer *time.Timer, ch chan *kafka.RpcResponse) error {
1374 select {
1375 // wait for response
1376 case resp, ok := <-ch:
1377 if !ok {
1378 //channel-closed
1379 return errors.New("channel on which reconcile response is awaited is closed")
1380 } else if resp.Err != nil {
1381 //error encountered
1382 return errors.New("error encountered while retrying reconcile")
1383 }
1384
1385 //In case of success quit retrying and wait for adapter to reset operation state of device
1386 agent.stopReconcilingMutex.Lock()
1387 agent.stopReconciling = nil
1388 agent.stopReconcilingMutex.Unlock()
1389 return nil
1390
1391 //if reconciling need to be stopped
1392 case _, ok := <-agent.stopReconciling:
1393 agent.stopReconcilingMutex.Lock()
1394 agent.stopReconciling = nil
1395 agent.stopReconcilingMutex.Unlock()
1396 if !ok {
1397 //channel-closed
1398 return errors.New("channel used to notify to stop reconcile is closed")
1399 }
1400 return nil
1401 //continue if timer expired
1402 case <-backoffTimer.C:
1403 }
1404 return nil
1405}
1406
1407func (agent *Agent) reconcilingCleanup(ctx context.Context) error {
1408 var desc string
1409 operStatus := &common.OperationResp{Code: common.OperationResp_OPERATION_FAILURE}
1410 if err := agent.requestQueue.WaitForGreenLight(ctx); err != nil {
1411 desc = err.Error()
1412 agent.logDeviceUpdate(ctx, "Reconciling", nil, nil, operStatus, &desc)
1413 return err
1414 }
1415 defer agent.requestQueue.RequestComplete()
1416 err := agent.updateTransientState(ctx, voltha.DeviceTransientState_NONE)
1417 if err != nil {
1418 desc = fmt.Sprintf("Not able to clear device transient state from Reconcile in progress."+
1419 "Err: %s", err.Error())
1420 logger.Errorf(ctx, desc)
1421 agent.logDeviceUpdate(ctx, "Reconciling", nil, nil, operStatus, &desc)
1422 return err
1423 }
1424 operStatus = &common.OperationResp{Code: common.OperationResp_OPERATION_SUCCESS}
1425 agent.logDeviceUpdate(ctx, "Reconciling", nil, nil, operStatus, &desc)
1426 return nil
1427}