khenaidoo | b920354 | 2018-09-17 22:56:37 -0400 | [diff] [blame] | 1 | /* |
| 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 | */ |
npujar | 1d86a52 | 2019-11-14 17:11:16 +0530 | [diff] [blame] | 16 | |
khenaidoo | b920354 | 2018-09-17 22:56:37 -0400 | [diff] [blame] | 17 | package core |
| 18 | |
| 19 | import ( |
| 20 | "context" |
Thomas Lee S | e5a4401 | 2019-11-07 20:32:24 +0530 | [diff] [blame] | 21 | "fmt" |
npujar | 1d86a52 | 2019-11-14 17:11:16 +0530 | [diff] [blame] | 22 | "time" |
| 23 | |
sbarbari | 17d7e22 | 2019-11-05 10:02:29 -0500 | [diff] [blame] | 24 | "github.com/opencord/voltha-go/db/model" |
khenaidoo | b920354 | 2018-09-17 22:56:37 -0400 | [diff] [blame] | 25 | "github.com/opencord/voltha-go/rw_core/config" |
serkant.uluderya | 2ae470f | 2020-01-21 11:13:09 -0800 | [diff] [blame] | 26 | "github.com/opencord/voltha-lib-go/v3/pkg/db" |
| 27 | "github.com/opencord/voltha-lib-go/v3/pkg/db/kvstore" |
| 28 | grpcserver "github.com/opencord/voltha-lib-go/v3/pkg/grpc" |
| 29 | "github.com/opencord/voltha-lib-go/v3/pkg/kafka" |
| 30 | "github.com/opencord/voltha-lib-go/v3/pkg/log" |
| 31 | "github.com/opencord/voltha-lib-go/v3/pkg/probe" |
| 32 | "github.com/opencord/voltha-protos/v3/go/voltha" |
khenaidoo | b920354 | 2018-09-17 22:56:37 -0400 | [diff] [blame] | 33 | "google.golang.org/grpc" |
khenaidoo | b324421 | 2019-08-27 14:32:27 -0400 | [diff] [blame] | 34 | "google.golang.org/grpc/codes" |
| 35 | "google.golang.org/grpc/status" |
khenaidoo | b920354 | 2018-09-17 22:56:37 -0400 | [diff] [blame] | 36 | ) |
| 37 | |
npujar | 1d86a52 | 2019-11-14 17:11:16 +0530 | [diff] [blame] | 38 | // Core represent read,write core attributes |
khenaidoo | b920354 | 2018-09-17 22:56:37 -0400 | [diff] [blame] | 39 | type Core struct { |
npujar | 1d86a52 | 2019-11-14 17:11:16 +0530 | [diff] [blame] | 40 | instanceID string |
khenaidoo | b920354 | 2018-09-17 22:56:37 -0400 | [diff] [blame] | 41 | deviceMgr *DeviceManager |
| 42 | logicalDeviceMgr *LogicalDeviceManager |
| 43 | grpcServer *grpcserver.GrpcServer |
Richard Jankowski | dbab94a | 2018-12-06 16:20:25 -0500 | [diff] [blame] | 44 | grpcNBIAPIHandler *APIHandler |
khenaidoo | 2c6a099 | 2019-04-29 13:46:56 -0400 | [diff] [blame] | 45 | adapterMgr *AdapterManager |
khenaidoo | b920354 | 2018-09-17 22:56:37 -0400 | [diff] [blame] | 46 | config *config.RWCoreFlags |
khenaidoo | 43c8212 | 2018-11-22 18:38:28 -0500 | [diff] [blame] | 47 | kmp *kafka.InterContainerProxy |
khenaidoo | 92e62c5 | 2018-10-03 14:02:54 -0400 | [diff] [blame] | 48 | clusterDataRoot model.Root |
| 49 | localDataRoot model.Root |
khenaidoo | b920354 | 2018-09-17 22:56:37 -0400 | [diff] [blame] | 50 | clusterDataProxy *model.Proxy |
| 51 | localDataProxy *model.Proxy |
| 52 | exitChannel chan int |
Richard Jankowski | e4d7766 | 2018-10-17 13:53:21 -0400 | [diff] [blame] | 53 | kvClient kvstore.Client |
Girish Kumar | 4d3887d | 2019-11-22 14:22:05 +0000 | [diff] [blame] | 54 | backend db.Backend |
khenaidoo | 43c8212 | 2018-11-22 18:38:28 -0500 | [diff] [blame] | 55 | kafkaClient kafka.Client |
khenaidoo | 2c6a099 | 2019-04-29 13:46:56 -0400 | [diff] [blame] | 56 | deviceOwnership *DeviceOwnership |
khenaidoo | b920354 | 2018-09-17 22:56:37 -0400 | [diff] [blame] | 57 | } |
| 58 | |
| 59 | func init() { |
npujar | 1d86a52 | 2019-11-14 17:11:16 +0530 | [diff] [blame] | 60 | _, err := log.AddPackage(log.JSON, log.WarnLevel, nil) |
| 61 | if err != nil { |
| 62 | log.Errorw("unable-to-register-package-to-the-log-map", log.Fields{"error": err}) |
| 63 | } |
khenaidoo | b920354 | 2018-09-17 22:56:37 -0400 | [diff] [blame] | 64 | } |
| 65 | |
npujar | 1d86a52 | 2019-11-14 17:11:16 +0530 | [diff] [blame] | 66 | // NewCore creates instance of rw core |
Thomas Lee S | e5a4401 | 2019-11-07 20:32:24 +0530 | [diff] [blame] | 67 | func NewCore(ctx context.Context, id string, cf *config.RWCoreFlags, kvClient kvstore.Client, kafkaClient kafka.Client) *Core { |
khenaidoo | b920354 | 2018-09-17 22:56:37 -0400 | [diff] [blame] | 68 | var core Core |
npujar | 1d86a52 | 2019-11-14 17:11:16 +0530 | [diff] [blame] | 69 | core.instanceID = id |
khenaidoo | b920354 | 2018-09-17 22:56:37 -0400 | [diff] [blame] | 70 | core.exitChannel = make(chan int, 1) |
| 71 | core.config = cf |
Richard Jankowski | e4d7766 | 2018-10-17 13:53:21 -0400 | [diff] [blame] | 72 | core.kvClient = kvClient |
khenaidoo | 43c8212 | 2018-11-22 18:38:28 -0500 | [diff] [blame] | 73 | core.kafkaClient = kafkaClient |
Richard Jankowski | e4d7766 | 2018-10-17 13:53:21 -0400 | [diff] [blame] | 74 | |
Girish Kumar | 4d3887d | 2019-11-22 14:22:05 +0000 | [diff] [blame] | 75 | // Configure backend to push Liveness Status at least every (cf.LiveProbeInterval / 2) seconds |
| 76 | // so as to avoid trigger of Liveness check (due to Liveness timeout) when backend is alive |
| 77 | livenessChannelInterval := cf.LiveProbeInterval / 2 |
| 78 | |
Richard Jankowski | e4d7766 | 2018-10-17 13:53:21 -0400 | [diff] [blame] | 79 | // Setup the KV store |
Girish Kumar | 4d3887d | 2019-11-22 14:22:05 +0000 | [diff] [blame] | 80 | core.backend = db.Backend{ |
| 81 | Client: kvClient, |
| 82 | StoreType: cf.KVStoreType, |
| 83 | Host: cf.KVStoreHost, |
| 84 | Port: cf.KVStorePort, |
| 85 | Timeout: cf.KVStoreTimeout, |
| 86 | LivenessChannelInterval: livenessChannelInterval, |
| 87 | PathPrefix: cf.KVStoreDataPrefix} |
| 88 | core.clusterDataRoot = model.NewRoot(&voltha.Voltha{}, &core.backend) |
| 89 | core.localDataRoot = model.NewRoot(&voltha.CoreInstance{}, &core.backend) |
khenaidoo | b920354 | 2018-09-17 22:56:37 -0400 | [diff] [blame] | 90 | return &core |
| 91 | } |
| 92 | |
npujar | 1d86a52 | 2019-11-14 17:11:16 +0530 | [diff] [blame] | 93 | // Start brings up core services |
Thomas Lee S | e5a4401 | 2019-11-07 20:32:24 +0530 | [diff] [blame] | 94 | func (core *Core) Start(ctx context.Context) error { |
David K. Bainbridge | b4a9ab0 | 2019-09-20 15:12:16 -0700 | [diff] [blame] | 95 | |
| 96 | // If the context has a probe then fetch it and register our services |
| 97 | var p *probe.Probe |
| 98 | if value := ctx.Value(probe.ProbeContextKey); value != nil { |
| 99 | if _, ok := value.(*probe.Probe); ok { |
| 100 | p = value.(*probe.Probe) |
| 101 | p.RegisterService( |
| 102 | "message-bus", |
| 103 | "kv-store", |
| 104 | "device-manager", |
| 105 | "logical-device-manager", |
| 106 | "adapter-manager", |
| 107 | "grpc-service", |
| 108 | ) |
| 109 | } |
| 110 | } |
| 111 | |
npujar | 1d86a52 | 2019-11-14 17:11:16 +0530 | [diff] [blame] | 112 | log.Info("starting-core-services", log.Fields{"coreId": core.instanceID}) |
khenaidoo | b324421 | 2019-08-27 14:32:27 -0400 | [diff] [blame] | 113 | |
| 114 | // Wait until connection to KV Store is up |
| 115 | if err := core.waitUntilKVStoreReachableOrMaxTries(ctx, core.config.MaxConnectionRetries, core.config.ConnectionRetryInterval); err != nil { |
| 116 | log.Fatal("Unable-to-connect-to-KV-store") |
| 117 | } |
David K. Bainbridge | b4a9ab0 | 2019-09-20 15:12:16 -0700 | [diff] [blame] | 118 | if p != nil { |
| 119 | p.UpdateStatus("kv-store", probe.ServiceStatusRunning) |
| 120 | } |
Thomas Lee S | e5a4401 | 2019-11-07 20:32:24 +0530 | [diff] [blame] | 121 | var err error |
| 122 | |
| 123 | core.clusterDataProxy, err = core.clusterDataRoot.CreateProxy(context.Background(), "/", false) |
| 124 | if err != nil { |
| 125 | probe.UpdateStatusFromContext(ctx, "kv-store", probe.ServiceStatusNotReady) |
| 126 | return fmt.Errorf("Failed to create cluster data proxy") |
| 127 | } |
| 128 | core.localDataProxy, err = core.localDataRoot.CreateProxy(context.Background(), "/", false) |
| 129 | if err != nil { |
| 130 | probe.UpdateStatusFromContext(ctx, "kv-store", probe.ServiceStatusNotReady) |
| 131 | return fmt.Errorf("Failed to create local data proxy") |
| 132 | } |
khenaidoo | b324421 | 2019-08-27 14:32:27 -0400 | [diff] [blame] | 133 | |
Scott Baker | ee6a087 | 2019-10-29 15:59:52 -0700 | [diff] [blame] | 134 | // core.kmp must be created before deviceMgr and adapterMgr, as they will make |
| 135 | // private copies of the poiner to core.kmp. |
| 136 | if err := core.initKafkaManager(ctx); err != nil { |
| 137 | log.Fatal("Failed-to-init-kafka-manager") |
David K. Bainbridge | b4a9ab0 | 2019-09-20 15:12:16 -0700 | [diff] [blame] | 138 | } |
khenaidoo | b324421 | 2019-08-27 14:32:27 -0400 | [diff] [blame] | 139 | |
khenaidoo | 631fe54 | 2019-05-31 15:44:43 -0400 | [diff] [blame] | 140 | log.Debugw("values", log.Fields{"kmp": core.kmp}) |
Richard Jankowski | 199fd86 | 2019-03-18 14:49:51 -0400 | [diff] [blame] | 141 | core.deviceMgr = newDeviceManager(core) |
npujar | 1d86a52 | 2019-11-14 17:11:16 +0530 | [diff] [blame] | 142 | core.adapterMgr = newAdapterManager(core.clusterDataProxy, core.instanceID, core.deviceMgr) |
khenaidoo | ba6b6c4 | 2019-08-02 09:11:56 -0400 | [diff] [blame] | 143 | core.deviceMgr.adapterMgr = core.adapterMgr |
khenaidoo | 2c6a099 | 2019-04-29 13:46:56 -0400 | [diff] [blame] | 144 | core.logicalDeviceMgr = newLogicalDeviceManager(core, core.deviceMgr, core.kmp, core.clusterDataProxy, core.config.DefaultCoreTimeout) |
khenaidoo | 54e0ddf | 2019-02-27 16:21:33 -0500 | [diff] [blame] | 145 | |
Scott Baker | ee6a087 | 2019-10-29 15:59:52 -0700 | [diff] [blame] | 146 | // Start the KafkaManager. This must be done after the deviceMgr, adapterMgr, and |
| 147 | // logicalDeviceMgr have been created, as once the kmp is started, it will register |
| 148 | // the above with the kmp. |
| 149 | |
| 150 | go core.startKafkaManager(ctx, |
| 151 | core.config.ConnectionRetryInterval, |
| 152 | core.config.LiveProbeInterval, |
| 153 | core.config.NotLiveProbeInterval) |
khenaidoo | b324421 | 2019-08-27 14:32:27 -0400 | [diff] [blame] | 154 | |
khenaidoo | b920354 | 2018-09-17 22:56:37 -0400 | [diff] [blame] | 155 | go core.startDeviceManager(ctx) |
| 156 | go core.startLogicalDeviceManager(ctx) |
| 157 | go core.startGRPCService(ctx) |
khenaidoo | 21d5115 | 2019-02-01 13:48:37 -0500 | [diff] [blame] | 158 | go core.startAdapterManager(ctx) |
Girish Kumar | 4d3887d | 2019-11-22 14:22:05 +0000 | [diff] [blame] | 159 | go core.monitorKvstoreLiveness(ctx) |
khenaidoo | b920354 | 2018-09-17 22:56:37 -0400 | [diff] [blame] | 160 | |
khenaidoo | 1ce37ad | 2019-03-24 22:07:24 -0400 | [diff] [blame] | 161 | // Setup device ownership context |
npujar | 1d86a52 | 2019-11-14 17:11:16 +0530 | [diff] [blame] | 162 | core.deviceOwnership = NewDeviceOwnership(core.instanceID, core.kvClient, core.deviceMgr, core.logicalDeviceMgr, |
khenaidoo | 1ce37ad | 2019-03-24 22:07:24 -0400 | [diff] [blame] | 163 | "service/voltha/owns_device", 10) |
| 164 | |
khenaidoo | b324421 | 2019-08-27 14:32:27 -0400 | [diff] [blame] | 165 | log.Info("core-services-started") |
Thomas Lee S | e5a4401 | 2019-11-07 20:32:24 +0530 | [diff] [blame] | 166 | return nil |
khenaidoo | b920354 | 2018-09-17 22:56:37 -0400 | [diff] [blame] | 167 | } |
| 168 | |
npujar | 1d86a52 | 2019-11-14 17:11:16 +0530 | [diff] [blame] | 169 | // Stop brings down core services |
khenaidoo | b920354 | 2018-09-17 22:56:37 -0400 | [diff] [blame] | 170 | func (core *Core) Stop(ctx context.Context) { |
khenaidoo | 1937407 | 2018-12-11 11:05:15 -0500 | [diff] [blame] | 171 | log.Info("stopping-adaptercore") |
David Bainbridge | f794fc5 | 2019-10-03 22:37:12 +0000 | [diff] [blame] | 172 | if core.exitChannel != nil { |
| 173 | core.exitChannel <- 1 |
| 174 | } |
khenaidoo | 43c8212 | 2018-11-22 18:38:28 -0500 | [diff] [blame] | 175 | // Stop all the started services |
David Bainbridge | f794fc5 | 2019-10-03 22:37:12 +0000 | [diff] [blame] | 176 | if core.grpcServer != nil { |
| 177 | core.grpcServer.Stop() |
| 178 | } |
| 179 | if core.logicalDeviceMgr != nil { |
| 180 | core.logicalDeviceMgr.stop(ctx) |
| 181 | } |
| 182 | if core.deviceMgr != nil { |
| 183 | core.deviceMgr.stop(ctx) |
| 184 | } |
| 185 | if core.kmp != nil { |
| 186 | core.kmp.Stop() |
| 187 | } |
khenaidoo | 1937407 | 2018-12-11 11:05:15 -0500 | [diff] [blame] | 188 | log.Info("adaptercore-stopped") |
khenaidoo | b920354 | 2018-09-17 22:56:37 -0400 | [diff] [blame] | 189 | } |
| 190 | |
khenaidoo | 631fe54 | 2019-05-31 15:44:43 -0400 | [diff] [blame] | 191 | //startGRPCService creates the grpc service handlers, registers it to the grpc server and starts the server |
khenaidoo | b920354 | 2018-09-17 22:56:37 -0400 | [diff] [blame] | 192 | func (core *Core) startGRPCService(ctx context.Context) { |
| 193 | // create an insecure gserver server |
Scott Baker | ee6a087 | 2019-10-29 15:59:52 -0700 | [diff] [blame] | 194 | core.grpcServer = grpcserver.NewGrpcServer(core.config.GrpcHost, core.config.GrpcPort, nil, false, probe.GetProbeFromContext(ctx)) |
khenaidoo | b920354 | 2018-09-17 22:56:37 -0400 | [diff] [blame] | 195 | log.Info("grpc-server-created") |
| 196 | |
khenaidoo | 54e0ddf | 2019-02-27 16:21:33 -0500 | [diff] [blame] | 197 | core.grpcNBIAPIHandler = NewAPIHandler(core) |
Richard Jankowski | 46464e9 | 2019-03-05 11:53:55 -0500 | [diff] [blame] | 198 | log.Infow("grpc-handler", log.Fields{"core_binding_key": core.config.CoreBindingKey}) |
Richard Jankowski | dbab94a | 2018-12-06 16:20:25 -0500 | [diff] [blame] | 199 | core.logicalDeviceMgr.setGrpcNbiHandler(core.grpcNBIAPIHandler) |
khenaidoo | b920354 | 2018-09-17 22:56:37 -0400 | [diff] [blame] | 200 | // Create a function to register the core GRPC service with the GRPC server |
| 201 | f := func(gs *grpc.Server) { |
| 202 | voltha.RegisterVolthaServiceServer( |
| 203 | gs, |
Richard Jankowski | dbab94a | 2018-12-06 16:20:25 -0500 | [diff] [blame] | 204 | core.grpcNBIAPIHandler, |
khenaidoo | b920354 | 2018-09-17 22:56:37 -0400 | [diff] [blame] | 205 | ) |
| 206 | } |
| 207 | |
| 208 | core.grpcServer.AddService(f) |
| 209 | log.Info("grpc-service-added") |
| 210 | |
David K. Bainbridge | b4a9ab0 | 2019-09-20 15:12:16 -0700 | [diff] [blame] | 211 | /* |
| 212 | * Start the GRPC server |
| 213 | * |
| 214 | * This is a bit sub-optimal here as the grpcServer.Start call does not return (blocks) |
| 215 | * until something fails, but we want to send a "start" status update. As written this |
| 216 | * means that we are actually sending the "start" status update before the server is |
| 217 | * started, which means it is possible that the status is "running" before it actually is. |
| 218 | * |
| 219 | * This means that there is a small window in which the core could return its status as |
| 220 | * ready, when it really isn't. |
| 221 | */ |
| 222 | probe.UpdateStatusFromContext(ctx, "grpc-service", probe.ServiceStatusRunning) |
khenaidoo | b920354 | 2018-09-17 22:56:37 -0400 | [diff] [blame] | 223 | log.Info("grpc-server-started") |
David K. Bainbridge | b4a9ab0 | 2019-09-20 15:12:16 -0700 | [diff] [blame] | 224 | core.grpcServer.Start(context.Background()) |
| 225 | probe.UpdateStatusFromContext(ctx, "grpc-service", probe.ServiceStatusStopped) |
khenaidoo | b920354 | 2018-09-17 22:56:37 -0400 | [diff] [blame] | 226 | } |
| 227 | |
Scott Baker | ee6a087 | 2019-10-29 15:59:52 -0700 | [diff] [blame] | 228 | // Initialize the kafka manager, but we will start it later |
| 229 | func (core *Core) initKafkaManager(ctx context.Context) error { |
| 230 | log.Infow("initialize-kafka-manager", log.Fields{"host": core.config.KafkaAdapterHost, |
khenaidoo | b920354 | 2018-09-17 22:56:37 -0400 | [diff] [blame] | 231 | "port": core.config.KafkaAdapterPort, "topic": core.config.CoreTopic}) |
Scott Baker | ee6a087 | 2019-10-29 15:59:52 -0700 | [diff] [blame] | 232 | |
| 233 | probe.UpdateStatusFromContext(ctx, "message-bus", probe.ServiceStatusPreparing) |
| 234 | |
| 235 | // create the proxy |
khenaidoo | b920354 | 2018-09-17 22:56:37 -0400 | [diff] [blame] | 236 | var err error |
khenaidoo | 43c8212 | 2018-11-22 18:38:28 -0500 | [diff] [blame] | 237 | if core.kmp, err = kafka.NewInterContainerProxy( |
| 238 | kafka.InterContainerHost(core.config.KafkaAdapterHost), |
| 239 | kafka.InterContainerPort(core.config.KafkaAdapterPort), |
| 240 | kafka.MsgClient(core.kafkaClient), |
khenaidoo | 7923270 | 2018-12-04 11:00:41 -0500 | [diff] [blame] | 241 | kafka.DefaultTopic(&kafka.Topic{Name: core.config.CoreTopic}), |
| 242 | kafka.DeviceDiscoveryTopic(&kafka.Topic{Name: core.config.AffinityRouterTopic})); err != nil { |
khenaidoo | b920354 | 2018-09-17 22:56:37 -0400 | [diff] [blame] | 243 | log.Errorw("fail-to-create-kafka-proxy", log.Fields{"error": err}) |
| 244 | return err |
| 245 | } |
Scott Baker | ee6a087 | 2019-10-29 15:59:52 -0700 | [diff] [blame] | 246 | |
| 247 | probe.UpdateStatusFromContext(ctx, "message-bus", probe.ServiceStatusPrepared) |
| 248 | |
| 249 | return nil |
| 250 | } |
| 251 | |
| 252 | /* |
| 253 | * KafkaMonitorThread |
| 254 | * |
npujar | 1d86a52 | 2019-11-14 17:11:16 +0530 | [diff] [blame] | 255 | * Responsible for starting the Kafka Interadapter Proxy and monitoring its liveness |
Scott Baker | ee6a087 | 2019-10-29 15:59:52 -0700 | [diff] [blame] | 256 | * state. |
| 257 | * |
| 258 | * Any producer that fails to send will cause KafkaInterContainerProxy to |
| 259 | * post a false event on its liveness channel. Any producer that succeeds in sending |
| 260 | * will cause KafkaInterContainerProxy to post a true event on its liveness |
npujar | 1d86a52 | 2019-11-14 17:11:16 +0530 | [diff] [blame] | 261 | * channel. Group receivers also update liveness state, and a receiver will typically |
Scott Baker | ee6a087 | 2019-10-29 15:59:52 -0700 | [diff] [blame] | 262 | * indicate a loss of liveness within 3-5 seconds of Kafka going down. Receivers |
| 263 | * only indicate restoration of liveness if a message is received. During normal |
| 264 | * operation, messages will be routinely produced and received, automatically |
| 265 | * indicating liveness state. These routine liveness indications are rate-limited |
| 266 | * inside sarama_client. |
| 267 | * |
| 268 | * This thread monitors the status of KafkaInterContainerProxy's liveness and pushes |
| 269 | * that state to the core's readiness probes. If no liveness event has been seen |
| 270 | * within a timeout, then the thread will make an attempt to produce a "liveness" |
| 271 | * message, which will in turn trigger a liveness event on the liveness channel, true |
| 272 | * or false depending on whether the attempt succeeded. |
| 273 | * |
| 274 | * The gRPC server in turn monitors the state of the readiness probe and will |
| 275 | * start issuing UNAVAILABLE response while the probe is not ready. |
| 276 | * |
| 277 | * startupRetryInterval -- interval between attempts to start |
| 278 | * liveProbeInterval -- interval between liveness checks when in a live state |
| 279 | * notLiveProbeInterval -- interval between liveness checks when in a notLive state |
| 280 | * |
| 281 | * liveProbeInterval and notLiveProbeInterval can be configured separately, |
| 282 | * though the current default is that both are set to 60 seconds. |
| 283 | */ |
| 284 | |
Girish Kumar | 4d3887d | 2019-11-22 14:22:05 +0000 | [diff] [blame] | 285 | func (core *Core) startKafkaManager(ctx context.Context, startupRetryInterval time.Duration, liveProbeInterval time.Duration, notLiveProbeInterval time.Duration) { |
Scott Baker | ee6a087 | 2019-10-29 15:59:52 -0700 | [diff] [blame] | 286 | log.Infow("starting-kafka-manager-thread", log.Fields{"host": core.config.KafkaAdapterHost, |
| 287 | "port": core.config.KafkaAdapterPort, "topic": core.config.CoreTopic}) |
| 288 | |
| 289 | started := false |
| 290 | for !started { |
| 291 | // If we haven't started yet, then try to start |
| 292 | log.Infow("starting-kafka-proxy", log.Fields{}) |
| 293 | if err := core.kmp.Start(); err != nil { |
| 294 | // We failed to start. Delay and then try again later. |
| 295 | // Don't worry about liveness, as we can't be live until we've started. |
| 296 | probe.UpdateStatusFromContext(ctx, "message-bus", probe.ServiceStatusNotReady) |
khenaidoo | b324421 | 2019-08-27 14:32:27 -0400 | [diff] [blame] | 297 | log.Infow("error-starting-kafka-messaging-proxy", log.Fields{"error": err}) |
Girish Kumar | 4d3887d | 2019-11-22 14:22:05 +0000 | [diff] [blame] | 298 | time.Sleep(startupRetryInterval) |
khenaidoo | b324421 | 2019-08-27 14:32:27 -0400 | [diff] [blame] | 299 | } else { |
Scott Baker | ee6a087 | 2019-10-29 15:59:52 -0700 | [diff] [blame] | 300 | // We started. We only need to do this once. |
| 301 | // Next we'll fall through and start checking liveness. |
| 302 | log.Infow("started-kafka-proxy", log.Fields{}) |
| 303 | |
| 304 | // cannot do this until after the kmp is started |
npujar | 1d86a52 | 2019-11-14 17:11:16 +0530 | [diff] [blame] | 305 | if err := core.registerAdapterRequestHandlers(ctx, core.instanceID, core.deviceMgr, core.logicalDeviceMgr, core.adapterMgr, core.clusterDataProxy, core.localDataProxy); err != nil { |
Scott Baker | ee6a087 | 2019-10-29 15:59:52 -0700 | [diff] [blame] | 306 | log.Fatal("Failure-registering-adapterRequestHandler") |
| 307 | } |
| 308 | |
| 309 | started = true |
khenaidoo | b324421 | 2019-08-27 14:32:27 -0400 | [diff] [blame] | 310 | } |
khenaidoo | b920354 | 2018-09-17 22:56:37 -0400 | [diff] [blame] | 311 | } |
Scott Baker | ee6a087 | 2019-10-29 15:59:52 -0700 | [diff] [blame] | 312 | |
| 313 | log.Info("started-kafka-message-proxy") |
| 314 | |
| 315 | livenessChannel := core.kmp.EnableLivenessChannel(true) |
| 316 | |
| 317 | log.Info("enabled-kafka-liveness-channel") |
| 318 | |
Girish Kumar | 4d3887d | 2019-11-22 14:22:05 +0000 | [diff] [blame] | 319 | timeout := liveProbeInterval |
Scott Baker | ee6a087 | 2019-10-29 15:59:52 -0700 | [diff] [blame] | 320 | for { |
| 321 | timeoutTimer := time.NewTimer(timeout) |
| 322 | select { |
| 323 | case liveness := <-livenessChannel: |
| 324 | log.Infow("kafka-manager-thread-liveness-event", log.Fields{"liveness": liveness}) |
| 325 | // there was a state change in Kafka liveness |
| 326 | if !liveness { |
| 327 | probe.UpdateStatusFromContext(ctx, "message-bus", probe.ServiceStatusNotReady) |
| 328 | |
| 329 | if core.grpcServer != nil { |
| 330 | log.Info("kafka-manager-thread-set-server-notready") |
| 331 | } |
| 332 | |
| 333 | // retry frequently while life is bad |
Girish Kumar | 4d3887d | 2019-11-22 14:22:05 +0000 | [diff] [blame] | 334 | timeout = notLiveProbeInterval |
Scott Baker | ee6a087 | 2019-10-29 15:59:52 -0700 | [diff] [blame] | 335 | } else { |
| 336 | probe.UpdateStatusFromContext(ctx, "message-bus", probe.ServiceStatusRunning) |
| 337 | |
| 338 | if core.grpcServer != nil { |
| 339 | log.Info("kafka-manager-thread-set-server-ready") |
| 340 | } |
| 341 | |
| 342 | // retry infrequently while life is good |
Girish Kumar | 4d3887d | 2019-11-22 14:22:05 +0000 | [diff] [blame] | 343 | timeout = liveProbeInterval |
Scott Baker | ee6a087 | 2019-10-29 15:59:52 -0700 | [diff] [blame] | 344 | } |
| 345 | if !timeoutTimer.Stop() { |
| 346 | <-timeoutTimer.C |
| 347 | } |
| 348 | case <-timeoutTimer.C: |
| 349 | log.Info("kafka-proxy-liveness-recheck") |
| 350 | // send the liveness probe in a goroutine; we don't want to deadlock ourselves as |
| 351 | // the liveness probe may wait (and block) writing to our channel. |
| 352 | go func() { |
| 353 | err := core.kmp.SendLiveness() |
| 354 | if err != nil { |
| 355 | // Catch possible error case if sending liveness after Sarama has been stopped. |
| 356 | log.Warnw("error-kafka-send-liveness", log.Fields{"error": err}) |
| 357 | } |
| 358 | }() |
| 359 | } |
| 360 | } |
khenaidoo | b920354 | 2018-09-17 22:56:37 -0400 | [diff] [blame] | 361 | } |
| 362 | |
khenaidoo | b324421 | 2019-08-27 14:32:27 -0400 | [diff] [blame] | 363 | // waitUntilKVStoreReachableOrMaxTries will wait until it can connect to a KV store or until maxtries has been reached |
Girish Kumar | 4d3887d | 2019-11-22 14:22:05 +0000 | [diff] [blame] | 364 | func (core *Core) waitUntilKVStoreReachableOrMaxTries(ctx context.Context, maxRetries int, retryInterval time.Duration) error { |
khenaidoo | b324421 | 2019-08-27 14:32:27 -0400 | [diff] [blame] | 365 | log.Infow("verifying-KV-store-connectivity", log.Fields{"host": core.config.KVStoreHost, |
| 366 | "port": core.config.KVStorePort, "retries": maxRetries, "retryInterval": retryInterval}) |
| 367 | // Get timeout in seconds with 1 second set as minimum |
| 368 | timeout := int(core.config.DefaultCoreTimeout / 1000) |
| 369 | if timeout < 1 { |
| 370 | timeout = 1 |
| 371 | } |
| 372 | count := 0 |
| 373 | for { |
| 374 | if !core.kvClient.IsConnectionUp(timeout) { |
| 375 | log.Info("KV-store-unreachable") |
| 376 | if maxRetries != -1 { |
| 377 | if count >= maxRetries { |
| 378 | return status.Error(codes.Unavailable, "kv store unreachable") |
| 379 | } |
| 380 | } |
npujar | 1d86a52 | 2019-11-14 17:11:16 +0530 | [diff] [blame] | 381 | count++ |
khenaidoo | b324421 | 2019-08-27 14:32:27 -0400 | [diff] [blame] | 382 | // Take a nap before retrying |
Girish Kumar | 4d3887d | 2019-11-22 14:22:05 +0000 | [diff] [blame] | 383 | time.Sleep(retryInterval) |
khenaidoo | b324421 | 2019-08-27 14:32:27 -0400 | [diff] [blame] | 384 | log.Infow("retry-KV-store-connectivity", log.Fields{"retryCount": count, "maxRetries": maxRetries, "retryInterval": retryInterval}) |
| 385 | |
| 386 | } else { |
| 387 | break |
| 388 | } |
| 389 | } |
| 390 | log.Info("KV-store-reachable") |
| 391 | return nil |
| 392 | } |
| 393 | |
npujar | 1d86a52 | 2019-11-14 17:11:16 +0530 | [diff] [blame] | 394 | func (core *Core) registerAdapterRequestHandlers(ctx context.Context, coreInstanceID string, dMgr *DeviceManager, |
khenaidoo | 297cd25 | 2019-02-07 22:10:23 -0500 | [diff] [blame] | 395 | ldMgr *LogicalDeviceManager, aMgr *AdapterManager, cdProxy *model.Proxy, ldProxy *model.Proxy, |
khenaidoo | 54e0ddf | 2019-02-27 16:21:33 -0500 | [diff] [blame] | 396 | ) error { |
npujar | 1d86a52 | 2019-11-14 17:11:16 +0530 | [diff] [blame] | 397 | requestProxy := NewAdapterRequestHandlerProxy(core, coreInstanceID, dMgr, ldMgr, aMgr, cdProxy, ldProxy, |
khenaidoo | 297cd25 | 2019-02-07 22:10:23 -0500 | [diff] [blame] | 398 | core.config.InCompetingMode, core.config.LongRunningRequestTimeout, core.config.DefaultRequestTimeout) |
khenaidoo | b920354 | 2018-09-17 22:56:37 -0400 | [diff] [blame] | 399 | |
khenaidoo | 54e0ddf | 2019-02-27 16:21:33 -0500 | [diff] [blame] | 400 | // Register the broadcast topic to handle any core-bound broadcast requests |
| 401 | if err := core.kmp.SubscribeWithRequestHandlerInterface(kafka.Topic{Name: core.config.CoreTopic}, requestProxy); err != nil { |
| 402 | log.Fatalw("Failed-registering-broadcast-handler", log.Fields{"topic": core.config.CoreTopic}) |
| 403 | return err |
| 404 | } |
| 405 | |
Kent Hagerman | a6d0c36 | 2019-07-30 12:50:21 -0400 | [diff] [blame] | 406 | // Register the core-pair topic to handle core-bound requests destined to the core pair |
| 407 | if err := core.kmp.SubscribeWithDefaultRequestHandler(kafka.Topic{Name: core.config.CorePairTopic}, kafka.OffsetNewest); err != nil { |
| 408 | log.Fatalw("Failed-registering-pair-handler", log.Fields{"topic": core.config.CorePairTopic}) |
| 409 | return err |
| 410 | } |
| 411 | |
khenaidoo | 54e0ddf | 2019-02-27 16:21:33 -0500 | [diff] [blame] | 412 | log.Info("request-handler-registered") |
khenaidoo | b920354 | 2018-09-17 22:56:37 -0400 | [diff] [blame] | 413 | return nil |
| 414 | } |
| 415 | |
| 416 | func (core *Core) startDeviceManager(ctx context.Context) { |
khenaidoo | 21d5115 | 2019-02-01 13:48:37 -0500 | [diff] [blame] | 417 | log.Info("DeviceManager-Starting...") |
khenaidoo | 4d4802d | 2018-10-04 21:59:49 -0400 | [diff] [blame] | 418 | core.deviceMgr.start(ctx, core.logicalDeviceMgr) |
khenaidoo | 21d5115 | 2019-02-01 13:48:37 -0500 | [diff] [blame] | 419 | log.Info("DeviceManager-Started") |
khenaidoo | b920354 | 2018-09-17 22:56:37 -0400 | [diff] [blame] | 420 | } |
| 421 | |
| 422 | func (core *Core) startLogicalDeviceManager(ctx context.Context) { |
khenaidoo | 21d5115 | 2019-02-01 13:48:37 -0500 | [diff] [blame] | 423 | log.Info("Logical-DeviceManager-Starting...") |
khenaidoo | 4d4802d | 2018-10-04 21:59:49 -0400 | [diff] [blame] | 424 | core.logicalDeviceMgr.start(ctx) |
khenaidoo | 21d5115 | 2019-02-01 13:48:37 -0500 | [diff] [blame] | 425 | log.Info("Logical-DeviceManager-Started") |
khenaidoo | b920354 | 2018-09-17 22:56:37 -0400 | [diff] [blame] | 426 | } |
khenaidoo | 21d5115 | 2019-02-01 13:48:37 -0500 | [diff] [blame] | 427 | |
| 428 | func (core *Core) startAdapterManager(ctx context.Context) { |
| 429 | log.Info("Adapter-Manager-Starting...") |
Thomas Lee S | e5a4401 | 2019-11-07 20:32:24 +0530 | [diff] [blame] | 430 | err := core.adapterMgr.start(ctx) |
| 431 | if err != nil { |
| 432 | log.Fatalf("failed-to-start-adapter-manager: error %v ", err) |
| 433 | } |
khenaidoo | 21d5115 | 2019-02-01 13:48:37 -0500 | [diff] [blame] | 434 | log.Info("Adapter-Manager-Started") |
William Kurkian | daa6bb2 | 2019-03-07 12:26:28 -0500 | [diff] [blame] | 435 | } |
Girish Kumar | 4d3887d | 2019-11-22 14:22:05 +0000 | [diff] [blame] | 436 | |
| 437 | /* |
| 438 | * Thread to monitor kvstore Liveness (connection status) |
| 439 | * |
| 440 | * This function constantly monitors Liveness State of kvstore as reported |
| 441 | * periodically by backend and updates the Status of kv-store service registered |
| 442 | * with rw_core probe. |
| 443 | * |
| 444 | * If no liveness event has been seen within a timeout, then the thread will |
| 445 | * perform a "liveness" check attempt, which will in turn trigger a liveness event on |
| 446 | * the liveness channel, true or false depending on whether the attempt succeeded. |
| 447 | * |
| 448 | * The gRPC server in turn monitors the state of the readiness probe and will |
| 449 | * start issuing UNAVAILABLE response while the probe is not ready. |
| 450 | */ |
| 451 | func (core *Core) monitorKvstoreLiveness(ctx context.Context) { |
| 452 | log.Info("start-monitoring-kvstore-liveness") |
| 453 | |
| 454 | // Instruct backend to create Liveness channel for transporting state updates |
| 455 | livenessChannel := core.backend.EnableLivenessChannel() |
| 456 | |
| 457 | log.Debug("enabled-kvstore-liveness-channel") |
| 458 | |
| 459 | // Default state for kvstore is alive for rw_core |
| 460 | timeout := core.config.LiveProbeInterval |
| 461 | for { |
| 462 | timeoutTimer := time.NewTimer(timeout) |
| 463 | select { |
| 464 | |
| 465 | case liveness := <-livenessChannel: |
| 466 | log.Debugw("received-liveness-change-notification", log.Fields{"liveness": liveness}) |
| 467 | |
| 468 | if !liveness { |
| 469 | probe.UpdateStatusFromContext(ctx, "kv-store", probe.ServiceStatusNotReady) |
| 470 | |
| 471 | if core.grpcServer != nil { |
| 472 | log.Info("kvstore-set-server-notready") |
| 473 | } |
| 474 | |
| 475 | timeout = core.config.NotLiveProbeInterval |
| 476 | |
| 477 | } else { |
| 478 | probe.UpdateStatusFromContext(ctx, "kv-store", probe.ServiceStatusRunning) |
| 479 | |
| 480 | if core.grpcServer != nil { |
| 481 | log.Info("kvstore-set-server-ready") |
| 482 | } |
| 483 | |
| 484 | timeout = core.config.LiveProbeInterval |
| 485 | } |
| 486 | |
| 487 | if !timeoutTimer.Stop() { |
| 488 | <-timeoutTimer.C |
| 489 | } |
| 490 | |
| 491 | case <-timeoutTimer.C: |
| 492 | log.Info("kvstore-perform-liveness-check-on-timeout") |
| 493 | |
| 494 | // Trigger Liveness check if no liveness update received within the timeout period. |
| 495 | // The Liveness check will push Live state to same channel which this routine is |
| 496 | // reading and processing. This, do it asynchronously to avoid blocking for |
| 497 | // backend response and avoid any possibility of deadlock |
| 498 | go core.backend.PerformLivenessCheck(core.config.KVStoreTimeout) |
| 499 | } |
| 500 | } |
| 501 | } |